builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-032 starttime: 1466820819.04 results: success (0) buildid: 20160624163010 builduid: ea65636e49554afe8785cd7aedd21f57 revision: c6bb3db5e1b837a3caa622d673bdc326b171e566 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-24 19:13:39.042818) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-24 19:13:39.043568) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-24 19:13:39.044064) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-24 19:13:39.080786) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 19:13:39.081133) ========= 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=745a4373a2a16df560f216e000000264-1466815098.321207-494276771 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-24 19:13: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% 40.6M=0s 2016-06-24 19:13:39 (40.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.185602 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 19:13:39.284355) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 19:13:39.285079) ========= 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=745a4373a2a16df560f216e000000264-1466815098.321207-494276771 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018107 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 19:13:39.339891) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-24 19:13:39.340862) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev c6bb3db5e1b837a3caa622d673bdc326b171e566 --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 c6bb3db5e1b837a3caa622d673bdc326b171e566 --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=745a4373a2a16df560f216e000000264-1466815098.321207-494276771 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-24 19:13:39,946 truncating revision to first 12 chars 2016-06-24 19:13:39,946 Setting DEBUG logging. 2016-06-24 19:13:39,946 attempt 1/10 2016-06-24 19:13:39,946 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/c6bb3db5e1b8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-24 19:13:40,566 unpacking tar archive at: mozilla-inbound-c6bb3db5e1b8/testing/mozharness/ program finished with exit code 0 elapsedTime=1.016926 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-24 19:13:40.379058) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-24 19:13:40.379648) ========= script_repo_revision: c6bb3db5e1b837a3caa622d673bdc326b171e566 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-24 19:13:40.380163) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-24 19:13:40.380492) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-24 19:13:40.392737) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-06-24 19:13:40.393079) ========= /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=745a4373a2a16df560f216e000000264-1466815098.321207-494276771 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:13:41 INFO - MultiFileLogger online at 20160624 19:13:41 in /builds/slave/test 19:13: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 19:13:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:13:41 INFO - {'append_to_log': False, 19:13:41 INFO - 'base_work_dir': '/builds/slave/test', 19:13:41 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 19:13:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:13:41 INFO - 'branch': 'Mozilla-Inbound', 19:13:41 INFO - 'buildbot_json_path': 'buildprops.json', 19:13:41 INFO - 'config_files': ('talos/linux_config.py',), 19:13:41 INFO - 'default_actions': ('clobber', 19:13:41 INFO - 'read-buildbot-config', 19:13:41 INFO - 'download-and-extract', 19:13:41 INFO - 'populate-webroot', 19:13:41 INFO - 'create-virtualenv', 19:13:41 INFO - 'install', 19:13:41 INFO - 'run-tests'), 19:13:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:13:41 INFO - 'download_minidump_stackwalk': True, 19:13:41 INFO - 'download_symbols': 'ondemand', 19:13:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:13:41 INFO - 'tooltool.py': '/tools/tooltool.py', 19:13:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:13:41 INFO - '/tools/misc-python/virtualenv.py')}, 19:13:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:13:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:13:41 INFO - 'installer_path': 'installer.exe', 19:13:41 INFO - 'log_level': 'info', 19:13:41 INFO - 'log_name': 'talos', 19:13:41 INFO - 'log_to_console': True, 19:13:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:13:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:13:41 INFO - 'opt_config_files': (), 19:13:41 INFO - 'pip_index': False, 19:13:41 INFO - 'sps_profile': False, 19:13:41 INFO - 'sps_profile_interval': 0, 19:13:41 INFO - 'suite': 'dromaeojs', 19:13:41 INFO - 'system_bits': '32', 19:13:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:13:41 INFO - 'title': 'talos-linux64-ix-032', 19:13:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:13:41 INFO - 'use_talos_json': True, 19:13:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:13:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:13:41 INFO - 'work_dir': 'build'} 19:13:41 INFO - ##### 19:13:41 INFO - ##### Running clobber step. 19:13:41 INFO - ##### 19:13:41 INFO - Running pre-action listener: _resource_record_pre_action 19:13:41 INFO - Running main action method: clobber 19:13:41 INFO - rmtree: /builds/slave/test/build 19:13:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:13:41 INFO - Running post-action listener: _resource_record_post_action 19:13:41 INFO - ##### 19:13:41 INFO - ##### Finished clobber step (success) 19:13:41 INFO - ##### 19:13:41 INFO - ##### 19:13:41 INFO - ##### Running read-buildbot-config step. 19:13:41 INFO - ##### 19:13:41 INFO - Running pre-action listener: _resource_record_pre_action 19:13:41 INFO - Running main action method: read_buildbot_config 19:13:41 INFO - Using buildbot properties: 19:13:41 INFO - { 19:13:41 INFO - "project": "", 19:13:41 INFO - "product": "firefox", 19:13:41 INFO - "script_repo_revision": "production", 19:13:41 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 19:13:41 INFO - "repository": "", 19:13:41 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 19:13:41 INFO - "buildid": "20160624163010", 19:13:41 INFO - "pgo_build": "True", 19:13:41 INFO - "basedir": "/builds/slave/test", 19:13:41 INFO - "buildnumber": 1984, 19:13:41 INFO - "slavename": "talos-linux64-ix-032", 19:13:41 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 19:13:41 INFO - "platform": "ubuntu64_hw", 19:13:41 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 19:13:41 INFO - "branch": "mozilla-inbound", 19:13:41 INFO - "repo_path": "integration/mozilla-inbound", 19:13:41 INFO - "revision": "c6bb3db5e1b837a3caa622d673bdc326b171e566", 19:13:41 INFO - "stage_platform": "linux64-pgo", 19:13:41 INFO - "builduid": "ea65636e49554afe8785cd7aedd21f57", 19:13:41 INFO - "slavebuilddir": "test" 19:13:41 INFO - } 19:13:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/T4Pk5F9XRxKNuXGHlQ3WDQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 19:13:41 INFO - Running post-action listener: _resource_record_post_action 19:13:41 INFO - ##### 19:13:41 INFO - ##### Finished read-buildbot-config step (success) 19:13:41 INFO - ##### 19:13:41 INFO - ##### 19:13:41 INFO - ##### Running download-and-extract step. 19:13:41 INFO - ##### 19:13:41 INFO - Running pre-action listener: _resource_record_pre_action 19:13:41 INFO - Running main action method: download_and_extract 19:13:41 INFO - mkdir: /builds/slave/test/build/tests 19:13: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')]} 19:13:41 INFO - https://queue.taskcluster.net/v1/task/T4Pk5F9XRxKNuXGHlQ3WDQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 19:13:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T4Pk5F9XRxKNuXGHlQ3WDQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:13:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T4Pk5F9XRxKNuXGHlQ3WDQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:13:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T4Pk5F9XRxKNuXGHlQ3WDQ/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 19:13:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T4Pk5F9XRxKNuXGHlQ3WDQ/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 19:13:43 INFO - Downloaded 1361 bytes. 19:13:43 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:13:43 INFO - Using the following test package requirements: 19:13:43 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 19:13:43 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:13:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:13:43 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:13:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:13:43 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:13:43 INFO - u'jsshell-linux-x86_64.zip'], 19:13:43 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:13:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:13:43 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 19:13:43 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:13:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:13:43 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:13:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:13:43 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:13:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:13:43 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:13:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:13:43 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:13:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:13:43 INFO - https://queue.taskcluster.net/v1/task/T4Pk5F9XRxKNuXGHlQ3WDQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:13:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T4Pk5F9XRxKNuXGHlQ3WDQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:13:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T4Pk5F9XRxKNuXGHlQ3WDQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:13:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T4Pk5F9XRxKNuXGHlQ3WDQ/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 19:13:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T4Pk5F9XRxKNuXGHlQ3WDQ/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 19:13:44 INFO - Downloaded 24279526 bytes. 19:13:44 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'] 19:13:44 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 19:13:46 INFO - Return code: 0 19:13:46 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 19:13:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:13:46 INFO - https://queue.taskcluster.net/v1/task/T4Pk5F9XRxKNuXGHlQ3WDQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:13:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T4Pk5F9XRxKNuXGHlQ3WDQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:13:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T4Pk5F9XRxKNuXGHlQ3WDQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:13:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T4Pk5F9XRxKNuXGHlQ3WDQ/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 19:13:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T4Pk5F9XRxKNuXGHlQ3WDQ/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 19:13:49 INFO - Downloaded 24279526 bytes. 19:13:49 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'] 19:13:49 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 19:13:51 INFO - Return code: 0 19:13:51 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')]} 19:13:51 INFO - https://queue.taskcluster.net/v1/task/T4Pk5F9XRxKNuXGHlQ3WDQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:13:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T4Pk5F9XRxKNuXGHlQ3WDQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 19:13:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T4Pk5F9XRxKNuXGHlQ3WDQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 19:13:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T4Pk5F9XRxKNuXGHlQ3WDQ/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 19:13:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T4Pk5F9XRxKNuXGHlQ3WDQ/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 19:13:52 INFO - Downloaded 14405188 bytes. 19:13:52 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'] 19:13:52 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 19:13:52 INFO - Return code: 0 19:13: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')]} 19:13:52 INFO - https://queue.taskcluster.net/v1/task/T4Pk5F9XRxKNuXGHlQ3WDQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:13:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T4Pk5F9XRxKNuXGHlQ3WDQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:13:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T4Pk5F9XRxKNuXGHlQ3WDQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:13:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T4Pk5F9XRxKNuXGHlQ3WDQ/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 19:13:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T4Pk5F9XRxKNuXGHlQ3WDQ/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 19:13:53 INFO - Downloaded 60172910 bytes. 19:13:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/T4Pk5F9XRxKNuXGHlQ3WDQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:13:53 INFO - mkdir: /builds/slave/test/properties 19:13:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:13:53 INFO - Writing to file /builds/slave/test/properties/build_url 19:13:53 INFO - Contents: 19:13:53 INFO - build_url:https://queue.taskcluster.net/v1/task/T4Pk5F9XRxKNuXGHlQ3WDQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:13:54 INFO - Running post-action listener: _resource_record_post_action 19:13:54 INFO - Running post-action listener: set_extra_try_arguments 19:13:54 INFO - ##### 19:13:54 INFO - ##### Finished download-and-extract step (success) 19:13:54 INFO - ##### 19:13:54 INFO - ##### 19:13:54 INFO - ##### Running populate-webroot step. 19:13:54 INFO - ##### 19:13:54 INFO - Running pre-action listener: _resource_record_pre_action 19:13:54 INFO - Running main action method: populate_webroot 19:13:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:13:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:13:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:13:54 INFO - '--tppagecycles', 19:13:54 INFO - '7'], 19:13:54 INFO - 'tests': ['tsvgm']}}, 19:13:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:13:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:13:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:13:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:13:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:13:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:13:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:13:54 INFO - 'talos_options': ['--disable-e10s'], 19:13:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:13:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:13:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:13:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:13:54 INFO - 'talos_options': ['--disable-e10s'], 19:13:54 INFO - 'tests': ['damp', 'tps']}, 19:13:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:13:54 INFO - 'tests': ['damp', 'tps']}, 19:13:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:13:54 INFO - 'tests': ['dromaeo_dom']}, 19:13:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:13:54 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:13:54 INFO - 'tests': ['basic_compositor_video']}, 19:13:54 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:13:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:13:54 INFO - 'tests': ['a11yr', 19:13:54 INFO - 'ts_paint', 19:13:54 INFO - 'tpaint', 19:13:54 INFO - 'sessionrestore', 19:13:54 INFO - 'sessionrestore_no_auto_restore', 19:13:54 INFO - 'tabpaint']}, 19:13:54 INFO - 'other-e10s': {'tests': ['a11yr', 19:13:54 INFO - 'ts_paint', 19:13:54 INFO - 'tpaint', 19:13:54 INFO - 'sessionrestore', 19:13:54 INFO - 'sessionrestore_no_auto_restore', 19:13:54 INFO - 'tabpaint']}, 19:13:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:13:54 INFO - 'ts_paint', 19:13:54 INFO - 'tpaint', 19:13:54 INFO - 'sessionrestore', 19:13:54 INFO - 'sessionrestore_no_auto_restore', 19:13:54 INFO - 'tabpaint']}, 19:13:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:13:54 INFO - 'ts_paint', 19:13:54 INFO - 'tpaint', 19:13:54 INFO - 'sessionrestore', 19:13:54 INFO - 'sessionrestore_no_auto_restore', 19:13:54 INFO - 'tabpaint']}, 19:13:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:13:54 INFO - 'tests': ['a11yr', 19:13:54 INFO - 'ts_paint', 19:13:54 INFO - 'tpaint', 19:13:54 INFO - 'sessionrestore', 19:13:54 INFO - 'sessionrestore_no_auto_restore', 19:13:54 INFO - 'tabpaint']}, 19:13:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:13:54 INFO - 'tests': ['a11yr', 19:13:54 INFO - 'ts_paint', 19:13:54 INFO - 'tpaint', 19:13:54 INFO - 'sessionrestore', 19:13:54 INFO - 'sessionrestore_no_auto_restore', 19:13:54 INFO - 'tabpaint']}, 19:13:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:13:54 INFO - 'tests': ['tsvgx', 19:13:54 INFO - 'tsvgr_opacity', 19:13:54 INFO - 'tart', 19:13:54 INFO - 'tscrollx', 19:13:54 INFO - 'cart']}, 19:13:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:13:54 INFO - 'tsvgr_opacity', 19:13:54 INFO - 'tart', 19:13:54 INFO - 'tscrollx', 19:13:54 INFO - 'cart']}, 19:13:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:13:54 INFO - 'talos_options': ['--disable-e10s'], 19:13:54 INFO - 'tests': ['tp5o']}, 19:13:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:13:54 INFO - 'tests': ['tp5o']}, 19:13:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:13:54 INFO - 'talos_options': ['--disable-e10s', 19:13:54 INFO - '--xperf_path', 19:13:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:13:54 INFO - 'tests': ['tp5n']}, 19:13:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:13:54 INFO - 'talos_options': ['--xperf_path', 19:13:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:13:54 INFO - 'tests': ['tp5n']}}, 19:13:54 INFO - 'talos.zip': {'path': '', 19:13:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:13:54 INFO - Running post-action listener: _resource_record_post_action 19:13:54 INFO - ##### 19:13:54 INFO - ##### Finished populate-webroot step (success) 19:13:54 INFO - ##### 19:13:54 INFO - ##### 19:13:54 INFO - ##### Running create-virtualenv step. 19:13:54 INFO - ##### 19:13:54 INFO - Running pre-action listener: _resource_record_pre_action 19:13:54 INFO - Running main action method: create_virtualenv 19:13:54 INFO - Creating virtualenv /builds/slave/test/build/venv 19:13:54 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 19:13:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:13:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:13:54 INFO - Using real prefix '/usr' 19:13:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:13:55 INFO - Installing distribute.............................................................................................................................................................................................done. 19:13:57 INFO - Installing pip.................done. 19:13:57 INFO - Return code: 0 19:13:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:13:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:13:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:13:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:13:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:13:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:13:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:13:57 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 0x7fa4ea08bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21761c0>, '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 0x21770c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2177550>, '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': '745a4373a2a16df560f216e000000264-1466815098.321207-494276771', '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 19:13:57 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 19:13:57 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 19:13:57 INFO - Using env: {'DISPLAY': ':0', 19:13:57 INFO - 'HOME': '/home/cltbld', 19:13:57 INFO - 'LANG': 'en_US.UTF-8', 19:13:57 INFO - 'LANGUAGE': 'en_US:en', 19:13:57 INFO - 'LOGNAME': 'cltbld', 19:13:57 INFO - 'MAIL': '/var/mail/cltbld', 19:13:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:13:57 INFO - 'MOZ_NO_REMOTE': '1', 19:13:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:13:57 INFO - 'NO_EM_RESTART': '1', 19:13:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:13:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:13:57 INFO - 'PWD': '/builds/slave/test', 19:13:57 INFO - 'SHELL': '/bin/bash', 19:13:57 INFO - 'SHLVL': '1', 19:13:57 INFO - 'TERM': 'linux', 19:13:57 INFO - 'TMOUT': '86400', 19:13:57 INFO - 'USER': 'cltbld', 19:13:57 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1466815098.321207-494276771', 19:13:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:13:57 INFO - '_': '/tools/buildbot/bin/python'} 19:13:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:13:57 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 19:13:57 INFO - Cleaning up... 19:13:57 INFO - Return code: 0 19:13:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:13:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:13:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:13:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:13:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:13:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:13:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:13:57 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 0x7fa4ea08bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21761c0>, '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 0x21770c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2177550>, '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': '745a4373a2a16df560f216e000000264-1466815098.321207-494276771', '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 19:13:57 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 19:13:57 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 19:13:57 INFO - Using env: {'DISPLAY': ':0', 19:13:57 INFO - 'HOME': '/home/cltbld', 19:13:57 INFO - 'LANG': 'en_US.UTF-8', 19:13:57 INFO - 'LANGUAGE': 'en_US:en', 19:13:57 INFO - 'LOGNAME': 'cltbld', 19:13:57 INFO - 'MAIL': '/var/mail/cltbld', 19:13:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:13:57 INFO - 'MOZ_NO_REMOTE': '1', 19:13:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:13:57 INFO - 'NO_EM_RESTART': '1', 19:13:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:13:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:13:57 INFO - 'PWD': '/builds/slave/test', 19:13:57 INFO - 'SHELL': '/bin/bash', 19:13:57 INFO - 'SHLVL': '1', 19:13:57 INFO - 'TERM': 'linux', 19:13:57 INFO - 'TMOUT': '86400', 19:13:57 INFO - 'USER': 'cltbld', 19:13:57 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1466815098.321207-494276771', 19:13:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:13:57 INFO - '_': '/tools/buildbot/bin/python'} 19:13:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:13:57 INFO - Downloading/unpacking psutil>=3.1.1 19:13:57 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 19:13:57 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 19:13:57 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 19:13:57 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 19:13:57 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 19:13:57 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 19:13:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:13:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:13:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:13:59 INFO - Installing collected packages: psutil 19:13:59 INFO - Running setup.py install for psutil 19:13:59 INFO - building 'psutil._psutil_linux' extension 19:13:59 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 19:13:59 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 19:13:59 INFO - building 'psutil._psutil_posix' extension 19:13:59 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 19:14:00 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 19:14:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:14:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:14:00 INFO - Successfully installed psutil 19:14:00 INFO - Cleaning up... 19:14:00 INFO - Return code: 0 19:14:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:14:00 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')]} 19:14:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:14:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:14:00 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')]} 19:14:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:14:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:14:00 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 0x7fa4ea08bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21761c0>, '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 0x21770c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2177550>, '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': '745a4373a2a16df560f216e000000264-1466815098.321207-494276771', '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 19:14:00 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 19:14:00 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 19:14:00 INFO - Using env: {'DISPLAY': ':0', 19:14:00 INFO - 'HOME': '/home/cltbld', 19:14:00 INFO - 'LANG': 'en_US.UTF-8', 19:14:00 INFO - 'LANGUAGE': 'en_US:en', 19:14:00 INFO - 'LOGNAME': 'cltbld', 19:14:00 INFO - 'MAIL': '/var/mail/cltbld', 19:14:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:14:00 INFO - 'MOZ_NO_REMOTE': '1', 19:14:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:14:00 INFO - 'NO_EM_RESTART': '1', 19:14:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:14:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:14:00 INFO - 'PWD': '/builds/slave/test', 19:14:00 INFO - 'SHELL': '/bin/bash', 19:14:00 INFO - 'SHLVL': '1', 19:14:00 INFO - 'TERM': 'linux', 19:14:00 INFO - 'TMOUT': '86400', 19:14:00 INFO - 'USER': 'cltbld', 19:14:00 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1466815098.321207-494276771', 19:14:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:14:00 INFO - '_': '/tools/buildbot/bin/python'} 19:14:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:14:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:14:00 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 19:14:00 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 19:14:00 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 19:14:00 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 19:14:00 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 19:14:00 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 19:14:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:14:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:14:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:14:02 INFO - Installing collected packages: mozsystemmonitor 19:14:02 INFO - Running setup.py install for mozsystemmonitor 19:14:02 INFO - Successfully installed mozsystemmonitor 19:14:02 INFO - Cleaning up... 19:14:02 INFO - Return code: 0 19:14:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:14:02 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')]} 19:14:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:14:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:14:02 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')]} 19:14:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:14:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:14:02 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 0x7fa4ea08bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21761c0>, '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 0x21770c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2177550>, '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': '745a4373a2a16df560f216e000000264-1466815098.321207-494276771', '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 19:14:02 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 19:14:02 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 19:14:02 INFO - Using env: {'DISPLAY': ':0', 19:14:02 INFO - 'HOME': '/home/cltbld', 19:14:02 INFO - 'LANG': 'en_US.UTF-8', 19:14:02 INFO - 'LANGUAGE': 'en_US:en', 19:14:02 INFO - 'LOGNAME': 'cltbld', 19:14:02 INFO - 'MAIL': '/var/mail/cltbld', 19:14:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:14:02 INFO - 'MOZ_NO_REMOTE': '1', 19:14:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:14:02 INFO - 'NO_EM_RESTART': '1', 19:14:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:14:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:14:02 INFO - 'PWD': '/builds/slave/test', 19:14:02 INFO - 'SHELL': '/bin/bash', 19:14:02 INFO - 'SHLVL': '1', 19:14:02 INFO - 'TERM': 'linux', 19:14:02 INFO - 'TMOUT': '86400', 19:14:02 INFO - 'USER': 'cltbld', 19:14:02 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1466815098.321207-494276771', 19:14:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:14:02 INFO - '_': '/tools/buildbot/bin/python'} 19:14:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:14:02 INFO - Downloading/unpacking jsonschema==2.5.1 19:14:02 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 19:14:02 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 19:14:02 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 19:14:02 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 19:14:02 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 19:14:02 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 19:14:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:14:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:14:04 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 19:14:04 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 19:14:04 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 19:14:04 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 19:14:04 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 19:14:04 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 19:14:04 INFO - Downloading functools32-3.2.3-2.tar.gz 19:14:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:14:04 INFO - warning: no files found matching '*.txt' 19:14:04 INFO - no previously-included directories found matching 'build' 19:14:04 INFO - no previously-included directories found matching 'dist' 19:14:04 INFO - no previously-included directories found matching '.git*' 19:14:04 INFO - Installing collected packages: jsonschema, functools32 19:14:04 INFO - Running setup.py install for functools32 19:14:04 INFO - warning: no files found matching '*.txt' 19:14:04 INFO - no previously-included directories found matching 'build' 19:14:04 INFO - no previously-included directories found matching 'dist' 19:14:04 INFO - no previously-included directories found matching '.git*' 19:14:04 INFO - Successfully installed jsonschema functools32 19:14:04 INFO - Cleaning up... 19:14:05 INFO - Return code: 0 19:14:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:14:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:14:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:14:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:14:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:14:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:14:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:14:05 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 0x7fa4ea08bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21761c0>, '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 0x21770c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2177550>, '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': '745a4373a2a16df560f216e000000264-1466815098.321207-494276771', '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 19:14:05 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 19:14:05 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 19:14:05 INFO - Using env: {'DISPLAY': ':0', 19:14:05 INFO - 'HOME': '/home/cltbld', 19:14:05 INFO - 'LANG': 'en_US.UTF-8', 19:14:05 INFO - 'LANGUAGE': 'en_US:en', 19:14:05 INFO - 'LOGNAME': 'cltbld', 19:14:05 INFO - 'MAIL': '/var/mail/cltbld', 19:14:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:14:05 INFO - 'MOZ_NO_REMOTE': '1', 19:14:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:14:05 INFO - 'NO_EM_RESTART': '1', 19:14:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:14:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:14:05 INFO - 'PWD': '/builds/slave/test', 19:14:05 INFO - 'SHELL': '/bin/bash', 19:14:05 INFO - 'SHLVL': '1', 19:14:05 INFO - 'TERM': 'linux', 19:14:05 INFO - 'TMOUT': '86400', 19:14:05 INFO - 'USER': 'cltbld', 19:14:05 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1466815098.321207-494276771', 19:14:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:14:05 INFO - '_': '/tools/buildbot/bin/python'} 19:14:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:14:05 INFO - Downloading/unpacking blobuploader==1.2.4 19:14:05 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 19:14:05 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 19:14:05 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 19:14:05 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 19:14:05 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 19:14:05 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 19:14:07 INFO - Downloading blobuploader-1.2.4.tar.gz 19:14:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:14:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:14:07 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 19:14:07 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 19:14:07 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 19:14:07 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 19:14:07 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 19:14:07 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 19:14:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:14:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:14:07 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 19:14:07 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 19:14:07 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 19:14:07 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 19:14:07 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 19:14:07 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 19:14:07 INFO - Downloading docopt-0.6.1.tar.gz 19:14:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:14:07 INFO - Installing collected packages: blobuploader, requests, docopt 19:14:07 INFO - Running setup.py install for blobuploader 19:14:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:14:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:14:07 INFO - Running setup.py install for requests 19:14:08 INFO - Running setup.py install for docopt 19:14:08 INFO - Successfully installed blobuploader requests docopt 19:14:08 INFO - Cleaning up... 19:14:08 INFO - Return code: 0 19:14:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:14:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:14:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:14:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:14:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:14:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:14:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:14:08 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 0x7fa4ea08bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21761c0>, '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 0x21770c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2177550>, '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': '745a4373a2a16df560f216e000000264-1466815098.321207-494276771', '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 19:14:08 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 19:14:08 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 19:14:08 INFO - Using env: {'DISPLAY': ':0', 19:14:08 INFO - 'HOME': '/home/cltbld', 19:14:08 INFO - 'LANG': 'en_US.UTF-8', 19:14:08 INFO - 'LANGUAGE': 'en_US:en', 19:14:08 INFO - 'LOGNAME': 'cltbld', 19:14:08 INFO - 'MAIL': '/var/mail/cltbld', 19:14:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:14:08 INFO - 'MOZ_NO_REMOTE': '1', 19:14:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:14:08 INFO - 'NO_EM_RESTART': '1', 19:14:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:14:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:14:08 INFO - 'PWD': '/builds/slave/test', 19:14:08 INFO - 'SHELL': '/bin/bash', 19:14:08 INFO - 'SHLVL': '1', 19:14:08 INFO - 'TERM': 'linux', 19:14:08 INFO - 'TMOUT': '86400', 19:14:08 INFO - 'USER': 'cltbld', 19:14:08 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1466815098.321207-494276771', 19:14:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:14:08 INFO - '_': '/tools/buildbot/bin/python'} 19:14:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:14:08 INFO - Running setup.py (path:/tmp/pip-iC8I7_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:14:08 INFO - Running setup.py (path:/tmp/pip-gcjK7_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:14:08 INFO - Running setup.py (path:/tmp/pip-pvVgtr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:14:08 INFO - Running setup.py (path:/tmp/pip-HrkccQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:14:09 INFO - Running setup.py (path:/tmp/pip-qRjw1W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:14:09 INFO - Running setup.py (path:/tmp/pip-vasens-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:14:09 INFO - Running setup.py (path:/tmp/pip-8sO4sp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:14:09 INFO - Running setup.py (path:/tmp/pip-ydadR7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:14:09 INFO - Running setup.py (path:/tmp/pip-ChZp6f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:14:09 INFO - Running setup.py (path:/tmp/pip-cyZi6w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:14:09 INFO - Running setup.py (path:/tmp/pip-i9NCMs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:14:09 INFO - Running setup.py (path:/tmp/pip-_z7ZXP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:14:09 INFO - Running setup.py (path:/tmp/pip-NRBmXk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:14:09 INFO - Running setup.py (path:/tmp/pip-K8ezfW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:14:09 INFO - Running setup.py (path:/tmp/pip-isHnC7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:14:09 INFO - Running setup.py (path:/tmp/pip-O1NO_w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:14:09 INFO - Running setup.py (path:/tmp/pip-UhV5NC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:14:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:14:09 INFO - Running setup.py install for manifestparser 19:14:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:14:10 INFO - Running setup.py install for mozcrash 19:14:10 INFO - Running setup.py install for mozdebug 19:14:10 INFO - Running setup.py install for mozdevice 19:14:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:14:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:14:10 INFO - Running setup.py install for mozfile 19:14:10 INFO - Running setup.py install for mozhttpd 19:14:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:14:10 INFO - Running setup.py install for mozinfo 19:14:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:14:10 INFO - Running setup.py install for mozInstall 19:14:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:14:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:14:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:14:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:14:10 INFO - Running setup.py install for mozleak 19:14:10 INFO - Running setup.py install for mozlog 19:14:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:14:10 INFO - Running setup.py install for moznetwork 19:14:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:14:11 INFO - Running setup.py install for mozprocess 19:14:11 INFO - Running setup.py install for mozprofile 19:14:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:14:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:14:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:14:11 INFO - Running setup.py install for mozrunner 19:14:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:14:11 INFO - Running setup.py install for mozscreenshot 19:14:11 INFO - Running setup.py install for moztest 19:14:11 INFO - Running setup.py install for mozversion 19:14:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:14:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:14:11 INFO - Cleaning up... 19:14:11 INFO - Return code: 0 19:14:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:14: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')]} 19:14:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:14:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:14: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')]} 19:14:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:14:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:14:11 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 0x7fa4ea08bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21761c0>, '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 0x21770c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2177550>, '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': '745a4373a2a16df560f216e000000264-1466815098.321207-494276771', '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 19:14:11 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 19:14:11 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 19:14:11 INFO - Using env: {'DISPLAY': ':0', 19:14:11 INFO - 'HOME': '/home/cltbld', 19:14:11 INFO - 'LANG': 'en_US.UTF-8', 19:14:11 INFO - 'LANGUAGE': 'en_US:en', 19:14:11 INFO - 'LOGNAME': 'cltbld', 19:14:11 INFO - 'MAIL': '/var/mail/cltbld', 19:14:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:14:11 INFO - 'MOZ_NO_REMOTE': '1', 19:14:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:14:11 INFO - 'NO_EM_RESTART': '1', 19:14:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:14:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:14:11 INFO - 'PWD': '/builds/slave/test', 19:14:11 INFO - 'SHELL': '/bin/bash', 19:14:11 INFO - 'SHLVL': '1', 19:14:11 INFO - 'TERM': 'linux', 19:14:11 INFO - 'TMOUT': '86400', 19:14:11 INFO - 'USER': 'cltbld', 19:14:11 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1466815098.321207-494276771', 19:14:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:14:11 INFO - '_': '/tools/buildbot/bin/python'} 19:14:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:14:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:14:11 INFO - Running setup.py (path:/tmp/pip-lLr7nj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:14:12 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)) 19:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:14:12 INFO - Running setup.py (path:/tmp/pip-n9HLLS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:14:12 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)) 19:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:14:12 INFO - Running setup.py (path:/tmp/pip-VsrhrG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:14:12 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)) 19:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:14:12 INFO - Running setup.py (path:/tmp/pip-aZTJTh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:14:12 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)) 19:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:14:12 INFO - Running setup.py (path:/tmp/pip-iAohhn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:14:12 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)) 19:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:14:12 INFO - Running setup.py (path:/tmp/pip-gc_xPA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:14:12 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)) 19:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:14:12 INFO - Running setup.py (path:/tmp/pip-6s5yRt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:14:12 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)) 19:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:14:12 INFO - Running setup.py (path:/tmp/pip-EoZpIx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:14:12 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)) 19:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:14:12 INFO - Running setup.py (path:/tmp/pip-wiwNug-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:14:12 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)) 19:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:14:12 INFO - Running setup.py (path:/tmp/pip-qsC1zS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:14:12 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)) 19:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:14:12 INFO - Running setup.py (path:/tmp/pip-5_iOey-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:14:12 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)) 19:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:14:12 INFO - Running setup.py (path:/tmp/pip-KyxBAz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:14:12 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)) 19:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:14:12 INFO - Running setup.py (path:/tmp/pip-4Uj5ZR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:14:12 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)) 19:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:14:12 INFO - Running setup.py (path:/tmp/pip-OA9hhs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:14:12 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)) 19:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:14:12 INFO - Running setup.py (path:/tmp/pip-RRsvpf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:14:13 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)) 19:14:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:14:13 INFO - Running setup.py (path:/tmp/pip-FxW7GB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:14:13 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)) 19:14:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:14:13 INFO - Running setup.py (path:/tmp/pip-pozjNl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:14:13 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)) 19:14:13 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)) 19:14:13 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)) 19:14:13 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)) 19:14:13 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)) 19:14:13 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)) 19:14:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:14:13 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 19:14:13 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 19:14:13 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 19:14:13 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 19:14:13 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 19:14:13 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 19:14:15 INFO - Downloading blessings-1.6.tar.gz 19:14:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:14:15 INFO - Installing collected packages: blessings 19:14:15 INFO - Running setup.py install for blessings 19:14:15 INFO - Successfully installed blessings 19:14:15 INFO - Cleaning up... 19:14:15 INFO - Return code: 0 19:14:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:14:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:14:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:14:15 INFO - Reading from file tmpfile_stdout 19:14:15 INFO - Current package versions: 19:14:15 INFO - argparse == 1.2.1 19:14:15 INFO - blessings == 1.6 19:14:15 INFO - blobuploader == 1.2.4 19:14:15 INFO - docopt == 0.6.1 19:14:15 INFO - functools32 == 3.2.3-2 19:14:15 INFO - jsonschema == 2.5.1 19:14:15 INFO - manifestparser == 1.1 19:14:15 INFO - mozInstall == 1.12 19:14:15 INFO - mozcrash == 0.17 19:14:15 INFO - mozdebug == 0.1 19:14:15 INFO - mozdevice == 0.48 19:14:15 INFO - mozfile == 1.2 19:14:15 INFO - mozhttpd == 0.7 19:14:15 INFO - mozinfo == 0.9 19:14:15 INFO - mozleak == 0.1 19:14:15 INFO - mozlog == 3.2 19:14:15 INFO - moznetwork == 0.27 19:14:15 INFO - mozprocess == 0.22 19:14:15 INFO - mozprofile == 0.28 19:14:15 INFO - mozrunner == 6.11 19:14:15 INFO - mozscreenshot == 0.1 19:14:15 INFO - mozsystemmonitor == 0.3 19:14:15 INFO - moztest == 0.7 19:14:15 INFO - mozversion == 1.4 19:14:15 INFO - psutil == 3.1.1 19:14:15 INFO - requests == 1.2.3 19:14:15 INFO - wsgiref == 0.1.2 19:14:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:14: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')]} 19:14:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:14:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:14: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')]} 19:14:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:14:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:14:15 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 0x7fa4ea08bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21761c0>, '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 0x21770c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2177550>, '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': '745a4373a2a16df560f216e000000264-1466815098.321207-494276771', '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 19:14:15 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 19:14:15 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 19:14:15 INFO - Using env: {'DISPLAY': ':0', 19:14:15 INFO - 'HOME': '/home/cltbld', 19:14:15 INFO - 'LANG': 'en_US.UTF-8', 19:14:15 INFO - 'LANGUAGE': 'en_US:en', 19:14:15 INFO - 'LOGNAME': 'cltbld', 19:14:15 INFO - 'MAIL': '/var/mail/cltbld', 19:14:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:14:15 INFO - 'MOZ_NO_REMOTE': '1', 19:14:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:14:15 INFO - 'NO_EM_RESTART': '1', 19:14:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:14:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:14:15 INFO - 'PWD': '/builds/slave/test', 19:14:15 INFO - 'SHELL': '/bin/bash', 19:14:15 INFO - 'SHLVL': '1', 19:14:15 INFO - 'TERM': 'linux', 19:14:15 INFO - 'TMOUT': '86400', 19:14:15 INFO - 'USER': 'cltbld', 19:14:15 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1466815098.321207-494276771', 19:14:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:14:15 INFO - '_': '/tools/buildbot/bin/python'} 19:14:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:14:15 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)) 19:14:15 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)) 19:14:15 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)) 19:14:15 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)) 19:14:15 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)) 19:14:15 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)) 19:14:15 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)) 19:14:15 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)) 19:14:15 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)) 19:14:15 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)) 19:14:15 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)) 19:14:15 INFO - Cleaning up... 19:14:15 INFO - Return code: 0 19:14:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:14: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')]} 19:14:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:14:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:14: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')]} 19:14:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:14:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:14: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa4ea08bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21761c0>, '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 0x21770c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2177550>, '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': '745a4373a2a16df560f216e000000264-1466815098.321207-494276771', '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 19:14: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', 'jsonschema'] in /builds/slave/test/build 19:14: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 jsonschema 19:14:15 INFO - Using env: {'DISPLAY': ':0', 19:14:15 INFO - 'HOME': '/home/cltbld', 19:14:15 INFO - 'LANG': 'en_US.UTF-8', 19:14:15 INFO - 'LANGUAGE': 'en_US:en', 19:14:15 INFO - 'LOGNAME': 'cltbld', 19:14:15 INFO - 'MAIL': '/var/mail/cltbld', 19:14:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:14:15 INFO - 'MOZ_NO_REMOTE': '1', 19:14:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:14:15 INFO - 'NO_EM_RESTART': '1', 19:14:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:14:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:14:15 INFO - 'PWD': '/builds/slave/test', 19:14:15 INFO - 'SHELL': '/bin/bash', 19:14:15 INFO - 'SHLVL': '1', 19:14:15 INFO - 'TERM': 'linux', 19:14:15 INFO - 'TMOUT': '86400', 19:14:15 INFO - 'USER': 'cltbld', 19:14:15 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1466815098.321207-494276771', 19:14:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:14:15 INFO - '_': '/tools/buildbot/bin/python'} 19:14:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:14:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:14:15 INFO - Cleaning up... 19:14:15 INFO - Return code: 0 19:14:15 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 19:14: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')]} 19:14:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:14:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:14: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')]} 19:14:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:14:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:14: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa4ea08bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21761c0>, '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 0x21770c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2177550>, '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': '745a4373a2a16df560f216e000000264-1466815098.321207-494276771', '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 19:14: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', 'flake8'] in /builds/slave/test/build 19:14: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 flake8 19:14:15 INFO - Using env: {'DISPLAY': ':0', 19:14:15 INFO - 'HOME': '/home/cltbld', 19:14:15 INFO - 'LANG': 'en_US.UTF-8', 19:14:15 INFO - 'LANGUAGE': 'en_US:en', 19:14:15 INFO - 'LOGNAME': 'cltbld', 19:14:15 INFO - 'MAIL': '/var/mail/cltbld', 19:14:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:14:15 INFO - 'MOZ_NO_REMOTE': '1', 19:14:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:14:15 INFO - 'NO_EM_RESTART': '1', 19:14:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:14:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:14:15 INFO - 'PWD': '/builds/slave/test', 19:14:15 INFO - 'SHELL': '/bin/bash', 19:14:15 INFO - 'SHLVL': '1', 19:14:15 INFO - 'TERM': 'linux', 19:14:15 INFO - 'TMOUT': '86400', 19:14:15 INFO - 'USER': 'cltbld', 19:14:15 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1466815098.321207-494276771', 19:14:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:14:15 INFO - '_': '/tools/buildbot/bin/python'} 19:14:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:14:16 INFO - Downloading/unpacking flake8 19:14: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 19:14: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 19:14: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 19:14: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 19:14: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 19:14: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 19:14:18 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:14:18 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:14: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 19:14: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 19:14: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 19:14: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 19:14: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 19:14: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 19:14:18 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:14:18 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:14: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 19:14: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 19:14: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 19:14: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 19:14: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 19:14: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 19:14:18 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:14: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 19:14: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 19:14: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 19:14: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 19:14: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 19:14: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 19:14:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 19:14:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:14:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:14:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:14:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:14:18 INFO - no previously-included directories found matching 'docs/_build' 19:14:18 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:14:18 INFO - Running setup.py install for pep8 19:14:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:14:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:14:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:14:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:14:18 INFO - no previously-included directories found matching 'docs/_build' 19:14:18 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 19:14:19 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:14:19 INFO - Cleaning up... 19:14:19 INFO - Return code: 0 19:14:19 INFO - Running post-action listener: _resource_record_post_action 19:14:19 INFO - Running post-action listener: _start_resource_monitoring 19:14:19 INFO - Starting resource monitoring. 19:14:19 INFO - ##### 19:14:19 INFO - ##### Finished create-virtualenv step (success) 19:14:19 INFO - ##### 19:14:19 INFO - ##### 19:14:19 INFO - ##### Running install step. 19:14:19 INFO - ##### 19:14:19 INFO - Running pre-action listener: _resource_record_pre_action 19:14:19 INFO - Running main action method: install 19:14:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:14:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:14:19 INFO - Reading from file tmpfile_stdout 19:14:19 INFO - Detecting whether we're running mozinstall >=1.0... 19:14:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:14:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:14:19 INFO - Reading from file tmpfile_stdout 19:14:19 INFO - Output received: 19:14:19 INFO - Usage: mozinstall [options] installer 19:14:19 INFO - Options: 19:14:19 INFO - -h, --help show this help message and exit 19:14:19 INFO - -d DEST, --destination=DEST 19:14:19 INFO - Directory to install application into. [default: 19:14:19 INFO - "/builds/slave/test"] 19:14:19 INFO - --app=APP Application being installed. [default: firefox] 19:14:19 INFO - mkdir: /builds/slave/test/build/application 19:14:19 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'] 19:14:19 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 19:14:37 INFO - Reading from file tmpfile_stdout 19:14:37 INFO - Output received: 19:14:37 INFO - /builds/slave/test/build/application/firefox/firefox 19:14:37 INFO - Running post-action listener: _resource_record_post_action 19:14:37 INFO - ##### 19:14:37 INFO - ##### Finished install step (success) 19:14:37 INFO - ##### 19:14:37 INFO - ##### 19:14:37 INFO - ##### Running run-tests step. 19:14:37 INFO - ##### 19:14:37 INFO - Running pre-action listener: _resource_record_pre_action 19:14:37 INFO - Running main action method: run_tests 19:14:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:14:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:14:37 INFO - Python 2.7.3 19:14:37 INFO - Return code: 0 19:14:37 INFO - grabbing minidump binary from tooltool 19:14:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:14:37 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 0x21761c0>, '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 0x21770c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2177550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:14:37 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 19:14:37 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 19:14:37 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 19:14:37 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:14:37 INFO - Return code: 0 19:14:37 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:14:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:14:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:14:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:14:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:14:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 19:14:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 19:14:38 INFO - Return code: 0 19:14:38 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/T4Pk5F9XRxKNuXGHlQ3WDQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--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 19:14:38 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/T4Pk5F9XRxKNuXGHlQ3WDQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-032 --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 19:14:38 INFO - Using env: {'DISPLAY': ':0', 19:14:38 INFO - 'HOME': '/home/cltbld', 19:14:38 INFO - 'LANG': 'en_US.UTF-8', 19:14:38 INFO - 'LANGUAGE': 'en_US:en', 19:14:38 INFO - 'LOGNAME': 'cltbld', 19:14:38 INFO - 'MAIL': '/var/mail/cltbld', 19:14:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:14:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:14:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:14:38 INFO - 'MOZ_NO_REMOTE': '1', 19:14:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:14:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:14:38 INFO - 'NO_EM_RESTART': '1', 19:14:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:14:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:14:38 INFO - 'PWD': '/builds/slave/test', 19:14:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:14:38 INFO - 'SHELL': '/bin/bash', 19:14:38 INFO - 'SHLVL': '1', 19:14:38 INFO - 'TERM': 'linux', 19:14:38 INFO - 'TMOUT': '86400', 19:14:38 INFO - 'USER': 'cltbld', 19:14:38 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1466815098.321207-494276771', 19:14:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:14:38 INFO - '_': '/tools/buildbot/bin/python'} 19:14:38 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/T4Pk5F9XRxKNuXGHlQ3WDQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--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 19:14:38 INFO - mozversion application_buildid: 20160624163010 19:14:38 INFO - mozversion application_changeset: c6bb3db5e1b837a3caa622d673bdc326b171e566 19:14:38 INFO - mozversion application_display_name: Nightly 19:14:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:14:38 INFO - mozversion application_name: Firefox 19:14:38 INFO - mozversion application_remotingname: firefox 19:14:38 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 19:14:38 INFO - mozversion application_vendor: Mozilla 19:14:38 INFO - mozversion application_version: 50.0a1 19:14:38 INFO - mozversion platform_buildid: 20160624163010 19:14:38 INFO - mozversion platform_changeset: c6bb3db5e1b837a3caa622d673bdc326b171e566 19:14:38 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 19:14:38 INFO - mozversion platform_version: 50.0a1 19:14:38 INFO - using testdate: 1466820878 19:14:38 INFO - actual date: 1466820878 19:14:38 INFO - starting webserver on 'localhost:57671' 19:14:38 INFO - SUITE-START | Running 2 tests 19:14:38 INFO - TEST-START | dromaeo_css 19:14:38 INFO - operating with platform_type : linux_ 19:14:38 INFO - Initialising browser for dromaeo_css test... 19:14:38 INFO - TEST-INFO | started process 11796 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjbzyK5/profile http://localhost:57671/getInfo.html) 19:14:42 INFO - PROCESS | 11796 | __metrics Screen width/height:1600/1200 19:14:42 INFO - PROCESS | 11796 | colorDepth:24 19:14:42 INFO - PROCESS | 11796 | Browser inner width/height: 1024/697 19:14:42 INFO - PROCESS | 11796 | __metrics 19:14:44 INFO - PROCESS | 11796 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:14:45 INFO - TEST-INFO | 11796: exit 0 19:14:45 INFO - Browser initialized. 19:14:45 INFO - Running cycle 1/1 for dromaeo_css test... 19:14:45 INFO - TEST-INFO | started process 11882 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjbzyK5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:14:57 INFO - PROCESS | 11882 | RSS: Main: 174272512 19:14:57 INFO - PROCESS | 11882 | 19:15:48 INFO - PROCESS | 11882 | 1466820948942 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] 19:17:56 INFO - PROCESS | 11882 | Cycle 1(1): loaded http://localhost:57671/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57671/tests/dromaeo/cssquery-ext.html) 19:17:58 INFO - PROCESS | 11882 | RSS: Main: 298889216 19:17:58 INFO - PROCESS | 11882 | 19:21:00 INFO - PROCESS | 11882 | Cycle 1(1): loaded http://localhost:57671/tests/dromaeo/cssquery-ext.html (next: http://localhost:57671/tests/dromaeo/cssquery-jquery.html) 19:21:01 INFO - PROCESS | 11882 | RSS: Main: 257265664 19:21:01 INFO - PROCESS | 11882 | 19:24:03 INFO - PROCESS | 11882 | Cycle 1(1): loaded http://localhost:57671/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57671/tests/dromaeo/cssquery-mootools.html) 19:24:03 INFO - PROCESS | 11882 | RSS: Main: 264269824 19:24:03 INFO - PROCESS | 11882 | 19:27:05 INFO - PROCESS | 11882 | Cycle 1(1): loaded http://localhost:57671/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57671/tests/dromaeo/cssquery-prototype.html) 19:27:06 INFO - PROCESS | 11882 | RSS: Main: 258015232 19:27:06 INFO - PROCESS | 11882 | 19:30:08 INFO - PROCESS | 11882 | Cycle 1(1): loaded http://localhost:57671/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57671/tests/dromaeo/cssquery-yui.html) 19:30:09 INFO - PROCESS | 11882 | RSS: Main: 220844032 19:30:09 INFO - PROCESS | 11882 | 19:33:12 INFO - PROCESS | 11882 | Cycle 1(1): loaded http://localhost:57671/tests/dromaeo/cssquery-yui.html (next: http://localhost:57671/tests/dromaeo/cssquery-dojo.html) 19:33:12 INFO - PROCESS | 11882 | RSS: Main: 291844096 19:33:12 INFO - PROCESS | 11882 | 19:33:12 INFO - PROCESS | 11882 | __start_tp_report 19:33:12 INFO - PROCESS | 11882 | _x_x_mozilla_page_load 19:33:12 INFO - PROCESS | 11882 | _x_x_mozilla_page_load_details 19:33:12 INFO - PROCESS | 11882 | |i|pagename|runs| 19:33:12 INFO - PROCESS | 11882 | |0;dojo.html;3090.6909309069088;3090.752739780817;3092.4742793725063;3109.455845227085;3152.2749767553464;5222.060029194743;5326.973365133179;5341.626086173969;5426.1046927257;5443.346798384195;5306.124489459245;5328.733563321838;5332.440093790155;5357.866053348668;5390.595705322097;4773.4510531289;4831.251156070814;4835.6131509479155;4839.419269687643;4958.2562615607585;4851.369321988154;4867.099586576477;4892.021595680861;4908.19014862549;4908.337374454439;4743.1699452596;4752.500987396325;4787.186178349654;4799.160146974265;4807.927881081787;4828.396450443694;4833.10587541306;4838.395200599925;4862.902741945177;4933.407991041062;4842.927356089662;4852.660313778037;4868.440129385131;4889.608831293488;4913.926291105637;5236.3978142513715;5298.947010529884;5311.203319502067;5366.4901834326065;5377.3009508764;5710.457506536873;5717.313922329347;5721.084626459747;5764.07774756037;5764.279465066867;5785.247917770663;5786.045302525078;5807.912881306742;5812.593118481708;5812.680302583356;5133.25567792668;5214.32213812202;5243.10867152585;5253.26454296395;5318.840434786963;5805.187273781674;5805.854853628609;5809.070548712186;5820.35976042635;5823.2429784128635;5591.46881046308;5599.44005599445;5600;5601;5602.299712535933;5533.778648854081;5612.747426365823;5673.319201695823;5673.574481913791;5744.224529688438;5661.7735290588735;5666.235058267163;5668.461496157858;5673.347565030074;5705.657660540381;5607.383187849333;5673.3475650299915;5676.545876329884;5678.488935995698;5679.574031947621;4302.827886884552;4325.178216138924;4330.501992270866;4338.696291259645;4353.782310884443;3868.613138686109;3899.941500877489;3900.531936167678;3901.6293452122572;3970.5830887756947;5443.237946687467;5452.809151679672;5453.072977593819;5456.508914197741;5492.176173573916;5499.670019798745;5625.071863142617;5662.5753068520025;5759.884802303931;5812.302523697099;5368.704721240291;5380.865478362994;5387.434319396485;5387.568994480433;5427;4933.112039832793;4933.432655244693;4944.499504459861;4955.876103097451;4993.575546078551;5786;5789.88420231593;5867.589268751231;5912.054071348563;5917.289925209003;5725.456081672234;5760.913586296125;5761.251037365116;5763.7982670606325;5765;5926.4666180044005;5937.109433584824;5945.40545945402;5946.910796337972;5949.583529153091;5466.043442397485;5536.806211782568;5544.085225937675;5592.077307244259;5599.132134519156;5625.634333768292;5661.745221465127;5663.348714897839;5685.175649530877;5696.829095127153;5445.128779395278;5541.224228608079;5553.666779993052;5556.194351819045;5559.749811258423;5405.00007498614;5433.130699088127;5443.455654434525;5467.890642187054;5467.917981230205;5376.838694839161;5380.435054319397;5394.730263486888;5428.212909128075;5447.891042179055;5429.565634749131;5528.834134975958;5598.748056337393;5603.439656034364;5616.7191640416995;5400.108982017923;5437.864053398696;5453.263809385682;5465.754041068082;5523.6685798852195 19:33:12 INFO - PROCESS | 11882 | |1;ext.html;572.7422659803087;601.6570554783772;616.4113271825407;620.2835724737928;634.5050860328945;30765.230869228282;43334.34998475022;44237.7788111059;44257.33613995793;44305.11389772207;45421.54578454215;45857;45986;46002.30996535055;46118.07763844721;8763;8831.911680883206;8880.511571863544;8886.822263554724;8890.110988901122;8938.150875666834;9048.095190480964;9050.86423703645;9051.411658242227;9056.637734490645;9104.089591040909;9144.451332920045;9151.816963660724;9153.633854645806;9155.26757859373;9028.819423611523;9064.592093355783;9074.727758167266;9075.410098343653;9080.046595107551;8917.910820891773;8990.415622984485;9001.144891235323;9003.909960900373;9009.189172974464;42064.36903446451;42128.78935605302;42450.36324455136;42546.36180457295;42589.78705106486;3257.2671148991526;3644.2711457708565;3863.2659794639208;3939.9015024624327;3995.20095980805;31429.685703143132;32513.6748632513;32832.17919552006;33125.503117453016;33249.833750831334;4433.889152771174;4499.325101234808;4526.434195725535;4590.770461476913;4680.157571637104;354024;356229;357529.2123539392;357894.8947297378;358012;59874;59922.101168482506;60303.09545356823;60357.39642603606;60409.09386359208;56783.43216567781;57126;57177.428225718046;57185;57229.42770572324;13973.441062357595;15361.923190383977;15706;16122.75815862763;16150.273237704332;12075.396230188455;12254.632361029184;12257.754844903053;12266.080043996735;12270.38648067593;18918.43244702661;19034;19052.71420928687;19123.90438047801;19137.90431047836;5872.324682661549;7035.522540266601;7253.347198752138;7292.19785823559;7323.157836848724;871.1636828644572;956.1060408518058;988.9604415823286;999.1656966432964;1072.3030030480095;31307.129113670824;31846.2038449036;32053.198670033435;32094.358112837614;32612.510812337834;1048.1981284317503;1103.3049179017169;1121.4560937945091;1155.820847768597;1263.9620811375673;16235.675286494441;17007.404740834012;17065.658686826195;17086.173963782858;17090.316387344366;558281.2945288048;561403;562156;564531;565383;57848.71075644679;58493;58503.41496585065;58616.413835861946;58959.41040589625;1217.622537013511;1300.7593595184921;1339.270097796703;1379.8068270441945;1415.9079659822078;29703.40593188081;33266.83366583152;33855.322893542485;33955.660443396235;34196.82901585476;51732.741336293075;52197;52521.47478525166;52534.73732631312;52635.21047184372;450915;457699;460160;462705;463653;39236.21527569376;40942.615044445054;45973.54026459692;47182.76408617935;48248.75875620599;49229.49560637965;49591;49999.500004999485;50217;50742.74628626833;43647.78176109099;45299.77350113228;45439.09121817479;45747.77126114348;46079.07841843212;41682.58317416787;41875;41969.580304197785;41975.58024419717;42228;41763;41950.79024604979;42708.57291427046;42749.145017100105;42947.35578966256;32969.34061318712;38308.425373619975;38331;38443.42334865035;39063;27592.448151037268;27786.305342365795;28084.29789255285;28176.71823281741;28190.295242619097 19:33:12 INFO - PROCESS | 11882 | |2;jquery.html;386.22561763663856;386.54773914520007;388.84780575240086;399.4627226380518;408.58732679993216;14823.35934096401;16134.515964521082;18089.81910180898;19565.413037608858;19568.51078723031;18548.44354669362;18709.90645046773;19235.711464328047;19792.30726924558;19813.108410121542;5593.776248950037;5604.971975140129;5838.095095260221;5845.7369418376275;5850.210221620069;4197.16056788642;5763.221965034709;5768.221290125843;5801.622894511865;6271.122042913996;6523.641199734013;6632;6652.268250492442;6657.101291325657;6659.267480577133;6334.334894836045;6519.869602607969;6534.346565343475;6536.934630653727;6598.439132673729;5480.972595137038;5735.684537350444;5740.425957404268;5740.4833564978935;5766.740496677659;22910.65634015491;23455.543446745065;23635.645465318034;23654.763452365427;23716.881415592983;2424.139430502164;2449.0571130115036;2462.9438896601037;2582.0575489946223;2782.276608081893;13919.23444210578;14145.787813182811;14153;14275.928620356935;14463.421463141462;1861.0694652673662;1922.8173323534243;1972.2899756087797;1986.0536674059358;1998.3305592626486;77812;78935.60532197302;81134.18865811266;81555.59222203851;82946;9415.952920235355;9598.18415434682;10117.747056323504;10147.543360548645;10327.638532651321;12266.509339626493;13689.31553422325;13728.176309421468;30995;31055.68944310528;9511.381760185566;9565.713028609152;9592.95203523978;9662.130408263149;9830.377987632104;7896.7236146734585;7975.960120199362;8027.237412445808;8092.797680058045;8409.621567029499;8710.689937823714;8921.821563568823;8996.100389960951;9098.636054557743;9104.180623743763;3442.5868895732674;3445.638207988175;3447.2772301946493;3463.636318186554;3498.772579782306;879.7668617816283;965.8164948659733;1006.2151521812998;1013.3919648211014;1037.766502536923;18899.149538270813;18952.62094758097;19108.808911910983;19367.709484357747;19481.662200536026;897.9191872731485;898.7483504618717;933.3839665820526;977.1645243317004;1036.4817591204398;10200.4389758564;10544.841827372595;10672.252942293964;10705.46472676363;10711.89288107109;485295;489327;490309;491248;503879;62715;93437;94941;96489.9999999986;96914;991.9206463483048;1008.0574662690261;1024.6413755185624;1044.2846650044744;1044.6813721814767;15957.361705532114;16950.66098677995;17066.2320195589;17093.658126837145;17345.826541734925;40431.79784101179;41109.383359250234;43599.34600980925;44314;45052.32421513746;60629.69685151546;62208;65841.67079164574;66313.66843165753;66321.0051849213;8052.355811535181;8480.01439323517;8499.362547808816;8787.912120878966;8878.289736821169;10829.458527073457;13041.347932603521;13436.126651767994;13575.864241357855;13973.161610303414;11550.537978480766;11597.246178998337;11674.649760507198;11809.586664466702;11935.761284774082;11618.302901825917;11765.411729413667;11768.235064720766;11818.46816893259;11827.881721182677;11812.881871181178;12024.75950481003;12169.574064907685;12201.816972745239;12366;8333.83332333362;8769.693060743099;8837.558122093998;8877.689280875138;8891.599878005376;11304;11762.58830940913;11817.468213930222;11891.881081189424;11926.582569610022 19:33:12 INFO - PROCESS | 11882 | |3;mootools.html;1302.5050480817288;1439.5681295611316;1498.9325480353384;1572.4968010236728;1750.5361079313975;8077.91922080779;8414.957925210372;8426.325893928486;8559.572021398937;8571.828563428728;8296.958515207416;8438.2827459666;8507.064222935473;8515.829683406344;8516.659333626647;2151.0965394534296;2172.7175467189245;2173.706549615805;2183.1813070098715;2183.530540933699;2089.665653495441;2143.228437762404;2148.0870629982273;2157.6979222908803;2160.2763074370105;2146.6887301341294;2161.7189765330563;2165.902534385956;2183.727034120735;2204.2725900452892;2119.5337025854287;2135.306025541697;2138.134055707441;2142.6571748520164;2147.3772605944414;2110.155937624947;2160.3087012156116;2160.7191065161587;2160.751513575943;2166.4367264511184;8499.405041647087;8538.103499132625;8629.482231066157;8631.309495240428;8757.56212189388;5040.143175660147;5176.637635365526;5180.067587834188;5187.974060129713;5188.688678679291;3347.916302092443;3350.932981340384;3380.2732412531177;3384.9661503384896;3438.862445502177;1086.3861918016376;1089.2974031749557;1123.3035517978824;1126.487448211062;1127.3461392392392;12004.459799309052;12081.758364832654;12101.818472722916;12107;12113.091518136174;4352.434183556181;4390.253656878338;4427.446569178853;4518.819247230074;4525.393485312732;9496.14534691881;9511.286653501014;9513.714588562354;9514.38156519824;9517.23862091045;4963.057019166346;5046.924296135561;5047.87380315495;5049.84850454487;5051;4215.852445164404;4266.914661706748;4665.533446655375;4678.087772884323;4713.976430117896;3474.2009337851932;3521.4189658706537;3551.8401671924826;3580.785152890835;3588.964110358915;1048.8636477257908;1070.464767616192;1078.6979645699216;1080.9459527023616;1090.5310716391868;879.7096958003843;992.5781542844262;997.4165113408737;1010.3322649360003;1012.731626119079;5925.466707996301;6078.027515597483;6115.327313995457;6188.628682279078;6204.038374052029;421.791213349394;424.1305324085674;427.22458737391537;429.1866912201361;440.97795110245;3992;4170.541240463546;4199.181159673834;4203.5376108628025;4266.0827921996915;10462.68611941643;10729.83905241422;10823.837642435212;10831.458427078614;10846.403447810288;10022.398656080659;10390.22073344487;10700.464976751287;10743.570257189625;10748.355098694103;7977.60111994398;8102.513849169069;8112.269895709414;8192.098869124391;8194.959025204955;5559.583031272751;5754.625949313281;5811.215485909348;5864.9413505864395;6022.378453312243;9695.224382049279;10101.090901818872;10123.088921996761;10123.64567240143;10124.088832005154;10106.444145572064;10173.491325433846;10218.1825453965;10241.74395640115;10322.741931451774;7211.747588834365;7636.274553917591;7899.526028438312;7923.445358824827;8023.438359314792;8503.362247831314;8544.40189186751;8564.05795362522;8611.784705382415;8613.181747733955;7760.611969401621;7800.687972481037;7856.528608283521;7859.764207073797;7993.480423772437;7586.658600362886;7654.846903061796;7716.151223365313;7735.922640773745;7770.378369730521;6860.3139686031;6986.126734158231;6986.6855991481525;6999.510034297754;7242.710291588278;5196.246544251138;5379.112446446293;5394;5413.1880217966045;5446.183072538993;4998.350214472095;5200.63595548308;5260.7106609135335;5273.604479664117;5447.673139611636 19:33:12 INFO - PROCESS | 11882 | |4;prototype.html;312.7826160818232;330.71228031612503;333.586352922376;339.50093362756746;344.0504208384857;5088.389393272812;5182.559482443988;5202.661826981243;5272.8154514592;5314.362276526813;5219.5041471060185;5253.6322457428;5269.525742683158;5281.894362112765;5286.365636123671;4158.293090174678;4159.292920203565;4178.76436106683;4179.582041795827;4192.951762059485;3941.4876066111365;3952.170044290688;4173.603507666782;4174.812133454002;4177.498700155986;4084.2035803018425;4091.115763386805;4144.652987778969;4146.502419709639;4155.937660935088;4142.461480007595;4147.294959856847;4161.396597493346;4174.269502836992;4184.163167366539;3467.9653203467897;3740.8503659853573;3742.5696044954634;3756.417755247941;3761.5110035695184;5107.3105130807235;5133.871653208662;5149.227615857614;5150.381954165524;5180.818671346522;4659.697119687244;4664.460727959765;4672.99530600919;4685.8594242172785;4709.552592503706;5342.27879236302;5391.32608423947;5491.2312276281355;5502.862428439281;5509.9255645149215;3947.5657677655436;3972.503437070366;3979.422983667352;3984.900377490557;3988.202359528106;5698.715064246771;5706.916975304026;5726.713664316768;5733.312002559678;5742.253507044099;3961.959590810735;4072.0884567534354;4093.1813637272667;4119.443875076826;4126.277901367249;4117.8970525736495;4119.855805046869;4128.153728485653;4142.875713728593;4143.316352801814;4692.53074692528;4699.365585645963;4700.2009658358165;4727.456342520585;4739.336492890998;5555.805546805843;5558.388577256498;5568.329501149639;5571.220029195916;5593.216949627055;1427.421894132878;1471.8822494200438;1479.8900824381715;1480.6520467690084;1481.9700308285853;935.4714586258879;940.0270719804969;944.9622015119318;951.871497347863;969.5636963366513;4628.490866004737;4728.645351598644;4736.915757066879;4749.64377671676;4761.4524329701835;5017.724025178577;5036.463878517087;5039.521245481674;5039.848804535796;5054.696718196847;4765.237561990065;4768.736284884509;4809.615230781529;4830.203016502308;4919.835272480097;2985.7163569460868;2993.832405361911;2998.9850050749606;3015.1406849047917;3024.6219222597174;5779.971100144472;5836.445537673914;5842.503387212135;5850.824475265749;5851.38560451155;5562.638428502134;5739.483446489836;5747.48272655463;5791.247137872049;5808.767649294065;5795.275590551181;5798.652080875161;5822.854428639318;5867.178594996704;5871.853203669943;5355.758990845344;5677.120046392815;5690.203371527907;5705.343885453226;5713.457221563945;5630.690312032878;5644.604877658689;5647.830565083054;5657.104869868475;5659.717014149359;5842.5325973921135;5862.882742345215;5868.647881127146;5872.4471694625845;5882.205902203319;3729.701623870138;3868.168343806095;4049.250888585621;4063.4920634920636;4072.674186065167;5599.664020158803;5602.747876345656;5629.718514074362;5637.9718101409235;5669.489745922887;5482.23248745168;5493.807716730055;5498.917516237179;5510.972445137749;5523.502884740393;5209.166533354645;5481.479259470344;5505.587080969023;5529.557635389239;5530.446955304437;5316.362036555638;5338.4127745947135;5362;5397.190421436816;5430.995265875667;5324.8136315228785;5455.727213639381;5489.149181876815;5510.972445137749;5541.55919460935;5436.287569415622;5438.374586922555;5455.345358556999;5498.487915823181;5502.477264659851 19:33:12 INFO - PROCESS | 11882 | |5;yui.html;767.1637914673005;785.8153333966517;814.588632740466;820.1142765812923;820.2535692519808;14837.851621483782;15885.205739713027;15934.920325398356;16017.759733604005;16024.83975160248;14809.11145331281;14826.406943722264;14890.925545372285;14895.702085958274;14960.551183464486;662.2185820731535;773.5822655765879;775.7866586688677;786.1548835002367;800.8638531449639;793.0602236349915;797.4935915693518;799.7360870912614;802.7230605441114;803.8070862992898;857.1000449528002;857.5797859049052;858.120426562775;858.4849090545686;859.2653281444337;695.7495301691387;832.9000519937616;850.2305413600701;850.3707256630111;850.3834719828137;618.6504624886925;619.2507066449601;620.2618883528587;620.314552419579;620.9720562574695;14960.850391496164;14964.551063468114;14988.550343489604;15029.774553381709;15110.54668359951;14310.570682879426;14510.347034383478;14740.115593064344;14822.925885370612;14874.256287185597;12823.93588032054;13099.41052652633;13195.868041319656;13220.801687974688;13381.330933453386;4388.71473354231;4588.632909367243;4662.300654901792;4688.69523480976;4690.202665546865;74394.62802686007;74670.25329746687;74752;75005;75633;11530.250533715282;11603.245789023855;11667.241629294238;11694.824577631342;11745.29528228309;22029;22226.222082227367;22321.776782232293;22340;22540.66189007166;8269.62786674601;8324.25081742646;8353.791155221168;8383.077861435237;8859.158379953895;4645.74448405341;4744.288356746516;4788.808447662054;4863.586595139453;4925.088858561177;3192.393445245396;3324.634290228073;3330.200751819546;3333.6999670029813;3335.199552107477;568.8776912963733;576.4379729763447;587.1045612361924;592.4075924075925;596.1921596237123;678.6708446403491;693.2478261086677;703.4720874812817;705.816487713188;724.7463387814329;8894.822103557892;9475.810483790285;9503.239740820718;9713.805723885484;9750.804983900282;566.2214455124205;595.6694034810635;623.7006237006262;672.0356288725596;774.2953911940108;4479.395281636937;4615.630749540029;4716.245400735935;4819.770958405654;4902.828401006019;111027.44486277679;115573;116333;118345;118776;100352.48413821396;100642;101389;103128;103929.48035259926;58094.7095264521;59954.400455995754;61704.69147654323;87600.12399876048;88496.5575172133;9840.950795245977;10203.28576999603;10272.075513203847;10794.514246858753;10870.782584348426;43520.782396087816;46710.53289467062;47116.7644161777;52657;53155.73422132865;69216.6539167301;71520.64239678768;72581;74260.2573974275;74971;14186;14471.710565788835;14482.420703172176;14611.196384198545;14774.409023638935;14969.775453368426;15561.299741511433;15569.532914012598;15581.376744930076;15957;13886.444542218198;13897.305134743021;14417.207053611732;14431.927840360731;14824.258787060387;14186.716265674835;14418.279086045866;14423.567292981228;14709.632259193606;15119.16844573559;13328.200307981551;13645.727085458037;14112.858871411565;14153.575392738234;14178.220197889215;11622.5350985963;11633.360165190996;11788.587399440978;11857.644270671894;12321.445534951128;11907.940460297643;12092.214006089576;12132;12283.324417157142;12439.564615238423 19:33:12 INFO - PROCESS | 11882 | __end_tp_report 19:33:12 INFO - PROCESS | 11882 | __start_cc_report 19:33:12 INFO - PROCESS | 11882 | _x_x_mozilla_cycle_collect,1015 19:33:12 INFO - PROCESS | 11882 | __end_cc_report 19:33:12 INFO - PROCESS | 11882 | __startTimestamp1466821992803__endTimestamp 19:33:12 INFO - PROCESS | 11882 | 19:33:12 INFO - PROCESS | 11882 | ------- Summary: start ------- 19:33:12 INFO - PROCESS | 11882 | Number of tests: 6 19:33:12 INFO - PROCESS | 11882 | 19:33:12 INFO - PROCESS | 11882 | [#0] dojo.html Cycles:165 Average:5284.84 Median:5447.89 stddev:593.33 (10.9%) stddev-sans-first:569.63 19:33:12 INFO - PROCESS | 11882 | Values: 3090.7 3090.8 3092.5 3109.5 3152.3 5222.1 5327.0 5341.6 5426.1 5443.3 5306.1 5328.7 5332.4 5357.9 5390.6 4773.5 4831.3 4835.6 4839.4 4958.3 4851.4 4867.1 4892.0 4908.2 4908.3 4743.2 4752.5 4787.2 4799.2 4807.9 4828.4 4833.1 4838.4 4862.9 4933.4 4842.9 4852.7 4868.4 4889.6 4913.9 5236.4 5298.9 5311.2 5366.5 5377.3 5710.5 5717.3 5721.1 5764.1 5764.3 5785.2 5786.0 5807.9 5812.6 5812.7 5133.3 5214.3 5243.1 5253.3 5318.8 5805.2 5805.9 5809.1 5820.4 5823.2 5591.5 5599.4 5600.0 5601.0 5602.3 5533.8 5612.7 5673.3 5673.6 5744.2 5661.8 5666.2 5668.5 5673.3 5705.7 5607.4 5673.3 5676.5 5678.5 5679.6 4302.8 4325.2 4330.5 4338.7 4353.8 3868.6 3899.9 3900.5 3901.6 3970.6 5443.2 5452.8 5453.1 5456.5 5492.2 5499.7 5625.1 5662.6 5759.9 5812.3 5368.7 5380.9 5387.4 5387.6 5427.0 4933.1 4933.4 4944.5 4955.9 4993.6 5786.0 5789.9 5867.6 5912.1 5917.3 5725.5 5760.9 5761.3 5763.8 5765.0 5926.5 5937.1 5945.4 5946.9 5949.6 5466.0 5536.8 5544.1 5592.1 5599.1 5625.6 5661.7 5663.3 5685.2 5696.8 5445.1 5541.2 5553.7 5556.2 5559.7 5405.0 5433.1 5443.5 5467.9 5467.9 5376.8 5380.4 5394.7 5428.2 5447.9 5429.6 5528.8 5598.7 5603.4 5616.7 5400.1 5437.9 5453.3 5465.8 5523.7 19:33:12 INFO - PROCESS | 11882 | 19:33:12 INFO - PROCESS | 11882 | [#1] ext.html Cycles:180 Average:62519.41 Median:227707.16 stddev:123855.75 (54.4%) stddev-sans-first:124115.87 19:33:12 INFO - PROCESS | 11882 | Values: 572.7 601.7 616.4 620.3 634.5 30765.2 43334.3 44237.8 44257.3 44305.1 45421.5 45857.0 45986.0 46002.3 46118.1 8763.0 8831.9 8880.5 8886.8 8890.1 8938.2 9048.1 9050.9 9051.4 9056.6 9104.1 9144.5 9151.8 9153.6 9155.3 9028.8 9064.6 9074.7 9075.4 9080.0 8917.9 8990.4 9001.1 9003.9 9009.2 42064.4 42128.8 42450.4 42546.4 42589.8 3257.3 3644.3 3863.3 3939.9 3995.2 31429.7 32513.7 32832.2 33125.5 33249.8 4433.9 4499.3 4526.4 4590.8 4680.2 354024.0 356229.0 357529.2 357894.9 358012.0 59874.0 59922.1 60303.1 60357.4 60409.1 56783.4 57126.0 57177.4 57185.0 57229.4 13973.4 15361.9 15706.0 16122.8 16150.3 12075.4 12254.6 12257.8 12266.1 12270.4 18918.4 19034.0 19052.7 19123.9 19137.9 5872.3 7035.5 7253.3 7292.2 7323.2 871.2 956.1 989.0 999.2 1072.3 31307.1 31846.2 32053.2 32094.4 32612.5 1048.2 1103.3 1121.5 1155.8 1264.0 16235.7 17007.4 17065.7 17086.2 17090.3 558281.3 561403.0 562156.0 564531.0 565383.0 57848.7 58493.0 58503.4 58616.4 58959.4 1217.6 1300.8 1339.3 1379.8 1415.9 29703.4 33266.8 33855.3 33955.7 34196.8 51732.7 52197.0 52521.5 52534.7 52635.2 450915.0 457699.0 460160.0 462705.0 463653.0 39236.2 40942.6 45973.5 47182.8 48248.8 49229.5 49591.0 49999.5 50217.0 50742.7 43647.8 45299.8 45439.1 45747.8 46079.1 41682.6 41875.0 41969.6 41975.6 42228.0 41763.0 41950.8 42708.6 42749.1 42947.4 32969.3 38308.4 38331.0 38443.4 39063.0 27592.4 27786.3 28084.3 28176.7 28190.3 19:33:12 INFO - PROCESS | 11882 | 19:33:12 INFO - PROCESS | 11882 | [#2] jquery.html Cycles:180 Average:29601.06 Median:1942.50 stddev:81058.27 (4172.9%) stddev-sans-first:81255.98 19:33:12 INFO - PROCESS | 11882 | Values: 386.2 386.5 388.8 399.5 408.6 14823.4 16134.5 18089.8 19565.4 19568.5 18548.4 18709.9 19235.7 19792.3 19813.1 5593.8 5605.0 5838.1 5845.7 5850.2 4197.2 5763.2 5768.2 5801.6 6271.1 6523.6 6632.0 6652.3 6657.1 6659.3 6334.3 6519.9 6534.3 6536.9 6598.4 5481.0 5735.7 5740.4 5740.5 5766.7 22910.7 23455.5 23635.6 23654.8 23716.9 2424.1 2449.1 2462.9 2582.1 2782.3 13919.2 14145.8 14153.0 14275.9 14463.4 1861.1 1922.8 1972.3 1986.1 1998.3 77812.0 78935.6 81134.2 81555.6 82946.0 9416.0 9598.2 10117.7 10147.5 10327.6 12266.5 13689.3 13728.2 30995.0 31055.7 9511.4 9565.7 9593.0 9662.1 9830.4 7896.7 7976.0 8027.2 8092.8 8409.6 8710.7 8921.8 8996.1 9098.6 9104.2 3442.6 3445.6 3447.3 3463.6 3498.8 879.8 965.8 1006.2 1013.4 1037.8 18899.1 18952.6 19108.8 19367.7 19481.7 897.9 898.7 933.4 977.2 1036.5 10200.4 10544.8 10672.3 10705.5 10711.9 485295.0 489327.0 490309.0 491248.0 503879.0 62715.0 93437.0 94941.0 96490.0 96914.0 991.9 1008.1 1024.6 1044.3 1044.7 15957.4 16950.7 17066.2 17093.7 17345.8 40431.8 41109.4 43599.3 44314.0 45052.3 60629.7 62208.0 65841.7 66313.7 66321.0 8052.4 8480.0 8499.4 8787.9 8878.3 10829.5 13041.3 13436.1 13575.9 13973.2 11550.5 11597.2 11674.6 11809.6 11935.8 11618.3 11765.4 11768.2 11818.5 11827.9 11812.9 12024.8 12169.6 12201.8 12366.0 8333.8 8769.7 8837.6 8877.7 8891.6 11304.0 11762.6 11817.5 11891.9 11926.6 19:33:12 INFO - PROCESS | 11882 | 19:33:12 INFO - PROCESS | 11882 | [#3] mootools.html Cycles:180 Average:5671.41 Median:4473.13 stddev:3279.21 (73.3%) stddev-sans-first:3271.97 19:33:12 INFO - PROCESS | 11882 | Values: 1302.5 1439.6 1498.9 1572.5 1750.5 8077.9 8415.0 8426.3 8559.6 8571.8 8297.0 8438.3 8507.1 8515.8 8516.7 2151.1 2172.7 2173.7 2183.2 2183.5 2089.7 2143.2 2148.1 2157.7 2160.3 2146.7 2161.7 2165.9 2183.7 2204.3 2119.5 2135.3 2138.1 2142.7 2147.4 2110.2 2160.3 2160.7 2160.8 2166.4 8499.4 8538.1 8629.5 8631.3 8757.6 5040.1 5176.6 5180.1 5188.0 5188.7 3347.9 3350.9 3380.3 3385.0 3438.9 1086.4 1089.3 1123.3 1126.5 1127.3 12004.5 12081.8 12101.8 12107.0 12113.1 4352.4 4390.3 4427.4 4518.8 4525.4 9496.1 9511.3 9513.7 9514.4 9517.2 4963.1 5046.9 5047.9 5049.8 5051.0 4215.9 4266.9 4665.5 4678.1 4714.0 3474.2 3521.4 3551.8 3580.8 3589.0 1048.9 1070.5 1078.7 1080.9 1090.5 879.7 992.6 997.4 1010.3 1012.7 5925.5 6078.0 6115.3 6188.6 6204.0 421.8 424.1 427.2 429.2 441.0 3992.0 4170.5 4199.2 4203.5 4266.1 10462.7 10729.8 10823.8 10831.5 10846.4 10022.4 10390.2 10700.5 10743.6 10748.4 7977.6 8102.5 8112.3 8192.1 8195.0 5559.6 5754.6 5811.2 5864.9 6022.4 9695.2 10101.1 10123.1 10123.6 10124.1 10106.4 10173.5 10218.2 10241.7 10322.7 7211.7 7636.3 7899.5 7923.4 8023.4 8503.4 8544.4 8564.1 8611.8 8613.2 7760.6 7800.7 7856.5 7859.8 7993.5 7586.7 7654.8 7716.2 7735.9 7770.4 6860.3 6986.1 6986.7 6999.5 7242.7 5196.2 5379.1 5394.0 5413.2 5446.2 4998.4 5200.6 5260.7 5273.6 5447.7 19:33:12 INFO - PROCESS | 11882 | 19:33:12 INFO - PROCESS | 11882 | [#4] prototype.html Cycles:180 Average:4607.43 Median:5181.69 stddev:1337.71 (25.8%) stddev-sans-first:1302.05 19:33:12 INFO - PROCESS | 11882 | Values: 312.8 330.7 333.6 339.5 344.1 5088.4 5182.6 5202.7 5272.8 5314.4 5219.5 5253.6 5269.5 5281.9 5286.4 4158.3 4159.3 4178.8 4179.6 4193.0 3941.5 3952.2 4173.6 4174.8 4177.5 4084.2 4091.1 4144.7 4146.5 4155.9 4142.5 4147.3 4161.4 4174.3 4184.2 3468.0 3740.9 3742.6 3756.4 3761.5 5107.3 5133.9 5149.2 5150.4 5180.8 4659.7 4664.5 4673.0 4685.9 4709.6 5342.3 5391.3 5491.2 5502.9 5509.9 3947.6 3972.5 3979.4 3984.9 3988.2 5698.7 5706.9 5726.7 5733.3 5742.3 3962.0 4072.1 4093.2 4119.4 4126.3 4117.9 4119.9 4128.2 4142.9 4143.3 4692.5 4699.4 4700.2 4727.5 4739.3 5555.8 5558.4 5568.3 5571.2 5593.2 1427.4 1471.9 1479.9 1480.7 1482.0 935.5 940.0 945.0 951.9 969.6 4628.5 4728.6 4736.9 4749.6 4761.5 5017.7 5036.5 5039.5 5039.8 5054.7 4765.2 4768.7 4809.6 4830.2 4919.8 2985.7 2993.8 2999.0 3015.1 3024.6 5780.0 5836.4 5842.5 5850.8 5851.4 5562.6 5739.5 5747.5 5791.2 5808.8 5795.3 5798.7 5822.9 5867.2 5871.9 5355.8 5677.1 5690.2 5705.3 5713.5 5630.7 5644.6 5647.8 5657.1 5659.7 5842.5 5862.9 5868.6 5872.4 5882.2 3729.7 3868.2 4049.3 4063.5 4072.7 5599.7 5602.7 5629.7 5638.0 5669.5 5482.2 5493.8 5498.9 5511.0 5523.5 5209.2 5481.5 5505.6 5529.6 5530.4 5316.4 5338.4 5362.0 5397.2 5431.0 5324.8 5455.7 5489.1 5511.0 5541.6 5436.3 5438.4 5455.3 5498.5 5502.5 19:33:12 INFO - PROCESS | 11882 | 19:33:12 INFO - PROCESS | 11882 | [#5] yui.html Cycles:180 Average:20598.78 Median:4434.06 stddev:29186.47 (658.2%) stddev-sans-first:29230.36 19:33:12 INFO - PROCESS | 11882 | Values: 767.2 785.8 814.6 820.1 820.3 14837.9 15885.2 15934.9 16017.8 16024.8 14809.1 14826.4 14890.9 14895.7 14960.6 662.2 773.6 775.8 786.2 800.9 793.1 797.5 799.7 802.7 803.8 857.1 857.6 858.1 858.5 859.3 695.7 832.9 850.2 850.4 850.4 618.7 619.3 620.3 620.3 621.0 14960.9 14964.6 14988.6 15029.8 15110.5 14310.6 14510.3 14740.1 14822.9 14874.3 12823.9 13099.4 13195.9 13220.8 13381.3 4388.7 4588.6 4662.3 4688.7 4690.2 74394.6 74670.3 74752.0 75005.0 75633.0 11530.3 11603.2 11667.2 11694.8 11745.3 22029.0 22226.2 22321.8 22340.0 22540.7 8269.6 8324.3 8353.8 8383.1 8859.2 4645.7 4744.3 4788.8 4863.6 4925.1 3192.4 3324.6 3330.2 3333.7 3335.2 568.9 576.4 587.1 592.4 596.2 678.7 693.2 703.5 705.8 724.7 8894.8 9475.8 9503.2 9713.8 9750.8 566.2 595.7 623.7 672.0 774.3 4479.4 4615.6 4716.2 4819.8 4902.8 111027.4 115573.0 116333.0 118345.0 118776.0 100352.5 100642.0 101389.0 103128.0 103929.5 58094.7 59954.4 61704.7 87600.1 88496.6 9841.0 10203.3 10272.1 10794.5 10870.8 43520.8 46710.5 47116.8 52657.0 53155.7 69216.7 71520.6 72581.0 74260.3 74971.0 14186.0 14471.7 14482.4 14611.2 14774.4 14969.8 15561.3 15569.5 15581.4 15957.0 13886.4 13897.3 14417.2 14431.9 14824.3 14186.7 14418.3 14423.6 14709.6 15119.2 13328.2 13645.7 14112.9 14153.6 14178.2 11622.5 11633.4 11788.6 11857.6 12321.4 11907.9 12092.2 12132.0 12283.3 12439.6 19:33:12 INFO - PROCESS | 11882 | -------- Summary: end -------- 19:33:12 INFO - PROCESS | 11882 | 19:33:13 INFO - TEST-INFO | 11882: exit 0 19:33:13 INFO - TEST-OK | dromaeo_css | took 1115252ms 19:33:13 INFO - TEST-START | kraken 19:33:13 INFO - operating with platform_type : linux_ 19:33:13 INFO - Initialising browser for kraken test... 19:33:13 INFO - TEST-INFO | started process 12065 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuh7eT5/profile http://localhost:57671/getInfo.html) 19:33:18 INFO - PROCESS | 12065 | __metrics Screen width/height:1600/1200 19:33:18 INFO - PROCESS | 12065 | colorDepth:24 19:33:18 INFO - PROCESS | 12065 | Browser inner width/height: 1024/697 19:33:18 INFO - PROCESS | 12065 | __metrics 19:33:19 INFO - PROCESS | 12065 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:33:20 INFO - TEST-INFO | 12065: exit 0 19:33:20 INFO - Browser initialized. 19:33:20 INFO - Running cycle 1/1 for kraken test... 19:33:20 INFO - TEST-INFO | started process 12151 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuh7eT5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:33:32 INFO - PROCESS | 12151 | RSS: Main: 173867008 19:33:32 INFO - PROCESS | 12151 | 19:33:34 INFO - PROCESS | 12151 | Cycle 1(1): loaded http://localhost:57671/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57671/tests/kraken/driver.html?testName=audio-beat-detection) 19:33:35 INFO - PROCESS | 12151 | RSS: Main: 232243200 19:33:35 INFO - PROCESS | 12151 | 19:33:38 INFO - PROCESS | 12151 | Cycle 1(1): loaded http://localhost:57671/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57671/tests/kraken/driver.html?testName=audio-dft) 19:33:39 INFO - PROCESS | 12151 | RSS: Main: 221392896 19:33:39 INFO - PROCESS | 12151 | 19:33:42 INFO - PROCESS | 12151 | Cycle 1(1): loaded http://localhost:57671/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57671/tests/kraken/driver.html?testName=audio-fft) 19:33:42 INFO - PROCESS | 12151 | RSS: Main: 286203904 19:33:42 INFO - PROCESS | 12151 | 19:33:44 INFO - PROCESS | 12151 | Cycle 1(1): loaded http://localhost:57671/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57671/tests/kraken/driver.html?testName=audio-oscillator) 19:33:45 INFO - PROCESS | 12151 | RSS: Main: 196468736 19:33:45 INFO - PROCESS | 12151 | 19:33:47 INFO - PROCESS | 12151 | Cycle 1(1): loaded http://localhost:57671/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57671/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:33:48 INFO - PROCESS | 12151 | RSS: Main: 200335360 19:33:48 INFO - PROCESS | 12151 | 19:33:51 INFO - PROCESS | 12151 | Cycle 1(1): loaded http://localhost:57671/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57671/tests/kraken/driver.html?testName=imaging-darkroom) 19:33:51 INFO - PROCESS | 12151 | RSS: Main: 236924928 19:33:51 INFO - PROCESS | 12151 | 19:33:55 INFO - PROCESS | 12151 | Cycle 1(1): loaded http://localhost:57671/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57671/tests/kraken/driver.html?testName=imaging-desaturate) 19:33:55 INFO - PROCESS | 12151 | RSS: Main: 238186496 19:33:55 INFO - PROCESS | 12151 | 19:33:58 INFO - PROCESS | 12151 | Cycle 1(1): loaded http://localhost:57671/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57671/tests/kraken/driver.html?testName=json-parse-financial) 19:33:59 INFO - PROCESS | 12151 | RSS: Main: 237436928 19:33:59 INFO - PROCESS | 12151 | 19:34:00 INFO - PROCESS | 12151 | Cycle 1(1): loaded http://localhost:57671/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57671/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:34:01 INFO - PROCESS | 12151 | RSS: Main: 226308096 19:34:01 INFO - PROCESS | 12151 | 19:34:03 INFO - PROCESS | 12151 | Cycle 1(1): loaded http://localhost:57671/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57671/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:34:03 INFO - PROCESS | 12151 | RSS: Main: 230461440 19:34:03 INFO - PROCESS | 12151 | 19:34:05 INFO - PROCESS | 12151 | Cycle 1(1): loaded http://localhost:57671/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57671/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:34:06 INFO - PROCESS | 12151 | RSS: Main: 238145536 19:34:06 INFO - PROCESS | 12151 | 19:34:09 INFO - PROCESS | 12151 | Cycle 1(1): loaded http://localhost:57671/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57671/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:34:09 INFO - PROCESS | 12151 | RSS: Main: 240603136 19:34:09 INFO - PROCESS | 12151 | 19:34:12 INFO - PROCESS | 12151 | Cycle 1(1): loaded http://localhost:57671/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57671/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:34:13 INFO - PROCESS | 12151 | RSS: Main: 241049600 19:34:13 INFO - PROCESS | 12151 | 19:34:14 INFO - PROCESS | 12151 | Cycle 1(1): loaded http://localhost:57671/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57671/tests/kraken/driver.html?testName=ai-astar) 19:34:14 INFO - PROCESS | 12151 | RSS: Main: 283799552 19:34:14 INFO - PROCESS | 12151 | 19:34:14 INFO - PROCESS | 12151 | __start_tp_report 19:34:14 INFO - PROCESS | 12151 | _x_x_mozilla_page_load 19:34:14 INFO - PROCESS | 12151 | _x_x_mozilla_page_load_details 19:34:14 INFO - PROCESS | 12151 | |i|pagename|runs| 19:34:14 INFO - PROCESS | 12151 | |0;ai-astar;100;111;108;111;111;109;112;112;110;109 19:34:14 INFO - PROCESS | 12151 | |1;audio-beat-detection;162;131;128;189;132;128;154;126;160;125 19:34:14 INFO - PROCESS | 12151 | |2;audio-dft;161;161;161;162;160;163;160;159;161;161 19:34:14 INFO - PROCESS | 12151 | |3;audio-fft;74;74;76;125;77;78;75;74;115;74 19:34:14 INFO - PROCESS | 12151 | |4;audio-oscillator;84;86;117;85;85;86;125;86;84;121 19:34:14 INFO - PROCESS | 12151 | |5;imaging-gaussian-blur;117;116;117;118;118;116;118;117;118;117 19:34:14 INFO - PROCESS | 12151 | |6;imaging-darkroom;145;146;147;147;148;145;145;145;147;146 19:34:14 INFO - PROCESS | 12151 | |7;imaging-desaturate;95;95;95;94;94;95;95;94;95;94 19:34:14 INFO - PROCESS | 12151 | |8;json-parse-financial;54;52;54;53;52;53;54;55;53;55 19:34:14 INFO - PROCESS | 12151 | |9;json-stringify-tinderbox;63;62;61;62;61;62;62;62;63;62 19:34:14 INFO - PROCESS | 12151 | |10;stanford-crypto-aes;85;81;85;79;79;81;81;81;89;79 19:34:14 INFO - PROCESS | 12151 | |11;stanford-crypto-ccm;140;135;131;118;132;120;119;124;132;137 19:34:14 INFO - PROCESS | 12151 | |12;stanford-crypto-pbkdf2;161;163;163;160;158;157;157;161;156;162 19:34:14 INFO - PROCESS | 12151 | |13;stanford-crypto-sha256-iterative;64;63;64;62;62;62;65;65;66;62 19:34:14 INFO - PROCESS | 12151 | __end_tp_report 19:34:14 INFO - PROCESS | 12151 | __start_cc_report 19:34:14 INFO - PROCESS | 12151 | _x_x_mozilla_cycle_collect,1640 19:34:14 INFO - PROCESS | 12151 | __end_cc_report 19:34:14 INFO - PROCESS | 12151 | __startTimestamp1466822054986__endTimestamp 19:34:14 INFO - PROCESS | 12151 | 19:34:14 INFO - PROCESS | 12151 | ------- Summary: start ------- 19:34:15 INFO - PROCESS | 12151 | Number of tests: 14 19:34:15 INFO - PROCESS | 12151 | 19:34:15 INFO - PROCESS | 12151 | [#0] ai-astar Cycles:10 Average:109.30 Median:111.00 stddev:3.53 (3.2%) stddev-sans-first:1.41 19:34:15 INFO - PROCESS | 12151 | Values: 100.0 111.0 108.0 111.0 111.0 109.0 112.0 112.0 110.0 109.0 19:34:15 INFO - PROCESS | 12151 | 19:34:15 INFO - PROCESS | 12151 | [#1] audio-beat-detection Cycles:10 Average:143.50 Median:143.00 stddev:21.63 (15.1%) stddev-sans-first:21.89 19:34:15 INFO - PROCESS | 12151 | Values: 162.0 131.0 128.0 189.0 132.0 128.0 154.0 126.0 160.0 125.0 19:34:15 INFO - PROCESS | 12151 | 19:34:15 INFO - PROCESS | 12151 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:1.10 (0.7%) stddev-sans-first:1.17 19:34:15 INFO - PROCESS | 12151 | Values: 161.0 161.0 161.0 162.0 160.0 163.0 160.0 159.0 161.0 161.0 19:34:15 INFO - PROCESS | 12151 | 19:34:15 INFO - PROCESS | 12151 | [#3] audio-fft Cycles:10 Average:84.20 Median:74.50 stddev:19.07 (25.6%) stddev-sans-first:19.86 19:34:15 INFO - PROCESS | 12151 | Values: 74.0 74.0 76.0 125.0 77.0 78.0 75.0 74.0 115.0 74.0 19:34:15 INFO - PROCESS | 12151 | 19:34:15 INFO - PROCESS | 12151 | [#4] audio-oscillator Cycles:10 Average:95.90 Median:85.00 stddev:17.44 (20.5%) stddev-sans-first:17.96 19:34:15 INFO - PROCESS | 12151 | Values: 84.0 86.0 117.0 85.0 85.0 86.0 125.0 86.0 84.0 121.0 19:34:15 INFO - PROCESS | 12151 | 19:34:15 INFO - PROCESS | 12151 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.50 stddev:0.79 (0.7%) stddev-sans-first:0.83 19:34:15 INFO - PROCESS | 12151 | Values: 117.0 116.0 117.0 118.0 118.0 116.0 118.0 117.0 118.0 117.0 19:34:15 INFO - PROCESS | 12151 | 19:34:15 INFO - PROCESS | 12151 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.50 stddev:1.10 (0.8%) stddev-sans-first:1.09 19:34:15 INFO - PROCESS | 12151 | Values: 145.0 146.0 147.0 147.0 148.0 145.0 145.0 145.0 147.0 146.0 19:34:15 INFO - PROCESS | 12151 | 19:34:15 INFO - PROCESS | 12151 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 19:34:15 INFO - PROCESS | 12151 | Values: 95.0 95.0 95.0 94.0 94.0 95.0 95.0 94.0 95.0 94.0 19:34:15 INFO - PROCESS | 12151 | 19:34:15 INFO - PROCESS | 12151 | [#8] json-parse-financial Cycles:10 Average:53.50 Median:54.00 stddev:1.08 (2.0%) stddev-sans-first:1.13 19:34:15 INFO - PROCESS | 12151 | Values: 54.0 52.0 54.0 53.0 52.0 53.0 54.0 55.0 53.0 55.0 19:34:15 INFO - PROCESS | 12151 | 19:34:15 INFO - PROCESS | 12151 | [#9] json-stringify-tinderbox Cycles:10 Average:62.00 Median:62.00 stddev:0.67 (1.1%) stddev-sans-first:0.60 19:34:15 INFO - PROCESS | 12151 | Values: 63.0 62.0 61.0 62.0 61.0 62.0 62.0 62.0 63.0 62.0 19:34:15 INFO - PROCESS | 12151 | 19:34:15 INFO - PROCESS | 12151 | [#10] stanford-crypto-aes Cycles:10 Average:82.00 Median:81.00 stddev:3.30 (4.1%) stddev-sans-first:3.32 19:34:15 INFO - PROCESS | 12151 | Values: 85.0 81.0 85.0 79.0 79.0 81.0 81.0 81.0 89.0 79.0 19:34:15 INFO - PROCESS | 12151 | 19:34:15 INFO - PROCESS | 12151 | [#11] stanford-crypto-ccm Cycles:10 Average:128.80 Median:132.00 stddev:7.96 (6.0%) stddev-sans-first:7.33 19:34:15 INFO - PROCESS | 12151 | Values: 140.0 135.0 131.0 118.0 132.0 120.0 119.0 124.0 132.0 137.0 19:34:15 INFO - PROCESS | 12151 | 19:34:15 INFO - PROCESS | 12151 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.80 Median:161.00 stddev:2.62 (1.6%) stddev-sans-first:2.74 19:34:15 INFO - PROCESS | 12151 | Values: 161.0 163.0 163.0 160.0 158.0 157.0 157.0 161.0 156.0 162.0 19:34:15 INFO - PROCESS | 12151 | 19:34:15 INFO - PROCESS | 12151 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.50 Median:64.00 stddev:1.51 (2.4%) stddev-sans-first:1.59 19:34:15 INFO - PROCESS | 12151 | Values: 64.0 63.0 64.0 62.0 62.0 62.0 65.0 65.0 66.0 62.0 19:34:15 INFO - PROCESS | 12151 | -------- Summary: end -------- 19:34:15 INFO - PROCESS | 12151 | 19:34:15 INFO - TEST-INFO | 12151: exit 0 19:34:15 INFO - TEST-OK | kraken | took 62388ms 19:34:15 INFO - SUITE-END | took 1177s 19:34:16 INFO - Completed test suite (00:19:37) 19:34:16 INFO - javascript benchmark 19:34:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3090.6909309069088, 3090.752739780817, 3092.4742793725063, 3109.455845227085, 3152.2749767553464, 5222.060029194743, 5326.973365133179, 5341.626086173969, 5426.1046927257, 5443.346798384195, 5306.124489459245, 5328.733563321838, 5332.440093790155, 5357.866053348668, 5390.595705322097, 4773.4510531289, 4831.251156070814, 4835.6131509479155, 4839.419269687643, 4958.2562615607585, 4851.369321988154, 4867.099586576477, 4892.021595680861, 4908.19014862549, 4908.337374454439, 4743.1699452596, 4752.500987396325, 4787.186178349654, 4799.160146974265, 4807.927881081787, 4828.396450443694, 4833.10587541306, 4838.395200599925, 4862.902741945177, 4933.407991041062, 4842.927356089662, 4852.660313778037, 4868.440129385131, 4889.608831293488, 4913.926291105637, 5236.3978142513715, 5298.947010529884, 5311.203319502067, 5366.4901834326065, 5377.3009508764, 5710.457506536873, 5717.313922329347, 5721.084626459747, 5764.07774756037, 5764.279465066867, 5785.247917770663, 5786.045302525078, 5807.912881306742, 5812.593118481708, 5812.680302583356, 5133.25567792668, 5214.32213812202, 5243.10867152585, 5253.26454296395, 5318.840434786963, 5805.187273781674, 5805.854853628609, 5809.070548712186, 5820.35976042635, 5823.2429784128635, 5591.46881046308, 5599.44005599445, 5600.0, 5601.0, 5602.299712535933, 5533.778648854081, 5612.747426365823, 5673.319201695823, 5673.574481913791, 5744.224529688438, 5661.7735290588735, 5666.235058267163, 5668.461496157858, 5673.347565030074, 5705.657660540381, 5607.383187849333, 5673.3475650299915, 5676.545876329884, 5678.488935995698, 5679.574031947621, 4302.827886884552, 4325.178216138924, 4330.501992270866, 4338.696291259645, 4353.782310884443, 3868.613138686109, 3899.941500877489, 3900.531936167678, 3901.6293452122572, 3970.5830887756947, 5443.237946687467, 5452.809151679672, 5453.072977593819, 5456.508914197741, 5492.176173573916, 5499.670019798745, 5625.071863142617, 5662.5753068520025, 5759.884802303931, 5812.302523697099, 5368.704721240291, 5380.865478362994, 5387.434319396485, 5387.568994480433, 5427.0, 4933.112039832793, 4933.432655244693, 4944.499504459861, 4955.876103097451, 4993.575546078551, 5786.0, 5789.88420231593, 5867.589268751231, 5912.054071348563, 5917.289925209003, 5725.456081672234, 5760.913586296125, 5761.251037365116, 5763.7982670606325, 5765.0, 5926.4666180044005, 5937.109433584824, 5945.40545945402, 5946.910796337972, 5949.583529153091, 5466.043442397485, 5536.806211782568, 5544.085225937675, 5592.077307244259, 5599.132134519156, 5625.634333768292, 5661.745221465127, 5663.348714897839, 5685.175649530877, 5696.829095127153, 5445.128779395278, 5541.224228608079, 5553.666779993052, 5556.194351819045, 5559.749811258423, 5405.00007498614, 5433.130699088127, 5443.455654434525, 5467.890642187054, 5467.917981230205, 5376.838694839161, 5380.435054319397, 5394.730263486888, 5428.212909128075, 5447.891042179055, 5429.565634749131, 5528.834134975958, 5598.748056337393, 5603.439656034364, 5616.7191640416995, 5400.108982017923, 5437.864053398696, 5453.263809385682, 5465.754041068082, 5523.6685798852195], "value": 5245.312864849227, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [572.7422659803087, 601.6570554783772, 616.4113271825407, 620.2835724737928, 634.5050860328945, 30765.230869228282, 43334.34998475022, 44237.7788111059, 44257.33613995793, 44305.11389772207, 45421.54578454215, 45857.0, 45986.0, 46002.30996535055, 46118.07763844721, 8763.0, 8831.911680883206, 8880.511571863544, 8886.822263554724, 8890.110988901122, 8938.150875666834, 9048.095190480964, 9050.86423703645, 9051.411658242227, 9056.637734490645, 9104.089591040909, 9144.451332920045, 9151.816963660724, 9153.633854645806, 9155.26757859373, 9028.819423611523, 9064.592093355783, 9074.727758167266, 9075.410098343653, 9080.046595107551, 8917.910820891773, 8990.415622984485, 9001.144891235323, 9003.909960900373, 9009.189172974464, 42064.36903446451, 42128.78935605302, 42450.36324455136, 42546.36180457295, 42589.78705106486, 3257.2671148991526, 3644.2711457708565, 3863.2659794639208, 3939.9015024624327, 3995.20095980805, 31429.685703143132, 32513.6748632513, 32832.17919552006, 33125.503117453016, 33249.833750831334, 4433.889152771174, 4499.325101234808, 4526.434195725535, 4590.770461476913, 4680.157571637104, 354024.0, 356229.0, 357529.2123539392, 357894.8947297378, 358012.0, 59874.0, 59922.101168482506, 60303.09545356823, 60357.39642603606, 60409.09386359208, 56783.43216567781, 57126.0, 57177.428225718046, 57185.0, 57229.42770572324, 13973.441062357595, 15361.923190383977, 15706.0, 16122.75815862763, 16150.273237704332, 12075.396230188455, 12254.632361029184, 12257.754844903053, 12266.080043996735, 12270.38648067593, 18918.43244702661, 19034.0, 19052.71420928687, 19123.90438047801, 19137.90431047836, 5872.324682661549, 7035.522540266601, 7253.347198752138, 7292.19785823559, 7323.157836848724, 871.1636828644572, 956.1060408518058, 988.9604415823286, 999.1656966432964, 1072.3030030480095, 31307.129113670824, 31846.2038449036, 32053.198670033435, 32094.358112837614, 32612.510812337834, 1048.1981284317503, 1103.3049179017169, 1121.4560937945091, 1155.820847768597, 1263.9620811375673, 16235.675286494441, 17007.404740834012, 17065.658686826195, 17086.173963782858, 17090.316387344366, 558281.2945288048, 561403.0, 562156.0, 564531.0, 565383.0, 57848.71075644679, 58493.0, 58503.41496585065, 58616.413835861946, 58959.41040589625, 1217.622537013511, 1300.7593595184921, 1339.270097796703, 1379.8068270441945, 1415.9079659822078, 29703.40593188081, 33266.83366583152, 33855.322893542485, 33955.660443396235, 34196.82901585476, 51732.741336293075, 52197.0, 52521.47478525166, 52534.73732631312, 52635.21047184372, 450915.0, 457699.0, 460160.0, 462705.0, 463653.0, 39236.21527569376, 40942.615044445054, 45973.54026459692, 47182.76408617935, 48248.75875620599, 49229.49560637965, 49591.0, 49999.500004999485, 50217.0, 50742.74628626833, 43647.78176109099, 45299.77350113228, 45439.09121817479, 45747.77126114348, 46079.07841843212, 41682.58317416787, 41875.0, 41969.580304197785, 41975.58024419717, 42228.0, 41763.0, 41950.79024604979, 42708.57291427046, 42749.145017100105, 42947.35578966256, 32969.34061318712, 38308.425373619975, 38331.0, 38443.42334865035, 39063.0, 27592.448151037268, 27786.305342365795, 28084.29789255285, 28176.71823281741, 28190.295242619097], "value": 20585.019440997978, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [386.22561763663856, 386.54773914520007, 388.84780575240086, 399.4627226380518, 408.58732679993216, 14823.35934096401, 16134.515964521082, 18089.81910180898, 19565.413037608858, 19568.51078723031, 18548.44354669362, 18709.90645046773, 19235.711464328047, 19792.30726924558, 19813.108410121542, 5593.776248950037, 5604.971975140129, 5838.095095260221, 5845.7369418376275, 5850.210221620069, 4197.16056788642, 5763.221965034709, 5768.221290125843, 5801.622894511865, 6271.122042913996, 6523.641199734013, 6632.0, 6652.268250492442, 6657.101291325657, 6659.267480577133, 6334.334894836045, 6519.869602607969, 6534.346565343475, 6536.934630653727, 6598.439132673729, 5480.972595137038, 5735.684537350444, 5740.425957404268, 5740.4833564978935, 5766.740496677659, 22910.65634015491, 23455.543446745065, 23635.645465318034, 23654.763452365427, 23716.881415592983, 2424.139430502164, 2449.0571130115036, 2462.9438896601037, 2582.0575489946223, 2782.276608081893, 13919.23444210578, 14145.787813182811, 14153.0, 14275.928620356935, 14463.421463141462, 1861.0694652673662, 1922.8173323534243, 1972.2899756087797, 1986.0536674059358, 1998.3305592626486, 77812.0, 78935.60532197302, 81134.18865811266, 81555.59222203851, 82946.0, 9415.952920235355, 9598.18415434682, 10117.747056323504, 10147.543360548645, 10327.638532651321, 12266.509339626493, 13689.31553422325, 13728.176309421468, 30995.0, 31055.68944310528, 9511.381760185566, 9565.713028609152, 9592.95203523978, 9662.130408263149, 9830.377987632104, 7896.7236146734585, 7975.960120199362, 8027.237412445808, 8092.797680058045, 8409.621567029499, 8710.689937823714, 8921.821563568823, 8996.100389960951, 9098.636054557743, 9104.180623743763, 3442.5868895732674, 3445.638207988175, 3447.2772301946493, 3463.636318186554, 3498.772579782306, 879.7668617816283, 965.8164948659733, 1006.2151521812998, 1013.3919648211014, 1037.766502536923, 18899.149538270813, 18952.62094758097, 19108.808911910983, 19367.709484357747, 19481.662200536026, 897.9191872731485, 898.7483504618717, 933.3839665820526, 977.1645243317004, 1036.4817591204398, 10200.4389758564, 10544.841827372595, 10672.252942293964, 10705.46472676363, 10711.89288107109, 485295.0, 489327.0, 490309.0, 491248.0, 503879.0, 62715.0, 93437.0, 94941.0, 96489.9999999986, 96914.0, 991.9206463483048, 1008.0574662690261, 1024.6413755185624, 1044.2846650044744, 1044.6813721814767, 15957.361705532114, 16950.66098677995, 17066.2320195589, 17093.658126837145, 17345.826541734925, 40431.79784101179, 41109.383359250234, 43599.34600980925, 44314.0, 45052.32421513746, 60629.69685151546, 62208.0, 65841.67079164574, 66313.66843165753, 66321.0051849213, 8052.355811535181, 8480.01439323517, 8499.362547808816, 8787.912120878966, 8878.289736821169, 10829.458527073457, 13041.347932603521, 13436.126651767994, 13575.864241357855, 13973.161610303414, 11550.537978480766, 11597.246178998337, 11674.649760507198, 11809.586664466702, 11935.761284774082, 11618.302901825917, 11765.411729413667, 11768.235064720766, 11818.46816893259, 11827.881721182677, 11812.881871181178, 12024.75950481003, 12169.574064907685, 12201.816972745239, 12366.0, 8333.83332333362, 8769.693060743099, 8837.558122093998, 8877.689280875138, 8891.599878005376, 11304.0, 11762.58830940913, 11817.468213930222, 11891.881081189424, 11926.582569610022], "value": 9812.802029238399, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1302.5050480817288, 1439.5681295611316, 1498.9325480353384, 1572.4968010236728, 1750.5361079313975, 8077.91922080779, 8414.957925210372, 8426.325893928486, 8559.572021398937, 8571.828563428728, 8296.958515207416, 8438.2827459666, 8507.064222935473, 8515.829683406344, 8516.659333626647, 2151.0965394534296, 2172.7175467189245, 2173.706549615805, 2183.1813070098715, 2183.530540933699, 2089.665653495441, 2143.228437762404, 2148.0870629982273, 2157.6979222908803, 2160.2763074370105, 2146.6887301341294, 2161.7189765330563, 2165.902534385956, 2183.727034120735, 2204.2725900452892, 2119.5337025854287, 2135.306025541697, 2138.134055707441, 2142.6571748520164, 2147.3772605944414, 2110.155937624947, 2160.3087012156116, 2160.7191065161587, 2160.751513575943, 2166.4367264511184, 8499.405041647087, 8538.103499132625, 8629.482231066157, 8631.309495240428, 8757.56212189388, 5040.143175660147, 5176.637635365526, 5180.067587834188, 5187.974060129713, 5188.688678679291, 3347.916302092443, 3350.932981340384, 3380.2732412531177, 3384.9661503384896, 3438.862445502177, 1086.3861918016376, 1089.2974031749557, 1123.3035517978824, 1126.487448211062, 1127.3461392392392, 12004.459799309052, 12081.758364832654, 12101.818472722916, 12107.0, 12113.091518136174, 4352.434183556181, 4390.253656878338, 4427.446569178853, 4518.819247230074, 4525.393485312732, 9496.14534691881, 9511.286653501014, 9513.714588562354, 9514.38156519824, 9517.23862091045, 4963.057019166346, 5046.924296135561, 5047.87380315495, 5049.84850454487, 5051.0, 4215.852445164404, 4266.914661706748, 4665.533446655375, 4678.087772884323, 4713.976430117896, 3474.2009337851932, 3521.4189658706537, 3551.8401671924826, 3580.785152890835, 3588.964110358915, 1048.8636477257908, 1070.464767616192, 1078.6979645699216, 1080.9459527023616, 1090.5310716391868, 879.7096958003843, 992.5781542844262, 997.4165113408737, 1010.3322649360003, 1012.731626119079, 5925.466707996301, 6078.027515597483, 6115.327313995457, 6188.628682279078, 6204.038374052029, 421.791213349394, 424.1305324085674, 427.22458737391537, 429.1866912201361, 440.97795110245, 3992.0, 4170.541240463546, 4199.181159673834, 4203.5376108628025, 4266.0827921996915, 10462.68611941643, 10729.83905241422, 10823.837642435212, 10831.458427078614, 10846.403447810288, 10022.398656080659, 10390.22073344487, 10700.464976751287, 10743.570257189625, 10748.355098694103, 7977.60111994398, 8102.513849169069, 8112.269895709414, 8192.098869124391, 8194.959025204955, 5559.583031272751, 5754.625949313281, 5811.215485909348, 5864.9413505864395, 6022.378453312243, 9695.224382049279, 10101.090901818872, 10123.088921996761, 10123.64567240143, 10124.088832005154, 10106.444145572064, 10173.491325433846, 10218.1825453965, 10241.74395640115, 10322.741931451774, 7211.747588834365, 7636.274553917591, 7899.526028438312, 7923.445358824827, 8023.438359314792, 8503.362247831314, 8544.40189186751, 8564.05795362522, 8611.784705382415, 8613.181747733955, 7760.611969401621, 7800.687972481037, 7856.528608283521, 7859.764207073797, 7993.480423772437, 7586.658600362886, 7654.846903061796, 7716.151223365313, 7735.922640773745, 7770.378369730521, 6860.3139686031, 6986.126734158231, 6986.6855991481525, 6999.510034297754, 7242.710291588278, 5196.246544251138, 5379.112446446293, 5394.0, 5413.1880217966045, 5446.183072538993, 4998.350214472095, 5200.63595548308, 5260.7106609135335, 5273.604479664117, 5447.673139611636], "value": 4417.993007068684, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [312.7826160818232, 330.71228031612503, 333.586352922376, 339.50093362756746, 344.0504208384857, 5088.389393272812, 5182.559482443988, 5202.661826981243, 5272.8154514592, 5314.362276526813, 5219.5041471060185, 5253.6322457428, 5269.525742683158, 5281.894362112765, 5286.365636123671, 4158.293090174678, 4159.292920203565, 4178.76436106683, 4179.582041795827, 4192.951762059485, 3941.4876066111365, 3952.170044290688, 4173.603507666782, 4174.812133454002, 4177.498700155986, 4084.2035803018425, 4091.115763386805, 4144.652987778969, 4146.502419709639, 4155.937660935088, 4142.461480007595, 4147.294959856847, 4161.396597493346, 4174.269502836992, 4184.163167366539, 3467.9653203467897, 3740.8503659853573, 3742.5696044954634, 3756.417755247941, 3761.5110035695184, 5107.3105130807235, 5133.871653208662, 5149.227615857614, 5150.381954165524, 5180.818671346522, 4659.697119687244, 4664.460727959765, 4672.99530600919, 4685.8594242172785, 4709.552592503706, 5342.27879236302, 5391.32608423947, 5491.2312276281355, 5502.862428439281, 5509.9255645149215, 3947.5657677655436, 3972.503437070366, 3979.422983667352, 3984.900377490557, 3988.202359528106, 5698.715064246771, 5706.916975304026, 5726.713664316768, 5733.312002559678, 5742.253507044099, 3961.959590810735, 4072.0884567534354, 4093.1813637272667, 4119.443875076826, 4126.277901367249, 4117.8970525736495, 4119.855805046869, 4128.153728485653, 4142.875713728593, 4143.316352801814, 4692.53074692528, 4699.365585645963, 4700.2009658358165, 4727.456342520585, 4739.336492890998, 5555.805546805843, 5558.388577256498, 5568.329501149639, 5571.220029195916, 5593.216949627055, 1427.421894132878, 1471.8822494200438, 1479.8900824381715, 1480.6520467690084, 1481.9700308285853, 935.4714586258879, 940.0270719804969, 944.9622015119318, 951.871497347863, 969.5636963366513, 4628.490866004737, 4728.645351598644, 4736.915757066879, 4749.64377671676, 4761.4524329701835, 5017.724025178577, 5036.463878517087, 5039.521245481674, 5039.848804535796, 5054.696718196847, 4765.237561990065, 4768.736284884509, 4809.615230781529, 4830.203016502308, 4919.835272480097, 2985.7163569460868, 2993.832405361911, 2998.9850050749606, 3015.1406849047917, 3024.6219222597174, 5779.971100144472, 5836.445537673914, 5842.503387212135, 5850.824475265749, 5851.38560451155, 5562.638428502134, 5739.483446489836, 5747.48272655463, 5791.247137872049, 5808.767649294065, 5795.275590551181, 5798.652080875161, 5822.854428639318, 5867.178594996704, 5871.853203669943, 5355.758990845344, 5677.120046392815, 5690.203371527907, 5705.343885453226, 5713.457221563945, 5630.690312032878, 5644.604877658689, 5647.830565083054, 5657.104869868475, 5659.717014149359, 5842.5325973921135, 5862.882742345215, 5868.647881127146, 5872.4471694625845, 5882.205902203319, 3729.701623870138, 3868.168343806095, 4049.250888585621, 4063.4920634920636, 4072.674186065167, 5599.664020158803, 5602.747876345656, 5629.718514074362, 5637.9718101409235, 5669.489745922887, 5482.23248745168, 5493.807716730055, 5498.917516237179, 5510.972445137749, 5523.502884740393, 5209.166533354645, 5481.479259470344, 5505.587080969023, 5529.557635389239, 5530.446955304437, 5316.362036555638, 5338.4127745947135, 5362.0, 5397.190421436816, 5430.995265875667, 5324.8136315228785, 5455.727213639381, 5489.149181876815, 5510.972445137749, 5541.55919460935, 5436.287569415622, 5438.374586922555, 5455.345358556999, 5498.487915823181, 5502.477264659851], "value": 4186.022311167693, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [767.1637914673005, 785.8153333966517, 814.588632740466, 820.1142765812923, 820.2535692519808, 14837.851621483782, 15885.205739713027, 15934.920325398356, 16017.759733604005, 16024.83975160248, 14809.11145331281, 14826.406943722264, 14890.925545372285, 14895.702085958274, 14960.551183464486, 662.2185820731535, 773.5822655765879, 775.7866586688677, 786.1548835002367, 800.8638531449639, 793.0602236349915, 797.4935915693518, 799.7360870912614, 802.7230605441114, 803.8070862992898, 857.1000449528002, 857.5797859049052, 858.120426562775, 858.4849090545686, 859.2653281444337, 695.7495301691387, 832.9000519937616, 850.2305413600701, 850.3707256630111, 850.3834719828137, 618.6504624886925, 619.2507066449601, 620.2618883528587, 620.314552419579, 620.9720562574695, 14960.850391496164, 14964.551063468114, 14988.550343489604, 15029.774553381709, 15110.54668359951, 14310.570682879426, 14510.347034383478, 14740.115593064344, 14822.925885370612, 14874.256287185597, 12823.93588032054, 13099.41052652633, 13195.868041319656, 13220.801687974688, 13381.330933453386, 4388.71473354231, 4588.632909367243, 4662.300654901792, 4688.69523480976, 4690.202665546865, 74394.62802686007, 74670.25329746687, 74752.0, 75005.0, 75633.0, 11530.250533715282, 11603.245789023855, 11667.241629294238, 11694.824577631342, 11745.29528228309, 22029.0, 22226.222082227367, 22321.776782232293, 22340.0, 22540.66189007166, 8269.62786674601, 8324.25081742646, 8353.791155221168, 8383.077861435237, 8859.158379953895, 4645.74448405341, 4744.288356746516, 4788.808447662054, 4863.586595139453, 4925.088858561177, 3192.393445245396, 3324.634290228073, 3330.200751819546, 3333.6999670029813, 3335.199552107477, 568.8776912963733, 576.4379729763447, 587.1045612361924, 592.4075924075925, 596.1921596237123, 678.6708446403491, 693.2478261086677, 703.4720874812817, 705.816487713188, 724.7463387814329, 8894.822103557892, 9475.810483790285, 9503.239740820718, 9713.805723885484, 9750.804983900282, 566.2214455124205, 595.6694034810635, 623.7006237006262, 672.0356288725596, 774.2953911940108, 4479.395281636937, 4615.630749540029, 4716.245400735935, 4819.770958405654, 4902.828401006019, 111027.44486277679, 115573.0, 116333.0, 118345.0, 118776.0, 100352.48413821396, 100642.0, 101389.0, 103128.0, 103929.48035259926, 58094.7095264521, 59954.400455995754, 61704.69147654323, 87600.12399876048, 88496.5575172133, 9840.950795245977, 10203.28576999603, 10272.075513203847, 10794.514246858753, 10870.782584348426, 43520.782396087816, 46710.53289467062, 47116.7644161777, 52657.0, 53155.73422132865, 69216.6539167301, 71520.64239678768, 72581.0, 74260.2573974275, 74971.0, 14186.0, 14471.710565788835, 14482.420703172176, 14611.196384198545, 14774.409023638935, 14969.775453368426, 15561.299741511433, 15569.532914012598, 15581.376744930076, 15957.0, 13886.444542218198, 13897.305134743021, 14417.207053611732, 14431.927840360731, 14824.258787060387, 14186.716265674835, 14418.279086045866, 14423.567292981228, 14709.632259193606, 15119.16844573559, 13328.200307981551, 13645.727085458037, 14112.858871411565, 14153.575392738234, 14178.220197889215, 11622.5350985963, 11633.360165190996, 11788.587399440978, 11857.644270671894, 12321.445534951128, 11907.940460297643, 12092.214006089576, 12132.0, 12283.324417157142, 12439.564615238423], "value": 7630.104019445777, "unit": "score"}], "name": "dromaeo_css", "value": 7285.404940804748, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 111.0, 108.0, 111.0, 111.0, 109.0, 112.0, 112.0, 110.0, 109.0], "value": 109.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 131.0, 128.0, 189.0, 132.0, 128.0, 154.0, 126.0, 160.0, 125.0], "value": 143.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 162.0, 160.0, 163.0, 160.0, 159.0, 161.0, 161.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 76.0, 125.0, 77.0, 78.0, 75.0, 74.0, 115.0, 74.0], "value": 84.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 117.0, 85.0, 85.0, 86.0, 125.0, 86.0, 84.0, 121.0], "value": 95.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 118.0, 118.0, 116.0, 118.0, 117.0, 118.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 147.0, 147.0, 148.0, 145.0, 145.0, 145.0, 147.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 94.0, 95.0, 95.0, 94.0, 95.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 52.0, 54.0, 53.0, 52.0, 53.0, 54.0, 55.0, 53.0, 55.0], "value": 53.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 61.0, 62.0, 61.0, 62.0, 62.0, 62.0, 63.0, 62.0], "value": 62.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 81.0, 85.0, 79.0, 79.0, 81.0, 81.0, 81.0, 89.0, 79.0], "value": 82.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 135.0, 131.0, 118.0, 132.0, 120.0, 119.0, 124.0, 132.0, 137.0], "value": 128.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 163.0, 160.0, 158.0, 157.0, 157.0, 161.0, 156.0, 162.0], "value": 159.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 64.0, 62.0, 62.0, 62.0, 65.0, 65.0, 66.0, 62.0], "value": 63.5, "unit": "score"}], "name": "kraken", "value": 1501.3000000000002, "alertThreshold": 2.0}]} 19:34:16 INFO - Return code: 0 19:34:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:34:16 INFO - # TBPL SUCCESS # 19:34:16 INFO - Running post-action listener: _resource_record_post_action 19:34:16 INFO - ##### 19:34:16 INFO - ##### Finished run-tests step (success) 19:34:16 INFO - ##### 19:34:16 INFO - Running post-run listener: _resource_record_post_run 19:34:16 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 563560448; Read time: 20; Write time: 1125524 19:34:16 INFO - TinderboxPrint: CPU usage
13.3% 19:34:16 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 19:34:16 INFO - TinderboxPrint: I/O write bytes / time
563,560,448 / 1,125,524 19:34:16 INFO - TinderboxPrint: CPU idle
8,282.7 (86.7%) 19:34:16 INFO - TinderboxPrint: CPU user
1,210.7 (12.7%) 19:34:16 INFO - TinderboxPrint: Swap in / out
0 / 0 19:34:16 INFO - install - Wall time: 18s; CPU: 17.0%; Read bytes: 0; Write bytes: 256565248; Read time: 0; Write time: 706664 19:34:16 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 4096; Write bytes: 295116800; Read time: 20; Write time: 417532 19:34:16 INFO - Running post-run listener: _upload_blobber_files 19:34:16 INFO - Blob upload gear active. 19:34:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:34:16 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 19:34:16 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'] 19:34:16 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 19:34:17 INFO - (blobuploader) - INFO - Open directory for files ... 19:34:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:34:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:34:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:34:21 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:34:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:34:21 INFO - (blobuploader) - INFO - Done attempting. 19:34:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:34:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:34:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:34:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:34:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:34:22 INFO - (blobuploader) - INFO - Done attempting. 19:34:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:34:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:34:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:34:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:34:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:34:23 INFO - (blobuploader) - INFO - Done attempting. 19:34:23 INFO - (blobuploader) - INFO - Iteration through files over. 19:34:23 INFO - Return code: 0 19:34:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:34:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:34:23 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/dd060d3b870e4fa589a17a0b05ef12f438bf2c1dfdeddd48aa87061a36d030d27e18cd4a95a3f27ef059221ad1805df19149da728655d3ac861e4f1c888270f1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/58fb1375fca93c8529a14d62068c11ed545175045eefecd2883c613f1fa748bad8aab61029cc66eed804c75cc8ab1685188c636a2a3cea59f726ecea9969e1e9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5fa43b94d7c861a91090714652c150db17e3f76b787a83779e0aabe79be53d027046837260010253812bfcb158d13534ff0cf890f7d5161580604100352899ce"} 19:34:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:34:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:34:23 INFO - Contents: 19:34:23 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/dd060d3b870e4fa589a17a0b05ef12f438bf2c1dfdeddd48aa87061a36d030d27e18cd4a95a3f27ef059221ad1805df19149da728655d3ac861e4f1c888270f1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/58fb1375fca93c8529a14d62068c11ed545175045eefecd2883c613f1fa748bad8aab61029cc66eed804c75cc8ab1685188c636a2a3cea59f726ecea9969e1e9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5fa43b94d7c861a91090714652c150db17e3f76b787a83779e0aabe79be53d027046837260010253812bfcb158d13534ff0cf890f7d5161580604100352899ce"} 19:34:23 INFO - Running post-run listener: copy_logs_to_upload_dir 19:34:23 INFO - Copying logs to upload dir... 19:34:23 INFO - mkdir: /builds/slave/test/build/upload/logs 19:34:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.648982 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-06-24 19:34:23.062438) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-24 19:34:23.066562) ========= 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=745a4373a2a16df560f216e000000264-1466815098.321207-494276771 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/dd060d3b870e4fa589a17a0b05ef12f438bf2c1dfdeddd48aa87061a36d030d27e18cd4a95a3f27ef059221ad1805df19149da728655d3ac861e4f1c888270f1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/58fb1375fca93c8529a14d62068c11ed545175045eefecd2883c613f1fa748bad8aab61029cc66eed804c75cc8ab1685188c636a2a3cea59f726ecea9969e1e9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5fa43b94d7c861a91090714652c150db17e3f76b787a83779e0aabe79be53d027046837260010253812bfcb158d13534ff0cf890f7d5161580604100352899ce"} build_url:https://queue.taskcluster.net/v1/task/T4Pk5F9XRxKNuXGHlQ3WDQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011361 build_url: 'https://queue.taskcluster.net/v1/task/T4Pk5F9XRxKNuXGHlQ3WDQ/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/dd060d3b870e4fa589a17a0b05ef12f438bf2c1dfdeddd48aa87061a36d030d27e18cd4a95a3f27ef059221ad1805df19149da728655d3ac861e4f1c888270f1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/58fb1375fca93c8529a14d62068c11ed545175045eefecd2883c613f1fa748bad8aab61029cc66eed804c75cc8ab1685188c636a2a3cea59f726ecea9969e1e9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5fa43b94d7c861a91090714652c150db17e3f76b787a83779e0aabe79be53d027046837260010253812bfcb158d13534ff0cf890f7d5161580604100352899ce"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-24 19:34:23.096156) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 19:34:23.096753) ========= 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=745a4373a2a16df560f216e000000264-1466815098.321207-494276771 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004438 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 19:34:23.177574) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-24 19:34:23.177938) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-24 19:34:23.178296) ========= ========= Total master_lag: 0.19 =========