builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-011 starttime: 1469615174.59 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.595104) ========= 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.595497) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-27 03:26:14.595774) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-27 03:26:14.614161) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 03:26:14.614456) ========= 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=5cf47e208febbcd81da23b2e0000026f-1469615006.295618-1760493587 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-27 03:26:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 15.6M=0.001s 2016-07-27 03:26:15 (15.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.116816 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 03:26:14.745280) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 03:26:14.745620) ========= 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=5cf47e208febbcd81da23b2e0000026f-1469615006.295618-1760493587 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014842 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 03:26:14.795391) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 03:26:14.795733) ========= 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=5cf47e208febbcd81da23b2e0000026f-1469615006.295618-1760493587 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-27 03:26:15,351 truncating revision to first 12 chars 2016-07-27 03:26:15,351 Setting DEBUG logging. 2016-07-27 03:26:15,351 attempt 1/10 2016-07-27 03:26:15,351 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,670 unpacking tar archive at: mozilla-aurora-ebd239b4cbfb/testing/mozharness/ program finished with exit code 0 elapsedTime=0.660000 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 03:26:15.469040) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-27 03:26:15.469336) ========= script_repo_revision: ebd239b4cbfb8eff833560f72b163275ac4026d3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-27 03:26:15.469724) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-27 03:26:15.470013) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-27 03:26:15.484264) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-07-27 03:26:15.484529) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=5cf47e208febbcd81da23b2e0000026f-1469615006.295618-1760493587 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:26:16 INFO - MultiFileLogger online at 20160727 03:26:16 in /builds/slave/test 03:26:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:26:16 INFO - {'append_to_log': False, 03:26:16 INFO - 'base_work_dir': '/builds/slave/test', 03:26:16 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:26:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:26:16 INFO - 'branch': 'Mozilla-Aurora', 03:26:16 INFO - 'buildbot_json_path': 'buildprops.json', 03:26:16 INFO - 'config_files': ('talos/linux_config.py',), 03:26:16 INFO - 'default_actions': ('clobber', 03:26:16 INFO - 'read-buildbot-config', 03:26:16 INFO - 'download-and-extract', 03:26:16 INFO - 'populate-webroot', 03:26:16 INFO - 'create-virtualenv', 03:26:16 INFO - 'install', 03:26:16 INFO - 'run-tests'), 03:26:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:26:16 INFO - 'download_minidump_stackwalk': True, 03:26:16 INFO - 'download_symbols': 'ondemand', 03:26:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:26:16 INFO - 'tooltool.py': '/tools/tooltool.py', 03:26:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:26:16 INFO - '/tools/misc-python/virtualenv.py')}, 03:26:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:26:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:26:16 INFO - 'installer_path': 'installer.exe', 03:26:16 INFO - 'log_level': 'info', 03:26:16 INFO - 'log_name': 'talos', 03:26:16 INFO - 'log_to_console': True, 03:26:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:26:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:26:16 INFO - 'opt_config_files': (), 03:26:16 INFO - 'pip_index': False, 03:26:16 INFO - 'sps_profile': False, 03:26:16 INFO - 'sps_profile_interval': 0, 03:26:16 INFO - 'suite': 'dromaeojs-e10s', 03:26:16 INFO - 'system_bits': '32', 03:26:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:26:16 INFO - 'title': 'talos-linux64-ix-011', 03:26:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:26:16 INFO - 'use_talos_json': True, 03:26:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:26:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:26:16 INFO - 'work_dir': 'build'} 03:26:16 INFO - ##### 03:26:16 INFO - ##### Running clobber 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: clobber 03:26:16 INFO - rmtree: /builds/slave/test/build 03:26:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:26:17 INFO - Running post-action listener: _resource_record_post_action 03:26:17 INFO - ##### 03:26:17 INFO - ##### Finished clobber step (success) 03:26:17 INFO - ##### 03:26:17 INFO - ##### 03:26:17 INFO - ##### Running read-buildbot-config step. 03:26:17 INFO - ##### 03:26:17 INFO - Running pre-action listener: _resource_record_pre_action 03:26:17 INFO - Running main action method: read_buildbot_config 03:26:17 INFO - Using buildbot properties: 03:26:17 INFO - { 03:26:17 INFO - "project": "", 03:26:17 INFO - "product": "firefox", 03:26:17 INFO - "script_repo_revision": "production", 03:26:17 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 03:26:17 INFO - "repository": "", 03:26:17 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 03:26:17 INFO - "buildid": "20160727004019", 03:26:17 INFO - "stage_platform": "linux64-pgo", 03:26:17 INFO - "basedir": "/builds/slave/test", 03:26:17 INFO - "nightly_build": "True", 03:26:17 INFO - "buildnumber": 408, 03:26:17 INFO - "slavename": "talos-linux64-ix-011", 03:26:17 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:26:17 INFO - "platform": "ubuntu64_hw", 03:26:17 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:26:17 INFO - "branch": "mozilla-aurora", 03:26:17 INFO - "repo_path": "releases/mozilla-aurora", 03:26:17 INFO - "revision": "ebd239b4cbfb8eff833560f72b163275ac4026d3", 03:26:17 INFO - "pgo_build": "True", 03:26:17 INFO - "builduid": "2fc58a4d5c144b7c97bb4b8cbf273105", 03:26:17 INFO - "slavebuilddir": "test" 03:26:17 INFO - } 03:26:17 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:17 INFO - Running post-action listener: _resource_record_post_action 03:26:17 INFO - ##### 03:26:17 INFO - ##### Finished read-buildbot-config step (success) 03:26:17 INFO - ##### 03:26:17 INFO - ##### 03:26:17 INFO - ##### Running download-and-extract step. 03:26:17 INFO - ##### 03:26:17 INFO - Running pre-action listener: _resource_record_pre_action 03:26:17 INFO - Running main action method: download_and_extract 03:26:17 INFO - mkdir: /builds/slave/test/build/tests 03:26:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:17 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:17 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:17 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:17 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:17 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:17 INFO - Downloaded 1361 bytes. 03:26:17 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:26:17 INFO - Using the following test package requirements: 03:26:17 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 03:26:17 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:26:17 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:26:17 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:26:17 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:26:17 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:26:17 INFO - u'jsshell-linux-x86_64.zip'], 03:26:17 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:26:17 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:26:17 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 03:26:17 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:26:17 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:26:17 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:26:17 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:26:17 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:26:17 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:26:17 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:26:17 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:26:17 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:26:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:17 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:17 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:17 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:17 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:17 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:18 INFO - Downloaded 24493586 bytes. 03:26:18 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:18 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:22 INFO - Downloaded 24493586 bytes. 03:26:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:26:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03: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.talos.tests.zip 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.talos.tests.zip 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.talos.tests.zip 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.talos.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:26:23 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:24 INFO - Downloaded 10833369 bytes. 03:26:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:26:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:26:24 INFO - Return code: 0 03:26:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:24 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:24 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:24 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:24 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:24 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:26 INFO - Downloaded 63631484 bytes. 03:26:26 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:26 INFO - mkdir: /builds/slave/test/properties 03:26:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:26:26 INFO - Writing to file /builds/slave/test/properties/build_url 03:26:26 INFO - Contents: 03:26:26 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:27 INFO - Running post-action listener: _resource_record_post_action 03:26:27 INFO - Running post-action listener: set_extra_try_arguments 03:26:27 INFO - ##### 03:26:27 INFO - ##### Finished download-and-extract step (success) 03:26:27 INFO - ##### 03:26:27 INFO - ##### 03:26:27 INFO - ##### Running populate-webroot step. 03:26:27 INFO - ##### 03:26:27 INFO - Running pre-action listener: _resource_record_pre_action 03:26:27 INFO - Running main action method: populate_webroot 03:26:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:26:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:26:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:26:27 INFO - '--tppagecycles', 03:26:27 INFO - '7'], 03:26:27 INFO - 'tests': ['tsvgm']}}, 03:26:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:26:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:26:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:26:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:26:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:26:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:26:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:27 INFO - 'talos_options': ['--disable-e10s'], 03:26:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:26:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:26:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:27 INFO - 'talos_options': ['--disable-e10s'], 03:26:27 INFO - 'tests': ['damp', 'tps']}, 03:26:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:27 INFO - 'tests': ['damp', 'tps']}, 03:26:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:26:27 INFO - 'tests': ['dromaeo_dom']}, 03:26:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:26:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:26:27 INFO - 'tests': ['a11yr', 03:26:27 INFO - 'ts_paint', 03:26:27 INFO - 'tpaint', 03:26:27 INFO - 'sessionrestore', 03:26:27 INFO - 'sessionrestore_no_auto_restore', 03:26:27 INFO - 'tabpaint']}, 03:26:27 INFO - 'other-e10s': {'tests': ['a11yr', 03:26:27 INFO - 'ts_paint', 03:26:27 INFO - 'tpaint', 03:26:27 INFO - 'sessionrestore', 03:26:27 INFO - 'sessionrestore_no_auto_restore', 03:26:27 INFO - 'tabpaint']}, 03:26:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:26:27 INFO - 'ts_paint', 03:26:27 INFO - 'tpaint', 03:26:27 INFO - 'sessionrestore', 03:26:27 INFO - 'sessionrestore_no_auto_restore', 03:26:27 INFO - 'tabpaint']}, 03:26:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:26:27 INFO - 'ts_paint', 03:26:27 INFO - 'tpaint', 03:26:27 INFO - 'sessionrestore', 03:26:27 INFO - 'sessionrestore_no_auto_restore', 03:26:27 INFO - 'tabpaint']}, 03:26:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:26:27 INFO - 'tests': ['a11yr', 03:26:27 INFO - 'ts_paint', 03:26:27 INFO - 'tpaint', 03:26:27 INFO - 'sessionrestore', 03:26:27 INFO - 'sessionrestore_no_auto_restore', 03:26:27 INFO - 'tabpaint']}, 03:26:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:26:27 INFO - 'tests': ['a11yr', 03:26:27 INFO - 'ts_paint', 03:26:27 INFO - 'tpaint', 03:26:27 INFO - 'sessionrestore', 03:26:27 INFO - 'sessionrestore_no_auto_restore', 03:26:27 INFO - 'tabpaint']}, 03:26:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:26:27 INFO - 'tests': ['tsvgx', 03:26:27 INFO - 'tsvgr_opacity', 03:26:27 INFO - 'tart', 03:26:27 INFO - 'tscrollx', 03:26:27 INFO - 'cart']}, 03:26:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:26:27 INFO - 'tsvgr_opacity', 03:26:27 INFO - 'tart', 03:26:27 INFO - 'tscrollx', 03:26:27 INFO - 'cart']}, 03:26:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:27 INFO - 'talos_options': ['--disable-e10s'], 03:26:27 INFO - 'tests': ['tp5o']}, 03:26:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:27 INFO - 'tests': ['tp5o']}, 03:26:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:27 INFO - 'talos_options': ['--disable-e10s', 03:26:27 INFO - '--xperf_path', 03:26:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:26:27 INFO - 'tests': ['tp5n']}, 03:26:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:27 INFO - 'talos_options': ['--xperf_path', 03:26:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:26:27 INFO - 'tests': ['tp5n']}}, 03:26:27 INFO - 'talos.zip': {'path': '', 03:26:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:26:27 INFO - Running post-action listener: _resource_record_post_action 03:26:27 INFO - ##### 03:26:27 INFO - ##### Finished populate-webroot step (success) 03:26:27 INFO - ##### 03:26:27 INFO - ##### 03:26:27 INFO - ##### Running create-virtualenv step. 03:26:27 INFO - ##### 03:26:27 INFO - Running pre-action listener: _resource_record_pre_action 03:26:27 INFO - Running main action method: create_virtualenv 03:26:27 INFO - Creating virtualenv /builds/slave/test/build/venv 03:26:27 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:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:26:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:26:27 INFO - Using real prefix '/usr' 03:26:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:26:27 INFO - Installing distribute.............................................................................................................................................................................................done. 03:26:29 INFO - Installing pip.................done. 03:26:29 INFO - Return code: 0 03:26:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:26:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f497aca9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa1c0>, '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 0x10ab0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab550>, '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': '5cf47e208febbcd81da23b2e0000026f-1469615006.295618-1760493587', '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:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:26:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:26:29 INFO - Using env: {'DISPLAY': ':0', 03:26:29 INFO - 'HOME': '/home/cltbld', 03:26:29 INFO - 'LANG': 'en_US.UTF-8', 03:26:29 INFO - 'LANGUAGE': 'en_US:en', 03:26:29 INFO - 'LOGNAME': 'cltbld', 03:26:29 INFO - 'MAIL': '/var/mail/cltbld', 03:26:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:29 INFO - 'MOZ_NO_REMOTE': '1', 03:26:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:29 INFO - 'NO_EM_RESTART': '1', 03:26:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:29 INFO - 'PWD': '/builds/slave/test', 03:26:29 INFO - 'SHELL': '/bin/bash', 03:26:29 INFO - 'SHLVL': '1', 03:26:29 INFO - 'TERM': 'linux', 03:26:29 INFO - 'TMOUT': '86400', 03:26:29 INFO - 'USER': 'cltbld', 03:26:29 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1469615006.295618-1760493587', 03:26:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:29 INFO - '_': '/tools/buildbot/bin/python'} 03:26:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:29 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:26:29 INFO - Cleaning up... 03:26:29 INFO - Return code: 0 03:26:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:26:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f497aca9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa1c0>, '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 0x10ab0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab550>, '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': '5cf47e208febbcd81da23b2e0000026f-1469615006.295618-1760493587', '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:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:26:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:26:29 INFO - Using env: {'DISPLAY': ':0', 03:26:29 INFO - 'HOME': '/home/cltbld', 03:26:29 INFO - 'LANG': 'en_US.UTF-8', 03:26:29 INFO - 'LANGUAGE': 'en_US:en', 03:26:29 INFO - 'LOGNAME': 'cltbld', 03:26:29 INFO - 'MAIL': '/var/mail/cltbld', 03:26:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:29 INFO - 'MOZ_NO_REMOTE': '1', 03:26:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:29 INFO - 'NO_EM_RESTART': '1', 03:26:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:29 INFO - 'PWD': '/builds/slave/test', 03:26:29 INFO - 'SHELL': '/bin/bash', 03:26:29 INFO - 'SHLVL': '1', 03:26:29 INFO - 'TERM': 'linux', 03:26:29 INFO - 'TMOUT': '86400', 03:26:29 INFO - 'USER': 'cltbld', 03:26:29 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1469615006.295618-1760493587', 03:26:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:29 INFO - '_': '/tools/buildbot/bin/python'} 03:26:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:30 INFO - Downloading/unpacking psutil>=3.1.1 03:26:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:26:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:26:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:26:32 INFO - Installing collected packages: psutil 03:26:32 INFO - Running setup.py install for psutil 03:26:32 INFO - building 'psutil._psutil_linux' extension 03:26:32 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:32 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:26:32 INFO - building 'psutil._psutil_posix' extension 03:26:32 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:26:32 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:26:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:26:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:26:32 INFO - Successfully installed psutil 03:26:32 INFO - Cleaning up... 03:26:32 INFO - Return code: 0 03:26:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:26:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f497aca9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa1c0>, '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 0x10ab0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab550>, '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': '5cf47e208febbcd81da23b2e0000026f-1469615006.295618-1760493587', '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:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:26:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:26:32 INFO - Using env: {'DISPLAY': ':0', 03:26:32 INFO - 'HOME': '/home/cltbld', 03:26:32 INFO - 'LANG': 'en_US.UTF-8', 03:26:32 INFO - 'LANGUAGE': 'en_US:en', 03:26:32 INFO - 'LOGNAME': 'cltbld', 03:26:32 INFO - 'MAIL': '/var/mail/cltbld', 03:26:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:32 INFO - 'MOZ_NO_REMOTE': '1', 03:26:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:32 INFO - 'NO_EM_RESTART': '1', 03:26:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:32 INFO - 'PWD': '/builds/slave/test', 03:26:32 INFO - 'SHELL': '/bin/bash', 03:26:32 INFO - 'SHLVL': '1', 03:26:32 INFO - 'TERM': 'linux', 03:26:32 INFO - 'TMOUT': '86400', 03:26:32 INFO - 'USER': 'cltbld', 03:26:32 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1469615006.295618-1760493587', 03:26:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:32 INFO - '_': '/tools/buildbot/bin/python'} 03:26:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:26:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:26:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:26:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:26:34 INFO - Installing collected packages: mozsystemmonitor 03:26:34 INFO - Running setup.py install for mozsystemmonitor 03:26:34 INFO - Successfully installed mozsystemmonitor 03:26:34 INFO - Cleaning up... 03:26:34 INFO - Return code: 0 03:26:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:26:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f497aca9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa1c0>, '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 0x10ab0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab550>, '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': '5cf47e208febbcd81da23b2e0000026f-1469615006.295618-1760493587', '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:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:26:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:26:34 INFO - Using env: {'DISPLAY': ':0', 03:26:34 INFO - 'HOME': '/home/cltbld', 03:26:34 INFO - 'LANG': 'en_US.UTF-8', 03:26:34 INFO - 'LANGUAGE': 'en_US:en', 03:26:34 INFO - 'LOGNAME': 'cltbld', 03:26:34 INFO - 'MAIL': '/var/mail/cltbld', 03:26:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:34 INFO - 'MOZ_NO_REMOTE': '1', 03:26:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:34 INFO - 'NO_EM_RESTART': '1', 03:26:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:34 INFO - 'PWD': '/builds/slave/test', 03:26:34 INFO - 'SHELL': '/bin/bash', 03:26:34 INFO - 'SHLVL': '1', 03:26:34 INFO - 'TERM': 'linux', 03:26:34 INFO - 'TMOUT': '86400', 03:26:34 INFO - 'USER': 'cltbld', 03:26:34 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1469615006.295618-1760493587', 03:26:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:34 INFO - '_': '/tools/buildbot/bin/python'} 03:26:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:35 INFO - Downloading/unpacking 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:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:26:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:26:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:37 INFO - Downloading functools32-3.2.3-2.tar.gz 03:26:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:26:37 INFO - warning: no files found matching '*.txt' 03:26:37 INFO - no previously-included directories found matching 'build' 03:26:37 INFO - no previously-included directories found matching 'dist' 03:26:37 INFO - no previously-included directories found matching '.git*' 03:26:37 INFO - Installing collected packages: jsonschema, functools32 03:26:37 INFO - Running setup.py install for functools32 03:26:37 INFO - warning: no files found matching '*.txt' 03:26:37 INFO - no previously-included directories found matching 'build' 03:26:37 INFO - no previously-included directories found matching 'dist' 03:26:37 INFO - no previously-included directories found matching '.git*' 03:26:37 INFO - Successfully installed jsonschema functools32 03:26:37 INFO - Cleaning up... 03:26:37 INFO - Return code: 0 03:26:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:26:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f497aca9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa1c0>, '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 0x10ab0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab550>, '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': '5cf47e208febbcd81da23b2e0000026f-1469615006.295618-1760493587', '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:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:26:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:26:37 INFO - Using env: {'DISPLAY': ':0', 03:26:37 INFO - 'HOME': '/home/cltbld', 03:26:37 INFO - 'LANG': 'en_US.UTF-8', 03:26:37 INFO - 'LANGUAGE': 'en_US:en', 03:26:37 INFO - 'LOGNAME': 'cltbld', 03:26:37 INFO - 'MAIL': '/var/mail/cltbld', 03:26:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:37 INFO - 'MOZ_NO_REMOTE': '1', 03:26:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:37 INFO - 'NO_EM_RESTART': '1', 03:26:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:37 INFO - 'PWD': '/builds/slave/test', 03:26:37 INFO - 'SHELL': '/bin/bash', 03:26:37 INFO - 'SHLVL': '1', 03:26:37 INFO - 'TERM': 'linux', 03:26:37 INFO - 'TMOUT': '86400', 03:26:37 INFO - 'USER': 'cltbld', 03:26:37 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1469615006.295618-1760493587', 03:26:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:37 INFO - '_': '/tools/buildbot/bin/python'} 03:26:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:37 INFO - Downloading/unpacking blobuploader==1.2.4 03:26:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:39 INFO - Downloading blobuploader-1.2.4.tar.gz 03:26:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:26:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:26:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:26:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:26:40 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:40 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:40 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:40 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:40 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:40 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:40 INFO - Downloading docopt-0.6.1.tar.gz 03:26:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:26:40 INFO - Installing collected packages: blobuploader, requests, docopt 03:26:40 INFO - Running setup.py install for blobuploader 03:26:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:26:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:26:40 INFO - Running setup.py install for requests 03:26:41 INFO - Running setup.py install for docopt 03:26:41 INFO - Successfully installed blobuploader requests docopt 03:26:41 INFO - Cleaning up... 03:26:41 INFO - Return code: 0 03:26:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:26:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:41 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 0x7f497aca9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa1c0>, '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 0x10ab0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab550>, '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': '5cf47e208febbcd81da23b2e0000026f-1469615006.295618-1760493587', '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:41 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:41 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:41 INFO - Using env: {'DISPLAY': ':0', 03:26:41 INFO - 'HOME': '/home/cltbld', 03:26:41 INFO - 'LANG': 'en_US.UTF-8', 03:26:41 INFO - 'LANGUAGE': 'en_US:en', 03:26:41 INFO - 'LOGNAME': 'cltbld', 03:26:41 INFO - 'MAIL': '/var/mail/cltbld', 03:26:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:41 INFO - 'MOZ_NO_REMOTE': '1', 03:26:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:41 INFO - 'NO_EM_RESTART': '1', 03:26:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:41 INFO - 'PWD': '/builds/slave/test', 03:26:41 INFO - 'SHELL': '/bin/bash', 03:26:41 INFO - 'SHLVL': '1', 03:26:41 INFO - 'TERM': 'linux', 03:26:41 INFO - 'TMOUT': '86400', 03:26:41 INFO - 'USER': 'cltbld', 03:26:41 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1469615006.295618-1760493587', 03:26:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:41 INFO - '_': '/tools/buildbot/bin/python'} 03:26:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:26:41 INFO - Running setup.py (path:/tmp/pip-jiJjSn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:26:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:26:41 INFO - Running setup.py (path:/tmp/pip-ENAHr3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:26:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:26:41 INFO - Running setup.py (path:/tmp/pip-_MGVyo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:26:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:26:41 INFO - Running setup.py (path:/tmp/pip-wK40Hk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:26:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:26:41 INFO - Running setup.py (path:/tmp/pip-LPhviI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:26:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:26:41 INFO - Running setup.py (path:/tmp/pip-EENXcA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:26:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:26:41 INFO - Running setup.py (path:/tmp/pip-bEEVp1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:26:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:26:41 INFO - Running setup.py (path:/tmp/pip-DZUnRA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:26:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:26:42 INFO - Running setup.py (path:/tmp/pip-nau_9c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:26:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:26:42 INFO - Running setup.py (path:/tmp/pip-Q2KFBw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:26:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:26:42 INFO - Running setup.py (path:/tmp/pip-iWXfQZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:26:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:26:42 INFO - Running setup.py (path:/tmp/pip-6eDvK1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:26:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:26:42 INFO - Running setup.py (path:/tmp/pip-dVPQK3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:26:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:26:42 INFO - Running setup.py (path:/tmp/pip-kO56io-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:26:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:26:42 INFO - Running setup.py (path:/tmp/pip-QfgHRt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:26:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:26:42 INFO - Running setup.py (path:/tmp/pip-izxKij-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:26:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:26:42 INFO - Running setup.py (path:/tmp/pip-QedNQG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:26:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:26:42 INFO - Running setup.py install for manifestparser 03:26:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:26:42 INFO - Running setup.py install for mozcrash 03:26:42 INFO - Running setup.py install for mozdebug 03:26:42 INFO - Running setup.py install for mozdevice 03:26:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:26:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:26:43 INFO - Running setup.py install for mozfile 03:26:43 INFO - Running setup.py install for mozhttpd 03:26:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:26:43 INFO - Running setup.py install for mozinfo 03:26:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:26:43 INFO - Running setup.py install for mozInstall 03:26:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:26:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:26:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:26:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:26:43 INFO - Running setup.py install for mozleak 03:26:43 INFO - Running setup.py install for mozlog 03:26:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:26:43 INFO - Running setup.py install for moznetwork 03:26:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:26:43 INFO - Running setup.py install for mozprocess 03:26:43 INFO - Running setup.py install for mozprofile 03:26:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:26:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:26:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:26:44 INFO - Running setup.py install for mozrunner 03:26:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:26:44 INFO - Running setup.py install for mozscreenshot 03:26:44 INFO - Running setup.py install for moztest 03:26:44 INFO - Running setup.py install for mozversion 03:26:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:26:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:26:44 INFO - Cleaning up... 03:26:44 INFO - Return code: 0 03:26:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:26:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f497aca9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa1c0>, '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 0x10ab0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab550>, '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': '5cf47e208febbcd81da23b2e0000026f-1469615006.295618-1760493587', '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:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:26:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:26:44 INFO - Using env: {'DISPLAY': ':0', 03:26:44 INFO - 'HOME': '/home/cltbld', 03:26:44 INFO - 'LANG': 'en_US.UTF-8', 03:26:44 INFO - 'LANGUAGE': 'en_US:en', 03:26:44 INFO - 'LOGNAME': 'cltbld', 03:26:44 INFO - 'MAIL': '/var/mail/cltbld', 03:26:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:44 INFO - 'MOZ_NO_REMOTE': '1', 03:26:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:44 INFO - 'NO_EM_RESTART': '1', 03:26:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:44 INFO - 'PWD': '/builds/slave/test', 03:26:44 INFO - 'SHELL': '/bin/bash', 03:26:44 INFO - 'SHLVL': '1', 03:26:44 INFO - 'TERM': 'linux', 03:26:44 INFO - 'TMOUT': '86400', 03:26:44 INFO - 'USER': 'cltbld', 03:26:44 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1469615006.295618-1760493587', 03:26:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:44 INFO - '_': '/tools/buildbot/bin/python'} 03:26:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:26:44 INFO - Running setup.py (path:/tmp/pip-R_jKrT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:26:44 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:26:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:26:44 INFO - Running setup.py (path:/tmp/pip-BEzWMX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:26:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:26:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:26:44 INFO - Running setup.py (path:/tmp/pip-hKfVWJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:26:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:26:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:26:44 INFO - Running setup.py (path:/tmp/pip-whe1hH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:26:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:26:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:26:45 INFO - Running setup.py (path:/tmp/pip-KpCBrh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:26:45 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:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:26:45 INFO - Running setup.py (path:/tmp/pip-tQ59lJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:26:45 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:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:26:45 INFO - Running setup.py (path:/tmp/pip-LV8x3r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:26:45 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:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:26:45 INFO - Running setup.py (path:/tmp/pip-UIr4S1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:26:45 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:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:26:45 INFO - Running setup.py (path:/tmp/pip-0Xygb_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:26:45 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:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:26:45 INFO - Running setup.py (path:/tmp/pip-fLON9y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:26:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:26:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:26:45 INFO - Running setup.py (path:/tmp/pip-koBDmG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:26:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:26:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:26:45 INFO - Running setup.py (path:/tmp/pip-EYRGPB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:26:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:26:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:26:45 INFO - Running setup.py (path:/tmp/pip-J3eyPa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:26:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:26:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:26:45 INFO - Running setup.py (path:/tmp/pip-WCSSje-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:26:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:26:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:26:45 INFO - Running setup.py (path:/tmp/pip-Iw3eVO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:26:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:26:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:26:45 INFO - Running setup.py (path:/tmp/pip-SNnllG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:26:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:26:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:26:45 INFO - Running setup.py (path:/tmp/pip-Ps7ZDN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:26:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:26:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:26:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:26:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:26:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:26:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:26:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:26:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:47 INFO - Downloading blessings-1.6.tar.gz 03:26:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:26:47 INFO - Installing collected packages: blessings 03:26:47 INFO - Running setup.py install for blessings 03:26:48 INFO - Successfully installed blessings 03:26:48 INFO - Cleaning up... 03:26:48 INFO - Return code: 0 03:26:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:26:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:26:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:26:48 INFO - Reading from file tmpfile_stdout 03:26:48 INFO - Current package versions: 03:26:48 INFO - argparse == 1.2.1 03:26:48 INFO - blessings == 1.6 03:26:48 INFO - blobuploader == 1.2.4 03:26:48 INFO - docopt == 0.6.1 03:26:48 INFO - functools32 == 3.2.3-2 03:26:48 INFO - jsonschema == 2.5.1 03:26:48 INFO - manifestparser == 1.1 03:26:48 INFO - mozInstall == 1.12 03:26:48 INFO - mozcrash == 0.17 03:26:48 INFO - mozdebug == 0.1 03:26:48 INFO - mozdevice == 0.48 03:26:48 INFO - mozfile == 1.2 03:26:48 INFO - mozhttpd == 0.7 03:26:48 INFO - mozinfo == 0.9 03:26:48 INFO - mozleak == 0.1 03:26:48 INFO - mozlog == 3.2 03:26:48 INFO - moznetwork == 0.27 03:26:48 INFO - mozprocess == 0.23 03:26:48 INFO - mozprofile == 0.28 03:26:48 INFO - mozrunner == 6.12 03:26:48 INFO - mozscreenshot == 0.1 03:26:48 INFO - mozsystemmonitor == 0.3 03:26:48 INFO - moztest == 0.7 03:26:48 INFO - mozversion == 1.4 03:26:48 INFO - psutil == 3.1.1 03:26:48 INFO - requests == 1.2.3 03:26:48 INFO - wsgiref == 0.1.2 03:26:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:26:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:48 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 0x7f497aca9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa1c0>, '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 0x10ab0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab550>, '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': '5cf47e208febbcd81da23b2e0000026f-1469615006.295618-1760493587', '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:48 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:48 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:48 INFO - Using env: {'DISPLAY': ':0', 03:26:48 INFO - 'HOME': '/home/cltbld', 03:26:48 INFO - 'LANG': 'en_US.UTF-8', 03:26:48 INFO - 'LANGUAGE': 'en_US:en', 03:26:48 INFO - 'LOGNAME': 'cltbld', 03:26:48 INFO - 'MAIL': '/var/mail/cltbld', 03:26:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:48 INFO - 'MOZ_NO_REMOTE': '1', 03:26:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:48 INFO - 'NO_EM_RESTART': '1', 03:26:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:48 INFO - 'PWD': '/builds/slave/test', 03:26:48 INFO - 'SHELL': '/bin/bash', 03:26:48 INFO - 'SHLVL': '1', 03:26:48 INFO - 'TERM': 'linux', 03:26:48 INFO - 'TMOUT': '86400', 03:26:48 INFO - 'USER': 'cltbld', 03:26:48 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1469615006.295618-1760493587', 03:26:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:48 INFO - '_': '/tools/buildbot/bin/python'} 03:26:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:26:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:26:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:26:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:26:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:26:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:26:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:26:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:26:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:26:48 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:26:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:26:48 INFO - Cleaning up... 03:26:48 INFO - Return code: 0 03:26:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:26:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f497aca9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa1c0>, '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 0x10ab0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab550>, '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': '5cf47e208febbcd81da23b2e0000026f-1469615006.295618-1760493587', '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:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:26:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:26:48 INFO - Using env: {'DISPLAY': ':0', 03:26:48 INFO - 'HOME': '/home/cltbld', 03:26:48 INFO - 'LANG': 'en_US.UTF-8', 03:26:48 INFO - 'LANGUAGE': 'en_US:en', 03:26:48 INFO - 'LOGNAME': 'cltbld', 03:26:48 INFO - 'MAIL': '/var/mail/cltbld', 03:26:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:48 INFO - 'MOZ_NO_REMOTE': '1', 03:26:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:48 INFO - 'NO_EM_RESTART': '1', 03:26:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:48 INFO - 'PWD': '/builds/slave/test', 03:26:48 INFO - 'SHELL': '/bin/bash', 03:26:48 INFO - 'SHLVL': '1', 03:26:48 INFO - 'TERM': 'linux', 03:26:48 INFO - 'TMOUT': '86400', 03:26:48 INFO - 'USER': 'cltbld', 03:26:48 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1469615006.295618-1760493587', 03:26:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:48 INFO - '_': '/tools/buildbot/bin/python'} 03:26:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:26:48 INFO - Cleaning up... 03:26:48 INFO - Return code: 0 03:26:48 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:26:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f497aca9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa1c0>, '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 0x10ab0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab550>, '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': '5cf47e208febbcd81da23b2e0000026f-1469615006.295618-1760493587', '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:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 03:26:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 03:26:48 INFO - Using env: {'DISPLAY': ':0', 03:26:48 INFO - 'HOME': '/home/cltbld', 03:26:48 INFO - 'LANG': 'en_US.UTF-8', 03:26:48 INFO - 'LANGUAGE': 'en_US:en', 03:26:48 INFO - 'LOGNAME': 'cltbld', 03:26:48 INFO - 'MAIL': '/var/mail/cltbld', 03:26:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:48 INFO - 'MOZ_NO_REMOTE': '1', 03:26:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:48 INFO - 'NO_EM_RESTART': '1', 03:26:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:48 INFO - 'PWD': '/builds/slave/test', 03:26:48 INFO - 'SHELL': '/bin/bash', 03:26:48 INFO - 'SHLVL': '1', 03:26:48 INFO - 'TERM': 'linux', 03:26:48 INFO - 'TMOUT': '86400', 03:26:48 INFO - 'USER': 'cltbld', 03:26:48 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1469615006.295618-1760493587', 03:26:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:48 INFO - '_': '/tools/buildbot/bin/python'} 03:26:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:48 INFO - Downloading/unpacking flake8 03:26:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03: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 - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:26:50 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:26:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:51 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:26:51 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:26:51 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:51 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:51 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:51 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:51 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:51 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:51 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:26:51 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:51 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:51 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:51 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:51 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:51 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:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:26:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:26:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:26:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:26:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:26:51 INFO - no previously-included directories found matching 'docs/_build' 03:26:51 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:26:51 INFO - Running setup.py install for pep8 03:26:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:26:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:26:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:26:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:26:51 INFO - no previously-included directories found matching 'docs/_build' 03:26:51 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:26:51 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:26:51 INFO - Cleaning up... 03:26:52 INFO - Return code: 0 03:26:52 INFO - Running post-action listener: _resource_record_post_action 03:26:52 INFO - Running post-action listener: _start_resource_monitoring 03:26:52 INFO - Starting resource monitoring. 03:26:52 INFO - ##### 03:26:52 INFO - ##### Finished create-virtualenv step (success) 03:26:52 INFO - ##### 03:26:52 INFO - ##### 03:26:52 INFO - ##### Running install step. 03:26:52 INFO - ##### 03:26:52 INFO - Running pre-action listener: _resource_record_pre_action 03:26:52 INFO - Running main action method: install 03:26:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:26:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:26:52 INFO - Reading from file tmpfile_stdout 03:26:52 INFO - Detecting whether we're running mozinstall >=1.0... 03:26:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:26:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:26:52 INFO - Reading from file tmpfile_stdout 03:26:52 INFO - Output received: 03:26:52 INFO - Usage: mozinstall [options] installer 03:26:52 INFO - Options: 03:26:52 INFO - -h, --help show this help message and exit 03:26:52 INFO - -d DEST, --destination=DEST 03:26:52 INFO - Directory to install application into. [default: 03:26:52 INFO - "/builds/slave/test"] 03:26:52 INFO - --app=APP Application being installed. [default: firefox] 03:26:52 INFO - mkdir: /builds/slave/test/build/application 03:26:52 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:52 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:08 INFO - Reading from file tmpfile_stdout 03:27:08 INFO - Output received: 03:27:08 INFO - /builds/slave/test/build/application/firefox/firefox 03:27:08 INFO - Running post-action listener: _resource_record_post_action 03:27:08 INFO - ##### 03:27:08 INFO - ##### Finished install step (success) 03:27:08 INFO - ##### 03:27:08 INFO - ##### 03:27:08 INFO - ##### Running run-tests step. 03:27:08 INFO - ##### 03:27:08 INFO - Running pre-action listener: _resource_record_pre_action 03:27:08 INFO - Running main action method: run_tests 03:27:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:27:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:27:08 INFO - Python 2.7.3 03:27:08 INFO - Return code: 0 03:27:08 INFO - grabbing minidump binary from tooltool 03:27:08 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:08 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 0x10aa1c0>, '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 0x10ab0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:27:08 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:08 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:08 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:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:27:08 INFO - Return code: 0 03:27:08 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:27:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:27:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:27:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:27:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:27:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:27:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:27:09 INFO - Return code: 0 03:27:09 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-e10s', '--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-011', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 03:27:09 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-e10s --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-011 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 03:27:09 INFO - Using env: {'DISPLAY': ':0', 03:27:09 INFO - 'HOME': '/home/cltbld', 03:27:09 INFO - 'LANG': 'en_US.UTF-8', 03:27:09 INFO - 'LANGUAGE': 'en_US:en', 03:27:09 INFO - 'LOGNAME': 'cltbld', 03:27:09 INFO - 'MAIL': '/var/mail/cltbld', 03:27:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:27:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:27:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:09 INFO - 'MOZ_NO_REMOTE': '1', 03:27:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:27:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:09 INFO - 'NO_EM_RESTART': '1', 03:27:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:09 INFO - 'PWD': '/builds/slave/test', 03:27:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:27:09 INFO - 'SHELL': '/bin/bash', 03:27:09 INFO - 'SHLVL': '1', 03:27:09 INFO - 'TERM': 'linux', 03:27:09 INFO - 'TMOUT': '86400', 03:27:09 INFO - 'USER': 'cltbld', 03:27:09 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1469615006.295618-1760493587', 03:27:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:09 INFO - '_': '/tools/buildbot/bin/python'} 03:27:09 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--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-011', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 03:27:09 INFO - mozversion application_buildid: 20160727004019 03:27:09 INFO - mozversion application_changeset: ebd239b4cbfb8eff833560f72b163275ac4026d3 03:27:09 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:27:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:27:09 INFO - mozversion application_name: Firefox 03:27:09 INFO - mozversion application_remotingname: firefox-dev 03:27:09 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:27:09 INFO - mozversion application_vendor: Mozilla 03:27:09 INFO - mozversion application_version: 49.0a2 03:27:09 INFO - mozversion platform_buildid: 20160727004019 03:27:09 INFO - mozversion platform_changeset: ebd239b4cbfb8eff833560f72b163275ac4026d3 03:27:09 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:27:09 INFO - mozversion platform_version: 49.0a2 03:27:09 INFO - using testdate: 1469615229 03:27:09 INFO - actual date: 1469615229 03:27:09 INFO - starting webserver on 'localhost:60680' 03:27:09 INFO - SUITE-START | Running 2 tests 03:27:09 INFO - TEST-START | dromaeo_css 03:27:09 INFO - operating with platform_type : linux_ 03:27:09 INFO - Initialising browser for dromaeo_css test... 03:27:09 INFO - TEST-INFO | started process 8656 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJXotVp/profile http://localhost:60680/getInfo.html) 03:27:14 INFO - PROCESS | 8656 | __metrics Screen width/height:1600/1200 03:27:14 INFO - PROCESS | 8656 | colorDepth:24 03:27:14 INFO - PROCESS | 8656 | Browser inner width/height: 1024/697 03:27:14 INFO - PROCESS | 8656 | __metrics 03:27:15 ERROR - PROCESS | 8656 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 03:27:16 INFO - TEST-INFO | 8656: exit 0 03:27:16 INFO - Browser initialized. 03:27:16 INFO - Running cycle 1/1 for dromaeo_css test... 03:27:16 INFO - TEST-INFO | started process 8785 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJXotVp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:27:28 INFO - PROCESS | 8785 | RSS: Main: 155742208 03:27:28 INFO - PROCESS | 8785 | 03:28:18 INFO - PROCESS | 8785 | 1469615298014 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:26 INFO - PROCESS | 8785 | Cycle 1(1): loaded http://localhost:60680/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60680/tests/dromaeo/cssquery-ext.html) 03:30:27 INFO - PROCESS | 8785 | RSS: Main: 160137216 03:30:27 INFO - PROCESS | 8785 | 03:33:29 INFO - PROCESS | 8785 | Cycle 1(1): loaded http://localhost:60680/tests/dromaeo/cssquery-ext.html (next: http://localhost:60680/tests/dromaeo/cssquery-jquery.html) 03:33:29 INFO - PROCESS | 8785 | RSS: Main: 157593600 03:33:29 INFO - PROCESS | 8785 | 03:36:31 INFO - PROCESS | 8785 | Cycle 1(1): loaded http://localhost:60680/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60680/tests/dromaeo/cssquery-mootools.html) 03:36:32 INFO - PROCESS | 8785 | RSS: Main: 156897280 03:36:32 INFO - PROCESS | 8785 | 03:39:33 INFO - PROCESS | 8785 | Cycle 1(1): loaded http://localhost:60680/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60680/tests/dromaeo/cssquery-prototype.html) 03:39:34 INFO - PROCESS | 8785 | RSS: Main: 156925952 03:39:34 INFO - PROCESS | 8785 | 03:42:36 INFO - PROCESS | 8785 | Cycle 1(1): loaded http://localhost:60680/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60680/tests/dromaeo/cssquery-yui.html) 03:42:37 INFO - PROCESS | 8785 | RSS: Main: 158752768 03:42:37 INFO - PROCESS | 8785 | 03:45:39 INFO - PROCESS | 8785 | Cycle 1(1): loaded http://localhost:60680/tests/dromaeo/cssquery-yui.html (next: http://localhost:60680/tests/dromaeo/cssquery-dojo.html) 03:45:40 INFO - PROCESS | 8785 | RSS: Main: 159379456 03:45:40 INFO - PROCESS | 8785 | 03:45:40 INFO - PROCESS | 8785 | __start_tp_report 03:45:40 INFO - PROCESS | 8785 | _x_x_mozilla_page_load 03:45:40 INFO - PROCESS | 8785 | _x_x_mozilla_page_load_details 03:45:40 INFO - PROCESS | 8785 | |i|pagename|runs| 03:45:40 INFO - PROCESS | 8785 | |0;dojo.html;3342.3816593930123;3394.422948098823;3423.469362248852;3423.6234014258434;3424.075499615102;5610.6353087049365;5632.408597097302;5643.012472817256;5697.287839020122;5733.455321744438;5685.687287199203;5711.600187986843;5734.541236701064;5736.368999410061;5753.309602847654;5163.638545301821;5193.45468725784;5228.712420816853;5239.685618862881;5245.973770131144;5141.665791723544;5204.947950520503;5242.606804489659;5267.0256002639635;5292.047431462335;5193.091209038422;5204.167333226685;5207.114790485608;5210.088234558956;5213.218017297398;5270.604704647148;5288.894222115536;5290.074237008508;5293.258943747878;5295.020421222086;4967.677100988461;5054.772535235923;5056.115179843513;5187.636865419422;5196.142636464979;5565.026120428909;5576.749046292886;5581.2186293918885;5585.190147428641;5617.43825617435;6075.574709770318;6076.605020673642;6094.542909281821;6104.20645316106;6108.602940808878;5876.29484461863;6012.609180403259;6073.240844894388;6146.938530614681;6157.815265541996;5699.088145896637;5706.914396284059;5710.942890571083;5721.799737009184;5749.626274292157;6213.813585592439;6227.688615569204;6229.3770622937345;6276.152719382825;6285.371462853678;5743.913841292384;5953.464188223081;5978.790742324085;6009.579329446984;6078.483328917003;6126.050462178369;6155.507559395238;6156.199694039746;6166.599171053867;6168.691565421711;6130.356312587203;6138.815835524942;6147.754089836446;6152.323244443108;6152.938470615326;5893.263342082239;6101.725422356005;6113.993245360534;6135.447031106579;6220.03589443637;4699.718016918996;4708.976455117771;4742.762861856962;4759;4766.213574760126;4050.270951228807;4210.452641156691;4221.936670949938;4226.957730422718;4252.277112890816;5658.773649054074;5752.539796816244;5834.504067154339;5849.707514624251;5895.764169433261;6070.514358851281;6097.878042439126;6151.011974408179;6184.845378865564;6186.072089186658;5609.859753506195;5828.591998560145;5892.1161825726485;5903.881922361528;5924.851878702981;5026.095302845523;5097.133487307166;5098.566621837185;5141.537261646395;5177.7670004849115;6403.711832967528;6421.325760795143;6422.165118534561;6430.935690643128;6451.0645956337;5903.616264942765;6162.845928851814;6173.290071641639;6173.660448675366;6174.197354343906;6322.399372059647;6330.52521060913;6358.491320694241;6480.384363485461;6495.0906873036865;6080.148779170831;6096.177016102769;6097.237845269341;6099;6112.2970858351855;5920.644761314335;6036.939630603638;6200.782972595937;6203;6211.3478084802255;5980.102984552352;6056.939430605637;6083;6109.694515274307;6114.936124487504;5995.820125396245;6046.183765191819;6055.939440605537;6059.848503787441;6069.969650151721;5680.914786278292;5848.853778655568;5856.472917437451;5971.164037034731;5976.7908123215475;5984.311804142405;6022.307434645072;6029.78895738647;6062;6091.177691011657;5950.97024514892;5969.820905372846;5978.521718262616;5981.401859814157;5990.9700451497465 03:45:40 INFO - PROCESS | 8785 | |1;ext.html;604.2869414091373;650.677914432356;653.6502970910561;662.9900551491727;669.5480550628326;46087.76956115219;47497.52502474974;47554.81112972173;47726.28410573844;52409.737951310286;48893.7555312223;49403.50596494034;49447;49461.75269123649;49464.75267623657;9010.324225683084;9043.728688139367;9122.22461090808;9123.406978546407;9147.496887671176;9157.130072643122;9223.985361610217;9229.861552076723;9233.722988310361;9265.768355791126;9220.21628161607;9265.119813617695;9271.907280927206;9314.534273286343;9318.86021709675;9163.496007719572;9203.447793132433;9228.6308547658;9232.122948319966;9239.815203695922;9112.453252804853;9211.355205135644;9271.860922086174;9290.256779457695;9293.72118836436;45887;46210.30684539735;46287.53712462866;46332.53667463316;46365.84085397858;3739.8691045813266;3777.4050438182967;3799.848006079781;3867.690584753241;3966.861159859391;34666.82666586651;34811.30377392438;34867.476987845206;35207.119822004395;35310.64689353099;4781.928271075936;4848.200046992242;4868.610511159099;5086.21163719624;5095.133827249377;389873;392055;392946;393843;393982;38618.80690596585;39535.209295813926;39546.604533954865;69342;70299.64850175819;41761.1647767049;41789.791051045155;41849;41853.790731046756;41982.580174198476;17439.302427902996;17459.738103928452;17524.649507009788;17630.118494075246;17692.29230830778;14764.852351476562;14843.257837108318;14864.925675371771;14976;15030.473933412279;9225.446473211628;9294.209992150607;9312.348135630577;9372.765680857896;9383.953080234554;3513.7364697647267;3548.467729840493;3549.591796943333;3602.621724718867;3610.151614370621;1062.644014255233;1131.7453572946185;1156.7744289863397;1164.8660404053642;1196.2045239915533;33841.32317353639;33926.75915510561;34021;34107.829460853034;34549.654503455145;1187.074082215873;1187.441902305915;1196.8862958018974;1221.6823625857342;1222.2422098299112;17966.461006169837;18033.368832091077;18047.819521804875;18059.54851128732;18083.457496275132;638220;647289;649366;652343;703406;65952;65983.34016659867;66404.66797666077;66813;66944.6652766733;1462.5246794791735;1500.092444071321;1606.694728001676;1615;1691.222037862597;34439;35371.93884183479;35627;35807;35891.102722431104;59503;59521.40478595332;59853;59952.10071849013;59955;578023;580128;581677;582611;584468;30980.22549436282;31681.20796980094;31835.681643184198;31951.36097278088;32070.518942215418;54294;54298;54776.45223547713;55435.445645543026;55647;44974.77512612416;45614.54385456103;46202.306965396216;46256.53743462522;46770;44958;44980;45466;45619;46996;44819.327710085025;45465.77267113643;45794;45931.770341149415;46060.769696152645;39237.21525569416;39659.60340396559;40333;40422.19155616812;40610;30148.246293841952;30432.239194020327;30868.22829429282;31205.219869503446;31241 03:45:40 INFO - PROCESS | 8785 | |2;jquery.html;414.0993339486616;421.7848897062501;421.7891054472765;428.10312395531366;430.6296584936954;19505.804941950577;19804.60390792183;20296.695549566768;20488;20562.177512899503;18987.430377088676;19124;19371.32200372987;20063.197472101136;20079.297224597143;5579.13523403871;5709.257796486451;5731.684757338345;5735.684537350444;5739.885202295952;5458.2904222451025;5681.176229446728;5690.886182276352;5736.053551164053;5743.942560574383;5612.747426365803;5650.180723795047;5660.037793575102;5688.118341657029;5693.943060569382;5479.75341109651;5604.439556044384;5673.602847800656;5696.6866822324755;5701.600887937846;5079.1365467870555;5098.107831129538;5108.64239503235;5115.053715062725;5126.307948426952;22960.7703922962;23947.281581552583;24356.634650480257;24398.146064887645;24436.633450498255;2675.1172113202597;2799.1882354117283;2811.9297017574518;2877.978317697229;3211.213252753067;14707.779383309258;14779.630509237248;14805.481808136663;14915.105093694305;15105.32026058819;2037.5822956293923;2084.3538503064096;2090.0281369163413;2115.206797450956;2143.592717383692;80864.59567702124;82552.88519214629;85419.57290213509;85658.57170714169;85857.14142858617;10546.841797373045;10661.626843060456;11431.657050288504;11725.648230553097;11790.5873294436;15254.694906101815;15286;15291.541253762405;15326.770098448533;15380.615484612974;8732.083131271253;8827.24968377695;8937.508437036025;9026.413283136575;9148.039455857039;9062.728118156467;9067.95466022679;9105.635774569075;9191.264698824078;9269.44383337002;6751.797446076625;6825.112735344473;6836.829079273058;6879.690413931385;6968.79093627192;1912.4373339724837;1970.5369238229005;1991.8008199179967;1998.7301714268679;2048.9385318440472;416.5272415808019;992.2260636703382;1052.65783631421;1056.989430105689;1063.7606538528923;11344.829827552594;11968.581099661471;11972.281663100242;12034.699132521757;12090;432.2996745272678;445.8238995596721;445.91750526152765;462.57443152299965;467.9953200467952;5918.496927761103;6258.061290806416;6306.432421082125;6409.711562979677;6437.581557198767;400932;408596;574498;590361;594335;105512.47243763886;111736.44131779451;113620;115010;115971;1079.3416016230094;1153.2734377342388;1158.8783177766381;1158.8783177766381;1161.7386088130104;18519.259229630665;18598.721019184453;18619.534511637317;18704.345347912757;19049.238030478624;44234.55765442304;44675.77662111669;45082;45379.54620453753;46294.53705462902;62422.68788656028;62991;63463;63592;64349.356506434335;8079;8945.329100317373;8957.10428957099;9090.681876121547;9266.351355405057;12898.226106433644;13887.37506812216;14012.78980815309;14036.78944815849;14051.508197213048;11804.527818887149;11826.586069487526;12012.219205751599;12051;12088.395580220778;11922.52309907594;11991;12346.629601111981;12601.87398126007;12615.747685046064;12322.507099715911;12334.938325308316;12456.190347627375;12506.124571279923;12565;8526.829463410573;8665;8665.870011949952;8696.78258043554;8883.600237989176;12161.270323780602;12174.87825121773;12282.263064215818;12297.508099675913;12346.074044446523 03:45:40 INFO - PROCESS | 8785 | |3;mootools.html;1328.6213429172687;1444.0902231594093;1479.3638735343804;1813.4106415414985;1839.6320735852833;8011.519308841459;8718.782030449242;8965.417247878884;9330.30022748294;9336.766580835483;8963.551822408886;9423.905760942389;9426.76433089173;9465.716028519138;9502.524873756302;2483.3170878008514;2539.492101579682;2550.2859199424192;2552.208815267273;2553.846769193845;2470.0613766768693;2542.275451496324;2544.0841297133015;2558.9872050639815;2560.539102961466;2465.7287698353166;2474.6906636670415;2514.4342522932284;2526.280010197085;2551.107112510616;2418.117387153694;2427.041318679112;2435.1720415058967;2447.400386905211;2460.5447992121426;2383.7258715247794;2399.9040038398616;2420.745821688715;2423.1882319423016;2485.9005639774387;9395.107464790903;9479.90520094804;9498.857517137249;9506.619735210583;9516;5640;5739.741711622945;5786.247787787561;5794.043982742843;5796.797112101056;3642.8907132786057;3674.356987527172;3760.4206233382047;3785.5646600641003;3797.468354430382;1286.5239861251398;1305.7649623067844;1306.6472052545855;1339.946402143913;1349.062401630867;13344.466221351135;13598.456061757517;13625.386857591433;13653.86346136536;13739.381727822272;5115.360579927509;5170.27616133734;5268.315119034501;5269.051570717308;5307.416184219733;11357.37534435614;11367;11440.713982150346;11464.94267528657;11465.54137834494;5623.465770751772;5655.745491452894;5703.144528320702;5722.62802917809;5844.561657875592;4316.892077698019;5112.3865136183895;5269.367675878919;5271.868203294872;5286.233496143114;4343.804528796211;4345.717528360709;4364.54172311909;4368.170047690928;4434.977825110854;1309.993450032763;1423.5800438870558;1426.6290764401124;1427.6288165077156;1446.5009571697747;1052.6052730226165;1061.639042725477;1070.341739829999;1080.1089101491302;1088.4394536813547;6409.935900641027;6621.569597976116;6632.966835165793;6637.336266373421;6658.700358483879;475.4081168944686;488.6164360976616;489.22213680248575;490.8429302623126;497.64169797745564;4424.0709451015;4466.084452687256;4529.864104076817;4555.612772914273;4561.726296422159;11545.82681259765;11693.298402095901;11780.528778848922;11866.940665296619;11933.462994165284;11136.33182009082;11707.473163707653;11722.238054526428;11762.411879405996;11788.528458861549;8558.186972237627;8750.168733970262;8894.199522043047;8983.46099234048;9040.954795226113;6397.360263973752;6489.902651460137;6492.350764923659;6542.574732642363;6766.627835469097;10740.46297685097;10923.890761092605;10977.615783447542;10990;11102.777944440904;11231.943840280746;11235.494402751732;11278.210525263154;11299.943500282774;11390.031847293072;7739.690412383442;8998.775030624287;9114.726558203265;9208.12522810332;9255.53722313895;9367.484788336707;9494.762630934281;9524.333296669167;9569.61721531131;9580.856287155559;8367.372447066617;8454.91545084566;8485.533295668798;8560;8608.182222688834;8174.632141553526;8218.547979860927;8412.242898139197;8448.66205351779;8468.745937621881;7706.537607743553;7786.221377862168;7875.448718589644;7882.09355924076;7915.525068495908;5517.227588137584;5549.250851135045;5619.662820230799;5640.379558248672;5759.625624334405;5437.755301011385;5600.691961942132;5631.802886898939;5633.915491267716;5695.772169113189 03:45:40 INFO - PROCESS | 8785 | |4;prototype.html;358.5929969484634;360.9981950090249;364.8850612057202;368.90408493791625;369.6488336080724;5489.149181876815;5576.525995290395;5632.295963004624;5637.91543126853;5667.404922483137;5595.013770111613;5656.2929633795775;5691.715414229282;5753.884922301551;5768.42315768424;4376.781160941956;4403.669724770639;4409.867703968886;4421.712588681741;4439.66702497314;4173.5409104998425;4402.273624851896;4413.4041904342985;4421.292593185091;4433.911321773563;4279.315309550472;4366.323219900921;4371.497277813044;4373.819068851408;4381.211381951248;4244.490661120654;4338.869833904972;4347.369631403429;4378.62781663559;4388.561143885618;3870.0711829161082;3872.341701910682;3875.2755024014323;3881.4954055972826;3882.941755873664;5487.807926722546;5499.202615620713;5510.283663123809;5514;5545.362283337387;4812.903741925142;5056.848294551132;5081.5426611605135;5085.516875896784;5096.547483967051;5952.9107063394085;5956.22569066023;5962.135490353874;5967.5524335675;6000;4269.978650106761;4283.357496375537;4298.226319262531;4303.708887333819;4318.093200427914;6114.266288045463;6172.814815555541;6173.876522469571;6221.284552276501;6239.469645080174;4355.303151495746;4370.169667763178;4372.491490435795;4373.081652852937;4403.933940990888;4394.231009573312;4437.378766972562;4453.910921781546;4463.754493502888;4479.574440428154;4787.2101103318255;5041.966396888629;5076.314697515862;5080.288759573663;5097.006083813695;5717.285339332583;5897.469227769521;5928.555358348141;5947.9702601486715;5966.313873904556;1511.5692027772031;1518.119490695394;1520.3158578639657;1523.5200911712775;1536.8002159719388;963.0898800633474;970.7670159161751;985.6254623243265;985.9351899948039;991.7074463033423;5180.430152683201;5209.062368773657;5220.504052115043;5229.71871891389;5251.422343542207;5432.945670543244;5507.586930980193;5531.944680553223;5538.750756215899;5544.556435485151;4942.505749425029;5085.364329458817;5146.897062058738;5169.25045868347;5171.3535808024;2918.9054104710735;2943.7939344246124;2949.778766592471;2953.1583498702767;2977.7468915142454;5668.688222147822;5707.143928410688;5722.54219662426;5726;5763.221965034751;5294.49702278283;5574.470425309589;5588.776448941997;5638.19577735129;5639.943600563942;5726.570507211975;5733.531213615703;5748.683822389725;5750.91684903723;5779.682117483579;5423.83728488146;5496.697681627549;5507.421720719267;5701.230333904869;6196.349383314687;6035;6063.544749260234;6071.787487437919;6106.725197366218;6119.724612392542;6222.408871157233;6464.644444555594;6475.514336424692;6486.318936511599;6493.123428337114;4328.766301604028;4369.978150109229;4374.266083697689;4379.737215767064;4389.736615803062;5925.133582921366;6089.878202435838;6184.484801223729;6192.256929168529;6241.625502469685;5997.880042399215;6001.129836173817;6010.166899095818;6031.457168854648;6040;5918.408159184047;5988.371221021905;6002.339742628395;6043.486303664238;6050.9394906050375;5660.773569057192;5945.40545945402;5945.464908158287;5949.315828679584;5994.820155395345;6124.101528526171;6125.785597504066;6128.417800308964;6131.754729810936;6169.1054797053275;5641.887162256814;5885.558583106199;5922.378150294157;5963;6011.158437818796 03:45:40 INFO - PROCESS | 8785 | |5;yui.html;800.6157044618583;814.2712272516098;888.2627419242029;889.8531742262526;911.0434044253534;16585.75121373179;16830.326786928523;16853.41013064543;17106.973581585113;17227.91386043068;15773.290201940912;15814.604634884134;15820.288087036082;15845.603859903507;16031.278592463337;843.7384410832661;863.3179787967498;864.3258258558335;867.6225841758824;869.430523007428;855.5764896376303;856.1695155698962;858.8368210040072;859.188067276424;861.3668953319306;900.4867225681364;900.7928176519405;904.2359206470522;905.4657751926362;908.246155690775;897.0849733272026;899.8605216191468;901.3285102598574;903.6114470777563;904.1094521895927;660.6630618384611;661.7783042680708;663.698017402081;663.7146027208298;665.8235567574596;15164.696706065817;15203.771943420857;15259.465918692793;15268.16025118618;15287.312070956834;14140.434382624786;14306.785398219035;14530;14601.12393256408;14653.41386344545;12294.508219671203;12617;12633.431495582628;12719.30043847588;12776.936115319457;4082.7754473503946;4098.549159592442;4098.815553300109;4108.712390132662;4186.58134186582;80600.59699701522;83244.16755832486;83674.58162709148;85116;85356;10203.42362809344;11305.604303849326;11310.09519238459;11381.487833047533;11618.360990145455;20800.167993280404;21549.67675484869;21659.241926532497;21751.78248217529;21824.672629910565;9320.254379649612;9416.62333506652;9623;9640.807183856425;9746.853797192905;5188.662736922163;5235.214717792362;5312.203169524602;5367.221752845893;5407.351117865881;3820.4078367853026;3889.3388124018984;3908.9609103908597;3911.413288006822;3917.764934103963;702.4380495603497;705.8059033765653;714.4891402647029;715.1096884378982;716.0154787167645;696.9372756451842;745.2361329637057;749.9550026998397;755.2447552447552;761.5925479868243;9914.900850991542;10169.593216271414;10220;10242.283040187116;10294.330868493524;694.2883544367064;702.2380716922197;790.6205021589669;797.330242596222;813.6013353456764;4466.932996005063;4616.792244349012;4856.708597484162;4889.046635905964;5035.7985680572365;84900.57549712212;127440;136005;139337;139723.30138349446;112607;114114.42942785399;116281.41859290819;117953.41023295;120674.39662801806;100006.49996750115;100936.49531752295;102615.48692256492;104875.95124048814;105559;9820.558074886505;9840.458774767456;9952.054554817281;9953.303268771406;10079.99200079986;47608.76195619;56475.71762141163;56798.43201567931;56978;57230;67145;71685.28314716787;72253;72493.27506724866;77581.22418775965;12791;12966.611001669966;14211.218382989035;14313.28433578296;14586.854131458975;16141.919290403473;16224.18879056066;16805.243764030405;17122.914385427994;17385.13074346303;13301.201927884358;13559.661008474866;13758.587242382744;13759.724805504035;13927.791083133558;13564.389602467716;13738.65653358674;13870.167789932637;13934.651633709238;14092.929535352258;12249.755004900031;12543.3101179436;12666.176698514568;12690.555830545887;12796.87203127994;11509.19672188176;11551.711207219887;11712.70718232051;11810.350430726392;11980.64058078259;10640.946795265974;10650.71009732911;10671.306365086244;10803.351798891777;10835.133189344991 03:45:40 INFO - PROCESS | 8785 | __end_tp_report 03:45:40 INFO - PROCESS | 8785 | __start_cc_report 03:45:40 INFO - PROCESS | 8785 | _x_x_mozilla_cycle_collect,333 03:45:40 INFO - PROCESS | 8785 | __end_cc_report 03:45:40 INFO - PROCESS | 8785 | __startTimestamp1469616340083__endTimestamp 03:45:40 INFO - PROCESS | 8785 | 03:45:40 INFO - PROCESS | 8785 | ------- Summary: start ------- 03:45:40 INFO - PROCESS | 8785 | Number of tests: 6 03:45:40 INFO - PROCESS | 8785 | 03:45:40 INFO - PROCESS | 8785 | [#0] dojo.html Cycles:165 Average:5691.15 Median:5924.85 stddev:644.60 (10.9%) stddev-sans-first:619.68 03:45:40 INFO - PROCESS | 8785 | Values: 3342.4 3394.4 3423.5 3423.6 3424.1 5610.6 5632.4 5643.0 5697.3 5733.5 5685.7 5711.6 5734.5 5736.4 5753.3 5163.6 5193.5 5228.7 5239.7 5246.0 5141.7 5204.9 5242.6 5267.0 5292.0 5193.1 5204.2 5207.1 5210.1 5213.2 5270.6 5288.9 5290.1 5293.3 5295.0 4967.7 5054.8 5056.1 5187.6 5196.1 5565.0 5576.7 5581.2 5585.2 5617.4 6075.6 6076.6 6094.5 6104.2 6108.6 5876.3 6012.6 6073.2 6146.9 6157.8 5699.1 5706.9 5710.9 5721.8 5749.6 6213.8 6227.7 6229.4 6276.2 6285.4 5743.9 5953.5 5978.8 6009.6 6078.5 6126.1 6155.5 6156.2 6166.6 6168.7 6130.4 6138.8 6147.8 6152.3 6152.9 5893.3 6101.7 6114.0 6135.4 6220.0 4699.7 4709.0 4742.8 4759.0 4766.2 4050.3 4210.5 4221.9 4227.0 4252.3 5658.8 5752.5 5834.5 5849.7 5895.8 6070.5 6097.9 6151.0 6184.8 6186.1 5609.9 5828.6 5892.1 5903.9 5924.9 5026.1 5097.1 5098.6 5141.5 5177.8 6403.7 6421.3 6422.2 6430.9 6451.1 5903.6 6162.8 6173.3 6173.7 6174.2 6322.4 6330.5 6358.5 6480.4 6495.1 6080.1 6096.2 6097.2 6099.0 6112.3 5920.6 6036.9 6200.8 6203.0 6211.3 5980.1 6056.9 6083.0 6109.7 6114.9 5995.8 6046.2 6055.9 6059.8 6070.0 5680.9 5848.9 5856.5 5971.2 5976.8 5984.3 6022.3 6029.8 6062.0 6091.2 5951.0 5969.8 5978.5 5981.4 5991.0 03:45:40 INFO - PROCESS | 8785 | 03:45:40 INFO - PROCESS | 8785 | [#1] ext.html Cycles:180 Average:69921.69 Median:45706.50 stddev:148284.04 (324.4%) stddev-sans-first:148608.68 03:45:40 INFO - PROCESS | 8785 | Values: 604.3 650.7 653.7 663.0 669.5 46087.8 47497.5 47554.8 47726.3 52409.7 48893.8 49403.5 49447.0 49461.8 49464.8 9010.3 9043.7 9122.2 9123.4 9147.5 9157.1 9224.0 9229.9 9233.7 9265.8 9220.2 9265.1 9271.9 9314.5 9318.9 9163.5 9203.4 9228.6 9232.1 9239.8 9112.5 9211.4 9271.9 9290.3 9293.7 45887.0 46210.3 46287.5 46332.5 46365.8 3739.9 3777.4 3799.8 3867.7 3966.9 34666.8 34811.3 34867.5 35207.1 35310.6 4781.9 4848.2 4868.6 5086.2 5095.1 389873.0 392055.0 392946.0 393843.0 393982.0 38618.8 39535.2 39546.6 69342.0 70299.6 41761.2 41789.8 41849.0 41853.8 41982.6 17439.3 17459.7 17524.6 17630.1 17692.3 14764.9 14843.3 14864.9 14976.0 15030.5 9225.4 9294.2 9312.3 9372.8 9384.0 3513.7 3548.5 3549.6 3602.6 3610.2 1062.6 1131.7 1156.8 1164.9 1196.2 33841.3 33926.8 34021.0 34107.8 34549.7 1187.1 1187.4 1196.9 1221.7 1222.2 17966.5 18033.4 18047.8 18059.5 18083.5 638220.0 647289.0 649366.0 652343.0 703406.0 65952.0 65983.3 66404.7 66813.0 66944.7 1462.5 1500.1 1606.7 1615.0 1691.2 34439.0 35371.9 35627.0 35807.0 35891.1 59503.0 59521.4 59853.0 59952.1 59955.0 578023.0 580128.0 581677.0 582611.0 584468.0 30980.2 31681.2 31835.7 31951.4 32070.5 54294.0 54298.0 54776.5 55435.4 55647.0 44974.8 45614.5 46202.3 46256.5 46770.0 44958.0 44980.0 45466.0 45619.0 46996.0 44819.3 45465.8 45794.0 45931.8 46060.8 39237.2 39659.6 40333.0 40422.2 40610.0 30148.2 30432.2 30868.2 31205.2 31241.0 03:45:40 INFO - PROCESS | 8785 | 03:45:40 INFO - PROCESS | 8785 | [#2] jquery.html Cycles:180 Average:30651.45 Median:2844.95 stddev:86464.95 (3039.2%) stddev-sans-first:86677.70 03:45:40 INFO - PROCESS | 8785 | Values: 414.1 421.8 421.8 428.1 430.6 19505.8 19804.6 20296.7 20488.0 20562.2 18987.4 19124.0 19371.3 20063.2 20079.3 5579.1 5709.3 5731.7 5735.7 5739.9 5458.3 5681.2 5690.9 5736.1 5743.9 5612.7 5650.2 5660.0 5688.1 5693.9 5479.8 5604.4 5673.6 5696.7 5701.6 5079.1 5098.1 5108.6 5115.1 5126.3 22960.8 23947.3 24356.6 24398.1 24436.6 2675.1 2799.2 2811.9 2878.0 3211.2 14707.8 14779.6 14805.5 14915.1 15105.3 2037.6 2084.4 2090.0 2115.2 2143.6 80864.6 82552.9 85419.6 85658.6 85857.1 10546.8 10661.6 11431.7 11725.6 11790.6 15254.7 15286.0 15291.5 15326.8 15380.6 8732.1 8827.2 8937.5 9026.4 9148.0 9062.7 9068.0 9105.6 9191.3 9269.4 6751.8 6825.1 6836.8 6879.7 6968.8 1912.4 1970.5 1991.8 1998.7 2048.9 416.5 992.2 1052.7 1057.0 1063.8 11344.8 11968.6 11972.3 12034.7 12090.0 432.3 445.8 445.9 462.6 468.0 5918.5 6258.1 6306.4 6409.7 6437.6 400932.0 408596.0 574498.0 590361.0 594335.0 105512.5 111736.4 113620.0 115010.0 115971.0 1079.3 1153.3 1158.9 1158.9 1161.7 18519.3 18598.7 18619.5 18704.3 19049.2 44234.6 44675.8 45082.0 45379.5 46294.5 62422.7 62991.0 63463.0 63592.0 64349.4 8079.0 8945.3 8957.1 9090.7 9266.4 12898.2 13887.4 14012.8 14036.8 14051.5 11804.5 11826.6 12012.2 12051.0 12088.4 11922.5 11991.0 12346.6 12601.9 12615.7 12322.5 12334.9 12456.2 12506.1 12565.0 8526.8 8665.0 8665.9 8696.8 8883.6 12161.3 12174.9 12282.3 12297.5 12346.1 03:45:40 INFO - PROCESS | 8785 | 03:45:40 INFO - PROCESS | 8785 | [#3] mootools.html Cycles:180 Average:6311.93 Median:2518.57 stddev:3618.14 (143.7%) stddev-sans-first:3608.90 03:45:40 INFO - PROCESS | 8785 | Values: 1328.6 1444.1 1479.4 1813.4 1839.6 8011.5 8718.8 8965.4 9330.3 9336.8 8963.6 9423.9 9426.8 9465.7 9502.5 2483.3 2539.5 2550.3 2552.2 2553.8 2470.1 2542.3 2544.1 2559.0 2560.5 2465.7 2474.7 2514.4 2526.3 2551.1 2418.1 2427.0 2435.2 2447.4 2460.5 2383.7 2399.9 2420.7 2423.2 2485.9 9395.1 9479.9 9498.9 9506.6 9516.0 5640.0 5739.7 5786.2 5794.0 5796.8 3642.9 3674.4 3760.4 3785.6 3797.5 1286.5 1305.8 1306.6 1339.9 1349.1 13344.5 13598.5 13625.4 13653.9 13739.4 5115.4 5170.3 5268.3 5269.1 5307.4 11357.4 11367.0 11440.7 11464.9 11465.5 5623.5 5655.7 5703.1 5722.6 5844.6 4316.9 5112.4 5269.4 5271.9 5286.2 4343.8 4345.7 4364.5 4368.2 4435.0 1310.0 1423.6 1426.6 1427.6 1446.5 1052.6 1061.6 1070.3 1080.1 1088.4 6409.9 6621.6 6633.0 6637.3 6658.7 475.4 488.6 489.2 490.8 497.6 4424.1 4466.1 4529.9 4555.6 4561.7 11545.8 11693.3 11780.5 11866.9 11933.5 11136.3 11707.5 11722.2 11762.4 11788.5 8558.2 8750.2 8894.2 8983.5 9041.0 6397.4 6489.9 6492.4 6542.6 6766.6 10740.5 10923.9 10977.6 10990.0 11102.8 11231.9 11235.5 11278.2 11299.9 11390.0 7739.7 8998.8 9114.7 9208.1 9255.5 9367.5 9494.8 9524.3 9569.6 9580.9 8367.4 8454.9 8485.5 8560.0 8608.2 8174.6 8218.5 8412.2 8448.7 8468.7 7706.5 7786.2 7875.4 7882.1 7915.5 5517.2 5549.3 5619.7 5640.4 5759.6 5437.8 5600.7 5631.8 5633.9 5695.8 03:45:40 INFO - PROCESS | 8785 | 03:45:40 INFO - PROCESS | 8785 | [#4] prototype.html Cycles:180 Average:4906.15 Median:5522.97 stddev:1438.52 (26.0%) stddev-sans-first:1401.48 03:45:40 INFO - PROCESS | 8785 | Values: 358.6 361.0 364.9 368.9 369.6 5489.1 5576.5 5632.3 5637.9 5667.4 5595.0 5656.3 5691.7 5753.9 5768.4 4376.8 4403.7 4409.9 4421.7 4439.7 4173.5 4402.3 4413.4 4421.3 4433.9 4279.3 4366.3 4371.5 4373.8 4381.2 4244.5 4338.9 4347.4 4378.6 4388.6 3870.1 3872.3 3875.3 3881.5 3882.9 5487.8 5499.2 5510.3 5514.0 5545.4 4812.9 5056.8 5081.5 5085.5 5096.5 5952.9 5956.2 5962.1 5967.6 6000.0 4270.0 4283.4 4298.2 4303.7 4318.1 6114.3 6172.8 6173.9 6221.3 6239.5 4355.3 4370.2 4372.5 4373.1 4403.9 4394.2 4437.4 4453.9 4463.8 4479.6 4787.2 5042.0 5076.3 5080.3 5097.0 5717.3 5897.5 5928.6 5948.0 5966.3 1511.6 1518.1 1520.3 1523.5 1536.8 963.1 970.8 985.6 985.9 991.7 5180.4 5209.1 5220.5 5229.7 5251.4 5432.9 5507.6 5531.9 5538.8 5544.6 4942.5 5085.4 5146.9 5169.3 5171.4 2918.9 2943.8 2949.8 2953.2 2977.7 5668.7 5707.1 5722.5 5726.0 5763.2 5294.5 5574.5 5588.8 5638.2 5639.9 5726.6 5733.5 5748.7 5750.9 5779.7 5423.8 5496.7 5507.4 5701.2 6196.3 6035.0 6063.5 6071.8 6106.7 6119.7 6222.4 6464.6 6475.5 6486.3 6493.1 4328.8 4370.0 4374.3 4379.7 4389.7 5925.1 6089.9 6184.5 6192.3 6241.6 5997.9 6001.1 6010.2 6031.5 6040.0 5918.4 5988.4 6002.3 6043.5 6050.9 5660.8 5945.4 5945.5 5949.3 5994.8 6124.1 6125.8 6128.4 6131.8 6169.1 5641.9 5885.6 5922.4 5963.0 6011.2 03:45:40 INFO - PROCESS | 8785 | 03:45:40 INFO - PROCESS | 8785 | [#5] yui.html Cycles:180 Average:22534.05 Median:3899.15 stddev:33691.31 (864.1%) stddev-sans-first:33746.30 03:45:40 INFO - PROCESS | 8785 | Values: 800.6 814.3 888.3 889.9 911.0 16585.8 16830.3 16853.4 17107.0 17227.9 15773.3 15814.6 15820.3 15845.6 16031.3 843.7 863.3 864.3 867.6 869.4 855.6 856.2 858.8 859.2 861.4 900.5 900.8 904.2 905.5 908.2 897.1 899.9 901.3 903.6 904.1 660.7 661.8 663.7 663.7 665.8 15164.7 15203.8 15259.5 15268.2 15287.3 14140.4 14306.8 14530.0 14601.1 14653.4 12294.5 12617.0 12633.4 12719.3 12776.9 4082.8 4098.5 4098.8 4108.7 4186.6 80600.6 83244.2 83674.6 85116.0 85356.0 10203.4 11305.6 11310.1 11381.5 11618.4 20800.2 21549.7 21659.2 21751.8 21824.7 9320.3 9416.6 9623.0 9640.8 9746.9 5188.7 5235.2 5312.2 5367.2 5407.4 3820.4 3889.3 3909.0 3911.4 3917.8 702.4 705.8 714.5 715.1 716.0 696.9 745.2 750.0 755.2 761.6 9914.9 10169.6 10220.0 10242.3 10294.3 694.3 702.2 790.6 797.3 813.6 4466.9 4616.8 4856.7 4889.0 5035.8 84900.6 127440.0 136005.0 139337.0 139723.3 112607.0 114114.4 116281.4 117953.4 120674.4 100006.5 100936.5 102615.5 104876.0 105559.0 9820.6 9840.5 9952.1 9953.3 10080.0 47608.8 56475.7 56798.4 56978.0 57230.0 67145.0 71685.3 72253.0 72493.3 77581.2 12791.0 12966.6 14211.2 14313.3 14586.9 16141.9 16224.2 16805.2 17122.9 17385.1 13301.2 13559.7 13758.6 13759.7 13927.8 13564.4 13738.7 13870.2 13934.7 14092.9 12249.8 12543.3 12666.2 12690.6 12796.9 11509.2 11551.7 11712.7 11810.4 11980.6 10640.9 10650.7 10671.3 10803.4 10835.1 03:45:40 INFO - PROCESS | 8785 | -------- Summary: end -------- 03:45:40 INFO - PROCESS | 8785 | 03:45:40 INFO - TEST-INFO | 8785: exit 0 03:45:40 INFO - TEST-OK | dromaeo_css | took 1111365ms 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 9031 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptwJ_xO/profile http://localhost:60680/getInfo.html) 03:45:46 INFO - PROCESS | 9031 | __metrics Screen width/height:1600/1200 03:45:46 INFO - PROCESS | 9031 | colorDepth:24 03:45:46 INFO - PROCESS | 9031 | Browser inner width/height: 1024/697 03:45:46 INFO - PROCESS | 9031 | __metrics 03:45:47 ERROR - PROCESS | 9031 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 03:45:48 INFO - TEST-INFO | 9031: exit 0 03:45:48 INFO - Browser initialized. 03:45:48 INFO - Running cycle 1/1 for kraken test... 03:45:48 INFO - TEST-INFO | started process 9160 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptwJ_xO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:46:00 INFO - PROCESS | 9160 | RSS: Main: 156250112 03:46:00 INFO - PROCESS | 9160 | 03:46:03 INFO - PROCESS | 9160 | Cycle 1(1): loaded http://localhost:60680/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60680/tests/kraken/driver.html?testName=audio-beat-detection) 03:46:03 INFO - PROCESS | 9160 | RSS: Main: 162021376 03:46:03 INFO - PROCESS | 9160 | 03:46:06 INFO - PROCESS | 9160 | Cycle 1(1): loaded http://localhost:60680/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60680/tests/kraken/driver.html?testName=audio-dft) 03:46:07 INFO - PROCESS | 9160 | RSS: Main: 161124352 03:46:07 INFO - PROCESS | 9160 | 03:46:10 INFO - PROCESS | 9160 | Cycle 1(1): loaded http://localhost:60680/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60680/tests/kraken/driver.html?testName=audio-fft) 03:46:10 INFO - PROCESS | 9160 | RSS: Main: 162091008 03:46:10 INFO - PROCESS | 9160 | 03:46:12 INFO - PROCESS | 9160 | Cycle 1(1): loaded http://localhost:60680/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60680/tests/kraken/driver.html?testName=audio-oscillator) 03:46:13 INFO - PROCESS | 9160 | RSS: Main: 161280000 03:46:13 INFO - PROCESS | 9160 | 03:46:15 INFO - PROCESS | 9160 | Cycle 1(1): loaded http://localhost:60680/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60680/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:46:16 INFO - PROCESS | 9160 | RSS: Main: 161038336 03:46:16 INFO - PROCESS | 9160 | 03:46:19 INFO - PROCESS | 9160 | Cycle 1(1): loaded http://localhost:60680/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60680/tests/kraken/driver.html?testName=imaging-darkroom) 03:46:19 INFO - PROCESS | 9160 | RSS: Main: 160800768 03:46:19 INFO - PROCESS | 9160 | 03:46:23 INFO - PROCESS | 9160 | Cycle 1(1): loaded http://localhost:60680/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60680/tests/kraken/driver.html?testName=imaging-desaturate) 03:46:24 INFO - PROCESS | 9160 | RSS: Main: 161112064 03:46:24 INFO - PROCESS | 9160 | 03:46:26 INFO - PROCESS | 9160 | Cycle 1(1): loaded http://localhost:60680/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60680/tests/kraken/driver.html?testName=json-parse-financial) 03:46:27 INFO - PROCESS | 9160 | RSS: Main: 160727040 03:46:27 INFO - PROCESS | 9160 | 03:46:28 INFO - PROCESS | 9160 | Cycle 1(1): loaded http://localhost:60680/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60680/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:46:29 INFO - PROCESS | 9160 | RSS: Main: 160665600 03:46:29 INFO - PROCESS | 9160 | 03:46:31 INFO - PROCESS | 9160 | Cycle 1(1): loaded http://localhost:60680/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60680/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:46:32 INFO - PROCESS | 9160 | RSS: Main: 161124352 03:46:32 INFO - PROCESS | 9160 | 03:46:34 INFO - PROCESS | 9160 | Cycle 1(1): loaded http://localhost:60680/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60680/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:46:34 INFO - PROCESS | 9160 | RSS: Main: 162451456 03:46:34 INFO - PROCESS | 9160 | 03:46:37 INFO - PROCESS | 9160 | Cycle 1(1): loaded http://localhost:60680/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60680/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:46:37 INFO - PROCESS | 9160 | RSS: Main: 162099200 03:46:37 INFO - PROCESS | 9160 | 03:46:40 INFO - PROCESS | 9160 | Cycle 1(1): loaded http://localhost:60680/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60680/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:46:41 INFO - PROCESS | 9160 | RSS: Main: 161533952 03:46:41 INFO - PROCESS | 9160 | 03:46:42 INFO - PROCESS | 9160 | Cycle 1(1): loaded http://localhost:60680/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60680/tests/kraken/driver.html?testName=ai-astar) 03:46:43 INFO - PROCESS | 9160 | RSS: Main: 162271232 03:46:43 INFO - PROCESS | 9160 | 03:46:43 INFO - PROCESS | 9160 | __start_tp_report 03:46:43 INFO - PROCESS | 9160 | _x_x_mozilla_page_load 03:46:43 INFO - PROCESS | 9160 | _x_x_mozilla_page_load_details 03:46:43 INFO - PROCESS | 9160 | |i|pagename|runs| 03:46:43 INFO - PROCESS | 9160 | |0;ai-astar;111;105;113;113;114;113;113;116;111;111 03:46:43 INFO - PROCESS | 9160 | |1;audio-beat-detection;164;125;152;176;131;156;153;126;177;127 03:46:43 INFO - PROCESS | 9160 | |2;audio-dft;163;162;163;163;162;162;161;163;163;162 03:46:43 INFO - PROCESS | 9160 | |3;audio-fft;74;75;77;168;77;75;75;76;170;75 03:46:43 INFO - PROCESS | 9160 | |4;audio-oscillator;85;84;149;85;85;84;143;83;84;135 03:46:43 INFO - PROCESS | 9160 | |5;imaging-gaussian-blur;117;117;117;117;118;117;117;116;118;118 03:46:43 INFO - PROCESS | 9160 | |6;imaging-darkroom;146;147;146;147;147;147;147;147;147;147 03:46:43 INFO - PROCESS | 9160 | |7;imaging-desaturate;96;95;96;95;95;95;95;95;96;95 03:46:43 INFO - PROCESS | 9160 | |8;json-parse-financial;55;57;55;55;55;56;57;55;55;54 03:46:43 INFO - PROCESS | 9160 | |9;json-stringify-tinderbox;61;61;60;61;62;61;60;61;61;62 03:46:43 INFO - PROCESS | 9160 | |10;stanford-crypto-aes;76;76;82;77;78;82;83;76;108;78 03:46:43 INFO - PROCESS | 9160 | |11;stanford-crypto-ccm;118;120;134;117;117;125;121;123;134;125 03:46:43 INFO - PROCESS | 9160 | |12;stanford-crypto-pbkdf2;153;154;156;153;154;155;155;152;157;161 03:46:43 INFO - PROCESS | 9160 | |13;stanford-crypto-sha256-iterative;68;62;62;61;62;67;65;62;62;61 03:46:43 INFO - PROCESS | 9160 | __end_tp_report 03:46:43 INFO - PROCESS | 9160 | __start_cc_report 03:46:43 INFO - PROCESS | 9160 | _x_x_mozilla_cycle_collect,927 03:46:43 INFO - PROCESS | 9160 | __end_cc_report 03:46:43 INFO - PROCESS | 9160 | __startTimestamp1469616403070__endTimestamp 03:46:43 INFO - PROCESS | 9160 | 03:46:43 INFO - PROCESS | 9160 | ------- Summary: start ------- 03:46:43 INFO - PROCESS | 9160 | Number of tests: 14 03:46:43 INFO - PROCESS | 9160 | 03:46:43 INFO - PROCESS | 9160 | [#0] ai-astar Cycles:10 Average:112.00 Median:113.00 stddev:2.91 (2.6%) stddev-sans-first:3.06 03:46:43 INFO - PROCESS | 9160 | Values: 111.0 105.0 113.0 113.0 114.0 113.0 113.0 116.0 111.0 111.0 03:46:43 INFO - PROCESS | 9160 | 03:46:43 INFO - PROCESS | 9160 | [#1] audio-beat-detection Cycles:10 Average:148.70 Median:154.50 stddev:20.34 (13.2%) stddev-sans-first:20.81 03:46:43 INFO - PROCESS | 9160 | Values: 164.0 125.0 152.0 176.0 131.0 156.0 153.0 126.0 177.0 127.0 03:46:43 INFO - PROCESS | 9160 | 03:46:43 INFO - PROCESS | 9160 | [#2] audio-dft Cycles:10 Average:162.40 Median:163.00 stddev:0.70 (0.4%) stddev-sans-first:0.71 03:46:43 INFO - PROCESS | 9160 | Values: 163.0 162.0 163.0 163.0 162.0 162.0 161.0 163.0 163.0 162.0 03:46:43 INFO - PROCESS | 9160 | 03:46:43 INFO - PROCESS | 9160 | [#3] audio-fft Cycles:10 Average:94.20 Median:75.00 stddev:39.44 (52.6%) stddev-sans-first:41.15 03:46:43 INFO - PROCESS | 9160 | Values: 74.0 75.0 77.0 168.0 77.0 75.0 75.0 76.0 170.0 75.0 03:46:43 INFO - PROCESS | 9160 | 03:46:43 INFO - PROCESS | 9160 | [#4] audio-oscillator Cycles:10 Average:101.70 Median:84.00 stddev:28.24 (33.6%) stddev-sans-first:29.30 03:46:43 INFO - PROCESS | 9160 | Values: 85.0 84.0 149.0 85.0 85.0 84.0 143.0 83.0 84.0 135.0 03:46:43 INFO - PROCESS | 9160 | 03:46:43 INFO - PROCESS | 9160 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 03:46:43 INFO - PROCESS | 9160 | Values: 117.0 117.0 117.0 117.0 118.0 117.0 117.0 116.0 118.0 118.0 03:46:43 INFO - PROCESS | 9160 | 03:46:43 INFO - PROCESS | 9160 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.42 (0.3%) stddev-sans-first:0.33 03:46:43 INFO - PROCESS | 9160 | Values: 146.0 147.0 146.0 147.0 147.0 147.0 147.0 147.0 147.0 147.0 03:46:43 INFO - PROCESS | 9160 | 03:46:43 INFO - PROCESS | 9160 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 03:46:43 INFO - PROCESS | 9160 | Values: 96.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 03:46:43 INFO - PROCESS | 9160 | 03:46:43 INFO - PROCESS | 9160 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:55.00 stddev:0.97 (1.8%) stddev-sans-first:1.01 03:46:43 INFO - PROCESS | 9160 | Values: 55.0 57.0 55.0 55.0 55.0 56.0 57.0 55.0 55.0 54.0 03:46:43 INFO - PROCESS | 9160 | 03:46:43 INFO - PROCESS | 9160 | [#9] json-stringify-tinderbox Cycles:10 Average:61.00 Median:61.00 stddev:0.67 (1.1%) stddev-sans-first:0.71 03:46:43 INFO - PROCESS | 9160 | Values: 61.0 61.0 60.0 61.0 62.0 61.0 60.0 61.0 61.0 62.0 03:46:43 INFO - PROCESS | 9160 | 03:46:43 INFO - PROCESS | 9160 | [#10] stanford-crypto-aes Cycles:10 Average:81.60 Median:78.00 stddev:9.66 (12.4%) stddev-sans-first:10.03 03:46:43 INFO - PROCESS | 9160 | Values: 76.0 76.0 82.0 77.0 78.0 82.0 83.0 76.0 108.0 78.0 03:46:43 INFO - PROCESS | 9160 | 03:46:43 INFO - PROCESS | 9160 | [#11] stanford-crypto-ccm Cycles:10 Average:123.40 Median:124.00 stddev:6.31 (5.1%) stddev-sans-first:6.38 03:46:43 INFO - PROCESS | 9160 | Values: 118.0 120.0 134.0 117.0 117.0 125.0 121.0 123.0 134.0 125.0 03:46:43 INFO - PROCESS | 9160 | 03:46:43 INFO - PROCESS | 9160 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.00 Median:155.00 stddev:2.58 (1.7%) stddev-sans-first:2.64 03:46:43 INFO - PROCESS | 9160 | Values: 153.0 154.0 156.0 153.0 154.0 155.0 155.0 152.0 157.0 161.0 03:46:43 INFO - PROCESS | 9160 | 03:46:43 INFO - PROCESS | 9160 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.20 Median:62.00 stddev:2.53 (4.1%) stddev-sans-first:2.00 03:46:43 INFO - PROCESS | 9160 | Values: 68.0 62.0 62.0 61.0 62.0 67.0 65.0 62.0 62.0 61.0 03:46:43 INFO - PROCESS | 9160 | -------- Summary: end -------- 03:46:43 INFO - PROCESS | 9160 | 03:46:44 INFO - TEST-INFO | 9160: exit 0 03:46:44 INFO - TEST-OK | kraken | took 63203ms 03:46:44 INFO - SUITE-END | took 1174s 03:46:44 INFO - Completed test suite (00:19:34) 03:46:44 INFO - javascript benchmark 03:46:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7611.526215131613, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3342.3816593930123, 3394.422948098823, 3423.469362248852, 3423.6234014258434, 3424.075499615102, 5610.6353087049365, 5632.408597097302, 5643.012472817256, 5697.287839020122, 5733.455321744438, 5685.687287199203, 5711.600187986843, 5734.541236701064, 5736.368999410061, 5753.309602847654, 5163.638545301821, 5193.45468725784, 5228.712420816853, 5239.685618862881, 5245.973770131144, 5141.665791723544, 5204.947950520503, 5242.606804489659, 5267.0256002639635, 5292.047431462335, 5193.091209038422, 5204.167333226685, 5207.114790485608, 5210.088234558956, 5213.218017297398, 5270.604704647148, 5288.894222115536, 5290.074237008508, 5293.258943747878, 5295.020421222086, 4967.677100988461, 5054.772535235923, 5056.115179843513, 5187.636865419422, 5196.142636464979, 5565.026120428909, 5576.749046292886, 5581.2186293918885, 5585.190147428641, 5617.43825617435, 6075.574709770318, 6076.605020673642, 6094.542909281821, 6104.20645316106, 6108.602940808878, 5876.29484461863, 6012.609180403259, 6073.240844894388, 6146.938530614681, 6157.815265541996, 5699.088145896637, 5706.914396284059, 5710.942890571083, 5721.799737009184, 5749.626274292157, 6213.813585592439, 6227.688615569204, 6229.3770622937345, 6276.152719382825, 6285.371462853678, 5743.913841292384, 5953.464188223081, 5978.790742324085, 6009.579329446984, 6078.483328917003, 6126.050462178369, 6155.507559395238, 6156.199694039746, 6166.599171053867, 6168.691565421711, 6130.356312587203, 6138.815835524942, 6147.754089836446, 6152.323244443108, 6152.938470615326, 5893.263342082239, 6101.725422356005, 6113.993245360534, 6135.447031106579, 6220.03589443637, 4699.718016918996, 4708.976455117771, 4742.762861856962, 4759.0, 4766.213574760126, 4050.270951228807, 4210.452641156691, 4221.936670949938, 4226.957730422718, 4252.277112890816, 5658.773649054074, 5752.539796816244, 5834.504067154339, 5849.707514624251, 5895.764169433261, 6070.514358851281, 6097.878042439126, 6151.011974408179, 6184.845378865564, 6186.072089186658, 5609.859753506195, 5828.591998560145, 5892.1161825726485, 5903.881922361528, 5924.851878702981, 5026.095302845523, 5097.133487307166, 5098.566621837185, 5141.537261646395, 5177.7670004849115, 6403.711832967528, 6421.325760795143, 6422.165118534561, 6430.935690643128, 6451.0645956337, 5903.616264942765, 6162.845928851814, 6173.290071641639, 6173.660448675366, 6174.197354343906, 6322.399372059647, 6330.52521060913, 6358.491320694241, 6480.384363485461, 6495.0906873036865, 6080.148779170831, 6096.177016102769, 6097.237845269341, 6099.0, 6112.2970858351855, 5920.644761314335, 6036.939630603638, 6200.782972595937, 6203.0, 6211.3478084802255, 5980.102984552352, 6056.939430605637, 6083.0, 6109.694515274307, 6114.936124487504, 5995.820125396245, 6046.183765191819, 6055.939440605537, 6059.848503787441, 6069.969650151721, 5680.914786278292, 5848.853778655568, 5856.472917437451, 5971.164037034731, 5976.7908123215475, 5984.311804142405, 6022.307434645072, 6029.78895738647, 6062.0, 6091.177691011657, 5950.97024514892, 5969.820905372846, 5978.521718262616, 5981.401859814157, 5990.9700451497465], "value": 5648.590449127166, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [604.2869414091373, 650.677914432356, 653.6502970910561, 662.9900551491727, 669.5480550628326, 46087.76956115219, 47497.52502474974, 47554.81112972173, 47726.28410573844, 52409.737951310286, 48893.7555312223, 49403.50596494034, 49447.0, 49461.75269123649, 49464.75267623657, 9010.324225683084, 9043.728688139367, 9122.22461090808, 9123.406978546407, 9147.496887671176, 9157.130072643122, 9223.985361610217, 9229.861552076723, 9233.722988310361, 9265.768355791126, 9220.21628161607, 9265.119813617695, 9271.907280927206, 9314.534273286343, 9318.86021709675, 9163.496007719572, 9203.447793132433, 9228.6308547658, 9232.122948319966, 9239.815203695922, 9112.453252804853, 9211.355205135644, 9271.860922086174, 9290.256779457695, 9293.72118836436, 45887.0, 46210.30684539735, 46287.53712462866, 46332.53667463316, 46365.84085397858, 3739.8691045813266, 3777.4050438182967, 3799.848006079781, 3867.690584753241, 3966.861159859391, 34666.82666586651, 34811.30377392438, 34867.476987845206, 35207.119822004395, 35310.64689353099, 4781.928271075936, 4848.200046992242, 4868.610511159099, 5086.21163719624, 5095.133827249377, 389873.0, 392055.0, 392946.0, 393843.0, 393982.0, 38618.80690596585, 39535.209295813926, 39546.604533954865, 69342.0, 70299.64850175819, 41761.1647767049, 41789.791051045155, 41849.0, 41853.790731046756, 41982.580174198476, 17439.302427902996, 17459.738103928452, 17524.649507009788, 17630.118494075246, 17692.29230830778, 14764.852351476562, 14843.257837108318, 14864.925675371771, 14976.0, 15030.473933412279, 9225.446473211628, 9294.209992150607, 9312.348135630577, 9372.765680857896, 9383.953080234554, 3513.7364697647267, 3548.467729840493, 3549.591796943333, 3602.621724718867, 3610.151614370621, 1062.644014255233, 1131.7453572946185, 1156.7744289863397, 1164.8660404053642, 1196.2045239915533, 33841.32317353639, 33926.75915510561, 34021.0, 34107.829460853034, 34549.654503455145, 1187.074082215873, 1187.441902305915, 1196.8862958018974, 1221.6823625857342, 1222.2422098299112, 17966.461006169837, 18033.368832091077, 18047.819521804875, 18059.54851128732, 18083.457496275132, 638220.0, 647289.0, 649366.0, 652343.0, 703406.0, 65952.0, 65983.34016659867, 66404.66797666077, 66813.0, 66944.6652766733, 1462.5246794791735, 1500.092444071321, 1606.694728001676, 1615.0, 1691.222037862597, 34439.0, 35371.93884183479, 35627.0, 35807.0, 35891.102722431104, 59503.0, 59521.40478595332, 59853.0, 59952.10071849013, 59955.0, 578023.0, 580128.0, 581677.0, 582611.0, 584468.0, 30980.22549436282, 31681.20796980094, 31835.681643184198, 31951.36097278088, 32070.518942215418, 54294.0, 54298.0, 54776.45223547713, 55435.445645543026, 55647.0, 44974.77512612416, 45614.54385456103, 46202.306965396216, 46256.53743462522, 46770.0, 44958.0, 44980.0, 45466.0, 45619.0, 46996.0, 44819.327710085025, 45465.77267113643, 45794.0, 45931.770341149415, 46060.769696152645, 39237.21525569416, 39659.60340396559, 40333.0, 40422.19155616812, 40610.0, 30148.246293841952, 30432.239194020327, 30868.22829429282, 31205.219869503446, 31241.0], "value": 20904.86862680493, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [414.0993339486616, 421.7848897062501, 421.7891054472765, 428.10312395531366, 430.6296584936954, 19505.804941950577, 19804.60390792183, 20296.695549566768, 20488.0, 20562.177512899503, 18987.430377088676, 19124.0, 19371.32200372987, 20063.197472101136, 20079.297224597143, 5579.13523403871, 5709.257796486451, 5731.684757338345, 5735.684537350444, 5739.885202295952, 5458.2904222451025, 5681.176229446728, 5690.886182276352, 5736.053551164053, 5743.942560574383, 5612.747426365803, 5650.180723795047, 5660.037793575102, 5688.118341657029, 5693.943060569382, 5479.75341109651, 5604.439556044384, 5673.602847800656, 5696.6866822324755, 5701.600887937846, 5079.1365467870555, 5098.107831129538, 5108.64239503235, 5115.053715062725, 5126.307948426952, 22960.7703922962, 23947.281581552583, 24356.634650480257, 24398.146064887645, 24436.633450498255, 2675.1172113202597, 2799.1882354117283, 2811.9297017574518, 2877.978317697229, 3211.213252753067, 14707.779383309258, 14779.630509237248, 14805.481808136663, 14915.105093694305, 15105.32026058819, 2037.5822956293923, 2084.3538503064096, 2090.0281369163413, 2115.206797450956, 2143.592717383692, 80864.59567702124, 82552.88519214629, 85419.57290213509, 85658.57170714169, 85857.14142858617, 10546.841797373045, 10661.626843060456, 11431.657050288504, 11725.648230553097, 11790.5873294436, 15254.694906101815, 15286.0, 15291.541253762405, 15326.770098448533, 15380.615484612974, 8732.083131271253, 8827.24968377695, 8937.508437036025, 9026.413283136575, 9148.039455857039, 9062.728118156467, 9067.95466022679, 9105.635774569075, 9191.264698824078, 9269.44383337002, 6751.797446076625, 6825.112735344473, 6836.829079273058, 6879.690413931385, 6968.79093627192, 1912.4373339724837, 1970.5369238229005, 1991.8008199179967, 1998.7301714268679, 2048.9385318440472, 416.5272415808019, 992.2260636703382, 1052.65783631421, 1056.989430105689, 1063.7606538528923, 11344.829827552594, 11968.581099661471, 11972.281663100242, 12034.699132521757, 12090.0, 432.2996745272678, 445.8238995596721, 445.91750526152765, 462.57443152299965, 467.9953200467952, 5918.496927761103, 6258.061290806416, 6306.432421082125, 6409.711562979677, 6437.581557198767, 400932.0, 408596.0, 574498.0, 590361.0, 594335.0, 105512.47243763886, 111736.44131779451, 113620.0, 115010.0, 115971.0, 1079.3416016230094, 1153.2734377342388, 1158.8783177766381, 1158.8783177766381, 1161.7386088130104, 18519.259229630665, 18598.721019184453, 18619.534511637317, 18704.345347912757, 19049.238030478624, 44234.55765442304, 44675.77662111669, 45082.0, 45379.54620453753, 46294.53705462902, 62422.68788656028, 62991.0, 63463.0, 63592.0, 64349.356506434335, 8079.0, 8945.329100317373, 8957.10428957099, 9090.681876121547, 9266.351355405057, 12898.226106433644, 13887.37506812216, 14012.78980815309, 14036.78944815849, 14051.508197213048, 11804.527818887149, 11826.586069487526, 12012.219205751599, 12051.0, 12088.395580220778, 11922.52309907594, 11991.0, 12346.629601111981, 12601.87398126007, 12615.747685046064, 12322.507099715911, 12334.938325308316, 12456.190347627375, 12506.124571279923, 12565.0, 8526.829463410573, 8665.0, 8665.870011949952, 8696.78258043554, 8883.600237989176, 12161.270323780602, 12174.87825121773, 12282.263064215818, 12297.508099675913, 12346.074044446523], "value": 9316.85063497825, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1328.6213429172687, 1444.0902231594093, 1479.3638735343804, 1813.4106415414985, 1839.6320735852833, 8011.519308841459, 8718.782030449242, 8965.417247878884, 9330.30022748294, 9336.766580835483, 8963.551822408886, 9423.905760942389, 9426.76433089173, 9465.716028519138, 9502.524873756302, 2483.3170878008514, 2539.492101579682, 2550.2859199424192, 2552.208815267273, 2553.846769193845, 2470.0613766768693, 2542.275451496324, 2544.0841297133015, 2558.9872050639815, 2560.539102961466, 2465.7287698353166, 2474.6906636670415, 2514.4342522932284, 2526.280010197085, 2551.107112510616, 2418.117387153694, 2427.041318679112, 2435.1720415058967, 2447.400386905211, 2460.5447992121426, 2383.7258715247794, 2399.9040038398616, 2420.745821688715, 2423.1882319423016, 2485.9005639774387, 9395.107464790903, 9479.90520094804, 9498.857517137249, 9506.619735210583, 9516.0, 5640.0, 5739.741711622945, 5786.247787787561, 5794.043982742843, 5796.797112101056, 3642.8907132786057, 3674.356987527172, 3760.4206233382047, 3785.5646600641003, 3797.468354430382, 1286.5239861251398, 1305.7649623067844, 1306.6472052545855, 1339.946402143913, 1349.062401630867, 13344.466221351135, 13598.456061757517, 13625.386857591433, 13653.86346136536, 13739.381727822272, 5115.360579927509, 5170.27616133734, 5268.315119034501, 5269.051570717308, 5307.416184219733, 11357.37534435614, 11367.0, 11440.713982150346, 11464.94267528657, 11465.54137834494, 5623.465770751772, 5655.745491452894, 5703.144528320702, 5722.62802917809, 5844.561657875592, 4316.892077698019, 5112.3865136183895, 5269.367675878919, 5271.868203294872, 5286.233496143114, 4343.804528796211, 4345.717528360709, 4364.54172311909, 4368.170047690928, 4434.977825110854, 1309.993450032763, 1423.5800438870558, 1426.6290764401124, 1427.6288165077156, 1446.5009571697747, 1052.6052730226165, 1061.639042725477, 1070.341739829999, 1080.1089101491302, 1088.4394536813547, 6409.935900641027, 6621.569597976116, 6632.966835165793, 6637.336266373421, 6658.700358483879, 475.4081168944686, 488.6164360976616, 489.22213680248575, 490.8429302623126, 497.64169797745564, 4424.0709451015, 4466.084452687256, 4529.864104076817, 4555.612772914273, 4561.726296422159, 11545.82681259765, 11693.298402095901, 11780.528778848922, 11866.940665296619, 11933.462994165284, 11136.33182009082, 11707.473163707653, 11722.238054526428, 11762.411879405996, 11788.528458861549, 8558.186972237627, 8750.168733970262, 8894.199522043047, 8983.46099234048, 9040.954795226113, 6397.360263973752, 6489.902651460137, 6492.350764923659, 6542.574732642363, 6766.627835469097, 10740.46297685097, 10923.890761092605, 10977.615783447542, 10990.0, 11102.777944440904, 11231.943840280746, 11235.494402751732, 11278.210525263154, 11299.943500282774, 11390.031847293072, 7739.690412383442, 8998.775030624287, 9114.726558203265, 9208.12522810332, 9255.53722313895, 9367.484788336707, 9494.762630934281, 9524.333296669167, 9569.61721531131, 9580.856287155559, 8367.372447066617, 8454.91545084566, 8485.533295668798, 8560.0, 8608.182222688834, 8174.632141553526, 8218.547979860927, 8412.242898139197, 8448.66205351779, 8468.745937621881, 7706.537607743553, 7786.221377862168, 7875.448718589644, 7882.09355924076, 7915.525068495908, 5517.227588137584, 5549.250851135045, 5619.662820230799, 5640.379558248672, 5759.625624334405, 5437.755301011385, 5600.691961942132, 5631.802886898939, 5633.915491267716, 5695.772169113189], "value": 4958.779845014804, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [358.5929969484634, 360.9981950090249, 364.8850612057202, 368.90408493791625, 369.6488336080724, 5489.149181876815, 5576.525995290395, 5632.295963004624, 5637.91543126853, 5667.404922483137, 5595.013770111613, 5656.2929633795775, 5691.715414229282, 5753.884922301551, 5768.42315768424, 4376.781160941956, 4403.669724770639, 4409.867703968886, 4421.712588681741, 4439.66702497314, 4173.5409104998425, 4402.273624851896, 4413.4041904342985, 4421.292593185091, 4433.911321773563, 4279.315309550472, 4366.323219900921, 4371.497277813044, 4373.819068851408, 4381.211381951248, 4244.490661120654, 4338.869833904972, 4347.369631403429, 4378.62781663559, 4388.561143885618, 3870.0711829161082, 3872.341701910682, 3875.2755024014323, 3881.4954055972826, 3882.941755873664, 5487.807926722546, 5499.202615620713, 5510.283663123809, 5514.0, 5545.362283337387, 4812.903741925142, 5056.848294551132, 5081.5426611605135, 5085.516875896784, 5096.547483967051, 5952.9107063394085, 5956.22569066023, 5962.135490353874, 5967.5524335675, 6000.0, 4269.978650106761, 4283.357496375537, 4298.226319262531, 4303.708887333819, 4318.093200427914, 6114.266288045463, 6172.814815555541, 6173.876522469571, 6221.284552276501, 6239.469645080174, 4355.303151495746, 4370.169667763178, 4372.491490435795, 4373.081652852937, 4403.933940990888, 4394.231009573312, 4437.378766972562, 4453.910921781546, 4463.754493502888, 4479.574440428154, 4787.2101103318255, 5041.966396888629, 5076.314697515862, 5080.288759573663, 5097.006083813695, 5717.285339332583, 5897.469227769521, 5928.555358348141, 5947.9702601486715, 5966.313873904556, 1511.5692027772031, 1518.119490695394, 1520.3158578639657, 1523.5200911712775, 1536.8002159719388, 963.0898800633474, 970.7670159161751, 985.6254623243265, 985.9351899948039, 991.7074463033423, 5180.430152683201, 5209.062368773657, 5220.504052115043, 5229.71871891389, 5251.422343542207, 5432.945670543244, 5507.586930980193, 5531.944680553223, 5538.750756215899, 5544.556435485151, 4942.505749425029, 5085.364329458817, 5146.897062058738, 5169.25045868347, 5171.3535808024, 2918.9054104710735, 2943.7939344246124, 2949.778766592471, 2953.1583498702767, 2977.7468915142454, 5668.688222147822, 5707.143928410688, 5722.54219662426, 5726.0, 5763.221965034751, 5294.49702278283, 5574.470425309589, 5588.776448941997, 5638.19577735129, 5639.943600563942, 5726.570507211975, 5733.531213615703, 5748.683822389725, 5750.91684903723, 5779.682117483579, 5423.83728488146, 5496.697681627549, 5507.421720719267, 5701.230333904869, 6196.349383314687, 6035.0, 6063.544749260234, 6071.787487437919, 6106.725197366218, 6119.724612392542, 6222.408871157233, 6464.644444555594, 6475.514336424692, 6486.318936511599, 6493.123428337114, 4328.766301604028, 4369.978150109229, 4374.266083697689, 4379.737215767064, 4389.736615803062, 5925.133582921366, 6089.878202435838, 6184.484801223729, 6192.256929168529, 6241.625502469685, 5997.880042399215, 6001.129836173817, 6010.166899095818, 6031.457168854648, 6040.0, 5918.408159184047, 5988.371221021905, 6002.339742628395, 6043.486303664238, 6050.9394906050375, 5660.773569057192, 5945.40545945402, 5945.464908158287, 5949.315828679584, 5994.820155395345, 6124.101528526171, 6125.785597504066, 6128.417800308964, 6131.754729810936, 6169.1054797053275, 5641.887162256814, 5885.558583106199, 5922.378150294157, 5963.0, 6011.158437818796], "value": 4451.849838192521, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [800.6157044618583, 814.2712272516098, 888.2627419242029, 889.8531742262526, 911.0434044253534, 16585.75121373179, 16830.326786928523, 16853.41013064543, 17106.973581585113, 17227.91386043068, 15773.290201940912, 15814.604634884134, 15820.288087036082, 15845.603859903507, 16031.278592463337, 843.7384410832661, 863.3179787967498, 864.3258258558335, 867.6225841758824, 869.430523007428, 855.5764896376303, 856.1695155698962, 858.8368210040072, 859.188067276424, 861.3668953319306, 900.4867225681364, 900.7928176519405, 904.2359206470522, 905.4657751926362, 908.246155690775, 897.0849733272026, 899.8605216191468, 901.3285102598574, 903.6114470777563, 904.1094521895927, 660.6630618384611, 661.7783042680708, 663.698017402081, 663.7146027208298, 665.8235567574596, 15164.696706065817, 15203.771943420857, 15259.465918692793, 15268.16025118618, 15287.312070956834, 14140.434382624786, 14306.785398219035, 14530.0, 14601.12393256408, 14653.41386344545, 12294.508219671203, 12617.0, 12633.431495582628, 12719.30043847588, 12776.936115319457, 4082.7754473503946, 4098.549159592442, 4098.815553300109, 4108.712390132662, 4186.58134186582, 80600.59699701522, 83244.16755832486, 83674.58162709148, 85116.0, 85356.0, 10203.42362809344, 11305.604303849326, 11310.09519238459, 11381.487833047533, 11618.360990145455, 20800.167993280404, 21549.67675484869, 21659.241926532497, 21751.78248217529, 21824.672629910565, 9320.254379649612, 9416.62333506652, 9623.0, 9640.807183856425, 9746.853797192905, 5188.662736922163, 5235.214717792362, 5312.203169524602, 5367.221752845893, 5407.351117865881, 3820.4078367853026, 3889.3388124018984, 3908.9609103908597, 3911.413288006822, 3917.764934103963, 702.4380495603497, 705.8059033765653, 714.4891402647029, 715.1096884378982, 716.0154787167645, 696.9372756451842, 745.2361329637057, 749.9550026998397, 755.2447552447552, 761.5925479868243, 9914.900850991542, 10169.593216271414, 10220.0, 10242.283040187116, 10294.330868493524, 694.2883544367064, 702.2380716922197, 790.6205021589669, 797.330242596222, 813.6013353456764, 4466.932996005063, 4616.792244349012, 4856.708597484162, 4889.046635905964, 5035.7985680572365, 84900.57549712212, 127440.0, 136005.0, 139337.0, 139723.30138349446, 112607.0, 114114.42942785399, 116281.41859290819, 117953.41023295, 120674.39662801806, 100006.49996750115, 100936.49531752295, 102615.48692256492, 104875.95124048814, 105559.0, 9820.558074886505, 9840.458774767456, 9952.054554817281, 9953.303268771406, 10079.99200079986, 47608.76195619, 56475.71762141163, 56798.43201567931, 56978.0, 57230.0, 67145.0, 71685.28314716787, 72253.0, 72493.27506724866, 77581.22418775965, 12791.0, 12966.611001669966, 14211.218382989035, 14313.28433578296, 14586.854131458975, 16141.919290403473, 16224.18879056066, 16805.243764030405, 17122.914385427994, 17385.13074346303, 13301.201927884358, 13559.661008474866, 13758.587242382744, 13759.724805504035, 13927.791083133558, 13564.389602467716, 13738.65653358674, 13870.167789932637, 13934.651633709238, 14092.929535352258, 12249.755004900031, 12543.3101179436, 12666.176698514568, 12690.555830545887, 12796.87203127994, 11509.19672188176, 11551.711207219887, 11712.70718232051, 11810.350430726392, 11980.64058078259, 10640.946795265974, 10650.71009732911, 10671.306365086244, 10803.351798891777, 10835.133189344991], "value": 8006.029538159843, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1517.9000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 105.0, 113.0, 113.0, 114.0, 113.0, 113.0, 116.0, 111.0, 111.0], "value": 112.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 125.0, 152.0, 176.0, 131.0, 156.0, 153.0, 126.0, 177.0, 127.0], "value": 148.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 163.0, 163.0, 162.0, 162.0, 161.0, 163.0, 163.0, 162.0], "value": 162.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 77.0, 168.0, 77.0, 75.0, 75.0, 76.0, 170.0, 75.0], "value": 94.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 149.0, 85.0, 85.0, 84.0, 143.0, 83.0, 84.0, 135.0], "value": 101.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 116.0, 118.0, 118.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 57.0, 55.0, 55.0, 55.0, 56.0, 57.0, 55.0, 55.0, 54.0], "value": 55.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 60.0, 61.0, 62.0, 61.0, 60.0, 61.0, 61.0, 62.0], "value": 61.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 82.0, 77.0, 78.0, 82.0, 83.0, 76.0, 108.0, 78.0], "value": 81.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 120.0, 134.0, 117.0, 117.0, 125.0, 121.0, 123.0, 134.0, 125.0], "value": 123.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 154.0, 156.0, 153.0, 154.0, 155.0, 155.0, 152.0, 157.0, 161.0], "value": 155.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 62.0, 62.0, 61.0, 62.0, 67.0, 65.0, 62.0, 62.0, 61.0], "value": 63.2, "unit": "score"}]}]} 03:46:44 INFO - Return code: 0 03:46:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:46:44 ERROR - # TBPL SUCCESS # 03:46:44 INFO - Running post-action listener: _resource_record_post_action 03:46:44 INFO - ##### 03:46:44 INFO - ##### Finished run-tests step (success) 03:46:44 INFO - ##### 03:46:44 INFO - Running post-run listener: _resource_record_post_run 03:46:44 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 290816; Write bytes: 514330624; Read time: 44; Write time: 929888 03:46:44 INFO - TinderboxPrint: CPU usage
13.5% 03:46:44 INFO - TinderboxPrint: I/O read bytes / time
290,816 / 44 03:46:44 INFO - TinderboxPrint: I/O write bytes / time
514,330,624 / 929,888 03:46:44 INFO - TinderboxPrint: CPU idle
8,227.1 (86.5%) 03:46:44 INFO - TinderboxPrint: CPU user
1,217.7 (12.8%) 03:46:44 INFO - TinderboxPrint: Swap in / out
0 / 0 03:46:44 INFO - install - Wall time: 16s; CPU: 17.0%; Read bytes: 0; Write bytes: 264814592; Read time: 0; Write time: 482672 03:46:44 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 266240; Write bytes: 248827904; Read time: 28; Write time: 447156 03:46:44 INFO - Running post-run listener: _upload_blobber_files 03:46:44 INFO - Blob upload gear active. 03:46:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:46:44 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:44 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:44 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:45 INFO - (blobuploader) - INFO - Open directory for files ... 03:46:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:46:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:46:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:46:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:46:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:46:46 INFO - (blobuploader) - INFO - Done attempting. 03:46:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:46:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:46:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:46:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:46:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:46:47 INFO - (blobuploader) - INFO - Done attempting. 03:46:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:46:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:46:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:46:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:46:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:46:50 INFO - (blobuploader) - INFO - Done attempting. 03:46:50 INFO - (blobuploader) - INFO - Iteration through files over. 03:46:50 INFO - Return code: 0 03:46:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:46:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:46:50 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ab980c9b1c135906ee003363e0906fc1f1a85147f8b7b725a7784487319aac486b050e423af6476c9099cc8811f7989d4e78926c6ece29316ac6f20a5cceb92c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a22fc74b8b4b39b352cb10b250adb10badde249f9601eba55b8413a1d57951fa3d6550e22e9fad7d4b244bc6d540607135dd6510215454cc4b5fc7b11cd9882c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/037b03ee56710083ab07ee2d3088f83eda09a239f1c1d01a36da1e5de6c7b68d18f32d2f0e75dc72a95fa238a3fa94ee0fe880852375ca0d46c6141cee4de961"} 03:46:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:46:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:46:50 INFO - Contents: 03:46:50 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ab980c9b1c135906ee003363e0906fc1f1a85147f8b7b725a7784487319aac486b050e423af6476c9099cc8811f7989d4e78926c6ece29316ac6f20a5cceb92c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a22fc74b8b4b39b352cb10b250adb10badde249f9601eba55b8413a1d57951fa3d6550e22e9fad7d4b244bc6d540607135dd6510215454cc4b5fc7b11cd9882c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/037b03ee56710083ab07ee2d3088f83eda09a239f1c1d01a36da1e5de6c7b68d18f32d2f0e75dc72a95fa238a3fa94ee0fe880852375ca0d46c6141cee4de961"} 03:46:50 INFO - Running post-run listener: copy_logs_to_upload_dir 03:46:50 INFO - Copying logs to upload dir... 03:46:50 INFO - mkdir: /builds/slave/test/build/upload/logs 03:46:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.755823 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-07-27 03:46:50.259438) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-27 03:46:50.263358) ========= 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=5cf47e208febbcd81da23b2e0000026f-1469615006.295618-1760493587 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ab980c9b1c135906ee003363e0906fc1f1a85147f8b7b725a7784487319aac486b050e423af6476c9099cc8811f7989d4e78926c6ece29316ac6f20a5cceb92c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a22fc74b8b4b39b352cb10b250adb10badde249f9601eba55b8413a1d57951fa3d6550e22e9fad7d4b244bc6d540607135dd6510215454cc4b5fc7b11cd9882c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/037b03ee56710083ab07ee2d3088f83eda09a239f1c1d01a36da1e5de6c7b68d18f32d2f0e75dc72a95fa238a3fa94ee0fe880852375ca0d46c6141cee4de961"} 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.011347 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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ab980c9b1c135906ee003363e0906fc1f1a85147f8b7b725a7784487319aac486b050e423af6476c9099cc8811f7989d4e78926c6ece29316ac6f20a5cceb92c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a22fc74b8b4b39b352cb10b250adb10badde249f9601eba55b8413a1d57951fa3d6550e22e9fad7d4b244bc6d540607135dd6510215454cc4b5fc7b11cd9882c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/037b03ee56710083ab07ee2d3088f83eda09a239f1c1d01a36da1e5de6c7b68d18f32d2f0e75dc72a95fa238a3fa94ee0fe880852375ca0d46c6141cee4de961"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-27 03:46:50.289402) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 03:46:50.289726) ========= 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=5cf47e208febbcd81da23b2e0000026f-1469615006.295618-1760493587 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004550 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 03:46:50.374723) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-27 03:46:50.375443) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-27 03:46:50.376132) ========= ========= Total master_lag: 0.18 =========