builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-005 starttime: 1467014824.56 results: success (0) buildid: 20160626223041 builduid: fd06654e5282495199a9acdd8dcab8bf revision: e68e0c28c1b1ed8ac55693f4fb0f6ebb14b74436 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 01:07:04.563529) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 01:07:04.564107) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 01:07:04.564464) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 01:07:04.598992) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 01:07:04.599471) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1467005418.192536-448123721 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-27 01:07:04-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 216M=0s 2016-06-27 01:07:05 (216 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.115465 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 01:07:04.732469) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 01:07:04.733061) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1467005418.192536-448123721 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023388 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 01:07:04.786853) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-27 01:07:04.787584) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev e68e0c28c1b1ed8ac55693f4fb0f6ebb14b74436 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev e68e0c28c1b1ed8ac55693f4fb0f6ebb14b74436 --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=7fc86f70bae03e018da0b1d8000001c4-1467005418.192536-448123721 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-27 01:07:05,171 truncating revision to first 12 chars 2016-06-27 01:07:05,172 Setting DEBUG logging. 2016-06-27 01:07:05,172 attempt 1/10 2016-06-27 01:07:05,172 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/e68e0c28c1b1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-27 01:07:06,608 unpacking tar archive at: mozilla-inbound-e68e0c28c1b1/testing/mozharness/ program finished with exit code 0 elapsedTime=1.762442 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-27 01:07:06.565403) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 01:07:06.565732) ========= script_repo_revision: e68e0c28c1b1ed8ac55693f4fb0f6ebb14b74436 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 01:07:06.566182) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 01:07:06.566552) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 01:07:06.577186) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-06-27 01:07:06.577518) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=7fc86f70bae03e018da0b1d8000001c4-1467005418.192536-448123721 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:07:07 INFO - MultiFileLogger online at 20160627 01:07:07 in /builds/slave/test 01:07:07 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 01:07:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:07:07 INFO - {'append_to_log': False, 01:07:07 INFO - 'base_work_dir': '/builds/slave/test', 01:07:07 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 01:07:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:07:07 INFO - 'branch': 'Mozilla-Inbound', 01:07:07 INFO - 'buildbot_json_path': 'buildprops.json', 01:07:07 INFO - 'config_files': ('talos/linux_config.py',), 01:07:07 INFO - 'default_actions': ('clobber', 01:07:07 INFO - 'read-buildbot-config', 01:07:07 INFO - 'download-and-extract', 01:07:07 INFO - 'populate-webroot', 01:07:07 INFO - 'create-virtualenv', 01:07:07 INFO - 'install', 01:07:07 INFO - 'run-tests'), 01:07:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:07:07 INFO - 'download_minidump_stackwalk': True, 01:07:07 INFO - 'download_symbols': 'ondemand', 01:07:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:07:07 INFO - 'tooltool.py': '/tools/tooltool.py', 01:07:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:07:07 INFO - '/tools/misc-python/virtualenv.py')}, 01:07:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:07:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:07:07 INFO - 'installer_path': 'installer.exe', 01:07:07 INFO - 'log_level': 'info', 01:07:07 INFO - 'log_name': 'talos', 01:07:07 INFO - 'log_to_console': True, 01:07:07 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:07:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:07:07 INFO - 'opt_config_files': (), 01:07:07 INFO - 'pip_index': False, 01:07:07 INFO - 'sps_profile': False, 01:07:07 INFO - 'sps_profile_interval': 0, 01:07:07 INFO - 'suite': 'dromaeojs-e10s', 01:07:07 INFO - 'system_bits': '32', 01:07:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:07:07 INFO - 'title': 'talos-linux64-ix-005', 01:07:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:07:07 INFO - 'use_talos_json': True, 01:07:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:07:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:07:07 INFO - 'work_dir': 'build'} 01:07:07 INFO - ##### 01:07:07 INFO - ##### Running clobber step. 01:07:07 INFO - ##### 01:07:07 INFO - Running pre-action listener: _resource_record_pre_action 01:07:07 INFO - Running main action method: clobber 01:07:07 INFO - rmtree: /builds/slave/test/build 01:07:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:07:07 INFO - Running post-action listener: _resource_record_post_action 01:07:07 INFO - ##### 01:07:07 INFO - ##### Finished clobber step (success) 01:07:07 INFO - ##### 01:07:07 INFO - ##### 01:07:07 INFO - ##### Running read-buildbot-config step. 01:07:07 INFO - ##### 01:07:07 INFO - Running pre-action listener: _resource_record_pre_action 01:07:07 INFO - Running main action method: read_buildbot_config 01:07:07 INFO - Using buildbot properties: 01:07:07 INFO - { 01:07:07 INFO - "project": "", 01:07:07 INFO - "product": "firefox", 01:07:07 INFO - "script_repo_revision": "production", 01:07:07 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 01:07:07 INFO - "repository": "", 01:07:07 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 01:07:07 INFO - "buildid": "20160626223041", 01:07:07 INFO - "pgo_build": "True", 01:07:07 INFO - "basedir": "/builds/slave/test", 01:07:07 INFO - "buildnumber": 916, 01:07:07 INFO - "slavename": "talos-linux64-ix-005", 01:07:07 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 01:07:07 INFO - "platform": "ubuntu64_hw", 01:07:07 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 01:07:07 INFO - "branch": "mozilla-inbound", 01:07:07 INFO - "repo_path": "integration/mozilla-inbound", 01:07:07 INFO - "revision": "e68e0c28c1b1ed8ac55693f4fb0f6ebb14b74436", 01:07:07 INFO - "stage_platform": "linux64-pgo", 01:07:07 INFO - "builduid": "fd06654e5282495199a9acdd8dcab8bf", 01:07:07 INFO - "slavebuilddir": "test" 01:07:07 INFO - } 01:07:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/fuU3XVGxQGmV4Zbqa6-uFA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 01:07:07 INFO - Running post-action listener: _resource_record_post_action 01:07:07 INFO - ##### 01:07:07 INFO - ##### Finished read-buildbot-config step (success) 01:07:07 INFO - ##### 01:07:07 INFO - ##### 01:07:07 INFO - ##### Running download-and-extract step. 01:07:07 INFO - ##### 01:07:07 INFO - Running pre-action listener: _resource_record_pre_action 01:07:07 INFO - Running main action method: download_and_extract 01:07:07 INFO - mkdir: /builds/slave/test/build/tests 01:07:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:07:07 INFO - https://queue.taskcluster.net/v1/task/fuU3XVGxQGmV4Zbqa6-uFA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 01:07:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fuU3XVGxQGmV4Zbqa6-uFA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:07:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fuU3XVGxQGmV4Zbqa6-uFA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:07:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fuU3XVGxQGmV4Zbqa6-uFA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:07:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fuU3XVGxQGmV4Zbqa6-uFA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 01:07:09 INFO - Downloaded 1361 bytes. 01:07:09 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:07:09 INFO - Using the following test package requirements: 01:07:09 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 01:07:09 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:07:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:07:09 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:07:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:07:09 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:07:09 INFO - u'jsshell-linux-x86_64.zip'], 01:07:09 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:07:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:07:09 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 01:07:09 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:07:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:07:09 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:07:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:07:09 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:07:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:07:09 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:07:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:07:09 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:07:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:07:09 INFO - https://queue.taskcluster.net/v1/task/fuU3XVGxQGmV4Zbqa6-uFA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:07:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fuU3XVGxQGmV4Zbqa6-uFA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:07:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fuU3XVGxQGmV4Zbqa6-uFA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:07:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fuU3XVGxQGmV4Zbqa6-uFA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:07:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fuU3XVGxQGmV4Zbqa6-uFA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:07:10 INFO - Downloaded 24280137 bytes. 01:07:10 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:07:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 01:07:11 INFO - Return code: 0 01:07:11 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 01:07:11 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')]} 01:07:11 INFO - https://queue.taskcluster.net/v1/task/fuU3XVGxQGmV4Zbqa6-uFA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:07:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fuU3XVGxQGmV4Zbqa6-uFA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:07:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fuU3XVGxQGmV4Zbqa6-uFA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:07:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fuU3XVGxQGmV4Zbqa6-uFA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:07:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fuU3XVGxQGmV4Zbqa6-uFA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:07:13 INFO - Downloaded 24280137 bytes. 01:07:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:07:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 01:07:14 INFO - Return code: 0 01:07:14 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')]} 01:07:14 INFO - https://queue.taskcluster.net/v1/task/fuU3XVGxQGmV4Zbqa6-uFA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:07:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fuU3XVGxQGmV4Zbqa6-uFA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 01:07:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fuU3XVGxQGmV4Zbqa6-uFA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 01:07:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fuU3XVGxQGmV4Zbqa6-uFA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 01:07:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fuU3XVGxQGmV4Zbqa6-uFA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 01:07:15 INFO - Downloaded 14405240 bytes. 01:07:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:07:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 01:07:15 INFO - Return code: 0 01:07:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:07:15 INFO - https://queue.taskcluster.net/v1/task/fuU3XVGxQGmV4Zbqa6-uFA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:07:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fuU3XVGxQGmV4Zbqa6-uFA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:07:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fuU3XVGxQGmV4Zbqa6-uFA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:07:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fuU3XVGxQGmV4Zbqa6-uFA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:07:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fuU3XVGxQGmV4Zbqa6-uFA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 01:07:17 INFO - Downloaded 60191146 bytes. 01:07:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fuU3XVGxQGmV4Zbqa6-uFA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:07:17 INFO - mkdir: /builds/slave/test/properties 01:07:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:07:17 INFO - Writing to file /builds/slave/test/properties/build_url 01:07:17 INFO - Contents: 01:07:17 INFO - build_url:https://queue.taskcluster.net/v1/task/fuU3XVGxQGmV4Zbqa6-uFA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:07:17 INFO - Running post-action listener: _resource_record_post_action 01:07:17 INFO - Running post-action listener: set_extra_try_arguments 01:07:17 INFO - ##### 01:07:17 INFO - ##### Finished download-and-extract step (success) 01:07:17 INFO - ##### 01:07:17 INFO - ##### 01:07:17 INFO - ##### Running populate-webroot step. 01:07:17 INFO - ##### 01:07:17 INFO - Running pre-action listener: _resource_record_pre_action 01:07:17 INFO - Running main action method: populate_webroot 01:07:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:07:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:07:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:07:17 INFO - '--tppagecycles', 01:07:17 INFO - '7'], 01:07:17 INFO - 'tests': ['tsvgm']}}, 01:07:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:07:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:07:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:07:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:07:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:07:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:07:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:07:17 INFO - 'talos_options': ['--disable-e10s'], 01:07:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:07:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:07:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:07:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:07:17 INFO - 'talos_options': ['--disable-e10s'], 01:07:17 INFO - 'tests': ['damp', 'tps']}, 01:07:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:07:17 INFO - 'tests': ['damp', 'tps']}, 01:07:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:07:17 INFO - 'tests': ['dromaeo_dom']}, 01:07:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:07:17 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:07:17 INFO - 'tests': ['basic_compositor_video']}, 01:07:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 01:07:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:07:17 INFO - 'tests': ['a11yr', 01:07:17 INFO - 'ts_paint', 01:07:17 INFO - 'tpaint', 01:07:17 INFO - 'sessionrestore', 01:07:17 INFO - 'sessionrestore_no_auto_restore', 01:07:17 INFO - 'tabpaint']}, 01:07:17 INFO - 'other-e10s': {'tests': ['a11yr', 01:07:17 INFO - 'ts_paint', 01:07:17 INFO - 'tpaint', 01:07:17 INFO - 'sessionrestore', 01:07:17 INFO - 'sessionrestore_no_auto_restore', 01:07:17 INFO - 'tabpaint']}, 01:07:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:07:17 INFO - 'ts_paint', 01:07:17 INFO - 'tpaint', 01:07:17 INFO - 'sessionrestore', 01:07:17 INFO - 'sessionrestore_no_auto_restore', 01:07:17 INFO - 'tabpaint']}, 01:07:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:07:17 INFO - 'ts_paint', 01:07:17 INFO - 'tpaint', 01:07:17 INFO - 'sessionrestore', 01:07:17 INFO - 'sessionrestore_no_auto_restore', 01:07:17 INFO - 'tabpaint']}, 01:07:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:07:17 INFO - 'tests': ['a11yr', 01:07:17 INFO - 'ts_paint', 01:07:17 INFO - 'tpaint', 01:07:17 INFO - 'sessionrestore', 01:07:17 INFO - 'sessionrestore_no_auto_restore', 01:07:17 INFO - 'tabpaint']}, 01:07:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:07:17 INFO - 'tests': ['a11yr', 01:07:17 INFO - 'ts_paint', 01:07:17 INFO - 'tpaint', 01:07:17 INFO - 'sessionrestore', 01:07:17 INFO - 'sessionrestore_no_auto_restore', 01:07:17 INFO - 'tabpaint']}, 01:07:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:07:17 INFO - 'tests': ['tsvgx', 01:07:17 INFO - 'tsvgr_opacity', 01:07:17 INFO - 'tart', 01:07:17 INFO - 'tscrollx', 01:07:17 INFO - 'cart']}, 01:07:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:07:17 INFO - 'tsvgr_opacity', 01:07:17 INFO - 'tart', 01:07:17 INFO - 'tscrollx', 01:07:17 INFO - 'cart']}, 01:07:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:07:17 INFO - 'talos_options': ['--disable-e10s'], 01:07:17 INFO - 'tests': ['tp5o']}, 01:07:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:07:17 INFO - 'tests': ['tp5o']}, 01:07:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:07:17 INFO - 'talos_options': ['--disable-e10s', 01:07:17 INFO - '--xperf_path', 01:07:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:07:17 INFO - 'tests': ['tp5n']}, 01:07:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:07:17 INFO - 'talos_options': ['--xperf_path', 01:07:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:07:17 INFO - 'tests': ['tp5n']}}, 01:07:17 INFO - 'talos.zip': {'path': '', 01:07:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:07:17 INFO - Running post-action listener: _resource_record_post_action 01:07:17 INFO - ##### 01:07:17 INFO - ##### Finished populate-webroot step (success) 01:07:17 INFO - ##### 01:07:17 INFO - ##### 01:07:17 INFO - ##### Running create-virtualenv step. 01:07:17 INFO - ##### 01:07:17 INFO - Running pre-action listener: _resource_record_pre_action 01:07:17 INFO - Running main action method: create_virtualenv 01:07:17 INFO - Creating virtualenv /builds/slave/test/build/venv 01:07:17 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 01:07:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:07:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:07:18 INFO - Using real prefix '/usr' 01:07:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:07:18 INFO - Installing distribute.............................................................................................................................................................................................done. 01:07:20 INFO - Installing pip.................done. 01:07:20 INFO - Return code: 0 01:07:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:07: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')]} 01:07:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:07:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:07: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')]} 01:07:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:07:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:07:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1ed791f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2257480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e66f0>, '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 0x22e75f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e7aa0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1467005418.192536-448123721', '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 01:07:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 01:07:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 01:07:20 INFO - Using env: {'DISPLAY': ':0', 01:07:20 INFO - 'HOME': '/home/cltbld', 01:07:20 INFO - 'LANG': 'en_US.UTF-8', 01:07:20 INFO - 'LANGUAGE': 'en_US:en', 01:07:20 INFO - 'LOGNAME': 'cltbld', 01:07:20 INFO - 'MAIL': '/var/mail/cltbld', 01:07:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:07:20 INFO - 'MOZ_NO_REMOTE': '1', 01:07:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:07:20 INFO - 'NO_EM_RESTART': '1', 01:07:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:07:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:07:20 INFO - 'PWD': '/builds/slave/test', 01:07:20 INFO - 'SHELL': '/bin/bash', 01:07:20 INFO - 'SHLVL': '1', 01:07:20 INFO - 'TERM': 'linux', 01:07:20 INFO - 'TMOUT': '86400', 01:07:20 INFO - 'USER': 'cltbld', 01:07:20 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1467005418.192536-448123721', 01:07:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:07:20 INFO - '_': '/tools/buildbot/bin/python'} 01:07:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:07:20 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 01:07:20 INFO - Cleaning up... 01:07:20 INFO - Return code: 0 01:07:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:07: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')]} 01:07:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:07:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:07: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')]} 01:07:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:07:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:07:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd1ed791f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2257480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e66f0>, '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 0x22e75f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e7aa0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1467005418.192536-448123721', '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 01:07:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 01:07:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 01:07:20 INFO - Using env: {'DISPLAY': ':0', 01:07:20 INFO - 'HOME': '/home/cltbld', 01:07:20 INFO - 'LANG': 'en_US.UTF-8', 01:07:20 INFO - 'LANGUAGE': 'en_US:en', 01:07:20 INFO - 'LOGNAME': 'cltbld', 01:07:20 INFO - 'MAIL': '/var/mail/cltbld', 01:07:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:07:20 INFO - 'MOZ_NO_REMOTE': '1', 01:07:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:07:20 INFO - 'NO_EM_RESTART': '1', 01:07:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:07:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:07:20 INFO - 'PWD': '/builds/slave/test', 01:07:20 INFO - 'SHELL': '/bin/bash', 01:07:20 INFO - 'SHLVL': '1', 01:07:20 INFO - 'TERM': 'linux', 01:07:20 INFO - 'TMOUT': '86400', 01:07:20 INFO - 'USER': 'cltbld', 01:07:20 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1467005418.192536-448123721', 01:07:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:07:20 INFO - '_': '/tools/buildbot/bin/python'} 01:07:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:07:20 INFO - Downloading/unpacking psutil>=3.1.1 01:07:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:07:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:07:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:07:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:07:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:07:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:07:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:07:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:07:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:07:22 INFO - Installing collected packages: psutil 01:07:22 INFO - Running setup.py install for psutil 01:07:22 INFO - building 'psutil._psutil_linux' extension 01:07:22 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 01:07:23 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 01:07:23 INFO - building 'psutil._psutil_posix' extension 01:07:23 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 01:07:23 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 01:07:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:07:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:07:23 INFO - Successfully installed psutil 01:07:23 INFO - Cleaning up... 01:07:23 INFO - Return code: 0 01:07:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:07: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')]} 01:07:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:07:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:07: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')]} 01:07:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:07:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:07:23 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 0x7fd1ed791f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2257480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e66f0>, '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 0x22e75f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e7aa0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1467005418.192536-448123721', '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 01:07:23 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 01:07:23 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 01:07:23 INFO - Using env: {'DISPLAY': ':0', 01:07:23 INFO - 'HOME': '/home/cltbld', 01:07:23 INFO - 'LANG': 'en_US.UTF-8', 01:07:23 INFO - 'LANGUAGE': 'en_US:en', 01:07:23 INFO - 'LOGNAME': 'cltbld', 01:07:23 INFO - 'MAIL': '/var/mail/cltbld', 01:07:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:07:23 INFO - 'MOZ_NO_REMOTE': '1', 01:07:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:07:23 INFO - 'NO_EM_RESTART': '1', 01:07:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:07:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:07:23 INFO - 'PWD': '/builds/slave/test', 01:07:23 INFO - 'SHELL': '/bin/bash', 01:07:23 INFO - 'SHLVL': '1', 01:07:23 INFO - 'TERM': 'linux', 01:07:23 INFO - 'TMOUT': '86400', 01:07:23 INFO - 'USER': 'cltbld', 01:07:23 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1467005418.192536-448123721', 01:07:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:07:23 INFO - '_': '/tools/buildbot/bin/python'} 01:07:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:07:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:07:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:07:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:07:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:07:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:07:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:07:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:07:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:07:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:07:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:07:25 INFO - Installing collected packages: mozsystemmonitor 01:07:25 INFO - Running setup.py install for mozsystemmonitor 01:07:25 INFO - Successfully installed mozsystemmonitor 01:07:25 INFO - Cleaning up... 01:07:25 INFO - Return code: 0 01:07:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:07:25 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')]} 01:07:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:07:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:07:25 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')]} 01:07:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:07:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:07:25 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 0x7fd1ed791f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2257480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e66f0>, '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 0x22e75f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e7aa0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1467005418.192536-448123721', '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 01:07:25 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 01:07:25 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 01:07:25 INFO - Using env: {'DISPLAY': ':0', 01:07:25 INFO - 'HOME': '/home/cltbld', 01:07:25 INFO - 'LANG': 'en_US.UTF-8', 01:07:25 INFO - 'LANGUAGE': 'en_US:en', 01:07:25 INFO - 'LOGNAME': 'cltbld', 01:07:25 INFO - 'MAIL': '/var/mail/cltbld', 01:07:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:07:25 INFO - 'MOZ_NO_REMOTE': '1', 01:07:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:07:25 INFO - 'NO_EM_RESTART': '1', 01:07:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:07:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:07:25 INFO - 'PWD': '/builds/slave/test', 01:07:25 INFO - 'SHELL': '/bin/bash', 01:07:25 INFO - 'SHLVL': '1', 01:07:25 INFO - 'TERM': 'linux', 01:07:25 INFO - 'TMOUT': '86400', 01:07:25 INFO - 'USER': 'cltbld', 01:07:25 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1467005418.192536-448123721', 01:07:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:07:25 INFO - '_': '/tools/buildbot/bin/python'} 01:07:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:07:25 INFO - Downloading/unpacking jsonschema==2.5.1 01:07:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:07:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:07:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:07:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:07:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:07:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:07:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:07:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:07:27 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 01:07:27 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 01:07:27 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 01:07:27 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 01:07:27 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 01:07:27 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 01:07:28 INFO - Downloading functools32-3.2.3-2.tar.gz 01:07:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:07:28 INFO - warning: no files found matching '*.txt' 01:07:28 INFO - no previously-included directories found matching 'build' 01:07:28 INFO - no previously-included directories found matching 'dist' 01:07:28 INFO - no previously-included directories found matching '.git*' 01:07:28 INFO - Installing collected packages: jsonschema, functools32 01:07:28 INFO - Running setup.py install for functools32 01:07:28 INFO - warning: no files found matching '*.txt' 01:07:28 INFO - no previously-included directories found matching 'build' 01:07:28 INFO - no previously-included directories found matching 'dist' 01:07:28 INFO - no previously-included directories found matching '.git*' 01:07:28 INFO - Successfully installed jsonschema functools32 01:07:28 INFO - Cleaning up... 01:07:28 INFO - Return code: 0 01:07:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:07:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:07:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:07:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:07:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:07:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:07:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:07:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd1ed791f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2257480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e66f0>, '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 0x22e75f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e7aa0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1467005418.192536-448123721', '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 01:07:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 01:07:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 01:07:28 INFO - Using env: {'DISPLAY': ':0', 01:07:28 INFO - 'HOME': '/home/cltbld', 01:07:28 INFO - 'LANG': 'en_US.UTF-8', 01:07:28 INFO - 'LANGUAGE': 'en_US:en', 01:07:28 INFO - 'LOGNAME': 'cltbld', 01:07:28 INFO - 'MAIL': '/var/mail/cltbld', 01:07:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:07:28 INFO - 'MOZ_NO_REMOTE': '1', 01:07:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:07:28 INFO - 'NO_EM_RESTART': '1', 01:07:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:07:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:07:28 INFO - 'PWD': '/builds/slave/test', 01:07:28 INFO - 'SHELL': '/bin/bash', 01:07:28 INFO - 'SHLVL': '1', 01:07:28 INFO - 'TERM': 'linux', 01:07:28 INFO - 'TMOUT': '86400', 01:07:28 INFO - 'USER': 'cltbld', 01:07:28 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1467005418.192536-448123721', 01:07:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:07:28 INFO - '_': '/tools/buildbot/bin/python'} 01:07:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:07:28 INFO - Downloading/unpacking blobuploader==1.2.4 01:07:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:07:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:07:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:07:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:07:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:07:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:07:30 INFO - Downloading blobuploader-1.2.4.tar.gz 01:07:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:07:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:07: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 01:07: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 01:07: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 01:07: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 01:07: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 01:07: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 01:07:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:07:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:07:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:07:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:07:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:07:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:07:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:07:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:07:31 INFO - Downloading docopt-0.6.1.tar.gz 01:07:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:07:31 INFO - Installing collected packages: blobuploader, requests, docopt 01:07:31 INFO - Running setup.py install for blobuploader 01:07:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:07:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:07:31 INFO - Running setup.py install for requests 01:07:31 INFO - Running setup.py install for docopt 01:07:31 INFO - Successfully installed blobuploader requests docopt 01:07:31 INFO - Cleaning up... 01:07:31 INFO - Return code: 0 01:07:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:07:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:07:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:07:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:07:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:07:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:07:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:07:31 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 0x7fd1ed791f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2257480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e66f0>, '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 0x22e75f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e7aa0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1467005418.192536-448123721', '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 01:07:31 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 01:07:31 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 01:07:31 INFO - Using env: {'DISPLAY': ':0', 01:07:31 INFO - 'HOME': '/home/cltbld', 01:07:31 INFO - 'LANG': 'en_US.UTF-8', 01:07:31 INFO - 'LANGUAGE': 'en_US:en', 01:07:31 INFO - 'LOGNAME': 'cltbld', 01:07:31 INFO - 'MAIL': '/var/mail/cltbld', 01:07:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:07:31 INFO - 'MOZ_NO_REMOTE': '1', 01:07:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:07:31 INFO - 'NO_EM_RESTART': '1', 01:07:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:07:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:07:31 INFO - 'PWD': '/builds/slave/test', 01:07:31 INFO - 'SHELL': '/bin/bash', 01:07:31 INFO - 'SHLVL': '1', 01:07:31 INFO - 'TERM': 'linux', 01:07:31 INFO - 'TMOUT': '86400', 01:07:31 INFO - 'USER': 'cltbld', 01:07:31 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1467005418.192536-448123721', 01:07:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:07:31 INFO - '_': '/tools/buildbot/bin/python'} 01:07:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:07:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:07:32 INFO - Running setup.py (path:/tmp/pip-_PxhMB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:07:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:07:32 INFO - Running setup.py (path:/tmp/pip-9lbvH9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:07:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:07:32 INFO - Running setup.py (path:/tmp/pip-nG1A6E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:07:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:07:32 INFO - Running setup.py (path:/tmp/pip-LJdT8g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:07:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:07:32 INFO - Running setup.py (path:/tmp/pip-3nAG8N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:07:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:07:32 INFO - Running setup.py (path:/tmp/pip-AKW9Fy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:07:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:07:32 INFO - Running setup.py (path:/tmp/pip-hd5AoL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:07:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:07:32 INFO - Running setup.py (path:/tmp/pip-yc0lkJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:07:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:07:32 INFO - Running setup.py (path:/tmp/pip-MDS9aq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:07:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:07:32 INFO - Running setup.py (path:/tmp/pip-E5Or2j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:07:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:07:32 INFO - Running setup.py (path:/tmp/pip-xalcyE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:07:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:07:32 INFO - Running setup.py (path:/tmp/pip-2ce_Co-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:07:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:07:32 INFO - Running setup.py (path:/tmp/pip-DL5WRy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:07:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:07:33 INFO - Running setup.py (path:/tmp/pip-JbPTU6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:07:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:07:33 INFO - Running setup.py (path:/tmp/pip-JqetAh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:07:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:07:33 INFO - Running setup.py (path:/tmp/pip-bkg8ik-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:07:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:07:33 INFO - Running setup.py (path:/tmp/pip-E3p4HI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:07:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:07:33 INFO - Running setup.py install for manifestparser 01:07:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:07:33 INFO - Running setup.py install for mozcrash 01:07:33 INFO - Running setup.py install for mozdebug 01:07:33 INFO - Running setup.py install for mozdevice 01:07:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:07:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:07:33 INFO - Running setup.py install for mozfile 01:07:33 INFO - Running setup.py install for mozhttpd 01:07:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:07:33 INFO - Running setup.py install for mozinfo 01:07:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:07:34 INFO - Running setup.py install for mozInstall 01:07:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:07:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:07:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:07:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:07:34 INFO - Running setup.py install for mozleak 01:07:34 INFO - Running setup.py install for mozlog 01:07:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:07:34 INFO - Running setup.py install for moznetwork 01:07:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:07:34 INFO - Running setup.py install for mozprocess 01:07:34 INFO - Running setup.py install for mozprofile 01:07:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:07:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:07:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:07:34 INFO - Running setup.py install for mozrunner 01:07:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:07:34 INFO - Running setup.py install for mozscreenshot 01:07:34 INFO - Running setup.py install for moztest 01:07:34 INFO - Running setup.py install for mozversion 01:07:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:07:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:07:35 INFO - Cleaning up... 01:07:35 INFO - Return code: 0 01:07:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:07:35 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')]} 01:07:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:07:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:07:35 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')]} 01:07:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:07:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:07:35 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 0x7fd1ed791f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2257480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e66f0>, '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 0x22e75f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e7aa0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1467005418.192536-448123721', '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 01:07:35 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 01:07:35 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 01:07:35 INFO - Using env: {'DISPLAY': ':0', 01:07:35 INFO - 'HOME': '/home/cltbld', 01:07:35 INFO - 'LANG': 'en_US.UTF-8', 01:07:35 INFO - 'LANGUAGE': 'en_US:en', 01:07:35 INFO - 'LOGNAME': 'cltbld', 01:07:35 INFO - 'MAIL': '/var/mail/cltbld', 01:07:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:07:35 INFO - 'MOZ_NO_REMOTE': '1', 01:07:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:07:35 INFO - 'NO_EM_RESTART': '1', 01:07:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:07:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:07:35 INFO - 'PWD': '/builds/slave/test', 01:07:35 INFO - 'SHELL': '/bin/bash', 01:07:35 INFO - 'SHLVL': '1', 01:07:35 INFO - 'TERM': 'linux', 01:07:35 INFO - 'TMOUT': '86400', 01:07:35 INFO - 'USER': 'cltbld', 01:07:35 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1467005418.192536-448123721', 01:07:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:07:35 INFO - '_': '/tools/buildbot/bin/python'} 01:07:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:07:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:07:35 INFO - Running setup.py (path:/tmp/pip-Y6JIOA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:07:35 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)) 01:07:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:07:35 INFO - Running setup.py (path:/tmp/pip-0RJOGj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:07:35 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)) 01:07:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:07:35 INFO - Running setup.py (path:/tmp/pip-9INfcd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:07:35 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)) 01:07:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:07:35 INFO - Running setup.py (path:/tmp/pip-1wKuPx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:07:35 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)) 01:07:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:07:35 INFO - Running setup.py (path:/tmp/pip-jN2q5O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:07:35 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)) 01:07:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:07:35 INFO - Running setup.py (path:/tmp/pip-2oIwPk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:07:35 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)) 01:07:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:07:35 INFO - Running setup.py (path:/tmp/pip-u8qMKj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:07:35 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)) 01:07:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:07:35 INFO - Running setup.py (path:/tmp/pip-h65uNP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:07:35 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)) 01:07:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:07:35 INFO - Running setup.py (path:/tmp/pip-q_qQAv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:07:35 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)) 01:07:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:07:35 INFO - Running setup.py (path:/tmp/pip-FRPA44-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:07:36 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)) 01:07:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:07:36 INFO - Running setup.py (path:/tmp/pip-vHvaNc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:07:36 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)) 01:07:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:07:36 INFO - Running setup.py (path:/tmp/pip-aYFDwx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:07:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 01:07:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:07:36 INFO - Running setup.py (path:/tmp/pip-nHMyis-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:07:36 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)) 01:07:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:07:36 INFO - Running setup.py (path:/tmp/pip-1qjD4q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:07:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 01:07:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:07:36 INFO - Running setup.py (path:/tmp/pip-YBKS31-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:07:36 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)) 01:07:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:07:36 INFO - Running setup.py (path:/tmp/pip-9MKX8t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:07:36 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)) 01:07:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:07:36 INFO - Running setup.py (path:/tmp/pip-XahivG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:07:36 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)) 01:07:36 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)) 01:07:36 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)) 01:07:36 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)) 01:07:36 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)) 01:07:36 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)) 01:07:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:07:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:07:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:07:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:07:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:07:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:07:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:07:38 INFO - Downloading blessings-1.6.tar.gz 01:07:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:07:38 INFO - Installing collected packages: blessings 01:07:38 INFO - Running setup.py install for blessings 01:07:38 INFO - Successfully installed blessings 01:07:38 INFO - Cleaning up... 01:07:38 INFO - Return code: 0 01:07:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:07:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:07:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:07:38 INFO - Reading from file tmpfile_stdout 01:07:38 INFO - Current package versions: 01:07:38 INFO - argparse == 1.2.1 01:07:38 INFO - blessings == 1.6 01:07:38 INFO - blobuploader == 1.2.4 01:07:38 INFO - docopt == 0.6.1 01:07:38 INFO - functools32 == 3.2.3-2 01:07:38 INFO - jsonschema == 2.5.1 01:07:38 INFO - manifestparser == 1.1 01:07:38 INFO - mozInstall == 1.12 01:07:38 INFO - mozcrash == 0.17 01:07:38 INFO - mozdebug == 0.1 01:07:38 INFO - mozdevice == 0.48 01:07:38 INFO - mozfile == 1.2 01:07:38 INFO - mozhttpd == 0.7 01:07:38 INFO - mozinfo == 0.9 01:07:38 INFO - mozleak == 0.1 01:07:38 INFO - mozlog == 3.2 01:07:38 INFO - moznetwork == 0.27 01:07:38 INFO - mozprocess == 0.22 01:07:38 INFO - mozprofile == 0.28 01:07:38 INFO - mozrunner == 6.11 01:07:38 INFO - mozscreenshot == 0.1 01:07:38 INFO - mozsystemmonitor == 0.3 01:07:38 INFO - moztest == 0.7 01:07:38 INFO - mozversion == 1.4 01:07:38 INFO - psutil == 3.1.1 01:07:38 INFO - requests == 1.2.3 01:07:38 INFO - wsgiref == 0.1.2 01:07:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:07:38 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')]} 01:07:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:07:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:07:38 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')]} 01:07:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:07:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:07:38 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 0x7fd1ed791f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2257480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e66f0>, '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 0x22e75f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e7aa0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1467005418.192536-448123721', '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 01:07:38 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 01:07:38 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 01:07:38 INFO - Using env: {'DISPLAY': ':0', 01:07:38 INFO - 'HOME': '/home/cltbld', 01:07:38 INFO - 'LANG': 'en_US.UTF-8', 01:07:38 INFO - 'LANGUAGE': 'en_US:en', 01:07:38 INFO - 'LOGNAME': 'cltbld', 01:07:38 INFO - 'MAIL': '/var/mail/cltbld', 01:07:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:07:38 INFO - 'MOZ_NO_REMOTE': '1', 01:07:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:07:38 INFO - 'NO_EM_RESTART': '1', 01:07:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:07:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:07:38 INFO - 'PWD': '/builds/slave/test', 01:07:38 INFO - 'SHELL': '/bin/bash', 01:07:38 INFO - 'SHLVL': '1', 01:07:38 INFO - 'TERM': 'linux', 01:07:38 INFO - 'TMOUT': '86400', 01:07:38 INFO - 'USER': 'cltbld', 01:07:38 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1467005418.192536-448123721', 01:07:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:07:38 INFO - '_': '/tools/buildbot/bin/python'} 01:07:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:07:39 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)) 01:07:39 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)) 01:07:39 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)) 01:07:39 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)) 01:07:39 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)) 01:07:39 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)) 01:07:39 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)) 01:07:39 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)) 01:07:39 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)) 01:07:39 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)) 01:07:39 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)) 01:07:39 INFO - Cleaning up... 01:07:39 INFO - Return code: 0 01:07:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:07:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:07:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:07:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:07:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:07:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:07:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:07:39 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 0x7fd1ed791f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2257480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e66f0>, '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 0x22e75f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e7aa0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1467005418.192536-448123721', '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 01:07:39 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 01:07:39 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 01:07:39 INFO - Using env: {'DISPLAY': ':0', 01:07:39 INFO - 'HOME': '/home/cltbld', 01:07:39 INFO - 'LANG': 'en_US.UTF-8', 01:07:39 INFO - 'LANGUAGE': 'en_US:en', 01:07:39 INFO - 'LOGNAME': 'cltbld', 01:07:39 INFO - 'MAIL': '/var/mail/cltbld', 01:07:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:07:39 INFO - 'MOZ_NO_REMOTE': '1', 01:07:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:07:39 INFO - 'NO_EM_RESTART': '1', 01:07:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:07:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:07:39 INFO - 'PWD': '/builds/slave/test', 01:07:39 INFO - 'SHELL': '/bin/bash', 01:07:39 INFO - 'SHLVL': '1', 01:07:39 INFO - 'TERM': 'linux', 01:07:39 INFO - 'TMOUT': '86400', 01:07:39 INFO - 'USER': 'cltbld', 01:07:39 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1467005418.192536-448123721', 01:07:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:07:39 INFO - '_': '/tools/buildbot/bin/python'} 01:07:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:07:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:07:39 INFO - Cleaning up... 01:07:39 INFO - Return code: 0 01:07:39 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:07:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:07:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:07:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:07:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:07:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:07:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:07:39 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 0x7fd1ed791f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2257480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e66f0>, '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 0x22e75f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e7aa0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1467005418.192536-448123721', '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 01:07:39 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 01:07:39 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 01:07:39 INFO - Using env: {'DISPLAY': ':0', 01:07:39 INFO - 'HOME': '/home/cltbld', 01:07:39 INFO - 'LANG': 'en_US.UTF-8', 01:07:39 INFO - 'LANGUAGE': 'en_US:en', 01:07:39 INFO - 'LOGNAME': 'cltbld', 01:07:39 INFO - 'MAIL': '/var/mail/cltbld', 01:07:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:07:39 INFO - 'MOZ_NO_REMOTE': '1', 01:07:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:07:39 INFO - 'NO_EM_RESTART': '1', 01:07:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:07:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:07:39 INFO - 'PWD': '/builds/slave/test', 01:07:39 INFO - 'SHELL': '/bin/bash', 01:07:39 INFO - 'SHLVL': '1', 01:07:39 INFO - 'TERM': 'linux', 01:07:39 INFO - 'TMOUT': '86400', 01:07:39 INFO - 'USER': 'cltbld', 01:07:39 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1467005418.192536-448123721', 01:07:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:07:39 INFO - '_': '/tools/buildbot/bin/python'} 01:07:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:07:39 INFO - Downloading/unpacking flake8 01:07: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 01:07: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 01:07: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 01:07: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 01:07: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 01:07: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 01:07:41 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:07:41 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:07:41 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 01:07:41 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 01:07:41 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 01:07:41 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 01:07:41 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 01:07:41 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 01:07:41 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:07:41 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:07:41 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 01:07:41 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 01:07:41 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 01:07:41 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 01:07:41 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 01:07:41 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 01:07:41 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:07:41 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 01:07:41 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 01:07:41 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 01:07:41 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 01:07:41 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 01:07:41 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 01:07:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:07:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:07:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:07:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:07:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:07:42 INFO - no previously-included directories found matching 'docs/_build' 01:07:42 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:07:42 INFO - Running setup.py install for pep8 01:07:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:07:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:07:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:07:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:07:42 INFO - no previously-included directories found matching 'docs/_build' 01:07:42 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:07:42 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:07:42 INFO - Cleaning up... 01:07:42 INFO - Return code: 0 01:07:42 INFO - Running post-action listener: _resource_record_post_action 01:07:42 INFO - Running post-action listener: _start_resource_monitoring 01:07:42 INFO - Starting resource monitoring. 01:07:42 INFO - ##### 01:07:42 INFO - ##### Finished create-virtualenv step (success) 01:07:42 INFO - ##### 01:07:42 INFO - ##### 01:07:42 INFO - ##### Running install step. 01:07:42 INFO - ##### 01:07:42 INFO - Running pre-action listener: _resource_record_pre_action 01:07:42 INFO - Running main action method: install 01:07:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:07:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:07:42 INFO - Reading from file tmpfile_stdout 01:07:42 INFO - Detecting whether we're running mozinstall >=1.0... 01:07:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:07:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:07:42 INFO - Reading from file tmpfile_stdout 01:07:42 INFO - Output received: 01:07:42 INFO - Usage: mozinstall [options] installer 01:07:42 INFO - Options: 01:07:42 INFO - -h, --help show this help message and exit 01:07:42 INFO - -d DEST, --destination=DEST 01:07:42 INFO - Directory to install application into. [default: 01:07:42 INFO - "/builds/slave/test"] 01:07:42 INFO - --app=APP Application being installed. [default: firefox] 01:07:42 INFO - mkdir: /builds/slave/test/build/application 01:07:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 01:07:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 01:07:59 INFO - Reading from file tmpfile_stdout 01:07:59 INFO - Output received: 01:07:59 INFO - /builds/slave/test/build/application/firefox/firefox 01:07:59 INFO - Running post-action listener: _resource_record_post_action 01:07:59 INFO - ##### 01:07:59 INFO - ##### Finished install step (success) 01:07:59 INFO - ##### 01:07:59 INFO - ##### 01:07:59 INFO - ##### Running run-tests step. 01:07:59 INFO - ##### 01:07:59 INFO - Running pre-action listener: _resource_record_pre_action 01:07:59 INFO - Running main action method: run_tests 01:07:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:07:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:07:59 INFO - Python 2.7.3 01:07:59 INFO - Return code: 0 01:07:59 INFO - grabbing minidump binary from tooltool 01:07:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:07:59 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 0x22e66f0>, '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 0x22e75f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e7aa0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:07:59 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 01:07:59 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 01:07:59 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 01:07:59 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:07:59 INFO - Return code: 0 01:07:59 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:07:59 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:07:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:07:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:07:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:07:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:07:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:08:00 INFO - Return code: 0 01:08:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fuU3XVGxQGmV4Zbqa6-uFA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--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 01:08:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fuU3XVGxQGmV4Zbqa6-uFA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-005 --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 01:08:00 INFO - Using env: {'DISPLAY': ':0', 01:08:00 INFO - 'HOME': '/home/cltbld', 01:08:00 INFO - 'LANG': 'en_US.UTF-8', 01:08:00 INFO - 'LANGUAGE': 'en_US:en', 01:08:00 INFO - 'LOGNAME': 'cltbld', 01:08:00 INFO - 'MAIL': '/var/mail/cltbld', 01:08:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:08:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:08:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:08:00 INFO - 'MOZ_NO_REMOTE': '1', 01:08:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:08:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:08:00 INFO - 'NO_EM_RESTART': '1', 01:08:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:08:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:08:00 INFO - 'PWD': '/builds/slave/test', 01:08:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:08:00 INFO - 'SHELL': '/bin/bash', 01:08:00 INFO - 'SHLVL': '1', 01:08:00 INFO - 'TERM': 'linux', 01:08:00 INFO - 'TMOUT': '86400', 01:08:00 INFO - 'USER': 'cltbld', 01:08:00 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1467005418.192536-448123721', 01:08:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:08:00 INFO - '_': '/tools/buildbot/bin/python'} 01:08:00 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fuU3XVGxQGmV4Zbqa6-uFA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--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 01:08:01 INFO - mozversion application_buildid: 20160626223041 01:08:01 INFO - mozversion application_changeset: e68e0c28c1b1ed8ac55693f4fb0f6ebb14b74436 01:08:01 INFO - mozversion application_display_name: Nightly 01:08:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:08:01 INFO - mozversion application_name: Firefox 01:08:01 INFO - mozversion application_remotingname: firefox 01:08:01 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 01:08:01 INFO - mozversion application_vendor: Mozilla 01:08:01 INFO - mozversion application_version: 50.0a1 01:08:01 INFO - mozversion platform_buildid: 20160626223041 01:08:01 INFO - mozversion platform_changeset: e68e0c28c1b1ed8ac55693f4fb0f6ebb14b74436 01:08:01 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 01:08:01 INFO - mozversion platform_version: 50.0a1 01:08:01 INFO - using testdate: 1467014881 01:08:01 INFO - actual date: 1467014881 01:08:01 INFO - starting webserver on 'localhost:50252' 01:08:01 INFO - SUITE-START | Running 2 tests 01:08:01 INFO - TEST-START | dromaeo_css 01:08:01 INFO - operating with platform_type : linux_ 01:08:01 INFO - Initialising browser for dromaeo_css test... 01:08:01 INFO - TEST-INFO | started process 14212 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpl4owGv/profile http://localhost:50252/getInfo.html) 01:08:05 INFO - PROCESS | 14212 | __metrics Screen width/height:1600/1200 01:08:05 INFO - PROCESS | 14212 | colorDepth:24 01:08:05 INFO - PROCESS | 14212 | Browser inner width/height: 1024/697 01:08:05 INFO - PROCESS | 14212 | __metrics 01:08:06 ERROR - PROCESS | 14212 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 01:08:07 INFO - TEST-INFO | 14212: exit 0 01:08:07 INFO - Browser initialized. 01:08:07 INFO - Running cycle 1/1 for dromaeo_css test... 01:08:07 INFO - TEST-INFO | started process 14333 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpl4owGv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:08:19 INFO - PROCESS | 14333 | RSS: Main: 184827904 01:08:19 INFO - PROCESS | 14333 | 01:09:08 INFO - PROCESS | 14333 | 1467014948750 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] 01:11:16 INFO - PROCESS | 14333 | Cycle 1(1): loaded http://localhost:50252/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50252/tests/dromaeo/cssquery-ext.html) 01:11:17 INFO - PROCESS | 14333 | RSS: Main: 188125184 01:11:17 INFO - PROCESS | 14333 | 01:14:19 INFO - PROCESS | 14333 | Cycle 1(1): loaded http://localhost:50252/tests/dromaeo/cssquery-ext.html (next: http://localhost:50252/tests/dromaeo/cssquery-jquery.html) 01:14:20 INFO - PROCESS | 14333 | RSS: Main: 186961920 01:14:20 INFO - PROCESS | 14333 | 01:17:22 INFO - PROCESS | 14333 | Cycle 1(1): loaded http://localhost:50252/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50252/tests/dromaeo/cssquery-mootools.html) 01:17:22 INFO - PROCESS | 14333 | RSS: Main: 188874752 01:17:22 INFO - PROCESS | 14333 | 01:20:24 INFO - PROCESS | 14333 | Cycle 1(1): loaded http://localhost:50252/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50252/tests/dromaeo/cssquery-prototype.html) 01:20:25 INFO - PROCESS | 14333 | RSS: Main: 186220544 01:20:25 INFO - PROCESS | 14333 | 01:23:27 INFO - PROCESS | 14333 | Cycle 1(1): loaded http://localhost:50252/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50252/tests/dromaeo/cssquery-yui.html) 01:23:28 INFO - PROCESS | 14333 | RSS: Main: 188436480 01:23:28 INFO - PROCESS | 14333 | 01:26:31 INFO - PROCESS | 14333 | Cycle 1(1): loaded http://localhost:50252/tests/dromaeo/cssquery-yui.html (next: http://localhost:50252/tests/dromaeo/cssquery-dojo.html) 01:26:31 INFO - PROCESS | 14333 | RSS: Main: 189321216 01:26:31 INFO - PROCESS | 14333 | 01:26:31 INFO - PROCESS | 14333 | __start_tp_report 01:26:31 INFO - PROCESS | 14333 | _x_x_mozilla_page_load 01:26:31 INFO - PROCESS | 14333 | _x_x_mozilla_page_load_details 01:26:31 INFO - PROCESS | 14333 | |i|pagename|runs| 01:26:31 INFO - PROCESS | 14333 | |0;dojo.html;3162.9367412651745;3169.920751981199;3190.5533225348454;3197.9200519987;3210.2616398228406;5364.356277246726;5378.300820893283;5474.945250547494;5481.177823326498;5521.806736764214;5470.370907345657;5511.53151982081;5526.364468086172;5568.5266752326;5659.8585035374135;4883.633727470445;4955.801767929279;5059.924101138486;5083.593312535007;5147.073526765181;712.3483321246473;5027.220780778966;5083.923741143886;5084.822031228908;5137.486251374851;5068.138416469209;5069.74651267437;5074.974625126869;5108.310378098965;5145.073886700392;5039.949600503985;5106.872328191787;5111.437741848394;5119.718415487147;5133.614978876599;5024.949750502485;5046.9747651261505;5081.898362032775;5096.745162741885;5141.948580514184;5602.663840169603;5617.32592088952;5628.240187574666;5632.3804381518;5693.430656934273;5801.854953626151;5924.348321684654;5963.731632076567;6049.395060493959;6055.5761096723245;6054.636721796706;6076.513878889678;6079.726412311456;6088.360722124202;6125.050617154348;5651.858703532363;5654.886902261973;5658.91511627326;5659.773609055633;5677.517411020068;5994.100884867217;6100.267967843798;6103.277060575968;6119.07606531266;6187.041008643578;5910.822675319747;5910.8817823643285;5915.674637894871;5940;5956.463918247378;5959.284885813643;6002.969985150134;6018.277806663228;6020.187274717857;6023.1266466363;5803;5831.067029275296;5831.533477321804;5892.322382926019;5916.26046744157;5777.162311464814;5812.3025236971835;5821.359650438449;5871.970640146772;5909.763609455659;4477.507474177838;4495.505494395614;4497.055618320124;4507.4365704286965;4537.024539723975;3946.072672921861;3951.6443520082757;3964.0486283291802;3969.503812023497;3996.540397854284;5672.943270567242;5674.914876276859;5686.658800471985;5689.0328644130595;5740.770369185269;5894.056950887837;5983.640981541034;5984.970075149597;5987.6108052976415;5990.670513121733;5531.889362212733;5572.192032155314;5602.0196465618355;5623.0721930880945;5663.405342439067;4903.828366007244;4944.950550494521;4959.429665588431;4963.677360971526;4964.90070198594;6108.633481991094;6138.508919286446;6138.631682099089;6139.84650383744;6140.140380346755;5747.48272655463;5779.479846813639;5790.7973220937065;5816.185733997159;5873.794417195378;6103.621715307426;6140.478059364826;6150.600210986271;6152.415520525543;6167.629942203482;5833.7666493341485;5838.824835254949;5848.736806843617;5864.501517371071;5870.677112758668;5782.5373970081455;5881.647101173943;5886.970565147147;5919.289685237799;5963.970180149072;5815.505682017076;5819.214406055128;5828.6211396259105;5829.795957141479;5833.82498525045;5768.105943578584;5789.218455508452;5793.217915581343;5793.710314484343;5805.680687562224;5507.779688812403;5648.435156484319;5671.8865622688145;5706.6005379624685;5713.428657134254;5822.388649191943;5855.443732845373;5883.058710606282;5890.646561206341;5894.322152952465;5547.472990065938;5712.171735098471;5722.227499287543;5732.598718089694;5742.253507044057 01:26:31 INFO - PROCESS | 14333 | |1;ext.html;569.6439725171767;611.2512172588578;622.726000559754;625.0592857749087;627.9183706118203;43021.78489107554;44269.77865110674;44624.776876115575;44992.77503612481;47759;46565.534344656546;46742.766286168604;47118.52881471184;47374;47478.52521474784;8921.643134274638;9081.455112693227;9082.13719696631;9085.13691199335;9098;8870.201681848632;9028.954855225715;9029.187373136416;9039.186473217409;9061.229795467394;9046.185843274105;9055.185033346997;9067.093290670913;9081.591328390205;9125.315601329894;9047;9093;9100.8634870477;9102.772430689252;9109.772255693595;8887;8914.73255802327;8972;8979.19187273142;8998.685046023424;43051.784741076095;43255.35116973248;43357.0489327981;43430.565694343284;43714.56285437137;3535.345960997198;3591.7665351752053;3700.7964561949084;4098.385242213662;4215.936760948558;32483.51274730881;33935.321293574234;34450.31099378024;34938.47592286118;35549.46675799865;4406.206882761102;4411.955880441186;4533.909321813545;4579.107074120548;4592.311153326994;364042;369460;371517;371768;372018;35438.29123417569;36141.63858361383;65214.347856521774;66054.33945660482;66157.33842661511;37958.62041379606;38170.618293817264;38172.42741358882;38326.80836595799;38340;15996.76004859928;16127.919360403357;16153.4346297879;16196.595085122966;16228;13448.529301474402;13523.39144738489;13559.796603050961;13571.457141714222;13579;8406;8529.360297977677;8547.40168188221;8562.571871406404;8624.051354351017;3297.950530742041;3325.900222993314;3334.916627084294;3335.382954153489;3424.503447000171;954.341504361988;1035.5236591167995;1141.9828702569469;1143.6226045404997;1155.9076672544365;32260.677393225767;32534.837325813693;32784.83607581947;32881.835590821895;33352.83323583366;1105.4748994227677;1114.4037939702382;1128.7516746315798;1210.975780484403;1249.8312727781815;17011.744823827652;17324.740128898076;17380.565485862953;17405;17452.912735436243;583720;602319;604377;604443;605241;59893.40106598965;61248.69375653182;61385.38614613886;61582.69208654018;61728.60492672946;1323.8543760186371;1342.731453709262;1348.298884580013;1355.8440779310308;1377.2081053394338;29838.403231935674;31809.363812724077;31993;32064.35871282608;32097.518537222426;51933.74033129961;52227.216591750395;52503.47496524986;52721.73639131933;52749.472505274454;500029;503023;503078;504220;504819;28515.28711782222;28959.85520072386;29569.112926612237;29730.70269297366;29804.254893627833;49292;49911.50088499069;49961;50918.236226457375;51029;42453;42730;43351.566484336014;43649.56350436455;43921.34117988297;36778.8161059193;36953.44569831401;36955.26089478249;37000;37238.44142337813;37515.43726844154;41487.58512414958;41555.792221038704;42217.78891105525;42653.146937061705;36042.8197859009;38101.4284785734;38510;38978.415323770736;39146;29315.706842931297;29462.11613651594;29799.404011920073;29900.839810906236;30129.246768830955 01:26:31 INFO - PROCESS | 14333 | |2;jquery.html;371.873562988584;372.8191826963922;374.5729867950536;386.872332130397;400.9679225661947;17627.82372176278;19530.218791248368;19929;20161.59676806465;20384.592308153828;18425;18799.718004229948;18987.62024759504;19062.2375104996;19065.428037158872;5439.673619582838;5545.3622833374275;5581.6371935824245;5658.971705141468;5669.121286200645;5306.893862122755;5347.893042139174;5506.366767821692;5526.198701188326;5558.360788509332;5403.2165336026255;5426.647267927572;5468.043092458824;5479.808206712766;5512.476314750113;5350;5419.376771671269;5439.292891924025;5454.127339625641;5467.234587157801;4835.419749630032;4893.877653058702;4924.950750492485;4951.108800415924;4978.6017118630425;22271.109155633756;22628.660570091462;22910.885445572665;23017.53964920709;23146.305610831703;2254.0983606557343;2306.550222706573;2353.5292941411617;2357.5638506876285;3019.9169049588063;7390.778276651656;8854.335924805666;9484.430934143973;9485.620575176985;14307.57077287683;1853.3976457651183;1882.4634979031048;1907.418237437581;1943.724823672103;1976.2786582897138;55969;84549.57725211335;85048;85476.57261713651;85842.5707871463;10320.43237621923;10427.68716938493;10438;10573.995470430296;10744.086752626114;14147.575572732834;14174.787378189336;14187.14877107377;14213.289335533182;14235.430582776573;8130.796730081795;8262.793430164174;8307.851392274148;8342.62458189383;8397.6221070052;8203.548804815673;8222;8348.707795227137;8384.329253659815;8431.19903609156;4252.468441444819;4289.785510724451;4333.609975102256;4339.435873336446;4505.842295519641;1838.7425760393555;1852.6109517001312;1859.869809113349;1870.8503319734389;1900.515368581003;908.3505293715026;987.2299606307092;1012.8987101289812;1021.4382089850552;1085.799127161462;18761.249550018118;19605.901970490057;19691.310804121786;19730.605387892163;19950.30173943905;984.6504490905626;990.4305024610877;998.2762497189625;1000.7398076500162;1026.779242462874;10165.847512287322;10841.67474975752;10897.945510272557;10921.563137474412;10922.726931826768;471762;473470;473700;473908;476628;68183.65908170427;83152.58423707963;85272.57363713141;86127.56936215404;86654.13345866586;993.60752502761;1012.4633944009687;1045.0437849367743;1050.3487837540774;1056.1920131099714;14371.281435928371;16232.26954787061;17355.7396639048;17446;17741.46775596734;41624.3756343649;42033.369499458146;42930;43237.567624323354;43764;61646.38353616586;62334.506619734704;63582.68208658927;63600;64592.354076458636;8136.145704701158;8288.792780180544;8297.04583972851;8387.74183872424;8394.790130246793;12467.688307792016;13799.586012419644;13822.516211932534;13955.651108722363;14143.858561414254;11692.883071169179;11815.763684726086;11930.10524210705;11996.700082497659;12093.879061209274;5513.56913440253;11647.417629118341;12208.572699955459;12236;12314.938425308175;12360.134790564574;12392.442340094538;12505.312207828656;12515.687107822378;12570.245785252913;6919.584824910521;7325.120985481776;7597.582132982739;7805;8533.402661813614;10491.94754026225;12116.333601651993;12155.939220303842;12197.573084941985;12249.938750306548 01:26:31 INFO - PROCESS | 14333 | |3;mootools.html;1471.9484818031367;1472.7790831375291;1616.4746457401347;1721.9827801721995;1735.991320043399;8102.594870256493;8692.43536163491;8730.781730456742;9250.583723732432;9285.303602229835;8810.955945220281;9036.41263317884;9053.637854485829;9111.498867562297;9133.451992880431;2291.106468477291;2313.410080429488;2325.6744055832196;2338.9298321050396;2340.9063637454483;2129.595376878396;2131.957360852782;2133.551954089643;2152.332776839177;2264.0264686184933;2234.497238121418;2246.225052356934;2269.4326418395403;2280.7149106361703;2310.792028717415;2262.7058482397265;2265.818734501236;2269.636858102704;2274.1699279762934;2279.87460689662;2227.9665805012937;2232.073689418889;2236.586231547169;2240.957954551125;2242.394553470554;9145.496997665126;9240.26077913772;9258.768530786718;9261.953690231505;9296.814063718755;5163.896722065575;5292.550133238679;5295.470452954673;5298.549623282026;5300.125479295912;3006.4438078955245;3043.5303753720555;3171.0803866878578;3189.4418476766705;3199.4880819068835;1062.1768129699467;1062.54310646422;1076.3272954403499;1089.1776708585046;1096.4408151842538;12694.238345699288;12828.615141545768;12835.807462888064;12838.101332906606;12939.935300323437;4449.57729015743;4567.6802623816675;4619.653525985565;4621.560951709582;4654.557817007379;10814;10844.45777711127;10890.72773180661;10902.345859248471;10906;5256.2115682647145;5279.736013199325;5301.257823904656;5337.386200586904;5349.384820745586;4294.248506511348;4582.1293954148605;4754.31062495943;4757.595604373667;4926.679765815211;3952.703547233969;3970.583088775637;4067.1662309226535;4069.328560787437;4090.181963607231;1229.170310040719;1236.6042866282883;1244.508419174421;1247.1955588645274;1251.6995920979082;1003.598560575761;1010.4796030044533;1027.5119318323736;1030.3611760708259;1043.8225501664735;6074;6132.294786099566;6172.321044685081;6402.391772781578;6491.350864913566;417.40936574746394;426.8996785755345;438.6140196626948;446.6583063956076;451.8463722334422;4033.233685599727;4046.8785936421955;4071.226466971266;4142.420061191436;4208.915821683549;11210.27133236337;11487.655370338904;11570.479328430241;11669;11669.35818529972;11337.1497137715;11381.203315767982;11391.829122563167;11452.770944581061;11477.483513241925;7901.525908445512;8324.750257492286;8330.166983301622;8517.872231916526;8570.528620925785;5870.207521984477;6027.457528822427;6062.90905636407;6168.352323006199;6196.287426945959;10347.379157250589;10369.325993810378;10434.321769084985;10557.155427565624;10576.788464230825;9948.900510995087;10410.47947602632;10433.9478302608;10596.788064238826;10748.140148787921;7302.671379788028;7981.122076571456;8083.959580202297;8229.135940726377;8232.588370581327;8972.641094356153;9013.459192448474;9031.909680903107;9042.638294468148;9094.27245820346;8020.157883422156;8192.918070819216;8249.917500825155;8289.792755180928;8340.833183336177;7957.124716281089;8082.555459449787;8120.1473845247765;8128.83742325162;8229.135940726377;6927.307269273032;7221.747238846615;7222.638868056471;7396.038514993232;7507.324340809353;5538.806141785019;5613.859653508695;5621.213030175697;5666;5782.421757824184;4485.282354823213;4506.909861802811;5168.147255702767;5351.678899266057;5365.624406291522 01:26:31 INFO - PROCESS | 14333 | |4;prototype.html;302.98198054536755;316.68964414873426;316.7291965369609;322.2089769615594;325.58650513847414;5512.944870551293;5575.303087114111;5655.802046928353;5684.829455116348;5790.392008839074;5583.8604034899145;5585.553155747541;5592.133219350997;5630.042892708239;5632.943670563293;4342.522322544518;4362.869113926571;4371.300591905296;4433.490148632916;4445.977770111161;4351.412559304501;4368.694191406603;4390.363397307388;4418.491873434548;4447.35513350564;4350.173467041268;4358.455193100863;4364.650827933773;4374.781260936957;4394.143142087294;4410.051838854662;4410.404595379615;4416.2713152329825;4423.623991960703;4430.474629461209;3695.150115473429;3788.6021967693546;3880.805959702032;3881.7282790204695;3893.1240470894104;5413.810516631938;5463.562914966793;5479.369872464637;5484.424135465799;5494.917576236359;4880.657819099741;4926.729029903354;4934.358533390672;4948.7278199699;4973.726445045521;5797.594168408213;5862.736176872051;5914.615549989237;5926.911096333559;5937.792177273818;4118.608732170439;4138.441310423084;4140.130572579762;4142;4144.52337981133;6171.876562468726;6190.628562286232;6199.628022318675;6206.379362063757;6240;4137.8758637240935;4263.232618128704;4265.210935976854;4273.166732487135;4296.5273819879785;4310.612044915973;4318.611324980767;4342.6308763754805;4359.956400435955;4381.38660587518;4943.579795717333;4991.101601711727;5007.522780779679;5036.841526448938;5043.823466178739;5848.210491583582;5903.734331955073;5914.467697907209;6035.30593981689;6042.848928776728;1436.8850491960618;1451.9056261342978;1454.861788130126;1462.5393001204586;1466.2009204983096;928.1831987850649;933.4352716606492;946.7917058247175;953.270747877874;953.9332246742662;5084.779632904754;5086.643934924594;5134.794608215704;5169.172932330809;5169.379674439091;5318.680879147263;5324.5740340772645;5351.866203344947;5355.3305836770405;5400.405955344909;5028.899422011613;5092.337996060489;5100.69395836251;5377.489138531833;5848.766049357978;3227.451333273349;3239.49787782894;3259.1200375898375;3307.1732066983254;3318.93793985927;6110.144579758838;6315.400036996478;6373.0440433934355;6410.230772307353;6411.6153030818305;6154;6221.160143380585;6268.1851359323;6273.529485288622;6288.27684816252;6287.371262873676;6296;6313.305536390993;6324.873502529924;6414.903776443357;5849.53203743708;6101.877962440815;6103.908441373472;6106.1451396803595;6109.48069414087;6056.636601803906;6135.815925522242;6139.171211886338;6149.815505534841;6160.969195153995;6157.353477884937;6308.653024083719;6367.808965731036;6396.744130234924;6470.220689310289;4130.463039804806;4149.813258403318;4152.688548358825;4172.332426811696;4189.790510474525;6139.785107521216;6208;6210.875782484415;6221.782237621662;6240.188775459162;5766.711664416846;5954.493868021266;6005.759769609342;6042.274927008787;6078.45293923549;5966.76132954677;5983.790567330123;6007.339192688713;6039.124326972476;6064.969675151596;5675.971620141873;5910.645361278337;5918.2898052234;5978.043513037893;6002.609830361012;6032.969835150971;6050.30421501533;6052.606580572248;6062.787802426894;6074.451014991149;5939.4951429129005;5944.64332140073;5953.64830891804;5974.283086029531;6006.279246490274 01:26:31 INFO - PROCESS | 14333 | |5;yui.html;718.2458418660409;758.8292634157311;794.3843521271015;811.8335741173053;830.6718846055808;14811.62970925726;15552;15573.610659733513;15614;15655.843441565581;14704.338304776284;14741.410343586243;14745.336459859305;14774.704505909902;14826.851731482682;672.4889084295921;792.2513225002375;799.7480793550028;808.5472135604051;820.958952052395;812.6424373275769;814.5031530766257;815.4862436664893;816.5223344343566;821.0311832038193;859.2953777902122;863.5509535041774;864.4769914201912;865.2861389353777;868.9695860644879;852.9189726975927;853.5988085599789;858.1118542308681;859.4070091636781;860.6987554355957;623.1151764494429;624.2602516018487;625.5121005615628;625.7184267079787;627.1690010735748;15362.231888405648;15427.768583471257;15495.92252038744;15566.610834729108;15581.610459738484;15196.757118793998;15309.464168754152;15347.309371078329;15402;15510.302036408277;12358.258504489759;12512.687182820411;12575.05687073464;12589.118761686686;12608.369581520887;3803.8478460861534;3870.3807390817333;3955.3275943089743;4021.2560676274984;4052.250333688277;79120.60439697822;80394.59802701007;80404.59797701033;81211.59394203051;82124.58937705333;11556.942215289038;11650.88349116498;11731.35477548726;11742.823857642143;11791.29252244868;20241.797582024286;21847.235346762787;22001.449963750714;22287.888560557418;22313.55372892533;8764.91235087641;8879.644814207359;8913.37606367561;9018.909810901938;9028.36801423894;4669.34629151919;4693.9765301173275;4709.222978208626;4761.428628564595;4855.514448555187;3699.611540788232;3818.4845045918446;3821.6369444903244;3821.7515861468914;3824.7896365700153;671.9764808231688;678.128604742903;680.4318394140947;686.8866637004838;700.0444393402968;765.8966039584585;766.1916677904752;770.2259229474342;788.7909703928464;791.2641243643467;9879.259055570717;9920.40477571348;10342.948285258526;10377.636782712569;10451.111655509214;653.7287025884204;670.7484693240035;712.4051417066808;733.1056111543908;743.8921356403291;5070.416902056237;5091.541761241432;5126.179811230185;5128.947986233557;5152.175651895679;114196.42901785437;116484;116562;117619.41190293994;118751;101269.49365253274;102205;103250.48374758229;104278;104642.4767876171;57588.71205644029;88904.55547722349;89091.55454222688;89568.5521572388;90943.54528227316;9786.314957952874;10069.597216111273;10146.949265253626;10307.690769276935;10433.686989390331;49110.50889491059;49643.50356496389;50525;50863;52705.472945270056;51063;51211.487885122166;66107.66946165239;67836;77836.61081694555;13403.195808251536;13470.19178849233;13635.522756703467;14033;14341.211233382264;15454.690906182039;15502.379904804133;15541.84458155404;15643.843561564694;15811.841881581036;14367.20980346091;14501.791362484688;14585.781213282022;14658.269830615312;14685.926570367079;14868;14906.403743850124;15087.698246035237;15787.842121578637;15954.28205730768;14084.78872816888;14291.928540357232;14510.564683059525;14526.782098268322;15189.696206075596;10821.621243256448;10983.670489885317;11036.558537658404;11203.887961120285;11216.943915280372;10796.838047429137;10859.34843909368;10947.397893115955;10947.890521095005;10950.288231264942 01:26:31 INFO - PROCESS | 14333 | __end_tp_report 01:26:31 INFO - PROCESS | 14333 | __start_cc_report 01:26:31 INFO - PROCESS | 14333 | _x_x_mozilla_cycle_collect,349 01:26:31 INFO - PROCESS | 14333 | __end_cc_report 01:26:31 INFO - PROCESS | 14333 | __startTimestamp1467015991260__endTimestamp 01:26:31 INFO - PROCESS | 14333 | 01:26:31 INFO - PROCESS | 14333 | ------- Summary: start ------- 01:26:31 INFO - PROCESS | 14333 | Number of tests: 6 01:26:31 INFO - PROCESS | 14333 | 01:26:31 INFO - PROCESS | 14333 | [#0] dojo.html Cycles:165 Average:5486.93 Median:5740.77 stddev:740.49 (12.9%) stddev-sans-first:719.96 01:26:31 INFO - PROCESS | 14333 | Values: 3162.9 3169.9 3190.6 3197.9 3210.3 5364.4 5378.3 5474.9 5481.2 5521.8 5470.4 5511.5 5526.4 5568.5 5659.9 4883.6 4955.8 5059.9 5083.6 5147.1 712.3 5027.2 5083.9 5084.8 5137.5 5068.1 5069.7 5075.0 5108.3 5145.1 5039.9 5106.9 5111.4 5119.7 5133.6 5024.9 5047.0 5081.9 5096.7 5141.9 5602.7 5617.3 5628.2 5632.4 5693.4 5801.9 5924.3 5963.7 6049.4 6055.6 6054.6 6076.5 6079.7 6088.4 6125.1 5651.9 5654.9 5658.9 5659.8 5677.5 5994.1 6100.3 6103.3 6119.1 6187.0 5910.8 5910.9 5915.7 5940.0 5956.5 5959.3 6003.0 6018.3 6020.2 6023.1 5803.0 5831.1 5831.5 5892.3 5916.3 5777.2 5812.3 5821.4 5872.0 5909.8 4477.5 4495.5 4497.1 4507.4 4537.0 3946.1 3951.6 3964.0 3969.5 3996.5 5672.9 5674.9 5686.7 5689.0 5740.8 5894.1 5983.6 5985.0 5987.6 5990.7 5531.9 5572.2 5602.0 5623.1 5663.4 4903.8 4945.0 4959.4 4963.7 4964.9 6108.6 6138.5 6138.6 6139.8 6140.1 5747.5 5779.5 5790.8 5816.2 5873.8 6103.6 6140.5 6150.6 6152.4 6167.6 5833.8 5838.8 5848.7 5864.5 5870.7 5782.5 5881.6 5887.0 5919.3 5964.0 5815.5 5819.2 5828.6 5829.8 5833.8 5768.1 5789.2 5793.2 5793.7 5805.7 5507.8 5648.4 5671.9 5706.6 5713.4 5822.4 5855.4 5883.1 5890.6 5894.3 5547.5 5712.2 5722.2 5732.6 5742.3 01:26:31 INFO - PROCESS | 14333 | 01:26:31 INFO - PROCESS | 14333 | [#1] ext.html Cycles:180 Average:63823.49 Median:42553.07 stddev:133242.15 (313.1%) stddev-sans-first:133531.29 01:26:31 INFO - PROCESS | 14333 | Values: 569.6 611.3 622.7 625.1 627.9 43021.8 44269.8 44624.8 44992.8 47759.0 46565.5 46742.8 47118.5 47374.0 47478.5 8921.6 9081.5 9082.1 9085.1 9098.0 8870.2 9029.0 9029.2 9039.2 9061.2 9046.2 9055.2 9067.1 9081.6 9125.3 9047.0 9093.0 9100.9 9102.8 9109.8 8887.0 8914.7 8972.0 8979.2 8998.7 43051.8 43255.4 43357.0 43430.6 43714.6 3535.3 3591.8 3700.8 4098.4 4215.9 32483.5 33935.3 34450.3 34938.5 35549.5 4406.2 4412.0 4533.9 4579.1 4592.3 364042.0 369460.0 371517.0 371768.0 372018.0 35438.3 36141.6 65214.3 66054.3 66157.3 37958.6 38170.6 38172.4 38326.8 38340.0 15996.8 16127.9 16153.4 16196.6 16228.0 13448.5 13523.4 13559.8 13571.5 13579.0 8406.0 8529.4 8547.4 8562.6 8624.1 3298.0 3325.9 3334.9 3335.4 3424.5 954.3 1035.5 1142.0 1143.6 1155.9 32260.7 32534.8 32784.8 32881.8 33352.8 1105.5 1114.4 1128.8 1211.0 1249.8 17011.7 17324.7 17380.6 17405.0 17452.9 583720.0 602319.0 604377.0 604443.0 605241.0 59893.4 61248.7 61385.4 61582.7 61728.6 1323.9 1342.7 1348.3 1355.8 1377.2 29838.4 31809.4 31993.0 32064.4 32097.5 51933.7 52227.2 52503.5 52721.7 52749.5 500029.0 503023.0 503078.0 504220.0 504819.0 28515.3 28959.9 29569.1 29730.7 29804.3 49292.0 49911.5 49961.0 50918.2 51029.0 42453.0 42730.0 43351.6 43649.6 43921.3 36778.8 36953.4 36955.3 37000.0 37238.4 37515.4 41487.6 41555.8 42217.8 42653.1 36042.8 38101.4 38510.0 38978.4 39146.0 29315.7 29462.1 29799.4 29900.8 30129.2 01:26:31 INFO - PROCESS | 14333 | 01:26:31 INFO - PROCESS | 14333 | [#2] jquery.html Cycles:180 Average:28270.52 Median:373.70 stddev:78115.42 (20903.5%) stddev-sans-first:78306.47 01:26:31 INFO - PROCESS | 14333 | Values: 371.9 372.8 374.6 386.9 401.0 17627.8 19530.2 19929.0 20161.6 20384.6 18425.0 18799.7 18987.6 19062.2 19065.4 5439.7 5545.4 5581.6 5659.0 5669.1 5306.9 5347.9 5506.4 5526.2 5558.4 5403.2 5426.6 5468.0 5479.8 5512.5 5350.0 5419.4 5439.3 5454.1 5467.2 4835.4 4893.9 4925.0 4951.1 4978.6 22271.1 22628.7 22910.9 23017.5 23146.3 2254.1 2306.6 2353.5 2357.6 3019.9 7390.8 8854.3 9484.4 9485.6 14307.6 1853.4 1882.5 1907.4 1943.7 1976.3 55969.0 84549.6 85048.0 85476.6 85842.6 10320.4 10427.7 10438.0 10574.0 10744.1 14147.6 14174.8 14187.1 14213.3 14235.4 8130.8 8262.8 8307.9 8342.6 8397.6 8203.5 8222.0 8348.7 8384.3 8431.2 4252.5 4289.8 4333.6 4339.4 4505.8 1838.7 1852.6 1859.9 1870.9 1900.5 908.4 987.2 1012.9 1021.4 1085.8 18761.2 19605.9 19691.3 19730.6 19950.3 984.7 990.4 998.3 1000.7 1026.8 10165.8 10841.7 10897.9 10921.6 10922.7 471762.0 473470.0 473700.0 473908.0 476628.0 68183.7 83152.6 85272.6 86127.6 86654.1 993.6 1012.5 1045.0 1050.3 1056.2 14371.3 16232.3 17355.7 17446.0 17741.5 41624.4 42033.4 42930.0 43237.6 43764.0 61646.4 62334.5 63582.7 63600.0 64592.4 8136.1 8288.8 8297.0 8387.7 8394.8 12467.7 13799.6 13822.5 13955.7 14143.9 11692.9 11815.8 11930.1 11996.7 12093.9 5513.6 11647.4 12208.6 12236.0 12314.9 12360.1 12392.4 12505.3 12515.7 12570.2 6919.6 7325.1 7597.6 7805.0 8533.4 10491.9 12116.3 12155.9 12197.6 12249.9 01:26:31 INFO - PROCESS | 14333 | 01:26:31 INFO - PROCESS | 14333 | [#3] mootools.html Cycles:180 Average:5948.68 Median:2360.57 stddev:3510.94 (148.7%) stddev-sans-first:3504.68 01:26:31 INFO - PROCESS | 14333 | Values: 1471.9 1472.8 1616.5 1722.0 1736.0 8102.6 8692.4 8730.8 9250.6 9285.3 8811.0 9036.4 9053.6 9111.5 9133.5 2291.1 2313.4 2325.7 2338.9 2340.9 2129.6 2132.0 2133.6 2152.3 2264.0 2234.5 2246.2 2269.4 2280.7 2310.8 2262.7 2265.8 2269.6 2274.2 2279.9 2228.0 2232.1 2236.6 2241.0 2242.4 9145.5 9240.3 9258.8 9262.0 9296.8 5163.9 5292.6 5295.5 5298.5 5300.1 3006.4 3043.5 3171.1 3189.4 3199.5 1062.2 1062.5 1076.3 1089.2 1096.4 12694.2 12828.6 12835.8 12838.1 12939.9 4449.6 4567.7 4619.7 4621.6 4654.6 10814.0 10844.5 10890.7 10902.3 10906.0 5256.2 5279.7 5301.3 5337.4 5349.4 4294.2 4582.1 4754.3 4757.6 4926.7 3952.7 3970.6 4067.2 4069.3 4090.2 1229.2 1236.6 1244.5 1247.2 1251.7 1003.6 1010.5 1027.5 1030.4 1043.8 6074.0 6132.3 6172.3 6402.4 6491.4 417.4 426.9 438.6 446.7 451.8 4033.2 4046.9 4071.2 4142.4 4208.9 11210.3 11487.7 11570.5 11669.0 11669.4 11337.1 11381.2 11391.8 11452.8 11477.5 7901.5 8324.8 8330.2 8517.9 8570.5 5870.2 6027.5 6062.9 6168.4 6196.3 10347.4 10369.3 10434.3 10557.2 10576.8 9948.9 10410.5 10433.9 10596.8 10748.1 7302.7 7981.1 8084.0 8229.1 8232.6 8972.6 9013.5 9031.9 9042.6 9094.3 8020.2 8192.9 8249.9 8289.8 8340.8 7957.1 8082.6 8120.1 8128.8 8229.1 6927.3 7221.7 7222.6 7396.0 7507.3 5538.8 5613.9 5621.2 5666.0 5782.4 4485.3 4506.9 5168.1 5351.7 5365.6 01:26:31 INFO - PROCESS | 14333 | 01:26:31 INFO - PROCESS | 14333 | [#4] prototype.html Cycles:180 Average:4951.36 Median:5579.58 stddev:1487.58 (26.7%) stddev-sans-first:1450.26 01:26:31 INFO - PROCESS | 14333 | Values: 303.0 316.7 316.7 322.2 325.6 5512.9 5575.3 5655.8 5684.8 5790.4 5583.9 5585.6 5592.1 5630.0 5632.9 4342.5 4362.9 4371.3 4433.5 4446.0 4351.4 4368.7 4390.4 4418.5 4447.4 4350.2 4358.5 4364.7 4374.8 4394.1 4410.1 4410.4 4416.3 4423.6 4430.5 3695.2 3788.6 3880.8 3881.7 3893.1 5413.8 5463.6 5479.4 5484.4 5494.9 4880.7 4926.7 4934.4 4948.7 4973.7 5797.6 5862.7 5914.6 5926.9 5937.8 4118.6 4138.4 4140.1 4142.0 4144.5 6171.9 6190.6 6199.6 6206.4 6240.0 4137.9 4263.2 4265.2 4273.2 4296.5 4310.6 4318.6 4342.6 4360.0 4381.4 4943.6 4991.1 5007.5 5036.8 5043.8 5848.2 5903.7 5914.5 6035.3 6042.8 1436.9 1451.9 1454.9 1462.5 1466.2 928.2 933.4 946.8 953.3 953.9 5084.8 5086.6 5134.8 5169.2 5169.4 5318.7 5324.6 5351.9 5355.3 5400.4 5028.9 5092.3 5100.7 5377.5 5848.8 3227.5 3239.5 3259.1 3307.2 3318.9 6110.1 6315.4 6373.0 6410.2 6411.6 6154.0 6221.2 6268.2 6273.5 6288.3 6287.4 6296.0 6313.3 6324.9 6414.9 5849.5 6101.9 6103.9 6106.1 6109.5 6056.6 6135.8 6139.2 6149.8 6161.0 6157.4 6308.7 6367.8 6396.7 6470.2 4130.5 4149.8 4152.7 4172.3 4189.8 6139.8 6208.0 6210.9 6221.8 6240.2 5766.7 5954.5 6005.8 6042.3 6078.5 5966.8 5983.8 6007.3 6039.1 6065.0 5676.0 5910.6 5918.3 5978.0 6002.6 6033.0 6050.3 6052.6 6062.8 6074.5 5939.5 5944.6 5953.6 5974.3 6006.3 01:26:31 INFO - PROCESS | 14333 | 01:26:31 INFO - PROCESS | 14333 | [#5] yui.html Cycles:180 Average:20932.41 Median:3821.69 stddev:29943.00 (783.5%) stddev-sans-first:29988.53 01:26:31 INFO - PROCESS | 14333 | Values: 718.2 758.8 794.4 811.8 830.7 14811.6 15552.0 15573.6 15614.0 15655.8 14704.3 14741.4 14745.3 14774.7 14826.9 672.5 792.3 799.7 808.5 821.0 812.6 814.5 815.5 816.5 821.0 859.3 863.6 864.5 865.3 869.0 852.9 853.6 858.1 859.4 860.7 623.1 624.3 625.5 625.7 627.2 15362.2 15427.8 15495.9 15566.6 15581.6 15196.8 15309.5 15347.3 15402.0 15510.3 12358.3 12512.7 12575.1 12589.1 12608.4 3803.8 3870.4 3955.3 4021.3 4052.3 79120.6 80394.6 80404.6 81211.6 82124.6 11556.9 11650.9 11731.4 11742.8 11791.3 20241.8 21847.2 22001.4 22287.9 22313.6 8764.9 8879.6 8913.4 9018.9 9028.4 4669.3 4694.0 4709.2 4761.4 4855.5 3699.6 3818.5 3821.6 3821.8 3824.8 672.0 678.1 680.4 686.9 700.0 765.9 766.2 770.2 788.8 791.3 9879.3 9920.4 10342.9 10377.6 10451.1 653.7 670.7 712.4 733.1 743.9 5070.4 5091.5 5126.2 5128.9 5152.2 114196.4 116484.0 116562.0 117619.4 118751.0 101269.5 102205.0 103250.5 104278.0 104642.5 57588.7 88904.6 89091.6 89568.6 90943.5 9786.3 10069.6 10146.9 10307.7 10433.7 49110.5 49643.5 50525.0 50863.0 52705.5 51063.0 51211.5 66107.7 67836.0 77836.6 13403.2 13470.2 13635.5 14033.0 14341.2 15454.7 15502.4 15541.8 15643.8 15811.8 14367.2 14501.8 14585.8 14658.3 14685.9 14868.0 14906.4 15087.7 15787.8 15954.3 14084.8 14291.9 14510.6 14526.8 15189.7 10821.6 10983.7 11036.6 11203.9 11216.9 10796.8 10859.3 10947.4 10947.9 10950.3 01:26:31 INFO - PROCESS | 14333 | -------- Summary: end -------- 01:26:31 INFO - PROCESS | 14333 | 01:26:31 INFO - TEST-INFO | 14333: exit 0 01:26:31 INFO - TEST-OK | dromaeo_css | took 1110960ms 01:26:31 INFO - TEST-START | kraken 01:26:31 INFO - operating with platform_type : linux_ 01:26:31 INFO - Initialising browser for kraken test... 01:26:31 INFO - TEST-INFO | started process 14576 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNQ0IW8/profile http://localhost:50252/getInfo.html) 01:26:36 INFO - PROCESS | 14576 | __metrics Screen width/height:1600/1200 01:26:36 INFO - PROCESS | 14576 | colorDepth:24 01:26:36 INFO - PROCESS | 14576 | Browser inner width/height: 1024/697 01:26:36 INFO - PROCESS | 14576 | __metrics 01:26:37 ERROR - PROCESS | 14576 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 01:26:37 INFO - TEST-INFO | 14576: exit 0 01:26:37 INFO - Browser initialized. 01:26:37 INFO - Running cycle 1/1 for kraken test... 01:26:37 INFO - TEST-INFO | started process 14697 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNQ0IW8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:26:49 INFO - PROCESS | 14697 | RSS: Main: 184315904 01:26:49 INFO - PROCESS | 14697 | 01:26:52 INFO - PROCESS | 14697 | Cycle 1(1): loaded http://localhost:50252/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50252/tests/kraken/driver.html?testName=audio-beat-detection) 01:26:53 INFO - PROCESS | 14697 | RSS: Main: 190251008 01:26:53 INFO - PROCESS | 14697 | 01:26:55 INFO - PROCESS | 14697 | Cycle 1(1): loaded http://localhost:50252/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50252/tests/kraken/driver.html?testName=audio-dft) 01:26:56 INFO - PROCESS | 14697 | RSS: Main: 189259776 01:26:56 INFO - PROCESS | 14697 | 01:26:59 INFO - PROCESS | 14697 | Cycle 1(1): loaded http://localhost:50252/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50252/tests/kraken/driver.html?testName=audio-fft) 01:27:00 INFO - PROCESS | 14697 | RSS: Main: 184434688 01:27:00 INFO - PROCESS | 14697 | 01:27:02 INFO - PROCESS | 14697 | Cycle 1(1): loaded http://localhost:50252/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50252/tests/kraken/driver.html?testName=audio-oscillator) 01:27:02 INFO - PROCESS | 14697 | RSS: Main: 184823808 01:27:02 INFO - PROCESS | 14697 | 01:27:05 INFO - PROCESS | 14697 | Cycle 1(1): loaded http://localhost:50252/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50252/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:27:05 INFO - PROCESS | 14697 | RSS: Main: 185384960 01:27:05 INFO - PROCESS | 14697 | 01:27:08 INFO - PROCESS | 14697 | Cycle 1(1): loaded http://localhost:50252/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50252/tests/kraken/driver.html?testName=imaging-darkroom) 01:27:09 INFO - PROCESS | 14697 | RSS: Main: 186167296 01:27:09 INFO - PROCESS | 14697 | 01:27:12 INFO - PROCESS | 14697 | Cycle 1(1): loaded http://localhost:50252/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50252/tests/kraken/driver.html?testName=imaging-desaturate) 01:27:13 INFO - PROCESS | 14697 | RSS: Main: 183672832 01:27:13 INFO - PROCESS | 14697 | 01:27:16 INFO - PROCESS | 14697 | Cycle 1(1): loaded http://localhost:50252/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50252/tests/kraken/driver.html?testName=json-parse-financial) 01:27:16 INFO - PROCESS | 14697 | RSS: Main: 185212928 01:27:16 INFO - PROCESS | 14697 | 01:27:18 INFO - PROCESS | 14697 | Cycle 1(1): loaded http://localhost:50252/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50252/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:27:19 INFO - PROCESS | 14697 | RSS: Main: 185135104 01:27:19 INFO - PROCESS | 14697 | 01:27:20 INFO - PROCESS | 14697 | Cycle 1(1): loaded http://localhost:50252/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50252/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:27:21 INFO - PROCESS | 14697 | RSS: Main: 185581568 01:27:21 INFO - PROCESS | 14697 | 01:27:23 INFO - PROCESS | 14697 | Cycle 1(1): loaded http://localhost:50252/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50252/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:27:24 INFO - PROCESS | 14697 | RSS: Main: 185835520 01:27:24 INFO - PROCESS | 14697 | 01:27:26 INFO - PROCESS | 14697 | Cycle 1(1): loaded http://localhost:50252/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50252/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:27:27 INFO - PROCESS | 14697 | RSS: Main: 186019840 01:27:27 INFO - PROCESS | 14697 | 01:27:30 INFO - PROCESS | 14697 | Cycle 1(1): loaded http://localhost:50252/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50252/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:27:30 INFO - PROCESS | 14697 | RSS: Main: 185880576 01:27:30 INFO - PROCESS | 14697 | 01:27:32 INFO - PROCESS | 14697 | Cycle 1(1): loaded http://localhost:50252/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50252/tests/kraken/driver.html?testName=ai-astar) 01:27:32 INFO - PROCESS | 14697 | RSS: Main: 186773504 01:27:32 INFO - PROCESS | 14697 | 01:27:32 INFO - PROCESS | 14697 | __start_tp_report 01:27:32 INFO - PROCESS | 14697 | _x_x_mozilla_page_load 01:27:32 INFO - PROCESS | 14697 | _x_x_mozilla_page_load_details 01:27:32 INFO - PROCESS | 14697 | |i|pagename|runs| 01:27:32 INFO - PROCESS | 14697 | |0;ai-astar;101;109;104;110;112;110;110;108;112;110 01:27:32 INFO - PROCESS | 14697 | |1;audio-beat-detection;151;125;160;177;131;158;155;126;183;128 01:27:32 INFO - PROCESS | 14697 | |2;audio-dft;163;161;160;160;163;174;166;161;161;163 01:27:32 INFO - PROCESS | 14697 | |3;audio-fft;75;76;76;172;77;75;75;76;162;74 01:27:32 INFO - PROCESS | 14697 | |4;audio-oscillator;94;86;149;92;86;86;142;85;85;152 01:27:32 INFO - PROCESS | 14697 | |5;imaging-gaussian-blur;117;117;119;117;117;117;117;117;119;118 01:27:32 INFO - PROCESS | 14697 | |6;imaging-darkroom;147;149;147;147;147;147;147;147;147;147 01:27:32 INFO - PROCESS | 14697 | |7;imaging-desaturate;95;98;95;96;95;95;96;96;96;95 01:27:32 INFO - PROCESS | 14697 | |8;json-parse-financial;53;53;58;52;56;53;53;55;57;53 01:27:32 INFO - PROCESS | 14697 | |9;json-stringify-tinderbox;63;63;63;63;63;63;63;63;64;62 01:27:32 INFO - PROCESS | 14697 | |10;stanford-crypto-aes;93;77;78;78;84;82;82;79;94;82 01:27:32 INFO - PROCESS | 14697 | |11;stanford-crypto-ccm;124;123;121;119;123;122;130;125;131;130 01:27:32 INFO - PROCESS | 14697 | |12;stanford-crypto-pbkdf2;164;157;160;160;158;157;158;160;157;160 01:27:32 INFO - PROCESS | 14697 | |13;stanford-crypto-sha256-iterative;64;73;70;71;63;65;62;62;64;62 01:27:32 INFO - PROCESS | 14697 | __end_tp_report 01:27:32 INFO - PROCESS | 14697 | __start_cc_report 01:27:32 INFO - PROCESS | 14697 | _x_x_mozilla_cycle_collect,894 01:27:32 INFO - PROCESS | 14697 | __end_cc_report 01:27:32 INFO - PROCESS | 14697 | __startTimestamp1467016052831__endTimestamp 01:27:32 INFO - PROCESS | 14697 | 01:27:32 INFO - PROCESS | 14697 | ------- Summary: start ------- 01:27:32 INFO - PROCESS | 14697 | Number of tests: 14 01:27:32 INFO - PROCESS | 14697 | 01:27:32 INFO - PROCESS | 14697 | [#0] ai-astar Cycles:10 Average:108.60 Median:110.00 stddev:3.50 (3.2%) stddev-sans-first:2.40 01:27:32 INFO - PROCESS | 14697 | Values: 101.0 109.0 104.0 110.0 112.0 110.0 110.0 108.0 112.0 110.0 01:27:32 INFO - PROCESS | 14697 | 01:27:32 INFO - PROCESS | 14697 | [#1] audio-beat-detection Cycles:10 Average:149.40 Median:156.50 stddev:21.21 (13.6%) stddev-sans-first:22.49 01:27:32 INFO - PROCESS | 14697 | Values: 151.0 125.0 160.0 177.0 131.0 158.0 155.0 126.0 183.0 128.0 01:27:32 INFO - PROCESS | 14697 | 01:27:32 INFO - PROCESS | 14697 | [#2] audio-dft Cycles:10 Average:163.20 Median:163.00 stddev:4.21 (2.6%) stddev-sans-first:4.47 01:27:32 INFO - PROCESS | 14697 | Values: 163.0 161.0 160.0 160.0 163.0 174.0 166.0 161.0 161.0 163.0 01:27:32 INFO - PROCESS | 14697 | 01:27:32 INFO - PROCESS | 14697 | [#3] audio-fft Cycles:10 Average:93.80 Median:75.50 stddev:38.66 (51.2%) stddev-sans-first:40.40 01:27:32 INFO - PROCESS | 14697 | Values: 75.0 76.0 76.0 172.0 77.0 75.0 75.0 76.0 162.0 74.0 01:27:32 INFO - PROCESS | 14697 | 01:27:32 INFO - PROCESS | 14697 | [#4] audio-oscillator Cycles:10 Average:105.70 Median:86.00 stddev:29.22 (34.0%) stddev-sans-first:30.68 01:27:32 INFO - PROCESS | 14697 | Values: 94.0 86.0 149.0 92.0 86.0 86.0 142.0 85.0 85.0 152.0 01:27:32 INFO - PROCESS | 14697 | 01:27:32 INFO - PROCESS | 14697 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:117.00 stddev:0.85 (0.7%) stddev-sans-first:0.88 01:27:32 INFO - PROCESS | 14697 | Values: 117.0 117.0 119.0 117.0 117.0 117.0 117.0 117.0 119.0 118.0 01:27:32 INFO - PROCESS | 14697 | 01:27:32 INFO - PROCESS | 14697 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 01:27:32 INFO - PROCESS | 14697 | Values: 147.0 149.0 147.0 147.0 147.0 147.0 147.0 147.0 147.0 147.0 01:27:32 INFO - PROCESS | 14697 | 01:27:32 INFO - PROCESS | 14697 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.95 (1.0%) stddev-sans-first:0.97 01:27:32 INFO - PROCESS | 14697 | Values: 95.0 98.0 95.0 96.0 95.0 95.0 96.0 96.0 96.0 95.0 01:27:32 INFO - PROCESS | 14697 | 01:27:32 INFO - PROCESS | 14697 | [#8] json-parse-financial Cycles:10 Average:54.30 Median:54.00 stddev:2.06 (3.8%) stddev-sans-first:2.13 01:27:32 INFO - PROCESS | 14697 | Values: 53.0 53.0 58.0 52.0 56.0 53.0 53.0 55.0 57.0 53.0 01:27:32 INFO - PROCESS | 14697 | 01:27:32 INFO - PROCESS | 14697 | [#9] json-stringify-tinderbox Cycles:10 Average:63.00 Median:63.00 stddev:0.47 (0.7%) stddev-sans-first:0.50 01:27:32 INFO - PROCESS | 14697 | Values: 63.0 63.0 63.0 63.0 63.0 63.0 63.0 63.0 64.0 62.0 01:27:32 INFO - PROCESS | 14697 | 01:27:32 INFO - PROCESS | 14697 | [#10] stanford-crypto-aes Cycles:10 Average:82.90 Median:82.00 stddev:6.03 (7.3%) stddev-sans-first:5.17 01:27:32 INFO - PROCESS | 14697 | Values: 93.0 77.0 78.0 78.0 84.0 82.0 82.0 79.0 94.0 82.0 01:27:32 INFO - PROCESS | 14697 | 01:27:32 INFO - PROCESS | 14697 | [#11] stanford-crypto-ccm Cycles:10 Average:124.80 Median:124.50 stddev:4.16 (3.3%) stddev-sans-first:4.40 01:27:32 INFO - PROCESS | 14697 | Values: 124.0 123.0 121.0 119.0 123.0 122.0 130.0 125.0 131.0 130.0 01:27:32 INFO - PROCESS | 14697 | 01:27:32 INFO - PROCESS | 14697 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.10 Median:160.00 stddev:2.18 (1.4%) stddev-sans-first:1.42 01:27:32 INFO - PROCESS | 14697 | Values: 164.0 157.0 160.0 160.0 158.0 157.0 158.0 160.0 157.0 160.0 01:27:32 INFO - PROCESS | 14697 | 01:27:32 INFO - PROCESS | 14697 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.60 Median:64.50 stddev:4.14 (6.4%) stddev-sans-first:4.35 01:27:32 INFO - PROCESS | 14697 | Values: 64.0 73.0 70.0 71.0 63.0 65.0 62.0 62.0 64.0 62.0 01:27:32 INFO - PROCESS | 14697 | -------- Summary: end -------- 01:27:32 INFO - PROCESS | 14697 | 01:27:33 INFO - TEST-INFO | 14697: exit 0 01:27:33 INFO - TEST-OK | kraken | took 61851ms 01:27:33 INFO - SUITE-END | took 1172s 01:27:33 INFO - Completed test suite (00:19:32) 01:27:33 INFO - javascript benchmark 01:27:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7317.735108860349, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3162.9367412651745, 3169.920751981199, 3190.5533225348454, 3197.9200519987, 3210.2616398228406, 5364.356277246726, 5378.300820893283, 5474.945250547494, 5481.177823326498, 5521.806736764214, 5470.370907345657, 5511.53151982081, 5526.364468086172, 5568.5266752326, 5659.8585035374135, 4883.633727470445, 4955.801767929279, 5059.924101138486, 5083.593312535007, 5147.073526765181, 712.3483321246473, 5027.220780778966, 5083.923741143886, 5084.822031228908, 5137.486251374851, 5068.138416469209, 5069.74651267437, 5074.974625126869, 5108.310378098965, 5145.073886700392, 5039.949600503985, 5106.872328191787, 5111.437741848394, 5119.718415487147, 5133.614978876599, 5024.949750502485, 5046.9747651261505, 5081.898362032775, 5096.745162741885, 5141.948580514184, 5602.663840169603, 5617.32592088952, 5628.240187574666, 5632.3804381518, 5693.430656934273, 5801.854953626151, 5924.348321684654, 5963.731632076567, 6049.395060493959, 6055.5761096723245, 6054.636721796706, 6076.513878889678, 6079.726412311456, 6088.360722124202, 6125.050617154348, 5651.858703532363, 5654.886902261973, 5658.91511627326, 5659.773609055633, 5677.517411020068, 5994.100884867217, 6100.267967843798, 6103.277060575968, 6119.07606531266, 6187.041008643578, 5910.822675319747, 5910.8817823643285, 5915.674637894871, 5940.0, 5956.463918247378, 5959.284885813643, 6002.969985150134, 6018.277806663228, 6020.187274717857, 6023.1266466363, 5803.0, 5831.067029275296, 5831.533477321804, 5892.322382926019, 5916.26046744157, 5777.162311464814, 5812.3025236971835, 5821.359650438449, 5871.970640146772, 5909.763609455659, 4477.507474177838, 4495.505494395614, 4497.055618320124, 4507.4365704286965, 4537.024539723975, 3946.072672921861, 3951.6443520082757, 3964.0486283291802, 3969.503812023497, 3996.540397854284, 5672.943270567242, 5674.914876276859, 5686.658800471985, 5689.0328644130595, 5740.770369185269, 5894.056950887837, 5983.640981541034, 5984.970075149597, 5987.6108052976415, 5990.670513121733, 5531.889362212733, 5572.192032155314, 5602.0196465618355, 5623.0721930880945, 5663.405342439067, 4903.828366007244, 4944.950550494521, 4959.429665588431, 4963.677360971526, 4964.90070198594, 6108.633481991094, 6138.508919286446, 6138.631682099089, 6139.84650383744, 6140.140380346755, 5747.48272655463, 5779.479846813639, 5790.7973220937065, 5816.185733997159, 5873.794417195378, 6103.621715307426, 6140.478059364826, 6150.600210986271, 6152.415520525543, 6167.629942203482, 5833.7666493341485, 5838.824835254949, 5848.736806843617, 5864.501517371071, 5870.677112758668, 5782.5373970081455, 5881.647101173943, 5886.970565147147, 5919.289685237799, 5963.970180149072, 5815.505682017076, 5819.214406055128, 5828.6211396259105, 5829.795957141479, 5833.82498525045, 5768.105943578584, 5789.218455508452, 5793.217915581343, 5793.710314484343, 5805.680687562224, 5507.779688812403, 5648.435156484319, 5671.8865622688145, 5706.6005379624685, 5713.428657134254, 5822.388649191943, 5855.443732845373, 5883.058710606282, 5890.646561206341, 5894.322152952465, 5547.472990065938, 5712.171735098471, 5722.227499287543, 5732.598718089694, 5742.253507044057], "value": 5437.7740652000075, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [569.6439725171767, 611.2512172588578, 622.726000559754, 625.0592857749087, 627.9183706118203, 43021.78489107554, 44269.77865110674, 44624.776876115575, 44992.77503612481, 47759.0, 46565.534344656546, 46742.766286168604, 47118.52881471184, 47374.0, 47478.52521474784, 8921.643134274638, 9081.455112693227, 9082.13719696631, 9085.13691199335, 9098.0, 8870.201681848632, 9028.954855225715, 9029.187373136416, 9039.186473217409, 9061.229795467394, 9046.185843274105, 9055.185033346997, 9067.093290670913, 9081.591328390205, 9125.315601329894, 9047.0, 9093.0, 9100.8634870477, 9102.772430689252, 9109.772255693595, 8887.0, 8914.73255802327, 8972.0, 8979.19187273142, 8998.685046023424, 43051.784741076095, 43255.35116973248, 43357.0489327981, 43430.565694343284, 43714.56285437137, 3535.345960997198, 3591.7665351752053, 3700.7964561949084, 4098.385242213662, 4215.936760948558, 32483.51274730881, 33935.321293574234, 34450.31099378024, 34938.47592286118, 35549.46675799865, 4406.206882761102, 4411.955880441186, 4533.909321813545, 4579.107074120548, 4592.311153326994, 364042.0, 369460.0, 371517.0, 371768.0, 372018.0, 35438.29123417569, 36141.63858361383, 65214.347856521774, 66054.33945660482, 66157.33842661511, 37958.62041379606, 38170.618293817264, 38172.42741358882, 38326.80836595799, 38340.0, 15996.76004859928, 16127.919360403357, 16153.4346297879, 16196.595085122966, 16228.0, 13448.529301474402, 13523.39144738489, 13559.796603050961, 13571.457141714222, 13579.0, 8406.0, 8529.360297977677, 8547.40168188221, 8562.571871406404, 8624.051354351017, 3297.950530742041, 3325.900222993314, 3334.916627084294, 3335.382954153489, 3424.503447000171, 954.341504361988, 1035.5236591167995, 1141.9828702569469, 1143.6226045404997, 1155.9076672544365, 32260.677393225767, 32534.837325813693, 32784.83607581947, 32881.835590821895, 33352.83323583366, 1105.4748994227677, 1114.4037939702382, 1128.7516746315798, 1210.975780484403, 1249.8312727781815, 17011.744823827652, 17324.740128898076, 17380.565485862953, 17405.0, 17452.912735436243, 583720.0, 602319.0, 604377.0, 604443.0, 605241.0, 59893.40106598965, 61248.69375653182, 61385.38614613886, 61582.69208654018, 61728.60492672946, 1323.8543760186371, 1342.731453709262, 1348.298884580013, 1355.8440779310308, 1377.2081053394338, 29838.403231935674, 31809.363812724077, 31993.0, 32064.35871282608, 32097.518537222426, 51933.74033129961, 52227.216591750395, 52503.47496524986, 52721.73639131933, 52749.472505274454, 500029.0, 503023.0, 503078.0, 504220.0, 504819.0, 28515.28711782222, 28959.85520072386, 29569.112926612237, 29730.70269297366, 29804.254893627833, 49292.0, 49911.50088499069, 49961.0, 50918.236226457375, 51029.0, 42453.0, 42730.0, 43351.566484336014, 43649.56350436455, 43921.34117988297, 36778.8161059193, 36953.44569831401, 36955.26089478249, 37000.0, 37238.44142337813, 37515.43726844154, 41487.58512414958, 41555.792221038704, 42217.78891105525, 42653.146937061705, 36042.8197859009, 38101.4284785734, 38510.0, 38978.415323770736, 39146.0, 29315.706842931297, 29462.11613651594, 29799.404011920073, 29900.839810906236, 30129.246768830955], "value": 19557.610403184386, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.873562988584, 372.8191826963922, 374.5729867950536, 386.872332130397, 400.9679225661947, 17627.82372176278, 19530.218791248368, 19929.0, 20161.59676806465, 20384.592308153828, 18425.0, 18799.718004229948, 18987.62024759504, 19062.2375104996, 19065.428037158872, 5439.673619582838, 5545.3622833374275, 5581.6371935824245, 5658.971705141468, 5669.121286200645, 5306.893862122755, 5347.893042139174, 5506.366767821692, 5526.198701188326, 5558.360788509332, 5403.2165336026255, 5426.647267927572, 5468.043092458824, 5479.808206712766, 5512.476314750113, 5350.0, 5419.376771671269, 5439.292891924025, 5454.127339625641, 5467.234587157801, 4835.419749630032, 4893.877653058702, 4924.950750492485, 4951.108800415924, 4978.6017118630425, 22271.109155633756, 22628.660570091462, 22910.885445572665, 23017.53964920709, 23146.305610831703, 2254.0983606557343, 2306.550222706573, 2353.5292941411617, 2357.5638506876285, 3019.9169049588063, 7390.778276651656, 8854.335924805666, 9484.430934143973, 9485.620575176985, 14307.57077287683, 1853.3976457651183, 1882.4634979031048, 1907.418237437581, 1943.724823672103, 1976.2786582897138, 55969.0, 84549.57725211335, 85048.0, 85476.57261713651, 85842.5707871463, 10320.43237621923, 10427.68716938493, 10438.0, 10573.995470430296, 10744.086752626114, 14147.575572732834, 14174.787378189336, 14187.14877107377, 14213.289335533182, 14235.430582776573, 8130.796730081795, 8262.793430164174, 8307.851392274148, 8342.62458189383, 8397.6221070052, 8203.548804815673, 8222.0, 8348.707795227137, 8384.329253659815, 8431.19903609156, 4252.468441444819, 4289.785510724451, 4333.609975102256, 4339.435873336446, 4505.842295519641, 1838.7425760393555, 1852.6109517001312, 1859.869809113349, 1870.8503319734389, 1900.515368581003, 908.3505293715026, 987.2299606307092, 1012.8987101289812, 1021.4382089850552, 1085.799127161462, 18761.249550018118, 19605.901970490057, 19691.310804121786, 19730.605387892163, 19950.30173943905, 984.6504490905626, 990.4305024610877, 998.2762497189625, 1000.7398076500162, 1026.779242462874, 10165.847512287322, 10841.67474975752, 10897.945510272557, 10921.563137474412, 10922.726931826768, 471762.0, 473470.0, 473700.0, 473908.0, 476628.0, 68183.65908170427, 83152.58423707963, 85272.57363713141, 86127.56936215404, 86654.13345866586, 993.60752502761, 1012.4633944009687, 1045.0437849367743, 1050.3487837540774, 1056.1920131099714, 14371.281435928371, 16232.26954787061, 17355.7396639048, 17446.0, 17741.46775596734, 41624.3756343649, 42033.369499458146, 42930.0, 43237.567624323354, 43764.0, 61646.38353616586, 62334.506619734704, 63582.68208658927, 63600.0, 64592.354076458636, 8136.145704701158, 8288.792780180544, 8297.04583972851, 8387.74183872424, 8394.790130246793, 12467.688307792016, 13799.586012419644, 13822.516211932534, 13955.651108722363, 14143.858561414254, 11692.883071169179, 11815.763684726086, 11930.10524210705, 11996.700082497659, 12093.879061209274, 5513.56913440253, 11647.417629118341, 12208.572699955459, 12236.0, 12314.938425308175, 12360.134790564574, 12392.442340094538, 12505.312207828656, 12515.687107822378, 12570.245785252913, 6919.584824910521, 7325.120985481776, 7597.582132982739, 7805.0, 8533.402661813614, 10491.94754026225, 12116.333601651993, 12155.939220303842, 12197.573084941985, 12249.938750306548], "value": 9047.440934118193, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1471.9484818031367, 1472.7790831375291, 1616.4746457401347, 1721.9827801721995, 1735.991320043399, 8102.594870256493, 8692.43536163491, 8730.781730456742, 9250.583723732432, 9285.303602229835, 8810.955945220281, 9036.41263317884, 9053.637854485829, 9111.498867562297, 9133.451992880431, 2291.106468477291, 2313.410080429488, 2325.6744055832196, 2338.9298321050396, 2340.9063637454483, 2129.595376878396, 2131.957360852782, 2133.551954089643, 2152.332776839177, 2264.0264686184933, 2234.497238121418, 2246.225052356934, 2269.4326418395403, 2280.7149106361703, 2310.792028717415, 2262.7058482397265, 2265.818734501236, 2269.636858102704, 2274.1699279762934, 2279.87460689662, 2227.9665805012937, 2232.073689418889, 2236.586231547169, 2240.957954551125, 2242.394553470554, 9145.496997665126, 9240.26077913772, 9258.768530786718, 9261.953690231505, 9296.814063718755, 5163.896722065575, 5292.550133238679, 5295.470452954673, 5298.549623282026, 5300.125479295912, 3006.4438078955245, 3043.5303753720555, 3171.0803866878578, 3189.4418476766705, 3199.4880819068835, 1062.1768129699467, 1062.54310646422, 1076.3272954403499, 1089.1776708585046, 1096.4408151842538, 12694.238345699288, 12828.615141545768, 12835.807462888064, 12838.101332906606, 12939.935300323437, 4449.57729015743, 4567.6802623816675, 4619.653525985565, 4621.560951709582, 4654.557817007379, 10814.0, 10844.45777711127, 10890.72773180661, 10902.345859248471, 10906.0, 5256.2115682647145, 5279.736013199325, 5301.257823904656, 5337.386200586904, 5349.384820745586, 4294.248506511348, 4582.1293954148605, 4754.31062495943, 4757.595604373667, 4926.679765815211, 3952.703547233969, 3970.583088775637, 4067.1662309226535, 4069.328560787437, 4090.181963607231, 1229.170310040719, 1236.6042866282883, 1244.508419174421, 1247.1955588645274, 1251.6995920979082, 1003.598560575761, 1010.4796030044533, 1027.5119318323736, 1030.3611760708259, 1043.8225501664735, 6074.0, 6132.294786099566, 6172.321044685081, 6402.391772781578, 6491.350864913566, 417.40936574746394, 426.8996785755345, 438.6140196626948, 446.6583063956076, 451.8463722334422, 4033.233685599727, 4046.8785936421955, 4071.226466971266, 4142.420061191436, 4208.915821683549, 11210.27133236337, 11487.655370338904, 11570.479328430241, 11669.0, 11669.35818529972, 11337.1497137715, 11381.203315767982, 11391.829122563167, 11452.770944581061, 11477.483513241925, 7901.525908445512, 8324.750257492286, 8330.166983301622, 8517.872231916526, 8570.528620925785, 5870.207521984477, 6027.457528822427, 6062.90905636407, 6168.352323006199, 6196.287426945959, 10347.379157250589, 10369.325993810378, 10434.321769084985, 10557.155427565624, 10576.788464230825, 9948.900510995087, 10410.47947602632, 10433.9478302608, 10596.788064238826, 10748.140148787921, 7302.671379788028, 7981.122076571456, 8083.959580202297, 8229.135940726377, 8232.588370581327, 8972.641094356153, 9013.459192448474, 9031.909680903107, 9042.638294468148, 9094.27245820346, 8020.157883422156, 8192.918070819216, 8249.917500825155, 8289.792755180928, 8340.833183336177, 7957.124716281089, 8082.555459449787, 8120.1473845247765, 8128.83742325162, 8229.135940726377, 6927.307269273032, 7221.747238846615, 7222.638868056471, 7396.038514993232, 7507.324340809353, 5538.806141785019, 5613.859653508695, 5621.213030175697, 5666.0, 5782.421757824184, 4485.282354823213, 4506.909861802811, 5168.147255702767, 5351.678899266057, 5365.624406291522], "value": 4609.124135897163, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [302.98198054536755, 316.68964414873426, 316.7291965369609, 322.2089769615594, 325.58650513847414, 5512.944870551293, 5575.303087114111, 5655.802046928353, 5684.829455116348, 5790.392008839074, 5583.8604034899145, 5585.553155747541, 5592.133219350997, 5630.042892708239, 5632.943670563293, 4342.522322544518, 4362.869113926571, 4371.300591905296, 4433.490148632916, 4445.977770111161, 4351.412559304501, 4368.694191406603, 4390.363397307388, 4418.491873434548, 4447.35513350564, 4350.173467041268, 4358.455193100863, 4364.650827933773, 4374.781260936957, 4394.143142087294, 4410.051838854662, 4410.404595379615, 4416.2713152329825, 4423.623991960703, 4430.474629461209, 3695.150115473429, 3788.6021967693546, 3880.805959702032, 3881.7282790204695, 3893.1240470894104, 5413.810516631938, 5463.562914966793, 5479.369872464637, 5484.424135465799, 5494.917576236359, 4880.657819099741, 4926.729029903354, 4934.358533390672, 4948.7278199699, 4973.726445045521, 5797.594168408213, 5862.736176872051, 5914.615549989237, 5926.911096333559, 5937.792177273818, 4118.608732170439, 4138.441310423084, 4140.130572579762, 4142.0, 4144.52337981133, 6171.876562468726, 6190.628562286232, 6199.628022318675, 6206.379362063757, 6240.0, 4137.8758637240935, 4263.232618128704, 4265.210935976854, 4273.166732487135, 4296.5273819879785, 4310.612044915973, 4318.611324980767, 4342.6308763754805, 4359.956400435955, 4381.38660587518, 4943.579795717333, 4991.101601711727, 5007.522780779679, 5036.841526448938, 5043.823466178739, 5848.210491583582, 5903.734331955073, 5914.467697907209, 6035.30593981689, 6042.848928776728, 1436.8850491960618, 1451.9056261342978, 1454.861788130126, 1462.5393001204586, 1466.2009204983096, 928.1831987850649, 933.4352716606492, 946.7917058247175, 953.270747877874, 953.9332246742662, 5084.779632904754, 5086.643934924594, 5134.794608215704, 5169.172932330809, 5169.379674439091, 5318.680879147263, 5324.5740340772645, 5351.866203344947, 5355.3305836770405, 5400.405955344909, 5028.899422011613, 5092.337996060489, 5100.69395836251, 5377.489138531833, 5848.766049357978, 3227.451333273349, 3239.49787782894, 3259.1200375898375, 3307.1732066983254, 3318.93793985927, 6110.144579758838, 6315.400036996478, 6373.0440433934355, 6410.230772307353, 6411.6153030818305, 6154.0, 6221.160143380585, 6268.1851359323, 6273.529485288622, 6288.27684816252, 6287.371262873676, 6296.0, 6313.305536390993, 6324.873502529924, 6414.903776443357, 5849.53203743708, 6101.877962440815, 6103.908441373472, 6106.1451396803595, 6109.48069414087, 6056.636601803906, 6135.815925522242, 6139.171211886338, 6149.815505534841, 6160.969195153995, 6157.353477884937, 6308.653024083719, 6367.808965731036, 6396.744130234924, 6470.220689310289, 4130.463039804806, 4149.813258403318, 4152.688548358825, 4172.332426811696, 4189.790510474525, 6139.785107521216, 6208.0, 6210.875782484415, 6221.782237621662, 6240.188775459162, 5766.711664416846, 5954.493868021266, 6005.759769609342, 6042.274927008787, 6078.45293923549, 5966.76132954677, 5983.790567330123, 6007.339192688713, 6039.124326972476, 6064.969675151596, 5675.971620141873, 5910.645361278337, 5918.2898052234, 5978.043513037893, 6002.609830361012, 6032.969835150971, 6050.30421501533, 6052.606580572248, 6062.787802426894, 6074.451014991149, 5939.4951429129005, 5944.64332140073, 5953.64830891804, 5974.283086029531, 6006.279246490274], "value": 4462.1882646599215, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [718.2458418660409, 758.8292634157311, 794.3843521271015, 811.8335741173053, 830.6718846055808, 14811.62970925726, 15552.0, 15573.610659733513, 15614.0, 15655.843441565581, 14704.338304776284, 14741.410343586243, 14745.336459859305, 14774.704505909902, 14826.851731482682, 672.4889084295921, 792.2513225002375, 799.7480793550028, 808.5472135604051, 820.958952052395, 812.6424373275769, 814.5031530766257, 815.4862436664893, 816.5223344343566, 821.0311832038193, 859.2953777902122, 863.5509535041774, 864.4769914201912, 865.2861389353777, 868.9695860644879, 852.9189726975927, 853.5988085599789, 858.1118542308681, 859.4070091636781, 860.6987554355957, 623.1151764494429, 624.2602516018487, 625.5121005615628, 625.7184267079787, 627.1690010735748, 15362.231888405648, 15427.768583471257, 15495.92252038744, 15566.610834729108, 15581.610459738484, 15196.757118793998, 15309.464168754152, 15347.309371078329, 15402.0, 15510.302036408277, 12358.258504489759, 12512.687182820411, 12575.05687073464, 12589.118761686686, 12608.369581520887, 3803.8478460861534, 3870.3807390817333, 3955.3275943089743, 4021.2560676274984, 4052.250333688277, 79120.60439697822, 80394.59802701007, 80404.59797701033, 81211.59394203051, 82124.58937705333, 11556.942215289038, 11650.88349116498, 11731.35477548726, 11742.823857642143, 11791.29252244868, 20241.797582024286, 21847.235346762787, 22001.449963750714, 22287.888560557418, 22313.55372892533, 8764.91235087641, 8879.644814207359, 8913.37606367561, 9018.909810901938, 9028.36801423894, 4669.34629151919, 4693.9765301173275, 4709.222978208626, 4761.428628564595, 4855.514448555187, 3699.611540788232, 3818.4845045918446, 3821.6369444903244, 3821.7515861468914, 3824.7896365700153, 671.9764808231688, 678.128604742903, 680.4318394140947, 686.8866637004838, 700.0444393402968, 765.8966039584585, 766.1916677904752, 770.2259229474342, 788.7909703928464, 791.2641243643467, 9879.259055570717, 9920.40477571348, 10342.948285258526, 10377.636782712569, 10451.111655509214, 653.7287025884204, 670.7484693240035, 712.4051417066808, 733.1056111543908, 743.8921356403291, 5070.416902056237, 5091.541761241432, 5126.179811230185, 5128.947986233557, 5152.175651895679, 114196.42901785437, 116484.0, 116562.0, 117619.41190293994, 118751.0, 101269.49365253274, 102205.0, 103250.48374758229, 104278.0, 104642.4767876171, 57588.71205644029, 88904.55547722349, 89091.55454222688, 89568.5521572388, 90943.54528227316, 9786.314957952874, 10069.597216111273, 10146.949265253626, 10307.690769276935, 10433.686989390331, 49110.50889491059, 49643.50356496389, 50525.0, 50863.0, 52705.472945270056, 51063.0, 51211.487885122166, 66107.66946165239, 67836.0, 77836.61081694555, 13403.195808251536, 13470.19178849233, 13635.522756703467, 14033.0, 14341.211233382264, 15454.690906182039, 15502.379904804133, 15541.84458155404, 15643.843561564694, 15811.841881581036, 14367.20980346091, 14501.791362484688, 14585.781213282022, 14658.269830615312, 14685.926570367079, 14868.0, 14906.403743850124, 15087.698246035237, 15787.842121578637, 15954.28205730768, 14084.78872816888, 14291.928540357232, 14510.564683059525, 14526.782098268322, 15189.696206075596, 10821.621243256448, 10983.670489885317, 11036.558537658404, 11203.887961120285, 11216.943915280372, 10796.838047429137, 10859.34843909368, 10947.397893115955, 10947.890521095005, 10950.288231264942], "value": 7758.711536421593, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1530.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 109.0, 104.0, 110.0, 112.0, 110.0, 110.0, 108.0, 112.0, 110.0], "value": 108.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 125.0, 160.0, 177.0, 131.0, 158.0, 155.0, 126.0, 183.0, 128.0], "value": 149.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 160.0, 160.0, 163.0, 174.0, 166.0, 161.0, 161.0, 163.0], "value": 163.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 172.0, 77.0, 75.0, 75.0, 76.0, 162.0, 74.0], "value": 93.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 86.0, 149.0, 92.0, 86.0, 86.0, 142.0, 85.0, 85.0, 152.0], "value": 105.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 119.0, 117.0, 117.0, 117.0, 117.0, 117.0, 119.0, 118.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 149.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 98.0, 95.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 58.0, 52.0, 56.0, 53.0, 53.0, 55.0, 57.0, 53.0], "value": 54.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 63.0, 63.0, 63.0, 63.0, 63.0, 64.0, 62.0], "value": 63.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 77.0, 78.0, 78.0, 84.0, 82.0, 82.0, 79.0, 94.0, 82.0], "value": 82.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 123.0, 121.0, 119.0, 123.0, 122.0, 130.0, 125.0, 131.0, 130.0], "value": 124.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 157.0, 160.0, 160.0, 158.0, 157.0, 158.0, 160.0, 157.0, 160.0], "value": 159.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 73.0, 70.0, 71.0, 63.0, 65.0, 62.0, 62.0, 64.0, 62.0], "value": 65.6, "unit": "score"}]}]} 01:27:34 INFO - Return code: 0 01:27:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:27:34 ERROR - # TBPL SUCCESS # 01:27:34 INFO - Running post-action listener: _resource_record_post_action 01:27:34 INFO - ##### 01:27:34 INFO - ##### Finished run-tests step (success) 01:27:34 INFO - ##### 01:27:34 INFO - Running post-run listener: _resource_record_post_run 01:27:34 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 552787968; Read time: 12; Write time: 445064 01:27:34 INFO - TinderboxPrint: CPU usage
13.5% 01:27:34 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 01:27:34 INFO - TinderboxPrint: I/O write bytes / time
552,787,968 / 445,064 01:27:34 INFO - TinderboxPrint: CPU idle
8,219.7 (86.5%) 01:27:34 INFO - TinderboxPrint: CPU user
1,226.5 (12.9%) 01:27:34 INFO - TinderboxPrint: Swap in / out
0 / 0 01:27:34 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 256573440; Read time: 0; Write time: 247888 01:27:34 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 296214528; Read time: 12; Write time: 197176 01:27:34 INFO - Running post-run listener: _upload_blobber_files 01:27:34 INFO - Blob upload gear active. 01:27:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:27:34 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 01:27:34 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-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 01:27:34 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-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 01:27:35 INFO - (blobuploader) - INFO - Open directory for files ... 01:27:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 01:27:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:27:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:27:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 01:27:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:27:36 INFO - (blobuploader) - INFO - Done attempting. 01:27:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 01:27:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:27:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:27:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 01:27:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:27:36 INFO - (blobuploader) - INFO - Done attempting. 01:27:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:27:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:27:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:27:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:27:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:27:41 INFO - (blobuploader) - INFO - Done attempting. 01:27:41 INFO - (blobuploader) - INFO - Iteration through files over. 01:27:41 INFO - Return code: 0 01:27:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:27:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:27:41 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/537667de6e8302fed4170ab01e1ca4d3f39fe4eaec25261332ed4ce06e7f505c196e6c8c5c4fdded9dafa9f526834acabe3a788814d83f103cf54cb7f8751f74", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0e847b222d29bdc493b9eeff24a24b6a23de841d0d148eaac8e46e819267e24cca4a4c51ca2bcd582f5f9dace33e6280fc5b0eef1d9c3d5a9ebc73f35946844d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/64cd1e5e17b56a0aa86aa06b6c8199349ac72a869c625e2494962490c6c6c8fcbf37a9fb85853aa487f23085a424d9f806c03549a930d2981e110a541b2a4739"} 01:27:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:27:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:27:41 INFO - Contents: 01:27:41 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/537667de6e8302fed4170ab01e1ca4d3f39fe4eaec25261332ed4ce06e7f505c196e6c8c5c4fdded9dafa9f526834acabe3a788814d83f103cf54cb7f8751f74", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0e847b222d29bdc493b9eeff24a24b6a23de841d0d148eaac8e46e819267e24cca4a4c51ca2bcd582f5f9dace33e6280fc5b0eef1d9c3d5a9ebc73f35946844d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/64cd1e5e17b56a0aa86aa06b6c8199349ac72a869c625e2494962490c6c6c8fcbf37a9fb85853aa487f23085a424d9f806c03549a930d2981e110a541b2a4739"} 01:27:41 INFO - Running post-run listener: copy_logs_to_upload_dir 01:27:41 INFO - Copying logs to upload dir... 01:27:41 INFO - mkdir: /builds/slave/test/build/upload/logs 01:27:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.925572 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-06-27 01:27:41.515454) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 01:27:41.518590) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1467005418.192536-448123721 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-Inbound/sha512/537667de6e8302fed4170ab01e1ca4d3f39fe4eaec25261332ed4ce06e7f505c196e6c8c5c4fdded9dafa9f526834acabe3a788814d83f103cf54cb7f8751f74", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0e847b222d29bdc493b9eeff24a24b6a23de841d0d148eaac8e46e819267e24cca4a4c51ca2bcd582f5f9dace33e6280fc5b0eef1d9c3d5a9ebc73f35946844d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/64cd1e5e17b56a0aa86aa06b6c8199349ac72a869c625e2494962490c6c6c8fcbf37a9fb85853aa487f23085a424d9f806c03549a930d2981e110a541b2a4739"} build_url:https://queue.taskcluster.net/v1/task/fuU3XVGxQGmV4Zbqa6-uFA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011186 build_url: 'https://queue.taskcluster.net/v1/task/fuU3XVGxQGmV4Zbqa6-uFA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/537667de6e8302fed4170ab01e1ca4d3f39fe4eaec25261332ed4ce06e7f505c196e6c8c5c4fdded9dafa9f526834acabe3a788814d83f103cf54cb7f8751f74", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0e847b222d29bdc493b9eeff24a24b6a23de841d0d148eaac8e46e819267e24cca4a4c51ca2bcd582f5f9dace33e6280fc5b0eef1d9c3d5a9ebc73f35946844d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/64cd1e5e17b56a0aa86aa06b6c8199349ac72a869c625e2494962490c6c6c8fcbf37a9fb85853aa487f23085a424d9f806c03549a930d2981e110a541b2a4739"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 01:27:41.543289) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 01:27:41.543572) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1467005418.192536-448123721 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004408 ========= master_lag: 0.42 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 01:27:41.966130) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 01:27:41.966450) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 01:27:41.966806) ========= ========= Total master_lag: 0.51 =========