builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-030 starttime: 1465455064.62 results: success (0) buildid: 20160608173003 builduid: 5409e863a65f46c7a617fd02e75a93b5 revision: 8a447c89176fb240f78db350e8d65f62d0a6fabb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-08 23:51:04.622075) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-08 23:51:04.622616) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-08 23:51:04.622896) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-08 23:51:04.660913) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 23:51:04.661232) ========= 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=4ac8d263c7293b36a1be1aed000001be-1465452373.611600-1220652694 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-08 23:51:04-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 88.6M=0s 2016-06-08 23:51:04 (88.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.085518 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 23:51:04.768769) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 23:51:04.769056) ========= 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=4ac8d263c7293b36a1be1aed000001be-1465452373.611600-1220652694 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018984 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 23:51:04.833556) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-08 23:51:04.833876) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 8a447c89176fb240f78db350e8d65f62d0a6fabb --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 8a447c89176fb240f78db350e8d65f62d0a6fabb --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=4ac8d263c7293b36a1be1aed000001be-1465452373.611600-1220652694 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-08 23:51:04,938 truncating revision to first 12 chars 2016-06-08 23:51:04,938 Setting DEBUG logging. 2016-06-08 23:51:04,938 attempt 1/10 2016-06-08 23:51:04,938 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/8a447c89176f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-08 23:51:05,890 unpacking tar archive at: fx-team-8a447c89176f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.300924 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-08 23:51:06.148545) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-08 23:51:06.148892) ========= script_repo_revision: 8a447c89176fb240f78db350e8d65f62d0a6fabb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-08 23:51:06.149322) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-08 23:51:06.149595) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-08 23:51:06.163363) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-06-08 23:51:06.163640) ========= /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=4ac8d263c7293b36a1be1aed000001be-1465452373.611600-1220652694 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:51:06 INFO - MultiFileLogger online at 20160608 23:51:06 in /builds/slave/test 23:51:06 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 23:51:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:51:06 INFO - {'append_to_log': False, 23:51:06 INFO - 'base_work_dir': '/builds/slave/test', 23:51:06 INFO - 'blob_upload_branch': 'Fx-Team', 23:51:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:51:06 INFO - 'branch': 'Fx-Team', 23:51:06 INFO - 'buildbot_json_path': 'buildprops.json', 23:51:06 INFO - 'config_files': ('talos/linux_config.py',), 23:51:06 INFO - 'default_actions': ('clobber', 23:51:06 INFO - 'read-buildbot-config', 23:51:06 INFO - 'download-and-extract', 23:51:06 INFO - 'populate-webroot', 23:51:06 INFO - 'create-virtualenv', 23:51:06 INFO - 'install', 23:51:06 INFO - 'run-tests'), 23:51:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:51:06 INFO - 'download_minidump_stackwalk': True, 23:51:06 INFO - 'download_symbols': 'ondemand', 23:51:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:51:06 INFO - 'tooltool.py': '/tools/tooltool.py', 23:51:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:51:06 INFO - '/tools/misc-python/virtualenv.py')}, 23:51:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:51:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:51:06 INFO - 'installer_path': 'installer.exe', 23:51:06 INFO - 'log_level': 'info', 23:51:06 INFO - 'log_name': 'talos', 23:51:06 INFO - 'log_to_console': True, 23:51:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:51:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:51:06 INFO - 'opt_config_files': (), 23:51:06 INFO - 'pip_index': False, 23:51:06 INFO - 'sps_profile': False, 23:51:06 INFO - 'sps_profile_interval': 0, 23:51:06 INFO - 'suite': 'dromaeojs', 23:51:06 INFO - 'system_bits': '32', 23:51:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:51:06 INFO - 'title': 'talos-linux64-ix-030', 23:51:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:51:06 INFO - 'use_talos_json': True, 23:51:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:51:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:51:06 INFO - 'work_dir': 'build'} 23:51:06 INFO - ##### 23:51:06 INFO - ##### Running clobber step. 23:51:06 INFO - ##### 23:51:06 INFO - Running pre-action listener: _resource_record_pre_action 23:51:06 INFO - Running main action method: clobber 23:51:06 INFO - rmtree: /builds/slave/test/build 23:51:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:51:07 INFO - Running post-action listener: _resource_record_post_action 23:51:07 INFO - ##### 23:51:07 INFO - ##### Finished clobber step (success) 23:51:07 INFO - ##### 23:51:07 INFO - ##### 23:51:07 INFO - ##### Running read-buildbot-config step. 23:51:07 INFO - ##### 23:51:07 INFO - Running pre-action listener: _resource_record_pre_action 23:51:07 INFO - Running main action method: read_buildbot_config 23:51:07 INFO - Using buildbot properties: 23:51:07 INFO - { 23:51:07 INFO - "project": "", 23:51:07 INFO - "product": "firefox", 23:51:07 INFO - "script_repo_revision": "production", 23:51:07 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 23:51:07 INFO - "repository": "", 23:51:07 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 23:51:07 INFO - "buildid": "20160608173003", 23:51:07 INFO - "pgo_build": "True", 23:51:07 INFO - "basedir": "/builds/slave/test", 23:51:07 INFO - "buildnumber": 785, 23:51:07 INFO - "slavename": "talos-linux64-ix-030", 23:51:07 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 23:51:07 INFO - "platform": "ubuntu64_hw", 23:51:07 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 23:51:07 INFO - "branch": "fx-team", 23:51:07 INFO - "repo_path": "integration/fx-team", 23:51:07 INFO - "revision": "8a447c89176fb240f78db350e8d65f62d0a6fabb", 23:51:07 INFO - "stage_platform": "linux64-pgo", 23:51:07 INFO - "builduid": "5409e863a65f46c7a617fd02e75a93b5", 23:51:07 INFO - "slavebuilddir": "test" 23:51:07 INFO - } 23:51:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/DeMSWSJQQU61QRdZfTiD5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 23:51:07 INFO - Running post-action listener: _resource_record_post_action 23:51:07 INFO - ##### 23:51:07 INFO - ##### Finished read-buildbot-config step (success) 23:51:07 INFO - ##### 23:51:07 INFO - ##### 23:51:07 INFO - ##### Running download-and-extract step. 23:51:07 INFO - ##### 23:51:07 INFO - Running pre-action listener: _resource_record_pre_action 23:51:07 INFO - Running main action method: download_and_extract 23:51:07 INFO - mkdir: /builds/slave/test/build/tests 23:51:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:51:07 INFO - https://queue.taskcluster.net/v1/task/DeMSWSJQQU61QRdZfTiD5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 23:51:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeMSWSJQQU61QRdZfTiD5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 23:51:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeMSWSJQQU61QRdZfTiD5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 23:51:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeMSWSJQQU61QRdZfTiD5Q/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 23:51:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeMSWSJQQU61QRdZfTiD5Q/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 23:51:10 INFO - Downloaded 1361 bytes. 23:51:10 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 23:51:10 INFO - Using the following test package requirements: 23:51:10 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 23:51:10 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:51:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:51:10 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:51:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 23:51:10 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:51:10 INFO - u'jsshell-linux-x86_64.zip'], 23:51:10 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:51:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:51:10 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 23:51:10 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:51:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:51:10 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:51:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:51:10 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:51:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:51:10 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:51:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:51:10 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:51:10 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')]} 23:51:10 INFO - https://queue.taskcluster.net/v1/task/DeMSWSJQQU61QRdZfTiD5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:51:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeMSWSJQQU61QRdZfTiD5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:51:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeMSWSJQQU61QRdZfTiD5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:51:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeMSWSJQQU61QRdZfTiD5Q/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 23:51:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeMSWSJQQU61QRdZfTiD5Q/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 23:51:16 INFO - Downloaded 24451190 bytes. 23:51:16 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'] 23:51:16 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 23:51:17 INFO - Return code: 0 23:51:17 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 23:51:17 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')]} 23:51:17 INFO - https://queue.taskcluster.net/v1/task/DeMSWSJQQU61QRdZfTiD5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:51:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeMSWSJQQU61QRdZfTiD5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:51:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeMSWSJQQU61QRdZfTiD5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:51:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeMSWSJQQU61QRdZfTiD5Q/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 23:51:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeMSWSJQQU61QRdZfTiD5Q/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 23:51:18 INFO - Downloaded 24451190 bytes. 23:51: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'] 23:51: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 23:51:19 INFO - Return code: 0 23:51: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')]} 23:51:19 INFO - https://queue.taskcluster.net/v1/task/DeMSWSJQQU61QRdZfTiD5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 23:51:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeMSWSJQQU61QRdZfTiD5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 23:51:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeMSWSJQQU61QRdZfTiD5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 23:51:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeMSWSJQQU61QRdZfTiD5Q/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 23:51:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeMSWSJQQU61QRdZfTiD5Q/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 23:51:20 INFO - Downloaded 10833369 bytes. 23:51:21 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'] 23:51:21 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 23:51:21 INFO - Return code: 0 23:51:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:51:21 INFO - https://queue.taskcluster.net/v1/task/DeMSWSJQQU61QRdZfTiD5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 23:51:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeMSWSJQQU61QRdZfTiD5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:51:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeMSWSJQQU61QRdZfTiD5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:51:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeMSWSJQQU61QRdZfTiD5Q/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 23:51:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeMSWSJQQU61QRdZfTiD5Q/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 23:51:22 INFO - Downloaded 59327656 bytes. 23:51:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DeMSWSJQQU61QRdZfTiD5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:51:22 INFO - mkdir: /builds/slave/test/properties 23:51:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:51:22 INFO - Writing to file /builds/slave/test/properties/build_url 23:51:22 INFO - Contents: 23:51:22 INFO - build_url:https://queue.taskcluster.net/v1/task/DeMSWSJQQU61QRdZfTiD5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:51:23 INFO - Running post-action listener: _resource_record_post_action 23:51:23 INFO - Running post-action listener: set_extra_try_arguments 23:51:23 INFO - ##### 23:51:23 INFO - ##### Finished download-and-extract step (success) 23:51:23 INFO - ##### 23:51:23 INFO - ##### 23:51:23 INFO - ##### Running populate-webroot step. 23:51:23 INFO - ##### 23:51:23 INFO - Running pre-action listener: _resource_record_pre_action 23:51:23 INFO - Running main action method: populate_webroot 23:51:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:51:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:51:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:51:23 INFO - '--tppagecycles', 23:51:23 INFO - '7'], 23:51:23 INFO - 'tests': ['tsvgm']}}, 23:51:23 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:51:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:51:23 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:51:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:51:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:51:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:51:23 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:51:23 INFO - 'talos_options': ['--disable-e10s'], 23:51:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:51:23 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:51:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:51:23 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:51:23 INFO - 'talos_options': ['--disable-e10s'], 23:51:23 INFO - 'tests': ['damp', 'tps']}, 23:51:23 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:51:23 INFO - 'tests': ['damp', 'tps']}, 23:51:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:51:23 INFO - 'tests': ['dromaeo_dom']}, 23:51:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:51:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:51:23 INFO - 'tests': ['a11yr', 23:51:23 INFO - 'ts_paint', 23:51:23 INFO - 'tpaint', 23:51:23 INFO - 'sessionrestore', 23:51:23 INFO - 'sessionrestore_no_auto_restore', 23:51:23 INFO - 'tabpaint']}, 23:51:23 INFO - 'other-e10s': {'tests': ['a11yr', 23:51:23 INFO - 'ts_paint', 23:51:23 INFO - 'tpaint', 23:51:23 INFO - 'sessionrestore', 23:51:23 INFO - 'sessionrestore_no_auto_restore', 23:51:23 INFO - 'tabpaint']}, 23:51:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:51:23 INFO - 'ts_paint', 23:51:23 INFO - 'tpaint', 23:51:23 INFO - 'sessionrestore', 23:51:23 INFO - 'sessionrestore_no_auto_restore', 23:51:23 INFO - 'tabpaint']}, 23:51:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:51:23 INFO - 'ts_paint', 23:51:23 INFO - 'tpaint', 23:51:23 INFO - 'sessionrestore', 23:51:23 INFO - 'sessionrestore_no_auto_restore', 23:51:23 INFO - 'tabpaint']}, 23:51:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:51:23 INFO - 'tests': ['a11yr', 23:51:23 INFO - 'ts_paint', 23:51:23 INFO - 'tpaint', 23:51:23 INFO - 'sessionrestore', 23:51:23 INFO - 'sessionrestore_no_auto_restore', 23:51:23 INFO - 'tabpaint']}, 23:51:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:51:23 INFO - 'tests': ['a11yr', 23:51:23 INFO - 'ts_paint', 23:51:23 INFO - 'tpaint', 23:51:23 INFO - 'sessionrestore', 23:51:23 INFO - 'sessionrestore_no_auto_restore', 23:51:23 INFO - 'tabpaint']}, 23:51:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:51:23 INFO - 'tests': ['tsvgx', 23:51:23 INFO - 'tsvgr_opacity', 23:51:23 INFO - 'tart', 23:51:23 INFO - 'tscrollx', 23:51:23 INFO - 'cart']}, 23:51:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:51:23 INFO - 'tsvgr_opacity', 23:51:23 INFO - 'tart', 23:51:23 INFO - 'tscrollx', 23:51:23 INFO - 'cart']}, 23:51:23 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:51:23 INFO - 'talos_options': ['--disable-e10s'], 23:51:23 INFO - 'tests': ['tp5o']}, 23:51:23 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:51:23 INFO - 'tests': ['tp5o']}, 23:51:23 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:51:23 INFO - 'talos_options': ['--disable-e10s', 23:51:23 INFO - '--xperf_path', 23:51:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:51:23 INFO - 'tests': ['tp5n']}, 23:51:23 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:51:23 INFO - 'talos_options': ['--xperf_path', 23:51:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:51:23 INFO - 'tests': ['tp5n']}}, 23:51:23 INFO - 'talos.zip': {'path': '', 23:51:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:51:23 INFO - Running post-action listener: _resource_record_post_action 23:51:23 INFO - ##### 23:51:23 INFO - ##### Finished populate-webroot step (success) 23:51:23 INFO - ##### 23:51:23 INFO - ##### 23:51:23 INFO - ##### Running create-virtualenv step. 23:51:23 INFO - ##### 23:51:23 INFO - Running pre-action listener: _resource_record_pre_action 23:51:23 INFO - Running main action method: create_virtualenv 23:51:23 INFO - Creating virtualenv /builds/slave/test/build/venv 23:51:23 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 23:51:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:51:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:51:23 INFO - Using real prefix '/usr' 23:51:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:51:24 INFO - Installing distribute.............................................................................................................................................................................................done. 23:51:26 INFO - Installing pip.................done. 23:51:26 INFO - Return code: 0 23:51:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:51:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:51:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:51:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:51:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:51:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:51:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:51:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4c314eef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x235b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ea1c0>, '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 0x23eb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23eb550>, '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': '4ac8d263c7293b36a1be1aed000001be-1465452373.611600-1220652694', '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 23:51:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 23:51:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 23:51:26 INFO - Using env: {'DISPLAY': ':0', 23:51:26 INFO - 'HOME': '/home/cltbld', 23:51:26 INFO - 'LANG': 'en_US.UTF-8', 23:51:26 INFO - 'LANGUAGE': 'en_US:en', 23:51:26 INFO - 'LOGNAME': 'cltbld', 23:51:26 INFO - 'MAIL': '/var/mail/cltbld', 23:51:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:51:26 INFO - 'MOZ_NO_REMOTE': '1', 23:51:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:51:26 INFO - 'NO_EM_RESTART': '1', 23:51:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:51:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:51:26 INFO - 'PWD': '/builds/slave/test', 23:51:26 INFO - 'SHELL': '/bin/bash', 23:51:26 INFO - 'SHLVL': '1', 23:51:26 INFO - 'TERM': 'linux', 23:51:26 INFO - 'TMOUT': '86400', 23:51:26 INFO - 'USER': 'cltbld', 23:51:26 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1465452373.611600-1220652694', 23:51:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:51:26 INFO - '_': '/tools/buildbot/bin/python'} 23:51:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:51:26 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 23:51:26 INFO - Cleaning up... 23:51:26 INFO - Return code: 0 23:51:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:51:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:51:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:51:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:51:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:51:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:51:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:51:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f4c314eef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x235b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ea1c0>, '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 0x23eb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23eb550>, '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': '4ac8d263c7293b36a1be1aed000001be-1465452373.611600-1220652694', '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 23:51:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 23:51:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 23:51:26 INFO - Using env: {'DISPLAY': ':0', 23:51:26 INFO - 'HOME': '/home/cltbld', 23:51:26 INFO - 'LANG': 'en_US.UTF-8', 23:51:26 INFO - 'LANGUAGE': 'en_US:en', 23:51:26 INFO - 'LOGNAME': 'cltbld', 23:51:26 INFO - 'MAIL': '/var/mail/cltbld', 23:51:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:51:26 INFO - 'MOZ_NO_REMOTE': '1', 23:51:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:51:26 INFO - 'NO_EM_RESTART': '1', 23:51:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:51:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:51:26 INFO - 'PWD': '/builds/slave/test', 23:51:26 INFO - 'SHELL': '/bin/bash', 23:51:26 INFO - 'SHLVL': '1', 23:51:26 INFO - 'TERM': 'linux', 23:51:26 INFO - 'TMOUT': '86400', 23:51:26 INFO - 'USER': 'cltbld', 23:51:26 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1465452373.611600-1220652694', 23:51:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:51:26 INFO - '_': '/tools/buildbot/bin/python'} 23:51:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:51:26 INFO - Downloading/unpacking psutil>=3.1.1 23:51:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:51:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:51:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:51:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:51:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:51:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:51:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:51:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:51:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:51:28 INFO - Installing collected packages: psutil 23:51:28 INFO - Running setup.py install for psutil 23:51:28 INFO - building 'psutil._psutil_linux' extension 23:51:28 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 23:51:28 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 23:51:28 INFO - building 'psutil._psutil_posix' extension 23:51:28 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 23:51:28 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 23:51:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:51:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:51:28 INFO - Successfully installed psutil 23:51:28 INFO - Cleaning up... 23:51:29 INFO - Return code: 0 23:51:29 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:51:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:51:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:51:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:51:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:51:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:51:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:51:29 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 0x7f4c314eef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x235b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ea1c0>, '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 0x23eb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23eb550>, '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': '4ac8d263c7293b36a1be1aed000001be-1465452373.611600-1220652694', '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 23:51:29 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 23:51:29 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 23:51:29 INFO - Using env: {'DISPLAY': ':0', 23:51:29 INFO - 'HOME': '/home/cltbld', 23:51:29 INFO - 'LANG': 'en_US.UTF-8', 23:51:29 INFO - 'LANGUAGE': 'en_US:en', 23:51:29 INFO - 'LOGNAME': 'cltbld', 23:51:29 INFO - 'MAIL': '/var/mail/cltbld', 23:51:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:51:29 INFO - 'MOZ_NO_REMOTE': '1', 23:51:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:51:29 INFO - 'NO_EM_RESTART': '1', 23:51:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:51:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:51:29 INFO - 'PWD': '/builds/slave/test', 23:51:29 INFO - 'SHELL': '/bin/bash', 23:51:29 INFO - 'SHLVL': '1', 23:51:29 INFO - 'TERM': 'linux', 23:51:29 INFO - 'TMOUT': '86400', 23:51:29 INFO - 'USER': 'cltbld', 23:51:29 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1465452373.611600-1220652694', 23:51:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:51:29 INFO - '_': '/tools/buildbot/bin/python'} 23:51:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:51:29 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:51:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:51:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:51:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:51:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:51:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:51:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:51:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:51:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:51:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:51:31 INFO - Installing collected packages: mozsystemmonitor 23:51:31 INFO - Running setup.py install for mozsystemmonitor 23:51:31 INFO - Successfully installed mozsystemmonitor 23:51:31 INFO - Cleaning up... 23:51:31 INFO - Return code: 0 23:51:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:51:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:51:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:51:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:51:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:51:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:51:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:51:31 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 0x7f4c314eef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x235b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ea1c0>, '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 0x23eb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23eb550>, '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': '4ac8d263c7293b36a1be1aed000001be-1465452373.611600-1220652694', '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 23:51:31 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 23:51:31 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 23:51:31 INFO - Using env: {'DISPLAY': ':0', 23:51:31 INFO - 'HOME': '/home/cltbld', 23:51:31 INFO - 'LANG': 'en_US.UTF-8', 23:51:31 INFO - 'LANGUAGE': 'en_US:en', 23:51:31 INFO - 'LOGNAME': 'cltbld', 23:51:31 INFO - 'MAIL': '/var/mail/cltbld', 23:51:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:51:31 INFO - 'MOZ_NO_REMOTE': '1', 23:51:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:51:31 INFO - 'NO_EM_RESTART': '1', 23:51:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:51:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:51:31 INFO - 'PWD': '/builds/slave/test', 23:51:31 INFO - 'SHELL': '/bin/bash', 23:51:31 INFO - 'SHLVL': '1', 23:51:31 INFO - 'TERM': 'linux', 23:51:31 INFO - 'TMOUT': '86400', 23:51:31 INFO - 'USER': 'cltbld', 23:51:31 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1465452373.611600-1220652694', 23:51:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:51:31 INFO - '_': '/tools/buildbot/bin/python'} 23:51:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:51:31 INFO - Downloading/unpacking jsonschema==2.5.1 23:51:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:51:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:51:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:51:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:51:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:51:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:51:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:51:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:51:33 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 23:51:33 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 23:51:33 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 23:51:33 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 23:51:33 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 23:51:33 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 23:51:33 INFO - Downloading functools32-3.2.3-2.tar.gz 23:51:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:51:33 INFO - warning: no files found matching '*.txt' 23:51:33 INFO - no previously-included directories found matching 'build' 23:51:33 INFO - no previously-included directories found matching 'dist' 23:51:33 INFO - no previously-included directories found matching '.git*' 23:51:33 INFO - Installing collected packages: jsonschema, functools32 23:51:33 INFO - Running setup.py install for functools32 23:51:33 INFO - warning: no files found matching '*.txt' 23:51:33 INFO - no previously-included directories found matching 'build' 23:51:33 INFO - no previously-included directories found matching 'dist' 23:51:33 INFO - no previously-included directories found matching '.git*' 23:51:33 INFO - Successfully installed jsonschema functools32 23:51:33 INFO - Cleaning up... 23:51:33 INFO - Return code: 0 23:51:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:51: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')]} 23:51:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:51:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:51: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')]} 23:51:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:51:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:51:33 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 0x7f4c314eef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x235b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ea1c0>, '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 0x23eb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23eb550>, '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': '4ac8d263c7293b36a1be1aed000001be-1465452373.611600-1220652694', '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 23:51:33 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 23:51:33 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 23:51:33 INFO - Using env: {'DISPLAY': ':0', 23:51:33 INFO - 'HOME': '/home/cltbld', 23:51:33 INFO - 'LANG': 'en_US.UTF-8', 23:51:33 INFO - 'LANGUAGE': 'en_US:en', 23:51:33 INFO - 'LOGNAME': 'cltbld', 23:51:33 INFO - 'MAIL': '/var/mail/cltbld', 23:51:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:51:33 INFO - 'MOZ_NO_REMOTE': '1', 23:51:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:51:33 INFO - 'NO_EM_RESTART': '1', 23:51:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:51:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:51:33 INFO - 'PWD': '/builds/slave/test', 23:51:33 INFO - 'SHELL': '/bin/bash', 23:51:33 INFO - 'SHLVL': '1', 23:51:33 INFO - 'TERM': 'linux', 23:51:33 INFO - 'TMOUT': '86400', 23:51:33 INFO - 'USER': 'cltbld', 23:51:33 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1465452373.611600-1220652694', 23:51:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:51:33 INFO - '_': '/tools/buildbot/bin/python'} 23:51:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:51:34 INFO - Downloading/unpacking blobuploader==1.2.4 23:51:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:51:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:51:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:51:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:51:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:51:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:51:36 INFO - Downloading blobuploader-1.2.4.tar.gz 23:51:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:51:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:51:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:51:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:51:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:51:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:51:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:51:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:51:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:51:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:51:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:51:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:51:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:51:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:51:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:51:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:51:36 INFO - Downloading docopt-0.6.1.tar.gz 23:51:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:51:36 INFO - Installing collected packages: blobuploader, requests, docopt 23:51:36 INFO - Running setup.py install for blobuploader 23:51:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:51:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:51:36 INFO - Running setup.py install for requests 23:51:37 INFO - Running setup.py install for docopt 23:51:37 INFO - Successfully installed blobuploader requests docopt 23:51:37 INFO - Cleaning up... 23:51:37 INFO - Return code: 0 23:51:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:51:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:51:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:51:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:51:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:51:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:51:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:51:37 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 0x7f4c314eef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x235b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ea1c0>, '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 0x23eb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23eb550>, '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': '4ac8d263c7293b36a1be1aed000001be-1465452373.611600-1220652694', '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 23:51:37 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 23:51:37 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 23:51:37 INFO - Using env: {'DISPLAY': ':0', 23:51:37 INFO - 'HOME': '/home/cltbld', 23:51:37 INFO - 'LANG': 'en_US.UTF-8', 23:51:37 INFO - 'LANGUAGE': 'en_US:en', 23:51:37 INFO - 'LOGNAME': 'cltbld', 23:51:37 INFO - 'MAIL': '/var/mail/cltbld', 23:51:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:51:37 INFO - 'MOZ_NO_REMOTE': '1', 23:51:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:51:37 INFO - 'NO_EM_RESTART': '1', 23:51:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:51:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:51:37 INFO - 'PWD': '/builds/slave/test', 23:51:37 INFO - 'SHELL': '/bin/bash', 23:51:37 INFO - 'SHLVL': '1', 23:51:37 INFO - 'TERM': 'linux', 23:51:37 INFO - 'TMOUT': '86400', 23:51:37 INFO - 'USER': 'cltbld', 23:51:37 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1465452373.611600-1220652694', 23:51:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:51:37 INFO - '_': '/tools/buildbot/bin/python'} 23:51:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:51:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:51:37 INFO - Running setup.py (path:/tmp/pip-uOV4p_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:51:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:51:37 INFO - Running setup.py (path:/tmp/pip-N2dQLu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:51:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:51:37 INFO - Running setup.py (path:/tmp/pip-xbUchY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:51:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:51:37 INFO - Running setup.py (path:/tmp/pip-d_HhTw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:51:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:51:37 INFO - Running setup.py (path:/tmp/pip-WSIRYe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:51:38 INFO - Running setup.py (path:/tmp/pip-Al2idP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:51:38 INFO - Running setup.py (path:/tmp/pip-rbpQw_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:51:38 INFO - Running setup.py (path:/tmp/pip-Xibkur-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:51:38 INFO - Running setup.py (path:/tmp/pip-fpsg9w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:51:38 INFO - Running setup.py (path:/tmp/pip-KzSMLl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:51:38 INFO - Running setup.py (path:/tmp/pip-kY6IYW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:51:38 INFO - Running setup.py (path:/tmp/pip-ltSgUv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:51:38 INFO - Running setup.py (path:/tmp/pip-ASuBRj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:51:38 INFO - Running setup.py (path:/tmp/pip-cmTiuE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:51:38 INFO - Running setup.py (path:/tmp/pip-5EimO1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:51:38 INFO - Running setup.py (path:/tmp/pip-rzQaxG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:51:38 INFO - Running setup.py (path:/tmp/pip-pl8z8f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:51:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:51:38 INFO - Running setup.py install for manifestparser 23:51:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:51:38 INFO - Running setup.py install for mozcrash 23:51:39 INFO - Running setup.py install for mozdebug 23:51:39 INFO - Running setup.py install for mozdevice 23:51:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:51:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:51:39 INFO - Running setup.py install for mozfile 23:51:39 INFO - Running setup.py install for mozhttpd 23:51:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:51:39 INFO - Running setup.py install for mozinfo 23:51:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:51:39 INFO - Running setup.py install for mozInstall 23:51:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:51:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:51:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:51:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:51:39 INFO - Running setup.py install for mozleak 23:51:39 INFO - Running setup.py install for mozlog 23:51:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:51:39 INFO - Running setup.py install for moznetwork 23:51:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:51:40 INFO - Running setup.py install for mozprocess 23:51:40 INFO - Running setup.py install for mozprofile 23:51:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:51:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:51:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:51:40 INFO - Running setup.py install for mozrunner 23:51:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:51:40 INFO - Running setup.py install for mozscreenshot 23:51:40 INFO - Running setup.py install for moztest 23:51:40 INFO - Running setup.py install for mozversion 23:51:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:51:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:51:40 INFO - Cleaning up... 23:51:40 INFO - Return code: 0 23:51:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:51: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')]} 23:51:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:51:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:51: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')]} 23:51:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:51:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:51:40 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 0x7f4c314eef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x235b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ea1c0>, '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 0x23eb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23eb550>, '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': '4ac8d263c7293b36a1be1aed000001be-1465452373.611600-1220652694', '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 23:51:40 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 23:51:40 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 23:51:40 INFO - Using env: {'DISPLAY': ':0', 23:51:40 INFO - 'HOME': '/home/cltbld', 23:51:40 INFO - 'LANG': 'en_US.UTF-8', 23:51:40 INFO - 'LANGUAGE': 'en_US:en', 23:51:40 INFO - 'LOGNAME': 'cltbld', 23:51:40 INFO - 'MAIL': '/var/mail/cltbld', 23:51:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:51:40 INFO - 'MOZ_NO_REMOTE': '1', 23:51:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:51:40 INFO - 'NO_EM_RESTART': '1', 23:51:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:51:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:51:40 INFO - 'PWD': '/builds/slave/test', 23:51:40 INFO - 'SHELL': '/bin/bash', 23:51:40 INFO - 'SHLVL': '1', 23:51:40 INFO - 'TERM': 'linux', 23:51:40 INFO - 'TMOUT': '86400', 23:51:40 INFO - 'USER': 'cltbld', 23:51:40 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1465452373.611600-1220652694', 23:51:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:51:40 INFO - '_': '/tools/buildbot/bin/python'} 23:51:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:51:40 INFO - Running setup.py (path:/tmp/pip-dKaM3L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:51:40 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)) 23:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:51:40 INFO - Running setup.py (path:/tmp/pip-uDuNc9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:51:41 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)) 23:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:51:41 INFO - Running setup.py (path:/tmp/pip-5Gsw0I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:51:41 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)) 23:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:51:41 INFO - Running setup.py (path:/tmp/pip-LlvYJ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:51:41 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)) 23:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:51:41 INFO - Running setup.py (path:/tmp/pip-0uxBXG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:51:41 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)) 23:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:51:41 INFO - Running setup.py (path:/tmp/pip-Qjiysl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:51:41 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)) 23:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:51:41 INFO - Running setup.py (path:/tmp/pip-T83hQW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:51:41 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)) 23:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:51:41 INFO - Running setup.py (path:/tmp/pip-7ZebMY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:51:41 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)) 23:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:51:41 INFO - Running setup.py (path:/tmp/pip-FQNven-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:51:41 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)) 23:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:51:41 INFO - Running setup.py (path:/tmp/pip-nkSPsy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:51:41 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)) 23:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:51:41 INFO - Running setup.py (path:/tmp/pip-Q_qNrN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:51:41 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)) 23:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:51:41 INFO - Running setup.py (path:/tmp/pip-X02n_w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:51:41 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)) 23:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:51:41 INFO - Running setup.py (path:/tmp/pip-Pxhhgu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:51:41 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)) 23:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:51:41 INFO - Running setup.py (path:/tmp/pip-Ve28kk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:51:41 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)) 23:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:51:41 INFO - Running setup.py (path:/tmp/pip-D62O76-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:51:42 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)) 23:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:51:42 INFO - Running setup.py (path:/tmp/pip-_j0t_O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:51:42 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)) 23:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:51:42 INFO - Running setup.py (path:/tmp/pip-slDTEl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:51:42 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)) 23:51:42 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)) 23:51:42 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)) 23:51:42 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)) 23:51:42 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)) 23:51:42 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)) 23:51:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:51:42 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 23:51:42 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 23:51:42 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 23:51:42 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 23:51:42 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 23:51:42 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 23:51:44 INFO - Downloading blessings-1.6.tar.gz 23:51:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:51:44 INFO - Installing collected packages: blessings 23:51:44 INFO - Running setup.py install for blessings 23:51:44 INFO - Successfully installed blessings 23:51:44 INFO - Cleaning up... 23:51:44 INFO - Return code: 0 23:51:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:51:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:51:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:51:44 INFO - Reading from file tmpfile_stdout 23:51:44 INFO - Current package versions: 23:51:44 INFO - argparse == 1.2.1 23:51:44 INFO - blessings == 1.6 23:51:44 INFO - blobuploader == 1.2.4 23:51:44 INFO - docopt == 0.6.1 23:51:44 INFO - functools32 == 3.2.3-2 23:51:44 INFO - jsonschema == 2.5.1 23:51:44 INFO - manifestparser == 1.1 23:51:44 INFO - mozInstall == 1.12 23:51:44 INFO - mozcrash == 0.17 23:51:44 INFO - mozdebug == 0.1 23:51:44 INFO - mozdevice == 0.48 23:51:44 INFO - mozfile == 1.2 23:51:44 INFO - mozhttpd == 0.7 23:51:44 INFO - mozinfo == 0.9 23:51:44 INFO - mozleak == 0.1 23:51:44 INFO - mozlog == 3.2 23:51:44 INFO - moznetwork == 0.27 23:51:44 INFO - mozprocess == 0.22 23:51:44 INFO - mozprofile == 0.28 23:51:44 INFO - mozrunner == 6.11 23:51:44 INFO - mozscreenshot == 0.1 23:51:44 INFO - mozsystemmonitor == 0.3 23:51:44 INFO - moztest == 0.7 23:51:44 INFO - mozversion == 1.4 23:51:44 INFO - psutil == 3.1.1 23:51:44 INFO - requests == 1.2.3 23:51:44 INFO - wsgiref == 0.1.2 23:51:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:51:44 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')]} 23:51:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:51:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:51:44 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')]} 23:51:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:51:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:51:44 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 0x7f4c314eef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x235b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ea1c0>, '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 0x23eb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23eb550>, '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': '4ac8d263c7293b36a1be1aed000001be-1465452373.611600-1220652694', '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 23:51:44 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 23:51:44 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 23:51:44 INFO - Using env: {'DISPLAY': ':0', 23:51:44 INFO - 'HOME': '/home/cltbld', 23:51:44 INFO - 'LANG': 'en_US.UTF-8', 23:51:44 INFO - 'LANGUAGE': 'en_US:en', 23:51:44 INFO - 'LOGNAME': 'cltbld', 23:51:44 INFO - 'MAIL': '/var/mail/cltbld', 23:51:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:51:44 INFO - 'MOZ_NO_REMOTE': '1', 23:51:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:51:44 INFO - 'NO_EM_RESTART': '1', 23:51:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:51:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:51:44 INFO - 'PWD': '/builds/slave/test', 23:51:44 INFO - 'SHELL': '/bin/bash', 23:51:44 INFO - 'SHLVL': '1', 23:51:44 INFO - 'TERM': 'linux', 23:51:44 INFO - 'TMOUT': '86400', 23:51:44 INFO - 'USER': 'cltbld', 23:51:44 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1465452373.611600-1220652694', 23:51:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:51:44 INFO - '_': '/tools/buildbot/bin/python'} 23:51:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:51:44 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)) 23:51:44 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)) 23:51:44 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)) 23:51:44 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)) 23:51:44 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)) 23:51:44 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)) 23:51:44 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)) 23:51:44 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)) 23:51:44 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)) 23:51:44 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)) 23:51:44 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)) 23:51:44 INFO - Cleaning up... 23:51:44 INFO - Return code: 0 23:51:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:51:44 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')]} 23:51:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:51:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:51:44 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')]} 23:51:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:51:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:51:44 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 0x7f4c314eef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x235b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ea1c0>, '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 0x23eb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23eb550>, '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': '4ac8d263c7293b36a1be1aed000001be-1465452373.611600-1220652694', '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 23:51:44 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 23:51:44 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 23:51:44 INFO - Using env: {'DISPLAY': ':0', 23:51:44 INFO - 'HOME': '/home/cltbld', 23:51:44 INFO - 'LANG': 'en_US.UTF-8', 23:51:44 INFO - 'LANGUAGE': 'en_US:en', 23:51:44 INFO - 'LOGNAME': 'cltbld', 23:51:44 INFO - 'MAIL': '/var/mail/cltbld', 23:51:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:51:44 INFO - 'MOZ_NO_REMOTE': '1', 23:51:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:51:44 INFO - 'NO_EM_RESTART': '1', 23:51:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:51:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:51:44 INFO - 'PWD': '/builds/slave/test', 23:51:44 INFO - 'SHELL': '/bin/bash', 23:51:44 INFO - 'SHLVL': '1', 23:51:44 INFO - 'TERM': 'linux', 23:51:44 INFO - 'TMOUT': '86400', 23:51:44 INFO - 'USER': 'cltbld', 23:51:44 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1465452373.611600-1220652694', 23:51:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:51:44 INFO - '_': '/tools/buildbot/bin/python'} 23:51:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:51:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:51:44 INFO - Cleaning up... 23:51:44 INFO - Return code: 0 23:51:44 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 23:51:44 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')]} 23:51:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:51:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:51:44 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')]} 23:51:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:51:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:51:44 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 0x7f4c314eef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x235b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ea1c0>, '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 0x23eb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23eb550>, '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': '4ac8d263c7293b36a1be1aed000001be-1465452373.611600-1220652694', '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 23:51:44 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 23:51:44 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 23:51:44 INFO - Using env: {'DISPLAY': ':0', 23:51:44 INFO - 'HOME': '/home/cltbld', 23:51:44 INFO - 'LANG': 'en_US.UTF-8', 23:51:44 INFO - 'LANGUAGE': 'en_US:en', 23:51:44 INFO - 'LOGNAME': 'cltbld', 23:51:44 INFO - 'MAIL': '/var/mail/cltbld', 23:51:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:51:44 INFO - 'MOZ_NO_REMOTE': '1', 23:51:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:51:44 INFO - 'NO_EM_RESTART': '1', 23:51:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:51:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:51:44 INFO - 'PWD': '/builds/slave/test', 23:51:44 INFO - 'SHELL': '/bin/bash', 23:51:44 INFO - 'SHLVL': '1', 23:51:44 INFO - 'TERM': 'linux', 23:51:44 INFO - 'TMOUT': '86400', 23:51:44 INFO - 'USER': 'cltbld', 23:51:44 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1465452373.611600-1220652694', 23:51:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:51:44 INFO - '_': '/tools/buildbot/bin/python'} 23:51:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:51:45 INFO - Downloading/unpacking flake8 23:51:45 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 23:51:45 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 23:51:45 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 23:51:45 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 23:51:45 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 23:51:45 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 23:51:47 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 23:51:47 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 23:51:47 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 23:51:47 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 23:51:47 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 23:51:47 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 23:51:47 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 23:51:47 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 23:51:47 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 23:51:47 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 23:51:47 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 23:51:47 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 23:51:47 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 23:51:47 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 23:51:47 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 23:51:47 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 23:51:47 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 23:51:47 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 23:51:47 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 23:51:47 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 23:51:47 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 23:51:47 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 23:51:47 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 23:51:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 23:51:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:51:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:51:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:51:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:51:47 INFO - no previously-included directories found matching 'docs/_build' 23:51:47 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 23:51:47 INFO - Running setup.py install for pep8 23:51:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:51:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:51:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:51:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:51:47 INFO - no previously-included directories found matching 'docs/_build' 23:51:47 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 23:51:47 INFO - Successfully installed flake8 mccabe pyflakes pep8 23:51:47 INFO - Cleaning up... 23:51:48 INFO - Return code: 0 23:51:48 INFO - Running post-action listener: _resource_record_post_action 23:51:48 INFO - Running post-action listener: _start_resource_monitoring 23:51:48 INFO - Starting resource monitoring. 23:51:48 INFO - ##### 23:51:48 INFO - ##### Finished create-virtualenv step (success) 23:51:48 INFO - ##### 23:51:48 INFO - ##### 23:51:48 INFO - ##### Running install step. 23:51:48 INFO - ##### 23:51:48 INFO - Running pre-action listener: _resource_record_pre_action 23:51:48 INFO - Running main action method: install 23:51:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:51:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:51:48 INFO - Reading from file tmpfile_stdout 23:51:48 INFO - Detecting whether we're running mozinstall >=1.0... 23:51:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:51:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:51:48 INFO - Reading from file tmpfile_stdout 23:51:48 INFO - Output received: 23:51:48 INFO - Usage: mozinstall [options] installer 23:51:48 INFO - Options: 23:51:48 INFO - -h, --help show this help message and exit 23:51:48 INFO - -d DEST, --destination=DEST 23:51:48 INFO - Directory to install application into. [default: 23:51:48 INFO - "/builds/slave/test"] 23:51:48 INFO - --app=APP Application being installed. [default: firefox] 23:51:48 INFO - mkdir: /builds/slave/test/build/application 23:51:48 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'] 23:51:48 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 23:52:05 INFO - Reading from file tmpfile_stdout 23:52:05 INFO - Output received: 23:52:05 INFO - /builds/slave/test/build/application/firefox/firefox 23:52:05 INFO - Running post-action listener: _resource_record_post_action 23:52:05 INFO - ##### 23:52:05 INFO - ##### Finished install step (success) 23:52:05 INFO - ##### 23:52:05 INFO - ##### 23:52:05 INFO - ##### Running run-tests step. 23:52:05 INFO - ##### 23:52:05 INFO - Running pre-action listener: _resource_record_pre_action 23:52:05 INFO - Running main action method: run_tests 23:52:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:52:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:52:05 INFO - Python 2.7.3 23:52:05 INFO - Return code: 0 23:52:05 INFO - grabbing minidump binary from tooltool 23:52:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:52:05 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 0x23ea1c0>, '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 0x23eb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23eb550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:52:05 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 23:52:05 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 23:52:05 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 23:52:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:52:05 INFO - Return code: 0 23:52:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:52:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:52:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:52:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:52:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:52:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 23:52:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 23:52:06 INFO - Return code: 0 23:52:06 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/DeMSWSJQQU61QRdZfTiD5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--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 23:52:06 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/DeMSWSJQQU61QRdZfTiD5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-030 --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 23:52:06 INFO - Using env: {'DISPLAY': ':0', 23:52:06 INFO - 'HOME': '/home/cltbld', 23:52:06 INFO - 'LANG': 'en_US.UTF-8', 23:52:06 INFO - 'LANGUAGE': 'en_US:en', 23:52:06 INFO - 'LOGNAME': 'cltbld', 23:52:06 INFO - 'MAIL': '/var/mail/cltbld', 23:52:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:52:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:52:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:52:06 INFO - 'MOZ_NO_REMOTE': '1', 23:52:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:52:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:52:06 INFO - 'NO_EM_RESTART': '1', 23:52:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:52:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:52:06 INFO - 'PWD': '/builds/slave/test', 23:52:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:52:06 INFO - 'SHELL': '/bin/bash', 23:52:06 INFO - 'SHLVL': '1', 23:52:06 INFO - 'TERM': 'linux', 23:52:06 INFO - 'TMOUT': '86400', 23:52:06 INFO - 'USER': 'cltbld', 23:52:06 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1465452373.611600-1220652694', 23:52:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:52:06 INFO - '_': '/tools/buildbot/bin/python'} 23:52:06 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/DeMSWSJQQU61QRdZfTiD5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--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 23:52:06 INFO - mozversion application_buildid: 20160608173003 23:52:06 INFO - mozversion application_changeset: 8a447c89176fb240f78db350e8d65f62d0a6fabb 23:52:06 INFO - mozversion application_display_name: Nightly 23:52:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:52:06 INFO - mozversion application_name: Firefox 23:52:06 INFO - mozversion application_remotingname: firefox 23:52:06 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 23:52:06 INFO - mozversion application_vendor: Mozilla 23:52:06 INFO - mozversion application_version: 50.0a1 23:52:06 INFO - mozversion platform_buildid: 20160608173003 23:52:06 INFO - mozversion platform_changeset: 8a447c89176fb240f78db350e8d65f62d0a6fabb 23:52:06 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 23:52:06 INFO - mozversion platform_version: 50.0a1 23:52:06 INFO - using testdate: 1465455126 23:52:06 INFO - actual date: 1465455126 23:52:06 INFO - starting webserver on 'localhost:47931' 23:52:06 INFO - SUITE-START | Running 2 tests 23:52:06 INFO - TEST-START | dromaeo_css 23:52:06 INFO - operating with platform_type : linux_ 23:52:06 INFO - Initialising browser for dromaeo_css test... 23:52:06 INFO - TEST-INFO | started process 25421 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8qk5B9/profile http://localhost:47931/getInfo.html) 23:52:10 INFO - PROCESS | 25421 | __metrics Screen width/height:1600/1200 23:52:10 INFO - PROCESS | 25421 | colorDepth:24 23:52:10 INFO - PROCESS | 25421 | Browser inner width/height: 1024/697 23:52:10 INFO - PROCESS | 25421 | __metrics 23:52:11 ERROR - PROCESS | 25421 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 23:52:11 INFO - PROCESS | 25421 | console.error: PushService: 23:52:11 INFO - PROCESS | 25421 | stateChangeProcessEnqueue: Error transitioning state 23:52:11 INFO - PROCESS | 25421 | UnknownError 23:52:12 INFO - TEST-INFO | 25421: exit 0 23:52:12 INFO - Browser initialized. 23:52:12 INFO - Running cycle 1/1 for dromaeo_css test... 23:52:12 INFO - TEST-INFO | started process 25506 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8qk5B9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:52:23 INFO - PROCESS | 25506 | RSS: Main: 155762688 23:52:23 INFO - PROCESS | 25506 | 23:53:15 INFO - PROCESS | 25506 | 1465455195111 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] 23:55:22 INFO - PROCESS | 25506 | Cycle 1(1): loaded http://localhost:47931/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47931/tests/dromaeo/cssquery-ext.html) 23:55:23 INFO - PROCESS | 25506 | RSS: Main: 241381376 23:55:23 INFO - PROCESS | 25506 | 23:58:26 INFO - PROCESS | 25506 | Cycle 1(1): loaded http://localhost:47931/tests/dromaeo/cssquery-ext.html (next: http://localhost:47931/tests/dromaeo/cssquery-jquery.html) 23:58:26 INFO - PROCESS | 25506 | RSS: Main: 236875776 23:58:26 INFO - PROCESS | 25506 | 00:01:28 INFO - PROCESS | 25506 | Cycle 1(1): loaded http://localhost:47931/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47931/tests/dromaeo/cssquery-mootools.html) 00:01:29 INFO - PROCESS | 25506 | RSS: Main: 237363200 00:01:29 INFO - PROCESS | 25506 | 00:04:31 INFO - PROCESS | 25506 | Cycle 1(1): loaded http://localhost:47931/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47931/tests/dromaeo/cssquery-prototype.html) 00:04:31 INFO - PROCESS | 25506 | RSS: Main: 235208704 00:04:31 INFO - PROCESS | 25506 | 00:07:34 INFO - PROCESS | 25506 | Cycle 1(1): loaded http://localhost:47931/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47931/tests/dromaeo/cssquery-yui.html) 00:07:34 INFO - PROCESS | 25506 | RSS: Main: 224714752 00:07:34 INFO - PROCESS | 25506 | 00:10:37 INFO - PROCESS | 25506 | Cycle 1(1): loaded http://localhost:47931/tests/dromaeo/cssquery-yui.html (next: http://localhost:47931/tests/dromaeo/cssquery-dojo.html) 00:10:37 INFO - PROCESS | 25506 | RSS: Main: 274526208 00:10:37 INFO - PROCESS | 25506 | 00:10:37 INFO - PROCESS | 25506 | __start_tp_report 00:10:37 INFO - PROCESS | 25506 | _x_x_mozilla_page_load 00:10:37 INFO - PROCESS | 25506 | _x_x_mozilla_page_load_details 00:10:37 INFO - PROCESS | 25506 | |i|pagename|runs| 00:10:37 INFO - PROCESS | 25506 | |0;dojo.html;3130.373925214956;3138.419392412404;3159.510275907234;3171.286460546376;3195.760317976151;5157.664751791141;5196.974015129928;5198.376194856618;5291.444398338172;5327.067763141449;5248.291480650111;5272.630915835893;5296.947030529694;5318;5376.892462150755;4760.952390476085;4826.686265392756;4846.127697014536;4851.296561998508;4984.576311013569;4877.268409738532;4890.24201248807;4895.363602731658;4948.257761335793;4970.726610036447;4727.149113159629;4743.264793956942;4752.596029337493;4765.904681906342;4775.164346239429;4779.928301075487;4788.186008378584;4790.760461976922;4802.68782529138;4897;4804.543568361035;4822.397200349957;4851.029794041206;4865.732384718839;4895.902081958377;5089.898202035975;5173.042987047408;5259.8422047338645;5278.155495120763;5279.70961597112;5708.372079071299;5714.399988001242;5720.427957204288;5731.226284451629;5744.195812586241;5758.971205143989;5780.653160810365;5800.419958004208;5802.21670074543;5803.9709801451145;5115.590752739772;5226.085435048889;5288.629795914288;5295.470452954673;5364.785408583691;5852.590318677737;5861.794837180678;5864.70676466175;5865.6480611162615;5866.970665146647;5438.945610543923;5645.491905728504;5660.745266463019;5662.320521537442;5663.773449061991;5633.8309850704545;5688.089905615082;5691.3170419549915;5722.799702010409;5724.856878577985;5683.886322273532;5686.943130568641;5692.516136128475;5696;5696.686682232434;5461.617686761968;5573.191887176336;5693.345265294462;5703.54371650267;5705.429457054262;4284.742915425085;4306.354046892991;4319.589638984291;4354.216241076637;4377.0808130293;3847.461355410245;3849.7882616455804;3860.6332398422664;3880.84476620932;3885.708571857122;5164.173732202829;5170.8190213343105;5295.894082118336;5355.357357117093;5413.756380962866;5639.830805075854;5677.687727174963;5682.318121825408;5703.17303990919;5727.140928860705;5369.48989845964;5371.919421208685;5372.70450125239;5374.516293533523;5378.650387724785;4760.166970780169;4832.9275060874115;4915.852524424273;4917.557419832232;4950.8762280943265;5742.454466825729;5805;5807.0998995155815;5813.098969659625;5867.9413205867395;5678;5692.857678558069;5693.572982026448;5693.629914055573;5697.487226149667;5648.887022259614;5734.05388110957;5766.163906233656;5808.273965754281;5821.214136091573;5610.13042978339;5625.662460252398;5627.352854421794;5640;5678.233438485751;5696.686682232517;5723.685197314021;5727.198192253005;5740.253767010429;5746.942530574808;5419.078756611307;5451.563874890078;5467.644603100785;5506.862328441821;5526.751296191762;5522.282103326542;5525.4474552546035;5532.529734972572;5538.529225015919;5540.75066622011;5383.08487557124;5421.972890135524;5428.104362780097;5458.181272809111;5503.862403439946;5410.026195284887;5436;5488.588355873405;5510;5586.692731899622;5433.076377015837;5435.728213589226;5436.266104075899;5436.510714035756;5480.561555075664 00:10:37 INFO - PROCESS | 25506 | |1;ext.html;595.5622617376227;609.5306613907292;620.2123303404676;631.5673763472021;632.7500637248285;31638.36723265536;43152.568474315245;44510.77744611273;44549.331760023626;44579;47501.76249118758;47822;47912.2813157802;47920.281195782;47962.28056579154;8950.910490895089;9091.63633454661;9102.63589456421;9103.590338434786;9105.180533751962;8975.730728078168;9018;9022.413543119676;9032.14194651507;9067.682631107913;9013.819723605524;9080;9094.54527273637;9100.453972761623;9100.590473428678;8990.505522196276;9086.227670647937;9098.863517047183;9102.77243068922;9112.589933453011;8838.734837954871;8871.911280887172;8877;8885.42244754089;8939.41893776909;42637.786811065744;42951.78524107391;43004;43128;43132.70601881949;3520.190356218084;3981.28336899358;4148.91702165958;4209.452771139732;4243.257429949746;32112.197195070312;32839.3432131356;33129;33175.502367464505;34183.48724769131;4045.110075783323;4194.958050419517;4208.789560521962;4278.187144442577;4313.698041137121;346589;348583.2570837155;350391;350425;350758;58781.118283225784;58831.70584147052;59028.704856475444;59273;59317;63825.680871595345;64336.35663643397;64455.67772161203;64467.67766161139;64545;16951.15244237808;17138.31446742116;17263.3957811476;17263.827361726475;17358.13209339528;13198.60404187876;13245.072844900957;13339.933300333436;13407.664808379868;13515;15855.603609909844;17359.30562777475;17535;17573.297068117132;17606.295748170185;6412.903806442907;6421.935780642228;6458.38645328693;6502.902456463157;6747.05541224229;999.1806718490768;1058.296233005043;1127.3010733345213;1138.292065697405;1146.8932480156689;32122.518162227585;32126.678733212837;32383.676163238066;32756.34487310288;33221.3355732884;1123.9213255072066;1185.4902391971534;1199.9700007499882;1201.2312120243053;1269.695273134441;16966.660666786596;17462.82537174612;17478.475645730396;17908.641827163385;18140.223521780073;459061;462971;463029;464584;607919;60899.391006090256;60966.085508717406;61222.38777612256;61296;61308.38691613116;1278.4822147030468;1382.5092092307286;1418;1430.742466356066;1434.5552878607666;29775.404491910474;33823.154421138686;33976.490352644236;34002.65997339995;34727.47908781421;52438;52927;53013.469865302395;53064.73467632637;53104.46895530995;427507;430796;431153;431323;431823;27473.977862434716;27706.307342316602;28640.849506554678;28642.85678571594;29763.55354669725;46475.30287045765;48328;49502.50497494979;50412.747936260086;51335.229971551205;41806.1638767229;42300.78849605732;42330.15339693127;42401.78799105985;44164.11671766482;40960.38559421551;41564.58435415607;41854.58145418507;42270.154596907276;42840;41514.792426037675;41690;42477.78761106298;42498.787506063505;42718;36046.639533605376;37832.243355133294;38078.42882356711;38114.237715244984;38209.235815282984;28174.2956426091;28556.85721571462;28564;28779.568306475838;28827.855860720563 00:10:37 INFO - PROCESS | 25506 | |2;jquery.html;375.1484131022579;376.5312186328022;380.79056518914626;385.5084766922174;386.58056009229983;18491.630167396645;19521.609567808635;19840.60318793625;20359.59280814383;20371.796282037158;18778.342758003473;18798.15408306626;19083.236670533162;19170.90414547929;19208.807911920878;5496.7526461309235;5570.108782594785;5604.691741954191;5713.314402271733;5754;5455.208994695767;5570.832875013756;5580.888382232353;5605;5653.547716182696;5517.917231241535;5530.5852061095375;5534.391216966131;5904.675242861641;6190.566660333779;6296.87406251877;6300.306966233734;6314.652694101823;6346.714397852108;6347.492200623962;5410.621256512007;5578.748956296977;5592.356878958931;5598.272224610774;5602.60781745278;12798.104132710714;13095.607131786062;13104.672383190402;24538.631920521206;25784.742152578423;2356.9410764730846;2550.4389034412397;2714.050082471139;2848.2025032990796;2861.898169204871;15096.245187740678;15679.764803527956;15973.600659983593;16052.11713355765;16322.428714994918;1943.4072607854598;2092.0794850265834;2168.1435832846096;2234.754177040524;2369.2418426103654;92555.53722231346;94030;94214.52892735493;96175.9999999993;101545;17510.64978700419;18335.81664183341;18377.632447350978;18380.540486487946;18624.255029798926;31740.365192696478;32337.838310808766;32899;32968.175795605304;32970.835145824596;9253.95373023144;9816.312858100007;10166.186705063577;10315.381077135396;10554.155667546731;8657.091005444463;8684.56577171139;8704.173103555153;8809.867851982226;8885.911140888638;8913.955430222808;8920.330975176757;8990.460572365679;8992.640294388282;9251.90748092524;3438.449848024354;3473.4195940847358;3530.410466393678;3570.410882204459;3640.740333809449;462.66919152805235;464.28963685561143;972.873526441558;1039.594558122333;1110.3337997201616;11400.714982125348;12101.09241806868;12116.81824772629;12169.513219471122;12312.569060082855;480.6107053286779;483.6711036495147;483.9104765618372;486.68365562384736;486.9707817530889;6375.10748495211;6474.158359413246;6563.507736919654;6572.277049524549;6596.505262105361;504468;504522;510072;512581;525847;69726;75278.24721752822;96249.51875240578;100657;101849;476.91415545201505;478.40916468161794;481.1387616167022;482.73208369354643;485.5969545277411;10917.290376125526;11075.612353567587;11084;11130.109591232844;11136.276142050741;39269;39770.60229397785;40345;40599.39100913548;44090.338644920994;50830.74584627053;51916;59172.40827591669;59320;59364;7645.923540764744;7699.230076992256;7866.252705993151;8381.413301068867;8670.306375490072;8478.152184781473;9528.761780955532;12486.625401237978;13303.866961330263;13760.31198440054;11782.116341274268;12015.339156346485;12149.817752733892;12215.69460763488;12307.692307692021;11863.110266730202;11990.100742444525;12047.33739644328;12209.328486933304;12491.812622810847;12183.390830458618;12226.572069977508;12370.62888113358;12445.875541244472;12546.811797822857;8700.477971321741;8716.651333946571;8776.605052772513;8954.328425367994;9072.455652660597;8977.102289771232;10916.560306317753;11944;12133.393330333625;12158.696032599255 00:10:37 INFO - PROCESS | 25506 | |3;mootools.html;1350.419319692533;1514.7273490771656;1526.2521364531378;1664.3758590528553;1824.7171688388305;8315.293200077993;8668.34987375947;8679.652813887446;8893.555322233895;8905;8748.825023499527;8942.687005954793;8954.507502087383;8955.46267223967;8955.95522022389;2033.5119571302855;2261.2424837679314;2342.1099982006813;2371.347879333184;2401.5797235483806;2336.6728657987896;2346.85918844869;2349.283468542094;2351.000824649526;2351.2123438648073;2334.7781960713705;2348.7886090251873;2383.892724827387;2384.141708984764;2386.9283921482383;1940.2433051110079;2183.770704076065;2194.967075493869;2241.12596087526;2263.7736226377397;2267.4218074390924;2306.5963456395066;2316.6177580699164;2319.6288593824906;2320.3734991552355;8364.289035431995;8440.53577053268;8446.408751387406;8452;8452.070272270046;5137.974310128426;5273.736313184364;5279.102552566034;5285.2600635911;5286.04851126797;3251.349730053999;3354.3626710924846;3401.6768407001296;3426.7258619310396;3505.3164632896596;1109.7669489407235;1162.6221478019677;1179.097990037622;1183.9408029598571;1191.5233906437409;12051.698707532294;12393.380330983506;12410.193337433038;12423.565175218824;12435.626931191988;4485.506594274627;4600;4648.465426475931;4705.223638099744;4707.29390591414;10583.94708026455;10591.152707783358;10609.469526523642;10610.151187904949;10618.840717389245;5164.25118357836;5224.085784987612;5226.242194881797;5229.450907654717;5231.843044708665;4194.433751443577;4699.483056863743;4791.880202994883;4829.5653391194965;4897.363342765418;3930.7248492605245;3940.330143875548;3995.0411901143516;4051.088505086332;4078.7144899857317;1216.2216181643755;1225.5159212111166;1238.8699186585459;1248.5193200617828;1256.2336974445582;871;986.5807032011367;988.9159421449258;1001.8146642871092;1006.1934820032795;5861.17943487912;5952.434518720715;6019.4883434908525;6066.363031881677;6102.847428814315;477.4795472934518;480.329939734076;486.26331108370846;1037.4553359486179;1080.152080616712;4067.7966101694797;4074.7351422157467;4112.91774164515;4113.300738874398;4116.608922152451;10689.893101069045;10800.675979720621;11015.669529914116;11027.44862756859;11027.669169924755;10754.139668826476;10761.78476430467;10798.838017429745;10843.620473283556;10872.075873550837;7993.400494962785;8127.552984585786;8140.877886831702;8145.615245408413;8145.796355091052;5832.650040997553;5859.970700146472;5866.560007999332;6044.002739547926;6113.358097399709;9875.160611347828;10014.098731113943;10119.59521619127;10207.132393746318;10259.48702564854;9932.602695892372;10226.07965283128;10281.383117012703;10297.691069267934;10304.330218535772;7694.692212311445;7865.60671966388;7891.289783919475;7941.245581669732;8015.519068855887;8707.434016788888;8727.432716873383;8768.342374321825;8773.605187766438;8810.911890881265;7673.232676732282;7889;7897.605119743875;7983.281504664608;7983.800404989922;7585.810354740955;7612.352949999312;7634.351080158249;7748;7821.608919553886;7123.679434425359;7171.641417929187;7189.604571748604;7192.640367981476;7200.135983681782;4816.205326121291;4909.3372394727685;5007.198848184273;5091.625261179387;5100.132977393926;5233.712145831863;5404.162354835007;5405.567554595545;5455.18172274162;5486.149646804752 00:10:37 INFO - PROCESS | 25506 | |4;prototype.html;320.82996012113574;330.88088288216244;336.20990671920987;338.33179470545673;340.88580325590925;5254.395744489385;5283.07546179418;5298.251576979597;5314.627976041678;5317.946820531798;5228.588281164083;5266.552343050846;5269.473052694729;5292.3913749918775;5297.682139071659;4081.2245673322122;4168.353905144708;4168.395582640515;4175.958240417603;4182.22628813669;4126.205100781155;4157.334826427772;4171;4182.2890108681595;4191.685623578229;4151.958480415203;4156.210320039183;4159.334506478964;4162;4162.708610397273;3921.8039098044983;3941.467901833259;4071.470708807866;4090.427340172378;4144.378343248522;3608.6030536640947;3617.8733744318824;3618.6381361863864;3620.981895090534;3630.43728222126;5073.518015788531;5085.923711144335;5089.854782673906;5093.5415812576675;5108.591312694975;4312.805923733439;4453.732776033448;4569.1318649456825;4608.861734147981;4626.791794369262;5386.973065134688;5408.918216356705;5412.2152287918425;5412.756425960842;5414.242006119146;3958.2083583283456;3963.9405408918888;3964.7621142731527;3976.741511801724;3980.5024371953505;5505.421930697259;5623.803166889139;5638.746256418471;5642.210090587321;5646.491815736604;4043.8584649537124;4044.3933409988736;4050.4734384529825;4054.7430296608145;4067.613576710208;4113.670906327487;4121.26906699187;4141.399497072907;4143.440635514227;4146.91706165875;4405.449318835145;4606.792694328763;4626;4650.279206722963;4687.10944920464;5490.396056433789;5522.502974732293;5524.309461317335;5525.723713814293;5531.585131115183;1396.9243682364522;1404.5505438259659;1412.0045368015524;1415;1419.2974477633638;918.4810582021137;919.3656377099913;924.1867156901883;961.403929563675;966.2415004221792;5206.193040078794;5246.422893481714;5262.60530460217;5296.7351632418995;5299.417064122943;5483.506484416342;5510.201020851954;5533.446655334515;5534.398832548695;5552.472515111058;5059.848204553869;5112.514311140436;5176.301199338116;5203.453637368098;5375.489328513785;2904.4626744052416;2952.660444048919;2994.2215024093894;2994.8652310646075;3012.8041677290908;5789.623674461231;5800.274965629296;5823.767049318065;5830.7959221427045;5876.559258055578;5538.141588053858;5731.197632331477;5746.88506229873;5748.913766293509;5770.4806567408295;5710.2862142232225;5754.884902302014;5784.582777219608;5789.160571716993;5809.215755872988;5379.4351593082165;5603.719814009201;5613.719314034201;5627.296587926509;5666;5514.53864725856;5526.640768350045;5537;5556.694381809039;5564.944350556442;5707.714614269353;5745.322993284385;5747.224124743273;5784.161296611884;5810.389909059488;3604.143566383944;3655.177585043344;3665.6253904785704;3690.8339124739987;3704.999300377766;5044.470330615232;5057.418396884405;5059.6844820347715;5067.771950262173;5106.47229621325;4909.410870695397;4916.11509928202;4918.5573298403315;4929.383827021622;4969.204927211629;4566.954330456653;4872.733089396853;4914.852554423373;4940.333055037668;4959.82640607577;4777.737224452689;4785.617150628011;4828.396450443694;4842.6368022399165;4870.733609261689;4922.310876477368;4973.5523802857915;4974.502549744997;4981.402231732215;4988.376452943382;4842.83050093245;4864.537868902448;4872.683275587217;5024.487756121939;5430 00:10:37 INFO - PROCESS | 25506 | |5;yui.html;705.3369832357583;725.6335550546974;744.6797876912927;755.4787196834184;820.7537738678395;14252;15277.465288714911;15284;16800.24398902049;17530.912345438286;14940.402383904659;15666.921665391657;15730.606734831606;15827.683446331066;15865.920670396632;687.5565260407035;808.1433680298873;818.4148333941231;823.3454403749034;823.8764185372212;831.8086840026798;839.9790005249887;840.3487297344576;840.6385254340631;840.8570543007672;872.4242000279817;880.6917578847416;881.0044649546004;881.5107615273521;881.6914080071956;720.9855802883939;826.3265438667466;850.1286181663844;875.6978842299396;877.8770972063884;614.6557927560581;621.0125899819309;621.2327775197627;621.2948303675361;621.6270237857294;14876;14898.329575169144;14916.850831491654;14926.776098358534;14933.17867517297;13884.4446222151;13906.165630062127;14002.159870407706;14141.575752727435;14220.146791192561;12625.747485050248;12748.681282967907;12850.550230741972;12987.935060324638;13067;4374.409454723604;4430.800613972379;4460.531644177379;4500.954990450086;4558.49856515783;73624.63187684027;74068;74309;74745;75898;11312.264702794291;11345.94327028376;11533.135014873918;11787.351695656822;11854.94072529632;22124.668129978065;22217;22287.888560557094;22391.21630742916;22397.66403503949;8438.240558349778;8453;8491.532965686823;8538.70114545988;8545.359098067669;4315.1585440838735;4349.695521313541;4621.976890115595;4646.525077275927;4834;3397.0997685613333;3519;3526.8765593204116;3529.9294014119573;3537.20412907099;616.051281027222;620.2433031701318;627.8085184018827;635.6218050260088;635.6567453575018;614.088079202384;614.4408588184731;628.9433950944436;679.1103654212997;693.3943493832094;9205.86191207119;9938.349918724847;10247.180225581935;10274.126699230499;10573.682789516326;605.4429924469499;649.3409189672486;693.2339764560189;744.2594618354772;778.7274453941076;4413.337999300131;4541.227991241497;4640.69835460694;4804.8318308859025;4923.384576927884;106040.46979765051;107727.46136269269;108424.45787771011;111241;112297;77821.61089194518;82750.58624706959;91270.08729912748;96213.03786962181;96370.51814740882;65948.67025664936;68230.31769682339;80861.59569202116;89037.55481222682;90413.09586904047;10159.949200253952;10404.739881503023;10494.317869338469;10536.52585633633;10550.366977981346;50296;51402.74298628483;52177.7391113042;52347.738261309976;52469.21296180484;62983.37016629775;64528.6773566148;73896.63051684707;75045.24954750383;76517.61741191258;13143.211407315592;13296.468141274241;13411.061225714106;13689.247091410069;13723.451061957809;14754.262286885398;14757.335919883846;14763.006295725623;14987.100773953598;15055.096694198382;13491.730165396833;13616.533864541832;13762.518311859038;14202.508736582924;14289.356978935764;13635.454581816617;13809.249244472545;13985.44058237659;14065.929670351992;14170.721272001847;13257.339241024605;13570.86429135696;13900.304984750925;14047.227402492552;14160.78758818598;11136.944315278372;11616.419179041182;11624.535018599161;11848.703782405164;11893.76212475763;11595.594154204562;11659.475323610628;11688.18182727201;11844.644660660195;11908.464119114487 00:10:37 INFO - PROCESS | 25506 | __end_tp_report 00:10:37 INFO - PROCESS | 25506 | __start_cc_report 00:10:37 INFO - PROCESS | 25506 | _x_x_mozilla_cycle_collect,961 00:10:37 INFO - PROCESS | 25506 | __end_cc_report 00:10:37 INFO - PROCESS | 25506 | __startTimestamp1465456237775__endTimestamp 00:10:37 INFO - PROCESS | 25506 | 00:10:37 INFO - PROCESS | 25506 | ------- Summary: start ------- 00:10:37 INFO - PROCESS | 25506 | Number of tests: 6 00:10:37 INFO - PROCESS | 25506 | 00:10:37 INFO - PROCESS | 25506 | [#0] dojo.html Cycles:165 Average:5265.30 Median:5436.00 stddev:589.08 (10.8%) stddev-sans-first:566.58 00:10:37 INFO - PROCESS | 25506 | Values: 3130.4 3138.4 3159.5 3171.3 3195.8 5157.7 5197.0 5198.4 5291.4 5327.1 5248.3 5272.6 5296.9 5318.0 5376.9 4761.0 4826.7 4846.1 4851.3 4984.6 4877.3 4890.2 4895.4 4948.3 4970.7 4727.1 4743.3 4752.6 4765.9 4775.2 4779.9 4788.2 4790.8 4802.7 4897.0 4804.5 4822.4 4851.0 4865.7 4895.9 5089.9 5173.0 5259.8 5278.2 5279.7 5708.4 5714.4 5720.4 5731.2 5744.2 5759.0 5780.7 5800.4 5802.2 5804.0 5115.6 5226.1 5288.6 5295.5 5364.8 5852.6 5861.8 5864.7 5865.6 5867.0 5438.9 5645.5 5660.7 5662.3 5663.8 5633.8 5688.1 5691.3 5722.8 5724.9 5683.9 5686.9 5692.5 5696.0 5696.7 5461.6 5573.2 5693.3 5703.5 5705.4 4284.7 4306.4 4319.6 4354.2 4377.1 3847.5 3849.8 3860.6 3880.8 3885.7 5164.2 5170.8 5295.9 5355.4 5413.8 5639.8 5677.7 5682.3 5703.2 5727.1 5369.5 5371.9 5372.7 5374.5 5378.7 4760.2 4832.9 4915.9 4917.6 4950.9 5742.5 5805.0 5807.1 5813.1 5867.9 5678.0 5692.9 5693.6 5693.6 5697.5 5648.9 5734.1 5766.2 5808.3 5821.2 5610.1 5625.7 5627.4 5640.0 5678.2 5696.7 5723.7 5727.2 5740.3 5746.9 5419.1 5451.6 5467.6 5506.9 5526.8 5522.3 5525.4 5532.5 5538.5 5540.8 5383.1 5422.0 5428.1 5458.2 5503.9 5410.0 5436.0 5488.6 5510.0 5586.7 5433.1 5435.7 5436.3 5436.5 5480.6 00:10:37 INFO - PROCESS | 25506 | 00:10:37 INFO - PROCESS | 25506 | [#1] ext.html Cycles:180 Average:59450.17 Median:42677.89 stddev:113458.51 (265.8%) stddev-sans-first:113690.74 00:10:37 INFO - PROCESS | 25506 | Values: 595.6 609.5 620.2 631.6 632.8 31638.4 43152.6 44510.8 44549.3 44579.0 47501.8 47822.0 47912.3 47920.3 47962.3 8950.9 9091.6 9102.6 9103.6 9105.2 8975.7 9018.0 9022.4 9032.1 9067.7 9013.8 9080.0 9094.5 9100.5 9100.6 8990.5 9086.2 9098.9 9102.8 9112.6 8838.7 8871.9 8877.0 8885.4 8939.4 42637.8 42951.8 43004.0 43128.0 43132.7 3520.2 3981.3 4148.9 4209.5 4243.3 32112.2 32839.3 33129.0 33175.5 34183.5 4045.1 4195.0 4208.8 4278.2 4313.7 346589.0 348583.3 350391.0 350425.0 350758.0 58781.1 58831.7 59028.7 59273.0 59317.0 63825.7 64336.4 64455.7 64467.7 64545.0 16951.2 17138.3 17263.4 17263.8 17358.1 13198.6 13245.1 13339.9 13407.7 13515.0 15855.6 17359.3 17535.0 17573.3 17606.3 6412.9 6421.9 6458.4 6502.9 6747.1 999.2 1058.3 1127.3 1138.3 1146.9 32122.5 32126.7 32383.7 32756.3 33221.3 1123.9 1185.5 1200.0 1201.2 1269.7 16966.7 17462.8 17478.5 17908.6 18140.2 459061.0 462971.0 463029.0 464584.0 607919.0 60899.4 60966.1 61222.4 61296.0 61308.4 1278.5 1382.5 1418.0 1430.7 1434.6 29775.4 33823.2 33976.5 34002.7 34727.5 52438.0 52927.0 53013.5 53064.7 53104.5 427507.0 430796.0 431153.0 431323.0 431823.0 27474.0 27706.3 28640.8 28642.9 29763.6 46475.3 48328.0 49502.5 50412.7 51335.2 41806.2 42300.8 42330.2 42401.8 44164.1 40960.4 41564.6 41854.6 42270.2 42840.0 41514.8 41690.0 42477.8 42498.8 42718.0 36046.6 37832.2 38078.4 38114.2 38209.2 28174.3 28556.9 28564.0 28779.6 28827.9 00:10:37 INFO - PROCESS | 25506 | 00:10:37 INFO - PROCESS | 25506 | [#2] jquery.html Cycles:180 Average:30251.49 Median:39519.80 stddev:84425.93 (213.6%) stddev-sans-first:84632.97 00:10:37 INFO - PROCESS | 25506 | Values: 375.1 376.5 380.8 385.5 386.6 18491.6 19521.6 19840.6 20359.6 20371.8 18778.3 18798.2 19083.2 19170.9 19208.8 5496.8 5570.1 5604.7 5713.3 5754.0 5455.2 5570.8 5580.9 5605.0 5653.5 5517.9 5530.6 5534.4 5904.7 6190.6 6296.9 6300.3 6314.7 6346.7 6347.5 5410.6 5578.7 5592.4 5598.3 5602.6 12798.1 13095.6 13104.7 24538.6 25784.7 2356.9 2550.4 2714.1 2848.2 2861.9 15096.2 15679.8 15973.6 16052.1 16322.4 1943.4 2092.1 2168.1 2234.8 2369.2 92555.5 94030.0 94214.5 96176.0 101545.0 17510.6 18335.8 18377.6 18380.5 18624.3 31740.4 32337.8 32899.0 32968.2 32970.8 9254.0 9816.3 10166.2 10315.4 10554.2 8657.1 8684.6 8704.2 8809.9 8885.9 8914.0 8920.3 8990.5 8992.6 9251.9 3438.4 3473.4 3530.4 3570.4 3640.7 462.7 464.3 972.9 1039.6 1110.3 11400.7 12101.1 12116.8 12169.5 12312.6 480.6 483.7 483.9 486.7 487.0 6375.1 6474.2 6563.5 6572.3 6596.5 504468.0 504522.0 510072.0 512581.0 525847.0 69726.0 75278.2 96249.5 100657.0 101849.0 476.9 478.4 481.1 482.7 485.6 10917.3 11075.6 11084.0 11130.1 11136.3 39269.0 39770.6 40345.0 40599.4 44090.3 50830.7 51916.0 59172.4 59320.0 59364.0 7645.9 7699.2 7866.3 8381.4 8670.3 8478.2 9528.8 12486.6 13303.9 13760.3 11782.1 12015.3 12149.8 12215.7 12307.7 11863.1 11990.1 12047.3 12209.3 12491.8 12183.4 12226.6 12370.6 12445.9 12546.8 8700.5 8716.7 8776.6 8954.3 9072.5 8977.1 10916.6 11944.0 12133.4 12158.7 00:10:37 INFO - PROCESS | 25506 | 00:10:37 INFO - PROCESS | 25506 | [#3] mootools.html Cycles:180 Average:5811.45 Median:4673.97 stddev:3323.83 (71.1%) stddev-sans-first:3316.25 00:10:37 INFO - PROCESS | 25506 | Values: 1350.4 1514.7 1526.3 1664.4 1824.7 8315.3 8668.3 8679.7 8893.6 8905.0 8748.8 8942.7 8954.5 8955.5 8956.0 2033.5 2261.2 2342.1 2371.3 2401.6 2336.7 2346.9 2349.3 2351.0 2351.2 2334.8 2348.8 2383.9 2384.1 2386.9 1940.2 2183.8 2195.0 2241.1 2263.8 2267.4 2306.6 2316.6 2319.6 2320.4 8364.3 8440.5 8446.4 8452.0 8452.1 5138.0 5273.7 5279.1 5285.3 5286.0 3251.3 3354.4 3401.7 3426.7 3505.3 1109.8 1162.6 1179.1 1183.9 1191.5 12051.7 12393.4 12410.2 12423.6 12435.6 4485.5 4600.0 4648.5 4705.2 4707.3 10583.9 10591.2 10609.5 10610.2 10618.8 5164.3 5224.1 5226.2 5229.5 5231.8 4194.4 4699.5 4791.9 4829.6 4897.4 3930.7 3940.3 3995.0 4051.1 4078.7 1216.2 1225.5 1238.9 1248.5 1256.2 871.0 986.6 988.9 1001.8 1006.2 5861.2 5952.4 6019.5 6066.4 6102.8 477.5 480.3 486.3 1037.5 1080.2 4067.8 4074.7 4112.9 4113.3 4116.6 10689.9 10800.7 11015.7 11027.4 11027.7 10754.1 10761.8 10798.8 10843.6 10872.1 7993.4 8127.6 8140.9 8145.6 8145.8 5832.7 5860.0 5866.6 6044.0 6113.4 9875.2 10014.1 10119.6 10207.1 10259.5 9932.6 10226.1 10281.4 10297.7 10304.3 7694.7 7865.6 7891.3 7941.2 8015.5 8707.4 8727.4 8768.3 8773.6 8810.9 7673.2 7889.0 7897.6 7983.3 7983.8 7585.8 7612.4 7634.4 7748.0 7821.6 7123.7 7171.6 7189.6 7192.6 7200.1 4816.2 4909.3 5007.2 5091.6 5100.1 5233.7 5404.2 5405.6 5455.2 5486.1 00:10:37 INFO - PROCESS | 25506 | 00:10:37 INFO - PROCESS | 25506 | [#4] prototype.html Cycles:180 Average:4519.35 Median:4977.95 stddev:1309.18 (26.3%) stddev-sans-first:1274.36 00:10:37 INFO - PROCESS | 25506 | Values: 320.8 330.9 336.2 338.3 340.9 5254.4 5283.1 5298.3 5314.6 5317.9 5228.6 5266.6 5269.5 5292.4 5297.7 4081.2 4168.4 4168.4 4176.0 4182.2 4126.2 4157.3 4171.0 4182.3 4191.7 4152.0 4156.2 4159.3 4162.0 4162.7 3921.8 3941.5 4071.5 4090.4 4144.4 3608.6 3617.9 3618.6 3621.0 3630.4 5073.5 5085.9 5089.9 5093.5 5108.6 4312.8 4453.7 4569.1 4608.9 4626.8 5387.0 5408.9 5412.2 5412.8 5414.2 3958.2 3963.9 3964.8 3976.7 3980.5 5505.4 5623.8 5638.7 5642.2 5646.5 4043.9 4044.4 4050.5 4054.7 4067.6 4113.7 4121.3 4141.4 4143.4 4146.9 4405.4 4606.8 4626.0 4650.3 4687.1 5490.4 5522.5 5524.3 5525.7 5531.6 1396.9 1404.6 1412.0 1415.0 1419.3 918.5 919.4 924.2 961.4 966.2 5206.2 5246.4 5262.6 5296.7 5299.4 5483.5 5510.2 5533.4 5534.4 5552.5 5059.8 5112.5 5176.3 5203.5 5375.5 2904.5 2952.7 2994.2 2994.9 3012.8 5789.6 5800.3 5823.8 5830.8 5876.6 5538.1 5731.2 5746.9 5748.9 5770.5 5710.3 5754.9 5784.6 5789.2 5809.2 5379.4 5603.7 5613.7 5627.3 5666.0 5514.5 5526.6 5537.0 5556.7 5564.9 5707.7 5745.3 5747.2 5784.2 5810.4 3604.1 3655.2 3665.6 3690.8 3705.0 5044.5 5057.4 5059.7 5067.8 5106.5 4909.4 4916.1 4918.6 4929.4 4969.2 4567.0 4872.7 4914.9 4940.3 4959.8 4777.7 4785.6 4828.4 4842.6 4870.7 4922.3 4973.6 4974.5 4981.4 4988.4 4842.8 4864.5 4872.7 5024.5 5430.0 00:10:37 INFO - PROCESS | 25506 | 00:10:37 INFO - PROCESS | 25506 | [#5] yui.html Cycles:180 Average:20193.91 Median:4393.87 stddev:28013.89 (637.6%) stddev-sans-first:28054.25 00:10:37 INFO - PROCESS | 25506 | Values: 705.3 725.6 744.7 755.5 820.8 14252.0 15277.5 15284.0 16800.2 17530.9 14940.4 15666.9 15730.6 15827.7 15865.9 687.6 808.1 818.4 823.3 823.9 831.8 840.0 840.3 840.6 840.9 872.4 880.7 881.0 881.5 881.7 721.0 826.3 850.1 875.7 877.9 614.7 621.0 621.2 621.3 621.6 14876.0 14898.3 14916.9 14926.8 14933.2 13884.4 13906.2 14002.2 14141.6 14220.1 12625.7 12748.7 12850.6 12987.9 13067.0 4374.4 4430.8 4460.5 4501.0 4558.5 73624.6 74068.0 74309.0 74745.0 75898.0 11312.3 11345.9 11533.1 11787.4 11854.9 22124.7 22217.0 22287.9 22391.2 22397.7 8438.2 8453.0 8491.5 8538.7 8545.4 4315.2 4349.7 4622.0 4646.5 4834.0 3397.1 3519.0 3526.9 3529.9 3537.2 616.1 620.2 627.8 635.6 635.7 614.1 614.4 628.9 679.1 693.4 9205.9 9938.3 10247.2 10274.1 10573.7 605.4 649.3 693.2 744.3 778.7 4413.3 4541.2 4640.7 4804.8 4923.4 106040.5 107727.5 108424.5 111241.0 112297.0 77821.6 82750.6 91270.1 96213.0 96370.5 65948.7 68230.3 80861.6 89037.6 90413.1 10159.9 10404.7 10494.3 10536.5 10550.4 50296.0 51402.7 52177.7 52347.7 52469.2 62983.4 64528.7 73896.6 75045.2 76517.6 13143.2 13296.5 13411.1 13689.2 13723.5 14754.3 14757.3 14763.0 14987.1 15055.1 13491.7 13616.5 13762.5 14202.5 14289.4 13635.5 13809.2 13985.4 14065.9 14170.7 13257.3 13570.9 13900.3 14047.2 14160.8 11136.9 11616.4 11624.5 11848.7 11893.8 11595.6 11659.5 11688.2 11844.6 11908.5 00:10:37 INFO - PROCESS | 25506 | -------- Summary: end -------- 00:10:37 INFO - PROCESS | 25506 | 00:10:38 INFO - TEST-INFO | 25506: exit 0 00:10:38 INFO - TEST-OK | dromaeo_css | took 1112037ms 00:10:38 INFO - TEST-START | kraken 00:10:38 INFO - operating with platform_type : linux_ 00:10:38 INFO - Initialising browser for kraken test... 00:10:38 INFO - TEST-INFO | started process 25686 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeE2km8/profile http://localhost:47931/getInfo.html) 00:10:42 INFO - PROCESS | 25686 | __metrics Screen width/height:1600/1200 00:10:42 INFO - PROCESS | 25686 | colorDepth:24 00:10:42 INFO - PROCESS | 25686 | Browser inner width/height: 1024/697 00:10:42 INFO - PROCESS | 25686 | __metrics 00:10:43 ERROR - PROCESS | 25686 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 00:10:43 INFO - PROCESS | 25686 | console.error: PushService: 00:10:43 INFO - PROCESS | 25686 | stateChangeProcessEnqueue: Error transitioning state 00:10:43 INFO - PROCESS | 25686 | UnknownError 00:10:43 INFO - TEST-INFO | 25686: exit 0 00:10:43 INFO - Browser initialized. 00:10:43 INFO - Running cycle 1/1 for kraken test... 00:10:43 INFO - TEST-INFO | started process 25774 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeE2km8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:10:55 INFO - PROCESS | 25774 | RSS: Main: 155860992 00:10:55 INFO - PROCESS | 25774 | 00:10:58 INFO - PROCESS | 25774 | Cycle 1(1): loaded http://localhost:47931/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47931/tests/kraken/driver.html?testName=audio-beat-detection) 00:10:59 INFO - PROCESS | 25774 | RSS: Main: 215326720 00:10:59 INFO - PROCESS | 25774 | 00:11:01 INFO - PROCESS | 25774 | Cycle 1(1): loaded http://localhost:47931/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47931/tests/kraken/driver.html?testName=audio-dft) 00:11:02 INFO - PROCESS | 25774 | RSS: Main: 201412608 00:11:02 INFO - PROCESS | 25774 | 00:11:05 INFO - PROCESS | 25774 | Cycle 1(1): loaded http://localhost:47931/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47931/tests/kraken/driver.html?testName=audio-fft) 00:11:06 INFO - PROCESS | 25774 | RSS: Main: 268750848 00:11:06 INFO - PROCESS | 25774 | 00:11:08 INFO - PROCESS | 25774 | Cycle 1(1): loaded http://localhost:47931/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47931/tests/kraken/driver.html?testName=audio-oscillator) 00:11:08 INFO - PROCESS | 25774 | RSS: Main: 179650560 00:11:08 INFO - PROCESS | 25774 | 00:11:11 INFO - PROCESS | 25774 | Cycle 1(1): loaded http://localhost:47931/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47931/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:11:11 INFO - PROCESS | 25774 | RSS: Main: 183275520 00:11:11 INFO - PROCESS | 25774 | 00:11:14 INFO - PROCESS | 25774 | Cycle 1(1): loaded http://localhost:47931/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47931/tests/kraken/driver.html?testName=imaging-darkroom) 00:11:15 INFO - PROCESS | 25774 | RSS: Main: 218054656 00:11:15 INFO - PROCESS | 25774 | 00:11:18 INFO - PROCESS | 25774 | Cycle 1(1): loaded http://localhost:47931/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47931/tests/kraken/driver.html?testName=imaging-desaturate) 00:11:19 INFO - PROCESS | 25774 | RSS: Main: 220336128 00:11:19 INFO - PROCESS | 25774 | 00:11:22 INFO - PROCESS | 25774 | Cycle 1(1): loaded http://localhost:47931/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47931/tests/kraken/driver.html?testName=json-parse-financial) 00:11:22 INFO - PROCESS | 25774 | RSS: Main: 220966912 00:11:22 INFO - PROCESS | 25774 | 00:11:24 INFO - PROCESS | 25774 | Cycle 1(1): loaded http://localhost:47931/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47931/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:11:24 INFO - PROCESS | 25774 | RSS: Main: 206086144 00:11:24 INFO - PROCESS | 25774 | 00:11:26 INFO - PROCESS | 25774 | Cycle 1(1): loaded http://localhost:47931/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47931/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:11:27 INFO - PROCESS | 25774 | RSS: Main: 211841024 00:11:27 INFO - PROCESS | 25774 | 00:11:29 INFO - PROCESS | 25774 | Cycle 1(1): loaded http://localhost:47931/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47931/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:11:29 INFO - PROCESS | 25774 | RSS: Main: 219070464 00:11:29 INFO - PROCESS | 25774 | 00:11:32 INFO - PROCESS | 25774 | Cycle 1(1): loaded http://localhost:47931/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47931/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:11:33 INFO - PROCESS | 25774 | RSS: Main: 223956992 00:11:33 INFO - PROCESS | 25774 | 00:11:35 INFO - PROCESS | 25774 | Cycle 1(1): loaded http://localhost:47931/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47931/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:11:36 INFO - PROCESS | 25774 | RSS: Main: 223555584 00:11:36 INFO - PROCESS | 25774 | 00:11:38 INFO - PROCESS | 25774 | Cycle 1(1): loaded http://localhost:47931/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47931/tests/kraken/driver.html?testName=ai-astar) 00:11:38 INFO - PROCESS | 25774 | RSS: Main: 265244672 00:11:38 INFO - PROCESS | 25774 | 00:11:38 INFO - PROCESS | 25774 | __start_tp_report 00:11:38 INFO - PROCESS | 25774 | _x_x_mozilla_page_load 00:11:38 INFO - PROCESS | 25774 | _x_x_mozilla_page_load_details 00:11:38 INFO - PROCESS | 25774 | |i|pagename|runs| 00:11:38 INFO - PROCESS | 25774 | |0;ai-astar;112;106;111;112;110;112;110;110;112;112 00:11:38 INFO - PROCESS | 25774 | |1;audio-beat-detection;146;126;130;177;126;127;156;131;164;125 00:11:38 INFO - PROCESS | 25774 | |2;audio-dft;161;160;168;162;161;162;162;160;161;161 00:11:38 INFO - PROCESS | 25774 | |3;audio-fft;74;75;75;120;76;76;74;75;104;75 00:11:38 INFO - PROCESS | 25774 | |4;audio-oscillator;86;84;115;85;85;85;120;85;86;131 00:11:38 INFO - PROCESS | 25774 | |5;imaging-gaussian-blur;117;116;116;117;117;116;117;117;117;117 00:11:38 INFO - PROCESS | 25774 | |6;imaging-darkroom;146;145;145;146;147;147;145;146;147;146 00:11:38 INFO - PROCESS | 25774 | |7;imaging-desaturate;95;96;94;95;95;95;95;95;95;95 00:11:38 INFO - PROCESS | 25774 | |8;json-parse-financial;58;56;55;55;57;56;56;56;56;55 00:11:38 INFO - PROCESS | 25774 | |9;json-stringify-tinderbox;61;61;61;60;62;61;61;61;61;63 00:11:38 INFO - PROCESS | 25774 | |10;stanford-crypto-aes;84;80;79;79;80;79;80;79;109;81 00:11:38 INFO - PROCESS | 25774 | |11;stanford-crypto-ccm;132;121;127;132;123;118;127;128;130;142 00:11:38 INFO - PROCESS | 25774 | |12;stanford-crypto-pbkdf2;159;162;166;159;157;161;158;162;159;159 00:11:38 INFO - PROCESS | 25774 | |13;stanford-crypto-sha256-iterative;63;63;70;62;63;63;64;64;63;61 00:11:38 INFO - PROCESS | 25774 | __end_tp_report 00:11:38 INFO - PROCESS | 25774 | __start_cc_report 00:11:38 INFO - PROCESS | 25774 | _x_x_mozilla_cycle_collect,1643 00:11:38 INFO - PROCESS | 25774 | __end_cc_report 00:11:38 INFO - PROCESS | 25774 | __startTimestamp1465456298318__endTimestamp 00:11:38 INFO - PROCESS | 25774 | 00:11:38 INFO - PROCESS | 25774 | ------- Summary: start ------- 00:11:38 INFO - PROCESS | 25774 | Number of tests: 14 00:11:38 INFO - PROCESS | 25774 | 00:11:38 INFO - PROCESS | 25774 | [#0] ai-astar Cycles:10 Average:110.70 Median:112.00 stddev:1.89 (1.7%) stddev-sans-first:1.94 00:11:38 INFO - PROCESS | 25774 | Values: 112.0 106.0 111.0 112.0 110.0 112.0 110.0 110.0 112.0 112.0 00:11:38 INFO - PROCESS | 25774 | 00:11:38 INFO - PROCESS | 25774 | [#1] audio-beat-detection Cycles:10 Average:140.80 Median:138.50 stddev:18.85 (13.6%) stddev-sans-first:19.90 00:11:38 INFO - PROCESS | 25774 | Values: 146.0 126.0 130.0 177.0 126.0 127.0 156.0 131.0 164.0 125.0 00:11:38 INFO - PROCESS | 25774 | 00:11:38 INFO - PROCESS | 25774 | [#2] audio-dft Cycles:10 Average:161.80 Median:161.50 stddev:2.30 (1.4%) stddev-sans-first:2.42 00:11:38 INFO - PROCESS | 25774 | Values: 161.0 160.0 168.0 162.0 161.0 162.0 162.0 160.0 161.0 161.0 00:11:38 INFO - PROCESS | 25774 | 00:11:38 INFO - PROCESS | 25774 | [#3] audio-fft Cycles:10 Average:82.40 Median:75.00 stddev:16.06 (21.4%) stddev-sans-first:16.75 00:11:38 INFO - PROCESS | 25774 | Values: 74.0 75.0 75.0 120.0 76.0 76.0 74.0 75.0 104.0 75.0 00:11:38 INFO - PROCESS | 25774 | 00:11:38 INFO - PROCESS | 25774 | [#4] audio-oscillator Cycles:10 Average:96.20 Median:85.00 stddev:18.23 (21.4%) stddev-sans-first:18.95 00:11:38 INFO - PROCESS | 25774 | Values: 86.0 84.0 115.0 85.0 85.0 85.0 120.0 85.0 86.0 131.0 00:11:38 INFO - PROCESS | 25774 | 00:11:38 INFO - PROCESS | 25774 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 00:11:38 INFO - PROCESS | 25774 | Values: 117.0 116.0 116.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 00:11:38 INFO - PROCESS | 25774 | 00:11:38 INFO - PROCESS | 25774 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 00:11:38 INFO - PROCESS | 25774 | Values: 146.0 145.0 145.0 146.0 147.0 147.0 145.0 146.0 147.0 146.0 00:11:38 INFO - PROCESS | 25774 | 00:11:38 INFO - PROCESS | 25774 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 00:11:38 INFO - PROCESS | 25774 | Values: 95.0 96.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 00:11:38 INFO - PROCESS | 25774 | 00:11:38 INFO - PROCESS | 25774 | [#8] json-parse-financial Cycles:10 Average:56.00 Median:56.00 stddev:0.94 (1.7%) stddev-sans-first:0.67 00:11:38 INFO - PROCESS | 25774 | Values: 58.0 56.0 55.0 55.0 57.0 56.0 56.0 56.0 56.0 55.0 00:11:38 INFO - PROCESS | 25774 | 00:11:38 INFO - PROCESS | 25774 | [#9] json-stringify-tinderbox Cycles:10 Average:61.20 Median:61.00 stddev:0.79 (1.3%) stddev-sans-first:0.83 00:11:38 INFO - PROCESS | 25774 | Values: 61.0 61.0 61.0 60.0 62.0 61.0 61.0 61.0 61.0 63.0 00:11:38 INFO - PROCESS | 25774 | 00:11:38 INFO - PROCESS | 25774 | [#10] stanford-crypto-aes Cycles:10 Average:83.00 Median:80.00 stddev:9.26 (11.6%) stddev-sans-first:9.82 00:11:38 INFO - PROCESS | 25774 | Values: 84.0 80.0 79.0 79.0 80.0 79.0 80.0 79.0 109.0 81.0 00:11:38 INFO - PROCESS | 25774 | 00:11:38 INFO - PROCESS | 25774 | [#11] stanford-crypto-ccm Cycles:10 Average:128.00 Median:129.00 stddev:6.73 (5.2%) stddev-sans-first:6.98 00:11:38 INFO - PROCESS | 25774 | Values: 132.0 121.0 127.0 132.0 123.0 118.0 127.0 128.0 130.0 142.0 00:11:38 INFO - PROCESS | 25774 | 00:11:38 INFO - PROCESS | 25774 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.20 Median:160.00 stddev:2.62 (1.6%) stddev-sans-first:2.74 00:11:38 INFO - PROCESS | 25774 | Values: 159.0 162.0 166.0 159.0 157.0 161.0 158.0 162.0 159.0 159.0 00:11:38 INFO - PROCESS | 25774 | 00:11:38 INFO - PROCESS | 25774 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.60 Median:63.00 stddev:2.41 (3.8%) stddev-sans-first:2.55 00:11:38 INFO - PROCESS | 25774 | Values: 63.0 63.0 70.0 62.0 63.0 63.0 64.0 64.0 63.0 61.0 00:11:38 INFO - PROCESS | 25774 | -------- Summary: end -------- 00:11:38 INFO - PROCESS | 25774 | 00:11:39 INFO - TEST-INFO | 25774: exit 0 00:11:39 INFO - TEST-OK | kraken | took 60853ms 00:11:39 INFO - SUITE-END | took 1172s 00:11:39 INFO - Completed test suite (00:19:33) 00:11:39 INFO - javascript benchmark 00:11:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3130.373925214956, 3138.419392412404, 3159.510275907234, 3171.286460546376, 3195.760317976151, 5157.664751791141, 5196.974015129928, 5198.376194856618, 5291.444398338172, 5327.067763141449, 5248.291480650111, 5272.630915835893, 5296.947030529694, 5318.0, 5376.892462150755, 4760.952390476085, 4826.686265392756, 4846.127697014536, 4851.296561998508, 4984.576311013569, 4877.268409738532, 4890.24201248807, 4895.363602731658, 4948.257761335793, 4970.726610036447, 4727.149113159629, 4743.264793956942, 4752.596029337493, 4765.904681906342, 4775.164346239429, 4779.928301075487, 4788.186008378584, 4790.760461976922, 4802.68782529138, 4897.0, 4804.543568361035, 4822.397200349957, 4851.029794041206, 4865.732384718839, 4895.902081958377, 5089.898202035975, 5173.042987047408, 5259.8422047338645, 5278.155495120763, 5279.70961597112, 5708.372079071299, 5714.399988001242, 5720.427957204288, 5731.226284451629, 5744.195812586241, 5758.971205143989, 5780.653160810365, 5800.419958004208, 5802.21670074543, 5803.9709801451145, 5115.590752739772, 5226.085435048889, 5288.629795914288, 5295.470452954673, 5364.785408583691, 5852.590318677737, 5861.794837180678, 5864.70676466175, 5865.6480611162615, 5866.970665146647, 5438.945610543923, 5645.491905728504, 5660.745266463019, 5662.320521537442, 5663.773449061991, 5633.8309850704545, 5688.089905615082, 5691.3170419549915, 5722.799702010409, 5724.856878577985, 5683.886322273532, 5686.943130568641, 5692.516136128475, 5696.0, 5696.686682232434, 5461.617686761968, 5573.191887176336, 5693.345265294462, 5703.54371650267, 5705.429457054262, 4284.742915425085, 4306.354046892991, 4319.589638984291, 4354.216241076637, 4377.0808130293, 3847.461355410245, 3849.7882616455804, 3860.6332398422664, 3880.84476620932, 3885.708571857122, 5164.173732202829, 5170.8190213343105, 5295.894082118336, 5355.357357117093, 5413.756380962866, 5639.830805075854, 5677.687727174963, 5682.318121825408, 5703.17303990919, 5727.140928860705, 5369.48989845964, 5371.919421208685, 5372.70450125239, 5374.516293533523, 5378.650387724785, 4760.166970780169, 4832.9275060874115, 4915.852524424273, 4917.557419832232, 4950.8762280943265, 5742.454466825729, 5805.0, 5807.0998995155815, 5813.098969659625, 5867.9413205867395, 5678.0, 5692.857678558069, 5693.572982026448, 5693.629914055573, 5697.487226149667, 5648.887022259614, 5734.05388110957, 5766.163906233656, 5808.273965754281, 5821.214136091573, 5610.13042978339, 5625.662460252398, 5627.352854421794, 5640.0, 5678.233438485751, 5696.686682232517, 5723.685197314021, 5727.198192253005, 5740.253767010429, 5746.942530574808, 5419.078756611307, 5451.563874890078, 5467.644603100785, 5506.862328441821, 5526.751296191762, 5522.282103326542, 5525.4474552546035, 5532.529734972572, 5538.529225015919, 5540.75066622011, 5383.08487557124, 5421.972890135524, 5428.104362780097, 5458.181272809111, 5503.862403439946, 5410.026195284887, 5436.0, 5488.588355873405, 5510.0, 5586.692731899622, 5433.076377015837, 5435.728213589226, 5436.266104075899, 5436.510714035756, 5480.561555075664], "value": 5226.666806719545, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [595.5622617376227, 609.5306613907292, 620.2123303404676, 631.5673763472021, 632.7500637248285, 31638.36723265536, 43152.568474315245, 44510.77744611273, 44549.331760023626, 44579.0, 47501.76249118758, 47822.0, 47912.2813157802, 47920.281195782, 47962.28056579154, 8950.910490895089, 9091.63633454661, 9102.63589456421, 9103.590338434786, 9105.180533751962, 8975.730728078168, 9018.0, 9022.413543119676, 9032.14194651507, 9067.682631107913, 9013.819723605524, 9080.0, 9094.54527273637, 9100.453972761623, 9100.590473428678, 8990.505522196276, 9086.227670647937, 9098.863517047183, 9102.77243068922, 9112.589933453011, 8838.734837954871, 8871.911280887172, 8877.0, 8885.42244754089, 8939.41893776909, 42637.786811065744, 42951.78524107391, 43004.0, 43128.0, 43132.70601881949, 3520.190356218084, 3981.28336899358, 4148.91702165958, 4209.452771139732, 4243.257429949746, 32112.197195070312, 32839.3432131356, 33129.0, 33175.502367464505, 34183.48724769131, 4045.110075783323, 4194.958050419517, 4208.789560521962, 4278.187144442577, 4313.698041137121, 346589.0, 348583.2570837155, 350391.0, 350425.0, 350758.0, 58781.118283225784, 58831.70584147052, 59028.704856475444, 59273.0, 59317.0, 63825.680871595345, 64336.35663643397, 64455.67772161203, 64467.67766161139, 64545.0, 16951.15244237808, 17138.31446742116, 17263.3957811476, 17263.827361726475, 17358.13209339528, 13198.60404187876, 13245.072844900957, 13339.933300333436, 13407.664808379868, 13515.0, 15855.603609909844, 17359.30562777475, 17535.0, 17573.297068117132, 17606.295748170185, 6412.903806442907, 6421.935780642228, 6458.38645328693, 6502.902456463157, 6747.05541224229, 999.1806718490768, 1058.296233005043, 1127.3010733345213, 1138.292065697405, 1146.8932480156689, 32122.518162227585, 32126.678733212837, 32383.676163238066, 32756.34487310288, 33221.3355732884, 1123.9213255072066, 1185.4902391971534, 1199.9700007499882, 1201.2312120243053, 1269.695273134441, 16966.660666786596, 17462.82537174612, 17478.475645730396, 17908.641827163385, 18140.223521780073, 459061.0, 462971.0, 463029.0, 464584.0, 607919.0, 60899.391006090256, 60966.085508717406, 61222.38777612256, 61296.0, 61308.38691613116, 1278.4822147030468, 1382.5092092307286, 1418.0, 1430.742466356066, 1434.5552878607666, 29775.404491910474, 33823.154421138686, 33976.490352644236, 34002.65997339995, 34727.47908781421, 52438.0, 52927.0, 53013.469865302395, 53064.73467632637, 53104.46895530995, 427507.0, 430796.0, 431153.0, 431323.0, 431823.0, 27473.977862434716, 27706.307342316602, 28640.849506554678, 28642.85678571594, 29763.55354669725, 46475.30287045765, 48328.0, 49502.50497494979, 50412.747936260086, 51335.229971551205, 41806.1638767229, 42300.78849605732, 42330.15339693127, 42401.78799105985, 44164.11671766482, 40960.38559421551, 41564.58435415607, 41854.58145418507, 42270.154596907276, 42840.0, 41514.792426037675, 41690.0, 42477.78761106298, 42498.787506063505, 42718.0, 36046.639533605376, 37832.243355133294, 38078.42882356711, 38114.237715244984, 38209.235815282984, 28174.2956426091, 28556.85721571462, 28564.0, 28779.568306475838, 28827.855860720563], "value": 20485.5991628189, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [375.1484131022579, 376.5312186328022, 380.79056518914626, 385.5084766922174, 386.58056009229983, 18491.630167396645, 19521.609567808635, 19840.60318793625, 20359.59280814383, 20371.796282037158, 18778.342758003473, 18798.15408306626, 19083.236670533162, 19170.90414547929, 19208.807911920878, 5496.7526461309235, 5570.108782594785, 5604.691741954191, 5713.314402271733, 5754.0, 5455.208994695767, 5570.832875013756, 5580.888382232353, 5605.0, 5653.547716182696, 5517.917231241535, 5530.5852061095375, 5534.391216966131, 5904.675242861641, 6190.566660333779, 6296.87406251877, 6300.306966233734, 6314.652694101823, 6346.714397852108, 6347.492200623962, 5410.621256512007, 5578.748956296977, 5592.356878958931, 5598.272224610774, 5602.60781745278, 12798.104132710714, 13095.607131786062, 13104.672383190402, 24538.631920521206, 25784.742152578423, 2356.9410764730846, 2550.4389034412397, 2714.050082471139, 2848.2025032990796, 2861.898169204871, 15096.245187740678, 15679.764803527956, 15973.600659983593, 16052.11713355765, 16322.428714994918, 1943.4072607854598, 2092.0794850265834, 2168.1435832846096, 2234.754177040524, 2369.2418426103654, 92555.53722231346, 94030.0, 94214.52892735493, 96175.9999999993, 101545.0, 17510.64978700419, 18335.81664183341, 18377.632447350978, 18380.540486487946, 18624.255029798926, 31740.365192696478, 32337.838310808766, 32899.0, 32968.175795605304, 32970.835145824596, 9253.95373023144, 9816.312858100007, 10166.186705063577, 10315.381077135396, 10554.155667546731, 8657.091005444463, 8684.56577171139, 8704.173103555153, 8809.867851982226, 8885.911140888638, 8913.955430222808, 8920.330975176757, 8990.460572365679, 8992.640294388282, 9251.90748092524, 3438.449848024354, 3473.4195940847358, 3530.410466393678, 3570.410882204459, 3640.740333809449, 462.66919152805235, 464.28963685561143, 972.873526441558, 1039.594558122333, 1110.3337997201616, 11400.714982125348, 12101.09241806868, 12116.81824772629, 12169.513219471122, 12312.569060082855, 480.6107053286779, 483.6711036495147, 483.9104765618372, 486.68365562384736, 486.9707817530889, 6375.10748495211, 6474.158359413246, 6563.507736919654, 6572.277049524549, 6596.505262105361, 504468.0, 504522.0, 510072.0, 512581.0, 525847.0, 69726.0, 75278.24721752822, 96249.51875240578, 100657.0, 101849.0, 476.91415545201505, 478.40916468161794, 481.1387616167022, 482.73208369354643, 485.5969545277411, 10917.290376125526, 11075.612353567587, 11084.0, 11130.109591232844, 11136.276142050741, 39269.0, 39770.60229397785, 40345.0, 40599.39100913548, 44090.338644920994, 50830.74584627053, 51916.0, 59172.40827591669, 59320.0, 59364.0, 7645.923540764744, 7699.230076992256, 7866.252705993151, 8381.413301068867, 8670.306375490072, 8478.152184781473, 9528.761780955532, 12486.625401237978, 13303.866961330263, 13760.31198440054, 11782.116341274268, 12015.339156346485, 12149.817752733892, 12215.69460763488, 12307.692307692021, 11863.110266730202, 11990.100742444525, 12047.33739644328, 12209.328486933304, 12491.812622810847, 12183.390830458618, 12226.572069977508, 12370.62888113358, 12445.875541244472, 12546.811797822857, 8700.477971321741, 8716.651333946571, 8776.605052772513, 8954.328425367994, 9072.455652660597, 8977.102289771232, 10916.560306317753, 11944.0, 12133.393330333625, 12158.696032599255], "value": 9275.343230159795, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1350.419319692533, 1514.7273490771656, 1526.2521364531378, 1664.3758590528553, 1824.7171688388305, 8315.293200077993, 8668.34987375947, 8679.652813887446, 8893.555322233895, 8905.0, 8748.825023499527, 8942.687005954793, 8954.507502087383, 8955.46267223967, 8955.95522022389, 2033.5119571302855, 2261.2424837679314, 2342.1099982006813, 2371.347879333184, 2401.5797235483806, 2336.6728657987896, 2346.85918844869, 2349.283468542094, 2351.000824649526, 2351.2123438648073, 2334.7781960713705, 2348.7886090251873, 2383.892724827387, 2384.141708984764, 2386.9283921482383, 1940.2433051110079, 2183.770704076065, 2194.967075493869, 2241.12596087526, 2263.7736226377397, 2267.4218074390924, 2306.5963456395066, 2316.6177580699164, 2319.6288593824906, 2320.3734991552355, 8364.289035431995, 8440.53577053268, 8446.408751387406, 8452.0, 8452.070272270046, 5137.974310128426, 5273.736313184364, 5279.102552566034, 5285.2600635911, 5286.04851126797, 3251.349730053999, 3354.3626710924846, 3401.6768407001296, 3426.7258619310396, 3505.3164632896596, 1109.7669489407235, 1162.6221478019677, 1179.097990037622, 1183.9408029598571, 1191.5233906437409, 12051.698707532294, 12393.380330983506, 12410.193337433038, 12423.565175218824, 12435.626931191988, 4485.506594274627, 4600.0, 4648.465426475931, 4705.223638099744, 4707.29390591414, 10583.94708026455, 10591.152707783358, 10609.469526523642, 10610.151187904949, 10618.840717389245, 5164.25118357836, 5224.085784987612, 5226.242194881797, 5229.450907654717, 5231.843044708665, 4194.433751443577, 4699.483056863743, 4791.880202994883, 4829.5653391194965, 4897.363342765418, 3930.7248492605245, 3940.330143875548, 3995.0411901143516, 4051.088505086332, 4078.7144899857317, 1216.2216181643755, 1225.5159212111166, 1238.8699186585459, 1248.5193200617828, 1256.2336974445582, 871.0, 986.5807032011367, 988.9159421449258, 1001.8146642871092, 1006.1934820032795, 5861.17943487912, 5952.434518720715, 6019.4883434908525, 6066.363031881677, 6102.847428814315, 477.4795472934518, 480.329939734076, 486.26331108370846, 1037.4553359486179, 1080.152080616712, 4067.7966101694797, 4074.7351422157467, 4112.91774164515, 4113.300738874398, 4116.608922152451, 10689.893101069045, 10800.675979720621, 11015.669529914116, 11027.44862756859, 11027.669169924755, 10754.139668826476, 10761.78476430467, 10798.838017429745, 10843.620473283556, 10872.075873550837, 7993.400494962785, 8127.552984585786, 8140.877886831702, 8145.615245408413, 8145.796355091052, 5832.650040997553, 5859.970700146472, 5866.560007999332, 6044.002739547926, 6113.358097399709, 9875.160611347828, 10014.098731113943, 10119.59521619127, 10207.132393746318, 10259.48702564854, 9932.602695892372, 10226.07965283128, 10281.383117012703, 10297.691069267934, 10304.330218535772, 7694.692212311445, 7865.60671966388, 7891.289783919475, 7941.245581669732, 8015.519068855887, 8707.434016788888, 8727.432716873383, 8768.342374321825, 8773.605187766438, 8810.911890881265, 7673.232676732282, 7889.0, 7897.605119743875, 7983.281504664608, 7983.800404989922, 7585.810354740955, 7612.352949999312, 7634.351080158249, 7748.0, 7821.608919553886, 7123.679434425359, 7171.641417929187, 7189.604571748604, 7192.640367981476, 7200.135983681782, 4816.205326121291, 4909.3372394727685, 5007.198848184273, 5091.625261179387, 5100.132977393926, 5233.712145831863, 5404.162354835007, 5405.567554595545, 5455.18172274162, 5486.149646804752], "value": 4612.495076496284, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [320.82996012113574, 330.88088288216244, 336.20990671920987, 338.33179470545673, 340.88580325590925, 5254.395744489385, 5283.07546179418, 5298.251576979597, 5314.627976041678, 5317.946820531798, 5228.588281164083, 5266.552343050846, 5269.473052694729, 5292.3913749918775, 5297.682139071659, 4081.2245673322122, 4168.353905144708, 4168.395582640515, 4175.958240417603, 4182.22628813669, 4126.205100781155, 4157.334826427772, 4171.0, 4182.2890108681595, 4191.685623578229, 4151.958480415203, 4156.210320039183, 4159.334506478964, 4162.0, 4162.708610397273, 3921.8039098044983, 3941.467901833259, 4071.470708807866, 4090.427340172378, 4144.378343248522, 3608.6030536640947, 3617.8733744318824, 3618.6381361863864, 3620.981895090534, 3630.43728222126, 5073.518015788531, 5085.923711144335, 5089.854782673906, 5093.5415812576675, 5108.591312694975, 4312.805923733439, 4453.732776033448, 4569.1318649456825, 4608.861734147981, 4626.791794369262, 5386.973065134688, 5408.918216356705, 5412.2152287918425, 5412.756425960842, 5414.242006119146, 3958.2083583283456, 3963.9405408918888, 3964.7621142731527, 3976.741511801724, 3980.5024371953505, 5505.421930697259, 5623.803166889139, 5638.746256418471, 5642.210090587321, 5646.491815736604, 4043.8584649537124, 4044.3933409988736, 4050.4734384529825, 4054.7430296608145, 4067.613576710208, 4113.670906327487, 4121.26906699187, 4141.399497072907, 4143.440635514227, 4146.91706165875, 4405.449318835145, 4606.792694328763, 4626.0, 4650.279206722963, 4687.10944920464, 5490.396056433789, 5522.502974732293, 5524.309461317335, 5525.723713814293, 5531.585131115183, 1396.9243682364522, 1404.5505438259659, 1412.0045368015524, 1415.0, 1419.2974477633638, 918.4810582021137, 919.3656377099913, 924.1867156901883, 961.403929563675, 966.2415004221792, 5206.193040078794, 5246.422893481714, 5262.60530460217, 5296.7351632418995, 5299.417064122943, 5483.506484416342, 5510.201020851954, 5533.446655334515, 5534.398832548695, 5552.472515111058, 5059.848204553869, 5112.514311140436, 5176.301199338116, 5203.453637368098, 5375.489328513785, 2904.4626744052416, 2952.660444048919, 2994.2215024093894, 2994.8652310646075, 3012.8041677290908, 5789.623674461231, 5800.274965629296, 5823.767049318065, 5830.7959221427045, 5876.559258055578, 5538.141588053858, 5731.197632331477, 5746.88506229873, 5748.913766293509, 5770.4806567408295, 5710.2862142232225, 5754.884902302014, 5784.582777219608, 5789.160571716993, 5809.215755872988, 5379.4351593082165, 5603.719814009201, 5613.719314034201, 5627.296587926509, 5666.0, 5514.53864725856, 5526.640768350045, 5537.0, 5556.694381809039, 5564.944350556442, 5707.714614269353, 5745.322993284385, 5747.224124743273, 5784.161296611884, 5810.389909059488, 3604.143566383944, 3655.177585043344, 3665.6253904785704, 3690.8339124739987, 3704.999300377766, 5044.470330615232, 5057.418396884405, 5059.6844820347715, 5067.771950262173, 5106.47229621325, 4909.410870695397, 4916.11509928202, 4918.5573298403315, 4929.383827021622, 4969.204927211629, 4566.954330456653, 4872.733089396853, 4914.852554423373, 4940.333055037668, 4959.82640607577, 4777.737224452689, 4785.617150628011, 4828.396450443694, 4842.6368022399165, 4870.733609261689, 4922.310876477368, 4973.5523802857915, 4974.502549744997, 4981.402231732215, 4988.376452943382, 4842.83050093245, 4864.537868902448, 4872.683275587217, 5024.487756121939, 5430.0], "value": 4108.705912133654, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [705.3369832357583, 725.6335550546974, 744.6797876912927, 755.4787196834184, 820.7537738678395, 14252.0, 15277.465288714911, 15284.0, 16800.24398902049, 17530.912345438286, 14940.402383904659, 15666.921665391657, 15730.606734831606, 15827.683446331066, 15865.920670396632, 687.5565260407035, 808.1433680298873, 818.4148333941231, 823.3454403749034, 823.8764185372212, 831.8086840026798, 839.9790005249887, 840.3487297344576, 840.6385254340631, 840.8570543007672, 872.4242000279817, 880.6917578847416, 881.0044649546004, 881.5107615273521, 881.6914080071956, 720.9855802883939, 826.3265438667466, 850.1286181663844, 875.6978842299396, 877.8770972063884, 614.6557927560581, 621.0125899819309, 621.2327775197627, 621.2948303675361, 621.6270237857294, 14876.0, 14898.329575169144, 14916.850831491654, 14926.776098358534, 14933.17867517297, 13884.4446222151, 13906.165630062127, 14002.159870407706, 14141.575752727435, 14220.146791192561, 12625.747485050248, 12748.681282967907, 12850.550230741972, 12987.935060324638, 13067.0, 4374.409454723604, 4430.800613972379, 4460.531644177379, 4500.954990450086, 4558.49856515783, 73624.63187684027, 74068.0, 74309.0, 74745.0, 75898.0, 11312.264702794291, 11345.94327028376, 11533.135014873918, 11787.351695656822, 11854.94072529632, 22124.668129978065, 22217.0, 22287.888560557094, 22391.21630742916, 22397.66403503949, 8438.240558349778, 8453.0, 8491.532965686823, 8538.70114545988, 8545.359098067669, 4315.1585440838735, 4349.695521313541, 4621.976890115595, 4646.525077275927, 4834.0, 3397.0997685613333, 3519.0, 3526.8765593204116, 3529.9294014119573, 3537.20412907099, 616.051281027222, 620.2433031701318, 627.8085184018827, 635.6218050260088, 635.6567453575018, 614.088079202384, 614.4408588184731, 628.9433950944436, 679.1103654212997, 693.3943493832094, 9205.86191207119, 9938.349918724847, 10247.180225581935, 10274.126699230499, 10573.682789516326, 605.4429924469499, 649.3409189672486, 693.2339764560189, 744.2594618354772, 778.7274453941076, 4413.337999300131, 4541.227991241497, 4640.69835460694, 4804.8318308859025, 4923.384576927884, 106040.46979765051, 107727.46136269269, 108424.45787771011, 111241.0, 112297.0, 77821.61089194518, 82750.58624706959, 91270.08729912748, 96213.03786962181, 96370.51814740882, 65948.67025664936, 68230.31769682339, 80861.59569202116, 89037.55481222682, 90413.09586904047, 10159.949200253952, 10404.739881503023, 10494.317869338469, 10536.52585633633, 10550.366977981346, 50296.0, 51402.74298628483, 52177.7391113042, 52347.738261309976, 52469.21296180484, 62983.37016629775, 64528.6773566148, 73896.63051684707, 75045.24954750383, 76517.61741191258, 13143.211407315592, 13296.468141274241, 13411.061225714106, 13689.247091410069, 13723.451061957809, 14754.262286885398, 14757.335919883846, 14763.006295725623, 14987.100773953598, 15055.096694198382, 13491.730165396833, 13616.533864541832, 13762.518311859038, 14202.508736582924, 14289.356978935764, 13635.454581816617, 13809.249244472545, 13985.44058237659, 14065.929670351992, 14170.721272001847, 13257.339241024605, 13570.86429135696, 13900.304984750925, 14047.227402492552, 14160.78758818598, 11136.944315278372, 11616.419179041182, 11624.535018599161, 11848.703782405164, 11893.76212475763, 11595.594154204562, 11659.475323610628, 11688.18182727201, 11844.644660660195, 11908.464119114487], "value": 7591.430369848954, "unit": "score"}], "name": "dromaeo_css", "value": 7230.516262834534, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 106.0, 111.0, 112.0, 110.0, 112.0, 110.0, 110.0, 112.0, 112.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 126.0, 130.0, 177.0, 126.0, 127.0, 156.0, 131.0, 164.0, 125.0], "value": 140.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 168.0, 162.0, 161.0, 162.0, 162.0, 160.0, 161.0, 161.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 120.0, 76.0, 76.0, 74.0, 75.0, 104.0, 75.0], "value": 82.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 115.0, 85.0, 85.0, 85.0, 120.0, 85.0, 86.0, 131.0], "value": 96.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 145.0, 146.0, 147.0, 147.0, 145.0, 146.0, 147.0, 146.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 56.0, 55.0, 55.0, 57.0, 56.0, 56.0, 56.0, 56.0, 55.0], "value": 56.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 60.0, 62.0, 61.0, 61.0, 61.0, 61.0, 63.0], "value": 61.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 80.0, 79.0, 79.0, 80.0, 79.0, 80.0, 79.0, 109.0, 81.0], "value": 83.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 121.0, 127.0, 132.0, 123.0, 118.0, 127.0, 128.0, 130.0, 142.0], "value": 128.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 162.0, 166.0, 159.0, 157.0, 161.0, 158.0, 162.0, 159.0, 159.0], "value": 160.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 70.0, 62.0, 63.0, 63.0, 64.0, 64.0, 63.0, 61.0], "value": 63.6, "unit": "score"}], "name": "kraken", "value": 1501.6000000000001, "alertThreshold": 2.0}]} 00:11:39 INFO - Return code: 0 00:11:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 00:11:39 ERROR - # TBPL SUCCESS # 00:11:39 INFO - Running post-action listener: _resource_record_post_action 00:11:39 INFO - ##### 00:11:39 INFO - ##### Finished run-tests step (success) 00:11:39 INFO - ##### 00:11:39 INFO - Running post-run listener: _resource_record_post_run 00:11:39 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 543973376; Read time: 16; Write time: 484416 00:11:39 INFO - TinderboxPrint: CPU usage
13.2% 00:11:39 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 00:11:39 INFO - TinderboxPrint: I/O write bytes / time
543,973,376 / 484,416 00:11:39 INFO - TinderboxPrint: CPU idle
8,251.0 (86.8%) 00:11:39 INFO - TinderboxPrint: CPU user
1,210.0 (12.7%) 00:11:39 INFO - TinderboxPrint: Swap in / out
0 / 0 00:11:39 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 248016896; Read time: 0; Write time: 231416 00:11:39 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 295264256; Read time: 16; Write time: 252952 00:11:40 INFO - Running post-run listener: _upload_blobber_files 00:11:40 INFO - Blob upload gear active. 00:11:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:11:40 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 00:11:40 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'] 00:11:40 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 00:11:40 INFO - (blobuploader) - INFO - Open directory for files ... 00:11:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 00:11:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:11:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:11:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 00:11:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:11:41 INFO - (blobuploader) - INFO - Done attempting. 00:11:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 00:11:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:11:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:11:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 00:11:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:11:42 INFO - (blobuploader) - INFO - Done attempting. 00:11:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 00:11:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:11:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:11:45 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 00:11:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:11:45 INFO - (blobuploader) - INFO - Done attempting. 00:11:45 INFO - (blobuploader) - INFO - Iteration through files over. 00:11:45 INFO - Return code: 0 00:11:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:11:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:11:45 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/48b7d174774e2afb7690e1cec65559c2130839719a6261960fe1791039f9e13ec03189fa9f91234bdb68438f656310555b51ce0d2c952bf663957065bd5fb1ee", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/83e32eb8a1f612a65cdd09b14f48b54de0711446bc9bb1893d9c841b6597b285c2f85d6201259c0276b322b4023983d9450d149a9d455312af0e7d631bdef4f0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/44c47f3007be690a84aa0ec72cd9184b1e210490a67de7b6b9fc1ba7c418c6c5a67e75d0ba191ff99ae5bda4e3b5a048ebd27b20b6f01e5a7ee47dca363840ea"} 00:11:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:11:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:11:45 INFO - Contents: 00:11:45 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/48b7d174774e2afb7690e1cec65559c2130839719a6261960fe1791039f9e13ec03189fa9f91234bdb68438f656310555b51ce0d2c952bf663957065bd5fb1ee", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/83e32eb8a1f612a65cdd09b14f48b54de0711446bc9bb1893d9c841b6597b285c2f85d6201259c0276b322b4023983d9450d149a9d455312af0e7d631bdef4f0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/44c47f3007be690a84aa0ec72cd9184b1e210490a67de7b6b9fc1ba7c418c6c5a67e75d0ba191ff99ae5bda4e3b5a048ebd27b20b6f01e5a7ee47dca363840ea"} 00:11:45 INFO - Running post-run listener: copy_logs_to_upload_dir 00:11:45 INFO - Copying logs to upload dir... 00:11:45 INFO - mkdir: /builds/slave/test/build/upload/logs 00:11:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.508866 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-06-09 00:11:45.695858) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 00:11:45.699691) ========= 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=4ac8d263c7293b36a1be1aed000001be-1465452373.611600-1220652694 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/48b7d174774e2afb7690e1cec65559c2130839719a6261960fe1791039f9e13ec03189fa9f91234bdb68438f656310555b51ce0d2c952bf663957065bd5fb1ee", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/83e32eb8a1f612a65cdd09b14f48b54de0711446bc9bb1893d9c841b6597b285c2f85d6201259c0276b322b4023983d9450d149a9d455312af0e7d631bdef4f0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/44c47f3007be690a84aa0ec72cd9184b1e210490a67de7b6b9fc1ba7c418c6c5a67e75d0ba191ff99ae5bda4e3b5a048ebd27b20b6f01e5a7ee47dca363840ea"} build_url:https://queue.taskcluster.net/v1/task/DeMSWSJQQU61QRdZfTiD5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011762 build_url: 'https://queue.taskcluster.net/v1/task/DeMSWSJQQU61QRdZfTiD5Q/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/48b7d174774e2afb7690e1cec65559c2130839719a6261960fe1791039f9e13ec03189fa9f91234bdb68438f656310555b51ce0d2c952bf663957065bd5fb1ee", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/83e32eb8a1f612a65cdd09b14f48b54de0711446bc9bb1893d9c841b6597b285c2f85d6201259c0276b322b4023983d9450d149a9d455312af0e7d631bdef4f0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/44c47f3007be690a84aa0ec72cd9184b1e210490a67de7b6b9fc1ba7c418c6c5a67e75d0ba191ff99ae5bda4e3b5a048ebd27b20b6f01e5a7ee47dca363840ea"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 00:11:45.725390) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 00:11:45.725720) ========= 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=4ac8d263c7293b36a1be1aed000001be-1465452373.611600-1220652694 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004402 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 00:11:45.809130) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 00:11:45.809457) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 00:11:45.809739) ========= ========= Total master_lag: 0.20 =========