builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-011 starttime: 1465860219.18 results: success (0) buildid: 20160613133008 builduid: b525de4aa3c34360b0bac3ef66cbc5c9 revision: 823b470e5aacc0c2426d2563197e0ae90a36dd53 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-13 16:23:39.180485) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-13 16:23:39.180971) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-13 16:23:39.181314) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-13 16:23:39.219826) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 16:23:39.220116) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5cf47e208febbcd81da23b2e0000026f-1465859433.571466-1883584488 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-13 16:23: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.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.3M=0s 2016-06-13 16:23:39 (43.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.072762 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 16:23:39.308953) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 16:23:39.309267) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5cf47e208febbcd81da23b2e0000026f-1465859433.571466-1883584488 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023177 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 16:23:39.360162) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-13 16:23:39.360552) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 823b470e5aacc0c2426d2563197e0ae90a36dd53 --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 823b470e5aacc0c2426d2563197e0ae90a36dd53 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5cf47e208febbcd81da23b2e0000026f-1465859433.571466-1883584488 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-13 16:23:39,979 truncating revision to first 12 chars 2016-06-13 16:23:39,979 Setting DEBUG logging. 2016-06-13 16:23:39,979 attempt 1/10 2016-06-13 16:23:39,979 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/823b470e5aac?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-13 16:23:40,816 unpacking tar archive at: mozilla-inbound-823b470e5aac/testing/mozharness/ program finished with exit code 0 elapsedTime=1.191499 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-13 16:23:40.566554) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-13 16:23:40.567256) ========= script_repo_revision: 823b470e5aacc0c2426d2563197e0ae90a36dd53 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-13 16:23:40.568077) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-13 16:23:40.568650) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-13 16:23:40.580145) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-06-13 16:23:40.580507) ========= /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=5cf47e208febbcd81da23b2e0000026f-1465859433.571466-1883584488 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:23:41 INFO - MultiFileLogger online at 20160613 16:23:41 in /builds/slave/test 16:23: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 16:23:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:23:41 INFO - {'append_to_log': False, 16:23:41 INFO - 'base_work_dir': '/builds/slave/test', 16:23:41 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 16:23:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:23:41 INFO - 'branch': 'Mozilla-Inbound', 16:23:41 INFO - 'buildbot_json_path': 'buildprops.json', 16:23:41 INFO - 'config_files': ('talos/linux_config.py',), 16:23:41 INFO - 'default_actions': ('clobber', 16:23:41 INFO - 'read-buildbot-config', 16:23:41 INFO - 'download-and-extract', 16:23:41 INFO - 'populate-webroot', 16:23:41 INFO - 'create-virtualenv', 16:23:41 INFO - 'install', 16:23:41 INFO - 'run-tests'), 16:23:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:23:41 INFO - 'download_minidump_stackwalk': True, 16:23:41 INFO - 'download_symbols': 'ondemand', 16:23:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:23:41 INFO - 'tooltool.py': '/tools/tooltool.py', 16:23:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:23:41 INFO - '/tools/misc-python/virtualenv.py')}, 16:23:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:23:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:23:41 INFO - 'installer_path': 'installer.exe', 16:23:41 INFO - 'log_level': 'info', 16:23:41 INFO - 'log_name': 'talos', 16:23:41 INFO - 'log_to_console': True, 16:23:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:23:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:23:41 INFO - 'opt_config_files': (), 16:23:41 INFO - 'pip_index': False, 16:23:41 INFO - 'sps_profile': False, 16:23:41 INFO - 'sps_profile_interval': 0, 16:23:41 INFO - 'suite': 'dromaeojs', 16:23:41 INFO - 'system_bits': '32', 16:23:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:23:41 INFO - 'title': 'talos-linux64-ix-011', 16:23:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:23:41 INFO - 'use_talos_json': True, 16:23:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:23:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:23:41 INFO - 'work_dir': 'build'} 16:23:41 INFO - ##### 16:23:41 INFO - ##### Running clobber step. 16:23:41 INFO - ##### 16:23:41 INFO - Running pre-action listener: _resource_record_pre_action 16:23:41 INFO - Running main action method: clobber 16:23:41 INFO - rmtree: /builds/slave/test/build 16:23:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:23:41 INFO - Running post-action listener: _resource_record_post_action 16:23:41 INFO - ##### 16:23:41 INFO - ##### Finished clobber step (success) 16:23:41 INFO - ##### 16:23:41 INFO - ##### 16:23:41 INFO - ##### Running read-buildbot-config step. 16:23:41 INFO - ##### 16:23:41 INFO - Running pre-action listener: _resource_record_pre_action 16:23:41 INFO - Running main action method: read_buildbot_config 16:23:41 INFO - Using buildbot properties: 16:23:41 INFO - { 16:23:41 INFO - "project": "", 16:23:41 INFO - "product": "firefox", 16:23:41 INFO - "script_repo_revision": "production", 16:23:41 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 16:23:41 INFO - "repository": "", 16:23:41 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 16:23:41 INFO - "buildid": "20160613133008", 16:23:41 INFO - "pgo_build": "True", 16:23:41 INFO - "basedir": "/builds/slave/test", 16:23:41 INFO - "buildnumber": 1923, 16:23:41 INFO - "slavename": "talos-linux64-ix-011", 16:23:41 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:23:41 INFO - "platform": "ubuntu64_hw", 16:23:41 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 16:23:41 INFO - "branch": "mozilla-inbound", 16:23:41 INFO - "repo_path": "integration/mozilla-inbound", 16:23:41 INFO - "revision": "823b470e5aacc0c2426d2563197e0ae90a36dd53", 16:23:41 INFO - "stage_platform": "linux64-pgo", 16:23:41 INFO - "builduid": "b525de4aa3c34360b0bac3ef66cbc5c9", 16:23:41 INFO - "slavebuilddir": "test" 16:23:41 INFO - } 16:23:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/IGf6dMwcTqWqPLCEMKo0yA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 16:23:41 INFO - Running post-action listener: _resource_record_post_action 16:23:41 INFO - ##### 16:23:41 INFO - ##### Finished read-buildbot-config step (success) 16:23:41 INFO - ##### 16:23:41 INFO - ##### 16:23:41 INFO - ##### Running download-and-extract step. 16:23:41 INFO - ##### 16:23:41 INFO - Running pre-action listener: _resource_record_pre_action 16:23:41 INFO - Running main action method: download_and_extract 16:23:41 INFO - mkdir: /builds/slave/test/build/tests 16:23: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')]} 16:23:41 INFO - https://queue.taskcluster.net/v1/task/IGf6dMwcTqWqPLCEMKo0yA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 16:23:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IGf6dMwcTqWqPLCEMKo0yA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:23:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IGf6dMwcTqWqPLCEMKo0yA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:23:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IGf6dMwcTqWqPLCEMKo0yA/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 16:23:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IGf6dMwcTqWqPLCEMKo0yA/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 16:23:52 INFO - Downloaded 1361 bytes. 16:23:52 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:23:52 INFO - Using the following test package requirements: 16:23:52 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 16:23:52 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:23:52 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:23:52 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:23:52 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:23:52 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:23:52 INFO - u'jsshell-linux-x86_64.zip'], 16:23:52 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:23:52 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:23:52 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 16:23:52 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:23:52 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:23:52 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:23:52 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:23:52 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:23:52 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:23:52 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:23:52 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:23:52 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:23:52 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')]} 16:23:52 INFO - https://queue.taskcluster.net/v1/task/IGf6dMwcTqWqPLCEMKo0yA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:23:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IGf6dMwcTqWqPLCEMKo0yA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:23:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IGf6dMwcTqWqPLCEMKo0yA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:23:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IGf6dMwcTqWqPLCEMKo0yA/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 16:23:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IGf6dMwcTqWqPLCEMKo0yA/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 16:24:06 INFO - Downloaded 24220083 bytes. 16:24: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'] 16:24: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 16:24:07 INFO - Return code: 0 16:24:07 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 16:24: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')]} 16:24:07 INFO - https://queue.taskcluster.net/v1/task/IGf6dMwcTqWqPLCEMKo0yA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:24:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IGf6dMwcTqWqPLCEMKo0yA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:24:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IGf6dMwcTqWqPLCEMKo0yA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:24:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IGf6dMwcTqWqPLCEMKo0yA/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 16:24:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IGf6dMwcTqWqPLCEMKo0yA/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 16:24:08 INFO - Downloaded 24220083 bytes. 16:24:08 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'] 16:24:08 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 16:24:09 INFO - Return code: 0 16:24:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:24:09 INFO - https://queue.taskcluster.net/v1/task/IGf6dMwcTqWqPLCEMKo0yA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:24:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IGf6dMwcTqWqPLCEMKo0yA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 16:24:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IGf6dMwcTqWqPLCEMKo0yA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 16:24:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IGf6dMwcTqWqPLCEMKo0yA/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 16:24:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IGf6dMwcTqWqPLCEMKo0yA/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 16:24:10 INFO - Downloaded 14405384 bytes. 16:24:10 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'] 16:24:10 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 16:24:11 INFO - Return code: 0 16:24:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:24:11 INFO - https://queue.taskcluster.net/v1/task/IGf6dMwcTqWqPLCEMKo0yA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:24:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IGf6dMwcTqWqPLCEMKo0yA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:24:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IGf6dMwcTqWqPLCEMKo0yA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:24:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IGf6dMwcTqWqPLCEMKo0yA/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 16:24:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IGf6dMwcTqWqPLCEMKo0yA/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 16:24:12 INFO - Downloaded 59346061 bytes. 16:24:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IGf6dMwcTqWqPLCEMKo0yA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:24:12 INFO - mkdir: /builds/slave/test/properties 16:24:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:24:12 INFO - Writing to file /builds/slave/test/properties/build_url 16:24:12 INFO - Contents: 16:24:12 INFO - build_url:https://queue.taskcluster.net/v1/task/IGf6dMwcTqWqPLCEMKo0yA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:24:13 INFO - Running post-action listener: _resource_record_post_action 16:24:13 INFO - Running post-action listener: set_extra_try_arguments 16:24:13 INFO - ##### 16:24:13 INFO - ##### Finished download-and-extract step (success) 16:24:13 INFO - ##### 16:24:13 INFO - ##### 16:24:13 INFO - ##### Running populate-webroot step. 16:24:13 INFO - ##### 16:24:13 INFO - Running pre-action listener: _resource_record_pre_action 16:24:13 INFO - Running main action method: populate_webroot 16:24:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:24:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:24:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:24:13 INFO - '--tppagecycles', 16:24:13 INFO - '7'], 16:24:13 INFO - 'tests': ['tsvgm']}}, 16:24:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:24:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:24:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:24:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:24:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:24:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:24:13 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:24:13 INFO - 'talos_options': ['--disable-e10s'], 16:24:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:24:13 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:24:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:24:13 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:24:13 INFO - 'talos_options': ['--disable-e10s'], 16:24:13 INFO - 'tests': ['damp', 'tps']}, 16:24:13 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:24:13 INFO - 'tests': ['damp', 'tps']}, 16:24:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:24:13 INFO - 'tests': ['dromaeo_dom']}, 16:24:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:24:13 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:24:13 INFO - 'tests': ['basic_compositor_video']}, 16:24:13 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:24:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:24:13 INFO - 'tests': ['a11yr', 16:24:13 INFO - 'ts_paint', 16:24:13 INFO - 'tpaint', 16:24:13 INFO - 'sessionrestore', 16:24:13 INFO - 'sessionrestore_no_auto_restore', 16:24:13 INFO - 'tabpaint']}, 16:24:13 INFO - 'other-e10s': {'tests': ['a11yr', 16:24:13 INFO - 'ts_paint', 16:24:13 INFO - 'tpaint', 16:24:13 INFO - 'sessionrestore', 16:24:13 INFO - 'sessionrestore_no_auto_restore', 16:24:13 INFO - 'tabpaint']}, 16:24:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:24:13 INFO - 'ts_paint', 16:24:13 INFO - 'tpaint', 16:24:13 INFO - 'sessionrestore', 16:24:13 INFO - 'sessionrestore_no_auto_restore', 16:24:13 INFO - 'tabpaint']}, 16:24:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:24:13 INFO - 'ts_paint', 16:24:13 INFO - 'tpaint', 16:24:13 INFO - 'sessionrestore', 16:24:13 INFO - 'sessionrestore_no_auto_restore', 16:24:13 INFO - 'tabpaint']}, 16:24:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:24:13 INFO - 'tests': ['a11yr', 16:24:13 INFO - 'ts_paint', 16:24:13 INFO - 'tpaint', 16:24:13 INFO - 'sessionrestore', 16:24:13 INFO - 'sessionrestore_no_auto_restore', 16:24:13 INFO - 'tabpaint']}, 16:24:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:24:13 INFO - 'tests': ['a11yr', 16:24:13 INFO - 'ts_paint', 16:24:13 INFO - 'tpaint', 16:24:13 INFO - 'sessionrestore', 16:24:13 INFO - 'sessionrestore_no_auto_restore', 16:24:13 INFO - 'tabpaint']}, 16:24:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:24:13 INFO - 'tests': ['tsvgx', 16:24:13 INFO - 'tsvgr_opacity', 16:24:13 INFO - 'tart', 16:24:13 INFO - 'tscrollx', 16:24:13 INFO - 'cart']}, 16:24:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:24:13 INFO - 'tsvgr_opacity', 16:24:13 INFO - 'tart', 16:24:13 INFO - 'tscrollx', 16:24:13 INFO - 'cart']}, 16:24:13 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:24:13 INFO - 'talos_options': ['--disable-e10s'], 16:24:13 INFO - 'tests': ['tp5o']}, 16:24:13 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:24:13 INFO - 'tests': ['tp5o']}, 16:24:13 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:24:13 INFO - 'talos_options': ['--disable-e10s', 16:24:13 INFO - '--xperf_path', 16:24:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:24:13 INFO - 'tests': ['tp5n']}, 16:24:13 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:24:13 INFO - 'talos_options': ['--xperf_path', 16:24:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:24:13 INFO - 'tests': ['tp5n']}}, 16:24:13 INFO - 'talos.zip': {'path': '', 16:24:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:24:13 INFO - Running post-action listener: _resource_record_post_action 16:24:13 INFO - ##### 16:24:13 INFO - ##### Finished populate-webroot step (success) 16:24:13 INFO - ##### 16:24:13 INFO - ##### 16:24:13 INFO - ##### Running create-virtualenv step. 16:24:13 INFO - ##### 16:24:13 INFO - Running pre-action listener: _resource_record_pre_action 16:24:13 INFO - Running main action method: create_virtualenv 16:24:13 INFO - Creating virtualenv /builds/slave/test/build/venv 16:24:13 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 16:24:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:24:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:24:13 INFO - Using real prefix '/usr' 16:24:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:24:13 INFO - Installing distribute.............................................................................................................................................................................................done. 16:24:15 INFO - Installing pip.................done. 16:24:15 INFO - Return code: 0 16:24:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:24:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:24:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:24:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:24:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:24:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:24:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:24:15 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 0x7fb67ba73f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a40020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad22e0>, '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 0x2a3e140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a3e5d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1465859433.571466-1883584488', '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 16:24:15 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 16:24:15 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 16:24:15 INFO - Using env: {'DISPLAY': ':0', 16:24:15 INFO - 'HOME': '/home/cltbld', 16:24:15 INFO - 'LANG': 'en_US.UTF-8', 16:24:15 INFO - 'LANGUAGE': 'en_US:en', 16:24:15 INFO - 'LOGNAME': 'cltbld', 16:24:15 INFO - 'MAIL': '/var/mail/cltbld', 16:24:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:24:15 INFO - 'MOZ_NO_REMOTE': '1', 16:24:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:24:15 INFO - 'NO_EM_RESTART': '1', 16:24:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:24:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:24:15 INFO - 'PWD': '/builds/slave/test', 16:24:15 INFO - 'SHELL': '/bin/bash', 16:24:15 INFO - 'SHLVL': '1', 16:24:15 INFO - 'TERM': 'linux', 16:24:15 INFO - 'TMOUT': '86400', 16:24:15 INFO - 'USER': 'cltbld', 16:24:15 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1465859433.571466-1883584488', 16:24:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:24:15 INFO - '_': '/tools/buildbot/bin/python'} 16:24:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:24:15 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 16:24:15 INFO - Cleaning up... 16:24:16 INFO - Return code: 0 16:24:16 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:24:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:24:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:24:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:24:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:24:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:24:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:24:16 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 0x7fb67ba73f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a40020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad22e0>, '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 0x2a3e140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a3e5d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1465859433.571466-1883584488', '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 16:24:16 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 16:24:16 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 16:24:16 INFO - Using env: {'DISPLAY': ':0', 16:24:16 INFO - 'HOME': '/home/cltbld', 16:24:16 INFO - 'LANG': 'en_US.UTF-8', 16:24:16 INFO - 'LANGUAGE': 'en_US:en', 16:24:16 INFO - 'LOGNAME': 'cltbld', 16:24:16 INFO - 'MAIL': '/var/mail/cltbld', 16:24:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:24:16 INFO - 'MOZ_NO_REMOTE': '1', 16:24:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:24:16 INFO - 'NO_EM_RESTART': '1', 16:24:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:24:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:24:16 INFO - 'PWD': '/builds/slave/test', 16:24:16 INFO - 'SHELL': '/bin/bash', 16:24:16 INFO - 'SHLVL': '1', 16:24:16 INFO - 'TERM': 'linux', 16:24:16 INFO - 'TMOUT': '86400', 16:24:16 INFO - 'USER': 'cltbld', 16:24:16 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1465859433.571466-1883584488', 16:24:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:24:16 INFO - '_': '/tools/buildbot/bin/python'} 16:24:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:24:16 INFO - Downloading/unpacking psutil>=3.1.1 16:24:16 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 16:24:16 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 16:24:16 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 16:24:16 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 16:24:16 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 16:24:16 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 16:24:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:24:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:24:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:24:18 INFO - Installing collected packages: psutil 16:24:18 INFO - Running setup.py install for psutil 16:24:18 INFO - building 'psutil._psutil_linux' extension 16:24:18 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 16:24:18 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 16:24:18 INFO - building 'psutil._psutil_posix' extension 16:24:18 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 16:24:18 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 16:24:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:24:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:24:18 INFO - Successfully installed psutil 16:24:18 INFO - Cleaning up... 16:24:18 INFO - Return code: 0 16:24:18 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:24: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')]} 16:24:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:24:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:24: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')]} 16:24:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:24:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:24: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb67ba73f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a40020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad22e0>, '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 0x2a3e140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a3e5d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1465859433.571466-1883584488', '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 16:24: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:24: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 mozsystemmonitor==0.3 16:24:18 INFO - Using env: {'DISPLAY': ':0', 16:24:18 INFO - 'HOME': '/home/cltbld', 16:24:18 INFO - 'LANG': 'en_US.UTF-8', 16:24:18 INFO - 'LANGUAGE': 'en_US:en', 16:24:18 INFO - 'LOGNAME': 'cltbld', 16:24:18 INFO - 'MAIL': '/var/mail/cltbld', 16:24:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:24:18 INFO - 'MOZ_NO_REMOTE': '1', 16:24:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:24:18 INFO - 'NO_EM_RESTART': '1', 16:24:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:24:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:24:18 INFO - 'PWD': '/builds/slave/test', 16:24:18 INFO - 'SHELL': '/bin/bash', 16:24:18 INFO - 'SHLVL': '1', 16:24:18 INFO - 'TERM': 'linux', 16:24:18 INFO - 'TMOUT': '86400', 16:24:18 INFO - 'USER': 'cltbld', 16:24:18 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1465859433.571466-1883584488', 16:24:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:24:18 INFO - '_': '/tools/buildbot/bin/python'} 16:24:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:24:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:24:18 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 16:24:18 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 16:24:18 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 16:24:18 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 16:24:18 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 16:24:18 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 16:24:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:24:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:24:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:24:20 INFO - Installing collected packages: mozsystemmonitor 16:24:20 INFO - Running setup.py install for mozsystemmonitor 16:24:20 INFO - Successfully installed mozsystemmonitor 16:24:20 INFO - Cleaning up... 16:24:21 INFO - Return code: 0 16:24:21 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:24: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')]} 16:24:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:24:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:24: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')]} 16:24:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:24:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:24: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', '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 0x7fb67ba73f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a40020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad22e0>, '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 0x2a3e140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a3e5d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1465859433.571466-1883584488', '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 16:24: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:24: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 jsonschema==2.5.1 16:24:21 INFO - Using env: {'DISPLAY': ':0', 16:24:21 INFO - 'HOME': '/home/cltbld', 16:24:21 INFO - 'LANG': 'en_US.UTF-8', 16:24:21 INFO - 'LANGUAGE': 'en_US:en', 16:24:21 INFO - 'LOGNAME': 'cltbld', 16:24:21 INFO - 'MAIL': '/var/mail/cltbld', 16:24:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:24:21 INFO - 'MOZ_NO_REMOTE': '1', 16:24:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:24:21 INFO - 'NO_EM_RESTART': '1', 16:24:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:24:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:24:21 INFO - 'PWD': '/builds/slave/test', 16:24:21 INFO - 'SHELL': '/bin/bash', 16:24:21 INFO - 'SHLVL': '1', 16:24:21 INFO - 'TERM': 'linux', 16:24:21 INFO - 'TMOUT': '86400', 16:24:21 INFO - 'USER': 'cltbld', 16:24:21 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1465859433.571466-1883584488', 16:24:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:24:21 INFO - '_': '/tools/buildbot/bin/python'} 16:24:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:24:21 INFO - Downloading/unpacking jsonschema==2.5.1 16:24: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 16:24: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 16:24: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 16:24: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 16:24: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 16:24: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 16:24:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:24:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:24:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:24:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:24:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:24:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:24:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:24:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:24:23 INFO - Downloading functools32-3.2.3-2.tar.gz 16:24:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:24:23 INFO - warning: no files found matching '*.txt' 16:24:23 INFO - no previously-included directories found matching 'build' 16:24:23 INFO - no previously-included directories found matching 'dist' 16:24:23 INFO - no previously-included directories found matching '.git*' 16:24:23 INFO - Installing collected packages: jsonschema, functools32 16:24:23 INFO - Running setup.py install for functools32 16:24:23 INFO - warning: no files found matching '*.txt' 16:24:23 INFO - no previously-included directories found matching 'build' 16:24:23 INFO - no previously-included directories found matching 'dist' 16:24:23 INFO - no previously-included directories found matching '.git*' 16:24:23 INFO - Successfully installed jsonschema functools32 16:24:23 INFO - Cleaning up... 16:24:23 INFO - Return code: 0 16:24:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:24: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')]} 16:24:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:24:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:24: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')]} 16:24:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:24:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:24: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', '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 0x7fb67ba73f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a40020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad22e0>, '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 0x2a3e140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a3e5d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1465859433.571466-1883584488', '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 16:24: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:24: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 blobuploader==1.2.4 16:24:23 INFO - Using env: {'DISPLAY': ':0', 16:24:23 INFO - 'HOME': '/home/cltbld', 16:24:23 INFO - 'LANG': 'en_US.UTF-8', 16:24:23 INFO - 'LANGUAGE': 'en_US:en', 16:24:23 INFO - 'LOGNAME': 'cltbld', 16:24:23 INFO - 'MAIL': '/var/mail/cltbld', 16:24:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:24:23 INFO - 'MOZ_NO_REMOTE': '1', 16:24:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:24:23 INFO - 'NO_EM_RESTART': '1', 16:24:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:24:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:24:23 INFO - 'PWD': '/builds/slave/test', 16:24:23 INFO - 'SHELL': '/bin/bash', 16:24:23 INFO - 'SHLVL': '1', 16:24:23 INFO - 'TERM': 'linux', 16:24:23 INFO - 'TMOUT': '86400', 16:24:23 INFO - 'USER': 'cltbld', 16:24:23 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1465859433.571466-1883584488', 16:24:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:24:23 INFO - '_': '/tools/buildbot/bin/python'} 16:24:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:24:23 INFO - Downloading/unpacking blobuploader==1.2.4 16:24:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:24:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:24:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:24:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:24:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:24:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:24:25 INFO - Downloading blobuploader-1.2.4.tar.gz 16:24:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:24:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:24:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:24:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:24:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:24:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:24:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:24:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:24:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:24:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:24: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 16:24: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 16:24: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 16:24: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 16:24: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 16:24: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 16:24:26 INFO - Downloading docopt-0.6.1.tar.gz 16:24:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:24:26 INFO - Installing collected packages: blobuploader, requests, docopt 16:24:26 INFO - Running setup.py install for blobuploader 16:24:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:24:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:24:26 INFO - Running setup.py install for requests 16:24:26 INFO - Running setup.py install for docopt 16:24:26 INFO - Successfully installed blobuploader requests docopt 16:24:26 INFO - Cleaning up... 16:24:27 INFO - Return code: 0 16:24:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:24:27 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')]} 16:24:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:24:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:24:27 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')]} 16:24:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:24:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:24:27 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 0x7fb67ba73f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a40020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad22e0>, '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 0x2a3e140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a3e5d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1465859433.571466-1883584488', '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 16:24:27 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 16:24:27 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 16:24:27 INFO - Using env: {'DISPLAY': ':0', 16:24:27 INFO - 'HOME': '/home/cltbld', 16:24:27 INFO - 'LANG': 'en_US.UTF-8', 16:24:27 INFO - 'LANGUAGE': 'en_US:en', 16:24:27 INFO - 'LOGNAME': 'cltbld', 16:24:27 INFO - 'MAIL': '/var/mail/cltbld', 16:24:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:24:27 INFO - 'MOZ_NO_REMOTE': '1', 16:24:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:24:27 INFO - 'NO_EM_RESTART': '1', 16:24:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:24:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:24:27 INFO - 'PWD': '/builds/slave/test', 16:24:27 INFO - 'SHELL': '/bin/bash', 16:24:27 INFO - 'SHLVL': '1', 16:24:27 INFO - 'TERM': 'linux', 16:24:27 INFO - 'TMOUT': '86400', 16:24:27 INFO - 'USER': 'cltbld', 16:24:27 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1465859433.571466-1883584488', 16:24:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:24:27 INFO - '_': '/tools/buildbot/bin/python'} 16:24:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:24:27 INFO - Running setup.py (path:/tmp/pip-eEr8xS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:24:27 INFO - Running setup.py (path:/tmp/pip-t6LM01-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:24:27 INFO - Running setup.py (path:/tmp/pip-RiMqax-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:24:27 INFO - Running setup.py (path:/tmp/pip-q6XqWX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:24:27 INFO - Running setup.py (path:/tmp/pip-TTnPaO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:24:27 INFO - Running setup.py (path:/tmp/pip-mMGyf9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:24:27 INFO - Running setup.py (path:/tmp/pip-GW0CFx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:24:27 INFO - Running setup.py (path:/tmp/pip-3oraeh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:24:27 INFO - Running setup.py (path:/tmp/pip-Vxz_lA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:24:27 INFO - Running setup.py (path:/tmp/pip-WIYHWH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:24:27 INFO - Running setup.py (path:/tmp/pip-48bahg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:24:28 INFO - Running setup.py (path:/tmp/pip-FTGEc8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:24:28 INFO - Running setup.py (path:/tmp/pip-_kgRkS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:24:28 INFO - Running setup.py (path:/tmp/pip-Q0qkus-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:24:28 INFO - Running setup.py (path:/tmp/pip-PCdqPf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:24:28 INFO - Running setup.py (path:/tmp/pip-ewmV38-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:24:28 INFO - Running setup.py (path:/tmp/pip-1Mjrlk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:24:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:24:28 INFO - Running setup.py install for manifestparser 16:24:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:24:28 INFO - Running setup.py install for mozcrash 16:24:28 INFO - Running setup.py install for mozdebug 16:24:28 INFO - Running setup.py install for mozdevice 16:24:28 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:24:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:24:28 INFO - Running setup.py install for mozfile 16:24:28 INFO - Running setup.py install for mozhttpd 16:24:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:24:29 INFO - Running setup.py install for mozinfo 16:24:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:24:29 INFO - Running setup.py install for mozInstall 16:24:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:24:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:24:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:24:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:24:29 INFO - Running setup.py install for mozleak 16:24:29 INFO - Running setup.py install for mozlog 16:24:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:24:29 INFO - Running setup.py install for moznetwork 16:24:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:24:29 INFO - Running setup.py install for mozprocess 16:24:29 INFO - Running setup.py install for mozprofile 16:24:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:24:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:24:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:24:29 INFO - Running setup.py install for mozrunner 16:24:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:24:29 INFO - Running setup.py install for mozscreenshot 16:24:30 INFO - Running setup.py install for moztest 16:24:30 INFO - Running setup.py install for mozversion 16:24:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:24:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:24:30 INFO - Cleaning up... 16:24:30 INFO - Return code: 0 16:24:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:24:30 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')]} 16:24:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:24:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:24:30 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')]} 16:24:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:24:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:24:30 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 0x7fb67ba73f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a40020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad22e0>, '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 0x2a3e140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a3e5d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1465859433.571466-1883584488', '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 16:24:30 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 16:24:30 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 16:24:30 INFO - Using env: {'DISPLAY': ':0', 16:24:30 INFO - 'HOME': '/home/cltbld', 16:24:30 INFO - 'LANG': 'en_US.UTF-8', 16:24:30 INFO - 'LANGUAGE': 'en_US:en', 16:24:30 INFO - 'LOGNAME': 'cltbld', 16:24:30 INFO - 'MAIL': '/var/mail/cltbld', 16:24:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:24:30 INFO - 'MOZ_NO_REMOTE': '1', 16:24:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:24:30 INFO - 'NO_EM_RESTART': '1', 16:24:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:24:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:24:30 INFO - 'PWD': '/builds/slave/test', 16:24:30 INFO - 'SHELL': '/bin/bash', 16:24:30 INFO - 'SHLVL': '1', 16:24:30 INFO - 'TERM': 'linux', 16:24:30 INFO - 'TMOUT': '86400', 16:24:30 INFO - 'USER': 'cltbld', 16:24:30 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1465859433.571466-1883584488', 16:24:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:24:30 INFO - '_': '/tools/buildbot/bin/python'} 16:24:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:24:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:24:30 INFO - Running setup.py (path:/tmp/pip-rFaZpf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:24:30 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)) 16:24:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:24:30 INFO - Running setup.py (path:/tmp/pip-8_so2H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:24:30 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)) 16:24:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:24:30 INFO - Running setup.py (path:/tmp/pip-s0JuNa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:24:30 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)) 16:24:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:24:30 INFO - Running setup.py (path:/tmp/pip-3plYsi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:24:30 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)) 16:24:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:24:30 INFO - Running setup.py (path:/tmp/pip-pMAq6D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:24:30 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)) 16:24:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:24:30 INFO - Running setup.py (path:/tmp/pip-FMDh9J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:24:30 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)) 16:24:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:24:30 INFO - Running setup.py (path:/tmp/pip-ZNjcyw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:24:30 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)) 16:24:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:24:30 INFO - Running setup.py (path:/tmp/pip-zoKzok-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:24:31 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)) 16:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:24:31 INFO - Running setup.py (path:/tmp/pip-wI9lZR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:24:31 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)) 16:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:24:31 INFO - Running setup.py (path:/tmp/pip-Q2SsVv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:24:31 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)) 16:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:24:31 INFO - Running setup.py (path:/tmp/pip-3kpZtT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:24:31 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)) 16:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:24:31 INFO - Running setup.py (path:/tmp/pip-kXErx0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:24:31 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)) 16:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:24:31 INFO - Running setup.py (path:/tmp/pip-057nvA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:24:31 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)) 16:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:24:31 INFO - Running setup.py (path:/tmp/pip-uBCfWI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:24:31 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)) 16:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:24:31 INFO - Running setup.py (path:/tmp/pip-mY5gza-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:24:31 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)) 16:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:24:31 INFO - Running setup.py (path:/tmp/pip-e9t6HP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:24:31 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)) 16:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:24:31 INFO - Running setup.py (path:/tmp/pip-p9ZaRW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:24:31 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)) 16:24:31 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)) 16:24:31 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)) 16:24:31 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)) 16:24:31 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)) 16:24:31 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)) 16:24:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:24:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:24:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:24:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:24:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:24:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:24:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:24:33 INFO - Downloading blessings-1.6.tar.gz 16:24:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:24:33 INFO - Installing collected packages: blessings 16:24:33 INFO - Running setup.py install for blessings 16:24:33 INFO - Successfully installed blessings 16:24:33 INFO - Cleaning up... 16:24:33 INFO - Return code: 0 16:24:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:24:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:24:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:24:34 INFO - Reading from file tmpfile_stdout 16:24:34 INFO - Current package versions: 16:24:34 INFO - argparse == 1.2.1 16:24:34 INFO - blessings == 1.6 16:24:34 INFO - blobuploader == 1.2.4 16:24:34 INFO - docopt == 0.6.1 16:24:34 INFO - functools32 == 3.2.3-2 16:24:34 INFO - jsonschema == 2.5.1 16:24:34 INFO - manifestparser == 1.1 16:24:34 INFO - mozInstall == 1.12 16:24:34 INFO - mozcrash == 0.17 16:24:34 INFO - mozdebug == 0.1 16:24:34 INFO - mozdevice == 0.48 16:24:34 INFO - mozfile == 1.2 16:24:34 INFO - mozhttpd == 0.7 16:24:34 INFO - mozinfo == 0.9 16:24:34 INFO - mozleak == 0.1 16:24:34 INFO - mozlog == 3.2 16:24:34 INFO - moznetwork == 0.27 16:24:34 INFO - mozprocess == 0.22 16:24:34 INFO - mozprofile == 0.28 16:24:34 INFO - mozrunner == 6.11 16:24:34 INFO - mozscreenshot == 0.1 16:24:34 INFO - mozsystemmonitor == 0.3 16:24:34 INFO - moztest == 0.7 16:24:34 INFO - mozversion == 1.4 16:24:34 INFO - psutil == 3.1.1 16:24:34 INFO - requests == 1.2.3 16:24:34 INFO - wsgiref == 0.1.2 16:24:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:24:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:24:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:24:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:24:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:24:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:24:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:24:34 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 0x7fb67ba73f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a40020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad22e0>, '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 0x2a3e140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a3e5d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1465859433.571466-1883584488', '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 16:24:34 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 16:24:34 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 16:24:34 INFO - Using env: {'DISPLAY': ':0', 16:24:34 INFO - 'HOME': '/home/cltbld', 16:24:34 INFO - 'LANG': 'en_US.UTF-8', 16:24:34 INFO - 'LANGUAGE': 'en_US:en', 16:24:34 INFO - 'LOGNAME': 'cltbld', 16:24:34 INFO - 'MAIL': '/var/mail/cltbld', 16:24:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:24:34 INFO - 'MOZ_NO_REMOTE': '1', 16:24:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:24:34 INFO - 'NO_EM_RESTART': '1', 16:24:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:24:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:24:34 INFO - 'PWD': '/builds/slave/test', 16:24:34 INFO - 'SHELL': '/bin/bash', 16:24:34 INFO - 'SHLVL': '1', 16:24:34 INFO - 'TERM': 'linux', 16:24:34 INFO - 'TMOUT': '86400', 16:24:34 INFO - 'USER': 'cltbld', 16:24:34 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1465859433.571466-1883584488', 16:24:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:24:34 INFO - '_': '/tools/buildbot/bin/python'} 16:24:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:24:34 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)) 16:24:34 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)) 16:24:34 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)) 16:24:34 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)) 16:24:34 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)) 16:24:34 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)) 16:24:34 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)) 16:24:34 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)) 16:24:34 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)) 16:24:34 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)) 16:24:34 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)) 16:24:34 INFO - Cleaning up... 16:24:34 INFO - Return code: 0 16:24:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:24:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:24:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:24:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:24:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:24:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:24:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:24:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb67ba73f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a40020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad22e0>, '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 0x2a3e140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a3e5d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1465859433.571466-1883584488', '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 16:24:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:24:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:24:34 INFO - Using env: {'DISPLAY': ':0', 16:24:34 INFO - 'HOME': '/home/cltbld', 16:24:34 INFO - 'LANG': 'en_US.UTF-8', 16:24:34 INFO - 'LANGUAGE': 'en_US:en', 16:24:34 INFO - 'LOGNAME': 'cltbld', 16:24:34 INFO - 'MAIL': '/var/mail/cltbld', 16:24:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:24:34 INFO - 'MOZ_NO_REMOTE': '1', 16:24:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:24:34 INFO - 'NO_EM_RESTART': '1', 16:24:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:24:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:24:34 INFO - 'PWD': '/builds/slave/test', 16:24:34 INFO - 'SHELL': '/bin/bash', 16:24:34 INFO - 'SHLVL': '1', 16:24:34 INFO - 'TERM': 'linux', 16:24:34 INFO - 'TMOUT': '86400', 16:24:34 INFO - 'USER': 'cltbld', 16:24:34 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1465859433.571466-1883584488', 16:24:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:24:34 INFO - '_': '/tools/buildbot/bin/python'} 16:24:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:24:34 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:24:34 INFO - Cleaning up... 16:24:34 INFO - Return code: 0 16:24:34 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:24:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:24:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:24:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:24:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:24:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:24:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:24:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb67ba73f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a40020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad22e0>, '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 0x2a3e140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a3e5d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1465859433.571466-1883584488', '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 16:24:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 16:24:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 16:24:34 INFO - Using env: {'DISPLAY': ':0', 16:24:34 INFO - 'HOME': '/home/cltbld', 16:24:34 INFO - 'LANG': 'en_US.UTF-8', 16:24:34 INFO - 'LANGUAGE': 'en_US:en', 16:24:34 INFO - 'LOGNAME': 'cltbld', 16:24:34 INFO - 'MAIL': '/var/mail/cltbld', 16:24:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:24:34 INFO - 'MOZ_NO_REMOTE': '1', 16:24:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:24:34 INFO - 'NO_EM_RESTART': '1', 16:24:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:24:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:24:34 INFO - 'PWD': '/builds/slave/test', 16:24:34 INFO - 'SHELL': '/bin/bash', 16:24:34 INFO - 'SHLVL': '1', 16:24:34 INFO - 'TERM': 'linux', 16:24:34 INFO - 'TMOUT': '86400', 16:24:34 INFO - 'USER': 'cltbld', 16:24:34 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1465859433.571466-1883584488', 16:24:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:24:34 INFO - '_': '/tools/buildbot/bin/python'} 16:24:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:24:34 INFO - Downloading/unpacking flake8 16:24: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 16:24: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 16:24: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 16:24: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 16:24: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 16:24: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 16:24:36 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:24:36 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:24:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:24:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:24:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:24:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:24:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:24:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:24:36 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:24:36 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:24:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:24:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:24:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:24:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:24:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:24:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:24:37 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:24: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 16:24: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 16:24: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 16:24: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 16:24: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 16:24: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 16:24:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:24:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:24:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:24:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:24:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:24:37 INFO - no previously-included directories found matching 'docs/_build' 16:24:37 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:24:37 INFO - Running setup.py install for pep8 16:24:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:24:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:24:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:24:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:24:37 INFO - no previously-included directories found matching 'docs/_build' 16:24:37 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:24:37 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:24:37 INFO - Cleaning up... 16:24:37 INFO - Return code: 0 16:24:37 INFO - Running post-action listener: _resource_record_post_action 16:24:37 INFO - Running post-action listener: _start_resource_monitoring 16:24:37 INFO - Starting resource monitoring. 16:24:37 INFO - ##### 16:24:37 INFO - ##### Finished create-virtualenv step (success) 16:24:37 INFO - ##### 16:24:37 INFO - ##### 16:24:37 INFO - ##### Running install step. 16:24:37 INFO - ##### 16:24:37 INFO - Running pre-action listener: _resource_record_pre_action 16:24:37 INFO - Running main action method: install 16:24:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:24:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:24:37 INFO - Reading from file tmpfile_stdout 16:24:37 INFO - Detecting whether we're running mozinstall >=1.0... 16:24:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:24:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:24:37 INFO - Reading from file tmpfile_stdout 16:24:37 INFO - Output received: 16:24:37 INFO - Usage: mozinstall [options] installer 16:24:37 INFO - Options: 16:24:37 INFO - -h, --help show this help message and exit 16:24:37 INFO - -d DEST, --destination=DEST 16:24:37 INFO - Directory to install application into. [default: 16:24:37 INFO - "/builds/slave/test"] 16:24:37 INFO - --app=APP Application being installed. [default: firefox] 16:24:37 INFO - mkdir: /builds/slave/test/build/application 16:24:37 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'] 16:24:37 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 16:24:56 INFO - Reading from file tmpfile_stdout 16:24:56 INFO - Output received: 16:24:56 INFO - /builds/slave/test/build/application/firefox/firefox 16:24:56 INFO - Running post-action listener: _resource_record_post_action 16:24:56 INFO - ##### 16:24:56 INFO - ##### Finished install step (success) 16:24:56 INFO - ##### 16:24:56 INFO - ##### 16:24:56 INFO - ##### Running run-tests step. 16:24:56 INFO - ##### 16:24:56 INFO - Running pre-action listener: _resource_record_pre_action 16:24:56 INFO - Running main action method: run_tests 16:24:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:24:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:24:56 INFO - Python 2.7.3 16:24:56 INFO - Return code: 0 16:24:56 INFO - grabbing minidump binary from tooltool 16:24:56 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')]} 16:24:56 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 0x2ad22e0>, '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 0x2a3e140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a3e5d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:24:56 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 16:24:56 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 16:24:56 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 16:24:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:24:56 INFO - Return code: 0 16:24:56 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:24:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:24:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:24:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:24:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:24:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:24:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:24:57 INFO - Return code: 0 16:24:57 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/IGf6dMwcTqWqPLCEMKo0yA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 16:24:57 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/IGf6dMwcTqWqPLCEMKo0yA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-011 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 16:24:57 INFO - Using env: {'DISPLAY': ':0', 16:24:57 INFO - 'HOME': '/home/cltbld', 16:24:57 INFO - 'LANG': 'en_US.UTF-8', 16:24:57 INFO - 'LANGUAGE': 'en_US:en', 16:24:57 INFO - 'LOGNAME': 'cltbld', 16:24:57 INFO - 'MAIL': '/var/mail/cltbld', 16:24:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:24:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:24:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:24:57 INFO - 'MOZ_NO_REMOTE': '1', 16:24:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:24:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:24:57 INFO - 'NO_EM_RESTART': '1', 16:24:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:24:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:24:57 INFO - 'PWD': '/builds/slave/test', 16:24:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:24:57 INFO - 'SHELL': '/bin/bash', 16:24:57 INFO - 'SHLVL': '1', 16:24:57 INFO - 'TERM': 'linux', 16:24:57 INFO - 'TMOUT': '86400', 16:24:57 INFO - 'USER': 'cltbld', 16:24:57 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1465859433.571466-1883584488', 16:24:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:24:57 INFO - '_': '/tools/buildbot/bin/python'} 16:24:57 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/IGf6dMwcTqWqPLCEMKo0yA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 16:24:57 INFO - mozversion application_buildid: 20160613133008 16:24:57 INFO - mozversion application_changeset: 823b470e5aacc0c2426d2563197e0ae90a36dd53 16:24:57 INFO - mozversion application_display_name: Nightly 16:24:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:24:57 INFO - mozversion application_name: Firefox 16:24:57 INFO - mozversion application_remotingname: firefox 16:24:57 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 16:24:57 INFO - mozversion application_vendor: Mozilla 16:24:57 INFO - mozversion application_version: 50.0a1 16:24:57 INFO - mozversion platform_buildid: 20160613133008 16:24:57 INFO - mozversion platform_changeset: 823b470e5aacc0c2426d2563197e0ae90a36dd53 16:24:57 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 16:24:57 INFO - mozversion platform_version: 50.0a1 16:24:57 INFO - using testdate: 1465860297 16:24:57 INFO - actual date: 1465860297 16:24:57 INFO - starting webserver on 'localhost:34937' 16:24:57 INFO - SUITE-START | Running 2 tests 16:24:57 INFO - TEST-START | dromaeo_css 16:24:57 INFO - operating with platform_type : linux_ 16:24:57 INFO - Initialising browser for dromaeo_css test... 16:24:57 INFO - TEST-INFO | started process 19613 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaLUeHT/profile http://localhost:34937/getInfo.html) 16:25:02 INFO - PROCESS | 19613 | __metrics Screen width/height:1600/1200 16:25:02 INFO - PROCESS | 19613 | colorDepth:24 16:25:02 INFO - PROCESS | 19613 | Browser inner width/height: 1024/697 16:25:02 INFO - PROCESS | 19613 | __metrics 16:25:04 INFO - PROCESS | 19613 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:25:04 INFO - PROCESS | 19613 | console.error: PushService: 16:25:04 INFO - PROCESS | 19613 | stateChangeProcessEnqueue: Error transitioning state 16:25:04 INFO - PROCESS | 19613 | UnknownError 16:25:05 INFO - TEST-INFO | 19613: exit 0 16:25:05 INFO - Browser initialized. 16:25:05 INFO - Running cycle 1/1 for dromaeo_css test... 16:25:05 INFO - TEST-INFO | started process 19694 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaLUeHT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:25:17 INFO - PROCESS | 19694 | RSS: Main: 177377280 16:25:17 INFO - PROCESS | 19694 | 16:26:08 INFO - PROCESS | 19694 | 1465860368861 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] 16:28:17 INFO - PROCESS | 19694 | Cycle 1(1): loaded http://localhost:34937/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34937/tests/dromaeo/cssquery-ext.html) 16:28:18 INFO - PROCESS | 19694 | RSS: Main: 267382784 16:28:18 INFO - PROCESS | 19694 | 16:31:20 INFO - PROCESS | 19694 | Cycle 1(1): loaded http://localhost:34937/tests/dromaeo/cssquery-ext.html (next: http://localhost:34937/tests/dromaeo/cssquery-jquery.html) 16:31:21 INFO - PROCESS | 19694 | RSS: Main: 261697536 16:31:21 INFO - PROCESS | 19694 | 16:34:22 INFO - PROCESS | 19694 | Cycle 1(1): loaded http://localhost:34937/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34937/tests/dromaeo/cssquery-mootools.html) 16:34:23 INFO - PROCESS | 19694 | RSS: Main: 263954432 16:34:23 INFO - PROCESS | 19694 | 16:37:25 INFO - PROCESS | 19694 | Cycle 1(1): loaded http://localhost:34937/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34937/tests/dromaeo/cssquery-prototype.html) 16:37:26 INFO - PROCESS | 19694 | RSS: Main: 255561728 16:37:26 INFO - PROCESS | 19694 | 16:40:28 INFO - PROCESS | 19694 | Cycle 1(1): loaded http://localhost:34937/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34937/tests/dromaeo/cssquery-yui.html) 16:40:29 INFO - PROCESS | 19694 | RSS: Main: 245833728 16:40:29 INFO - PROCESS | 19694 | 16:43:32 INFO - PROCESS | 19694 | Cycle 1(1): loaded http://localhost:34937/tests/dromaeo/cssquery-yui.html (next: http://localhost:34937/tests/dromaeo/cssquery-dojo.html) 16:43:32 INFO - PROCESS | 19694 | RSS: Main: 299483136 16:43:32 INFO - PROCESS | 19694 | 16:43:32 INFO - PROCESS | 19694 | __start_tp_report 16:43:32 INFO - PROCESS | 19694 | _x_x_mozilla_page_load 16:43:32 INFO - PROCESS | 19694 | _x_x_mozilla_page_load_details 16:43:32 INFO - PROCESS | 19694 | |i|pagename|runs| 16:43:32 INFO - PROCESS | 19694 | |0;dojo.html;3105.192649911024;3119.9999999999995;3135.1691801672555;3145.5281707743848;3170.1440611035023;5132.3327967364285;5251.842444726664;5311.707856067915;5392.191171324298;5441.129419292914;5291.365036195662;5308.23030660554;5324.7071411072375;5360.169173778061;5389.245505629215;4733.100710864933;4781.928271075936;4886.584640305578;4956.306117143603;5036.169032109716;4926.507349265081;4958.157113290749;4964.751762411883;4978;4978.303037574742;4719;4765.380500534943;4803.279508073782;4869.4156701195725;4889.266610008527;4877.658563900528;4880.072786170616;4885.487023862479;4885.998370334073;4928.581070609002;4823.807047718087;4851.854444366674;4860.781264843091;4875.293082503053;4905.950940490585;5130.204818253177;5177.58579313654;5244.370675518924;5275.57795376369;5362.302900622933;5676.886462270772;5723.313202415737;5735.827925162252;5739.139129130622;5792.855178620526;5579.023670857584;5803.912941305884;5832.1834943108;5842.298924129132;5850.6489610623075;5306.734663266821;5348.277982472356;5358.169483730028;5420.295361602966;5423.023855706011;5852.385499522574;5891.734871930774;5892.823215303548;5901.232839730807;5940.851478713067;5396.64921780083;5574.442555744393;5690.658560486384;5695.6582605043;5697.886042279214;5690.345610254791;5749.626274292157;5750.88498230033;5752.338481074647;5807.448292412214;5723.599348045597;5736.42635736423;5742.109972954198;5742.28221472316;5746.367899531048;5489.780408783604;5581.2186293918885;5655.4910058094965;5724.4561766632105;5725.742341594639;4391.8682439526865;4393.253146965024;4394.956050439455;4433;4434.068845542472;3898.9610103899167;3908.394198899175;3911.7261791674878;3911.7848518331766;3942.42834788954;5179.04187725272;5225;5364.7317634118135;5385.434529374437;5393.919091213635;5766.798162064391;5784.94215057844;5786.681732504669;5795.594308398372;5830.941690583039;5390.838274851761;5423.29497165366;5423.593230507728;5423.647462914977;5452.454754524516;4784.976075119602;4911.508849115131;4961.950380496149;4971.751412429364;4999.0501804657;5972.970135149297;5975.043992961192;5982.521398288127;5984.162217289496;5992.520598352121;5577.8047768327915;5769.278840144982;5779.826605201851;5782.942170578409;5785.623934444247;5851.736671849862;5916.171735956884;5924.496417804535;5954.46409823118;5961.225040744675;5660.716964151694;5662.377138514842;5668.37647858727;5671;5675.460831221028;5511.669299842022;5663.292088488939;5729.083346664514;5730.74211660468;5732.885342293214;5469.617126801086;5526.530244929065;5564.248826408545;5611.270534830446;5613.438656134354;5523.779048838162;5577.888442231214;5578.665280083208;5585.804496842591;5613.607047506635;5316.946830531645;5317.096093664164;5522.779088836563;5526.41972592888;5570.192322113352;5444.3194600674915;5524.640898341756;5534.695591742493;5539.390667026543;5572.164175373727;5346.278252436027;5366.785328586813;5370.409254981871;5397.59518036141;5404.621676482609 16:43:32 INFO - PROCESS | 19694 | |1;ext.html;585.9355470898203;598.2432223237608;610.7709608896664;611.1382950040442;631.5736877607617;33197.66802331976;36234.63765362345;44173.116537669266;44726.32910506345;44924.77537612316;46218;46435.30347044797;46638.06723865529;46794.53205467945;46807.76596117023;8978.057303983069;9115.726528204164;9141.222996045344;9145.862812057825;9147.817043659123;8986.955065224665;9101.408408453462;9101.726948191532;9102.408343457688;9102.77243068922;9086.50024248666;9145.314101442385;9146.085391460834;9149.5882685279;9154.49650269235;9044.502552359618;9077.727668169966;9099.81800363989;9106.681266155652;9108.544572771369;8940.597673104661;8994.055624159435;8998.325125615605;9006.459612423276;9008.099190081006;42875.14249715019;43029.139417211794;43227.35158972618;43280.35079473811;43282.78358608187;3584.2473080653094;3762.567304759933;3930.744501607386;4027.577104404025;4193.077522944947;33047.48585278945;33120.50319245189;33208.833955830065;33690.1577460563;34589;4334.566543345672;4336.850858262883;4366.781660916973;4427.026054268056;4495.64034877209;336133.99999999756;338881;340370;341200;341560;56965.43034569684;57037.42962570404;57270;57277;57307.140392894136;36928.26143477169;37556.624433755314;61321.38678613157;61501.384986150464;61671.38328616746;15486.5354039379;15535.84464155344;15629.60925976837;15636.374545018072;15638;11686.649400517997;11749.412529373669;11759.47082381295;11786.58746943853;11794.52821887115;20118.798812011984;20223.19107235694;20251.594968100555;20328.288509902082;20470.078846451946;7051.682674279567;7166.319199676022;7266.346028857428;7429.9257007430315;7454.664540095709;954.4511905654276;1028.8816786069697;1091.2633972068822;1131.4512461456188;1145.8000638773574;32736.83631581827;32861.83569082187;32902.506462403086;33524.83237583796;33649.49525757116;1085.2999815119204;1111.1555218034352;1133.982990255147;1146.9426528673532;1202.8676845546984;17061;17360.09185762064;17392.65214695699;17522;17570.209340579706;508565;511796;511940;513099;516425;59943;60093.69953150206;60142.39857601455;60161;60390;1241.6647505173553;1337.752515784583;1378.372840357635;1380.3581334679423;1392.958211253664;32550.34899302048;33468.32253419672;33971;34110;34433.65566344405;51336.229956549934;56279.43720562906;58071.709641451525;58148.4185158143;62791.37208628038;462760;469429;470221;471205;472976;37759.62240377561;44620.33069504025;46266.76866615645;46544.7672761634;47644.2853357193;47752.52247477481;51983.74008129935;53004;53257.46742532525;53964;43659.56340436555;44240.33639495474;44475.11049779051;44793.328100079176;45259.32111018272;43401;43577.34633980556;43584.56415435805;44268.778656106515;44747.77626111849;43703.78148109239;44419.33370999502;44685.776571116934;44838.327425088;44906.55093449024;38034.42948355832;39325.60674393219;39398.21203575855;40064.59935400609;40127.59872401239;29202.123936281947;29391;29654;29741.85129074341;29889.402211956072 16:43:32 INFO - PROCESS | 19694 | |2;jquery.html;405.1269514196905;408.43023981545724;409.88932988093217;417.7159531518567;425.81264243732755;12270.938645306784;12927.353632318394;18619.255229790808;20582.588348233025;20622;20132.899335503338;20636.793632063676;21052.368428947117;21112.366629001117;22365;5993.28080630325;6474.417302442779;6483.189601299838;6485.578437401554;6487.643179625119;4441.666874984373;5752.884942301152;6298;6437.517186211029;7352.558846469202;7488.475806693534;7523.398128149763;7530.134034586038;7530.661120249574;7539.0576177977755;7231.9638401807915;7493.437992150556;7499.062617172881;7507.361874240696;7511.737089201852;4247.702660813744;6657.334266573353;7063.399611033017;7157.141143062814;7167.856642867166;26067.608985865227;26295.474090518273;26766.46467070648;27432.862835685693;27479.17562473129;2571.459993401388;2643.254792510458;2692.380752426933;3014.125903487986;3281;15825.762613560806;15947.44183953556;16341.91829040859;16363.83636163635;16595.75531835105;2056.331692200041;2078.189506092625;2085.9687104693444;2122.713433686448;2197.923072692448;94738.52630736803;99622.003779962;99736;100742;101689;15793;17397.739033914502;17552.824471755375;17558.824411755973;18146.45560633183;31990.36019279648;32168.83915580454;32400;32495;32542.34915301728;9234;9413.435193888388;9487.241020718326;9634.90365096354;9651.613935442503;7728.7681369559;7942.523448593103;8057.919420805717;8195.631196596167;8222.465539739898;8952.910470895338;9141.81716365669;9177.265818734486;9294.213480057775;9308.581113849757;3279.737620990315;3502.527158833525;3600.963990360115;3617.764845285048;3666.7066634669695;916.5371487398821;977.6040703515088;991.6067924565996;997.217184510156;1004.2919741582167;19589.31437399684;19882.60234795325;19980.3006894758;19984.90007549953;20152.89923550373;967.3083745122271;977.6578197630772;1000.5297510170209;1057.9047885690325;1079.5034284229184;10720.410377429316;11290.774184516264;11300.604478843201;11337.093032557375;11344.205905586694;446253.11761206924;448860;452382;455228;458519;67784.6610766943;99046.50476747715;99639.50180249053;103011.48494257481;103881;1018.063381688848;1022.7754633671883;1028.0695970147028;1033.8397548379862;1036.9792604147724;16631.83368166303;17870.106494675474;18033.188506516977;18095.09524523795;18326.17532211027;44779.32831007472;45324.32013519734;45796.31305530486;46477.3028404581;46518.53481465142;62178.37821621726;62455.68772156292;62496.93769904941;63262;63938.680306598166;9182.908170918472;9212.170904618617;9322.860157097513;9335.673251436167;9398;10637.308574942914;14048;14118.43526258938;14229.14625122496;14358.497452589108;6229.345918678474;12122.454489547816;12148.757024859276;12195.268283902995;12298.81551776742;12028.63914082579;12304.26174429537;12379.319137447526;12403.503859845505;12420.62738117858;12246.693832654255;12296.877031229573;12390.56633017876;12439.502419903103;12509;8958.328125390752;9139.451632902048;9175.862362064441;9302.209312208268;9670.129688328085;11724.355160465915;12526.248425094524;12540.749185016432;12642;12921.806172907225 16:43:32 INFO - PROCESS | 19694 | |3;mootools.html;1318.2288361308633;1463.195242616561;1481.8073650425445;1611.7824093747347;1733.8092809790921;8425.789355266113;8862.202401783838;8891.644334226623;9153.130452606993;9155.542222888862;8933.062028487013;9153.359264851462;9155;9156.725298241046;9157.45055296681;2069.492974221318;2343.3438637181616;2404.230646193219;2443.890024948877;2486.962695559568;2461.9261422157274;2467.728549859514;2473.9628905566433;2476.6904136982876;2480.6527086207943;2429.3197904586746;2460.1266550374626;2467.0501856785086;2477.1330034487964;2477.2568229531157;2038.3069756282862;2279.8176145908287;2305.8501197422115;2311.4914718761847;2356.8585884846966;2299.3331933739196;2314.2941402872116;2335.824813139004;2338.6024375856146;2339.415146213447;8367.916320836835;8444.071152173256;8497.660093596249;8513.489190648519;8516.489010659381;5244.056069907415;5390.6226564140525;5397.2443857859935;5407.297051383295;5410.48600382963;3498.0555250082334;3549.9530535189906;3701.38927077032;3757.906052348686;3771.15149091455;1305.7388522295578;1306.15752839419;1339.7521458530202;1342.8187194728685;1361.3805718398105;12412.069094817925;12429.440675169548;12496.062795290389;12559.497620095186;12573.434195461135;4667.649926255544;4676.111538807616;4749.952500474951;4756.9762151189025;4826.638002149853;9392.577334019985;9416.482093484787;9461.621535138655;9469.952650236704;9486.478243696525;5215.452377500384;5235.1623740201385;5243.501867322599;5244.370675518962;5244.606654500928;4321.416608757778;4830.541098595628;4979;4985.277134815504;5093.668911520739;3931.2137572485617;3975.8210880510446;4027.778472184058;4047.6357127858632;4071.531773845986;1232.0451649971344;1235.3576140406938;1244.8195011723249;1246.9251844889336;1269.3082270162784;877.0571635491872;882.7395918204145;931.725141083382;940.47333493244;941.8445956417252;5604.663720176803;5796.130580412888;5882.088276317178;5951.720380118209;6022.2171117754415;908.9363744537819;921.4885738415244;955.8757361543094;990.4107056301489;993.1062044160313;3778.5843557208686;3795.7153213509096;3814.1227517670536;3849.653531182207;3897.240038192582;11062.22564420499;11388.94305528467;11390;11421.714457138638;11433.542658293742;9704.417734935927;9999.750006249902;11374.886251137383;11377.431128443544;11382.146339024606;8477.74566762998;8505.277051450696;8596.999999999874;8633.352498562634;8660.69687560945;5637.5489960802215;5870.970645146747;5976.103584462366;6004.309504407049;6148.4773794227995;9723.708288751348;10635.255532112678;10685.732856678334;10698.03717665414;10835.241533092923;10301.330413523097;10589.841152382874;10590.417527036087;10657.573697052341;10709.678709638412;6470.579412338183;6506.869862602627;7423.851522969402;7470.4023678106705;7590.582517961565;8814.779630509289;8837.690680826141;8901.866472002795;8922.197002269826;8928.241099506615;7493.063367079115;7748.535087894745;7780.260875216845;7790.493617914817;7821.648025838737;7645.732399365996;7787.221277872394;7884.093329266978;7892.881606776018;7907.209279072047;6598.571092878948;6702.162229721285;6711.228208755861;6715.899261510984;6717.093192418961;4813.7352445615825;4815.879603009953;4904.411470623548;4919.778609962489;4963.602911767122;4797.18447863857;4930.211166213388;4932.136876046606;4947.727874966911;5035.29505869186 16:43:32 INFO - PROCESS | 19694 | |4;prototype.html;331.87057047751375;336.07411581094084;342.7497926513646;347.8469473431691;348.5364465261203;5237.973810130949;5285.7885684572575;5303.178007408857;5315.813946511873;5323.8136665216725;5247.2653828464045;5257.211418287259;5265.210218467232;5283.577313814895;5286.682799032061;3823.273578020181;3951.466552015477;3973.7814420207023;3990.5410877748996;4076.5923407659293;4158.4594002779595;4167.6249137577615;4179.811908464127;4180.310248808943;4187.644050255717;4104.753714777108;4125.546189919107;4135.979320103395;4148.191102734952;4155.709100362976;3939.3500072488005;4065.227606754737;4114.382842573608;4126.525449573308;4158.708890377675;3709;3711.851525938959;3715.9628403715888;3717.646823551758;3730.5896351401325;5067.138586440314;5081.466446023152;5089.8727531812;5098.031374038957;5104.872378190538;4427.46870375557;4718.174319494075;4737.549932756383;4762.452317983441;4768.237082066853;5426.131818908955;5450.945490545084;5471.890562188734;5487.530611224965;5490.258815059956;3958.6833053355663;3969.64273215412;3971.5829837866895;3973.324534829086;3977.125032492847;5463.726813659301;5594.944050559483;5666.263385759866;5674.205611214434;5782.392848750863;4071.063655359284;4078.408630748584;4087.652549533323;4092.976755811047;4093.488313960755;4095.8566450174103;4127.525334586501;4128.710990230655;4135.31767258399;4143.8964025899595;4599.816007359668;4723.291506274018;4728.503507131702;4729.101470720552;4730.840943968681;5469.890602187934;5493.642913210629;5511.4213007633625;5538.695371754511;5542.418046105182;1398.8878841321175;1418.2128918450153;1421.729871324445;1425.7148570285983;1429.178222522054;873.3188113271658;897.7890195803981;906.8821053263033;908.7368557704796;913.7806926337631;4682.648801339845;4734.786934587952;4749.667523273338;4774.761261936889;4825.686330388514;5023.8899662141985;5029.711481276011;5044.848654540369;5149.403684857706;5159.716215608178;4495.505494395614;4735.905281894343;4811.374521312207;4833.830815921497;4843.588294994965;2642.920712378632;2659.587763896599;2689.596560515899;2690.4664341325647;2694.1109433886772;5106.923396149061;5134.614903882224;5156.226566015052;5158.561522270574;5166;4767.261074533453;5121.103806833789;5139.869228769665;5148.382194136652;5502.312210973629;5658.490735833712;5790.855228619234;5806.44838740319;5808.6224395414165;5813.79651712188;5610.607257491936;5612.494875461228;5617.382087970402;5624.803131890364;5631.662100273997;5422.701751403711;5577.721113944368;5601.271834661468;5647.29408823897;5660;5751.166080918327;5755.8488302338865;5800.187973683604;5806.187133801187;5824.417558244142;4060.675145988255;4074.5110586729784;4075.4090656853996;4079.1229885574744;4086.3053280942904;5450.31871016123;5560.7219639018695;5599.7600959616475;5618;5629.437056294338;5443.652153925386;5445.50990410865;5463.699496527729;5464.3442786865835;5468.179773034077;5215.617861266844;5373.9731301343245;5396.676199428047;5460.863478413072;5462.508374246337;5424.349078110652;5429.837104886859;5437.592180586393;5439.476946454841;5451.400345961862;5551.167324901297;5566.192902029264;5571.247881535941;5575.860603484945;5576.247206627216;5263.947360526499;5358.9550037742265;5445.576718360292;5458.099413596712;5462.781488740406 16:43:32 INFO - PROCESS | 19694 | |5;yui.html;740.248647622663;783.6003638144545;783.7492002559176;821.4291067707942;852.6035393542004;15306;16449.588760281;16450.50648480546;16484.75272870905;16513.339466421345;14366.640833979129;14995.47515836946;15364.462243821468;15399;15506.14716190609;811.2293321344716;825.2737590919982;827.5862068965517;829.6308142876422;832.3299743706344;816.8897198878165;822.4982760516081;824.6165533027141;824.6371596497552;824.6412810427453;870.4820631724145;873.2097451806126;874.3704532736451;874.5102742464209;874.641397027219;858.5235194467068;868.1839071273015;869.2741560796742;869.7738587967111;870.5951732444444;628.7422156915688;633.0788702437942;633.5913335898366;633.9017452294902;633.9239291285076;13490.797638035438;13828.446862125504;13940.233287169202;13947.442102315896;14765.704685906328;12932.935335323356;13338.799918001238;13373.732525349438;13706.93146534261;14518;13424.395902184426;13519.932400338033;13622.523211687543;13658.521951731742;13854.16874987504;4594.425696787902;4654.25531914892;4674.602658773974;4750.857474275777;4834.540718631724;54280;56812.14781778277;74226.25773742302;74827.25172748203;80025.59987200085;11918.404079795975;12088.758224835454;12111.697207569705;12370.195937264049;12407.44166512509;21812.563748725253;21833.890830546065;21858.890705546688;21944.561108778053;21986.780132198473;7863.842723145505;8523.914760852313;8918.955405222932;8943.821123577492;9137.994820569733;4800.927986080212;4897.7795999180125;4911.754412279443;4927.630427717935;4984.8753781155765;3571.607123216444;3737.1404576947452;3739.700823934079;3742.2515496900182;3743;631.6589041917313;643.9195100612424;653.4380432827764;654.5483616304734;659.5811659596095;687.6011913090396;692.4183685704032;714.8963400306926;744.2966396755014;780.2236774409499;9440.339176257734;9940.403575785476;10063.899361006297;10167.593296268215;10356.792864142826;598.6497898729206;708.450950513346;726.556800351785;762.9656665450068;767.1024900866;4889.975550122298;4901.313816065754;4961.5534601886;4969.453360130383;5012.899742005139;116831.41584292024;119055.40472297583;120831.39584302022;121655;123149;102182;102646;104082;104557.47721261345;105473;56806;62331.688341558;68580.6570967142;71869.64065179745;91515;9333.953330233306;9644.75888102803;10005.299629025898;10250.38497690141;10265.2301077418;51559.74220129025;51820;52261;53281.20078198908;53835;69714.30285697078;70393;70563;73960;74925.6253718728;13578.32108394596;13604.319784010562;13638.863611363759;13931.651708707363;14015.929920350332;15172.468963586221;15182.544523664308;15789.842101578837;16114;16228.51314460568;14832.406703731729;14909.254537272876;14910.701785964437;15725.921370393075;15962.840371596136;13893.513727019506;14163.716725665223;14528.782068268772;14705.485308014167;14987.250637468302;13355.599332020054;13895.58313250604;13984.930075349557;14516.419343226575;14714.117152970855;11810.940945295219;11839.289642621126;11954.940225299166;12127.636170914886;12250.693732656755;11912.642620721392;12186.695332616755;12312.938435307766;12548.937255313665;12558.811617825922 16:43:32 INFO - PROCESS | 19694 | __end_tp_report 16:43:32 INFO - PROCESS | 19694 | __start_cc_report 16:43:32 INFO - PROCESS | 19694 | _x_x_mozilla_cycle_collect,823 16:43:32 INFO - PROCESS | 19694 | __end_cc_report 16:43:32 INFO - PROCESS | 19694 | __startTimestamp1465861412271__endTimestamp 16:43:32 INFO - PROCESS | 19694 | 16:43:32 INFO - PROCESS | 19694 | ------- Summary: start ------- 16:43:32 INFO - PROCESS | 19694 | Number of tests: 6 16:43:32 INFO - PROCESS | 19694 | 16:43:32 INFO - PROCESS | 19694 | [#0] dojo.html Cycles:165 Average:5308.41 Median:5444.32 stddev:598.19 (11.0%) stddev-sans-first:574.52 16:43:32 INFO - PROCESS | 19694 | Values: 3105.2 3120.0 3135.2 3145.5 3170.1 5132.3 5251.8 5311.7 5392.2 5441.1 5291.4 5308.2 5324.7 5360.2 5389.2 4733.1 4781.9 4886.6 4956.3 5036.2 4926.5 4958.2 4964.8 4978.0 4978.3 4719.0 4765.4 4803.3 4869.4 4889.3 4877.7 4880.1 4885.5 4886.0 4928.6 4823.8 4851.9 4860.8 4875.3 4906.0 5130.2 5177.6 5244.4 5275.6 5362.3 5676.9 5723.3 5735.8 5739.1 5792.9 5579.0 5803.9 5832.2 5842.3 5850.6 5306.7 5348.3 5358.2 5420.3 5423.0 5852.4 5891.7 5892.8 5901.2 5940.9 5396.6 5574.4 5690.7 5695.7 5697.9 5690.3 5749.6 5750.9 5752.3 5807.4 5723.6 5736.4 5742.1 5742.3 5746.4 5489.8 5581.2 5655.5 5724.5 5725.7 4391.9 4393.3 4395.0 4433.0 4434.1 3899.0 3908.4 3911.7 3911.8 3942.4 5179.0 5225.0 5364.7 5385.4 5393.9 5766.8 5784.9 5786.7 5795.6 5830.9 5390.8 5423.3 5423.6 5423.6 5452.5 4785.0 4911.5 4962.0 4971.8 4999.1 5973.0 5975.0 5982.5 5984.2 5992.5 5577.8 5769.3 5779.8 5782.9 5785.6 5851.7 5916.2 5924.5 5954.5 5961.2 5660.7 5662.4 5668.4 5671.0 5675.5 5511.7 5663.3 5729.1 5730.7 5732.9 5469.6 5526.5 5564.2 5611.3 5613.4 5523.8 5577.9 5578.7 5585.8 5613.6 5316.9 5317.1 5522.8 5526.4 5570.2 5444.3 5524.6 5534.7 5539.4 5572.2 5346.3 5366.8 5370.4 5397.6 5404.6 16:43:32 INFO - PROCESS | 19694 | 16:43:32 INFO - PROCESS | 19694 | [#1] ext.html Cycles:180 Average:61307.07 Median:24423.18 stddev:118125.35 (483.7%) stddev-sans-first:118368.74 16:43:32 INFO - PROCESS | 19694 | Values: 585.9 598.2 610.8 611.1 631.6 33197.7 36234.6 44173.1 44726.3 44924.8 46218.0 46435.3 46638.1 46794.5 46807.8 8978.1 9115.7 9141.2 9145.9 9147.8 8987.0 9101.4 9101.7 9102.4 9102.8 9086.5 9145.3 9146.1 9149.6 9154.5 9044.5 9077.7 9099.8 9106.7 9108.5 8940.6 8994.1 8998.3 9006.5 9008.1 42875.1 43029.1 43227.4 43280.4 43282.8 3584.2 3762.6 3930.7 4027.6 4193.1 33047.5 33120.5 33208.8 33690.2 34589.0 4334.6 4336.9 4366.8 4427.0 4495.6 336134.0 338881.0 340370.0 341200.0 341560.0 56965.4 57037.4 57270.0 57277.0 57307.1 36928.3 37556.6 61321.4 61501.4 61671.4 15486.5 15535.8 15629.6 15636.4 15638.0 11686.6 11749.4 11759.5 11786.6 11794.5 20118.8 20223.2 20251.6 20328.3 20470.1 7051.7 7166.3 7266.3 7429.9 7454.7 954.5 1028.9 1091.3 1131.5 1145.8 32736.8 32861.8 32902.5 33524.8 33649.5 1085.3 1111.2 1134.0 1146.9 1202.9 17061.0 17360.1 17392.7 17522.0 17570.2 508565.0 511796.0 511940.0 513099.0 516425.0 59943.0 60093.7 60142.4 60161.0 60390.0 1241.7 1337.8 1378.4 1380.4 1393.0 32550.3 33468.3 33971.0 34110.0 34433.7 51336.2 56279.4 58071.7 58148.4 62791.4 462760.0 469429.0 470221.0 471205.0 472976.0 37759.6 44620.3 46266.8 46544.8 47644.3 47752.5 51983.7 53004.0 53257.5 53964.0 43659.6 44240.3 44475.1 44793.3 45259.3 43401.0 43577.3 43584.6 44268.8 44747.8 43703.8 44419.3 44685.8 44838.3 44906.6 38034.4 39325.6 39398.2 40064.6 40127.6 29202.1 29391.0 29654.0 29741.9 29889.4 16:43:32 INFO - PROCESS | 19694 | 16:43:32 INFO - PROCESS | 19694 | [#2] jquery.html Cycles:180 Average:30197.93 Median:17911.04 stddev:75141.80 (419.5%) stddev-sans-first:75319.29 16:43:32 INFO - PROCESS | 19694 | Values: 405.1 408.4 409.9 417.7 425.8 12270.9 12927.4 18619.3 20582.6 20622.0 20132.9 20636.8 21052.4 21112.4 22365.0 5993.3 6474.4 6483.2 6485.6 6487.6 4441.7 5752.9 6298.0 6437.5 7352.6 7488.5 7523.4 7530.1 7530.7 7539.1 7232.0 7493.4 7499.1 7507.4 7511.7 4247.7 6657.3 7063.4 7157.1 7167.9 26067.6 26295.5 26766.5 27432.9 27479.2 2571.5 2643.3 2692.4 3014.1 3281.0 15825.8 15947.4 16341.9 16363.8 16595.8 2056.3 2078.2 2086.0 2122.7 2197.9 94738.5 99622.0 99736.0 100742.0 101689.0 15793.0 17397.7 17552.8 17558.8 18146.5 31990.4 32168.8 32400.0 32495.0 32542.3 9234.0 9413.4 9487.2 9634.9 9651.6 7728.8 7942.5 8057.9 8195.6 8222.5 8952.9 9141.8 9177.3 9294.2 9308.6 3279.7 3502.5 3601.0 3617.8 3666.7 916.5 977.6 991.6 997.2 1004.3 19589.3 19882.6 19980.3 19984.9 20152.9 967.3 977.7 1000.5 1057.9 1079.5 10720.4 11290.8 11300.6 11337.1 11344.2 446253.1 448860.0 452382.0 455228.0 458519.0 67784.7 99046.5 99639.5 103011.5 103881.0 1018.1 1022.8 1028.1 1033.8 1037.0 16631.8 17870.1 18033.2 18095.1 18326.2 44779.3 45324.3 45796.3 46477.3 46518.5 62178.4 62455.7 62496.9 63262.0 63938.7 9182.9 9212.2 9322.9 9335.7 9398.0 10637.3 14048.0 14118.4 14229.1 14358.5 6229.3 12122.5 12148.8 12195.3 12298.8 12028.6 12304.3 12379.3 12403.5 12420.6 12246.7 12296.9 12390.6 12439.5 12509.0 8958.3 9139.5 9175.9 9302.2 9670.1 11724.4 12526.2 12540.7 12642.0 12921.8 16:43:32 INFO - PROCESS | 19694 | 16:43:32 INFO - PROCESS | 19694 | [#3] mootools.html Cycles:180 Average:5819.44 Median:4939.93 stddev:3325.40 (67.3%) stddev-sans-first:3317.53 16:43:32 INFO - PROCESS | 19694 | Values: 1318.2 1463.2 1481.8 1611.8 1733.8 8425.8 8862.2 8891.6 9153.1 9155.5 8933.1 9153.4 9155.0 9156.7 9157.5 2069.5 2343.3 2404.2 2443.9 2487.0 2461.9 2467.7 2474.0 2476.7 2480.7 2429.3 2460.1 2467.1 2477.1 2477.3 2038.3 2279.8 2305.9 2311.5 2356.9 2299.3 2314.3 2335.8 2338.6 2339.4 8367.9 8444.1 8497.7 8513.5 8516.5 5244.1 5390.6 5397.2 5407.3 5410.5 3498.1 3550.0 3701.4 3757.9 3771.2 1305.7 1306.2 1339.8 1342.8 1361.4 12412.1 12429.4 12496.1 12559.5 12573.4 4667.6 4676.1 4750.0 4757.0 4826.6 9392.6 9416.5 9461.6 9470.0 9486.5 5215.5 5235.2 5243.5 5244.4 5244.6 4321.4 4830.5 4979.0 4985.3 5093.7 3931.2 3975.8 4027.8 4047.6 4071.5 1232.0 1235.4 1244.8 1246.9 1269.3 877.1 882.7 931.7 940.5 941.8 5604.7 5796.1 5882.1 5951.7 6022.2 908.9 921.5 955.9 990.4 993.1 3778.6 3795.7 3814.1 3849.7 3897.2 11062.2 11388.9 11390.0 11421.7 11433.5 9704.4 9999.8 11374.9 11377.4 11382.1 8477.7 8505.3 8597.0 8633.4 8660.7 5637.5 5871.0 5976.1 6004.3 6148.5 9723.7 10635.3 10685.7 10698.0 10835.2 10301.3 10589.8 10590.4 10657.6 10709.7 6470.6 6506.9 7423.9 7470.4 7590.6 8814.8 8837.7 8901.9 8922.2 8928.2 7493.1 7748.5 7780.3 7790.5 7821.6 7645.7 7787.2 7884.1 7892.9 7907.2 6598.6 6702.2 6711.2 6715.9 6717.1 4813.7 4815.9 4904.4 4919.8 4963.6 4797.2 4930.2 4932.1 4947.7 5035.3 16:43:32 INFO - PROCESS | 19694 | 16:43:32 INFO - PROCESS | 19694 | [#4] prototype.html Cycles:180 Average:4548.50 Median:5127.86 stddev:1324.23 (25.8%) stddev-sans-first:1289.57 16:43:32 INFO - PROCESS | 19694 | Values: 331.9 336.1 342.7 347.8 348.5 5238.0 5285.8 5303.2 5315.8 5323.8 5247.3 5257.2 5265.2 5283.6 5286.7 3823.3 3951.5 3973.8 3990.5 4076.6 4158.5 4167.6 4179.8 4180.3 4187.6 4104.8 4125.5 4136.0 4148.2 4155.7 3939.4 4065.2 4114.4 4126.5 4158.7 3709.0 3711.9 3716.0 3717.6 3730.6 5067.1 5081.5 5089.9 5098.0 5104.9 4427.5 4718.2 4737.5 4762.5 4768.2 5426.1 5450.9 5471.9 5487.5 5490.3 3958.7 3969.6 3971.6 3973.3 3977.1 5463.7 5594.9 5666.3 5674.2 5782.4 4071.1 4078.4 4087.7 4093.0 4093.5 4095.9 4127.5 4128.7 4135.3 4143.9 4599.8 4723.3 4728.5 4729.1 4730.8 5469.9 5493.6 5511.4 5538.7 5542.4 1398.9 1418.2 1421.7 1425.7 1429.2 873.3 897.8 906.9 908.7 913.8 4682.6 4734.8 4749.7 4774.8 4825.7 5023.9 5029.7 5044.8 5149.4 5159.7 4495.5 4735.9 4811.4 4833.8 4843.6 2642.9 2659.6 2689.6 2690.5 2694.1 5106.9 5134.6 5156.2 5158.6 5166.0 4767.3 5121.1 5139.9 5148.4 5502.3 5658.5 5790.9 5806.4 5808.6 5813.8 5610.6 5612.5 5617.4 5624.8 5631.7 5422.7 5577.7 5601.3 5647.3 5660.0 5751.2 5755.8 5800.2 5806.2 5824.4 4060.7 4074.5 4075.4 4079.1 4086.3 5450.3 5560.7 5599.8 5618.0 5629.4 5443.7 5445.5 5463.7 5464.3 5468.2 5215.6 5374.0 5396.7 5460.9 5462.5 5424.3 5429.8 5437.6 5439.5 5451.4 5551.2 5566.2 5571.2 5575.9 5576.2 5263.9 5359.0 5445.6 5458.1 5462.8 16:43:32 INFO - PROCESS | 19694 | 16:43:32 INFO - PROCESS | 19694 | [#5] yui.html Cycles:180 Average:20687.00 Median:4168.71 stddev:29433.16 (706.0%) stddev-sans-first:29477.62 16:43:32 INFO - PROCESS | 19694 | Values: 740.2 783.6 783.7 821.4 852.6 15306.0 16449.6 16450.5 16484.8 16513.3 14366.6 14995.5 15364.5 15399.0 15506.1 811.2 825.3 827.6 829.6 832.3 816.9 822.5 824.6 824.6 824.6 870.5 873.2 874.4 874.5 874.6 858.5 868.2 869.3 869.8 870.6 628.7 633.1 633.6 633.9 633.9 13490.8 13828.4 13940.2 13947.4 14765.7 12932.9 13338.8 13373.7 13706.9 14518.0 13424.4 13519.9 13622.5 13658.5 13854.2 4594.4 4654.3 4674.6 4750.9 4834.5 54280.0 56812.1 74226.3 74827.3 80025.6 11918.4 12088.8 12111.7 12370.2 12407.4 21812.6 21833.9 21858.9 21944.6 21986.8 7863.8 8523.9 8919.0 8943.8 9138.0 4800.9 4897.8 4911.8 4927.6 4984.9 3571.6 3737.1 3739.7 3742.3 3743.0 631.7 643.9 653.4 654.5 659.6 687.6 692.4 714.9 744.3 780.2 9440.3 9940.4 10063.9 10167.6 10356.8 598.6 708.5 726.6 763.0 767.1 4890.0 4901.3 4961.6 4969.5 5012.9 116831.4 119055.4 120831.4 121655.0 123149.0 102182.0 102646.0 104082.0 104557.5 105473.0 56806.0 62331.7 68580.7 71869.6 91515.0 9334.0 9644.8 10005.3 10250.4 10265.2 51559.7 51820.0 52261.0 53281.2 53835.0 69714.3 70393.0 70563.0 73960.0 74925.6 13578.3 13604.3 13638.9 13931.7 14015.9 15172.5 15182.5 15789.8 16114.0 16228.5 14832.4 14909.3 14910.7 15725.9 15962.8 13893.5 14163.7 14528.8 14705.5 14987.3 13355.6 13895.6 13984.9 14516.4 14714.1 11810.9 11839.3 11954.9 12127.6 12250.7 11912.6 12186.7 12312.9 12548.9 12558.8 16:43:32 INFO - PROCESS | 19694 | -------- Summary: end -------- 16:43:32 INFO - PROCESS | 19694 | 16:43:33 INFO - TEST-INFO | 19694: exit 0 16:43:33 INFO - TEST-OK | dromaeo_css | took 1115507ms 16:43:33 INFO - TEST-START | kraken 16:43:33 INFO - operating with platform_type : linux_ 16:43:33 INFO - Initialising browser for kraken test... 16:43:33 INFO - TEST-INFO | started process 19877 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzYmaIT/profile http://localhost:34937/getInfo.html) 16:43:38 INFO - PROCESS | 19877 | __metrics Screen width/height:1600/1200 16:43:38 INFO - PROCESS | 19877 | colorDepth:24 16:43:38 INFO - PROCESS | 19877 | Browser inner width/height: 1024/697 16:43:38 INFO - PROCESS | 19877 | __metrics 16:43:39 INFO - PROCESS | 19877 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:43:39 INFO - PROCESS | 19877 | console.error: PushService: 16:43:39 INFO - PROCESS | 19877 | stateChangeProcessEnqueue: Error transitioning state 16:43:39 INFO - PROCESS | 19877 | UnknownError 16:43:40 INFO - TEST-INFO | 19877: exit 0 16:43:40 INFO - Browser initialized. 16:43:40 INFO - Running cycle 1/1 for kraken test... 16:43:40 INFO - TEST-INFO | started process 19961 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzYmaIT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:43:52 INFO - PROCESS | 19961 | RSS: Main: 177532928 16:43:52 INFO - PROCESS | 19961 | 16:43:55 INFO - PROCESS | 19961 | Cycle 1(1): loaded http://localhost:34937/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34937/tests/kraken/driver.html?testName=audio-beat-detection) 16:43:56 INFO - PROCESS | 19961 | RSS: Main: 236670976 16:43:56 INFO - PROCESS | 19961 | 16:43:58 INFO - PROCESS | 19961 | Cycle 1(1): loaded http://localhost:34937/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34937/tests/kraken/driver.html?testName=audio-dft) 16:43:59 INFO - PROCESS | 19961 | RSS: Main: 224325632 16:43:59 INFO - PROCESS | 19961 | 16:44:02 INFO - PROCESS | 19961 | Cycle 1(1): loaded http://localhost:34937/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34937/tests/kraken/driver.html?testName=audio-fft) 16:44:03 INFO - PROCESS | 19961 | RSS: Main: 290213888 16:44:03 INFO - PROCESS | 19961 | 16:44:05 INFO - PROCESS | 19961 | Cycle 1(1): loaded http://localhost:34937/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34937/tests/kraken/driver.html?testName=audio-oscillator) 16:44:05 INFO - PROCESS | 19961 | RSS: Main: 201797632 16:44:05 INFO - PROCESS | 19961 | 16:44:07 INFO - PROCESS | 19961 | Cycle 1(1): loaded http://localhost:34937/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34937/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:44:08 INFO - PROCESS | 19961 | RSS: Main: 205807616 16:44:08 INFO - PROCESS | 19961 | 16:44:11 INFO - PROCESS | 19961 | Cycle 1(1): loaded http://localhost:34937/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34937/tests/kraken/driver.html?testName=imaging-darkroom) 16:44:12 INFO - PROCESS | 19961 | RSS: Main: 241782784 16:44:12 INFO - PROCESS | 19961 | 16:44:15 INFO - PROCESS | 19961 | Cycle 1(1): loaded http://localhost:34937/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34937/tests/kraken/driver.html?testName=imaging-desaturate) 16:44:16 INFO - PROCESS | 19961 | RSS: Main: 241922048 16:44:16 INFO - PROCESS | 19961 | 16:44:19 INFO - PROCESS | 19961 | Cycle 1(1): loaded http://localhost:34937/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34937/tests/kraken/driver.html?testName=json-parse-financial) 16:44:19 INFO - PROCESS | 19961 | RSS: Main: 242663424 16:44:19 INFO - PROCESS | 19961 | 16:44:21 INFO - PROCESS | 19961 | Cycle 1(1): loaded http://localhost:34937/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34937/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:44:21 INFO - PROCESS | 19961 | RSS: Main: 230498304 16:44:21 INFO - PROCESS | 19961 | 16:44:23 INFO - PROCESS | 19961 | Cycle 1(1): loaded http://localhost:34937/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34937/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:44:24 INFO - PROCESS | 19961 | RSS: Main: 237137920 16:44:24 INFO - PROCESS | 19961 | 16:44:26 INFO - PROCESS | 19961 | Cycle 1(1): loaded http://localhost:34937/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34937/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:44:26 INFO - PROCESS | 19961 | RSS: Main: 238891008 16:44:26 INFO - PROCESS | 19961 | 16:44:29 INFO - PROCESS | 19961 | Cycle 1(1): loaded http://localhost:34937/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34937/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:44:29 INFO - PROCESS | 19961 | RSS: Main: 240177152 16:44:29 INFO - PROCESS | 19961 | 16:44:32 INFO - PROCESS | 19961 | Cycle 1(1): loaded http://localhost:34937/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34937/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:44:33 INFO - PROCESS | 19961 | RSS: Main: 239247360 16:44:33 INFO - PROCESS | 19961 | 16:44:34 INFO - PROCESS | 19961 | Cycle 1(1): loaded http://localhost:34937/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34937/tests/kraken/driver.html?testName=ai-astar) 16:44:35 INFO - PROCESS | 19961 | RSS: Main: 281903104 16:44:35 INFO - PROCESS | 19961 | 16:44:35 INFO - PROCESS | 19961 | __start_tp_report 16:44:35 INFO - PROCESS | 19961 | _x_x_mozilla_page_load 16:44:35 INFO - PROCESS | 19961 | _x_x_mozilla_page_load_details 16:44:35 INFO - PROCESS | 19961 | |i|pagename|runs| 16:44:35 INFO - PROCESS | 19961 | |0;ai-astar;111;106;109;111;109;110;110;108;109;109 16:44:35 INFO - PROCESS | 19961 | |1;audio-beat-detection;148;126;128;189;126;131;155;129;155;125 16:44:35 INFO - PROCESS | 19961 | |2;audio-dft;160;161;162;159;160;166;161;163;161;167 16:44:35 INFO - PROCESS | 19961 | |3;audio-fft;75;76;78;120;76;79;74;75;98;74 16:44:35 INFO - PROCESS | 19961 | |4;audio-oscillator;85;84;111;86;86;86;117;85;85;140 16:44:35 INFO - PROCESS | 19961 | |5;imaging-gaussian-blur;117;117;117;118;117;118;117;117;117;117 16:44:35 INFO - PROCESS | 19961 | |6;imaging-darkroom;145;146;145;145;145;145;145;145;146;145 16:44:35 INFO - PROCESS | 19961 | |7;imaging-desaturate;95;94;95;95;94;95;95;95;95;95 16:44:35 INFO - PROCESS | 19961 | |8;json-parse-financial;54;54;54;54;53;53;54;53;52;53 16:44:35 INFO - PROCESS | 19961 | |9;json-stringify-tinderbox;60;60;60;60;61;61;60;59;61;61 16:44:35 INFO - PROCESS | 19961 | |10;stanford-crypto-aes;79;80;80;82;80;80;85;82;115;81 16:44:35 INFO - PROCESS | 19961 | |11;stanford-crypto-ccm;123;123;119;120;120;125;119;122;139;122 16:44:35 INFO - PROCESS | 19961 | |12;stanford-crypto-pbkdf2;164;159;161;162;159;165;157;163;164;158 16:44:35 INFO - PROCESS | 19961 | |13;stanford-crypto-sha256-iterative;67;63;63;63;63;65;63;63;63;62 16:44:35 INFO - PROCESS | 19961 | __end_tp_report 16:44:35 INFO - PROCESS | 19961 | __start_cc_report 16:44:35 INFO - PROCESS | 19961 | _x_x_mozilla_cycle_collect,1605 16:44:35 INFO - PROCESS | 19961 | __end_cc_report 16:44:35 INFO - PROCESS | 19961 | __startTimestamp1465861475124__endTimestamp 16:44:35 INFO - PROCESS | 19961 | 16:44:35 INFO - PROCESS | 19961 | ------- Summary: start ------- 16:44:35 INFO - PROCESS | 19961 | Number of tests: 14 16:44:35 INFO - PROCESS | 19961 | 16:44:35 INFO - PROCESS | 19961 | [#0] ai-astar Cycles:10 Average:109.20 Median:109.50 stddev:1.48 (1.3%) stddev-sans-first:1.41 16:44:35 INFO - PROCESS | 19961 | Values: 111.0 106.0 109.0 111.0 109.0 110.0 110.0 108.0 109.0 109.0 16:44:35 INFO - PROCESS | 19961 | 16:44:35 INFO - PROCESS | 19961 | [#1] audio-beat-detection Cycles:10 Average:141.20 Median:139.50 stddev:20.72 (14.9%) stddev-sans-first:21.83 16:44:35 INFO - PROCESS | 19961 | Values: 148.0 126.0 128.0 189.0 126.0 131.0 155.0 129.0 155.0 125.0 16:44:35 INFO - PROCESS | 19961 | 16:44:35 INFO - PROCESS | 19961 | [#2] audio-dft Cycles:10 Average:162.00 Median:161.50 stddev:2.62 (1.6%) stddev-sans-first:2.68 16:44:35 INFO - PROCESS | 19961 | Values: 160.0 161.0 162.0 159.0 160.0 166.0 161.0 163.0 161.0 167.0 16:44:35 INFO - PROCESS | 19961 | 16:44:35 INFO - PROCESS | 19961 | [#3] audio-fft Cycles:10 Average:82.50 Median:76.00 stddev:14.98 (19.7%) stddev-sans-first:15.64 16:44:35 INFO - PROCESS | 19961 | Values: 75.0 76.0 78.0 120.0 76.0 79.0 74.0 75.0 98.0 74.0 16:44:35 INFO - PROCESS | 19961 | 16:44:35 INFO - PROCESS | 19961 | [#4] audio-oscillator Cycles:10 Average:96.50 Median:85.00 stddev:19.46 (22.9%) stddev-sans-first:20.19 16:44:35 INFO - PROCESS | 19961 | Values: 85.0 84.0 111.0 86.0 86.0 86.0 117.0 85.0 85.0 140.0 16:44:35 INFO - PROCESS | 19961 | 16:44:35 INFO - PROCESS | 19961 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 16:44:35 INFO - PROCESS | 19961 | Values: 117.0 117.0 117.0 118.0 117.0 118.0 117.0 117.0 117.0 117.0 16:44:35 INFO - PROCESS | 19961 | 16:44:35 INFO - PROCESS | 19961 | [#6] imaging-darkroom Cycles:10 Average:145.20 Median:145.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 16:44:35 INFO - PROCESS | 19961 | Values: 145.0 146.0 145.0 145.0 145.0 145.0 145.0 145.0 146.0 145.0 16:44:35 INFO - PROCESS | 19961 | 16:44:35 INFO - PROCESS | 19961 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 16:44:35 INFO - PROCESS | 19961 | Values: 95.0 94.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 16:44:35 INFO - PROCESS | 19961 | 16:44:35 INFO - PROCESS | 19961 | [#8] json-parse-financial Cycles:10 Average:53.40 Median:54.00 stddev:0.70 (1.3%) stddev-sans-first:0.71 16:44:35 INFO - PROCESS | 19961 | Values: 54.0 54.0 54.0 54.0 53.0 53.0 54.0 53.0 52.0 53.0 16:44:35 INFO - PROCESS | 19961 | 16:44:35 INFO - PROCESS | 19961 | [#9] json-stringify-tinderbox Cycles:10 Average:60.30 Median:60.50 stddev:0.67 (1.1%) stddev-sans-first:0.71 16:44:35 INFO - PROCESS | 19961 | Values: 60.0 60.0 60.0 60.0 61.0 61.0 60.0 59.0 61.0 61.0 16:44:35 INFO - PROCESS | 19961 | 16:44:35 INFO - PROCESS | 19961 | [#10] stanford-crypto-aes Cycles:10 Average:84.40 Median:80.50 stddev:10.89 (13.5%) stddev-sans-first:11.37 16:44:35 INFO - PROCESS | 19961 | Values: 79.0 80.0 80.0 82.0 80.0 80.0 85.0 82.0 115.0 81.0 16:44:35 INFO - PROCESS | 19961 | 16:44:35 INFO - PROCESS | 19961 | [#11] stanford-crypto-ccm Cycles:10 Average:123.20 Median:122.50 stddev:5.88 (4.8%) stddev-sans-first:6.24 16:44:35 INFO - PROCESS | 19961 | Values: 123.0 123.0 119.0 120.0 120.0 125.0 119.0 122.0 139.0 122.0 16:44:35 INFO - PROCESS | 19961 | 16:44:35 INFO - PROCESS | 19961 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.20 Median:162.50 stddev:2.82 (1.7%) stddev-sans-first:2.80 16:44:35 INFO - PROCESS | 19961 | Values: 164.0 159.0 161.0 162.0 159.0 165.0 157.0 163.0 164.0 158.0 16:44:35 INFO - PROCESS | 19961 | 16:44:35 INFO - PROCESS | 19961 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.50 Median:63.00 stddev:1.43 (2.3%) stddev-sans-first:0.78 16:44:35 INFO - PROCESS | 19961 | Values: 67.0 63.0 63.0 63.0 63.0 65.0 63.0 63.0 63.0 62.0 16:44:35 INFO - PROCESS | 19961 | -------- Summary: end -------- 16:44:35 INFO - PROCESS | 19961 | 16:44:36 INFO - TEST-INFO | 19961: exit 0 16:44:36 INFO - TEST-OK | kraken | took 63058ms 16:44:36 INFO - SUITE-END | took 1178s 16:44:36 INFO - Completed test suite (00:19:38) 16:44:36 INFO - javascript benchmark 16:44:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3105.192649911024, 3119.9999999999995, 3135.1691801672555, 3145.5281707743848, 3170.1440611035023, 5132.3327967364285, 5251.842444726664, 5311.707856067915, 5392.191171324298, 5441.129419292914, 5291.365036195662, 5308.23030660554, 5324.7071411072375, 5360.169173778061, 5389.245505629215, 4733.100710864933, 4781.928271075936, 4886.584640305578, 4956.306117143603, 5036.169032109716, 4926.507349265081, 4958.157113290749, 4964.751762411883, 4978.0, 4978.303037574742, 4719.0, 4765.380500534943, 4803.279508073782, 4869.4156701195725, 4889.266610008527, 4877.658563900528, 4880.072786170616, 4885.487023862479, 4885.998370334073, 4928.581070609002, 4823.807047718087, 4851.854444366674, 4860.781264843091, 4875.293082503053, 4905.950940490585, 5130.204818253177, 5177.58579313654, 5244.370675518924, 5275.57795376369, 5362.302900622933, 5676.886462270772, 5723.313202415737, 5735.827925162252, 5739.139129130622, 5792.855178620526, 5579.023670857584, 5803.912941305884, 5832.1834943108, 5842.298924129132, 5850.6489610623075, 5306.734663266821, 5348.277982472356, 5358.169483730028, 5420.295361602966, 5423.023855706011, 5852.385499522574, 5891.734871930774, 5892.823215303548, 5901.232839730807, 5940.851478713067, 5396.64921780083, 5574.442555744393, 5690.658560486384, 5695.6582605043, 5697.886042279214, 5690.345610254791, 5749.626274292157, 5750.88498230033, 5752.338481074647, 5807.448292412214, 5723.599348045597, 5736.42635736423, 5742.109972954198, 5742.28221472316, 5746.367899531048, 5489.780408783604, 5581.2186293918885, 5655.4910058094965, 5724.4561766632105, 5725.742341594639, 4391.8682439526865, 4393.253146965024, 4394.956050439455, 4433.0, 4434.068845542472, 3898.9610103899167, 3908.394198899175, 3911.7261791674878, 3911.7848518331766, 3942.42834788954, 5179.04187725272, 5225.0, 5364.7317634118135, 5385.434529374437, 5393.919091213635, 5766.798162064391, 5784.94215057844, 5786.681732504669, 5795.594308398372, 5830.941690583039, 5390.838274851761, 5423.29497165366, 5423.593230507728, 5423.647462914977, 5452.454754524516, 4784.976075119602, 4911.508849115131, 4961.950380496149, 4971.751412429364, 4999.0501804657, 5972.970135149297, 5975.043992961192, 5982.521398288127, 5984.162217289496, 5992.520598352121, 5577.8047768327915, 5769.278840144982, 5779.826605201851, 5782.942170578409, 5785.623934444247, 5851.736671849862, 5916.171735956884, 5924.496417804535, 5954.46409823118, 5961.225040744675, 5660.716964151694, 5662.377138514842, 5668.37647858727, 5671.0, 5675.460831221028, 5511.669299842022, 5663.292088488939, 5729.083346664514, 5730.74211660468, 5732.885342293214, 5469.617126801086, 5526.530244929065, 5564.248826408545, 5611.270534830446, 5613.438656134354, 5523.779048838162, 5577.888442231214, 5578.665280083208, 5585.804496842591, 5613.607047506635, 5316.946830531645, 5317.096093664164, 5522.779088836563, 5526.41972592888, 5570.192322113352, 5444.3194600674915, 5524.640898341756, 5534.695591742493, 5539.390667026543, 5572.164175373727, 5346.278252436027, 5366.785328586813, 5370.409254981871, 5397.59518036141, 5404.621676482609], "value": 5268.857336185015, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [585.9355470898203, 598.2432223237608, 610.7709608896664, 611.1382950040442, 631.5736877607617, 33197.66802331976, 36234.63765362345, 44173.116537669266, 44726.32910506345, 44924.77537612316, 46218.0, 46435.30347044797, 46638.06723865529, 46794.53205467945, 46807.76596117023, 8978.057303983069, 9115.726528204164, 9141.222996045344, 9145.862812057825, 9147.817043659123, 8986.955065224665, 9101.408408453462, 9101.726948191532, 9102.408343457688, 9102.77243068922, 9086.50024248666, 9145.314101442385, 9146.085391460834, 9149.5882685279, 9154.49650269235, 9044.502552359618, 9077.727668169966, 9099.81800363989, 9106.681266155652, 9108.544572771369, 8940.597673104661, 8994.055624159435, 8998.325125615605, 9006.459612423276, 9008.099190081006, 42875.14249715019, 43029.139417211794, 43227.35158972618, 43280.35079473811, 43282.78358608187, 3584.2473080653094, 3762.567304759933, 3930.744501607386, 4027.577104404025, 4193.077522944947, 33047.48585278945, 33120.50319245189, 33208.833955830065, 33690.1577460563, 34589.0, 4334.566543345672, 4336.850858262883, 4366.781660916973, 4427.026054268056, 4495.64034877209, 336133.99999999756, 338881.0, 340370.0, 341200.0, 341560.0, 56965.43034569684, 57037.42962570404, 57270.0, 57277.0, 57307.140392894136, 36928.26143477169, 37556.624433755314, 61321.38678613157, 61501.384986150464, 61671.38328616746, 15486.5354039379, 15535.84464155344, 15629.60925976837, 15636.374545018072, 15638.0, 11686.649400517997, 11749.412529373669, 11759.47082381295, 11786.58746943853, 11794.52821887115, 20118.798812011984, 20223.19107235694, 20251.594968100555, 20328.288509902082, 20470.078846451946, 7051.682674279567, 7166.319199676022, 7266.346028857428, 7429.9257007430315, 7454.664540095709, 954.4511905654276, 1028.8816786069697, 1091.2633972068822, 1131.4512461456188, 1145.8000638773574, 32736.83631581827, 32861.83569082187, 32902.506462403086, 33524.83237583796, 33649.49525757116, 1085.2999815119204, 1111.1555218034352, 1133.982990255147, 1146.9426528673532, 1202.8676845546984, 17061.0, 17360.09185762064, 17392.65214695699, 17522.0, 17570.209340579706, 508565.0, 511796.0, 511940.0, 513099.0, 516425.0, 59943.0, 60093.69953150206, 60142.39857601455, 60161.0, 60390.0, 1241.6647505173553, 1337.752515784583, 1378.372840357635, 1380.3581334679423, 1392.958211253664, 32550.34899302048, 33468.32253419672, 33971.0, 34110.0, 34433.65566344405, 51336.229956549934, 56279.43720562906, 58071.709641451525, 58148.4185158143, 62791.37208628038, 462760.0, 469429.0, 470221.0, 471205.0, 472976.0, 37759.62240377561, 44620.33069504025, 46266.76866615645, 46544.7672761634, 47644.2853357193, 47752.52247477481, 51983.74008129935, 53004.0, 53257.46742532525, 53964.0, 43659.56340436555, 44240.33639495474, 44475.11049779051, 44793.328100079176, 45259.32111018272, 43401.0, 43577.34633980556, 43584.56415435805, 44268.778656106515, 44747.77626111849, 43703.78148109239, 44419.33370999502, 44685.776571116934, 44838.327425088, 44906.55093449024, 38034.42948355832, 39325.60674393219, 39398.21203575855, 40064.59935400609, 40127.59872401239, 29202.123936281947, 29391.0, 29654.0, 29741.85129074341, 29889.402211956072], "value": 20829.67360487308, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [405.1269514196905, 408.43023981545724, 409.88932988093217, 417.7159531518567, 425.81264243732755, 12270.938645306784, 12927.353632318394, 18619.255229790808, 20582.588348233025, 20622.0, 20132.899335503338, 20636.793632063676, 21052.368428947117, 21112.366629001117, 22365.0, 5993.28080630325, 6474.417302442779, 6483.189601299838, 6485.578437401554, 6487.643179625119, 4441.666874984373, 5752.884942301152, 6298.0, 6437.517186211029, 7352.558846469202, 7488.475806693534, 7523.398128149763, 7530.134034586038, 7530.661120249574, 7539.0576177977755, 7231.9638401807915, 7493.437992150556, 7499.062617172881, 7507.361874240696, 7511.737089201852, 4247.702660813744, 6657.334266573353, 7063.399611033017, 7157.141143062814, 7167.856642867166, 26067.608985865227, 26295.474090518273, 26766.46467070648, 27432.862835685693, 27479.17562473129, 2571.459993401388, 2643.254792510458, 2692.380752426933, 3014.125903487986, 3281.0, 15825.762613560806, 15947.44183953556, 16341.91829040859, 16363.83636163635, 16595.75531835105, 2056.331692200041, 2078.189506092625, 2085.9687104693444, 2122.713433686448, 2197.923072692448, 94738.52630736803, 99622.003779962, 99736.0, 100742.0, 101689.0, 15793.0, 17397.739033914502, 17552.824471755375, 17558.824411755973, 18146.45560633183, 31990.36019279648, 32168.83915580454, 32400.0, 32495.0, 32542.34915301728, 9234.0, 9413.435193888388, 9487.241020718326, 9634.90365096354, 9651.613935442503, 7728.7681369559, 7942.523448593103, 8057.919420805717, 8195.631196596167, 8222.465539739898, 8952.910470895338, 9141.81716365669, 9177.265818734486, 9294.213480057775, 9308.581113849757, 3279.737620990315, 3502.527158833525, 3600.963990360115, 3617.764845285048, 3666.7066634669695, 916.5371487398821, 977.6040703515088, 991.6067924565996, 997.217184510156, 1004.2919741582167, 19589.31437399684, 19882.60234795325, 19980.3006894758, 19984.90007549953, 20152.89923550373, 967.3083745122271, 977.6578197630772, 1000.5297510170209, 1057.9047885690325, 1079.5034284229184, 10720.410377429316, 11290.774184516264, 11300.604478843201, 11337.093032557375, 11344.205905586694, 446253.11761206924, 448860.0, 452382.0, 455228.0, 458519.0, 67784.6610766943, 99046.50476747715, 99639.50180249053, 103011.48494257481, 103881.0, 1018.063381688848, 1022.7754633671883, 1028.0695970147028, 1033.8397548379862, 1036.9792604147724, 16631.83368166303, 17870.106494675474, 18033.188506516977, 18095.09524523795, 18326.17532211027, 44779.32831007472, 45324.32013519734, 45796.31305530486, 46477.3028404581, 46518.53481465142, 62178.37821621726, 62455.68772156292, 62496.93769904941, 63262.0, 63938.680306598166, 9182.908170918472, 9212.170904618617, 9322.860157097513, 9335.673251436167, 9398.0, 10637.308574942914, 14048.0, 14118.43526258938, 14229.14625122496, 14358.497452589108, 6229.345918678474, 12122.454489547816, 12148.757024859276, 12195.268283902995, 12298.81551776742, 12028.63914082579, 12304.26174429537, 12379.319137447526, 12403.503859845505, 12420.62738117858, 12246.693832654255, 12296.877031229573, 12390.56633017876, 12439.502419903103, 12509.0, 8958.328125390752, 9139.451632902048, 9175.862362064441, 9302.209312208268, 9670.129688328085, 11724.355160465915, 12526.248425094524, 12540.749185016432, 12642.0, 12921.806172907225], "value": 10628.62699347197, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1318.2288361308633, 1463.195242616561, 1481.8073650425445, 1611.7824093747347, 1733.8092809790921, 8425.789355266113, 8862.202401783838, 8891.644334226623, 9153.130452606993, 9155.542222888862, 8933.062028487013, 9153.359264851462, 9155.0, 9156.725298241046, 9157.45055296681, 2069.492974221318, 2343.3438637181616, 2404.230646193219, 2443.890024948877, 2486.962695559568, 2461.9261422157274, 2467.728549859514, 2473.9628905566433, 2476.6904136982876, 2480.6527086207943, 2429.3197904586746, 2460.1266550374626, 2467.0501856785086, 2477.1330034487964, 2477.2568229531157, 2038.3069756282862, 2279.8176145908287, 2305.8501197422115, 2311.4914718761847, 2356.8585884846966, 2299.3331933739196, 2314.2941402872116, 2335.824813139004, 2338.6024375856146, 2339.415146213447, 8367.916320836835, 8444.071152173256, 8497.660093596249, 8513.489190648519, 8516.489010659381, 5244.056069907415, 5390.6226564140525, 5397.2443857859935, 5407.297051383295, 5410.48600382963, 3498.0555250082334, 3549.9530535189906, 3701.38927077032, 3757.906052348686, 3771.15149091455, 1305.7388522295578, 1306.15752839419, 1339.7521458530202, 1342.8187194728685, 1361.3805718398105, 12412.069094817925, 12429.440675169548, 12496.062795290389, 12559.497620095186, 12573.434195461135, 4667.649926255544, 4676.111538807616, 4749.952500474951, 4756.9762151189025, 4826.638002149853, 9392.577334019985, 9416.482093484787, 9461.621535138655, 9469.952650236704, 9486.478243696525, 5215.452377500384, 5235.1623740201385, 5243.501867322599, 5244.370675518962, 5244.606654500928, 4321.416608757778, 4830.541098595628, 4979.0, 4985.277134815504, 5093.668911520739, 3931.2137572485617, 3975.8210880510446, 4027.778472184058, 4047.6357127858632, 4071.531773845986, 1232.0451649971344, 1235.3576140406938, 1244.8195011723249, 1246.9251844889336, 1269.3082270162784, 877.0571635491872, 882.7395918204145, 931.725141083382, 940.47333493244, 941.8445956417252, 5604.663720176803, 5796.130580412888, 5882.088276317178, 5951.720380118209, 6022.2171117754415, 908.9363744537819, 921.4885738415244, 955.8757361543094, 990.4107056301489, 993.1062044160313, 3778.5843557208686, 3795.7153213509096, 3814.1227517670536, 3849.653531182207, 3897.240038192582, 11062.22564420499, 11388.94305528467, 11390.0, 11421.714457138638, 11433.542658293742, 9704.417734935927, 9999.750006249902, 11374.886251137383, 11377.431128443544, 11382.146339024606, 8477.74566762998, 8505.277051450696, 8596.999999999874, 8633.352498562634, 8660.69687560945, 5637.5489960802215, 5870.970645146747, 5976.103584462366, 6004.309504407049, 6148.4773794227995, 9723.708288751348, 10635.255532112678, 10685.732856678334, 10698.03717665414, 10835.241533092923, 10301.330413523097, 10589.841152382874, 10590.417527036087, 10657.573697052341, 10709.678709638412, 6470.579412338183, 6506.869862602627, 7423.851522969402, 7470.4023678106705, 7590.582517961565, 8814.779630509289, 8837.690680826141, 8901.866472002795, 8922.197002269826, 8928.241099506615, 7493.063367079115, 7748.535087894745, 7780.260875216845, 7790.493617914817, 7821.648025838737, 7645.732399365996, 7787.221277872394, 7884.093329266978, 7892.881606776018, 7907.209279072047, 6598.571092878948, 6702.162229721285, 6711.228208755861, 6715.899261510984, 6717.093192418961, 4813.7352445615825, 4815.879603009953, 4904.411470623548, 4919.778609962489, 4963.602911767122, 4797.18447863857, 4930.211166213388, 4932.136876046606, 4947.727874966911, 5035.29505869186], "value": 4665.456643271028, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [331.87057047751375, 336.07411581094084, 342.7497926513646, 347.8469473431691, 348.5364465261203, 5237.973810130949, 5285.7885684572575, 5303.178007408857, 5315.813946511873, 5323.8136665216725, 5247.2653828464045, 5257.211418287259, 5265.210218467232, 5283.577313814895, 5286.682799032061, 3823.273578020181, 3951.466552015477, 3973.7814420207023, 3990.5410877748996, 4076.5923407659293, 4158.4594002779595, 4167.6249137577615, 4179.811908464127, 4180.310248808943, 4187.644050255717, 4104.753714777108, 4125.546189919107, 4135.979320103395, 4148.191102734952, 4155.709100362976, 3939.3500072488005, 4065.227606754737, 4114.382842573608, 4126.525449573308, 4158.708890377675, 3709.0, 3711.851525938959, 3715.9628403715888, 3717.646823551758, 3730.5896351401325, 5067.138586440314, 5081.466446023152, 5089.8727531812, 5098.031374038957, 5104.872378190538, 4427.46870375557, 4718.174319494075, 4737.549932756383, 4762.452317983441, 4768.237082066853, 5426.131818908955, 5450.945490545084, 5471.890562188734, 5487.530611224965, 5490.258815059956, 3958.6833053355663, 3969.64273215412, 3971.5829837866895, 3973.324534829086, 3977.125032492847, 5463.726813659301, 5594.944050559483, 5666.263385759866, 5674.205611214434, 5782.392848750863, 4071.063655359284, 4078.408630748584, 4087.652549533323, 4092.976755811047, 4093.488313960755, 4095.8566450174103, 4127.525334586501, 4128.710990230655, 4135.31767258399, 4143.8964025899595, 4599.816007359668, 4723.291506274018, 4728.503507131702, 4729.101470720552, 4730.840943968681, 5469.890602187934, 5493.642913210629, 5511.4213007633625, 5538.695371754511, 5542.418046105182, 1398.8878841321175, 1418.2128918450153, 1421.729871324445, 1425.7148570285983, 1429.178222522054, 873.3188113271658, 897.7890195803981, 906.8821053263033, 908.7368557704796, 913.7806926337631, 4682.648801339845, 4734.786934587952, 4749.667523273338, 4774.761261936889, 4825.686330388514, 5023.8899662141985, 5029.711481276011, 5044.848654540369, 5149.403684857706, 5159.716215608178, 4495.505494395614, 4735.905281894343, 4811.374521312207, 4833.830815921497, 4843.588294994965, 2642.920712378632, 2659.587763896599, 2689.596560515899, 2690.4664341325647, 2694.1109433886772, 5106.923396149061, 5134.614903882224, 5156.226566015052, 5158.561522270574, 5166.0, 4767.261074533453, 5121.103806833789, 5139.869228769665, 5148.382194136652, 5502.312210973629, 5658.490735833712, 5790.855228619234, 5806.44838740319, 5808.6224395414165, 5813.79651712188, 5610.607257491936, 5612.494875461228, 5617.382087970402, 5624.803131890364, 5631.662100273997, 5422.701751403711, 5577.721113944368, 5601.271834661468, 5647.29408823897, 5660.0, 5751.166080918327, 5755.8488302338865, 5800.187973683604, 5806.187133801187, 5824.417558244142, 4060.675145988255, 4074.5110586729784, 4075.4090656853996, 4079.1229885574744, 4086.3053280942904, 5450.31871016123, 5560.7219639018695, 5599.7600959616475, 5618.0, 5629.437056294338, 5443.652153925386, 5445.50990410865, 5463.699496527729, 5464.3442786865835, 5468.179773034077, 5215.617861266844, 5373.9731301343245, 5396.676199428047, 5460.863478413072, 5462.508374246337, 5424.349078110652, 5429.837104886859, 5437.592180586393, 5439.476946454841, 5451.400345961862, 5551.167324901297, 5566.192902029264, 5571.247881535941, 5575.860603484945, 5576.247206627216, 5263.947360526499, 5358.9550037742265, 5445.576718360292, 5458.099413596712, 5462.781488740406], "value": 4129.741480607243, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [740.248647622663, 783.6003638144545, 783.7492002559176, 821.4291067707942, 852.6035393542004, 15306.0, 16449.588760281, 16450.50648480546, 16484.75272870905, 16513.339466421345, 14366.640833979129, 14995.47515836946, 15364.462243821468, 15399.0, 15506.14716190609, 811.2293321344716, 825.2737590919982, 827.5862068965517, 829.6308142876422, 832.3299743706344, 816.8897198878165, 822.4982760516081, 824.6165533027141, 824.6371596497552, 824.6412810427453, 870.4820631724145, 873.2097451806126, 874.3704532736451, 874.5102742464209, 874.641397027219, 858.5235194467068, 868.1839071273015, 869.2741560796742, 869.7738587967111, 870.5951732444444, 628.7422156915688, 633.0788702437942, 633.5913335898366, 633.9017452294902, 633.9239291285076, 13490.797638035438, 13828.446862125504, 13940.233287169202, 13947.442102315896, 14765.704685906328, 12932.935335323356, 13338.799918001238, 13373.732525349438, 13706.93146534261, 14518.0, 13424.395902184426, 13519.932400338033, 13622.523211687543, 13658.521951731742, 13854.16874987504, 4594.425696787902, 4654.25531914892, 4674.602658773974, 4750.857474275777, 4834.540718631724, 54280.0, 56812.14781778277, 74226.25773742302, 74827.25172748203, 80025.59987200085, 11918.404079795975, 12088.758224835454, 12111.697207569705, 12370.195937264049, 12407.44166512509, 21812.563748725253, 21833.890830546065, 21858.890705546688, 21944.561108778053, 21986.780132198473, 7863.842723145505, 8523.914760852313, 8918.955405222932, 8943.821123577492, 9137.994820569733, 4800.927986080212, 4897.7795999180125, 4911.754412279443, 4927.630427717935, 4984.8753781155765, 3571.607123216444, 3737.1404576947452, 3739.700823934079, 3742.2515496900182, 3743.0, 631.6589041917313, 643.9195100612424, 653.4380432827764, 654.5483616304734, 659.5811659596095, 687.6011913090396, 692.4183685704032, 714.8963400306926, 744.2966396755014, 780.2236774409499, 9440.339176257734, 9940.403575785476, 10063.899361006297, 10167.593296268215, 10356.792864142826, 598.6497898729206, 708.450950513346, 726.556800351785, 762.9656665450068, 767.1024900866, 4889.975550122298, 4901.313816065754, 4961.5534601886, 4969.453360130383, 5012.899742005139, 116831.41584292024, 119055.40472297583, 120831.39584302022, 121655.0, 123149.0, 102182.0, 102646.0, 104082.0, 104557.47721261345, 105473.0, 56806.0, 62331.688341558, 68580.6570967142, 71869.64065179745, 91515.0, 9333.953330233306, 9644.75888102803, 10005.299629025898, 10250.38497690141, 10265.2301077418, 51559.74220129025, 51820.0, 52261.0, 53281.20078198908, 53835.0, 69714.30285697078, 70393.0, 70563.0, 73960.0, 74925.6253718728, 13578.32108394596, 13604.319784010562, 13638.863611363759, 13931.651708707363, 14015.929920350332, 15172.468963586221, 15182.544523664308, 15789.842101578837, 16114.0, 16228.51314460568, 14832.406703731729, 14909.254537272876, 14910.701785964437, 15725.921370393075, 15962.840371596136, 13893.513727019506, 14163.716725665223, 14528.782068268772, 14705.485308014167, 14987.250637468302, 13355.599332020054, 13895.58313250604, 13984.930075349557, 14516.419343226575, 14714.117152970855, 11810.940945295219, 11839.289642621126, 11954.940225299166, 12127.636170914886, 12250.693732656755, 11912.642620721392, 12186.695332616755, 12312.938435307766, 12548.937255313665, 12558.811617825922], "value": 7782.458986139355, "unit": "score"}], "name": "dromaeo_css", "value": 7478.421611702677, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 106.0, 109.0, 111.0, 109.0, 110.0, 110.0, 108.0, 109.0, 109.0], "value": 109.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 126.0, 128.0, 189.0, 126.0, 131.0, 155.0, 129.0, 155.0, 125.0], "value": 141.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 162.0, 159.0, 160.0, 166.0, 161.0, 163.0, 161.0, 167.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 78.0, 120.0, 76.0, 79.0, 74.0, 75.0, 98.0, 74.0], "value": 82.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 111.0, 86.0, 86.0, 86.0, 117.0, 85.0, 85.0, 140.0], "value": 96.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 146.0, 145.0], "value": 145.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 54.0, 53.0, 53.0, 54.0, 53.0, 52.0, 53.0], "value": 53.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 60.0, 60.0, 61.0, 61.0, 60.0, 59.0, 61.0, 61.0], "value": 60.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 80.0, 82.0, 80.0, 80.0, 85.0, 82.0, 115.0, 81.0], "value": 84.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 123.0, 119.0, 120.0, 120.0, 125.0, 119.0, 122.0, 139.0, 122.0], "value": 123.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 159.0, 161.0, 162.0, 159.0, 165.0, 157.0, 163.0, 164.0, 158.0], "value": 161.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 63.0, 63.0, 63.0, 63.0, 65.0, 63.0, 63.0, 63.0, 62.0], "value": 63.5, "unit": "score"}], "name": "kraken", "value": 1494.6000000000001, "alertThreshold": 2.0}]} 16:44:36 INFO - Return code: 0 16:44:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:44:36 INFO - # TBPL SUCCESS # 16:44:36 INFO - Running post-action listener: _resource_record_post_action 16:44:36 INFO - ##### 16:44:36 INFO - ##### Finished run-tests step (success) 16:44:36 INFO - ##### 16:44:36 INFO - Running post-run listener: _resource_record_post_run 16:44:36 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 12288; Write bytes: 548941824; Read time: 256; Write time: 1183656 16:44:36 INFO - TinderboxPrint: CPU usage
13.3% 16:44:36 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 256 16:44:36 INFO - TinderboxPrint: I/O write bytes / time
548,941,824 / 1,183,656 16:44:36 INFO - TinderboxPrint: CPU idle
8,284.2 (86.7%) 16:44:36 INFO - TinderboxPrint: CPU user
1,207.2 (12.6%) 16:44:36 INFO - TinderboxPrint: Swap in / out
0 / 0 16:44:36 INFO - install - Wall time: 19s; CPU: 16.0%; Read bytes: 4096; Write bytes: 261468160; Read time: 236; Write time: 582320 16:44:36 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 8192; Write bytes: 287473664; Read time: 20; Write time: 601336 16:44:37 INFO - Running post-run listener: _upload_blobber_files 16:44:37 INFO - Blob upload gear active. 16:44:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:44:37 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 16:44:37 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'] 16:44:37 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 16:44:37 INFO - (blobuploader) - INFO - Open directory for files ... 16:44:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:44:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:44:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:44:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:44:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:44:38 INFO - (blobuploader) - INFO - Done attempting. 16:44:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:44:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:44:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:44:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:44:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:44:39 INFO - (blobuploader) - INFO - Done attempting. 16:44:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:44:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:44:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:44:43 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:44:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:44:43 INFO - (blobuploader) - INFO - Done attempting. 16:44:43 INFO - (blobuploader) - INFO - Iteration through files over. 16:44:43 INFO - Return code: 0 16:44:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:44:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:44:43 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/884f163711193c600090e707fb76544877f9530c9003dbfd0f96b35f4186d03928274ebd2af0da540f631e374bfa07565072af4cb7ebfe4d4c2f793243341a34", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6bf7aa8befa99aec3437de64fb85ee035e6b8a2a85fc659662179183ced4ead6c97c14f9c20a73e293fcbb3a6b2c3fe4da1cdfde9691be4d255d67d48334faee", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1e5ad3c716b4cf7d7a5bd82bd8654d121360c2823208acd2056364ba08264692e715673812bcf5c310177b94b1f5c171d4b661923c58346b172b1cd6d9514315"} 16:44:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:44:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:44:43 INFO - Contents: 16:44:43 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/884f163711193c600090e707fb76544877f9530c9003dbfd0f96b35f4186d03928274ebd2af0da540f631e374bfa07565072af4cb7ebfe4d4c2f793243341a34", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6bf7aa8befa99aec3437de64fb85ee035e6b8a2a85fc659662179183ced4ead6c97c14f9c20a73e293fcbb3a6b2c3fe4da1cdfde9691be4d255d67d48334faee", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1e5ad3c716b4cf7d7a5bd82bd8654d121360c2823208acd2056364ba08264692e715673812bcf5c310177b94b1f5c171d4b661923c58346b172b1cd6d9514315"} 16:44:43 INFO - Running post-run listener: copy_logs_to_upload_dir 16:44:43 INFO - Copying logs to upload dir... 16:44:43 INFO - mkdir: /builds/slave/test/build/upload/logs 16:44:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.170450 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-06-13 16:44:42.770975) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-13 16:44:42.777143) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5cf47e208febbcd81da23b2e0000026f-1465859433.571466-1883584488 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/884f163711193c600090e707fb76544877f9530c9003dbfd0f96b35f4186d03928274ebd2af0da540f631e374bfa07565072af4cb7ebfe4d4c2f793243341a34", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6bf7aa8befa99aec3437de64fb85ee035e6b8a2a85fc659662179183ced4ead6c97c14f9c20a73e293fcbb3a6b2c3fe4da1cdfde9691be4d255d67d48334faee", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1e5ad3c716b4cf7d7a5bd82bd8654d121360c2823208acd2056364ba08264692e715673812bcf5c310177b94b1f5c171d4b661923c58346b172b1cd6d9514315"} build_url:https://queue.taskcluster.net/v1/task/IGf6dMwcTqWqPLCEMKo0yA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011360 build_url: 'https://queue.taskcluster.net/v1/task/IGf6dMwcTqWqPLCEMKo0yA/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/884f163711193c600090e707fb76544877f9530c9003dbfd0f96b35f4186d03928274ebd2af0da540f631e374bfa07565072af4cb7ebfe4d4c2f793243341a34", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6bf7aa8befa99aec3437de64fb85ee035e6b8a2a85fc659662179183ced4ead6c97c14f9c20a73e293fcbb3a6b2c3fe4da1cdfde9691be4d255d67d48334faee", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1e5ad3c716b4cf7d7a5bd82bd8654d121360c2823208acd2056364ba08264692e715673812bcf5c310177b94b1f5c171d4b661923c58346b172b1cd6d9514315"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-13 16:44:42.802750) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 16:44:42.803071) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5cf47e208febbcd81da23b2e0000026f-1465859433.571466-1883584488 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004433 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 16:44:42.886276) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-13 16:44:42.886612) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-13 16:44:42.886897) ========= ========= Total master_lag: 0.17 =========