builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-047 starttime: 1465665098.98 results: success (0) buildid: 20160611073123 builduid: 5f5ad121f57a4727b3535021d79a1637 revision: d3695a07cbdcfe167ca944436175df9fda58e4ff ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-11 10:11:38.977436) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-11 10:11:38.977866) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-11 10:11:38.978145) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-11 10:11:39.015204) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-11 10:11:39.015515) ========= 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=03627c79f6bb3d1578c4a402000001ba-1465655652.265244-548633170 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-11 10:11:39-- 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% 50.7M=0s 2016-06-11 10:11:39 (50.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.142883 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-11 10:11:39.174403) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-11 10:11:39.174729) ========= 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=03627c79f6bb3d1578c4a402000001ba-1465655652.265244-548633170 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019832 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-11 10:11:39.226907) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-11 10:11:39.227243) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev d3695a07cbdcfe167ca944436175df9fda58e4ff --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 d3695a07cbdcfe167ca944436175df9fda58e4ff --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=03627c79f6bb3d1578c4a402000001ba-1465655652.265244-548633170 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-11 10:11:39,685 truncating revision to first 12 chars 2016-06-11 10:11:39,685 Setting DEBUG logging. 2016-06-11 10:11:39,685 attempt 1/10 2016-06-11 10:11:39,685 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/d3695a07cbdc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-11 10:11:40,669 unpacking tar archive at: mozilla-inbound-d3695a07cbdc/testing/mozharness/ program finished with exit code 0 elapsedTime=1.333307 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-11 10:11:40.573284) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-11 10:11:40.573591) ========= script_repo_revision: d3695a07cbdcfe167ca944436175df9fda58e4ff ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-11 10:11:40.573986) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-11 10:11:40.574266) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-11 10:11:40.584605) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2016-06-11 10:11:40.585011) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=03627c79f6bb3d1578c4a402000001ba-1465655652.265244-548633170 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:11:41 INFO - MultiFileLogger online at 20160611 10:11:41 in /builds/slave/test 10:11:41 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 10:11:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:11:41 INFO - {'append_to_log': False, 10:11:41 INFO - 'base_work_dir': '/builds/slave/test', 10:11:41 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 10:11:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:11:41 INFO - 'branch': 'Mozilla-Inbound', 10:11:41 INFO - 'buildbot_json_path': 'buildprops.json', 10:11:41 INFO - 'config_files': ('talos/linux_config.py',), 10:11:41 INFO - 'default_actions': ('clobber', 10:11:41 INFO - 'read-buildbot-config', 10:11:41 INFO - 'download-and-extract', 10:11:41 INFO - 'populate-webroot', 10:11:41 INFO - 'create-virtualenv', 10:11:41 INFO - 'install', 10:11:41 INFO - 'run-tests'), 10:11:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:11:41 INFO - 'download_minidump_stackwalk': True, 10:11:41 INFO - 'download_symbols': 'ondemand', 10:11:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:11:41 INFO - 'tooltool.py': '/tools/tooltool.py', 10:11:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:11:41 INFO - '/tools/misc-python/virtualenv.py')}, 10:11:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:11:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:11:41 INFO - 'installer_path': 'installer.exe', 10:11:41 INFO - 'log_level': 'info', 10:11:41 INFO - 'log_name': 'talos', 10:11:41 INFO - 'log_to_console': True, 10:11:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:11:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:11:41 INFO - 'opt_config_files': (), 10:11:41 INFO - 'pip_index': False, 10:11:41 INFO - 'sps_profile': False, 10:11:41 INFO - 'sps_profile_interval': 0, 10:11:41 INFO - 'suite': 'dromaeojs', 10:11:41 INFO - 'system_bits': '32', 10:11:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:11:41 INFO - 'title': 'talos-linux64-ix-047', 10:11:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:11:41 INFO - 'use_talos_json': True, 10:11:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:11:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:11:41 INFO - 'work_dir': 'build'} 10:11:41 INFO - ##### 10:11:41 INFO - ##### Running clobber step. 10:11:41 INFO - ##### 10:11:41 INFO - Running pre-action listener: _resource_record_pre_action 10:11:41 INFO - Running main action method: clobber 10:11:41 INFO - rmtree: /builds/slave/test/build 10:11:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:11:41 INFO - Running post-action listener: _resource_record_post_action 10:11:41 INFO - ##### 10:11:41 INFO - ##### Finished clobber step (success) 10:11:41 INFO - ##### 10:11:41 INFO - ##### 10:11:41 INFO - ##### Running read-buildbot-config step. 10:11:41 INFO - ##### 10:11:41 INFO - Running pre-action listener: _resource_record_pre_action 10:11:41 INFO - Running main action method: read_buildbot_config 10:11:41 INFO - Using buildbot properties: 10:11:41 INFO - { 10:11:41 INFO - "project": "", 10:11:41 INFO - "product": "firefox", 10:11:41 INFO - "script_repo_revision": "production", 10:11:41 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 10:11:41 INFO - "repository": "", 10:11:41 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 10:11:41 INFO - "buildid": "20160611073123", 10:11:41 INFO - "pgo_build": "True", 10:11:41 INFO - "basedir": "/builds/slave/test", 10:11:41 INFO - "buildnumber": 1915, 10:11:41 INFO - "slavename": "talos-linux64-ix-047", 10:11:41 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:11:41 INFO - "platform": "ubuntu64_hw", 10:11:41 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 10:11:41 INFO - "branch": "mozilla-inbound", 10:11:41 INFO - "repo_path": "integration/mozilla-inbound", 10:11:41 INFO - "revision": "d3695a07cbdcfe167ca944436175df9fda58e4ff", 10:11:41 INFO - "stage_platform": "linux64-pgo", 10:11:41 INFO - "builduid": "5f5ad121f57a4727b3535021d79a1637", 10:11:41 INFO - "slavebuilddir": "test" 10:11:41 INFO - } 10:11:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/Suz4I6w-Tj-gwr5uqz11Dg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 10:11:41 INFO - Running post-action listener: _resource_record_post_action 10:11:41 INFO - ##### 10:11:41 INFO - ##### Finished read-buildbot-config step (success) 10:11:41 INFO - ##### 10:11:41 INFO - ##### 10:11:41 INFO - ##### Running download-and-extract step. 10:11:41 INFO - ##### 10:11:41 INFO - Running pre-action listener: _resource_record_pre_action 10:11:41 INFO - Running main action method: download_and_extract 10:11:41 INFO - mkdir: /builds/slave/test/build/tests 10:11:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:11:41 INFO - https://queue.taskcluster.net/v1/task/Suz4I6w-Tj-gwr5uqz11Dg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:11:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Suz4I6w-Tj-gwr5uqz11Dg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:11:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Suz4I6w-Tj-gwr5uqz11Dg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:11:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Suz4I6w-Tj-gwr5uqz11Dg/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 10:11:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Suz4I6w-Tj-gwr5uqz11Dg/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 10:11:45 INFO - Downloaded 1361 bytes. 10:11:45 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:11:45 INFO - Using the following test package requirements: 10:11:45 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 10:11:45 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:11:45 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:11:45 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:11:45 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:11:45 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:11:45 INFO - u'jsshell-linux-x86_64.zip'], 10:11:45 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:11:45 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:11:45 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 10:11:45 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:11:45 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:11:45 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:11:45 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:11:45 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:11:45 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:11:45 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:11:45 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:11:45 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:11:45 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')]} 10:11:45 INFO - https://queue.taskcluster.net/v1/task/Suz4I6w-Tj-gwr5uqz11Dg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:11:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Suz4I6w-Tj-gwr5uqz11Dg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:11:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Suz4I6w-Tj-gwr5uqz11Dg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:11:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Suz4I6w-Tj-gwr5uqz11Dg/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 10:11:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Suz4I6w-Tj-gwr5uqz11Dg/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 10:12:03 INFO - Downloaded 24464301 bytes. 10:12:03 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'] 10:12:03 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 10:12:05 INFO - Return code: 0 10:12:05 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 10:12:05 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')]} 10:12:05 INFO - https://queue.taskcluster.net/v1/task/Suz4I6w-Tj-gwr5uqz11Dg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:12:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Suz4I6w-Tj-gwr5uqz11Dg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:12:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Suz4I6w-Tj-gwr5uqz11Dg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:12:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Suz4I6w-Tj-gwr5uqz11Dg/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 10:12:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Suz4I6w-Tj-gwr5uqz11Dg/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 10:12:06 INFO - Downloaded 24464301 bytes. 10:12:06 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'] 10:12:06 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 10:12:07 INFO - Return code: 0 10:12: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')]} 10:12:07 INFO - https://queue.taskcluster.net/v1/task/Suz4I6w-Tj-gwr5uqz11Dg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:12:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Suz4I6w-Tj-gwr5uqz11Dg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 10:12:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Suz4I6w-Tj-gwr5uqz11Dg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 10:12:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Suz4I6w-Tj-gwr5uqz11Dg/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 10:12:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Suz4I6w-Tj-gwr5uqz11Dg/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 10:12:13 INFO - Downloaded 10833377 bytes. 10:12:13 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'] 10:12:13 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 10:12:13 INFO - Return code: 0 10:12:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:13 INFO - https://queue.taskcluster.net/v1/task/Suz4I6w-Tj-gwr5uqz11Dg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:12:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Suz4I6w-Tj-gwr5uqz11Dg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:12:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Suz4I6w-Tj-gwr5uqz11Dg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:12:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Suz4I6w-Tj-gwr5uqz11Dg/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 10:12:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Suz4I6w-Tj-gwr5uqz11Dg/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 10:12:15 INFO - Downloaded 59312027 bytes. 10:12:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Suz4I6w-Tj-gwr5uqz11Dg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:12:15 INFO - mkdir: /builds/slave/test/properties 10:12:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:12:15 INFO - Writing to file /builds/slave/test/properties/build_url 10:12:15 INFO - Contents: 10:12:15 INFO - build_url:https://queue.taskcluster.net/v1/task/Suz4I6w-Tj-gwr5uqz11Dg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:12:16 INFO - Running post-action listener: _resource_record_post_action 10:12:16 INFO - Running post-action listener: set_extra_try_arguments 10:12:16 INFO - ##### 10:12:16 INFO - ##### Finished download-and-extract step (success) 10:12:16 INFO - ##### 10:12:16 INFO - ##### 10:12:16 INFO - ##### Running populate-webroot step. 10:12:16 INFO - ##### 10:12:16 INFO - Running pre-action listener: _resource_record_pre_action 10:12:16 INFO - Running main action method: populate_webroot 10:12:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:12:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:12:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:12:16 INFO - '--tppagecycles', 10:12:16 INFO - '7'], 10:12:16 INFO - 'tests': ['tsvgm']}}, 10:12:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:12:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:12:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:12:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:12:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:12:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:12:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:12:16 INFO - 'talos_options': ['--disable-e10s'], 10:12:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:12:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:12:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:12:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:12:16 INFO - 'talos_options': ['--disable-e10s'], 10:12:16 INFO - 'tests': ['damp', 'tps']}, 10:12:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:12:16 INFO - 'tests': ['damp', 'tps']}, 10:12:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:12:16 INFO - 'tests': ['dromaeo_dom']}, 10:12:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:12:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:12:16 INFO - 'tests': ['a11yr', 10:12:16 INFO - 'ts_paint', 10:12:16 INFO - 'tpaint', 10:12:16 INFO - 'sessionrestore', 10:12:16 INFO - 'sessionrestore_no_auto_restore', 10:12:16 INFO - 'tabpaint']}, 10:12:16 INFO - 'other-e10s': {'tests': ['a11yr', 10:12:16 INFO - 'ts_paint', 10:12:16 INFO - 'tpaint', 10:12:16 INFO - 'sessionrestore', 10:12:16 INFO - 'sessionrestore_no_auto_restore', 10:12:16 INFO - 'tabpaint']}, 10:12:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:12:16 INFO - 'ts_paint', 10:12:16 INFO - 'tpaint', 10:12:16 INFO - 'sessionrestore', 10:12:16 INFO - 'sessionrestore_no_auto_restore', 10:12:16 INFO - 'tabpaint']}, 10:12:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:12:16 INFO - 'ts_paint', 10:12:16 INFO - 'tpaint', 10:12:16 INFO - 'sessionrestore', 10:12:16 INFO - 'sessionrestore_no_auto_restore', 10:12:16 INFO - 'tabpaint']}, 10:12:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:12:16 INFO - 'tests': ['a11yr', 10:12:16 INFO - 'ts_paint', 10:12:16 INFO - 'tpaint', 10:12:16 INFO - 'sessionrestore', 10:12:16 INFO - 'sessionrestore_no_auto_restore', 10:12:16 INFO - 'tabpaint']}, 10:12:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:12:16 INFO - 'tests': ['a11yr', 10:12:16 INFO - 'ts_paint', 10:12:16 INFO - 'tpaint', 10:12:16 INFO - 'sessionrestore', 10:12:16 INFO - 'sessionrestore_no_auto_restore', 10:12:16 INFO - 'tabpaint']}, 10:12:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:12:16 INFO - 'tests': ['tsvgx', 10:12:16 INFO - 'tsvgr_opacity', 10:12:16 INFO - 'tart', 10:12:16 INFO - 'tscrollx', 10:12:16 INFO - 'cart']}, 10:12:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:12:16 INFO - 'tsvgr_opacity', 10:12:16 INFO - 'tart', 10:12:16 INFO - 'tscrollx', 10:12:16 INFO - 'cart']}, 10:12:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:12:16 INFO - 'talos_options': ['--disable-e10s'], 10:12:16 INFO - 'tests': ['tp5o']}, 10:12:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:12:16 INFO - 'tests': ['tp5o']}, 10:12:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:12:16 INFO - 'talos_options': ['--disable-e10s', 10:12:16 INFO - '--xperf_path', 10:12:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:12:16 INFO - 'tests': ['tp5n']}, 10:12:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:12:16 INFO - 'talos_options': ['--xperf_path', 10:12:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:12:16 INFO - 'tests': ['tp5n']}}, 10:12:16 INFO - 'talos.zip': {'path': '', 10:12:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:12:16 INFO - Running post-action listener: _resource_record_post_action 10:12:16 INFO - ##### 10:12:16 INFO - ##### Finished populate-webroot step (success) 10:12:16 INFO - ##### 10:12:16 INFO - ##### 10:12:16 INFO - ##### Running create-virtualenv step. 10:12:16 INFO - ##### 10:12:16 INFO - Running pre-action listener: _resource_record_pre_action 10:12:16 INFO - Running main action method: create_virtualenv 10:12:16 INFO - Creating virtualenv /builds/slave/test/build/venv 10:12:16 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 10:12:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:12:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:12:16 INFO - Using real prefix '/usr' 10:12:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:12:16 INFO - Installing distribute.............................................................................................................................................................................................done. 10:12:18 INFO - Installing pip.................done. 10:12:18 INFO - Return code: 0 10:12:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:12:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd09f684f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e71350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f001c0>, '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 0x1f010c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f01550>, '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': '03627c79f6bb3d1578c4a402000001ba-1465655652.265244-548633170', '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 10:12:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:12:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:12:18 INFO - Using env: {'DISPLAY': ':0', 10:12:18 INFO - 'HOME': '/home/cltbld', 10:12:18 INFO - 'LANG': 'en_US.UTF-8', 10:12:18 INFO - 'LANGUAGE': 'en_US:en', 10:12:18 INFO - 'LOGNAME': 'cltbld', 10:12:18 INFO - 'MAIL': '/var/mail/cltbld', 10:12:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:18 INFO - 'MOZ_NO_REMOTE': '1', 10:12:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:18 INFO - 'NO_EM_RESTART': '1', 10:12:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:18 INFO - 'PWD': '/builds/slave/test', 10:12:18 INFO - 'SHELL': '/bin/bash', 10:12:18 INFO - 'SHLVL': '1', 10:12:18 INFO - 'TERM': 'linux', 10:12:18 INFO - 'TMOUT': '86400', 10:12:18 INFO - 'USER': 'cltbld', 10:12:18 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1465655652.265244-548633170', 10:12:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:18 INFO - '_': '/tools/buildbot/bin/python'} 10:12:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:18 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 10:12:18 INFO - Cleaning up... 10:12:18 INFO - Return code: 0 10:12:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:12:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd09f684f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e71350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f001c0>, '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 0x1f010c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f01550>, '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': '03627c79f6bb3d1578c4a402000001ba-1465655652.265244-548633170', '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 10:12:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:12:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:12:18 INFO - Using env: {'DISPLAY': ':0', 10:12:18 INFO - 'HOME': '/home/cltbld', 10:12:18 INFO - 'LANG': 'en_US.UTF-8', 10:12:18 INFO - 'LANGUAGE': 'en_US:en', 10:12:18 INFO - 'LOGNAME': 'cltbld', 10:12:18 INFO - 'MAIL': '/var/mail/cltbld', 10:12:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:18 INFO - 'MOZ_NO_REMOTE': '1', 10:12:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:18 INFO - 'NO_EM_RESTART': '1', 10:12:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:18 INFO - 'PWD': '/builds/slave/test', 10:12:18 INFO - 'SHELL': '/bin/bash', 10:12:18 INFO - 'SHLVL': '1', 10:12:18 INFO - 'TERM': 'linux', 10:12:18 INFO - 'TMOUT': '86400', 10:12:18 INFO - 'USER': 'cltbld', 10:12:18 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1465655652.265244-548633170', 10:12:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:18 INFO - '_': '/tools/buildbot/bin/python'} 10:12:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:19 INFO - Downloading/unpacking psutil>=3.1.1 10:12:19 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 10:12:19 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 10:12:19 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 10:12:19 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 10:12:19 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 10:12:19 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 10:12:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:12:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:12:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:12:21 INFO - Installing collected packages: psutil 10:12:21 INFO - Running setup.py install for psutil 10:12:21 INFO - building 'psutil._psutil_linux' extension 10:12:21 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 10:12:21 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 10:12:21 INFO - building 'psutil._psutil_posix' extension 10:12:21 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 10:12:21 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 10:12:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:12:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:12:21 INFO - Successfully installed psutil 10:12:21 INFO - Cleaning up... 10:12:21 INFO - Return code: 0 10:12:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:12:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:21 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 0x7fd09f684f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e71350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f001c0>, '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 0x1f010c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f01550>, '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': '03627c79f6bb3d1578c4a402000001ba-1465655652.265244-548633170', '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 10:12:21 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 10:12:21 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 10:12:21 INFO - Using env: {'DISPLAY': ':0', 10:12:21 INFO - 'HOME': '/home/cltbld', 10:12:21 INFO - 'LANG': 'en_US.UTF-8', 10:12:21 INFO - 'LANGUAGE': 'en_US:en', 10:12:21 INFO - 'LOGNAME': 'cltbld', 10:12:21 INFO - 'MAIL': '/var/mail/cltbld', 10:12:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:21 INFO - 'MOZ_NO_REMOTE': '1', 10:12:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:21 INFO - 'NO_EM_RESTART': '1', 10:12:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:21 INFO - 'PWD': '/builds/slave/test', 10:12:21 INFO - 'SHELL': '/bin/bash', 10:12:21 INFO - 'SHLVL': '1', 10:12:21 INFO - 'TERM': 'linux', 10:12:21 INFO - 'TMOUT': '86400', 10:12:21 INFO - 'USER': 'cltbld', 10:12:21 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1465655652.265244-548633170', 10:12:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:21 INFO - '_': '/tools/buildbot/bin/python'} 10:12:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:12:21 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 10:12:21 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 10:12:21 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 10:12:21 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 10:12:21 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 10:12:21 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 10:12:23 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:12:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:12:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:12:23 INFO - Installing collected packages: mozsystemmonitor 10:12:23 INFO - Running setup.py install for mozsystemmonitor 10:12:23 INFO - Successfully installed mozsystemmonitor 10:12:23 INFO - Cleaning up... 10:12:23 INFO - Return code: 0 10:12:23 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:12: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')]} 10:12:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12: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')]} 10:12:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12: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', '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 0x7fd09f684f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e71350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f001c0>, '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 0x1f010c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f01550>, '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': '03627c79f6bb3d1578c4a402000001ba-1465655652.265244-548633170', '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 10:12: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:12: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 jsonschema==2.5.1 10:12:23 INFO - Using env: {'DISPLAY': ':0', 10:12:23 INFO - 'HOME': '/home/cltbld', 10:12:23 INFO - 'LANG': 'en_US.UTF-8', 10:12:23 INFO - 'LANGUAGE': 'en_US:en', 10:12:23 INFO - 'LOGNAME': 'cltbld', 10:12:23 INFO - 'MAIL': '/var/mail/cltbld', 10:12:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:23 INFO - 'MOZ_NO_REMOTE': '1', 10:12:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:23 INFO - 'NO_EM_RESTART': '1', 10:12:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:23 INFO - 'PWD': '/builds/slave/test', 10:12:23 INFO - 'SHELL': '/bin/bash', 10:12:23 INFO - 'SHLVL': '1', 10:12:23 INFO - 'TERM': 'linux', 10:12:23 INFO - 'TMOUT': '86400', 10:12:23 INFO - 'USER': 'cltbld', 10:12:23 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1465655652.265244-548633170', 10:12:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:23 INFO - '_': '/tools/buildbot/bin/python'} 10:12:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:24 INFO - Downloading/unpacking jsonschema==2.5.1 10:12:24 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 10:12:24 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 10:12:24 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 10:12:24 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 10:12:24 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 10:12:24 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 10:12:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:12:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:12:26 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 10:12:26 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 10:12:26 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 10:12:26 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 10:12:26 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 10:12:26 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 10:12:26 INFO - Downloading functools32-3.2.3-2.tar.gz 10:12:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:12:26 INFO - warning: no files found matching '*.txt' 10:12:26 INFO - no previously-included directories found matching 'build' 10:12:26 INFO - no previously-included directories found matching 'dist' 10:12:26 INFO - no previously-included directories found matching '.git*' 10:12:26 INFO - Installing collected packages: jsonschema, functools32 10:12:26 INFO - Running setup.py install for functools32 10:12:26 INFO - warning: no files found matching '*.txt' 10:12:26 INFO - no previously-included directories found matching 'build' 10:12:26 INFO - no previously-included directories found matching 'dist' 10:12:26 INFO - no previously-included directories found matching '.git*' 10:12:26 INFO - Successfully installed jsonschema functools32 10:12:26 INFO - Cleaning up... 10:12:26 INFO - Return code: 0 10:12:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:12:26 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')]} 10:12:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:26 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')]} 10:12:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:26 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 0x7fd09f684f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e71350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f001c0>, '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 0x1f010c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f01550>, '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': '03627c79f6bb3d1578c4a402000001ba-1465655652.265244-548633170', '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 10:12:26 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 10:12:26 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 10:12:26 INFO - Using env: {'DISPLAY': ':0', 10:12:26 INFO - 'HOME': '/home/cltbld', 10:12:26 INFO - 'LANG': 'en_US.UTF-8', 10:12:26 INFO - 'LANGUAGE': 'en_US:en', 10:12:26 INFO - 'LOGNAME': 'cltbld', 10:12:26 INFO - 'MAIL': '/var/mail/cltbld', 10:12:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:26 INFO - 'MOZ_NO_REMOTE': '1', 10:12:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:26 INFO - 'NO_EM_RESTART': '1', 10:12:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:26 INFO - 'PWD': '/builds/slave/test', 10:12:26 INFO - 'SHELL': '/bin/bash', 10:12:26 INFO - 'SHLVL': '1', 10:12:26 INFO - 'TERM': 'linux', 10:12:26 INFO - 'TMOUT': '86400', 10:12:26 INFO - 'USER': 'cltbld', 10:12:26 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1465655652.265244-548633170', 10:12:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:26 INFO - '_': '/tools/buildbot/bin/python'} 10:12:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:26 INFO - Downloading/unpacking blobuploader==1.2.4 10:12:26 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 10:12:26 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 10:12:26 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 10:12:26 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 10:12:26 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 10:12:26 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 10:12:28 INFO - Downloading blobuploader-1.2.4.tar.gz 10:12:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:12:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:12: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 10:12: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 10:12: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 10:12: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 10:12: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 10:12: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 10:12:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:12:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:12:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:29 INFO - Downloading docopt-0.6.1.tar.gz 10:12:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:12:29 INFO - Installing collected packages: blobuploader, requests, docopt 10:12:29 INFO - Running setup.py install for blobuploader 10:12:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:12:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:12:29 INFO - Running setup.py install for requests 10:12:29 INFO - Running setup.py install for docopt 10:12:29 INFO - Successfully installed blobuploader requests docopt 10:12:29 INFO - Cleaning up... 10:12:29 INFO - Return code: 0 10:12:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:12:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:29 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 0x7fd09f684f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e71350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f001c0>, '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 0x1f010c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f01550>, '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': '03627c79f6bb3d1578c4a402000001ba-1465655652.265244-548633170', '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 10:12:29 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 10:12:29 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 10:12:29 INFO - Using env: {'DISPLAY': ':0', 10:12:29 INFO - 'HOME': '/home/cltbld', 10:12:29 INFO - 'LANG': 'en_US.UTF-8', 10:12:29 INFO - 'LANGUAGE': 'en_US:en', 10:12:29 INFO - 'LOGNAME': 'cltbld', 10:12:29 INFO - 'MAIL': '/var/mail/cltbld', 10:12:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:29 INFO - 'MOZ_NO_REMOTE': '1', 10:12:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:29 INFO - 'NO_EM_RESTART': '1', 10:12:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:29 INFO - 'PWD': '/builds/slave/test', 10:12:29 INFO - 'SHELL': '/bin/bash', 10:12:29 INFO - 'SHLVL': '1', 10:12:29 INFO - 'TERM': 'linux', 10:12:29 INFO - 'TMOUT': '86400', 10:12:29 INFO - 'USER': 'cltbld', 10:12:29 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1465655652.265244-548633170', 10:12:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:29 INFO - '_': '/tools/buildbot/bin/python'} 10:12:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:12:30 INFO - Running setup.py (path:/tmp/pip-cp19te-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:12:30 INFO - Running setup.py (path:/tmp/pip-3nrBKa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:12:30 INFO - Running setup.py (path:/tmp/pip-o_QAO2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:12:30 INFO - Running setup.py (path:/tmp/pip-HsPT8k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:12:30 INFO - Running setup.py (path:/tmp/pip-dUHOkr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:12:30 INFO - Running setup.py (path:/tmp/pip-FHKvGK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:12:30 INFO - Running setup.py (path:/tmp/pip-5jwpfy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:12:30 INFO - Running setup.py (path:/tmp/pip-ECcZVH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:12:30 INFO - Running setup.py (path:/tmp/pip-qysJmv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:12:30 INFO - Running setup.py (path:/tmp/pip-Jhi5rF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:12:30 INFO - Running setup.py (path:/tmp/pip-WKoNJY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:12:30 INFO - Running setup.py (path:/tmp/pip-lCsLqy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:12:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:12:31 INFO - Running setup.py (path:/tmp/pip-2WmfY7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:12:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:12:31 INFO - Running setup.py (path:/tmp/pip-n9xWw6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:12:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:12:31 INFO - Running setup.py (path:/tmp/pip-NXZV43-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:12:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:12:31 INFO - Running setup.py (path:/tmp/pip-OKYYWI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:12:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:12:31 INFO - Running setup.py (path:/tmp/pip-RVqcgj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:12:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:12:31 INFO - Running setup.py install for manifestparser 10:12:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:12:31 INFO - Running setup.py install for mozcrash 10:12:31 INFO - Running setup.py install for mozdebug 10:12:31 INFO - Running setup.py install for mozdevice 10:12:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:12:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:12:31 INFO - Running setup.py install for mozfile 10:12:31 INFO - Running setup.py install for mozhttpd 10:12:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:12:31 INFO - Running setup.py install for mozinfo 10:12:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:12:32 INFO - Running setup.py install for mozInstall 10:12:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:12:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:12:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:12:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:12:32 INFO - Running setup.py install for mozleak 10:12:32 INFO - Running setup.py install for mozlog 10:12:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:12:32 INFO - Running setup.py install for moznetwork 10:12:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:12:32 INFO - Running setup.py install for mozprocess 10:12:32 INFO - Running setup.py install for mozprofile 10:12:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:12:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:12:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:12:32 INFO - Running setup.py install for mozrunner 10:12:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:12:32 INFO - Running setup.py install for mozscreenshot 10:12:32 INFO - Running setup.py install for moztest 10:12:33 INFO - Running setup.py install for mozversion 10:12:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:12:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:12:33 INFO - Cleaning up... 10:12:33 INFO - Return code: 0 10:12:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:12:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:33 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 0x7fd09f684f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e71350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f001c0>, '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 0x1f010c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f01550>, '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': '03627c79f6bb3d1578c4a402000001ba-1465655652.265244-548633170', '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 10:12:33 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 10:12:33 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 10:12:33 INFO - Using env: {'DISPLAY': ':0', 10:12:33 INFO - 'HOME': '/home/cltbld', 10:12:33 INFO - 'LANG': 'en_US.UTF-8', 10:12:33 INFO - 'LANGUAGE': 'en_US:en', 10:12:33 INFO - 'LOGNAME': 'cltbld', 10:12:33 INFO - 'MAIL': '/var/mail/cltbld', 10:12:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:33 INFO - 'MOZ_NO_REMOTE': '1', 10:12:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:33 INFO - 'NO_EM_RESTART': '1', 10:12:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:33 INFO - 'PWD': '/builds/slave/test', 10:12:33 INFO - 'SHELL': '/bin/bash', 10:12:33 INFO - 'SHLVL': '1', 10:12:33 INFO - 'TERM': 'linux', 10:12:33 INFO - 'TMOUT': '86400', 10:12:33 INFO - 'USER': 'cltbld', 10:12:33 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1465655652.265244-548633170', 10:12:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:33 INFO - '_': '/tools/buildbot/bin/python'} 10:12:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:12:33 INFO - Running setup.py (path:/tmp/pip-DfBEcF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:12:33 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)) 10:12:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:12:33 INFO - Running setup.py (path:/tmp/pip-6yiZuF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:12:33 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)) 10:12:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:12:33 INFO - Running setup.py (path:/tmp/pip-kAEbVu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:12:33 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)) 10:12:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:12:33 INFO - Running setup.py (path:/tmp/pip-qUSKQa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:12:33 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)) 10:12:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:12:33 INFO - Running setup.py (path:/tmp/pip-1wqzwp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:12:33 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)) 10:12:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:12:33 INFO - Running setup.py (path:/tmp/pip-RHVPW9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:12:33 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)) 10:12:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:12:33 INFO - Running setup.py (path:/tmp/pip-71PzWA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:12:33 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)) 10:12:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:12:33 INFO - Running setup.py (path:/tmp/pip-YbcXo8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:12:33 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)) 10:12:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:12:33 INFO - Running setup.py (path:/tmp/pip-F0g7qL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:12:34 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)) 10:12:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:12:34 INFO - Running setup.py (path:/tmp/pip-L3xmur-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:12:34 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)) 10:12:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:12:34 INFO - Running setup.py (path:/tmp/pip-pBkjQR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:12:34 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)) 10:12:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:12:34 INFO - Running setup.py (path:/tmp/pip-5li816-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:12:34 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)) 10:12:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:12:34 INFO - Running setup.py (path:/tmp/pip-i9z_ec-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:12:34 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)) 10:12:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:12:34 INFO - Running setup.py (path:/tmp/pip-K1G9YE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:12:34 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)) 10:12:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:12:34 INFO - Running setup.py (path:/tmp/pip-Et0YzJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:12:34 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)) 10:12:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:12:34 INFO - Running setup.py (path:/tmp/pip-yZApQY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:12:34 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)) 10:12:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:12:34 INFO - Running setup.py (path:/tmp/pip-UA75Gu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:12:34 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)) 10:12:34 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)) 10:12:34 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)) 10:12:34 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)) 10:12:34 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)) 10:12:34 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)) 10:12:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:12:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:36 INFO - Downloading blessings-1.6.tar.gz 10:12:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:12:36 INFO - Installing collected packages: blessings 10:12:36 INFO - Running setup.py install for blessings 10:12:36 INFO - Successfully installed blessings 10:12:36 INFO - Cleaning up... 10:12:36 INFO - Return code: 0 10:12:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:12:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:12:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:12:36 INFO - Reading from file tmpfile_stdout 10:12:36 INFO - Current package versions: 10:12:36 INFO - argparse == 1.2.1 10:12:36 INFO - blessings == 1.6 10:12:36 INFO - blobuploader == 1.2.4 10:12:36 INFO - docopt == 0.6.1 10:12:36 INFO - functools32 == 3.2.3-2 10:12:36 INFO - jsonschema == 2.5.1 10:12:36 INFO - manifestparser == 1.1 10:12:36 INFO - mozInstall == 1.12 10:12:36 INFO - mozcrash == 0.17 10:12:36 INFO - mozdebug == 0.1 10:12:36 INFO - mozdevice == 0.48 10:12:36 INFO - mozfile == 1.2 10:12:36 INFO - mozhttpd == 0.7 10:12:36 INFO - mozinfo == 0.9 10:12:36 INFO - mozleak == 0.1 10:12:36 INFO - mozlog == 3.2 10:12:36 INFO - moznetwork == 0.27 10:12:36 INFO - mozprocess == 0.22 10:12:36 INFO - mozprofile == 0.28 10:12:36 INFO - mozrunner == 6.11 10:12:36 INFO - mozscreenshot == 0.1 10:12:36 INFO - mozsystemmonitor == 0.3 10:12:36 INFO - moztest == 0.7 10:12:36 INFO - mozversion == 1.4 10:12:36 INFO - psutil == 3.1.1 10:12:36 INFO - requests == 1.2.3 10:12:36 INFO - wsgiref == 0.1.2 10:12:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:12:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:36 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 0x7fd09f684f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e71350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f001c0>, '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 0x1f010c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f01550>, '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': '03627c79f6bb3d1578c4a402000001ba-1465655652.265244-548633170', '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 10:12:36 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 10:12:36 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 10:12:36 INFO - Using env: {'DISPLAY': ':0', 10:12:36 INFO - 'HOME': '/home/cltbld', 10:12:36 INFO - 'LANG': 'en_US.UTF-8', 10:12:36 INFO - 'LANGUAGE': 'en_US:en', 10:12:36 INFO - 'LOGNAME': 'cltbld', 10:12:36 INFO - 'MAIL': '/var/mail/cltbld', 10:12:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:36 INFO - 'MOZ_NO_REMOTE': '1', 10:12:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:36 INFO - 'NO_EM_RESTART': '1', 10:12:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:36 INFO - 'PWD': '/builds/slave/test', 10:12:36 INFO - 'SHELL': '/bin/bash', 10:12:36 INFO - 'SHLVL': '1', 10:12:36 INFO - 'TERM': 'linux', 10:12:36 INFO - 'TMOUT': '86400', 10:12:36 INFO - 'USER': 'cltbld', 10:12:36 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1465655652.265244-548633170', 10:12:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:36 INFO - '_': '/tools/buildbot/bin/python'} 10:12:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:37 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)) 10:12:37 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)) 10:12:37 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)) 10:12:37 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)) 10:12:37 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)) 10:12:37 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)) 10:12:37 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)) 10:12:37 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)) 10:12:37 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)) 10:12:37 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)) 10:12:37 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)) 10:12:37 INFO - Cleaning up... 10:12:37 INFO - Return code: 0 10:12:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:12:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd09f684f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e71350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f001c0>, '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 0x1f010c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f01550>, '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': '03627c79f6bb3d1578c4a402000001ba-1465655652.265244-548633170', '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 10:12:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:12:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:12:37 INFO - Using env: {'DISPLAY': ':0', 10:12:37 INFO - 'HOME': '/home/cltbld', 10:12:37 INFO - 'LANG': 'en_US.UTF-8', 10:12:37 INFO - 'LANGUAGE': 'en_US:en', 10:12:37 INFO - 'LOGNAME': 'cltbld', 10:12:37 INFO - 'MAIL': '/var/mail/cltbld', 10:12:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:37 INFO - 'MOZ_NO_REMOTE': '1', 10:12:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:37 INFO - 'NO_EM_RESTART': '1', 10:12:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:37 INFO - 'PWD': '/builds/slave/test', 10:12:37 INFO - 'SHELL': '/bin/bash', 10:12:37 INFO - 'SHLVL': '1', 10:12:37 INFO - 'TERM': 'linux', 10:12:37 INFO - 'TMOUT': '86400', 10:12:37 INFO - 'USER': 'cltbld', 10:12:37 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1465655652.265244-548633170', 10:12:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:37 INFO - '_': '/tools/buildbot/bin/python'} 10:12:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:37 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:12:37 INFO - Cleaning up... 10:12:37 INFO - Return code: 0 10:12:37 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:12:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd09f684f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e71350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f001c0>, '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 0x1f010c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f01550>, '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': '03627c79f6bb3d1578c4a402000001ba-1465655652.265244-548633170', '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 10:12:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 10:12:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 10:12:37 INFO - Using env: {'DISPLAY': ':0', 10:12:37 INFO - 'HOME': '/home/cltbld', 10:12:37 INFO - 'LANG': 'en_US.UTF-8', 10:12:37 INFO - 'LANGUAGE': 'en_US:en', 10:12:37 INFO - 'LOGNAME': 'cltbld', 10:12:37 INFO - 'MAIL': '/var/mail/cltbld', 10:12:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:37 INFO - 'MOZ_NO_REMOTE': '1', 10:12:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:37 INFO - 'NO_EM_RESTART': '1', 10:12:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:37 INFO - 'PWD': '/builds/slave/test', 10:12:37 INFO - 'SHELL': '/bin/bash', 10:12:37 INFO - 'SHLVL': '1', 10:12:37 INFO - 'TERM': 'linux', 10:12:37 INFO - 'TMOUT': '86400', 10:12:37 INFO - 'USER': 'cltbld', 10:12:37 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1465655652.265244-548633170', 10:12:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:37 INFO - '_': '/tools/buildbot/bin/python'} 10:12:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:37 INFO - Downloading/unpacking flake8 10:12:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:39 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:12:39 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:12: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 10:12: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 10:12: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 10:12: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 10:12: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 10:12: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 10:12:39 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:12:39 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:12: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 10:12: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 10:12: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 10:12: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 10:12: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 10:12: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 10:12:39 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:12: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 10:12: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 10:12: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 10:12:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:12:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:12:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:12:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:12:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:12:40 INFO - no previously-included directories found matching 'docs/_build' 10:12:40 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:12:40 INFO - Running setup.py install for pep8 10:12:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:12:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:12:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:12:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:12:40 INFO - no previously-included directories found matching 'docs/_build' 10:12:40 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:12:40 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:12:40 INFO - Cleaning up... 10:12:40 INFO - Return code: 0 10:12:40 INFO - Running post-action listener: _resource_record_post_action 10:12:40 INFO - Running post-action listener: _start_resource_monitoring 10:12:40 INFO - Starting resource monitoring. 10:12:40 INFO - ##### 10:12:40 INFO - ##### Finished create-virtualenv step (success) 10:12:40 INFO - ##### 10:12:40 INFO - ##### 10:12:40 INFO - ##### Running install step. 10:12:40 INFO - ##### 10:12:40 INFO - Running pre-action listener: _resource_record_pre_action 10:12:40 INFO - Running main action method: install 10:12:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:12:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:12:40 INFO - Reading from file tmpfile_stdout 10:12:40 INFO - Detecting whether we're running mozinstall >=1.0... 10:12:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:12:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:12:40 INFO - Reading from file tmpfile_stdout 10:12:40 INFO - Output received: 10:12:40 INFO - Usage: mozinstall [options] installer 10:12:40 INFO - Options: 10:12:40 INFO - -h, --help show this help message and exit 10:12:40 INFO - -d DEST, --destination=DEST 10:12:40 INFO - Directory to install application into. [default: 10:12:40 INFO - "/builds/slave/test"] 10:12:40 INFO - --app=APP Application being installed. [default: firefox] 10:12:40 INFO - mkdir: /builds/slave/test/build/application 10:12:40 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'] 10:12:40 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 10:12:57 INFO - Reading from file tmpfile_stdout 10:12:57 INFO - Output received: 10:12:57 INFO - /builds/slave/test/build/application/firefox/firefox 10:12:57 INFO - Running post-action listener: _resource_record_post_action 10:12:57 INFO - ##### 10:12:57 INFO - ##### Finished install step (success) 10:12:57 INFO - ##### 10:12:57 INFO - ##### 10:12:57 INFO - ##### Running run-tests step. 10:12:57 INFO - ##### 10:12:57 INFO - Running pre-action listener: _resource_record_pre_action 10:12:57 INFO - Running main action method: run_tests 10:12:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:12:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:12:57 INFO - Python 2.7.3 10:12:57 INFO - Return code: 0 10:12:57 INFO - grabbing minidump binary from tooltool 10:12:57 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')]} 10:12:57 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 0x1f001c0>, '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 0x1f010c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f01550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:12:57 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 10:12:57 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 10:12:57 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 10:12:57 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:12:57 INFO - Return code: 0 10:12:57 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:12:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:12:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:12:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:12:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:12:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:12:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:12:58 INFO - Return code: 0 10:12:58 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Suz4I6w-Tj-gwr5uqz11Dg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 10:12:58 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Suz4I6w-Tj-gwr5uqz11Dg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-047 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 10:12:58 INFO - Using env: {'DISPLAY': ':0', 10:12:58 INFO - 'HOME': '/home/cltbld', 10:12:58 INFO - 'LANG': 'en_US.UTF-8', 10:12:58 INFO - 'LANGUAGE': 'en_US:en', 10:12:58 INFO - 'LOGNAME': 'cltbld', 10:12:58 INFO - 'MAIL': '/var/mail/cltbld', 10:12:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:12:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:12:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:58 INFO - 'MOZ_NO_REMOTE': '1', 10:12:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:12:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:58 INFO - 'NO_EM_RESTART': '1', 10:12:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:58 INFO - 'PWD': '/builds/slave/test', 10:12:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:12:58 INFO - 'SHELL': '/bin/bash', 10:12:58 INFO - 'SHLVL': '1', 10:12:58 INFO - 'TERM': 'linux', 10:12:58 INFO - 'TMOUT': '86400', 10:12:58 INFO - 'USER': 'cltbld', 10:12:58 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1465655652.265244-548633170', 10:12:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:58 INFO - '_': '/tools/buildbot/bin/python'} 10:12:58 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Suz4I6w-Tj-gwr5uqz11Dg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 10:12:58 INFO - mozversion application_buildid: 20160611073123 10:12:58 INFO - mozversion application_changeset: d3695a07cbdcfe167ca944436175df9fda58e4ff 10:12:58 INFO - mozversion application_display_name: Nightly 10:12:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:12:58 INFO - mozversion application_name: Firefox 10:12:58 INFO - mozversion application_remotingname: firefox 10:12:58 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 10:12:58 INFO - mozversion application_vendor: Mozilla 10:12:58 INFO - mozversion application_version: 50.0a1 10:12:58 INFO - mozversion platform_buildid: 20160611073123 10:12:58 INFO - mozversion platform_changeset: d3695a07cbdcfe167ca944436175df9fda58e4ff 10:12:58 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 10:12:58 INFO - mozversion platform_version: 50.0a1 10:12:58 INFO - using testdate: 1465665178 10:12:58 INFO - actual date: 1465665178 10:12:58 INFO - starting webserver on 'localhost:46074' 10:12:58 INFO - SUITE-START | Running 2 tests 10:12:58 INFO - TEST-START | dromaeo_css 10:12:58 INFO - operating with platform_type : linux_ 10:12:58 INFO - Initialising browser for dromaeo_css test... 10:12:58 INFO - TEST-INFO | started process 4426 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpt7LyY1/profile http://localhost:46074/getInfo.html) 10:13:02 INFO - PROCESS | 4426 | __metrics Screen width/height:1600/1200 10:13:02 INFO - PROCESS | 4426 | colorDepth:24 10:13:02 INFO - PROCESS | 4426 | Browser inner width/height: 1024/697 10:13:02 INFO - PROCESS | 4426 | __metrics 10:13:03 ERROR - PROCESS | 4426 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:13:04 INFO - PROCESS | 4426 | console.error: PushService: 10:13:04 INFO - PROCESS | 4426 | stateChangeProcessEnqueue: Error transitioning state 10:13:04 INFO - PROCESS | 4426 | UnknownError 10:13:04 INFO - TEST-INFO | 4426: exit 0 10:13:04 INFO - Browser initialized. 10:13:04 INFO - Running cycle 1/1 for dromaeo_css test... 10:13:04 INFO - TEST-INFO | started process 4506 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpt7LyY1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:13:16 INFO - PROCESS | 4506 | RSS: Main: 174149632 10:13:16 INFO - PROCESS | 4506 | 10:14:08 INFO - PROCESS | 4506 | 1465665248459 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] 10:16:16 INFO - PROCESS | 4506 | Cycle 1(1): loaded http://localhost:46074/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46074/tests/dromaeo/cssquery-ext.html) 10:16:17 INFO - PROCESS | 4506 | RSS: Main: 265854976 10:16:17 INFO - PROCESS | 4506 | 10:19:19 INFO - PROCESS | 4506 | Cycle 1(1): loaded http://localhost:46074/tests/dromaeo/cssquery-ext.html (next: http://localhost:46074/tests/dromaeo/cssquery-jquery.html) 10:19:20 INFO - PROCESS | 4506 | RSS: Main: 264040448 10:19:20 INFO - PROCESS | 4506 | 10:22:22 INFO - PROCESS | 4506 | Cycle 1(1): loaded http://localhost:46074/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46074/tests/dromaeo/cssquery-mootools.html) 10:22:22 INFO - PROCESS | 4506 | RSS: Main: 267804672 10:22:22 INFO - PROCESS | 4506 | 10:25:24 INFO - PROCESS | 4506 | Cycle 1(1): loaded http://localhost:46074/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46074/tests/dromaeo/cssquery-prototype.html) 10:25:25 INFO - PROCESS | 4506 | RSS: Main: 265457664 10:25:25 INFO - PROCESS | 4506 | 10:28:28 INFO - PROCESS | 4506 | Cycle 1(1): loaded http://localhost:46074/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46074/tests/dromaeo/cssquery-yui.html) 10:28:28 INFO - PROCESS | 4506 | RSS: Main: 231436288 10:28:28 INFO - PROCESS | 4506 | 10:31:31 INFO - PROCESS | 4506 | Cycle 1(1): loaded http://localhost:46074/tests/dromaeo/cssquery-yui.html (next: http://localhost:46074/tests/dromaeo/cssquery-dojo.html) 10:31:31 INFO - PROCESS | 4506 | RSS: Main: 297017344 10:31:31 INFO - PROCESS | 4506 | 10:31:31 INFO - PROCESS | 4506 | __start_tp_report 10:31:31 INFO - PROCESS | 4506 | _x_x_mozilla_page_load 10:31:31 INFO - PROCESS | 4506 | _x_x_mozilla_page_load_details 10:31:31 INFO - PROCESS | 4506 | |i|pagename|runs| 10:31:31 INFO - PROCESS | 4506 | |0;dojo.html;3081.676423975483;3094.2883136878518;3114.937701245976;3135.6707545707714;3152.0228729093983;5217.139172036619;5307.230451584518;5335.039692855285;5427.131658934566;5449.972750136254;5419.349678038631;5419.891602167954;5431.646942948705;5507.091329930557;5507.366652834925;4886.218205087187;4912.189488734354;5028.899422011576;5077.746112694369;5121.2318152277085;5031.044101620699;5078.5937125029905;5082.745862706868;5099.413567439737;5099.898002039957;4748.833790817322;4802.855914322576;4903.779329930162;4930.28510865926;4999.450060493343;5002.824901128443;5010.599152067826;5011.2483127530795;5012.8997420051755;5071.619628527875;4950.331705219821;4955.058538877602;4985.651004429691;4992.500749925015;5003;5233.319668443116;5289.391719952217;5290.65610735301;5333.893322133575;5483.506484416382;5733.713314334266;5747.885042299131;5786.5370770338695;5839.620424672383;5884.176215329857;5892.970535147339;5922.2597175353085;5941.197938278364;5943.197668314765;5949.375315591887;5332.760025798849;5431.131019036975;5467.58993075517;5479.1781232815;5531.944680553143;5987.970060149759;6035.185249991195;6050.3949605040025;6056.3338032816355;6058.909116363258;5556.249906262684;5816.47651711348;5824.650520968756;5824.679642619697;5829.59192856496;5676.205331253628;5697.4587414195585;5740.569457290637;5804.65172089676;5862.267216597926;5767.798127065533;5770.826875193751;5773.278340207474;5776.1624564437925;5776.480116789425;5700.515456186187;5748.856278592985;5775.971120144372;5792.218050563204;5812.9709351452975;4503.797329120198;4530.569595888385;4539.182947069493;4568.840090596813;4572.314152877028;4021.235965166609;4047.453593764863;4048.0284731664187;4061.2283666103936;4083.1833633273463;5379.623426360117;5397.8380648580605;5437.184422336682;5578.079616863253;5589.664620122724;5772.076467765138;5802.158686990363;5834.183214349994;5849.64902105875;5904.1734157218025;5400.324959380077;5412.5940554458575;5434.076207044812;5438.782448702087;5443.755031023614;4823.27650852375;4946.505349465025;4962.751862406865;4991.126552853236;5066.898662026739;5999.790007349722;6004.849878753066;6011.519078473799;6014.398560143951;6049.727762250709;5813.505852002627;5824.417558244311;5829.387914268941;5832.387599302182;5835.299764028344;5828.038373668467;5980.760769569169;5988.22153120109;5989.3711160329285;6051.576389652858;5782.653040817396;5811.070228763378;5819.214406055297;5824.912626310524;5829.883402332014;5854;5874.970625147018;5884.293884733859;5905.43898329658;5911.054231322968;5501.587380946525;5588.944110559005;5635.492805647511;5650.547956163415;5714.342850572238;5658.151277308437;5665.773369065356;5676.914846277392;5679.00617391963;5683.090705487102;5358.705271210121;5577.051901176891;5580.302462192226;5596.41237670055;5602.915956260741;5645.774169033357;5692.345380281321;5703.828885133453;5792.160136780059;5793.681347525758;5600.383957764561;5619.634723742944;5630.211770352072;5638.887222255614;5642.153676948326 10:31:31 INFO - PROCESS | 4506 | |1;ext.html;599.991000134998;608.309568639594;609.826199533133;609.8475381154711;610.8961476548986;30955;39067.804660976726;42024;42444.363334550006;47173.764131179385;45057;45457.77271113648;45494.545054549446;45565;45565.08869822601;8965.641374345034;9098.909010909905;9119.951205611373;9120.042395548471;9125.771855703593;8917.242034427081;9047;9049.411788233776;9051.14014168653;9055.185033346997;9010.594523246436;9052.049534798816;9070.546472676373;9073.274138068939;9074.954625226865;8916.242119419858;8922;8927.285817134678;8935.731928042136;8970.775730606721;8753.7811554711;8848.115188481164;8895.377323587352;8912.06423325548;8918.019017908025;43065.784671076755;43205.567944320785;43310.13379732388;43491.78254108741;43527;3448.689617934398;3481.7736847104857;3523.260115375774;3545.2200515886466;3926.6269704378037;30104.69895301063;30987.53518697199;33087.6691233087;33140.66859331424;33246.50130248048;3959.307121253769;4096.09885825118;4121.072758629284;4248.362745588187;4279.871603851859;336279;342835;342950.9999999975;343430;343760;63243.367566323745;63259;63689.681551592876;63708.68145659242;63918;67030.32969670338;67744.6612766933;67826;67892.660536697;67956;15403.768943465857;15514.379424823106;15536.922315388576;15554.533363999099;15558.299876505584;11655.53377864876;11679.591214307458;11728.76542469163;11769;11793;16782.69032793495;20396.694049589267;20571;20657.483562911046;20662.276820311217;6574.638394888231;7318.194998550155;7492.182114276092;7606.467547271638;7625.923740762632;929.2148134826061;960.644561512231;1066.0352381095122;1069.465466422379;1088.5808963548932;28965.710342896302;30929.536056959165;31808;31847.203819904687;32137.196570085467;1074.7366895110592;1094.8357746338113;1096.6435908329825;1104.1056744037196;1128.0862501373913;16182.514524564282;16619.169041547873;16633.50099497017;16637.833621663627;17005.91497042507;510701;512320;517147;563675;828108;60256.69871650702;60449.39550604438;60461.69769151126;60751.69624151851;60834;1240.8138779183014;1262.545483625894;1341.530464337474;1376.8072469854228;1382.5437605590132;27196;33992;34075;34387.312253755284;34455;55330.17004744852;55332.44667553434;55359.446405535426;55850.72074639601;55903.16145257743;484381;485915;487273;491761;492208.5389573029;26121.73878261193;28062;28616.57075143916;29230.7076929228;29859;42316;42815.3577696341;46497.76751116223;48156.27765583589;48342.51657483521;40588.594114058484;40626.59373406346;40765.38851917164;41748.3737743928;41781;38538;39806.601933981445;40059;40458.190836182526;40542.79728601338;39223.41164882472;40154.39768403535;40248.19503609853;40477;40609;33253.83373083119;35404.29191416209;35969;35994.46008309825;36239.275214495035;27451.17646470609;27658.861705692147;27880.302992425353;27894.163175103968;27998 10:31:31 INFO - PROCESS | 4506 | |2;jquery.html;404.6156151655926;409.3246143862626;411.5884115884116;417.434376419951;429.3216717586214;13614.795778063311;18190;19785;19872.304469343577;19999.60000799985;15422.383104675828;19312.130954107062;19387.515312117204;19907.203711851507;20228.29200977966;5731.484166425032;5905.911411328833;5911.231539899807;5919.467247947684;5924.08176732605;5797.913031304533;5858.7949421770245;5898.7640494380175;5902.557308201902;5906.084556893688;4214.578542145776;6202.2867370252325;6489.61062336259;6506.4469520090615;6630.071789949411;6346.809595712136;6547.083408322815;6567.080608714808;6567.802965911031;6600.9339906601035;5812.476877081083;5826.912596311059;5836.620619659709;5838.095095260242;5855;23130.42173945648;23522.7647723524;24247.87876060626;24257.757422425904;24536.263912082664;2440.7681270279295;2515.1197081021496;2634.012245407972;2702.5675891857404;2804.831710097401;14093.577192684235;14457.927710361486;14884.776728349083;14957.626059348495;15033.398664053424;1914.521096931312;2015.506200980769;2015.61703276377;2022.3730643500562;2044.7137400763904;75900.62049689771;77320.61339693321;78457;84194;89186.55406723055;10723.678289651323;11215.420453295788;11277.32336059839;11321.433928303552;11567;15937.760933586005;16003.279852406436;16102.75845862313;16104.114273714824;16105.838941610667;7620.5808680523105;7907.130215676271;7911;7916.802079948047;8020.799480013046;7366.558006519626;7428.665710043061;7466.290702383265;7564.886526702104;7603.4297427693145;4349.804258808361;4398.824047038147;4645.488996210414;4864.1516223834715;4954.157793175169;1957.7259183714007;1983.672694005473;2018.3339497965635;2027.7566691997056;2042.5812708394744;894.3337213775778;942.8915674697361;965.358036905464;986.9851952220722;998.6404894238068;18759.531011724815;19635.312764053477;19657.606847862964;20001.199952001756;20275.594488110157;948.4025064209504;962.6245764151986;963.2582911158509;972.7422233108232;981.9705408837747;10544.209184311207;11116.833247501294;11153.832692509619;11167.162462815322;11194;430502;434147;439166;441797;443015;95019.52490237505;97140;97249;97892.51053744685;98085;948.1987720376271;955.9139677429065;968.2302569457298;969.5152423788106;973.5862258540234;17293.315414862074;17344.132793360535;17400.651986959936;17600.207990640196;17678.292868285123;30300.69699302979;37425.6257437433;42286;42490.78754606207;43385.349219762364;57701.422985769605;57914.62939076783;58098.7095064522;58494.4150558506;58511.70744146252;7875.330596899328;8728.825423491622;8801.779955501164;9037.77405564866;9119.635214591608;8699.347548933982;10630.468476576294;10800.837987430037;12819.42312595954;12983.545575904798;12027.518899243933;12045.879541204476;12071.215371000857;12138.089643276613;12219.938900305442;11683.824742629038;11714.414279285831;11799.115066369885;11916.76166476683;12114.333711645944;12060;12229.87770122323;12284.447199875849;12340.568080117511;12628.558000469939;7889.881651775343;8043.798905027421;8188.099309076116;8209.138040505899;8535.402521823413;8737.606807693795;11450.37022963745;11567.537298507965;11735.237209581692;12129.939350303192 10:31:31 INFO - PROCESS | 4506 | |3;mootools.html;1296.1251155470056;1434.447737621016;1470.595586213791;1576.1725094325477;1744.6946784312734;8585.926759155105;8981.05698901615;8985.955070224647;9145.314101442385;9170.908290917088;8905.109489051092;9087.864016997875;9097;9114.726558203249;9217.815643687121;2103.568768402474;2315.9421014474606;2391.784739373456;2403.194929698553;2430.1373012580543;2341.9414514637183;2345.4253707841604;2350.21267875262;2356.387339291788;2365.4322962488964;2340.8127349811975;2350.576896158691;2367.846090004144;2369.1115831563166;2374.3589230907646;2046.7032280319345;2245.6070187717246;2312.583734927712;2313.687652166953;2339.6958395408574;2355.7762012608773;2377.6314671225814;2397.520495900827;2399.5560821248123;2405.0500052479174;9278.51543753003;9336.766580835465;9341.76645583859;9349.111834375723;9357.672481463116;5378.193271009341;5527.55779537636;5528.55771538276;5531.529819965308;5533.916991245094;3168.207948012997;3335.116194208537;3422.6064002639764;3438.9656103439147;3445.0870519312402;1074.3500182389698;1093.824988001916;1104.6851647280566;1105.8617672790901;1109.1071687291726;12921.612351629467;12926.41831117602;12930.741385172243;12944.61166165026;12950.546730864375;4771.785269662804;4778.641601879804;4850.684705494132;4869.2939523768855;4919.237518184687;10641.5211315491;10683.83974240387;10687.679369618923;10690.19823513224;10714.303570267908;5360.70516121617;5364.7317634118135;5370.677759334374;5389.137737961985;5399.082156033483;4483.708558943658;4844.612431005511;4975.253711943165;5017.7491125443585;5095.261187127846;4069.7587235892743;4089.44792453021;4145.440365550672;4172.852465571931;4182.602652747984;1290.4193113098954;1304.4325718312564;1317.4993502469001;1327.0312671749678;1340.9195448273135;896.5203616065373;1000.7990411506076;1001.2640709078821;1016.7305663998899;1030.4487099401783;6360.14138091361;6409.262934762562;6440.162778838815;6456.322086180978;6604.240512341143;456.8149899290793;464.3730963199721;465.3206318774559;469.0806020200445;473.96445266605144;4188.434561334242;4300.268954277781;4338.154059958278;4349.608535231844;4361.498427680857;11616.186866919235;11839.526418943318;11918.940405297919;11942;12040.879591204151;11462.426878656033;11790;11812.70468238301;11813.232139910879;11892.940535297268;8508.74473765788;8640.395172338001;8653.783655408539;8679.869801952977;8764.255038321815;6052.969735151296;6133.294671112701;6171.228596425447;6172.876542469216;6203.286622038343;10793.190510711886;10819.08037816763;10919.617813376812;10926.672199834018;10928.180386470887;10851.348919064882;10879.945600271947;11159.553617855196;11165.441727913734;11194.496247668712;7483.625818708934;7917.7624671259955;8117.10711821711;8348.290395316224;8425.410221284452;9127.497987610745;9128.361014728906;9204.723858284262;9204.769880752767;9208.079192080739;7957.283844454027;8214.83570328602;8218.671253150047;8262.008558972962;8336.374406990579;7937.444378893422;8055.1542088079905;8078.842315369261;8152.429329946846;8192.877106843522;6996.895046574204;7213.314735100157;7488.5506869588;7573.97751303589;7579.54522728638;5136.383633963948;5166.6125040621355;5177.974110129425;5236.345456817898;5304.7347632618985;5172.327597412313;5196.662216955886;5234.11020126587;5337.25278461008;5401.972990135024 10:31:31 INFO - PROCESS | 4506 | |4;prototype.html;336.11098644086394;352.85356577020536;356.39946689827644;358.42114984300355;358.85825099085844;5188.584913206943;5224.817131400402;5305.814296499619;5386.73066346683;5418.376886658036;5203.9219411708855;5217.660852044614;5252.973735131319;5282.788688452467;5288.497592728694;4214.789260536969;4226.661867050644;4227.175700738358;4234.9364759528635;4255.17024180285;3979.9204015919663;4007.5973409306657;4193.895152621194;4237.512686041098;4280.678949078816;4143.52904718825;4206.516250631186;4206.537280899099;4210.326347784355;4212.431321771567;4190.161967606491;4201.34879093741;4204.558521355275;4207.684423668237;4213.51544572375;3677.17263615687;3706.796126213057;3764.209516001643;3784.4890939723336;3786.981065094657;5104.744762761847;5135.639055650256;5162.716050617215;5167.870803229912;5175.689458632456;4814.253790662453;4820.228763397839;4827.106985207713;4827.710337379768;4836.347093142416;5367.141257398836;5519.254900588409;5532.087205611069;5554.583406244547;5563.972180139114;4096.6313031826985;4123.731957422758;4125.938110928309;4128.525219599755;4133.6073073058315;5668.43315668434;5697.715114244271;5699.743511541949;5707.971460142714;5708.286464191976;3971.960280397159;4231.640310573574;4247.17180149874;4248.661671573444;4260.978695106504;4249.235137675187;4272.594103560157;4286.142771445723;4293.44185255921;4305.590968857953;4768.427788665313;4777.283407488904;4785.186518291899;4803.711777293303;4816.036792641416;5328.333958255218;5572.554195664337;5616.326040875121;5616.803411880564;5630.296212973379;1458.3947661720479;1479.3948565806006;1489.8900319262218;1492.6715223451138;1501.2418728542234;942.59468428575;949.9952500237455;962.5369438453512;967.883853937532;973.956171972263;4711.764411779397;4728.243481043017;4737.4129666562085;4743.980044290494;4757.405324334458;5026.235570436245;5061.898762024739;5072.51811077947;5079.390473143247;5153;4517.367568540407;4549.818007279738;4720.881977950578;4823.927641085386;4835.540623640749;2676.839389636628;2683.9597406038924;2694.3802925327286;2698.4333290008926;2737.4525094980686;5145.63640635232;5183.611229157828;5185.0037735472115;5191.922121168185;5269.420363759983;4924.581410580141;4974.9751251243515;5066.441447069206;5145.099607568661;5182.507661772201;5195;5200.973995130076;5207.719136943777;5216.58267338612;5258.763355649005;5040.042391945665;5043.12541851156;5058.443571207091;5067.315912351933;5073.05762657665;5019.974900125622;5062.772175252197;5259.815906443256;5655.4344565543115;5708.4862362387585;5843.328017278068;5854.502367298827;5886.38192989747;5948.196993406008;5950;3872.941905871358;3916.941245881371;3986.362182050858;3995.360742281221;3998.540167880731;5633.549316054788;5634.464725851038;5682.289713785777;5709.68596727184;5731.713414329183;5302.231176479312;5421.972890135524;5497.367802702581;5513.8345849624575;5549.723563580318;5438.2658341125025;5439.782408703608;5463.235147079333;5464.26232458613;5511;5364.371457985637;5371.811986580451;5373.301470808769;5414.187871819258;5422.945770542244;5338.798770276812;5510.559155267649;5517.779288828402;5531.668099914018;5559.8888022240135;5392.838214853561;5412.646838290428;5418.807862270294;5435.2934118564335;5435.907175737449 10:31:31 INFO - PROCESS | 4506 | |5;yui.html;720.5964659790521;773.9342155916747;784.901887264092;793.2305663506397;798.1818635898204;12801.551945681904;13384.263865487394;14239.644008899782;14366.856331436695;14427.495037673683;14121.92939035306;14211.644708882282;14251;14275.357608907598;14369.56891293263;666.8632930249287;780.7540624703229;796.4305521552103;808.107041718898;808.9676412943476;803.0323460230437;819.2053707903355;821.2034326703118;821.3552361396305;821.5892053973014;850.6980022092162;851.7785375802305;854.9871751923695;855.170484629908;857.7941294089436;702.8488874891897;831.9584020798936;855.6278019061666;857.7684025313162;858.3519442820661;619.9566030377875;621.592856678876;622.1290193728771;622.2999125983268;622.7540121651967;13311.267880266581;13338.266395348252;13366.799498007538;13383;13387.933060334635;14821.258937053104;14900.403983840633;15150.090994540364;15331.540053798404;15395.692086158215;10822.13422926172;11002.50488728009;11125.944370278177;11342.432878356132;11507.309561426342;3864.671502922227;3889.961100388988;3942.211557688474;4031.133306339151;4066.451029111062;74034.99999999946;74128;74847.25152748458;75246.62376688136;76544.23455765427;11306.265092768943;11415.143864210217;11450.770984580427;11648.359340236368;11799.292042477478;22862.885685571797;22904.427389315402;22913.427164320692;22926.312210633707;22932.656010159862;8131.9186808132345;8315.459495132796;8370.623321950527;8411.747647570583;8573.785655358666;4592.2193227151465;4658.930116048262;4675.8671689967805;4693.530646935279;4765.499622539653;3627.474016267626;3728.9067773305883;3729.4965179700935;3739.0278527583023;3740.214554943492;596.1445325957266;630.6499892559582;635.3170341882495;640.9871802563922;659.9670016499156;658.1476987301456;671.2414971082645;713.8679344321214;750.598429840033;773.5436092705331;9325.953370233105;9626.855597166048;9632.9036709632;9790;9891.653792117386;678.8065401360589;722.1226210154582;727.0548287226584;729.1214087025122;759.5746382026083;4551.453825540956;4675.57919787214;4698.95301046992;4757.144713561714;4810.735409552508;72415.27584724085;73167;120417;123387;125461.82650821532;109573;109689;110374;111794;113549.99999999834;96027.51986240024;96596;97733;98624;98685.59858010535;9172.541372931193;9284.860727089233;9327.906720932704;9385.783988134386;9467.621295148117;51518;52714.47285527096;54026;54264.18603721026;55171.44828551663;55648;66103;68449.65775171093;68574.3142568568;79163.60418197872;11724.58963936258;12236.510539578318;12456.564020259248;13522.323883805968;13548.525801596898;12954.740905181656;13180.340982951006;13285.535006274735;13660.590182294547;13914.02601817863;14607.19660418687;14665.92667036658;14679.633009174857;14884.10695358282;15090.54728358151;13424.664383390493;13648.522301719393;13746.725065498835;13829.30853457303;14309.284535772962;13821.79267310971;13904.51334203298;14155.858441415867;14231.359588818736;14889.16604968002;11372.943135284602;11530.884691152982;11831.526738930346;11906;11967.222130561486;10607.893921060999;10883.564657413932;11146.944265278946;11179.944100279447;11282.548698051985 10:31:31 INFO - PROCESS | 4506 | __end_tp_report 10:31:31 INFO - PROCESS | 4506 | __start_cc_report 10:31:31 INFO - PROCESS | 4506 | _x_x_mozilla_cycle_collect,861 10:31:31 INFO - PROCESS | 4506 | __end_cc_report 10:31:31 INFO - PROCESS | 4506 | __startTimestamp1465666291828__endTimestamp 10:31:31 INFO - PROCESS | 4506 | 10:31:31 INFO - PROCESS | 4506 | ------- Summary: start ------- 10:31:31 INFO - PROCESS | 4506 | Number of tests: 6 10:31:31 INFO - PROCESS | 4506 | 10:31:31 INFO - PROCESS | 4506 | [#0] dojo.html Cycles:165 Average:5408.18 Median:5600.38 stddev:607.39 (10.8%) stddev-sans-first:581.19 10:31:31 INFO - PROCESS | 4506 | Values: 3081.7 3094.3 3114.9 3135.7 3152.0 5217.1 5307.2 5335.0 5427.1 5450.0 5419.3 5419.9 5431.6 5507.1 5507.4 4886.2 4912.2 5028.9 5077.7 5121.2 5031.0 5078.6 5082.7 5099.4 5099.9 4748.8 4802.9 4903.8 4930.3 4999.5 5002.8 5010.6 5011.2 5012.9 5071.6 4950.3 4955.1 4985.7 4992.5 5003.0 5233.3 5289.4 5290.7 5333.9 5483.5 5733.7 5747.9 5786.5 5839.6 5884.2 5893.0 5922.3 5941.2 5943.2 5949.4 5332.8 5431.1 5467.6 5479.2 5531.9 5988.0 6035.2 6050.4 6056.3 6058.9 5556.2 5816.5 5824.7 5824.7 5829.6 5676.2 5697.5 5740.6 5804.7 5862.3 5767.8 5770.8 5773.3 5776.2 5776.5 5700.5 5748.9 5776.0 5792.2 5813.0 4503.8 4530.6 4539.2 4568.8 4572.3 4021.2 4047.5 4048.0 4061.2 4083.2 5379.6 5397.8 5437.2 5578.1 5589.7 5772.1 5802.2 5834.2 5849.6 5904.2 5400.3 5412.6 5434.1 5438.8 5443.8 4823.3 4946.5 4962.8 4991.1 5066.9 5999.8 6004.8 6011.5 6014.4 6049.7 5813.5 5824.4 5829.4 5832.4 5835.3 5828.0 5980.8 5988.2 5989.4 6051.6 5782.7 5811.1 5819.2 5824.9 5829.9 5854.0 5875.0 5884.3 5905.4 5911.1 5501.6 5588.9 5635.5 5650.5 5714.3 5658.2 5665.8 5676.9 5679.0 5683.1 5358.7 5577.1 5580.3 5596.4 5602.9 5645.8 5692.3 5703.8 5792.2 5793.7 5600.4 5619.6 5630.2 5638.9 5642.2 10:31:31 INFO - PROCESS | 4506 | 10:31:31 INFO - PROCESS | 4506 | [#1] ext.html Cycles:180 Average:63196.51 Median:22934.72 stddev:130084.35 (567.2%) stddev-sans-first:130364.37 10:31:31 INFO - PROCESS | 4506 | Values: 600.0 608.3 609.8 609.8 610.9 30955.0 39067.8 42024.0 42444.4 47173.8 45057.0 45457.8 45494.5 45565.0 45565.1 8965.6 9098.9 9120.0 9120.0 9125.8 8917.2 9047.0 9049.4 9051.1 9055.2 9010.6 9052.0 9070.5 9073.3 9075.0 8916.2 8922.0 8927.3 8935.7 8970.8 8753.8 8848.1 8895.4 8912.1 8918.0 43065.8 43205.6 43310.1 43491.8 43527.0 3448.7 3481.8 3523.3 3545.2 3926.6 30104.7 30987.5 33087.7 33140.7 33246.5 3959.3 4096.1 4121.1 4248.4 4279.9 336279.0 342835.0 342951.0 343430.0 343760.0 63243.4 63259.0 63689.7 63708.7 63918.0 67030.3 67744.7 67826.0 67892.7 67956.0 15403.8 15514.4 15536.9 15554.5 15558.3 11655.5 11679.6 11728.8 11769.0 11793.0 16782.7 20396.7 20571.0 20657.5 20662.3 6574.6 7318.2 7492.2 7606.5 7625.9 929.2 960.6 1066.0 1069.5 1088.6 28965.7 30929.5 31808.0 31847.2 32137.2 1074.7 1094.8 1096.6 1104.1 1128.1 16182.5 16619.2 16633.5 16637.8 17005.9 510701.0 512320.0 517147.0 563675.0 828108.0 60256.7 60449.4 60461.7 60751.7 60834.0 1240.8 1262.5 1341.5 1376.8 1382.5 27196.0 33992.0 34075.0 34387.3 34455.0 55330.2 55332.4 55359.4 55850.7 55903.2 484381.0 485915.0 487273.0 491761.0 492208.5 26121.7 28062.0 28616.6 29230.7 29859.0 42316.0 42815.4 46497.8 48156.3 48342.5 40588.6 40626.6 40765.4 41748.4 41781.0 38538.0 39806.6 40059.0 40458.2 40542.8 39223.4 40154.4 40248.2 40477.0 40609.0 33253.8 35404.3 35969.0 35994.5 36239.3 27451.2 27658.9 27880.3 27894.2 27998.0 10:31:31 INFO - PROCESS | 4506 | 10:31:31 INFO - PROCESS | 4506 | [#2] jquery.html Cycles:180 Average:27773.46 Median:42388.39 stddev:72595.35 (171.3%) stddev-sans-first:72769.92 10:31:31 INFO - PROCESS | 4506 | Values: 404.6 409.3 411.6 417.4 429.3 13614.8 18190.0 19785.0 19872.3 19999.6 15422.4 19312.1 19387.5 19907.2 20228.3 5731.5 5905.9 5911.2 5919.5 5924.1 5797.9 5858.8 5898.8 5902.6 5906.1 4214.6 6202.3 6489.6 6506.4 6630.1 6346.8 6547.1 6567.1 6567.8 6600.9 5812.5 5826.9 5836.6 5838.1 5855.0 23130.4 23522.8 24247.9 24257.8 24536.3 2440.8 2515.1 2634.0 2702.6 2804.8 14093.6 14457.9 14884.8 14957.6 15033.4 1914.5 2015.5 2015.6 2022.4 2044.7 75900.6 77320.6 78457.0 84194.0 89186.6 10723.7 11215.4 11277.3 11321.4 11567.0 15937.8 16003.3 16102.8 16104.1 16105.8 7620.6 7907.1 7911.0 7916.8 8020.8 7366.6 7428.7 7466.3 7564.9 7603.4 4349.8 4398.8 4645.5 4864.2 4954.2 1957.7 1983.7 2018.3 2027.8 2042.6 894.3 942.9 965.4 987.0 998.6 18759.5 19635.3 19657.6 20001.2 20275.6 948.4 962.6 963.3 972.7 982.0 10544.2 11116.8 11153.8 11167.2 11194.0 430502.0 434147.0 439166.0 441797.0 443015.0 95019.5 97140.0 97249.0 97892.5 98085.0 948.2 955.9 968.2 969.5 973.6 17293.3 17344.1 17400.7 17600.2 17678.3 30300.7 37425.6 42286.0 42490.8 43385.3 57701.4 57914.6 58098.7 58494.4 58511.7 7875.3 8728.8 8801.8 9037.8 9119.6 8699.3 10630.5 10800.8 12819.4 12983.5 12027.5 12045.9 12071.2 12138.1 12219.9 11683.8 11714.4 11799.1 11916.8 12114.3 12060.0 12229.9 12284.4 12340.6 12628.6 7889.9 8043.8 8188.1 8209.1 8535.4 8737.6 11450.4 11567.5 11735.2 12129.9 10:31:31 INFO - PROCESS | 4506 | 10:31:31 INFO - PROCESS | 4506 | [#3] mootools.html Cycles:180 Average:6072.87 Median:460.59 stddev:3569.06 (774.9%) stddev-sans-first:3561.02 10:31:31 INFO - PROCESS | 4506 | Values: 1296.1 1434.4 1470.6 1576.2 1744.7 8585.9 8981.1 8986.0 9145.3 9170.9 8905.1 9087.9 9097.0 9114.7 9217.8 2103.6 2315.9 2391.8 2403.2 2430.1 2341.9 2345.4 2350.2 2356.4 2365.4 2340.8 2350.6 2367.8 2369.1 2374.4 2046.7 2245.6 2312.6 2313.7 2339.7 2355.8 2377.6 2397.5 2399.6 2405.1 9278.5 9336.8 9341.8 9349.1 9357.7 5378.2 5527.6 5528.6 5531.5 5533.9 3168.2 3335.1 3422.6 3439.0 3445.1 1074.4 1093.8 1104.7 1105.9 1109.1 12921.6 12926.4 12930.7 12944.6 12950.5 4771.8 4778.6 4850.7 4869.3 4919.2 10641.5 10683.8 10687.7 10690.2 10714.3 5360.7 5364.7 5370.7 5389.1 5399.1 4483.7 4844.6 4975.3 5017.7 5095.3 4069.8 4089.4 4145.4 4172.9 4182.6 1290.4 1304.4 1317.5 1327.0 1340.9 896.5 1000.8 1001.3 1016.7 1030.4 6360.1 6409.3 6440.2 6456.3 6604.2 456.8 464.4 465.3 469.1 474.0 4188.4 4300.3 4338.2 4349.6 4361.5 11616.2 11839.5 11918.9 11942.0 12040.9 11462.4 11790.0 11812.7 11813.2 11892.9 8508.7 8640.4 8653.8 8679.9 8764.3 6053.0 6133.3 6171.2 6172.9 6203.3 10793.2 10819.1 10919.6 10926.7 10928.2 10851.3 10879.9 11159.6 11165.4 11194.5 7483.6 7917.8 8117.1 8348.3 8425.4 9127.5 9128.4 9204.7 9204.8 9208.1 7957.3 8214.8 8218.7 8262.0 8336.4 7937.4 8055.2 8078.8 8152.4 8192.9 6996.9 7213.3 7488.6 7574.0 7579.5 5136.4 5166.6 5178.0 5236.3 5304.7 5172.3 5196.7 5234.1 5337.3 5402.0 10:31:31 INFO - PROCESS | 4506 | 10:31:31 INFO - PROCESS | 4506 | [#4] prototype.html Cycles:180 Average:4550.01 Median:5069.92 stddev:1290.83 (25.5%) stddev-sans-first:1255.11 10:31:31 INFO - PROCESS | 4506 | Values: 336.1 352.9 356.4 358.4 358.9 5188.6 5224.8 5305.8 5386.7 5418.4 5203.9 5217.7 5253.0 5282.8 5288.5 4214.8 4226.7 4227.2 4234.9 4255.2 3979.9 4007.6 4193.9 4237.5 4280.7 4143.5 4206.5 4206.5 4210.3 4212.4 4190.2 4201.3 4204.6 4207.7 4213.5 3677.2 3706.8 3764.2 3784.5 3787.0 5104.7 5135.6 5162.7 5167.9 5175.7 4814.3 4820.2 4827.1 4827.7 4836.3 5367.1 5519.3 5532.1 5554.6 5564.0 4096.6 4123.7 4125.9 4128.5 4133.6 5668.4 5697.7 5699.7 5708.0 5708.3 3972.0 4231.6 4247.2 4248.7 4261.0 4249.2 4272.6 4286.1 4293.4 4305.6 4768.4 4777.3 4785.2 4803.7 4816.0 5328.3 5572.6 5616.3 5616.8 5630.3 1458.4 1479.4 1489.9 1492.7 1501.2 942.6 950.0 962.5 967.9 974.0 4711.8 4728.2 4737.4 4744.0 4757.4 5026.2 5061.9 5072.5 5079.4 5153.0 4517.4 4549.8 4720.9 4823.9 4835.5 2676.8 2684.0 2694.4 2698.4 2737.5 5145.6 5183.6 5185.0 5191.9 5269.4 4924.6 4975.0 5066.4 5145.1 5182.5 5195.0 5201.0 5207.7 5216.6 5258.8 5040.0 5043.1 5058.4 5067.3 5073.1 5020.0 5062.8 5259.8 5655.4 5708.5 5843.3 5854.5 5886.4 5948.2 5950.0 3872.9 3916.9 3986.4 3995.4 3998.5 5633.5 5634.5 5682.3 5709.7 5731.7 5302.2 5422.0 5497.4 5513.8 5549.7 5438.3 5439.8 5463.2 5464.3 5511.0 5364.4 5371.8 5373.3 5414.2 5422.9 5338.8 5510.6 5517.8 5531.7 5559.9 5392.8 5412.6 5418.8 5435.3 5435.9 10:31:31 INFO - PROCESS | 4506 | 10:31:31 INFO - PROCESS | 4506 | [#5] yui.html Cycles:180 Average:20902.25 Median:4667.25 stddev:30615.86 (656.0%) stddev-sans-first:30664.24 10:31:31 INFO - PROCESS | 4506 | Values: 720.6 773.9 784.9 793.2 798.2 12801.6 13384.3 14239.6 14366.9 14427.5 14121.9 14211.6 14251.0 14275.4 14369.6 666.9 780.8 796.4 808.1 809.0 803.0 819.2 821.2 821.4 821.6 850.7 851.8 855.0 855.2 857.8 702.8 832.0 855.6 857.8 858.4 620.0 621.6 622.1 622.3 622.8 13311.3 13338.3 13366.8 13383.0 13387.9 14821.3 14900.4 15150.1 15331.5 15395.7 10822.1 11002.5 11125.9 11342.4 11507.3 3864.7 3890.0 3942.2 4031.1 4066.5 74035.0 74128.0 74847.3 75246.6 76544.2 11306.3 11415.1 11450.8 11648.4 11799.3 22862.9 22904.4 22913.4 22926.3 22932.7 8131.9 8315.5 8370.6 8411.7 8573.8 4592.2 4658.9 4675.9 4693.5 4765.5 3627.5 3728.9 3729.5 3739.0 3740.2 596.1 630.6 635.3 641.0 660.0 658.1 671.2 713.9 750.6 773.5 9326.0 9626.9 9632.9 9790.0 9891.7 678.8 722.1 727.1 729.1 759.6 4551.5 4675.6 4699.0 4757.1 4810.7 72415.3 73167.0 120417.0 123387.0 125461.8 109573.0 109689.0 110374.0 111794.0 113550.0 96027.5 96596.0 97733.0 98624.0 98685.6 9172.5 9284.9 9327.9 9385.8 9467.6 51518.0 52714.5 54026.0 54264.2 55171.4 55648.0 66103.0 68449.7 68574.3 79163.6 11724.6 12236.5 12456.6 13522.3 13548.5 12954.7 13180.3 13285.5 13660.6 13914.0 14607.2 14665.9 14679.6 14884.1 15090.5 13424.7 13648.5 13746.7 13829.3 14309.3 13821.8 13904.5 14155.9 14231.4 14889.2 11372.9 11530.9 11831.5 11906.0 11967.2 10607.9 10883.6 11146.9 11179.9 11282.5 10:31:31 INFO - PROCESS | 4506 | -------- Summary: end -------- 10:31:31 INFO - PROCESS | 4506 | 10:31:32 INFO - TEST-INFO | 4506: exit 0 10:31:32 INFO - TEST-OK | dromaeo_css | took 1113681ms 10:31:32 INFO - TEST-START | kraken 10:31:32 INFO - operating with platform_type : linux_ 10:31:32 INFO - Initialising browser for kraken test... 10:31:32 INFO - TEST-INFO | started process 4692 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKJJJtw/profile http://localhost:46074/getInfo.html) 10:31:36 INFO - PROCESS | 4692 | __metrics Screen width/height:1600/1200 10:31:36 INFO - PROCESS | 4692 | colorDepth:24 10:31:36 INFO - PROCESS | 4692 | Browser inner width/height: 1024/697 10:31:36 INFO - PROCESS | 4692 | __metrics 10:31:37 ERROR - PROCESS | 4692 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:31:37 INFO - PROCESS | 4692 | console.error: PushService: 10:31:37 INFO - PROCESS | 4692 | stateChangeProcessEnqueue: Error transitioning state 10:31:37 INFO - PROCESS | 4692 | UnknownError 10:31:38 INFO - TEST-INFO | 4692: exit 0 10:31:38 INFO - Browser initialized. 10:31:38 INFO - Running cycle 1/1 for kraken test... 10:31:38 INFO - TEST-INFO | started process 4775 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKJJJtw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:31:50 INFO - PROCESS | 4775 | RSS: Main: 174129152 10:31:50 INFO - PROCESS | 4775 | 10:31:52 INFO - PROCESS | 4775 | Cycle 1(1): loaded http://localhost:46074/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46074/tests/kraken/driver.html?testName=audio-beat-detection) 10:31:53 INFO - PROCESS | 4775 | RSS: Main: 231673856 10:31:53 INFO - PROCESS | 4775 | 10:31:56 INFO - PROCESS | 4775 | Cycle 1(1): loaded http://localhost:46074/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46074/tests/kraken/driver.html?testName=audio-dft) 10:31:57 INFO - PROCESS | 4775 | RSS: Main: 220909568 10:31:57 INFO - PROCESS | 4775 | 10:32:00 INFO - PROCESS | 4775 | Cycle 1(1): loaded http://localhost:46074/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46074/tests/kraken/driver.html?testName=audio-fft) 10:32:00 INFO - PROCESS | 4775 | RSS: Main: 286171136 10:32:00 INFO - PROCESS | 4775 | 10:32:02 INFO - PROCESS | 4775 | Cycle 1(1): loaded http://localhost:46074/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46074/tests/kraken/driver.html?testName=audio-oscillator) 10:32:03 INFO - PROCESS | 4775 | RSS: Main: 197025792 10:32:03 INFO - PROCESS | 4775 | 10:32:05 INFO - PROCESS | 4775 | Cycle 1(1): loaded http://localhost:46074/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46074/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:32:06 INFO - PROCESS | 4775 | RSS: Main: 200450048 10:32:06 INFO - PROCESS | 4775 | 10:32:09 INFO - PROCESS | 4775 | Cycle 1(1): loaded http://localhost:46074/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46074/tests/kraken/driver.html?testName=imaging-darkroom) 10:32:09 INFO - PROCESS | 4775 | RSS: Main: 235098112 10:32:09 INFO - PROCESS | 4775 | 10:32:13 INFO - PROCESS | 4775 | Cycle 1(1): loaded http://localhost:46074/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46074/tests/kraken/driver.html?testName=imaging-desaturate) 10:32:13 INFO - PROCESS | 4775 | RSS: Main: 237031424 10:32:13 INFO - PROCESS | 4775 | 10:32:16 INFO - PROCESS | 4775 | Cycle 1(1): loaded http://localhost:46074/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46074/tests/kraken/driver.html?testName=json-parse-financial) 10:32:17 INFO - PROCESS | 4775 | RSS: Main: 237699072 10:32:17 INFO - PROCESS | 4775 | 10:32:18 INFO - PROCESS | 4775 | Cycle 1(1): loaded http://localhost:46074/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46074/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:32:19 INFO - PROCESS | 4775 | RSS: Main: 221126656 10:32:19 INFO - PROCESS | 4775 | 10:32:20 INFO - PROCESS | 4775 | Cycle 1(1): loaded http://localhost:46074/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46074/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:32:21 INFO - PROCESS | 4775 | RSS: Main: 225198080 10:32:21 INFO - PROCESS | 4775 | 10:32:23 INFO - PROCESS | 4775 | Cycle 1(1): loaded http://localhost:46074/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46074/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:32:24 INFO - PROCESS | 4775 | RSS: Main: 232701952 10:32:24 INFO - PROCESS | 4775 | 10:32:26 INFO - PROCESS | 4775 | Cycle 1(1): loaded http://localhost:46074/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46074/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:32:27 INFO - PROCESS | 4775 | RSS: Main: 239833088 10:32:27 INFO - PROCESS | 4775 | 10:32:30 INFO - PROCESS | 4775 | Cycle 1(1): loaded http://localhost:46074/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46074/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:32:30 INFO - PROCESS | 4775 | RSS: Main: 242024448 10:32:30 INFO - PROCESS | 4775 | 10:32:32 INFO - PROCESS | 4775 | Cycle 1(1): loaded http://localhost:46074/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46074/tests/kraken/driver.html?testName=ai-astar) 10:32:32 INFO - PROCESS | 4775 | RSS: Main: 284336128 10:32:32 INFO - PROCESS | 4775 | 10:32:32 INFO - PROCESS | 4775 | __start_tp_report 10:32:32 INFO - PROCESS | 4775 | _x_x_mozilla_page_load 10:32:32 INFO - PROCESS | 4775 | _x_x_mozilla_page_load_details 10:32:32 INFO - PROCESS | 4775 | |i|pagename|runs| 10:32:32 INFO - PROCESS | 4775 | |0;ai-astar;112;106;110;109;112;109;110;110;109;109 10:32:32 INFO - PROCESS | 4775 | |1;audio-beat-detection;155;129;131;179;132;153;155;128;175;125 10:32:32 INFO - PROCESS | 4775 | |2;audio-dft;162;160;161;160;160;161;163;162;162;161 10:32:32 INFO - PROCESS | 4775 | |3;audio-fft;75;76;76;117;76;75;74;74;97;75 10:32:32 INFO - PROCESS | 4775 | |4;audio-oscillator;84;85;116;85;85;85;112;84;85;124 10:32:32 INFO - PROCESS | 4775 | |5;imaging-gaussian-blur;117;117;117;117;117;116;117;117;116;117 10:32:32 INFO - PROCESS | 4775 | |6;imaging-darkroom;147;145;147;146;146;145;146;145;145;147 10:32:32 INFO - PROCESS | 4775 | |7;imaging-desaturate;94;95;95;95;95;95;95;95;95;95 10:32:32 INFO - PROCESS | 4775 | |8;json-parse-financial;53;53;53;52;52;53;54;52;53;52 10:32:32 INFO - PROCESS | 4775 | |9;json-stringify-tinderbox;61;61;61;61;61;61;61;61;61;61 10:32:32 INFO - PROCESS | 4775 | |10;stanford-crypto-aes;80;79;85;82;81;82;80;83;116;82 10:32:32 INFO - PROCESS | 4775 | |11;stanford-crypto-ccm;123;122;124;129;118;131;128;121;151;130 10:32:32 INFO - PROCESS | 4775 | |12;stanford-crypto-pbkdf2;165;164;169;162;161;161;168;161;168;163 10:32:32 INFO - PROCESS | 4775 | |13;stanford-crypto-sha256-iterative;67;63;63;63;64;66;62;67;66;65 10:32:32 INFO - PROCESS | 4775 | __end_tp_report 10:32:32 INFO - PROCESS | 4775 | __start_cc_report 10:32:32 INFO - PROCESS | 4775 | _x_x_mozilla_cycle_collect,1676 10:32:32 INFO - PROCESS | 4775 | __end_cc_report 10:32:32 INFO - PROCESS | 4775 | __startTimestamp1465666352740__endTimestamp 10:32:32 INFO - PROCESS | 4775 | 10:32:32 INFO - PROCESS | 4775 | ------- Summary: start ------- 10:32:32 INFO - PROCESS | 4775 | Number of tests: 14 10:32:32 INFO - PROCESS | 4775 | 10:32:32 INFO - PROCESS | 4775 | [#0] ai-astar Cycles:10 Average:109.60 Median:110.00 stddev:1.71 (1.6%) stddev-sans-first:1.58 10:32:32 INFO - PROCESS | 4775 | Values: 112.0 106.0 110.0 109.0 112.0 109.0 110.0 110.0 109.0 109.0 10:32:32 INFO - PROCESS | 4775 | 10:32:32 INFO - PROCESS | 4775 | [#1] audio-beat-detection Cycles:10 Average:146.20 Median:154.00 stddev:20.04 (13.0%) stddev-sans-first:21.00 10:32:32 INFO - PROCESS | 4775 | Values: 155.0 129.0 131.0 179.0 132.0 153.0 155.0 128.0 175.0 125.0 10:32:32 INFO - PROCESS | 4775 | 10:32:32 INFO - PROCESS | 4775 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.50 stddev:1.03 (0.6%) stddev-sans-first:1.05 10:32:32 INFO - PROCESS | 4775 | Values: 162.0 160.0 161.0 160.0 160.0 161.0 163.0 162.0 162.0 161.0 10:32:32 INFO - PROCESS | 4775 | 10:32:32 INFO - PROCESS | 4775 | [#3] audio-fft Cycles:10 Average:81.50 Median:75.50 stddev:14.26 (18.9%) stddev-sans-first:14.93 10:32:32 INFO - PROCESS | 4775 | Values: 75.0 76.0 76.0 117.0 76.0 75.0 74.0 74.0 97.0 75.0 10:32:32 INFO - PROCESS | 4775 | 10:32:32 INFO - PROCESS | 4775 | [#4] audio-oscillator Cycles:10 Average:94.50 Median:85.00 stddev:16.02 (18.9%) stddev-sans-first:16.54 10:32:32 INFO - PROCESS | 4775 | Values: 84.0 85.0 116.0 85.0 85.0 85.0 112.0 84.0 85.0 124.0 10:32:32 INFO - PROCESS | 4775 | 10:32:32 INFO - PROCESS | 4775 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 10:32:32 INFO - PROCESS | 4775 | Values: 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 116.0 117.0 10:32:32 INFO - PROCESS | 4775 | 10:32:32 INFO - PROCESS | 4775 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.88 (0.6%) stddev-sans-first:0.83 10:32:32 INFO - PROCESS | 4775 | Values: 147.0 145.0 147.0 146.0 146.0 145.0 146.0 145.0 145.0 147.0 10:32:32 INFO - PROCESS | 4775 | 10:32:32 INFO - PROCESS | 4775 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 10:32:32 INFO - PROCESS | 4775 | Values: 94.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 10:32:32 INFO - PROCESS | 4775 | 10:32:32 INFO - PROCESS | 4775 | [#8] json-parse-financial Cycles:10 Average:52.70 Median:53.00 stddev:0.67 (1.3%) stddev-sans-first:0.71 10:32:32 INFO - PROCESS | 4775 | Values: 53.0 53.0 53.0 52.0 52.0 53.0 54.0 52.0 53.0 52.0 10:32:32 INFO - PROCESS | 4775 | 10:32:32 INFO - PROCESS | 4775 | [#9] json-stringify-tinderbox Cycles:10 Average:61.00 Median:61.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 10:32:32 INFO - PROCESS | 4775 | Values: 61.0 61.0 61.0 61.0 61.0 61.0 61.0 61.0 61.0 61.0 10:32:32 INFO - PROCESS | 4775 | 10:32:32 INFO - PROCESS | 4775 | [#10] stanford-crypto-aes Cycles:10 Average:85.00 Median:82.00 stddev:11.03 (13.4%) stddev-sans-first:11.54 10:32:32 INFO - PROCESS | 4775 | Values: 80.0 79.0 85.0 82.0 81.0 82.0 80.0 83.0 116.0 82.0 10:32:32 INFO - PROCESS | 4775 | 10:32:32 INFO - PROCESS | 4775 | [#11] stanford-crypto-ccm Cycles:10 Average:127.70 Median:128.50 stddev:9.24 (7.2%) stddev-sans-first:9.64 10:32:32 INFO - PROCESS | 4775 | Values: 123.0 122.0 124.0 129.0 118.0 131.0 128.0 121.0 151.0 130.0 10:32:32 INFO - PROCESS | 4775 | 10:32:32 INFO - PROCESS | 4775 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.20 Median:164.50 stddev:3.16 (1.9%) stddev-sans-first:3.33 10:32:32 INFO - PROCESS | 4775 | Values: 165.0 164.0 169.0 162.0 161.0 161.0 168.0 161.0 168.0 163.0 10:32:32 INFO - PROCESS | 4775 | 10:32:32 INFO - PROCESS | 4775 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.60 Median:65.50 stddev:1.84 (2.8%) stddev-sans-first:1.73 10:32:32 INFO - PROCESS | 4775 | Values: 67.0 63.0 63.0 63.0 64.0 66.0 62.0 67.0 66.0 65.0 10:32:32 INFO - PROCESS | 4775 | -------- Summary: end -------- 10:32:32 INFO - PROCESS | 4775 | 10:32:33 INFO - TEST-INFO | 4775: exit 0 10:32:33 INFO - TEST-OK | kraken | took 61071ms 10:32:33 INFO - SUITE-END | took 1174s 10:32:33 INFO - Completed test suite (00:19:34) 10:32:33 INFO - javascript benchmark 10:32:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3081.676423975483, 3094.2883136878518, 3114.937701245976, 3135.6707545707714, 3152.0228729093983, 5217.139172036619, 5307.230451584518, 5335.039692855285, 5427.131658934566, 5449.972750136254, 5419.349678038631, 5419.891602167954, 5431.646942948705, 5507.091329930557, 5507.366652834925, 4886.218205087187, 4912.189488734354, 5028.899422011576, 5077.746112694369, 5121.2318152277085, 5031.044101620699, 5078.5937125029905, 5082.745862706868, 5099.413567439737, 5099.898002039957, 4748.833790817322, 4802.855914322576, 4903.779329930162, 4930.28510865926, 4999.450060493343, 5002.824901128443, 5010.599152067826, 5011.2483127530795, 5012.8997420051755, 5071.619628527875, 4950.331705219821, 4955.058538877602, 4985.651004429691, 4992.500749925015, 5003.0, 5233.319668443116, 5289.391719952217, 5290.65610735301, 5333.893322133575, 5483.506484416382, 5733.713314334266, 5747.885042299131, 5786.5370770338695, 5839.620424672383, 5884.176215329857, 5892.970535147339, 5922.2597175353085, 5941.197938278364, 5943.197668314765, 5949.375315591887, 5332.760025798849, 5431.131019036975, 5467.58993075517, 5479.1781232815, 5531.944680553143, 5987.970060149759, 6035.185249991195, 6050.3949605040025, 6056.3338032816355, 6058.909116363258, 5556.249906262684, 5816.47651711348, 5824.650520968756, 5824.679642619697, 5829.59192856496, 5676.205331253628, 5697.4587414195585, 5740.569457290637, 5804.65172089676, 5862.267216597926, 5767.798127065533, 5770.826875193751, 5773.278340207474, 5776.1624564437925, 5776.480116789425, 5700.515456186187, 5748.856278592985, 5775.971120144372, 5792.218050563204, 5812.9709351452975, 4503.797329120198, 4530.569595888385, 4539.182947069493, 4568.840090596813, 4572.314152877028, 4021.235965166609, 4047.453593764863, 4048.0284731664187, 4061.2283666103936, 4083.1833633273463, 5379.623426360117, 5397.8380648580605, 5437.184422336682, 5578.079616863253, 5589.664620122724, 5772.076467765138, 5802.158686990363, 5834.183214349994, 5849.64902105875, 5904.1734157218025, 5400.324959380077, 5412.5940554458575, 5434.076207044812, 5438.782448702087, 5443.755031023614, 4823.27650852375, 4946.505349465025, 4962.751862406865, 4991.126552853236, 5066.898662026739, 5999.790007349722, 6004.849878753066, 6011.519078473799, 6014.398560143951, 6049.727762250709, 5813.505852002627, 5824.417558244311, 5829.387914268941, 5832.387599302182, 5835.299764028344, 5828.038373668467, 5980.760769569169, 5988.22153120109, 5989.3711160329285, 6051.576389652858, 5782.653040817396, 5811.070228763378, 5819.214406055297, 5824.912626310524, 5829.883402332014, 5854.0, 5874.970625147018, 5884.293884733859, 5905.43898329658, 5911.054231322968, 5501.587380946525, 5588.944110559005, 5635.492805647511, 5650.547956163415, 5714.342850572238, 5658.151277308437, 5665.773369065356, 5676.914846277392, 5679.00617391963, 5683.090705487102, 5358.705271210121, 5577.051901176891, 5580.302462192226, 5596.41237670055, 5602.915956260741, 5645.774169033357, 5692.345380281321, 5703.828885133453, 5792.160136780059, 5793.681347525758, 5600.383957764561, 5619.634723742944, 5630.211770352072, 5638.887222255614, 5642.153676948326], "value": 5367.516462415182, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [599.991000134998, 608.309568639594, 609.826199533133, 609.8475381154711, 610.8961476548986, 30955.0, 39067.804660976726, 42024.0, 42444.363334550006, 47173.764131179385, 45057.0, 45457.77271113648, 45494.545054549446, 45565.0, 45565.08869822601, 8965.641374345034, 9098.909010909905, 9119.951205611373, 9120.042395548471, 9125.771855703593, 8917.242034427081, 9047.0, 9049.411788233776, 9051.14014168653, 9055.185033346997, 9010.594523246436, 9052.049534798816, 9070.546472676373, 9073.274138068939, 9074.954625226865, 8916.242119419858, 8922.0, 8927.285817134678, 8935.731928042136, 8970.775730606721, 8753.7811554711, 8848.115188481164, 8895.377323587352, 8912.06423325548, 8918.019017908025, 43065.784671076755, 43205.567944320785, 43310.13379732388, 43491.78254108741, 43527.0, 3448.689617934398, 3481.7736847104857, 3523.260115375774, 3545.2200515886466, 3926.6269704378037, 30104.69895301063, 30987.53518697199, 33087.6691233087, 33140.66859331424, 33246.50130248048, 3959.307121253769, 4096.09885825118, 4121.072758629284, 4248.362745588187, 4279.871603851859, 336279.0, 342835.0, 342950.9999999975, 343430.0, 343760.0, 63243.367566323745, 63259.0, 63689.681551592876, 63708.68145659242, 63918.0, 67030.32969670338, 67744.6612766933, 67826.0, 67892.660536697, 67956.0, 15403.768943465857, 15514.379424823106, 15536.922315388576, 15554.533363999099, 15558.299876505584, 11655.53377864876, 11679.591214307458, 11728.76542469163, 11769.0, 11793.0, 16782.69032793495, 20396.694049589267, 20571.0, 20657.483562911046, 20662.276820311217, 6574.638394888231, 7318.194998550155, 7492.182114276092, 7606.467547271638, 7625.923740762632, 929.2148134826061, 960.644561512231, 1066.0352381095122, 1069.465466422379, 1088.5808963548932, 28965.710342896302, 30929.536056959165, 31808.0, 31847.203819904687, 32137.196570085467, 1074.7366895110592, 1094.8357746338113, 1096.6435908329825, 1104.1056744037196, 1128.0862501373913, 16182.514524564282, 16619.169041547873, 16633.50099497017, 16637.833621663627, 17005.91497042507, 510701.0, 512320.0, 517147.0, 563675.0, 828108.0, 60256.69871650702, 60449.39550604438, 60461.69769151126, 60751.69624151851, 60834.0, 1240.8138779183014, 1262.545483625894, 1341.530464337474, 1376.8072469854228, 1382.5437605590132, 27196.0, 33992.0, 34075.0, 34387.312253755284, 34455.0, 55330.17004744852, 55332.44667553434, 55359.446405535426, 55850.72074639601, 55903.16145257743, 484381.0, 485915.0, 487273.0, 491761.0, 492208.5389573029, 26121.73878261193, 28062.0, 28616.57075143916, 29230.7076929228, 29859.0, 42316.0, 42815.3577696341, 46497.76751116223, 48156.27765583589, 48342.51657483521, 40588.594114058484, 40626.59373406346, 40765.38851917164, 41748.3737743928, 41781.0, 38538.0, 39806.601933981445, 40059.0, 40458.190836182526, 40542.79728601338, 39223.41164882472, 40154.39768403535, 40248.19503609853, 40477.0, 40609.0, 33253.83373083119, 35404.29191416209, 35969.0, 35994.46008309825, 36239.275214495035, 27451.17646470609, 27658.861705692147, 27880.302992425353, 27894.163175103968, 27998.0], "value": 20249.030147973946, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [404.6156151655926, 409.3246143862626, 411.5884115884116, 417.434376419951, 429.3216717586214, 13614.795778063311, 18190.0, 19785.0, 19872.304469343577, 19999.60000799985, 15422.383104675828, 19312.130954107062, 19387.515312117204, 19907.203711851507, 20228.29200977966, 5731.484166425032, 5905.911411328833, 5911.231539899807, 5919.467247947684, 5924.08176732605, 5797.913031304533, 5858.7949421770245, 5898.7640494380175, 5902.557308201902, 5906.084556893688, 4214.578542145776, 6202.2867370252325, 6489.61062336259, 6506.4469520090615, 6630.071789949411, 6346.809595712136, 6547.083408322815, 6567.080608714808, 6567.802965911031, 6600.9339906601035, 5812.476877081083, 5826.912596311059, 5836.620619659709, 5838.095095260242, 5855.0, 23130.42173945648, 23522.7647723524, 24247.87876060626, 24257.757422425904, 24536.263912082664, 2440.7681270279295, 2515.1197081021496, 2634.012245407972, 2702.5675891857404, 2804.831710097401, 14093.577192684235, 14457.927710361486, 14884.776728349083, 14957.626059348495, 15033.398664053424, 1914.521096931312, 2015.506200980769, 2015.61703276377, 2022.3730643500562, 2044.7137400763904, 75900.62049689771, 77320.61339693321, 78457.0, 84194.0, 89186.55406723055, 10723.678289651323, 11215.420453295788, 11277.32336059839, 11321.433928303552, 11567.0, 15937.760933586005, 16003.279852406436, 16102.75845862313, 16104.114273714824, 16105.838941610667, 7620.5808680523105, 7907.130215676271, 7911.0, 7916.802079948047, 8020.799480013046, 7366.558006519626, 7428.665710043061, 7466.290702383265, 7564.886526702104, 7603.4297427693145, 4349.804258808361, 4398.824047038147, 4645.488996210414, 4864.1516223834715, 4954.157793175169, 1957.7259183714007, 1983.672694005473, 2018.3339497965635, 2027.7566691997056, 2042.5812708394744, 894.3337213775778, 942.8915674697361, 965.358036905464, 986.9851952220722, 998.6404894238068, 18759.531011724815, 19635.312764053477, 19657.606847862964, 20001.199952001756, 20275.594488110157, 948.4025064209504, 962.6245764151986, 963.2582911158509, 972.7422233108232, 981.9705408837747, 10544.209184311207, 11116.833247501294, 11153.832692509619, 11167.162462815322, 11194.0, 430502.0, 434147.0, 439166.0, 441797.0, 443015.0, 95019.52490237505, 97140.0, 97249.0, 97892.51053744685, 98085.0, 948.1987720376271, 955.9139677429065, 968.2302569457298, 969.5152423788106, 973.5862258540234, 17293.315414862074, 17344.132793360535, 17400.651986959936, 17600.207990640196, 17678.292868285123, 30300.69699302979, 37425.6257437433, 42286.0, 42490.78754606207, 43385.349219762364, 57701.422985769605, 57914.62939076783, 58098.7095064522, 58494.4150558506, 58511.70744146252, 7875.330596899328, 8728.825423491622, 8801.779955501164, 9037.77405564866, 9119.635214591608, 8699.347548933982, 10630.468476576294, 10800.837987430037, 12819.42312595954, 12983.545575904798, 12027.518899243933, 12045.879541204476, 12071.215371000857, 12138.089643276613, 12219.938900305442, 11683.824742629038, 11714.414279285831, 11799.115066369885, 11916.76166476683, 12114.333711645944, 12060.0, 12229.87770122323, 12284.447199875849, 12340.568080117511, 12628.558000469939, 7889.881651775343, 8043.798905027421, 8188.099309076116, 8209.138040505899, 8535.402521823413, 8737.606807693795, 11450.37022963745, 11567.537298507965, 11735.237209581692, 12129.939350303192], "value": 9340.200504447914, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1296.1251155470056, 1434.447737621016, 1470.595586213791, 1576.1725094325477, 1744.6946784312734, 8585.926759155105, 8981.05698901615, 8985.955070224647, 9145.314101442385, 9170.908290917088, 8905.109489051092, 9087.864016997875, 9097.0, 9114.726558203249, 9217.815643687121, 2103.568768402474, 2315.9421014474606, 2391.784739373456, 2403.194929698553, 2430.1373012580543, 2341.9414514637183, 2345.4253707841604, 2350.21267875262, 2356.387339291788, 2365.4322962488964, 2340.8127349811975, 2350.576896158691, 2367.846090004144, 2369.1115831563166, 2374.3589230907646, 2046.7032280319345, 2245.6070187717246, 2312.583734927712, 2313.687652166953, 2339.6958395408574, 2355.7762012608773, 2377.6314671225814, 2397.520495900827, 2399.5560821248123, 2405.0500052479174, 9278.51543753003, 9336.766580835465, 9341.76645583859, 9349.111834375723, 9357.672481463116, 5378.193271009341, 5527.55779537636, 5528.55771538276, 5531.529819965308, 5533.916991245094, 3168.207948012997, 3335.116194208537, 3422.6064002639764, 3438.9656103439147, 3445.0870519312402, 1074.3500182389698, 1093.824988001916, 1104.6851647280566, 1105.8617672790901, 1109.1071687291726, 12921.612351629467, 12926.41831117602, 12930.741385172243, 12944.61166165026, 12950.546730864375, 4771.785269662804, 4778.641601879804, 4850.684705494132, 4869.2939523768855, 4919.237518184687, 10641.5211315491, 10683.83974240387, 10687.679369618923, 10690.19823513224, 10714.303570267908, 5360.70516121617, 5364.7317634118135, 5370.677759334374, 5389.137737961985, 5399.082156033483, 4483.708558943658, 4844.612431005511, 4975.253711943165, 5017.7491125443585, 5095.261187127846, 4069.7587235892743, 4089.44792453021, 4145.440365550672, 4172.852465571931, 4182.602652747984, 1290.4193113098954, 1304.4325718312564, 1317.4993502469001, 1327.0312671749678, 1340.9195448273135, 896.5203616065373, 1000.7990411506076, 1001.2640709078821, 1016.7305663998899, 1030.4487099401783, 6360.14138091361, 6409.262934762562, 6440.162778838815, 6456.322086180978, 6604.240512341143, 456.8149899290793, 464.3730963199721, 465.3206318774559, 469.0806020200445, 473.96445266605144, 4188.434561334242, 4300.268954277781, 4338.154059958278, 4349.608535231844, 4361.498427680857, 11616.186866919235, 11839.526418943318, 11918.940405297919, 11942.0, 12040.879591204151, 11462.426878656033, 11790.0, 11812.70468238301, 11813.232139910879, 11892.940535297268, 8508.74473765788, 8640.395172338001, 8653.783655408539, 8679.869801952977, 8764.255038321815, 6052.969735151296, 6133.294671112701, 6171.228596425447, 6172.876542469216, 6203.286622038343, 10793.190510711886, 10819.08037816763, 10919.617813376812, 10926.672199834018, 10928.180386470887, 10851.348919064882, 10879.945600271947, 11159.553617855196, 11165.441727913734, 11194.496247668712, 7483.625818708934, 7917.7624671259955, 8117.10711821711, 8348.290395316224, 8425.410221284452, 9127.497987610745, 9128.361014728906, 9204.723858284262, 9204.769880752767, 9208.079192080739, 7957.283844454027, 8214.83570328602, 8218.671253150047, 8262.008558972962, 8336.374406990579, 7937.444378893422, 8055.1542088079905, 8078.842315369261, 8152.429329946846, 8192.877106843522, 6996.895046574204, 7213.314735100157, 7488.5506869588, 7573.97751303589, 7579.54522728638, 5136.383633963948, 5166.6125040621355, 5177.974110129425, 5236.345456817898, 5304.7347632618985, 5172.327597412313, 5196.662216955886, 5234.11020126587, 5337.25278461008, 5401.972990135024], "value": 4714.297608621257, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [336.11098644086394, 352.85356577020536, 356.39946689827644, 358.42114984300355, 358.85825099085844, 5188.584913206943, 5224.817131400402, 5305.814296499619, 5386.73066346683, 5418.376886658036, 5203.9219411708855, 5217.660852044614, 5252.973735131319, 5282.788688452467, 5288.497592728694, 4214.789260536969, 4226.661867050644, 4227.175700738358, 4234.9364759528635, 4255.17024180285, 3979.9204015919663, 4007.5973409306657, 4193.895152621194, 4237.512686041098, 4280.678949078816, 4143.52904718825, 4206.516250631186, 4206.537280899099, 4210.326347784355, 4212.431321771567, 4190.161967606491, 4201.34879093741, 4204.558521355275, 4207.684423668237, 4213.51544572375, 3677.17263615687, 3706.796126213057, 3764.209516001643, 3784.4890939723336, 3786.981065094657, 5104.744762761847, 5135.639055650256, 5162.716050617215, 5167.870803229912, 5175.689458632456, 4814.253790662453, 4820.228763397839, 4827.106985207713, 4827.710337379768, 4836.347093142416, 5367.141257398836, 5519.254900588409, 5532.087205611069, 5554.583406244547, 5563.972180139114, 4096.6313031826985, 4123.731957422758, 4125.938110928309, 4128.525219599755, 4133.6073073058315, 5668.43315668434, 5697.715114244271, 5699.743511541949, 5707.971460142714, 5708.286464191976, 3971.960280397159, 4231.640310573574, 4247.17180149874, 4248.661671573444, 4260.978695106504, 4249.235137675187, 4272.594103560157, 4286.142771445723, 4293.44185255921, 4305.590968857953, 4768.427788665313, 4777.283407488904, 4785.186518291899, 4803.711777293303, 4816.036792641416, 5328.333958255218, 5572.554195664337, 5616.326040875121, 5616.803411880564, 5630.296212973379, 1458.3947661720479, 1479.3948565806006, 1489.8900319262218, 1492.6715223451138, 1501.2418728542234, 942.59468428575, 949.9952500237455, 962.5369438453512, 967.883853937532, 973.956171972263, 4711.764411779397, 4728.243481043017, 4737.4129666562085, 4743.980044290494, 4757.405324334458, 5026.235570436245, 5061.898762024739, 5072.51811077947, 5079.390473143247, 5153.0, 4517.367568540407, 4549.818007279738, 4720.881977950578, 4823.927641085386, 4835.540623640749, 2676.839389636628, 2683.9597406038924, 2694.3802925327286, 2698.4333290008926, 2737.4525094980686, 5145.63640635232, 5183.611229157828, 5185.0037735472115, 5191.922121168185, 5269.420363759983, 4924.581410580141, 4974.9751251243515, 5066.441447069206, 5145.099607568661, 5182.507661772201, 5195.0, 5200.973995130076, 5207.719136943777, 5216.58267338612, 5258.763355649005, 5040.042391945665, 5043.12541851156, 5058.443571207091, 5067.315912351933, 5073.05762657665, 5019.974900125622, 5062.772175252197, 5259.815906443256, 5655.4344565543115, 5708.4862362387585, 5843.328017278068, 5854.502367298827, 5886.38192989747, 5948.196993406008, 5950.0, 3872.941905871358, 3916.941245881371, 3986.362182050858, 3995.360742281221, 3998.540167880731, 5633.549316054788, 5634.464725851038, 5682.289713785777, 5709.68596727184, 5731.713414329183, 5302.231176479312, 5421.972890135524, 5497.367802702581, 5513.8345849624575, 5549.723563580318, 5438.2658341125025, 5439.782408703608, 5463.235147079333, 5464.26232458613, 5511.0, 5364.371457985637, 5371.811986580451, 5373.301470808769, 5414.187871819258, 5422.945770542244, 5338.798770276812, 5510.559155267649, 5517.779288828402, 5531.668099914018, 5559.8888022240135, 5392.838214853561, 5412.646838290428, 5418.807862270294, 5435.2934118564335, 5435.907175737449], "value": 4149.7944965652, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [720.5964659790521, 773.9342155916747, 784.901887264092, 793.2305663506397, 798.1818635898204, 12801.551945681904, 13384.263865487394, 14239.644008899782, 14366.856331436695, 14427.495037673683, 14121.92939035306, 14211.644708882282, 14251.0, 14275.357608907598, 14369.56891293263, 666.8632930249287, 780.7540624703229, 796.4305521552103, 808.107041718898, 808.9676412943476, 803.0323460230437, 819.2053707903355, 821.2034326703118, 821.3552361396305, 821.5892053973014, 850.6980022092162, 851.7785375802305, 854.9871751923695, 855.170484629908, 857.7941294089436, 702.8488874891897, 831.9584020798936, 855.6278019061666, 857.7684025313162, 858.3519442820661, 619.9566030377875, 621.592856678876, 622.1290193728771, 622.2999125983268, 622.7540121651967, 13311.267880266581, 13338.266395348252, 13366.799498007538, 13383.0, 13387.933060334635, 14821.258937053104, 14900.403983840633, 15150.090994540364, 15331.540053798404, 15395.692086158215, 10822.13422926172, 11002.50488728009, 11125.944370278177, 11342.432878356132, 11507.309561426342, 3864.671502922227, 3889.961100388988, 3942.211557688474, 4031.133306339151, 4066.451029111062, 74034.99999999946, 74128.0, 74847.25152748458, 75246.62376688136, 76544.23455765427, 11306.265092768943, 11415.143864210217, 11450.770984580427, 11648.359340236368, 11799.292042477478, 22862.885685571797, 22904.427389315402, 22913.427164320692, 22926.312210633707, 22932.656010159862, 8131.9186808132345, 8315.459495132796, 8370.623321950527, 8411.747647570583, 8573.785655358666, 4592.2193227151465, 4658.930116048262, 4675.8671689967805, 4693.530646935279, 4765.499622539653, 3627.474016267626, 3728.9067773305883, 3729.4965179700935, 3739.0278527583023, 3740.214554943492, 596.1445325957266, 630.6499892559582, 635.3170341882495, 640.9871802563922, 659.9670016499156, 658.1476987301456, 671.2414971082645, 713.8679344321214, 750.598429840033, 773.5436092705331, 9325.953370233105, 9626.855597166048, 9632.9036709632, 9790.0, 9891.653792117386, 678.8065401360589, 722.1226210154582, 727.0548287226584, 729.1214087025122, 759.5746382026083, 4551.453825540956, 4675.57919787214, 4698.95301046992, 4757.144713561714, 4810.735409552508, 72415.27584724085, 73167.0, 120417.0, 123387.0, 125461.82650821532, 109573.0, 109689.0, 110374.0, 111794.0, 113549.99999999834, 96027.51986240024, 96596.0, 97733.0, 98624.0, 98685.59858010535, 9172.541372931193, 9284.860727089233, 9327.906720932704, 9385.783988134386, 9467.621295148117, 51518.0, 52714.47285527096, 54026.0, 54264.18603721026, 55171.44828551663, 55648.0, 66103.0, 68449.65775171093, 68574.3142568568, 79163.60418197872, 11724.58963936258, 12236.510539578318, 12456.564020259248, 13522.323883805968, 13548.525801596898, 12954.740905181656, 13180.340982951006, 13285.535006274735, 13660.590182294547, 13914.02601817863, 14607.19660418687, 14665.92667036658, 14679.633009174857, 14884.10695358282, 15090.54728358151, 13424.664383390493, 13648.522301719393, 13746.725065498835, 13829.30853457303, 14309.284535772962, 13821.79267310971, 13904.51334203298, 14155.858441415867, 14231.359588818736, 14889.16604968002, 11372.943135284602, 11530.884691152982, 11831.526738930346, 11906.0, 11967.222130561486, 10607.893921060999, 10883.564657413932, 11146.944265278946, 11179.944100279447, 11282.548698051985], "value": 7540.500012418882, "unit": "score"}], "name": "dromaeo_css", "value": 7287.365142795618, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 106.0, 110.0, 109.0, 112.0, 109.0, 110.0, 110.0, 109.0, 109.0], "value": 109.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 129.0, 131.0, 179.0, 132.0, 153.0, 155.0, 128.0, 175.0, 125.0], "value": 146.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 161.0, 160.0, 160.0, 161.0, 163.0, 162.0, 162.0, 161.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 117.0, 76.0, 75.0, 74.0, 74.0, 97.0, 75.0], "value": 81.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 116.0, 85.0, 85.0, 85.0, 112.0, 84.0, 85.0, 124.0], "value": 94.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 145.0, 147.0, 146.0, 146.0, 145.0, 146.0, 145.0, 145.0, 147.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 53.0, 52.0, 52.0, 53.0, 54.0, 52.0, 53.0, 52.0], "value": 52.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 61.0, 61.0, 61.0, 61.0, 61.0, 61.0, 61.0], "value": 61.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 85.0, 82.0, 81.0, 82.0, 80.0, 83.0, 116.0, 82.0], "value": 85.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 122.0, 124.0, 129.0, 118.0, 131.0, 128.0, 121.0, 151.0, 130.0], "value": 127.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 164.0, 169.0, 162.0, 161.0, 161.0, 168.0, 161.0, 168.0, 163.0], "value": 164.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 63.0, 63.0, 63.0, 64.0, 66.0, 62.0, 67.0, 66.0, 65.0], "value": 64.6, "unit": "score"}], "name": "kraken", "value": 1505.8, "alertThreshold": 2.0}]} 10:32:34 INFO - Return code: 0 10:32:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:32:34 ERROR - # TBPL SUCCESS # 10:32:34 INFO - Running post-action listener: _resource_record_post_action 10:32:34 INFO - ##### 10:32:34 INFO - ##### Finished run-tests step (success) 10:32:34 INFO - ##### 10:32:34 INFO - Running post-run listener: _resource_record_post_run 10:32:34 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 8192; Write bytes: 409440256; Read time: 212; Write time: 315156 10:32:34 INFO - TinderboxPrint: CPU usage
13.2% 10:32:34 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 212 10:32:34 INFO - TinderboxPrint: I/O write bytes / time
409,440,256 / 315,156 10:32:34 INFO - TinderboxPrint: CPU idle
8,258.5 (86.7%) 10:32:34 INFO - TinderboxPrint: CPU user
1,213.5 (12.7%) 10:32:34 INFO - TinderboxPrint: Swap in / out
0 / 0 10:32:34 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 4096; Write bytes: 121532416; Read time: 124; Write time: 82812 10:32:34 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 287907840; Read time: 88; Write time: 232344 10:32:34 INFO - Running post-run listener: _upload_blobber_files 10:32:34 INFO - Blob upload gear active. 10:32:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:32: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 10:32: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'] 10:32: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 10:32:35 INFO - (blobuploader) - INFO - Open directory for files ... 10:32:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:32:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:32:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:32:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:32:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:32:39 INFO - (blobuploader) - INFO - Done attempting. 10:32:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:32:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:32:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:32:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:32:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:32:39 INFO - (blobuploader) - INFO - Done attempting. 10:32:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:32:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:32:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:32:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:32:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:32:40 INFO - (blobuploader) - INFO - Done attempting. 10:32:40 INFO - (blobuploader) - INFO - Iteration through files over. 10:32:40 INFO - Return code: 0 10:32:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:32:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:32:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a21ad63efc94c957c8799ba03d0171bdaa78b59ab51a2c502ec6deb7d66166a527df87987bdcc2aacf3857befc5d94c488445010a09b629ad534a45944c8f0d5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f85103754315b4bd2c1b97389abb78e65aa48cda5cf71000f7eb3135f5d36d9fb6aefcea9de2d668c8e07faa8296b102a37d297622f823af8ffd527e95db7e81", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5911a243d1e4b9cb7cb20a4442cb3e615863995cc7f137da8ed36257345f5b53861bf8bea86eb9b368022f0d25f3d37006fcad3c905cab3f79db92784eaa5eb2"} 10:32:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:32:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:32:40 INFO - Contents: 10:32:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a21ad63efc94c957c8799ba03d0171bdaa78b59ab51a2c502ec6deb7d66166a527df87987bdcc2aacf3857befc5d94c488445010a09b629ad534a45944c8f0d5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f85103754315b4bd2c1b97389abb78e65aa48cda5cf71000f7eb3135f5d36d9fb6aefcea9de2d668c8e07faa8296b102a37d297622f823af8ffd527e95db7e81", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5911a243d1e4b9cb7cb20a4442cb3e615863995cc7f137da8ed36257345f5b53861bf8bea86eb9b368022f0d25f3d37006fcad3c905cab3f79db92784eaa5eb2"} 10:32:40 INFO - Running post-run listener: copy_logs_to_upload_dir 10:32:40 INFO - Copying logs to upload dir... 10:32:40 INFO - mkdir: /builds/slave/test/build/upload/logs 10:32:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1259.713257 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2016-06-11 10:32:40.323200) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-11 10:32:40.326981) ========= 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=03627c79f6bb3d1578c4a402000001ba-1465655652.265244-548633170 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a21ad63efc94c957c8799ba03d0171bdaa78b59ab51a2c502ec6deb7d66166a527df87987bdcc2aacf3857befc5d94c488445010a09b629ad534a45944c8f0d5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f85103754315b4bd2c1b97389abb78e65aa48cda5cf71000f7eb3135f5d36d9fb6aefcea9de2d668c8e07faa8296b102a37d297622f823af8ffd527e95db7e81", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5911a243d1e4b9cb7cb20a4442cb3e615863995cc7f137da8ed36257345f5b53861bf8bea86eb9b368022f0d25f3d37006fcad3c905cab3f79db92784eaa5eb2"} build_url:https://queue.taskcluster.net/v1/task/Suz4I6w-Tj-gwr5uqz11Dg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011333 build_url: 'https://queue.taskcluster.net/v1/task/Suz4I6w-Tj-gwr5uqz11Dg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a21ad63efc94c957c8799ba03d0171bdaa78b59ab51a2c502ec6deb7d66166a527df87987bdcc2aacf3857befc5d94c488445010a09b629ad534a45944c8f0d5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f85103754315b4bd2c1b97389abb78e65aa48cda5cf71000f7eb3135f5d36d9fb6aefcea9de2d668c8e07faa8296b102a37d297622f823af8ffd527e95db7e81", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5911a243d1e4b9cb7cb20a4442cb3e615863995cc7f137da8ed36257345f5b53861bf8bea86eb9b368022f0d25f3d37006fcad3c905cab3f79db92784eaa5eb2"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-11 10:32:40.353171) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-11 10:32:40.353560) ========= 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=03627c79f6bb3d1578c4a402000001ba-1465655652.265244-548633170 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004487 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-11 10:32:40.437563) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-11 10:32:40.437926) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-11 10:32:40.438254) ========= ========= Total master_lag: 0.18 =========