builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-013 starttime: 1467083220.88 results: success (0) buildid: 20160627173005 builduid: cf09a895afa94857855ac1b26bb13aa5 revision: 6e61bbb4c032837e3874f9f6bbe60381b7e6ce34 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 20:07:00.876207) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 20:07:00.876604) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 20:07:00.876879) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 20:07:00.928192) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 20:07:00.928451) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1467082825.818622-1721532570 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-27 20:07:01-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2016-06-27 20:07:01 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.188723 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 20:07:01.131077) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 20:07:01.131381) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1467082825.818622-1721532570 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017475 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 20:07:01.180523) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 20:07:01.180909) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 6e61bbb4c032837e3874f9f6bbe60381b7e6ce34 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 6e61bbb4c032837e3874f9f6bbe60381b7e6ce34 --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=9c3a94c35cc88655b05d2c08000001b2-1467082825.818622-1721532570 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-27 20:07:01,294 truncating revision to first 12 chars 2016-06-27 20:07:01,294 Setting DEBUG logging. 2016-06-27 20:07:01,294 attempt 1/10 2016-06-27 20:07:01,294 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/6e61bbb4c032?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-27 20:07:01,595 unpacking tar archive at: fx-team-6e61bbb4c032/testing/mozharness/ program finished with exit code 0 elapsedTime=0.676142 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 20:07:01.871723) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 20:07:01.872025) ========= script_repo_revision: 6e61bbb4c032837e3874f9f6bbe60381b7e6ce34 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 20:07:01.872403) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 20:07:01.872773) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 20:07:01.882817) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-06-27 20:07:01.883096) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=9c3a94c35cc88655b05d2c08000001b2-1467082825.818622-1721532570 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:07:02 INFO - MultiFileLogger online at 20160627 20:07:02 in /builds/slave/test 20:07:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 20:07:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:07:02 INFO - {'append_to_log': False, 20:07:02 INFO - 'base_work_dir': '/builds/slave/test', 20:07:02 INFO - 'blob_upload_branch': 'Fx-Team', 20:07:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:07:02 INFO - 'branch': 'Fx-Team', 20:07:02 INFO - 'buildbot_json_path': 'buildprops.json', 20:07:02 INFO - 'config_files': ('talos/linux_config.py',), 20:07:02 INFO - 'default_actions': ('clobber', 20:07:02 INFO - 'read-buildbot-config', 20:07:02 INFO - 'download-and-extract', 20:07:02 INFO - 'populate-webroot', 20:07:02 INFO - 'create-virtualenv', 20:07:02 INFO - 'install', 20:07:02 INFO - 'run-tests'), 20:07:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:07:02 INFO - 'download_minidump_stackwalk': True, 20:07:02 INFO - 'download_symbols': 'ondemand', 20:07:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:07:02 INFO - 'tooltool.py': '/tools/tooltool.py', 20:07:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:07:02 INFO - '/tools/misc-python/virtualenv.py')}, 20:07:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:07:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:07:02 INFO - 'installer_path': 'installer.exe', 20:07:02 INFO - 'log_level': 'info', 20:07:02 INFO - 'log_name': 'talos', 20:07:02 INFO - 'log_to_console': True, 20:07:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:07:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:07:02 INFO - 'opt_config_files': (), 20:07:02 INFO - 'pip_index': False, 20:07:02 INFO - 'sps_profile': False, 20:07:02 INFO - 'sps_profile_interval': 0, 20:07:02 INFO - 'suite': 'dromaeojs', 20:07:02 INFO - 'system_bits': '32', 20:07:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:07:02 INFO - 'title': 'talos-linux64-ix-013', 20:07:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:07:02 INFO - 'use_talos_json': True, 20:07:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:07:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:07:02 INFO - 'work_dir': 'build'} 20:07:02 INFO - ##### 20:07:02 INFO - ##### Running clobber step. 20:07:02 INFO - ##### 20:07:02 INFO - Running pre-action listener: _resource_record_pre_action 20:07:02 INFO - Running main action method: clobber 20:07:02 INFO - rmtree: /builds/slave/test/build 20:07:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:07:03 INFO - Running post-action listener: _resource_record_post_action 20:07:03 INFO - ##### 20:07:03 INFO - ##### Finished clobber step (success) 20:07:03 INFO - ##### 20:07:03 INFO - ##### 20:07:03 INFO - ##### Running read-buildbot-config step. 20:07:03 INFO - ##### 20:07:03 INFO - Running pre-action listener: _resource_record_pre_action 20:07:03 INFO - Running main action method: read_buildbot_config 20:07:03 INFO - Using buildbot properties: 20:07:03 INFO - { 20:07:03 INFO - "project": "", 20:07:03 INFO - "product": "firefox", 20:07:03 INFO - "script_repo_revision": "production", 20:07:03 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 20:07:03 INFO - "repository": "", 20:07:03 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 20:07:03 INFO - "buildid": "20160627173005", 20:07:03 INFO - "pgo_build": "True", 20:07:03 INFO - "basedir": "/builds/slave/test", 20:07:03 INFO - "buildnumber": 221, 20:07:03 INFO - "slavename": "talos-linux64-ix-013", 20:07:03 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 20:07:03 INFO - "platform": "ubuntu64_hw", 20:07:03 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 20:07:03 INFO - "branch": "fx-team", 20:07:03 INFO - "repo_path": "integration/fx-team", 20:07:03 INFO - "revision": "6e61bbb4c032837e3874f9f6bbe60381b7e6ce34", 20:07:03 INFO - "stage_platform": "linux64-pgo", 20:07:03 INFO - "builduid": "cf09a895afa94857855ac1b26bb13aa5", 20:07:03 INFO - "slavebuilddir": "test" 20:07:03 INFO - } 20:07:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/GSJnKxL4S6e7jEHf_EBX3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 20:07:03 INFO - Running post-action listener: _resource_record_post_action 20:07:03 INFO - ##### 20:07:03 INFO - ##### Finished read-buildbot-config step (success) 20:07:03 INFO - ##### 20:07:03 INFO - ##### 20:07:03 INFO - ##### Running download-and-extract step. 20:07:03 INFO - ##### 20:07:03 INFO - Running pre-action listener: _resource_record_pre_action 20:07:03 INFO - Running main action method: download_and_extract 20:07:03 INFO - mkdir: /builds/slave/test/build/tests 20:07:03 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')]} 20:07:03 INFO - https://queue.taskcluster.net/v1/task/GSJnKxL4S6e7jEHf_EBX3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 20:07:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GSJnKxL4S6e7jEHf_EBX3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:07:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GSJnKxL4S6e7jEHf_EBX3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:07:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GSJnKxL4S6e7jEHf_EBX3w/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 20:07:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GSJnKxL4S6e7jEHf_EBX3w/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 20:07:14 INFO - Downloaded 1361 bytes. 20:07:14 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:07:14 INFO - Using the following test package requirements: 20:07:14 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 20:07:14 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:07:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:07:14 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:07:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:07:14 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:07:14 INFO - u'jsshell-linux-x86_64.zip'], 20:07:14 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:07:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:07:14 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 20:07:14 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:07:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:07:14 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:07:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:07:14 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:07:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:07:14 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:07:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:07:14 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:07:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:07:14 INFO - https://queue.taskcluster.net/v1/task/GSJnKxL4S6e7jEHf_EBX3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:07:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GSJnKxL4S6e7jEHf_EBX3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:07:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GSJnKxL4S6e7jEHf_EBX3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:07:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GSJnKxL4S6e7jEHf_EBX3w/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 20:07:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GSJnKxL4S6e7jEHf_EBX3w/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 20:07:18 INFO - Downloaded 24279773 bytes. 20:07:18 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'] 20:07:18 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 20:07:19 INFO - Return code: 0 20:07:19 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 20:07:19 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')]} 20:07:19 INFO - https://queue.taskcluster.net/v1/task/GSJnKxL4S6e7jEHf_EBX3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:07:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GSJnKxL4S6e7jEHf_EBX3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:07:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GSJnKxL4S6e7jEHf_EBX3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:07:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GSJnKxL4S6e7jEHf_EBX3w/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 20:07:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GSJnKxL4S6e7jEHf_EBX3w/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 20:07:31 INFO - Downloaded 24279773 bytes. 20:07:31 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'] 20:07:31 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 20:07:33 INFO - Return code: 0 20:07:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:07:33 INFO - https://queue.taskcluster.net/v1/task/GSJnKxL4S6e7jEHf_EBX3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:07:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GSJnKxL4S6e7jEHf_EBX3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 20:07:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GSJnKxL4S6e7jEHf_EBX3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 20:07:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GSJnKxL4S6e7jEHf_EBX3w/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 20:07:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GSJnKxL4S6e7jEHf_EBX3w/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 20:07:34 INFO - Downloaded 14405245 bytes. 20:07:34 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'] 20:07:34 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 20:07:34 INFO - Return code: 0 20:07:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:07:34 INFO - https://queue.taskcluster.net/v1/task/GSJnKxL4S6e7jEHf_EBX3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:07:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GSJnKxL4S6e7jEHf_EBX3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:07:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GSJnKxL4S6e7jEHf_EBX3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:07:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GSJnKxL4S6e7jEHf_EBX3w/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 20:07:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GSJnKxL4S6e7jEHf_EBX3w/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 20:07:37 INFO - Downloaded 60281382 bytes. 20:07:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GSJnKxL4S6e7jEHf_EBX3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:07:37 INFO - mkdir: /builds/slave/test/properties 20:07:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:07:37 INFO - Writing to file /builds/slave/test/properties/build_url 20:07:37 INFO - Contents: 20:07:37 INFO - build_url:https://queue.taskcluster.net/v1/task/GSJnKxL4S6e7jEHf_EBX3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:07:38 INFO - Running post-action listener: _resource_record_post_action 20:07:38 INFO - Running post-action listener: set_extra_try_arguments 20:07:38 INFO - ##### 20:07:38 INFO - ##### Finished download-and-extract step (success) 20:07:38 INFO - ##### 20:07:38 INFO - ##### 20:07:38 INFO - ##### Running populate-webroot step. 20:07:38 INFO - ##### 20:07:38 INFO - Running pre-action listener: _resource_record_pre_action 20:07:38 INFO - Running main action method: populate_webroot 20:07:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:07:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:07:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:07:38 INFO - '--tppagecycles', 20:07:38 INFO - '7'], 20:07:38 INFO - 'tests': ['tsvgm']}}, 20:07:38 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:07:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:07:38 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:07:38 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:07:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:07:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:07:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:07:38 INFO - 'talos_options': ['--disable-e10s'], 20:07:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:07:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:07:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:07:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:07:38 INFO - 'talos_options': ['--disable-e10s'], 20:07:38 INFO - 'tests': ['damp', 'tps']}, 20:07:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:07:38 INFO - 'tests': ['damp', 'tps']}, 20:07:38 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:07:38 INFO - 'tests': ['dromaeo_dom']}, 20:07:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:07:38 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:07:38 INFO - 'tests': ['basic_compositor_video']}, 20:07:38 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:07:38 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:07:38 INFO - 'tests': ['a11yr', 20:07:38 INFO - 'ts_paint', 20:07:38 INFO - 'tpaint', 20:07:38 INFO - 'sessionrestore', 20:07:38 INFO - 'sessionrestore_no_auto_restore', 20:07:38 INFO - 'tabpaint']}, 20:07:38 INFO - 'other-e10s': {'tests': ['a11yr', 20:07:38 INFO - 'ts_paint', 20:07:38 INFO - 'tpaint', 20:07:38 INFO - 'sessionrestore', 20:07:38 INFO - 'sessionrestore_no_auto_restore', 20:07:38 INFO - 'tabpaint']}, 20:07:38 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:07:38 INFO - 'ts_paint', 20:07:38 INFO - 'tpaint', 20:07:38 INFO - 'sessionrestore', 20:07:38 INFO - 'sessionrestore_no_auto_restore', 20:07:38 INFO - 'tabpaint']}, 20:07:38 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:07:38 INFO - 'ts_paint', 20:07:38 INFO - 'tpaint', 20:07:38 INFO - 'sessionrestore', 20:07:38 INFO - 'sessionrestore_no_auto_restore', 20:07:38 INFO - 'tabpaint']}, 20:07:38 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:07:38 INFO - 'tests': ['a11yr', 20:07:38 INFO - 'ts_paint', 20:07:38 INFO - 'tpaint', 20:07:38 INFO - 'sessionrestore', 20:07:38 INFO - 'sessionrestore_no_auto_restore', 20:07:38 INFO - 'tabpaint']}, 20:07:38 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:07:38 INFO - 'tests': ['a11yr', 20:07:38 INFO - 'ts_paint', 20:07:38 INFO - 'tpaint', 20:07:38 INFO - 'sessionrestore', 20:07:38 INFO - 'sessionrestore_no_auto_restore', 20:07:38 INFO - 'tabpaint']}, 20:07:38 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:07:38 INFO - 'tests': ['tsvgx', 20:07:38 INFO - 'tsvgr_opacity', 20:07:38 INFO - 'tart', 20:07:38 INFO - 'tscrollx', 20:07:38 INFO - 'cart']}, 20:07:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:07:38 INFO - 'tsvgr_opacity', 20:07:38 INFO - 'tart', 20:07:38 INFO - 'tscrollx', 20:07:38 INFO - 'cart']}, 20:07:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:07:38 INFO - 'talos_options': ['--disable-e10s'], 20:07:38 INFO - 'tests': ['tp5o']}, 20:07:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:07:38 INFO - 'tests': ['tp5o']}, 20:07:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:07:38 INFO - 'talos_options': ['--disable-e10s', 20:07:38 INFO - '--xperf_path', 20:07:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:07:38 INFO - 'tests': ['tp5n']}, 20:07:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:07:38 INFO - 'talos_options': ['--xperf_path', 20:07:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:07:38 INFO - 'tests': ['tp5n']}}, 20:07:38 INFO - 'talos.zip': {'path': '', 20:07:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:07:38 INFO - Running post-action listener: _resource_record_post_action 20:07:38 INFO - ##### 20:07:38 INFO - ##### Finished populate-webroot step (success) 20:07:38 INFO - ##### 20:07:38 INFO - ##### 20:07:38 INFO - ##### Running create-virtualenv step. 20:07:38 INFO - ##### 20:07:38 INFO - Running pre-action listener: _resource_record_pre_action 20:07:38 INFO - Running main action method: create_virtualenv 20:07:38 INFO - Creating virtualenv /builds/slave/test/build/venv 20:07:38 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 20:07:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:07:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:07:38 INFO - Using real prefix '/usr' 20:07:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:07:38 INFO - Installing distribute.............................................................................................................................................................................................done. 20:07:40 INFO - Installing pip.................done. 20:07:40 INFO - Return code: 0 20:07:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:07:40 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')]} 20:07:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:07:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:40 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')]} 20:07:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:07:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:40 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 0x7fa321580f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16e4480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17736f0>, '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 0x17745f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1774aa0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1467082825.818622-1721532570', '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 20:07:40 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 20:07:40 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 20:07:40 INFO - Using env: {'DISPLAY': ':0', 20:07:40 INFO - 'HOME': '/home/cltbld', 20:07:40 INFO - 'LANG': 'en_US.UTF-8', 20:07:40 INFO - 'LANGUAGE': 'en_US:en', 20:07:40 INFO - 'LOGNAME': 'cltbld', 20:07:40 INFO - 'MAIL': '/var/mail/cltbld', 20:07:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:07:40 INFO - 'MOZ_NO_REMOTE': '1', 20:07:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:07:40 INFO - 'NO_EM_RESTART': '1', 20:07:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:07:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:07:40 INFO - 'PWD': '/builds/slave/test', 20:07:40 INFO - 'SHELL': '/bin/bash', 20:07:40 INFO - 'SHLVL': '1', 20:07:40 INFO - 'TERM': 'linux', 20:07:40 INFO - 'TMOUT': '86400', 20:07:40 INFO - 'USER': 'cltbld', 20:07:40 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1467082825.818622-1721532570', 20:07:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:07:40 INFO - '_': '/tools/buildbot/bin/python'} 20:07:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:07:41 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 20:07:41 INFO - Cleaning up... 20:07:41 INFO - Return code: 0 20:07:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:07: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')]} 20:07:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:07:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07: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')]} 20:07:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:07:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:41 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 0x7fa321580f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16e4480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17736f0>, '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 0x17745f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1774aa0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1467082825.818622-1721532570', '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 20:07:41 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 20:07:41 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 20:07:41 INFO - Using env: {'DISPLAY': ':0', 20:07:41 INFO - 'HOME': '/home/cltbld', 20:07:41 INFO - 'LANG': 'en_US.UTF-8', 20:07:41 INFO - 'LANGUAGE': 'en_US:en', 20:07:41 INFO - 'LOGNAME': 'cltbld', 20:07:41 INFO - 'MAIL': '/var/mail/cltbld', 20:07:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:07:41 INFO - 'MOZ_NO_REMOTE': '1', 20:07:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:07:41 INFO - 'NO_EM_RESTART': '1', 20:07:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:07:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:07:41 INFO - 'PWD': '/builds/slave/test', 20:07:41 INFO - 'SHELL': '/bin/bash', 20:07:41 INFO - 'SHLVL': '1', 20:07:41 INFO - 'TERM': 'linux', 20:07:41 INFO - 'TMOUT': '86400', 20:07:41 INFO - 'USER': 'cltbld', 20:07:41 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1467082825.818622-1721532570', 20:07:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:07:41 INFO - '_': '/tools/buildbot/bin/python'} 20:07:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:07:41 INFO - Downloading/unpacking psutil>=3.1.1 20:07:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:07:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:07:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:07:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:07:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:07:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:07:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:07:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:07:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:07:43 INFO - Installing collected packages: psutil 20:07:43 INFO - Running setup.py install for psutil 20:07:43 INFO - building 'psutil._psutil_linux' extension 20:07:43 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 20:07:43 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 20:07:43 INFO - building 'psutil._psutil_posix' extension 20:07:43 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 20:07:43 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 20:07:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:07:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:07:43 INFO - Successfully installed psutil 20:07:43 INFO - Cleaning up... 20:07:43 INFO - Return code: 0 20:07:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:07: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')]} 20:07:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:07:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07: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')]} 20:07:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:07:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:43 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 0x7fa321580f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16e4480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17736f0>, '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 0x17745f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1774aa0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1467082825.818622-1721532570', '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 20:07:43 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 20:07:43 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 20:07:43 INFO - Using env: {'DISPLAY': ':0', 20:07:43 INFO - 'HOME': '/home/cltbld', 20:07:43 INFO - 'LANG': 'en_US.UTF-8', 20:07:43 INFO - 'LANGUAGE': 'en_US:en', 20:07:43 INFO - 'LOGNAME': 'cltbld', 20:07:43 INFO - 'MAIL': '/var/mail/cltbld', 20:07:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:07:43 INFO - 'MOZ_NO_REMOTE': '1', 20:07:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:07:43 INFO - 'NO_EM_RESTART': '1', 20:07:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:07:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:07:43 INFO - 'PWD': '/builds/slave/test', 20:07:43 INFO - 'SHELL': '/bin/bash', 20:07:43 INFO - 'SHLVL': '1', 20:07:43 INFO - 'TERM': 'linux', 20:07:43 INFO - 'TMOUT': '86400', 20:07:43 INFO - 'USER': 'cltbld', 20:07:43 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1467082825.818622-1721532570', 20:07:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:07:43 INFO - '_': '/tools/buildbot/bin/python'} 20:07:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:07:44 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:07:44 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 20:07:44 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 20:07:44 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 20:07:44 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 20:07:44 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 20:07:44 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 20:07:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:07:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:07:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:07:46 INFO - Installing collected packages: mozsystemmonitor 20:07:46 INFO - Running setup.py install for mozsystemmonitor 20:07:46 INFO - Successfully installed mozsystemmonitor 20:07:46 INFO - Cleaning up... 20:07:46 INFO - Return code: 0 20:07:46 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:07: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')]} 20:07:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:07:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07: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')]} 20:07:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:07:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:46 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 0x7fa321580f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16e4480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17736f0>, '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 0x17745f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1774aa0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1467082825.818622-1721532570', '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 20:07:46 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 20:07:46 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 20:07:46 INFO - Using env: {'DISPLAY': ':0', 20:07:46 INFO - 'HOME': '/home/cltbld', 20:07:46 INFO - 'LANG': 'en_US.UTF-8', 20:07:46 INFO - 'LANGUAGE': 'en_US:en', 20:07:46 INFO - 'LOGNAME': 'cltbld', 20:07:46 INFO - 'MAIL': '/var/mail/cltbld', 20:07:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:07:46 INFO - 'MOZ_NO_REMOTE': '1', 20:07:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:07:46 INFO - 'NO_EM_RESTART': '1', 20:07:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:07:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:07:46 INFO - 'PWD': '/builds/slave/test', 20:07:46 INFO - 'SHELL': '/bin/bash', 20:07:46 INFO - 'SHLVL': '1', 20:07:46 INFO - 'TERM': 'linux', 20:07:46 INFO - 'TMOUT': '86400', 20:07:46 INFO - 'USER': 'cltbld', 20:07:46 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1467082825.818622-1721532570', 20:07:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:07:46 INFO - '_': '/tools/buildbot/bin/python'} 20:07:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:07:46 INFO - Downloading/unpacking jsonschema==2.5.1 20:07:46 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 20:07:46 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 20:07:46 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 20:07:46 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 20:07:46 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 20:07:46 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 20:07:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:07:48 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:07:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:07:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:07:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:07:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:07:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:07:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:07:48 INFO - Downloading functools32-3.2.3-2.tar.gz 20:07:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:07:48 INFO - warning: no files found matching '*.txt' 20:07:48 INFO - no previously-included directories found matching 'build' 20:07:48 INFO - no previously-included directories found matching 'dist' 20:07:48 INFO - no previously-included directories found matching '.git*' 20:07:48 INFO - Installing collected packages: jsonschema, functools32 20:07:48 INFO - Running setup.py install for functools32 20:07:48 INFO - warning: no files found matching '*.txt' 20:07:48 INFO - no previously-included directories found matching 'build' 20:07:48 INFO - no previously-included directories found matching 'dist' 20:07:48 INFO - no previously-included directories found matching '.git*' 20:07:48 INFO - Successfully installed jsonschema functools32 20:07:48 INFO - Cleaning up... 20:07:48 INFO - Return code: 0 20:07:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:07:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:07:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:07:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:07:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:07:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fa321580f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16e4480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17736f0>, '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 0x17745f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1774aa0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1467082825.818622-1721532570', '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 20:07:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 20:07:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 20:07:48 INFO - Using env: {'DISPLAY': ':0', 20:07:48 INFO - 'HOME': '/home/cltbld', 20:07:48 INFO - 'LANG': 'en_US.UTF-8', 20:07:48 INFO - 'LANGUAGE': 'en_US:en', 20:07:48 INFO - 'LOGNAME': 'cltbld', 20:07:48 INFO - 'MAIL': '/var/mail/cltbld', 20:07:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:07:48 INFO - 'MOZ_NO_REMOTE': '1', 20:07:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:07:48 INFO - 'NO_EM_RESTART': '1', 20:07:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:07:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:07:48 INFO - 'PWD': '/builds/slave/test', 20:07:48 INFO - 'SHELL': '/bin/bash', 20:07:48 INFO - 'SHLVL': '1', 20:07:48 INFO - 'TERM': 'linux', 20:07:48 INFO - 'TMOUT': '86400', 20:07:48 INFO - 'USER': 'cltbld', 20:07:48 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1467082825.818622-1721532570', 20:07:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:07:48 INFO - '_': '/tools/buildbot/bin/python'} 20:07:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:07:49 INFO - Downloading/unpacking blobuploader==1.2.4 20:07:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:07:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:07:49 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 20:07:49 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 20:07:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:07:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:07:51 INFO - Downloading blobuploader-1.2.4.tar.gz 20:07:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:07:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:07:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:07:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:07:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:07:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:07:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:07:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:07:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:07:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:07:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:07:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:07:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:07:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:07:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:07:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:07:51 INFO - Downloading docopt-0.6.1.tar.gz 20:07:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:07:51 INFO - Installing collected packages: blobuploader, requests, docopt 20:07:51 INFO - Running setup.py install for blobuploader 20:07:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:07:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:07:51 INFO - Running setup.py install for requests 20:07:52 INFO - Running setup.py install for docopt 20:07:52 INFO - Successfully installed blobuploader requests docopt 20:07:52 INFO - Cleaning up... 20:07:52 INFO - Return code: 0 20:07:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:07: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')]} 20:07:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:07:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07: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')]} 20:07:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:07:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:52 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 0x7fa321580f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16e4480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17736f0>, '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 0x17745f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1774aa0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1467082825.818622-1721532570', '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 20:07:52 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 20:07:52 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 20:07:52 INFO - Using env: {'DISPLAY': ':0', 20:07:52 INFO - 'HOME': '/home/cltbld', 20:07:52 INFO - 'LANG': 'en_US.UTF-8', 20:07:52 INFO - 'LANGUAGE': 'en_US:en', 20:07:52 INFO - 'LOGNAME': 'cltbld', 20:07:52 INFO - 'MAIL': '/var/mail/cltbld', 20:07:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:07:52 INFO - 'MOZ_NO_REMOTE': '1', 20:07:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:07:52 INFO - 'NO_EM_RESTART': '1', 20:07:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:07:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:07:52 INFO - 'PWD': '/builds/slave/test', 20:07:52 INFO - 'SHELL': '/bin/bash', 20:07:52 INFO - 'SHLVL': '1', 20:07:52 INFO - 'TERM': 'linux', 20:07:52 INFO - 'TMOUT': '86400', 20:07:52 INFO - 'USER': 'cltbld', 20:07:52 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1467082825.818622-1721532570', 20:07:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:07:52 INFO - '_': '/tools/buildbot/bin/python'} 20:07:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:07:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:07:52 INFO - Running setup.py (path:/tmp/pip-pkTe9F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:07:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:07:52 INFO - Running setup.py (path:/tmp/pip-7_jLY7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:07:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:07:52 INFO - Running setup.py (path:/tmp/pip-hKj62i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:07:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:07:52 INFO - Running setup.py (path:/tmp/pip-W1_B9E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:07:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:07:52 INFO - Running setup.py (path:/tmp/pip-HwCUKk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:07:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:07:53 INFO - Running setup.py (path:/tmp/pip-zO3myy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:07:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:07:53 INFO - Running setup.py (path:/tmp/pip-_Njx52-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:07:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:07:53 INFO - Running setup.py (path:/tmp/pip-5igDfA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:07:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:07:53 INFO - Running setup.py (path:/tmp/pip-p0zp5K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:07:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:07:53 INFO - Running setup.py (path:/tmp/pip-pgeZLs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:07:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:07:53 INFO - Running setup.py (path:/tmp/pip-l0PFKf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:07:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:07:53 INFO - Running setup.py (path:/tmp/pip-fpdtWM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:07:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:07:53 INFO - Running setup.py (path:/tmp/pip-exCogc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:07:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:07:53 INFO - Running setup.py (path:/tmp/pip-O6HsW_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:07:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:07:53 INFO - Running setup.py (path:/tmp/pip-ZptCfF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:07:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:07:53 INFO - Running setup.py (path:/tmp/pip-9kPh0P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:07:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:07:53 INFO - Running setup.py (path:/tmp/pip-z1eaqF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:07:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:07:53 INFO - Running setup.py install for manifestparser 20:07:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:07:54 INFO - Running setup.py install for mozcrash 20:07:54 INFO - Running setup.py install for mozdebug 20:07:54 INFO - Running setup.py install for mozdevice 20:07:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:07:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:07:54 INFO - Running setup.py install for mozfile 20:07:54 INFO - Running setup.py install for mozhttpd 20:07:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:07:54 INFO - Running setup.py install for mozinfo 20:07:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:07:54 INFO - Running setup.py install for mozInstall 20:07:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:07:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:07:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:07:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:07:54 INFO - Running setup.py install for mozleak 20:07:54 INFO - Running setup.py install for mozlog 20:07:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:07:54 INFO - Running setup.py install for moznetwork 20:07:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:07:55 INFO - Running setup.py install for mozprocess 20:07:55 INFO - Running setup.py install for mozprofile 20:07:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:07:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:07:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:07:55 INFO - Running setup.py install for mozrunner 20:07:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:07:55 INFO - Running setup.py install for mozscreenshot 20:07:55 INFO - Running setup.py install for moztest 20:07:55 INFO - Running setup.py install for mozversion 20:07:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:07:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:07:55 INFO - Cleaning up... 20:07:55 INFO - Return code: 0 20:07:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:07:55 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')]} 20:07:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:07:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:55 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')]} 20:07:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:07:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:55 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 0x7fa321580f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16e4480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17736f0>, '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 0x17745f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1774aa0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1467082825.818622-1721532570', '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 20:07:55 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 20:07:55 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 20:07:55 INFO - Using env: {'DISPLAY': ':0', 20:07:55 INFO - 'HOME': '/home/cltbld', 20:07:55 INFO - 'LANG': 'en_US.UTF-8', 20:07:55 INFO - 'LANGUAGE': 'en_US:en', 20:07:55 INFO - 'LOGNAME': 'cltbld', 20:07:55 INFO - 'MAIL': '/var/mail/cltbld', 20:07:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:07:55 INFO - 'MOZ_NO_REMOTE': '1', 20:07:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:07:55 INFO - 'NO_EM_RESTART': '1', 20:07:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:07:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:07:55 INFO - 'PWD': '/builds/slave/test', 20:07:55 INFO - 'SHELL': '/bin/bash', 20:07:55 INFO - 'SHLVL': '1', 20:07:55 INFO - 'TERM': 'linux', 20:07:55 INFO - 'TMOUT': '86400', 20:07:55 INFO - 'USER': 'cltbld', 20:07:55 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1467082825.818622-1721532570', 20:07:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:07:55 INFO - '_': '/tools/buildbot/bin/python'} 20:07:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:07:55 INFO - Running setup.py (path:/tmp/pip-p4Ndvd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:07:55 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)) 20:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:07:55 INFO - Running setup.py (path:/tmp/pip-o7NWsi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:07:56 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)) 20:07:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:07:56 INFO - Running setup.py (path:/tmp/pip-r2xe06-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:07:56 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)) 20:07:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:07:56 INFO - Running setup.py (path:/tmp/pip-KMrret-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:07:56 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)) 20:07:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:07:56 INFO - Running setup.py (path:/tmp/pip-YXOeig-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:07:56 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)) 20:07:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:07:56 INFO - Running setup.py (path:/tmp/pip-gmrD5b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:07:56 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)) 20:07:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:07:56 INFO - Running setup.py (path:/tmp/pip-UWodAN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:07:56 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)) 20:07:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:07:56 INFO - Running setup.py (path:/tmp/pip-Q7QmCc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:07:56 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)) 20:07:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:07:56 INFO - Running setup.py (path:/tmp/pip-yDYqwh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:07:56 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)) 20:07:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:07:56 INFO - Running setup.py (path:/tmp/pip-jyqf7u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:07:56 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)) 20:07:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:07:56 INFO - Running setup.py (path:/tmp/pip-9Nor_A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:07:56 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)) 20:07:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:07:56 INFO - Running setup.py (path:/tmp/pip-opDJf2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:07:56 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)) 20:07:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:07:56 INFO - Running setup.py (path:/tmp/pip-9Ng91x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:07:56 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)) 20:07:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:07:56 INFO - Running setup.py (path:/tmp/pip-Nm4klq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:07:56 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)) 20:07:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:07:56 INFO - Running setup.py (path:/tmp/pip-HDcaF8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:07:56 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)) 20:07:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:07:56 INFO - Running setup.py (path:/tmp/pip-mI2B2a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:07:57 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)) 20:07:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:07:57 INFO - Running setup.py (path:/tmp/pip-7volDG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:07:57 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)) 20:07:57 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)) 20:07:57 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)) 20:07:57 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)) 20:07:57 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)) 20:07:57 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)) 20:07:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:07: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 20:07: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 20:07: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 20:07: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 20:07: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 20:07: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 20:07:59 INFO - Downloading blessings-1.6.tar.gz 20:07:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:07:59 INFO - Installing collected packages: blessings 20:07:59 INFO - Running setup.py install for blessings 20:07:59 INFO - Successfully installed blessings 20:07:59 INFO - Cleaning up... 20:07:59 INFO - Return code: 0 20:07:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:07:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:07:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:07:59 INFO - Reading from file tmpfile_stdout 20:07:59 INFO - Current package versions: 20:07:59 INFO - argparse == 1.2.1 20:07:59 INFO - blessings == 1.6 20:07:59 INFO - blobuploader == 1.2.4 20:07:59 INFO - docopt == 0.6.1 20:07:59 INFO - functools32 == 3.2.3-2 20:07:59 INFO - jsonschema == 2.5.1 20:07:59 INFO - manifestparser == 1.1 20:07:59 INFO - mozInstall == 1.12 20:07:59 INFO - mozcrash == 0.17 20:07:59 INFO - mozdebug == 0.1 20:07:59 INFO - mozdevice == 0.48 20:07:59 INFO - mozfile == 1.2 20:07:59 INFO - mozhttpd == 0.7 20:07:59 INFO - mozinfo == 0.9 20:07:59 INFO - mozleak == 0.1 20:07:59 INFO - mozlog == 3.2 20:07:59 INFO - moznetwork == 0.27 20:07:59 INFO - mozprocess == 0.22 20:07:59 INFO - mozprofile == 0.28 20:07:59 INFO - mozrunner == 6.11 20:07:59 INFO - mozscreenshot == 0.1 20:07:59 INFO - mozsystemmonitor == 0.3 20:07:59 INFO - moztest == 0.7 20:07:59 INFO - mozversion == 1.4 20:07:59 INFO - psutil == 3.1.1 20:07:59 INFO - requests == 1.2.3 20:07:59 INFO - wsgiref == 0.1.2 20:07:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:07:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:07:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:07:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:07:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:07:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:59 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 0x7fa321580f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16e4480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17736f0>, '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 0x17745f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1774aa0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1467082825.818622-1721532570', '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 20:07:59 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 20:07:59 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 20:07:59 INFO - Using env: {'DISPLAY': ':0', 20:07:59 INFO - 'HOME': '/home/cltbld', 20:07:59 INFO - 'LANG': 'en_US.UTF-8', 20:07:59 INFO - 'LANGUAGE': 'en_US:en', 20:07:59 INFO - 'LOGNAME': 'cltbld', 20:07:59 INFO - 'MAIL': '/var/mail/cltbld', 20:07:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:07:59 INFO - 'MOZ_NO_REMOTE': '1', 20:07:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:07:59 INFO - 'NO_EM_RESTART': '1', 20:07:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:07:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:07:59 INFO - 'PWD': '/builds/slave/test', 20:07:59 INFO - 'SHELL': '/bin/bash', 20:07:59 INFO - 'SHLVL': '1', 20:07:59 INFO - 'TERM': 'linux', 20:07:59 INFO - 'TMOUT': '86400', 20:07:59 INFO - 'USER': 'cltbld', 20:07:59 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1467082825.818622-1721532570', 20:07:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:07:59 INFO - '_': '/tools/buildbot/bin/python'} 20:07:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:07:59 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)) 20:07:59 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)) 20:07:59 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)) 20:07:59 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)) 20:07:59 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)) 20:07:59 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)) 20:07:59 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)) 20:07:59 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)) 20:07:59 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)) 20:07:59 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)) 20:07:59 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)) 20:07:59 INFO - Cleaning up... 20:07:59 INFO - Return code: 0 20:07:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:07:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:07:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:07:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:07:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:07:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:59 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 0x7fa321580f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16e4480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17736f0>, '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 0x17745f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1774aa0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1467082825.818622-1721532570', '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 20:07:59 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 20:07:59 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 20:07:59 INFO - Using env: {'DISPLAY': ':0', 20:07:59 INFO - 'HOME': '/home/cltbld', 20:07:59 INFO - 'LANG': 'en_US.UTF-8', 20:07:59 INFO - 'LANGUAGE': 'en_US:en', 20:07:59 INFO - 'LOGNAME': 'cltbld', 20:07:59 INFO - 'MAIL': '/var/mail/cltbld', 20:07:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:07:59 INFO - 'MOZ_NO_REMOTE': '1', 20:07:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:07:59 INFO - 'NO_EM_RESTART': '1', 20:07:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:07:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:07:59 INFO - 'PWD': '/builds/slave/test', 20:07:59 INFO - 'SHELL': '/bin/bash', 20:07:59 INFO - 'SHLVL': '1', 20:07:59 INFO - 'TERM': 'linux', 20:07:59 INFO - 'TMOUT': '86400', 20:07:59 INFO - 'USER': 'cltbld', 20:07:59 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1467082825.818622-1721532570', 20:07:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:07:59 INFO - '_': '/tools/buildbot/bin/python'} 20:07:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:07:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:07:59 INFO - Cleaning up... 20:07:59 INFO - Return code: 0 20:07:59 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 20:07:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:07:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:07:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:07:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:07:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:59 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 0x7fa321580f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16e4480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17736f0>, '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 0x17745f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1774aa0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1467082825.818622-1721532570', '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 20:07:59 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 20:07:59 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 20:07:59 INFO - Using env: {'DISPLAY': ':0', 20:07:59 INFO - 'HOME': '/home/cltbld', 20:07:59 INFO - 'LANG': 'en_US.UTF-8', 20:07:59 INFO - 'LANGUAGE': 'en_US:en', 20:07:59 INFO - 'LOGNAME': 'cltbld', 20:07:59 INFO - 'MAIL': '/var/mail/cltbld', 20:07:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:07:59 INFO - 'MOZ_NO_REMOTE': '1', 20:07:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:07:59 INFO - 'NO_EM_RESTART': '1', 20:07:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:07:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:07:59 INFO - 'PWD': '/builds/slave/test', 20:07:59 INFO - 'SHELL': '/bin/bash', 20:07:59 INFO - 'SHLVL': '1', 20:07:59 INFO - 'TERM': 'linux', 20:07:59 INFO - 'TMOUT': '86400', 20:07:59 INFO - 'USER': 'cltbld', 20:07:59 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1467082825.818622-1721532570', 20:07:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:07:59 INFO - '_': '/tools/buildbot/bin/python'} 20:08:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:08:00 INFO - Downloading/unpacking flake8 20:08: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 20:08: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 20:08: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 20:08: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 20:08: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 20:08: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 20:08:02 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 20:08:02 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 20:08: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 20:08: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 20:08: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 20:08: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 20:08: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 20:08: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 20:08:02 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 20:08:02 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 20:08: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 20:08: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 20:08: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 20:08: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 20:08: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 20:08: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 20:08:02 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 20:08: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 20:08: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 20:08: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 20:08: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 20:08: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 20:08: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 20:08:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 20:08:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:08:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:08:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:08:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:08:02 INFO - no previously-included directories found matching 'docs/_build' 20:08:02 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 20:08:03 INFO - Running setup.py install for pep8 20:08:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:08:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:08:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:08:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:08:03 INFO - no previously-included directories found matching 'docs/_build' 20:08:03 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 20:08:03 INFO - Successfully installed flake8 mccabe pyflakes pep8 20:08:03 INFO - Cleaning up... 20:08:03 INFO - Return code: 0 20:08:03 INFO - Running post-action listener: _resource_record_post_action 20:08:03 INFO - Running post-action listener: _start_resource_monitoring 20:08:03 INFO - Starting resource monitoring. 20:08:03 INFO - ##### 20:08:03 INFO - ##### Finished create-virtualenv step (success) 20:08:03 INFO - ##### 20:08:03 INFO - ##### 20:08:03 INFO - ##### Running install step. 20:08:03 INFO - ##### 20:08:03 INFO - Running pre-action listener: _resource_record_pre_action 20:08:03 INFO - Running main action method: install 20:08:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:08:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:08:03 INFO - Reading from file tmpfile_stdout 20:08:03 INFO - Detecting whether we're running mozinstall >=1.0... 20:08:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:08:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:08:03 INFO - Reading from file tmpfile_stdout 20:08:03 INFO - Output received: 20:08:03 INFO - Usage: mozinstall [options] installer 20:08:03 INFO - Options: 20:08:03 INFO - -h, --help show this help message and exit 20:08:03 INFO - -d DEST, --destination=DEST 20:08:03 INFO - Directory to install application into. [default: 20:08:03 INFO - "/builds/slave/test"] 20:08:03 INFO - --app=APP Application being installed. [default: firefox] 20:08:03 INFO - mkdir: /builds/slave/test/build/application 20:08:03 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'] 20:08:03 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 20:08:20 INFO - Reading from file tmpfile_stdout 20:08:20 INFO - Output received: 20:08:20 INFO - /builds/slave/test/build/application/firefox/firefox 20:08:20 INFO - Running post-action listener: _resource_record_post_action 20:08:20 INFO - ##### 20:08:20 INFO - ##### Finished install step (success) 20:08:20 INFO - ##### 20:08:20 INFO - ##### 20:08:20 INFO - ##### Running run-tests step. 20:08:20 INFO - ##### 20:08:20 INFO - Running pre-action listener: _resource_record_pre_action 20:08:20 INFO - Running main action method: run_tests 20:08:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:08:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:08:20 INFO - Python 2.7.3 20:08:20 INFO - Return code: 0 20:08:20 INFO - grabbing minidump binary from tooltool 20:08:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:08:20 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 0x17736f0>, '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 0x17745f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1774aa0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:08:20 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 20:08:20 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 20:08:20 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 20:08:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:08:20 INFO - Return code: 0 20:08:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:08:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:08:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:08:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:08:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:08:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 20:08:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 20:08:21 INFO - Return code: 0 20:08:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GSJnKxL4S6e7jEHf_EBX3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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 20:08:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GSJnKxL4S6e7jEHf_EBX3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-013 --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 20:08:21 INFO - Using env: {'DISPLAY': ':0', 20:08:21 INFO - 'HOME': '/home/cltbld', 20:08:21 INFO - 'LANG': 'en_US.UTF-8', 20:08:21 INFO - 'LANGUAGE': 'en_US:en', 20:08:21 INFO - 'LOGNAME': 'cltbld', 20:08:21 INFO - 'MAIL': '/var/mail/cltbld', 20:08:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:08:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:08:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:08:21 INFO - 'MOZ_NO_REMOTE': '1', 20:08:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:08:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:08:21 INFO - 'NO_EM_RESTART': '1', 20:08:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:08:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:08:21 INFO - 'PWD': '/builds/slave/test', 20:08:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:08:21 INFO - 'SHELL': '/bin/bash', 20:08:21 INFO - 'SHLVL': '1', 20:08:21 INFO - 'TERM': 'linux', 20:08:21 INFO - 'TMOUT': '86400', 20:08:21 INFO - 'USER': 'cltbld', 20:08:21 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1467082825.818622-1721532570', 20:08:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:08:21 INFO - '_': '/tools/buildbot/bin/python'} 20:08:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GSJnKxL4S6e7jEHf_EBX3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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 20:08:21 INFO - mozversion application_buildid: 20160627173005 20:08:21 INFO - mozversion application_changeset: 6e61bbb4c032837e3874f9f6bbe60381b7e6ce34 20:08:21 INFO - mozversion application_display_name: Nightly 20:08:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:08:21 INFO - mozversion application_name: Firefox 20:08:21 INFO - mozversion application_remotingname: firefox 20:08:21 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 20:08:21 INFO - mozversion application_vendor: Mozilla 20:08:21 INFO - mozversion application_version: 50.0a1 20:08:21 INFO - mozversion platform_buildid: 20160627173005 20:08:21 INFO - mozversion platform_changeset: 6e61bbb4c032837e3874f9f6bbe60381b7e6ce34 20:08:21 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 20:08:21 INFO - mozversion platform_version: 50.0a1 20:08:21 INFO - using testdate: 1467083301 20:08:21 INFO - actual date: 1467083301 20:08:21 INFO - starting webserver on 'localhost:36402' 20:08:21 INFO - SUITE-START | Running 2 tests 20:08:21 INFO - TEST-START | dromaeo_css 20:08:21 INFO - operating with platform_type : linux_ 20:08:21 INFO - Initialising browser for dromaeo_css test... 20:08:21 INFO - TEST-INFO | started process 30524 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp92LimG/profile http://localhost:36402/getInfo.html) 20:08:26 INFO - PROCESS | 30524 | __metrics Screen width/height:1600/1200 20:08:26 INFO - PROCESS | 30524 | colorDepth:24 20:08:26 INFO - PROCESS | 30524 | Browser inner width/height: 1024/697 20:08:26 INFO - PROCESS | 30524 | __metrics 20:08:27 INFO - PROCESS | 30524 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:08:27 INFO - TEST-INFO | 30524: exit 0 20:08:27 INFO - Browser initialized. 20:08:27 INFO - Running cycle 1/1 for dromaeo_css test... 20:08:27 INFO - TEST-INFO | started process 30604 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp92LimG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:08:39 INFO - PROCESS | 30604 | RSS: Main: 174301184 20:08:39 INFO - PROCESS | 30604 | 20:09:30 INFO - PROCESS | 30604 | 1467083370604 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] 20:11:39 INFO - PROCESS | 30604 | Cycle 1(1): loaded http://localhost:36402/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36402/tests/dromaeo/cssquery-ext.html) 20:11:40 INFO - PROCESS | 30604 | RSS: Main: 278409216 20:11:40 INFO - PROCESS | 30604 | 20:14:42 INFO - PROCESS | 30604 | Cycle 1(1): loaded http://localhost:36402/tests/dromaeo/cssquery-ext.html (next: http://localhost:36402/tests/dromaeo/cssquery-jquery.html) 20:14:43 INFO - PROCESS | 30604 | RSS: Main: 254857216 20:14:43 INFO - PROCESS | 30604 | 20:17:45 INFO - PROCESS | 30604 | Cycle 1(1): loaded http://localhost:36402/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36402/tests/dromaeo/cssquery-mootools.html) 20:17:46 INFO - PROCESS | 30604 | RSS: Main: 260620288 20:17:46 INFO - PROCESS | 30604 | 20:20:48 INFO - PROCESS | 30604 | Cycle 1(1): loaded http://localhost:36402/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36402/tests/dromaeo/cssquery-prototype.html) 20:20:48 INFO - PROCESS | 30604 | RSS: Main: 260911104 20:20:48 INFO - PROCESS | 30604 | 20:23:51 INFO - PROCESS | 30604 | Cycle 1(1): loaded http://localhost:36402/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36402/tests/dromaeo/cssquery-yui.html) 20:23:51 INFO - PROCESS | 30604 | RSS: Main: 228806656 20:23:51 INFO - PROCESS | 30604 | 20:26:54 INFO - PROCESS | 30604 | Cycle 1(1): loaded http://localhost:36402/tests/dromaeo/cssquery-yui.html (next: http://localhost:36402/tests/dromaeo/cssquery-dojo.html) 20:26:54 INFO - PROCESS | 30604 | RSS: Main: 301256704 20:26:54 INFO - PROCESS | 30604 | 20:26:54 INFO - PROCESS | 30604 | __start_tp_report 20:26:54 INFO - PROCESS | 30604 | _x_x_mozilla_page_load 20:26:54 INFO - PROCESS | 30604 | _x_x_mozilla_page_load_details 20:26:54 INFO - PROCESS | 30604 | |i|pagename|runs| 20:26:54 INFO - PROCESS | 30604 | |0;dojo.html;3112.564241006259;3130.9060728178147;3140.952885706714;3148.874045038199;3187.697168768966;5269.683818970864;5336.066188417031;5353.544948679367;5433.402325744165;5493.835184944448;5446.700431476277;5459.481349271823;5464.972675136629;5493.066178749612;5524.640898341605;4865.61075113991;4960.305557221992;5001.599872010231;5012.147934851066;5170.121079416508;5061.038402703493;5066.569341605968;5085.720285384303;5129.0767661820855;5133.435322114583;4843.58829499493;4913.14020046494;4920.778564964585;4928.901421971576;4985.426675932242;4912.901741965176;4938.38270216223;4996.375453068366;5008.474110218447;5050.318207042039;4844.176489996709;4958.355413796219;4989.850304490871;4991.07665081961;5036.949630503685;5336.599755018389;5393.19102134679;5431.53831924283;5433.972830135864;5486.862828429281;5823.592348535604;5888.234529511179;5907.232059832194;5923.940760592382;5931.228940237785;5666.490015898589;5794.101914203263;5909.349971503131;5910.852228694317;5911.9113213301835;5451.127819548853;5536.280283563151;5540.7783688652;5544.833654990357;5546.750396232179;6002.54980876436;6031.4270144336215;6032.728527216286;6033.698315084228;6034.426729460782;5604.607677462538;5646.3224413069875;5655.0386434306265;5775.104858746901;5797.246357973437;5823.82528524145;5826.388229235954;5861.062230043172;5885.264341957255;5888.5289176865745;5772.624779389326;5806.44838740319;5811.680357580289;5820.796272130455;5831.446012628793;5596.244506991586;5771.624844385102;5792.9420705793245;5799.942000580025;5823.475887170091;4441.933370999438;4442.711223770445;4442.800073996678;4459.509453960061;4497.887552811206;3961.920761584752;3979.5622481527007;3986.80065996699;4003.3994900764537;4018.3168861293652;5345.812896548602;5385.165299378603;5448.564114870801;5449.863753406196;5510.752016159283;5860.443257890493;5869.7945571904775;5870.44230798082;5872.236609240771;5878.030125029408;5390.272313237741;5517.503424691797;5523.889522209533;5527.751251193706;5527.917081243784;4980.77586508608;5028.120078986163;5032.547070763649;5053.418856831438;5057.342545469065;6078.483328917003;6081.787137450168;6091.939080609137;6092.603980741238;6097.908531371944;5600.579956503197;5752.827415177551;5803.912941305968;5818.6217895836635;5819.709014549171;6078.787242446493;6131.9272270139245;6142.7136481981925;6145.324014358328;6145.661988590492;5747.913781293368;5757.8560535986935;5793.102069179284;5793.188953546422;5804.82585522435;5710.5146062585145;5785.363610002981;5803.970980145073;5907.438793314628;5920.141579471038;5712.314522257356;5712.6286791358425;5714.742836572281;5717.5425965921795;5748.9425105748405;5635.8591035224445;5680.857978550569;5741.770329186786;5746.454086861741;5760.251167348386;5484.177373394023;5564.304461942257;5626.971865140812;5629.240052592848;5647.971760141173;5792.102224155263;5845.3570107289015;5847.970760146172;5849.853753656193;5860.677662728421;5634.774609015593;5675.716214189191;5677.063284558001;5685.829425117253;5691.77232910679 20:26:54 INFO - PROCESS | 30604 | |1;ext.html;577.8497590626439;622.1600838867528;625.037442338798;628.3496581038626;643.8165122939963;30811.537826932614;31446.68553314469;33793.493097603554;33932.83033584829;33963.490547641806;43947;44813.55186448143;44996;48191.27713084307;48532.51467485324;8775.07861674523;8906.153915378029;8910.465372077664;8911.420757650732;8919.063498332678;8644.265237454823;8761.605727742266;8771.95614021929;8772.824543509127;8777.824443511126;8798.6920457784;8820.691275805348;8825.867611985825;8828.779280517974;8832.249258813008;8721.95639021804;8739.563021848946;8768.605412756377;8775.078616745213;8776.780580485474;8817.118288171196;8905.154010369004;8916.331275154325;8924.598393072327;8925.419847709878;42718;43030.56969430297;43091.7845410771;43138.78430607858;43161.78419107884;3410.369081719865;3590.407582748843;4215.114825886537;4309.375140604626;4416.470023597189;34703.479447808306;35357;35383.115422114395;35417.34860883792;35776.82111589451;4396.164728701537;4494;4513.232750432434;4524.140413321458;4545.749983750892;372905;376551;376917.1154144239;377063;377613;61606;61727.69136154291;61990.38009619936;62025.689871550356;62163.689181554706;35543.46684799678;36401.45397819035;36422.635773642454;37626.43560346597;37698.246035079144;16397.67204655924;16524.6695066098;16578.419755308507;16590.585235369213;16651.750223746654;12402.317872517098;12525.749485010248;12548.24710517372;12549.309787961567;12552.246865188117;19469.415917522496;19724.802751972296;19828.70256946118;19929.800701993085;20002.799972000095;6990.876905638191;7205.207427183006;7316.158641756266;7452.590107544137;7477.840290199745;965.584798536636;975.6390135649713;1007.5919252702668;1032.912202462799;1115.4718036290335;32004.679953200637;32116.19709507281;32290.83854580759;32359.352812944082;32594.511082333785;1090.0625462102585;1128.6275529075385;1142.6343570057502;1144.0961640304233;1146.157574182975;16550.42073527421;16722.83277167213;17047.31810727582;17099.23053462597;17181.65636687284;571649;572930;573839;577750;578975;60048.39951600428;60671.696641517396;60708.392916071156;60729.69635151796;60775.392246077856;1268.3848333558217;1355.6746380868717;1366.357811828439;1371.095077249011;1386.4869998100567;31625.5256171153;33247;33271.50092748562;33315.66684333223;33459.66540334566;51194.74402627963;51273.487265126874;51861.740691296305;51950.480495196076;51994.48005519896;431343;435701;435832;435954;436360;25627.231183064538;27399.86300068487;28364;28585;28662.856685716437;49140.26289605587;49274.50725492699;49282.50717492779;49556.50443495663;50168.498315017845;41014.1797164061;41713;41898.79050604728;42242.57757422509;42525;40509.1898162041;40947.7952610235;41106;41372.172556548096;41777.79111104425;39235.2152956945;39365;39443.80278098706;40257.19485610213;40303;35269.47095793514;36635.81682091572;36880.26239475249;37216.813915930245;37234.6276537242;27733.44533109367;27945.441091177658;28108.43783124367;28110;28119.437611247253 20:26:54 INFO - PROCESS | 30604 | |2;jquery.html;373.5722597625719;387.27386150966936;387.4865802811276;390.86515152272466;410.1468944595242;17793;19265.422037338867;19855.40433786987;20217.39347819564;20313;18554.90722546389;19216.42350729477;19501.21995120197;19727.605447891034;19736;5351.759170837302;5609.719514024293;5733.942660573403;5817.1565123057135;5883.47048765611;5713.400092990239;5733.512651424634;5741.110127930177;5760.913586296209;5764.135379693059;5364.6781193128345;5494.203340515623;5501.587380946445;5727;5730.713464326788;5540.279763630722;5547.389787123413;5551.2228288039705;5555.916661250085;5585.218069470277;5059.291699162083;5390.299261096072;5390.434004429557;5394.05604019299;5395.676259424447;12463.376831158406;12502.874971250261;12546.933510651514;13007;14250.144991300554;2176.7170267865235;2284.6116160252795;2312.144506532577;2336.030547322859;2401.399650087478;10080.89919100807;10159.59361625534;10568.577256909715;12984.545540906023;14118.647033824134;1942.2425254150892;1952.9316473923345;1980.0990549300034;2114.358525125433;2153.7846215378495;72747;77529.61235193844;80067;80499.19500804976;88451.7659226403;10495.527701253463;10711.517981690842;11040.447977601088;11147.79278290867;11368.54525818958;15347.539573812803;15388.615284617974;15426.305816238297;15440.536783896501;15469.458568950033;7828.138904720477;8032.558209298428;8066.677332906618;8127.837443251102;8147.551884646283;7591.4685971981435;7630.931669566266;7652.273034061755;7761.301482866456;7827.569483678339;4744.810207591727;4798.304245884327;4811.27830825379;4844.539768721966;4906.852794416173;1984.811442912921;1988.9701654475195;1989.6717041688248;1996.5807180492259;2051.558914833318;926.4904302633524;944.6412447037501;978.6134476881592;982.8083523712808;1017.765913839821;18561.81438185601;19185.52036199106;19328.226870925006;19596.70604940927;19962.30131945375;983.5672304186278;994.9801003979879;1005.2109094361037;1013.6350913671073;1046.2989796836139;10273.434961077062;10698.893011069946;10786.56853725858;10947.726306842393;10957.342559446459;468264;479970;484278;489652;490660;89190.55404722935;89403;89619.55190224007;90317;90432.5478372604;993.9453330066771;1001.4892404873567;1010.4947526236881;1016.9389836609827;1023.048564834696;16647.50057498277;16923.492295231164;17163.141842908055;17278.740818887476;17539.123043847503;39598.2080358397;41134;41592.584074160084;41934.790326048176;42107;55002.44997549973;55918;56911.430885690614;57560.71219643875;58121.70939145277;8396.286315663237;8408.579571021302;8656.091110433314;8658.610362533575;8707.346948978979;10325.586976520855;12832;12853.35733213317;12902.548410805577;13143.60569182926;10262.794744104927;10407.791844163226;11376.829347559627;11570.305781653127;11733.296002239551;11038.779224415628;11299.322040677585;11573.13201509907;11692.181547291948;11793.233439826385;11701.824472632747;11942.34317112567;12006.159568830099;12113.939430302793;12378.75242495163;8417.663293468193;8510;8627.784305392164;8670.393072484865;8771.079036701054;10583.841242381217;11664.6500604982;11703.531858725555;11752.58865939688;11828.17202795796 20:26:54 INFO - PROCESS | 30604 | |3;mootools.html;1292.147182859313;1436.4613270023742;1466.4207637982997;1576;1740.1734176266268;7926.207379262078;8367.2469477747;8367.330613550908;8577.14228577142;8605.91394086059;8375.41372103953;8557.957210213941;8563.743087707364;8568.057513673506;8568.614412351444;1888.1031510032763;2198.1097655449566;2250.0999600159903;2274.1471948019494;2280.9657855132186;2269.614165591845;2272.3183045086407;2273.170292843117;2286.702728645282;2289.3933107726466;2262.73978492473;2280.0309868305903;2282.1441959265276;2282.4065742906882;2285.382946604416;1864.580469394389;2151.214806595597;2208.6797414374905;2211.9557608847895;2215.966760498594;2219.1899956515917;2224.688543603897;2241.3724157236;2241.529278851443;2244.2818298144603;8205.71280005203;8316;8324.084350721416;8325.542095184823;8325.875111873265;4960.702357858504;5024.19612861944;5086.389633243997;5091.592672586185;5093.770780314895;3077.5229839374933;3164.936701265985;3172.587563616715;3234.417804795136;3246.853891574885;1008.4856723071213;1019.6737044145876;1023.8259495885643;1042.6298663974333;1045.372776334201;11339.319640821495;11381.715457113556;11419.200655954086;11423.485943132579;11429.942850285779;4383.364412160219;4389.978050109729;4482.439695038121;4487.663425243055;4552.613027892667;9796.706098817047;9813.362131461432;9815.116639502336;9831.557579908922;9834.360766550151;5077.669951453144;5107.336046313955;5109.770060347293;5112.284280200774;5112.795488180431;3972.423998520256;4464.084862603158;4606.792694328697;4620.521433141363;4693.366395536559;3821.7324787264624;3824.0822202671716;3900.0444891001885;3932.46911666927;3972.106276087915;1219.3171823778712;1225.9632211033684;1232.3653318540958;1253.3419954523947;1263.633546271571;918.9172974432333;932.7947851472801;936.1761649748178;940.1585580905188;969.6266937229218;5614.63504872182;5849.415058494116;5863.384344643836;5951.791687290924;6091.878162436815;425.9637930775919;426.89754458929633;427.85666801621807;434.88040788782706;442.95127535971017;4007.719459637856;4033.213523362916;4070.7964601769795;4074.409210664437;4130.56629053945;9751.951240243896;10136.645217417356;10181.490925453698;10409.219308551888;10474.842877356845;10276.948615256875;10326.690199294033;10334.431606261727;10342.534585943651;10352.171826253882;7702.191269916578;7832.020997375442;7863.252990965849;7881.448298619156;7884.921150788418;5754.798582049608;6019;6045.546584006129;6066.666333351708;6087.239095113111;9522.761930951781;9786.75533111678;9799.85300220483;9802.313838031554;9804.65683701067;9665.468399238109;9899.20806335477;9973.45146016947;10016.39901605906;10082.949585252027;6819.727210911707;7009.754658586925;7239.710411583477;7338.339549440576;7399.704011839682;8106.310963567927;8321.54231517248;8373.790655233668;8384.66461341564;8395.24442800151;7258.3104605062435;7424.406047516294;7455.478116532007;7542.924570754441;7601.619919004138;7195.100612423447;7347.8530429392185;7465.104187497535;7465.29079737424;7651.961740191486;6948.965255173692;7009.369156775914;7051.400630946427;7067.434605231672;7074.045003924404;4918.6556941015215;5013.398392192814;5019.472955339636;5045.974770126126;5050.77271522775;5025.874353141201;5098.898022039612;5130.256112863689;5144.614153938394;5211.739413029409 20:26:54 INFO - PROCESS | 30604 | |4;prototype.html;289.47171412172776;304.1741671362251;307.403636944328;325.76056598400174;328.6664036003457;5188.740562971855;5218.504242097004;5365.5975801814875;5388.784448622056;5434.483724046219;5290.365156181264;5307.336582927134;5318.494742999418;5318.867028324294;5377.381601115872;4190.853320133796;4203.7687927164;4208.726432781859;4218.072024154696;4223.239816832969;3960.2079584083153;3997.700747257153;4200.894977625553;4227.87316380509;4230;4139.751614903115;4173.476681011424;4192.37114432836;4199.601037901394;4210.873673789792;4140.792960351985;4156.729812562174;4162.833486660515;4165.146145040259;4176.222811830129;3451.8964431067106;3715.2198038411966;3717.200801827593;3730.3098926698376;3743.7192210584044;5053.797848086072;5130.97380523893;5189.546926860485;5193.169092945111;5241;4662.72023678577;4672.332219207906;4715.41057367829;4739.241721324606;4739.431268247798;5366.570674346043;5483.369412517572;5488.341399032101;5491.450854914477;5549.861253468655;4010.47863777707;4015.6185162409815;4018.2566225248424;4038.454808600831;4041.2523683118716;5739.598228124033;5761.798337058183;5779.971100144515;5781.19063331134;5795.478406943395;3935.2916475034767;4095.5494895561465;4106.342985122366;4116.629503344713;4122.237386083524;4079.714419990572;4110.136871257009;4125.814338354781;4132.318167502329;4144.48193975753;4690.906181876411;4699.694519856198;4715.552022557851;4715.783581716588;4739.478657347689;5552.222688823568;5554.222408862763;5583.944160558423;5590.580706446952;5606.187102870061;1379.9724005519834;1430.3277459593974;1431.914085154894;1432.4628264400849;1433.8781203597812;897.2911399994063;903.3089686389917;923.7644400677784;930.9208717258973;931.3793998442661;4719.5044520325555;4780;4792.664513484023;4807.4471435784635;4828.382491865194;5065.645404821627;5066.706640683585;5087.608823852857;5092.490750924878;5092.490750924878;4817.686850354716;4823.445303790038;4848.5636292733825;4863.756812159378;5092.974535127375;3037.5139977603476;3047.1163362625034;3051.855554167187;3061.9846900765356;3073.3545955349628;5988.760449582055;6014.669193194329;6035.78874739382;6071.2714474263375;6075.544334174866;5625.71871406428;5879.85427796127;5912.438318359749;5913.1912341638235;5938.8812223755285;5880.470757631833;5904.822855314347;5964.552658550626;5973.940260597426;5979.461848433575;5540.252065971043;5727.539477433228;5728.513076388554;5757.65454072757;5821.359650438533;5680.971595141998;5695.914561281667;5697.632568183689;5711.143328500758;5712.914306285326;5865.296164460292;5869.882602348014;5943.7518121195035;5947.524198064058;5959.433853783884;3980.800959951933;4156.314208155621;4174.123434078756;4182.560831112689;4183.748975061506;5781.942180578309;5790;5796.565257605612;5798.246227990334;5816.505597024131;5531.280933478622;5666.405027472056;5700.175943698143;5707.771689132388;5717.514011309086;5635.380108188014;5638.88722225545;5638.915416268841;5646.096624540054;5652.604317697722;5541.584381171348;5546.417626149358;5550.861228469159;5576.386597474356;5579.609427340048;5445.53712934405;5613.522850557748;5624.3250809903075;5626.381098079126;5666.603337766317;5429.972850135724;5454.318210223722;5455.1544510600925;5463.590230732631;5469.253561310515 20:26:54 INFO - PROCESS | 30604 | |5;yui.html;738.5605564689012;758.5638258001644;777.953322800632;803.6544285957038;845.8604330285503;15283.388664453423;16507.17464126795;16514.91742541287;16598.585035374123;16626.83373166268;14536.200508972002;15476.76784848228;15503.224838758073;15538.922305388485;15566;681.1893846322885;799;803.9397045221632;812.7642983534768;816.0982114763191;810.4893916832388;812.3663542436909;813.2964985287742;813.7355359508153;813.7640084375524;865.5282870835379;869.8999615044256;870.1298701298701;870.1298701298701;870.29071306885;720.1933834105809;827.7971896885272;837.924586787186;844.1305455380967;851.7402192331336;619.8822223777468;621.7699451203039;621.9036049412348;621.9191505104353;621.9906701399483;14758.409663613442;15212.087274763438;15231.162286074261;15300.158491283086;15362.078275303518;14482.42070317186;14602.70794584113;14716.70566588673;14746.705065898623;14859;12380.504779808796;12486.875131248753;12714.427850746739;12777.29724865132;12794.868464436;4471.53048929861;4473.373727678128;4480.708753931017;4524.072565124142;4589.908201835978;74492;76868;77436.22563774404;77886.83169752458;78207.6089619554;11246;11721.941390293165;11760.470778814974;11790.938815506646;11838;19925.701114483294;20050;20165.193392264144;20209.6968545469;20949.266775662778;8133.227343402367;8169.428140030141;8211.71259005932;8252.422330436812;8261.669533218725;4715.269133284346;4778.952210477851;4792.2332426811545;4881;4925.088858561177;3344.966550334514;3434.5019972103905;3442.7590068695454;3443.2424866529323;3444.6727560881677;515.3300709078184;564.0861803877744;582.7645391769476;584.2579923497135;587.4301927130676;621.2948303675361;703.1772825793834;718.267367285366;732.2018999290799;737.3290305821677;10426.739331516772;10445.68662940113;10499.317544359592;10526.421046842344;10759.731006724738;753.9434542409341;768.3939873417744;775.5889378629336;776.9805754856174;789.4394979564458;5162.008729282878;5175.560077393388;5214.921776173361;5216.60875434344;5260.658057226268;126719;126965;128199;128208;130496;66982.33017669858;109526;109761;111551;112247.4387628073;59217.70391148017;59422.40577594169;77158.6142069286;99346;100832.49583752034;9920.873721222748;10058.547365368722;10065;10075.445850478294;10156.796864062826;56864.43135568757;56972;57436.564085898186;58143.4185658138;59074.113888292566;49815.50184498254;66802;67040.3295967034;67769.66115169393;72009.63995179991;13832.930835345758;13874.861251387762;13896.444142234197;14124.78812817829;14143.434262629791;15483.84516154869;15877;15952.92023539875;15961.20193990319;16601.41895033668;14527.491537796126;14855.331510081856;15134.621634459227;15425.151616661191;15911.443099491462;14067.859321407064;14248;15289.464868729541;15895.046297222203;15904.920475397548;14035.298235088409;14256.501022464165;14266.714665706835;14297.285135742963;14958.551243462714;12003.698982779806;12105.455254513392;12277.28478729657;12505.812412813633;12890.806637900627;10952.507137178687;11832.112591555495;12054.73425290367;12344.567940122412;12414.689632759253 20:26:54 INFO - PROCESS | 30604 | __end_tp_report 20:26:54 INFO - PROCESS | 30604 | __start_cc_report 20:26:54 INFO - PROCESS | 30604 | _x_x_mozilla_cycle_collect,921 20:26:54 INFO - PROCESS | 30604 | __end_cc_report 20:26:54 INFO - PROCESS | 30604 | __startTimestamp1467084414860__endTimestamp 20:26:54 INFO - PROCESS | 30604 | 20:26:54 INFO - PROCESS | 30604 | ------- Summary: start ------- 20:26:54 INFO - PROCESS | 30604 | Number of tests: 6 20:26:54 INFO - PROCESS | 30604 | 20:26:54 INFO - PROCESS | 30604 | [#0] dojo.html Cycles:165 Average:5429.41 Median:5634.77 stddev:620.92 (11.0%) stddev-sans-first:595.64 20:26:54 INFO - PROCESS | 30604 | Values: 3112.6 3130.9 3141.0 3148.9 3187.7 5269.7 5336.1 5353.5 5433.4 5493.8 5446.7 5459.5 5465.0 5493.1 5524.6 4865.6 4960.3 5001.6 5012.1 5170.1 5061.0 5066.6 5085.7 5129.1 5133.4 4843.6 4913.1 4920.8 4928.9 4985.4 4912.9 4938.4 4996.4 5008.5 5050.3 4844.2 4958.4 4989.9 4991.1 5036.9 5336.6 5393.2 5431.5 5434.0 5486.9 5823.6 5888.2 5907.2 5923.9 5931.2 5666.5 5794.1 5909.3 5910.9 5911.9 5451.1 5536.3 5540.8 5544.8 5546.8 6002.5 6031.4 6032.7 6033.7 6034.4 5604.6 5646.3 5655.0 5775.1 5797.2 5823.8 5826.4 5861.1 5885.3 5888.5 5772.6 5806.4 5811.7 5820.8 5831.4 5596.2 5771.6 5792.9 5799.9 5823.5 4441.9 4442.7 4442.8 4459.5 4497.9 3961.9 3979.6 3986.8 4003.4 4018.3 5345.8 5385.2 5448.6 5449.9 5510.8 5860.4 5869.8 5870.4 5872.2 5878.0 5390.3 5517.5 5523.9 5527.8 5527.9 4980.8 5028.1 5032.5 5053.4 5057.3 6078.5 6081.8 6091.9 6092.6 6097.9 5600.6 5752.8 5803.9 5818.6 5819.7 6078.8 6131.9 6142.7 6145.3 6145.7 5747.9 5757.9 5793.1 5793.2 5804.8 5710.5 5785.4 5804.0 5907.4 5920.1 5712.3 5712.6 5714.7 5717.5 5748.9 5635.9 5680.9 5741.8 5746.5 5760.3 5484.2 5564.3 5627.0 5629.2 5648.0 5792.1 5845.4 5848.0 5849.9 5860.7 5634.8 5675.7 5677.1 5685.8 5691.8 20:26:54 INFO - PROCESS | 30604 | 20:26:54 INFO - PROCESS | 30604 | [#1] ext.html Cycles:180 Average:61500.95 Median:41745.40 stddev:124758.86 (298.9%) stddev-sans-first:125024.98 20:26:54 INFO - PROCESS | 30604 | Values: 577.8 622.2 625.0 628.3 643.8 30811.5 31446.7 33793.5 33932.8 33963.5 43947.0 44813.6 44996.0 48191.3 48532.5 8775.1 8906.2 8910.5 8911.4 8919.1 8644.3 8761.6 8772.0 8772.8 8777.8 8798.7 8820.7 8825.9 8828.8 8832.2 8722.0 8739.6 8768.6 8775.1 8776.8 8817.1 8905.2 8916.3 8924.6 8925.4 42718.0 43030.6 43091.8 43138.8 43161.8 3410.4 3590.4 4215.1 4309.4 4416.5 34703.5 35357.0 35383.1 35417.3 35776.8 4396.2 4494.0 4513.2 4524.1 4545.7 372905.0 376551.0 376917.1 377063.0 377613.0 61606.0 61727.7 61990.4 62025.7 62163.7 35543.5 36401.5 36422.6 37626.4 37698.2 16397.7 16524.7 16578.4 16590.6 16651.8 12402.3 12525.7 12548.2 12549.3 12552.2 19469.4 19724.8 19828.7 19929.8 20002.8 6990.9 7205.2 7316.2 7452.6 7477.8 965.6 975.6 1007.6 1032.9 1115.5 32004.7 32116.2 32290.8 32359.4 32594.5 1090.1 1128.6 1142.6 1144.1 1146.2 16550.4 16722.8 17047.3 17099.2 17181.7 571649.0 572930.0 573839.0 577750.0 578975.0 60048.4 60671.7 60708.4 60729.7 60775.4 1268.4 1355.7 1366.4 1371.1 1386.5 31625.5 33247.0 33271.5 33315.7 33459.7 51194.7 51273.5 51861.7 51950.5 51994.5 431343.0 435701.0 435832.0 435954.0 436360.0 25627.2 27399.9 28364.0 28585.0 28662.9 49140.3 49274.5 49282.5 49556.5 50168.5 41014.2 41713.0 41898.8 42242.6 42525.0 40509.2 40947.8 41106.0 41372.2 41777.8 39235.2 39365.0 39443.8 40257.2 40303.0 35269.5 36635.8 36880.3 37216.8 37234.6 27733.4 27945.4 28108.4 28110.0 28119.4 20:26:54 INFO - PROCESS | 30604 | 20:26:54 INFO - PROCESS | 30604 | [#2] jquery.html Cycles:180 Average:28358.23 Median:2324.09 stddev:79580.75 (3424.2%) stddev-sans-first:79776.26 20:26:54 INFO - PROCESS | 30604 | Values: 373.6 387.3 387.5 390.9 410.1 17793.0 19265.4 19855.4 20217.4 20313.0 18554.9 19216.4 19501.2 19727.6 19736.0 5351.8 5609.7 5733.9 5817.2 5883.5 5713.4 5733.5 5741.1 5760.9 5764.1 5364.7 5494.2 5501.6 5727.0 5730.7 5540.3 5547.4 5551.2 5555.9 5585.2 5059.3 5390.3 5390.4 5394.1 5395.7 12463.4 12502.9 12546.9 13007.0 14250.1 2176.7 2284.6 2312.1 2336.0 2401.4 10080.9 10159.6 10568.6 12984.5 14118.6 1942.2 1952.9 1980.1 2114.4 2153.8 72747.0 77529.6 80067.0 80499.2 88451.8 10495.5 10711.5 11040.4 11147.8 11368.5 15347.5 15388.6 15426.3 15440.5 15469.5 7828.1 8032.6 8066.7 8127.8 8147.6 7591.5 7630.9 7652.3 7761.3 7827.6 4744.8 4798.3 4811.3 4844.5 4906.9 1984.8 1989.0 1989.7 1996.6 2051.6 926.5 944.6 978.6 982.8 1017.8 18561.8 19185.5 19328.2 19596.7 19962.3 983.6 995.0 1005.2 1013.6 1046.3 10273.4 10698.9 10786.6 10947.7 10957.3 468264.0 479970.0 484278.0 489652.0 490660.0 89190.6 89403.0 89619.6 90317.0 90432.5 993.9 1001.5 1010.5 1016.9 1023.0 16647.5 16923.5 17163.1 17278.7 17539.1 39598.2 41134.0 41592.6 41934.8 42107.0 55002.4 55918.0 56911.4 57560.7 58121.7 8396.3 8408.6 8656.1 8658.6 8707.3 10325.6 12832.0 12853.4 12902.5 13143.6 10262.8 10407.8 11376.8 11570.3 11733.3 11038.8 11299.3 11573.1 11692.2 11793.2 11701.8 11942.3 12006.2 12113.9 12378.8 8417.7 8510.0 8627.8 8670.4 8771.1 10583.8 11664.7 11703.5 11752.6 11828.2 20:26:54 INFO - PROCESS | 30604 | 20:26:54 INFO - PROCESS | 30604 | [#3] mootools.html Cycles:180 Average:5563.39 Median:5025.04 stddev:3151.86 (62.7%) stddev-sans-first:3144.36 20:26:54 INFO - PROCESS | 30604 | Values: 1292.1 1436.5 1466.4 1576.0 1740.2 7926.2 8367.2 8367.3 8577.1 8605.9 8375.4 8558.0 8563.7 8568.1 8568.6 1888.1 2198.1 2250.1 2274.1 2281.0 2269.6 2272.3 2273.2 2286.7 2289.4 2262.7 2280.0 2282.1 2282.4 2285.4 1864.6 2151.2 2208.7 2212.0 2216.0 2219.2 2224.7 2241.4 2241.5 2244.3 8205.7 8316.0 8324.1 8325.5 8325.9 4960.7 5024.2 5086.4 5091.6 5093.8 3077.5 3164.9 3172.6 3234.4 3246.9 1008.5 1019.7 1023.8 1042.6 1045.4 11339.3 11381.7 11419.2 11423.5 11429.9 4383.4 4390.0 4482.4 4487.7 4552.6 9796.7 9813.4 9815.1 9831.6 9834.4 5077.7 5107.3 5109.8 5112.3 5112.8 3972.4 4464.1 4606.8 4620.5 4693.4 3821.7 3824.1 3900.0 3932.5 3972.1 1219.3 1226.0 1232.4 1253.3 1263.6 918.9 932.8 936.2 940.2 969.6 5614.6 5849.4 5863.4 5951.8 6091.9 426.0 426.9 427.9 434.9 443.0 4007.7 4033.2 4070.8 4074.4 4130.6 9752.0 10136.6 10181.5 10409.2 10474.8 10276.9 10326.7 10334.4 10342.5 10352.2 7702.2 7832.0 7863.3 7881.4 7884.9 5754.8 6019.0 6045.5 6066.7 6087.2 9522.8 9786.8 9799.9 9802.3 9804.7 9665.5 9899.2 9973.5 10016.4 10082.9 6819.7 7009.8 7239.7 7338.3 7399.7 8106.3 8321.5 8373.8 8384.7 8395.2 7258.3 7424.4 7455.5 7542.9 7601.6 7195.1 7347.9 7465.1 7465.3 7652.0 6949.0 7009.4 7051.4 7067.4 7074.0 4918.7 5013.4 5019.5 5046.0 5050.8 5025.9 5098.9 5130.3 5144.6 5211.7 20:26:54 INFO - PROCESS | 30604 | 20:26:54 INFO - PROCESS | 30604 | [#4] prototype.html Cycles:180 Average:4669.02 Median:5229.75 stddev:1376.05 (26.3%) stddev-sans-first:1340.07 20:26:54 INFO - PROCESS | 30604 | Values: 289.5 304.2 307.4 325.8 328.7 5188.7 5218.5 5365.6 5388.8 5434.5 5290.4 5307.3 5318.5 5318.9 5377.4 4190.9 4203.8 4208.7 4218.1 4223.2 3960.2 3997.7 4200.9 4227.9 4230.0 4139.8 4173.5 4192.4 4199.6 4210.9 4140.8 4156.7 4162.8 4165.1 4176.2 3451.9 3715.2 3717.2 3730.3 3743.7 5053.8 5131.0 5189.5 5193.2 5241.0 4662.7 4672.3 4715.4 4739.2 4739.4 5366.6 5483.4 5488.3 5491.5 5549.9 4010.5 4015.6 4018.3 4038.5 4041.3 5739.6 5761.8 5780.0 5781.2 5795.5 3935.3 4095.5 4106.3 4116.6 4122.2 4079.7 4110.1 4125.8 4132.3 4144.5 4690.9 4699.7 4715.6 4715.8 4739.5 5552.2 5554.2 5583.9 5590.6 5606.2 1380.0 1430.3 1431.9 1432.5 1433.9 897.3 903.3 923.8 930.9 931.4 4719.5 4780.0 4792.7 4807.4 4828.4 5065.6 5066.7 5087.6 5092.5 5092.5 4817.7 4823.4 4848.6 4863.8 5093.0 3037.5 3047.1 3051.9 3062.0 3073.4 5988.8 6014.7 6035.8 6071.3 6075.5 5625.7 5879.9 5912.4 5913.2 5938.9 5880.5 5904.8 5964.6 5973.9 5979.5 5540.3 5727.5 5728.5 5757.7 5821.4 5681.0 5695.9 5697.6 5711.1 5712.9 5865.3 5869.9 5943.8 5947.5 5959.4 3980.8 4156.3 4174.1 4182.6 4183.7 5781.9 5790.0 5796.6 5798.2 5816.5 5531.3 5666.4 5700.2 5707.8 5717.5 5635.4 5638.9 5638.9 5646.1 5652.6 5541.6 5546.4 5550.9 5576.4 5579.6 5445.5 5613.5 5624.3 5626.4 5666.6 5430.0 5454.3 5455.2 5463.6 5469.3 20:26:54 INFO - PROCESS | 30604 | 20:26:54 INFO - PROCESS | 30604 | [#5] yui.html Cycles:180 Average:21307.06 Median:3438.63 stddev:30963.91 (900.5%) stddev-sans-first:31012.26 20:26:54 INFO - PROCESS | 30604 | Values: 738.6 758.6 778.0 803.7 845.9 15283.4 16507.2 16514.9 16598.6 16626.8 14536.2 15476.8 15503.2 15538.9 15566.0 681.2 799.0 803.9 812.8 816.1 810.5 812.4 813.3 813.7 813.8 865.5 869.9 870.1 870.1 870.3 720.2 827.8 837.9 844.1 851.7 619.9 621.8 621.9 621.9 622.0 14758.4 15212.1 15231.2 15300.2 15362.1 14482.4 14602.7 14716.7 14746.7 14859.0 12380.5 12486.9 12714.4 12777.3 12794.9 4471.5 4473.4 4480.7 4524.1 4589.9 74492.0 76868.0 77436.2 77886.8 78207.6 11246.0 11721.9 11760.5 11790.9 11838.0 19925.7 20050.0 20165.2 20209.7 20949.3 8133.2 8169.4 8211.7 8252.4 8261.7 4715.3 4779.0 4792.2 4881.0 4925.1 3345.0 3434.5 3442.8 3443.2 3444.7 515.3 564.1 582.8 584.3 587.4 621.3 703.2 718.3 732.2 737.3 10426.7 10445.7 10499.3 10526.4 10759.7 753.9 768.4 775.6 777.0 789.4 5162.0 5175.6 5214.9 5216.6 5260.7 126719.0 126965.0 128199.0 128208.0 130496.0 66982.3 109526.0 109761.0 111551.0 112247.4 59217.7 59422.4 77158.6 99346.0 100832.5 9920.9 10058.5 10065.0 10075.4 10156.8 56864.4 56972.0 57436.6 58143.4 59074.1 49815.5 66802.0 67040.3 67769.7 72009.6 13832.9 13874.9 13896.4 14124.8 14143.4 15483.8 15877.0 15952.9 15961.2 16601.4 14527.5 14855.3 15134.6 15425.2 15911.4 14067.9 14248.0 15289.5 15895.0 15904.9 14035.3 14256.5 14266.7 14297.3 14958.6 12003.7 12105.5 12277.3 12505.8 12890.8 10952.5 11832.1 12054.7 12344.6 12414.7 20:26:54 INFO - PROCESS | 30604 | -------- Summary: end -------- 20:26:54 INFO - PROCESS | 30604 | 20:26:55 INFO - TEST-INFO | 30604: exit 0 20:26:55 INFO - TEST-OK | dromaeo_css | took 1113880ms 20:26:55 INFO - TEST-START | kraken 20:26:55 INFO - operating with platform_type : linux_ 20:26:55 INFO - Initialising browser for kraken test... 20:26:55 INFO - TEST-INFO | started process 30793 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkVErwV/profile http://localhost:36402/getInfo.html) 20:26:59 INFO - PROCESS | 30793 | __metrics Screen width/height:1600/1200 20:26:59 INFO - PROCESS | 30793 | colorDepth:24 20:26:59 INFO - PROCESS | 30793 | Browser inner width/height: 1024/697 20:26:59 INFO - PROCESS | 30793 | __metrics 20:27:00 INFO - PROCESS | 30793 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:27:01 INFO - TEST-INFO | 30793: exit 0 20:27:01 INFO - Browser initialized. 20:27:01 INFO - Running cycle 1/1 for kraken test... 20:27:01 INFO - TEST-INFO | started process 30874 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkVErwV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:27:13 INFO - PROCESS | 30874 | RSS: Main: 174473216 20:27:13 INFO - PROCESS | 30874 | 20:27:16 INFO - PROCESS | 30874 | Cycle 1(1): loaded http://localhost:36402/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36402/tests/kraken/driver.html?testName=audio-beat-detection) 20:27:17 INFO - PROCESS | 30874 | RSS: Main: 232865792 20:27:17 INFO - PROCESS | 30874 | 20:27:19 INFO - PROCESS | 30874 | Cycle 1(1): loaded http://localhost:36402/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36402/tests/kraken/driver.html?testName=audio-dft) 20:27:20 INFO - PROCESS | 30874 | RSS: Main: 220442624 20:27:20 INFO - PROCESS | 30874 | 20:27:23 INFO - PROCESS | 30874 | Cycle 1(1): loaded http://localhost:36402/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36402/tests/kraken/driver.html?testName=audio-fft) 20:27:24 INFO - PROCESS | 30874 | RSS: Main: 286556160 20:27:24 INFO - PROCESS | 30874 | 20:27:26 INFO - PROCESS | 30874 | Cycle 1(1): loaded http://localhost:36402/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36402/tests/kraken/driver.html?testName=audio-oscillator) 20:27:26 INFO - PROCESS | 30874 | RSS: Main: 197521408 20:27:26 INFO - PROCESS | 30874 | 20:27:29 INFO - PROCESS | 30874 | Cycle 1(1): loaded http://localhost:36402/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36402/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:27:29 INFO - PROCESS | 30874 | RSS: Main: 201900032 20:27:29 INFO - PROCESS | 30874 | 20:27:32 INFO - PROCESS | 30874 | Cycle 1(1): loaded http://localhost:36402/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36402/tests/kraken/driver.html?testName=imaging-darkroom) 20:27:33 INFO - PROCESS | 30874 | RSS: Main: 237768704 20:27:33 INFO - PROCESS | 30874 | 20:27:36 INFO - PROCESS | 30874 | Cycle 1(1): loaded http://localhost:36402/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36402/tests/kraken/driver.html?testName=imaging-desaturate) 20:27:37 INFO - PROCESS | 30874 | RSS: Main: 238022656 20:27:37 INFO - PROCESS | 30874 | 20:27:39 INFO - PROCESS | 30874 | Cycle 1(1): loaded http://localhost:36402/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36402/tests/kraken/driver.html?testName=json-parse-financial) 20:27:40 INFO - PROCESS | 30874 | RSS: Main: 237850624 20:27:40 INFO - PROCESS | 30874 | 20:27:42 INFO - PROCESS | 30874 | Cycle 1(1): loaded http://localhost:36402/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36402/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:27:42 INFO - PROCESS | 30874 | RSS: Main: 224808960 20:27:42 INFO - PROCESS | 30874 | 20:27:44 INFO - PROCESS | 30874 | Cycle 1(1): loaded http://localhost:36402/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36402/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:27:45 INFO - PROCESS | 30874 | RSS: Main: 229031936 20:27:45 INFO - PROCESS | 30874 | 20:27:47 INFO - PROCESS | 30874 | Cycle 1(1): loaded http://localhost:36402/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36402/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:27:47 INFO - PROCESS | 30874 | RSS: Main: 235315200 20:27:47 INFO - PROCESS | 30874 | 20:27:50 INFO - PROCESS | 30874 | Cycle 1(1): loaded http://localhost:36402/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36402/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:27:50 INFO - PROCESS | 30874 | RSS: Main: 238264320 20:27:50 INFO - PROCESS | 30874 | 20:27:53 INFO - PROCESS | 30874 | Cycle 1(1): loaded http://localhost:36402/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36402/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:27:54 INFO - PROCESS | 30874 | RSS: Main: 237899776 20:27:54 INFO - PROCESS | 30874 | 20:27:55 INFO - PROCESS | 30874 | Cycle 1(1): loaded http://localhost:36402/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36402/tests/kraken/driver.html?testName=ai-astar) 20:27:56 INFO - PROCESS | 30874 | RSS: Main: 280055808 20:27:56 INFO - PROCESS | 30874 | 20:27:56 INFO - PROCESS | 30874 | __start_tp_report 20:27:56 INFO - PROCESS | 30874 | _x_x_mozilla_page_load 20:27:56 INFO - PROCESS | 30874 | _x_x_mozilla_page_load_details 20:27:56 INFO - PROCESS | 30874 | |i|pagename|runs| 20:27:56 INFO - PROCESS | 30874 | |0;ai-astar;102;113;111;112;111;112;110;110;110;110 20:27:56 INFO - PROCESS | 30874 | |1;audio-beat-detection;149;131;124;205;126;126;163;127;170;133 20:27:56 INFO - PROCESS | 30874 | |2;audio-dft;161;159;159;160;159;162;161;160;161;160 20:27:56 INFO - PROCESS | 30874 | |3;audio-fft;73;74;75;125;75;76;74;76;99;74 20:27:56 INFO - PROCESS | 30874 | |4;audio-oscillator;85;85;118;85;85;85;131;85;85;129 20:27:56 INFO - PROCESS | 30874 | |5;imaging-gaussian-blur;117;117;116;117;117;117;117;116;118;116 20:27:56 INFO - PROCESS | 30874 | |6;imaging-darkroom;146;146;147;146;145;145;146;147;148;146 20:27:56 INFO - PROCESS | 30874 | |7;imaging-desaturate;95;95;96;96;95;95;96;96;96;95 20:27:56 INFO - PROCESS | 30874 | |8;json-parse-financial;55;53;62;52;53;52;55;54;52;54 20:27:56 INFO - PROCESS | 30874 | |9;json-stringify-tinderbox;62;62;61;62;62;62;61;62;62;61 20:27:56 INFO - PROCESS | 30874 | |10;stanford-crypto-aes;79;79;83;82;79;80;79;80;91;80 20:27:56 INFO - PROCESS | 30874 | |11;stanford-crypto-ccm;121;121;125;130;120;121;118;120;124;120 20:27:56 INFO - PROCESS | 30874 | |12;stanford-crypto-pbkdf2;160;157;156;156;158;159;157;157;156;156 20:27:56 INFO - PROCESS | 30874 | |13;stanford-crypto-sha256-iterative;62;61;63;62;62;61;62;62;61;65 20:27:56 INFO - PROCESS | 30874 | __end_tp_report 20:27:56 INFO - PROCESS | 30874 | __start_cc_report 20:27:56 INFO - PROCESS | 30874 | _x_x_mozilla_cycle_collect,1629 20:27:56 INFO - PROCESS | 30874 | __end_cc_report 20:27:56 INFO - PROCESS | 30874 | __startTimestamp1467084476073__endTimestamp 20:27:56 INFO - PROCESS | 30874 | 20:27:56 INFO - PROCESS | 30874 | ------- Summary: start ------- 20:27:56 INFO - PROCESS | 30874 | Number of tests: 14 20:27:56 INFO - PROCESS | 30874 | 20:27:56 INFO - PROCESS | 30874 | [#0] ai-astar Cycles:10 Average:110.10 Median:111.00 stddev:3.03 (2.7%) stddev-sans-first:1.12 20:27:56 INFO - PROCESS | 30874 | Values: 102.0 113.0 111.0 112.0 111.0 112.0 110.0 110.0 110.0 110.0 20:27:56 INFO - PROCESS | 30874 | 20:27:56 INFO - PROCESS | 30874 | [#1] audio-beat-detection Cycles:10 Average:145.40 Median:141.00 stddev:26.65 (18.9%) stddev-sans-first:28.23 20:27:56 INFO - PROCESS | 30874 | Values: 149.0 131.0 124.0 205.0 126.0 126.0 163.0 127.0 170.0 133.0 20:27:56 INFO - PROCESS | 30874 | 20:27:56 INFO - PROCESS | 30874 | [#2] audio-dft Cycles:10 Average:160.20 Median:160.50 stddev:1.03 (0.6%) stddev-sans-first:1.05 20:27:56 INFO - PROCESS | 30874 | Values: 161.0 159.0 159.0 160.0 159.0 162.0 161.0 160.0 161.0 160.0 20:27:56 INFO - PROCESS | 30874 | 20:27:56 INFO - PROCESS | 30874 | [#3] audio-fft Cycles:10 Average:82.10 Median:75.00 stddev:16.93 (22.6%) stddev-sans-first:17.64 20:27:56 INFO - PROCESS | 30874 | Values: 73.0 74.0 75.0 125.0 75.0 76.0 74.0 76.0 99.0 74.0 20:27:56 INFO - PROCESS | 30874 | 20:27:56 INFO - PROCESS | 30874 | [#4] audio-oscillator Cycles:10 Average:97.30 Median:85.00 stddev:20.08 (23.6%) stddev-sans-first:20.80 20:27:56 INFO - PROCESS | 30874 | Values: 85.0 85.0 118.0 85.0 85.0 85.0 131.0 85.0 85.0 129.0 20:27:56 INFO - PROCESS | 30874 | 20:27:56 INFO - PROCESS | 30874 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 20:27:56 INFO - PROCESS | 30874 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 117.0 116.0 118.0 116.0 20:27:56 INFO - PROCESS | 30874 | 20:27:56 INFO - PROCESS | 30874 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 20:27:56 INFO - PROCESS | 30874 | Values: 146.0 146.0 147.0 146.0 145.0 145.0 146.0 147.0 148.0 146.0 20:27:56 INFO - PROCESS | 30874 | 20:27:56 INFO - PROCESS | 30874 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 20:27:56 INFO - PROCESS | 30874 | Values: 95.0 95.0 96.0 96.0 95.0 95.0 96.0 96.0 96.0 95.0 20:27:56 INFO - PROCESS | 30874 | 20:27:56 INFO - PROCESS | 30874 | [#8] json-parse-financial Cycles:10 Average:54.20 Median:54.00 stddev:2.97 (5.5%) stddev-sans-first:3.14 20:27:56 INFO - PROCESS | 30874 | Values: 55.0 53.0 62.0 52.0 53.0 52.0 55.0 54.0 52.0 54.0 20:27:56 INFO - PROCESS | 30874 | 20:27:56 INFO - PROCESS | 30874 | [#9] json-stringify-tinderbox Cycles:10 Average:61.70 Median:62.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 20:27:56 INFO - PROCESS | 30874 | Values: 62.0 62.0 61.0 62.0 62.0 62.0 61.0 62.0 62.0 61.0 20:27:56 INFO - PROCESS | 30874 | 20:27:56 INFO - PROCESS | 30874 | [#10] stanford-crypto-aes Cycles:10 Average:81.20 Median:80.00 stddev:3.71 (4.6%) stddev-sans-first:3.84 20:27:56 INFO - PROCESS | 30874 | Values: 79.0 79.0 83.0 82.0 79.0 80.0 79.0 80.0 91.0 80.0 20:27:56 INFO - PROCESS | 30874 | 20:27:56 INFO - PROCESS | 30874 | [#11] stanford-crypto-ccm Cycles:10 Average:122.00 Median:121.00 stddev:3.46 (2.9%) stddev-sans-first:3.66 20:27:56 INFO - PROCESS | 30874 | Values: 121.0 121.0 125.0 130.0 120.0 121.0 118.0 120.0 124.0 120.0 20:27:56 INFO - PROCESS | 30874 | 20:27:56 INFO - PROCESS | 30874 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.20 Median:157.00 stddev:1.40 (0.9%) stddev-sans-first:1.05 20:27:56 INFO - PROCESS | 30874 | Values: 160.0 157.0 156.0 156.0 158.0 159.0 157.0 157.0 156.0 156.0 20:27:56 INFO - PROCESS | 30874 | 20:27:56 INFO - PROCESS | 30874 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.10 Median:62.00 stddev:1.20 (1.9%) stddev-sans-first:1.27 20:27:56 INFO - PROCESS | 30874 | Values: 62.0 61.0 63.0 62.0 62.0 61.0 62.0 62.0 61.0 65.0 20:27:56 INFO - PROCESS | 30874 | -------- Summary: end -------- 20:27:56 INFO - PROCESS | 30874 | 20:27:57 INFO - TEST-INFO | 30874: exit 0 20:27:57 INFO - TEST-OK | kraken | took 61423ms 20:27:57 INFO - SUITE-END | took 1175s 20:27:57 INFO - Completed test suite (00:19:35) 20:27:57 INFO - javascript benchmark 20:27:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3112.564241006259, 3130.9060728178147, 3140.952885706714, 3148.874045038199, 3187.697168768966, 5269.683818970864, 5336.066188417031, 5353.544948679367, 5433.402325744165, 5493.835184944448, 5446.700431476277, 5459.481349271823, 5464.972675136629, 5493.066178749612, 5524.640898341605, 4865.61075113991, 4960.305557221992, 5001.599872010231, 5012.147934851066, 5170.121079416508, 5061.038402703493, 5066.569341605968, 5085.720285384303, 5129.0767661820855, 5133.435322114583, 4843.58829499493, 4913.14020046494, 4920.778564964585, 4928.901421971576, 4985.426675932242, 4912.901741965176, 4938.38270216223, 4996.375453068366, 5008.474110218447, 5050.318207042039, 4844.176489996709, 4958.355413796219, 4989.850304490871, 4991.07665081961, 5036.949630503685, 5336.599755018389, 5393.19102134679, 5431.53831924283, 5433.972830135864, 5486.862828429281, 5823.592348535604, 5888.234529511179, 5907.232059832194, 5923.940760592382, 5931.228940237785, 5666.490015898589, 5794.101914203263, 5909.349971503131, 5910.852228694317, 5911.9113213301835, 5451.127819548853, 5536.280283563151, 5540.7783688652, 5544.833654990357, 5546.750396232179, 6002.54980876436, 6031.4270144336215, 6032.728527216286, 6033.698315084228, 6034.426729460782, 5604.607677462538, 5646.3224413069875, 5655.0386434306265, 5775.104858746901, 5797.246357973437, 5823.82528524145, 5826.388229235954, 5861.062230043172, 5885.264341957255, 5888.5289176865745, 5772.624779389326, 5806.44838740319, 5811.680357580289, 5820.796272130455, 5831.446012628793, 5596.244506991586, 5771.624844385102, 5792.9420705793245, 5799.942000580025, 5823.475887170091, 4441.933370999438, 4442.711223770445, 4442.800073996678, 4459.509453960061, 4497.887552811206, 3961.920761584752, 3979.5622481527007, 3986.80065996699, 4003.3994900764537, 4018.3168861293652, 5345.812896548602, 5385.165299378603, 5448.564114870801, 5449.863753406196, 5510.752016159283, 5860.443257890493, 5869.7945571904775, 5870.44230798082, 5872.236609240771, 5878.030125029408, 5390.272313237741, 5517.503424691797, 5523.889522209533, 5527.751251193706, 5527.917081243784, 4980.77586508608, 5028.120078986163, 5032.547070763649, 5053.418856831438, 5057.342545469065, 6078.483328917003, 6081.787137450168, 6091.939080609137, 6092.603980741238, 6097.908531371944, 5600.579956503197, 5752.827415177551, 5803.912941305968, 5818.6217895836635, 5819.709014549171, 6078.787242446493, 6131.9272270139245, 6142.7136481981925, 6145.324014358328, 6145.661988590492, 5747.913781293368, 5757.8560535986935, 5793.102069179284, 5793.188953546422, 5804.82585522435, 5710.5146062585145, 5785.363610002981, 5803.970980145073, 5907.438793314628, 5920.141579471038, 5712.314522257356, 5712.6286791358425, 5714.742836572281, 5717.5425965921795, 5748.9425105748405, 5635.8591035224445, 5680.857978550569, 5741.770329186786, 5746.454086861741, 5760.251167348386, 5484.177373394023, 5564.304461942257, 5626.971865140812, 5629.240052592848, 5647.971760141173, 5792.102224155263, 5845.3570107289015, 5847.970760146172, 5849.853753656193, 5860.677662728421, 5634.774609015593, 5675.716214189191, 5677.063284558001, 5685.829425117253, 5691.77232910679], "value": 5387.146109244441, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [577.8497590626439, 622.1600838867528, 625.037442338798, 628.3496581038626, 643.8165122939963, 30811.537826932614, 31446.68553314469, 33793.493097603554, 33932.83033584829, 33963.490547641806, 43947.0, 44813.55186448143, 44996.0, 48191.27713084307, 48532.51467485324, 8775.07861674523, 8906.153915378029, 8910.465372077664, 8911.420757650732, 8919.063498332678, 8644.265237454823, 8761.605727742266, 8771.95614021929, 8772.824543509127, 8777.824443511126, 8798.6920457784, 8820.691275805348, 8825.867611985825, 8828.779280517974, 8832.249258813008, 8721.95639021804, 8739.563021848946, 8768.605412756377, 8775.078616745213, 8776.780580485474, 8817.118288171196, 8905.154010369004, 8916.331275154325, 8924.598393072327, 8925.419847709878, 42718.0, 43030.56969430297, 43091.7845410771, 43138.78430607858, 43161.78419107884, 3410.369081719865, 3590.407582748843, 4215.114825886537, 4309.375140604626, 4416.470023597189, 34703.479447808306, 35357.0, 35383.115422114395, 35417.34860883792, 35776.82111589451, 4396.164728701537, 4494.0, 4513.232750432434, 4524.140413321458, 4545.749983750892, 372905.0, 376551.0, 376917.1154144239, 377063.0, 377613.0, 61606.0, 61727.69136154291, 61990.38009619936, 62025.689871550356, 62163.689181554706, 35543.46684799678, 36401.45397819035, 36422.635773642454, 37626.43560346597, 37698.246035079144, 16397.67204655924, 16524.6695066098, 16578.419755308507, 16590.585235369213, 16651.750223746654, 12402.317872517098, 12525.749485010248, 12548.24710517372, 12549.309787961567, 12552.246865188117, 19469.415917522496, 19724.802751972296, 19828.70256946118, 19929.800701993085, 20002.799972000095, 6990.876905638191, 7205.207427183006, 7316.158641756266, 7452.590107544137, 7477.840290199745, 965.584798536636, 975.6390135649713, 1007.5919252702668, 1032.912202462799, 1115.4718036290335, 32004.679953200637, 32116.19709507281, 32290.83854580759, 32359.352812944082, 32594.511082333785, 1090.0625462102585, 1128.6275529075385, 1142.6343570057502, 1144.0961640304233, 1146.157574182975, 16550.42073527421, 16722.83277167213, 17047.31810727582, 17099.23053462597, 17181.65636687284, 571649.0, 572930.0, 573839.0, 577750.0, 578975.0, 60048.39951600428, 60671.696641517396, 60708.392916071156, 60729.69635151796, 60775.392246077856, 1268.3848333558217, 1355.6746380868717, 1366.357811828439, 1371.095077249011, 1386.4869998100567, 31625.5256171153, 33247.0, 33271.50092748562, 33315.66684333223, 33459.66540334566, 51194.74402627963, 51273.487265126874, 51861.740691296305, 51950.480495196076, 51994.48005519896, 431343.0, 435701.0, 435832.0, 435954.0, 436360.0, 25627.231183064538, 27399.86300068487, 28364.0, 28585.0, 28662.856685716437, 49140.26289605587, 49274.50725492699, 49282.50717492779, 49556.50443495663, 50168.498315017845, 41014.1797164061, 41713.0, 41898.79050604728, 42242.57757422509, 42525.0, 40509.1898162041, 40947.7952610235, 41106.0, 41372.172556548096, 41777.79111104425, 39235.2152956945, 39365.0, 39443.80278098706, 40257.19485610213, 40303.0, 35269.47095793514, 36635.81682091572, 36880.26239475249, 37216.813915930245, 37234.6276537242, 27733.44533109367, 27945.441091177658, 28108.43783124367, 28110.0, 28119.437611247253], "value": 20040.52546114902, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [373.5722597625719, 387.27386150966936, 387.4865802811276, 390.86515152272466, 410.1468944595242, 17793.0, 19265.422037338867, 19855.40433786987, 20217.39347819564, 20313.0, 18554.90722546389, 19216.42350729477, 19501.21995120197, 19727.605447891034, 19736.0, 5351.759170837302, 5609.719514024293, 5733.942660573403, 5817.1565123057135, 5883.47048765611, 5713.400092990239, 5733.512651424634, 5741.110127930177, 5760.913586296209, 5764.135379693059, 5364.6781193128345, 5494.203340515623, 5501.587380946445, 5727.0, 5730.713464326788, 5540.279763630722, 5547.389787123413, 5551.2228288039705, 5555.916661250085, 5585.218069470277, 5059.291699162083, 5390.299261096072, 5390.434004429557, 5394.05604019299, 5395.676259424447, 12463.376831158406, 12502.874971250261, 12546.933510651514, 13007.0, 14250.144991300554, 2176.7170267865235, 2284.6116160252795, 2312.144506532577, 2336.030547322859, 2401.399650087478, 10080.89919100807, 10159.59361625534, 10568.577256909715, 12984.545540906023, 14118.647033824134, 1942.2425254150892, 1952.9316473923345, 1980.0990549300034, 2114.358525125433, 2153.7846215378495, 72747.0, 77529.61235193844, 80067.0, 80499.19500804976, 88451.7659226403, 10495.527701253463, 10711.517981690842, 11040.447977601088, 11147.79278290867, 11368.54525818958, 15347.539573812803, 15388.615284617974, 15426.305816238297, 15440.536783896501, 15469.458568950033, 7828.138904720477, 8032.558209298428, 8066.677332906618, 8127.837443251102, 8147.551884646283, 7591.4685971981435, 7630.931669566266, 7652.273034061755, 7761.301482866456, 7827.569483678339, 4744.810207591727, 4798.304245884327, 4811.27830825379, 4844.539768721966, 4906.852794416173, 1984.811442912921, 1988.9701654475195, 1989.6717041688248, 1996.5807180492259, 2051.558914833318, 926.4904302633524, 944.6412447037501, 978.6134476881592, 982.8083523712808, 1017.765913839821, 18561.81438185601, 19185.52036199106, 19328.226870925006, 19596.70604940927, 19962.30131945375, 983.5672304186278, 994.9801003979879, 1005.2109094361037, 1013.6350913671073, 1046.2989796836139, 10273.434961077062, 10698.893011069946, 10786.56853725858, 10947.726306842393, 10957.342559446459, 468264.0, 479970.0, 484278.0, 489652.0, 490660.0, 89190.55404722935, 89403.0, 89619.55190224007, 90317.0, 90432.5478372604, 993.9453330066771, 1001.4892404873567, 1010.4947526236881, 1016.9389836609827, 1023.048564834696, 16647.50057498277, 16923.492295231164, 17163.141842908055, 17278.740818887476, 17539.123043847503, 39598.2080358397, 41134.0, 41592.584074160084, 41934.790326048176, 42107.0, 55002.44997549973, 55918.0, 56911.430885690614, 57560.71219643875, 58121.70939145277, 8396.286315663237, 8408.579571021302, 8656.091110433314, 8658.610362533575, 8707.346948978979, 10325.586976520855, 12832.0, 12853.35733213317, 12902.548410805577, 13143.60569182926, 10262.794744104927, 10407.791844163226, 11376.829347559627, 11570.305781653127, 11733.296002239551, 11038.779224415628, 11299.322040677585, 11573.13201509907, 11692.181547291948, 11793.233439826385, 11701.824472632747, 11942.34317112567, 12006.159568830099, 12113.939430302793, 12378.75242495163, 8417.663293468193, 8510.0, 8627.784305392164, 8670.393072484865, 8771.079036701054, 10583.841242381217, 11664.6500604982, 11703.531858725555, 11752.58865939688, 11828.17202795796], "value": 9031.951038901796, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1292.147182859313, 1436.4613270023742, 1466.4207637982997, 1576.0, 1740.1734176266268, 7926.207379262078, 8367.2469477747, 8367.330613550908, 8577.14228577142, 8605.91394086059, 8375.41372103953, 8557.957210213941, 8563.743087707364, 8568.057513673506, 8568.614412351444, 1888.1031510032763, 2198.1097655449566, 2250.0999600159903, 2274.1471948019494, 2280.9657855132186, 2269.614165591845, 2272.3183045086407, 2273.170292843117, 2286.702728645282, 2289.3933107726466, 2262.73978492473, 2280.0309868305903, 2282.1441959265276, 2282.4065742906882, 2285.382946604416, 1864.580469394389, 2151.214806595597, 2208.6797414374905, 2211.9557608847895, 2215.966760498594, 2219.1899956515917, 2224.688543603897, 2241.3724157236, 2241.529278851443, 2244.2818298144603, 8205.71280005203, 8316.0, 8324.084350721416, 8325.542095184823, 8325.875111873265, 4960.702357858504, 5024.19612861944, 5086.389633243997, 5091.592672586185, 5093.770780314895, 3077.5229839374933, 3164.936701265985, 3172.587563616715, 3234.417804795136, 3246.853891574885, 1008.4856723071213, 1019.6737044145876, 1023.8259495885643, 1042.6298663974333, 1045.372776334201, 11339.319640821495, 11381.715457113556, 11419.200655954086, 11423.485943132579, 11429.942850285779, 4383.364412160219, 4389.978050109729, 4482.439695038121, 4487.663425243055, 4552.613027892667, 9796.706098817047, 9813.362131461432, 9815.116639502336, 9831.557579908922, 9834.360766550151, 5077.669951453144, 5107.336046313955, 5109.770060347293, 5112.284280200774, 5112.795488180431, 3972.423998520256, 4464.084862603158, 4606.792694328697, 4620.521433141363, 4693.366395536559, 3821.7324787264624, 3824.0822202671716, 3900.0444891001885, 3932.46911666927, 3972.106276087915, 1219.3171823778712, 1225.9632211033684, 1232.3653318540958, 1253.3419954523947, 1263.633546271571, 918.9172974432333, 932.7947851472801, 936.1761649748178, 940.1585580905188, 969.6266937229218, 5614.63504872182, 5849.415058494116, 5863.384344643836, 5951.791687290924, 6091.878162436815, 425.9637930775919, 426.89754458929633, 427.85666801621807, 434.88040788782706, 442.95127535971017, 4007.719459637856, 4033.213523362916, 4070.7964601769795, 4074.409210664437, 4130.56629053945, 9751.951240243896, 10136.645217417356, 10181.490925453698, 10409.219308551888, 10474.842877356845, 10276.948615256875, 10326.690199294033, 10334.431606261727, 10342.534585943651, 10352.171826253882, 7702.191269916578, 7832.020997375442, 7863.252990965849, 7881.448298619156, 7884.921150788418, 5754.798582049608, 6019.0, 6045.546584006129, 6066.666333351708, 6087.239095113111, 9522.761930951781, 9786.75533111678, 9799.85300220483, 9802.313838031554, 9804.65683701067, 9665.468399238109, 9899.20806335477, 9973.45146016947, 10016.39901605906, 10082.949585252027, 6819.727210911707, 7009.754658586925, 7239.710411583477, 7338.339549440576, 7399.704011839682, 8106.310963567927, 8321.54231517248, 8373.790655233668, 8384.66461341564, 8395.24442800151, 7258.3104605062435, 7424.406047516294, 7455.478116532007, 7542.924570754441, 7601.619919004138, 7195.100612423447, 7347.8530429392185, 7465.104187497535, 7465.29079737424, 7651.961740191486, 6948.965255173692, 7009.369156775914, 7051.400630946427, 7067.434605231672, 7074.045003924404, 4918.6556941015215, 5013.398392192814, 5019.472955339636, 5045.974770126126, 5050.77271522775, 5025.874353141201, 5098.898022039612, 5130.256112863689, 5144.614153938394, 5211.739413029409], "value": 4376.034303996362, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [289.47171412172776, 304.1741671362251, 307.403636944328, 325.76056598400174, 328.6664036003457, 5188.740562971855, 5218.504242097004, 5365.5975801814875, 5388.784448622056, 5434.483724046219, 5290.365156181264, 5307.336582927134, 5318.494742999418, 5318.867028324294, 5377.381601115872, 4190.853320133796, 4203.7687927164, 4208.726432781859, 4218.072024154696, 4223.239816832969, 3960.2079584083153, 3997.700747257153, 4200.894977625553, 4227.87316380509, 4230.0, 4139.751614903115, 4173.476681011424, 4192.37114432836, 4199.601037901394, 4210.873673789792, 4140.792960351985, 4156.729812562174, 4162.833486660515, 4165.146145040259, 4176.222811830129, 3451.8964431067106, 3715.2198038411966, 3717.200801827593, 3730.3098926698376, 3743.7192210584044, 5053.797848086072, 5130.97380523893, 5189.546926860485, 5193.169092945111, 5241.0, 4662.72023678577, 4672.332219207906, 4715.41057367829, 4739.241721324606, 4739.431268247798, 5366.570674346043, 5483.369412517572, 5488.341399032101, 5491.450854914477, 5549.861253468655, 4010.47863777707, 4015.6185162409815, 4018.2566225248424, 4038.454808600831, 4041.2523683118716, 5739.598228124033, 5761.798337058183, 5779.971100144515, 5781.19063331134, 5795.478406943395, 3935.2916475034767, 4095.5494895561465, 4106.342985122366, 4116.629503344713, 4122.237386083524, 4079.714419990572, 4110.136871257009, 4125.814338354781, 4132.318167502329, 4144.48193975753, 4690.906181876411, 4699.694519856198, 4715.552022557851, 4715.783581716588, 4739.478657347689, 5552.222688823568, 5554.222408862763, 5583.944160558423, 5590.580706446952, 5606.187102870061, 1379.9724005519834, 1430.3277459593974, 1431.914085154894, 1432.4628264400849, 1433.8781203597812, 897.2911399994063, 903.3089686389917, 923.7644400677784, 930.9208717258973, 931.3793998442661, 4719.5044520325555, 4780.0, 4792.664513484023, 4807.4471435784635, 4828.382491865194, 5065.645404821627, 5066.706640683585, 5087.608823852857, 5092.490750924878, 5092.490750924878, 4817.686850354716, 4823.445303790038, 4848.5636292733825, 4863.756812159378, 5092.974535127375, 3037.5139977603476, 3047.1163362625034, 3051.855554167187, 3061.9846900765356, 3073.3545955349628, 5988.760449582055, 6014.669193194329, 6035.78874739382, 6071.2714474263375, 6075.544334174866, 5625.71871406428, 5879.85427796127, 5912.438318359749, 5913.1912341638235, 5938.8812223755285, 5880.470757631833, 5904.822855314347, 5964.552658550626, 5973.940260597426, 5979.461848433575, 5540.252065971043, 5727.539477433228, 5728.513076388554, 5757.65454072757, 5821.359650438533, 5680.971595141998, 5695.914561281667, 5697.632568183689, 5711.143328500758, 5712.914306285326, 5865.296164460292, 5869.882602348014, 5943.7518121195035, 5947.524198064058, 5959.433853783884, 3980.800959951933, 4156.314208155621, 4174.123434078756, 4182.560831112689, 4183.748975061506, 5781.942180578309, 5790.0, 5796.565257605612, 5798.246227990334, 5816.505597024131, 5531.280933478622, 5666.405027472056, 5700.175943698143, 5707.771689132388, 5717.514011309086, 5635.380108188014, 5638.88722225545, 5638.915416268841, 5646.096624540054, 5652.604317697722, 5541.584381171348, 5546.417626149358, 5550.861228469159, 5576.386597474356, 5579.609427340048, 5445.53712934405, 5613.522850557748, 5624.3250809903075, 5626.381098079126, 5666.603337766317, 5429.972850135724, 5454.318210223722, 5455.1544510600925, 5463.590230732631, 5469.253561310515], "value": 4222.925064884038, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [738.5605564689012, 758.5638258001644, 777.953322800632, 803.6544285957038, 845.8604330285503, 15283.388664453423, 16507.17464126795, 16514.91742541287, 16598.585035374123, 16626.83373166268, 14536.200508972002, 15476.76784848228, 15503.224838758073, 15538.922305388485, 15566.0, 681.1893846322885, 799.0, 803.9397045221632, 812.7642983534768, 816.0982114763191, 810.4893916832388, 812.3663542436909, 813.2964985287742, 813.7355359508153, 813.7640084375524, 865.5282870835379, 869.8999615044256, 870.1298701298701, 870.1298701298701, 870.29071306885, 720.1933834105809, 827.7971896885272, 837.924586787186, 844.1305455380967, 851.7402192331336, 619.8822223777468, 621.7699451203039, 621.9036049412348, 621.9191505104353, 621.9906701399483, 14758.409663613442, 15212.087274763438, 15231.162286074261, 15300.158491283086, 15362.078275303518, 14482.42070317186, 14602.70794584113, 14716.70566588673, 14746.705065898623, 14859.0, 12380.504779808796, 12486.875131248753, 12714.427850746739, 12777.29724865132, 12794.868464436, 4471.53048929861, 4473.373727678128, 4480.708753931017, 4524.072565124142, 4589.908201835978, 74492.0, 76868.0, 77436.22563774404, 77886.83169752458, 78207.6089619554, 11246.0, 11721.941390293165, 11760.470778814974, 11790.938815506646, 11838.0, 19925.701114483294, 20050.0, 20165.193392264144, 20209.6968545469, 20949.266775662778, 8133.227343402367, 8169.428140030141, 8211.71259005932, 8252.422330436812, 8261.669533218725, 4715.269133284346, 4778.952210477851, 4792.2332426811545, 4881.0, 4925.088858561177, 3344.966550334514, 3434.5019972103905, 3442.7590068695454, 3443.2424866529323, 3444.6727560881677, 515.3300709078184, 564.0861803877744, 582.7645391769476, 584.2579923497135, 587.4301927130676, 621.2948303675361, 703.1772825793834, 718.267367285366, 732.2018999290799, 737.3290305821677, 10426.739331516772, 10445.68662940113, 10499.317544359592, 10526.421046842344, 10759.731006724738, 753.9434542409341, 768.3939873417744, 775.5889378629336, 776.9805754856174, 789.4394979564458, 5162.008729282878, 5175.560077393388, 5214.921776173361, 5216.60875434344, 5260.658057226268, 126719.0, 126965.0, 128199.0, 128208.0, 130496.0, 66982.33017669858, 109526.0, 109761.0, 111551.0, 112247.4387628073, 59217.70391148017, 59422.40577594169, 77158.6142069286, 99346.0, 100832.49583752034, 9920.873721222748, 10058.547365368722, 10065.0, 10075.445850478294, 10156.796864062826, 56864.43135568757, 56972.0, 57436.564085898186, 58143.4185658138, 59074.113888292566, 49815.50184498254, 66802.0, 67040.3295967034, 67769.66115169393, 72009.63995179991, 13832.930835345758, 13874.861251387762, 13896.444142234197, 14124.78812817829, 14143.434262629791, 15483.84516154869, 15877.0, 15952.92023539875, 15961.20193990319, 16601.41895033668, 14527.491537796126, 14855.331510081856, 15134.621634459227, 15425.151616661191, 15911.443099491462, 14067.859321407064, 14248.0, 15289.464868729541, 15895.046297222203, 15904.920475397548, 14035.298235088409, 14256.501022464165, 14266.714665706835, 14297.285135742963, 14958.551243462714, 12003.698982779806, 12105.455254513392, 12277.28478729657, 12505.812412813633, 12890.806637900627, 10952.507137178687, 11832.112591555495, 12054.73425290367, 12344.567940122412, 12414.689632759253], "value": 7787.117766316957, "unit": "score"}], "name": "dromaeo_css", "value": 7208.769993022503, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 113.0, 111.0, 112.0, 111.0, 112.0, 110.0, 110.0, 110.0, 110.0], "value": 110.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 131.0, 124.0, 205.0, 126.0, 126.0, 163.0, 127.0, 170.0, 133.0], "value": 145.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 159.0, 159.0, 160.0, 159.0, 162.0, 161.0, 160.0, 161.0, 160.0], "value": 160.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 75.0, 125.0, 75.0, 76.0, 74.0, 76.0, 99.0, 74.0], "value": 82.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 118.0, 85.0, 85.0, 85.0, 131.0, 85.0, 85.0, 129.0], "value": 97.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 118.0, 116.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 146.0, 145.0, 145.0, 146.0, 147.0, 148.0, 146.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 62.0, 52.0, 53.0, 52.0, 55.0, 54.0, 52.0, 54.0], "value": 54.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 61.0, 62.0, 62.0, 62.0, 61.0, 62.0, 62.0, 61.0], "value": 61.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 83.0, 82.0, 79.0, 80.0, 79.0, 80.0, 91.0, 80.0], "value": 81.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 121.0, 125.0, 130.0, 120.0, 121.0, 118.0, 120.0, 124.0, 120.0], "value": 122.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 157.0, 156.0, 156.0, 158.0, 159.0, 157.0, 157.0, 156.0, 156.0], "value": 157.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 63.0, 62.0, 62.0, 61.0, 62.0, 62.0, 61.0, 65.0], "value": 62.1, "unit": "score"}], "name": "kraken", "value": 1492.0, "alertThreshold": 2.0}]} 20:27:57 INFO - Return code: 0 20:27:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:27:57 INFO - # TBPL SUCCESS # 20:27:57 INFO - Running post-action listener: _resource_record_post_action 20:27:57 INFO - ##### 20:27:57 INFO - ##### Finished run-tests step (success) 20:27:57 INFO - ##### 20:27:57 INFO - Running post-run listener: _resource_record_post_run 20:27:57 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 0; Write bytes: 552140800; Read time: 0; Write time: 449532 20:27:57 INFO - TinderboxPrint: CPU usage
13.2% 20:27:57 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 20:27:57 INFO - TinderboxPrint: I/O write bytes / time
552,140,800 / 449,532 20:27:57 INFO - TinderboxPrint: CPU idle
8,271.9 (86.8%) 20:27:57 INFO - TinderboxPrint: CPU user
1,205.5 (12.7%) 20:27:57 INFO - TinderboxPrint: Swap in / out
0 / 0 20:27:57 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 262696960; Read time: 0; Write time: 269868 20:27:57 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 289443840; Read time: 0; Write time: 179664 20:27:58 INFO - Running post-run listener: _upload_blobber_files 20:27:58 INFO - Blob upload gear active. 20:27:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:27:58 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 20:27:58 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:27:58 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:27:58 INFO - (blobuploader) - INFO - Open directory for files ... 20:27:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:27:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:27:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:27:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:27:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:27:59 INFO - (blobuploader) - INFO - Done attempting. 20:27:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:27:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:27:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:28:02 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:28:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:28:02 INFO - (blobuploader) - INFO - Done attempting. 20:28:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:28:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:28:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:28:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:28:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:28:03 INFO - (blobuploader) - INFO - Done attempting. 20:28:03 INFO - (blobuploader) - INFO - Iteration through files over. 20:28:03 INFO - Return code: 0 20:28:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:28:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:28:03 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b335fb4e0b862c6841bb7625c45ff1860853b441f0e0cbab3fcebc65d73d0f14152d9b6d0425f39fde75818b3c9000f2e393a1e6c77914bb74e13e87a985b01b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/759f757ee8a7d5a257a877cbbd31db6218d991a5fc0c436a2492a267f229633fe555b21d5e4903a12952acfcd600cd314443e59b4f296d6b5a75575a169c31fc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8f2fb4a27ed0fb7ce2c413281bc9866f0b396a07f900b37720ee09e9ad9f894ac9a6a203f212afbdaa9744e8ffa9629c530a27860c8ec2b00d144faf55875bb0"} 20:28:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:28:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:28:03 INFO - Contents: 20:28:03 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b335fb4e0b862c6841bb7625c45ff1860853b441f0e0cbab3fcebc65d73d0f14152d9b6d0425f39fde75818b3c9000f2e393a1e6c77914bb74e13e87a985b01b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/759f757ee8a7d5a257a877cbbd31db6218d991a5fc0c436a2492a267f229633fe555b21d5e4903a12952acfcd600cd314443e59b4f296d6b5a75575a169c31fc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8f2fb4a27ed0fb7ce2c413281bc9866f0b396a07f900b37720ee09e9ad9f894ac9a6a203f212afbdaa9744e8ffa9629c530a27860c8ec2b00d144faf55875bb0"} 20:28:03 INFO - Running post-run listener: copy_logs_to_upload_dir 20:28:03 INFO - Copying logs to upload dir... 20:28:03 INFO - mkdir: /builds/slave/test/build/upload/logs 20:28:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.668918 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-06-27 20:28:03.603113) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 20:28:03.609998) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1467082825.818622-1721532570 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b335fb4e0b862c6841bb7625c45ff1860853b441f0e0cbab3fcebc65d73d0f14152d9b6d0425f39fde75818b3c9000f2e393a1e6c77914bb74e13e87a985b01b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/759f757ee8a7d5a257a877cbbd31db6218d991a5fc0c436a2492a267f229633fe555b21d5e4903a12952acfcd600cd314443e59b4f296d6b5a75575a169c31fc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8f2fb4a27ed0fb7ce2c413281bc9866f0b396a07f900b37720ee09e9ad9f894ac9a6a203f212afbdaa9744e8ffa9629c530a27860c8ec2b00d144faf55875bb0"} build_url:https://queue.taskcluster.net/v1/task/GSJnKxL4S6e7jEHf_EBX3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011212 build_url: 'https://queue.taskcluster.net/v1/task/GSJnKxL4S6e7jEHf_EBX3w/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/Fx-Team/sha512/b335fb4e0b862c6841bb7625c45ff1860853b441f0e0cbab3fcebc65d73d0f14152d9b6d0425f39fde75818b3c9000f2e393a1e6c77914bb74e13e87a985b01b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/759f757ee8a7d5a257a877cbbd31db6218d991a5fc0c436a2492a267f229633fe555b21d5e4903a12952acfcd600cd314443e59b4f296d6b5a75575a169c31fc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8f2fb4a27ed0fb7ce2c413281bc9866f0b396a07f900b37720ee09e9ad9f894ac9a6a203f212afbdaa9744e8ffa9629c530a27860c8ec2b00d144faf55875bb0"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 20:28:03.639627) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 20:28:03.639991) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1467082825.818622-1721532570 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004433 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 20:28:03.724579) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 20:28:03.724951) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 20:28:03.725283) ========= ========= Total master_lag: 0.21 =========