builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-027 starttime: 1464967262.46 results: success (0) buildid: 20160603053007 builduid: 7cb7edd069bb4d71b98cd12dd7c2799a revision: 0ef7cc6b42c72be6ef8d0786fb1f5371c11e9e32 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-03 08:21:02.460425) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-03 08:21:02.460927) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-03 08:21:02.461247) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-03 08:21:02.549329) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 08:21:02.549661) ========= 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=1f5564757af27664ca02d71f000001b0-1464966917.239381-2065992589 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-03 08:21:02-- 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% 79.3M=0s 2016-06-03 08:21:03 (79.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.435779 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 08:21:03.018416) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 08:21:03.019314) ========= 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=1f5564757af27664ca02d71f000001b0-1464966917.239381-2065992589 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019789 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 08:21:03.074047) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-03 08:21:03.074407) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 0ef7cc6b42c72be6ef8d0786fb1f5371c11e9e32 --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 0ef7cc6b42c72be6ef8d0786fb1f5371c11e9e32 --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=1f5564757af27664ca02d71f000001b0-1464966917.239381-2065992589 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-03 08:21:03,134 truncating revision to first 12 chars 2016-06-03 08:21:03,134 Setting DEBUG logging. 2016-06-03 08:21:03,134 attempt 1/10 2016-06-03 08:21:03,135 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/0ef7cc6b42c7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-03 08:21:03,789 unpacking tar archive at: fx-team-0ef7cc6b42c7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.986989 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-03 08:21:04.077472) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-03 08:21:04.077980) ========= script_repo_revision: 0ef7cc6b42c72be6ef8d0786fb1f5371c11e9e32 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-03 08:21:04.078638) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-03 08:21:04.079182) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-03 08:21:04.096117) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2016-06-03 08:21:04.096440) ========= /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=1f5564757af27664ca02d71f000001b0-1464966917.239381-2065992589 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:21:04 INFO - MultiFileLogger online at 20160603 08:21:04 in /builds/slave/test 08:21:04 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 08:21:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:21:04 INFO - {'append_to_log': False, 08:21:04 INFO - 'base_work_dir': '/builds/slave/test', 08:21:04 INFO - 'blob_upload_branch': 'Fx-Team', 08:21:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:21:04 INFO - 'branch': 'Fx-Team', 08:21:04 INFO - 'buildbot_json_path': 'buildprops.json', 08:21:04 INFO - 'config_files': ('talos/linux_config.py',), 08:21:04 INFO - 'default_actions': ('clobber', 08:21:04 INFO - 'read-buildbot-config', 08:21:04 INFO - 'download-and-extract', 08:21:04 INFO - 'populate-webroot', 08:21:04 INFO - 'create-virtualenv', 08:21:04 INFO - 'install', 08:21:04 INFO - 'run-tests'), 08:21:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:21:04 INFO - 'download_minidump_stackwalk': True, 08:21:04 INFO - 'download_symbols': 'ondemand', 08:21:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:21:04 INFO - 'tooltool.py': '/tools/tooltool.py', 08:21:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:21:04 INFO - '/tools/misc-python/virtualenv.py')}, 08:21:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:21:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:21:04 INFO - 'installer_path': 'installer.exe', 08:21:04 INFO - 'log_level': 'info', 08:21:04 INFO - 'log_name': 'talos', 08:21:04 INFO - 'log_to_console': True, 08:21:04 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:21:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:21:04 INFO - 'opt_config_files': (), 08:21:04 INFO - 'pip_index': False, 08:21:04 INFO - 'sps_profile': False, 08:21:04 INFO - 'sps_profile_interval': 0, 08:21:04 INFO - 'suite': 'dromaeojs', 08:21:04 INFO - 'system_bits': '32', 08:21:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:21:04 INFO - 'title': 'talos-linux64-ix-027', 08:21:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:21:04 INFO - 'use_talos_json': True, 08:21:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:21:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:21:04 INFO - 'work_dir': 'build'} 08:21:04 INFO - ##### 08:21:04 INFO - ##### Running clobber step. 08:21:04 INFO - ##### 08:21:04 INFO - Running pre-action listener: _resource_record_pre_action 08:21:04 INFO - Running main action method: clobber 08:21:04 INFO - rmtree: /builds/slave/test/build 08:21:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:21:04 INFO - Running post-action listener: _resource_record_post_action 08:21:04 INFO - ##### 08:21:04 INFO - ##### Finished clobber step (success) 08:21:04 INFO - ##### 08:21:04 INFO - ##### 08:21:04 INFO - ##### Running read-buildbot-config step. 08:21:04 INFO - ##### 08:21:04 INFO - Running pre-action listener: _resource_record_pre_action 08:21:04 INFO - Running main action method: read_buildbot_config 08:21:04 INFO - Using buildbot properties: 08:21:04 INFO - { 08:21:04 INFO - "project": "", 08:21:04 INFO - "product": "firefox", 08:21:04 INFO - "script_repo_revision": "production", 08:21:04 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:21:04 INFO - "repository": "", 08:21:04 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 08:21:04 INFO - "buildid": "20160603053007", 08:21:04 INFO - "pgo_build": "True", 08:21:04 INFO - "basedir": "/builds/slave/test", 08:21:04 INFO - "buildnumber": 1219, 08:21:04 INFO - "slavename": "talos-linux64-ix-027", 08:21:04 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:21:04 INFO - "platform": "ubuntu64_hw", 08:21:04 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:21:04 INFO - "branch": "fx-team", 08:21:04 INFO - "repo_path": "integration/fx-team", 08:21:04 INFO - "revision": "0ef7cc6b42c72be6ef8d0786fb1f5371c11e9e32", 08:21:04 INFO - "stage_platform": "linux64-pgo", 08:21:04 INFO - "builduid": "7cb7edd069bb4d71b98cd12dd7c2799a", 08:21:04 INFO - "slavebuilddir": "test" 08:21:04 INFO - } 08:21:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/WP2Ilp0jQ4eDbNgq8ejirw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 08:21:04 INFO - Running post-action listener: _resource_record_post_action 08:21:04 INFO - ##### 08:21:04 INFO - ##### Finished read-buildbot-config step (success) 08:21:04 INFO - ##### 08:21:04 INFO - ##### 08:21:04 INFO - ##### Running download-and-extract step. 08:21:04 INFO - ##### 08:21:04 INFO - Running pre-action listener: _resource_record_pre_action 08:21:04 INFO - Running main action method: download_and_extract 08:21:04 INFO - mkdir: /builds/slave/test/build/tests 08:21:04 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')]} 08:21:04 INFO - https://queue.taskcluster.net/v1/task/WP2Ilp0jQ4eDbNgq8ejirw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:21:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WP2Ilp0jQ4eDbNgq8ejirw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:21:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WP2Ilp0jQ4eDbNgq8ejirw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:21:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WP2Ilp0jQ4eDbNgq8ejirw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:21:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WP2Ilp0jQ4eDbNgq8ejirw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:21:13 INFO - Downloaded 1361 bytes. 08:21:13 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:21:13 INFO - Using the following test package requirements: 08:21:13 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 08:21:13 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:21:13 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:21:13 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:21:13 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:21:13 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:21:13 INFO - u'jsshell-linux-x86_64.zip'], 08:21:13 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:21:13 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:21:13 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 08:21:13 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:21:13 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:21:13 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:21:13 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:21:13 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:21:13 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:21:13 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:21:13 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:21:13 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:21:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:13 INFO - https://queue.taskcluster.net/v1/task/WP2Ilp0jQ4eDbNgq8ejirw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:21:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WP2Ilp0jQ4eDbNgq8ejirw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:21:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WP2Ilp0jQ4eDbNgq8ejirw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:21:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WP2Ilp0jQ4eDbNgq8ejirw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:21:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WP2Ilp0jQ4eDbNgq8ejirw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:21:22 INFO - Downloaded 24440968 bytes. 08:21:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:21:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:21:23 INFO - Return code: 0 08:21:23 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:21:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:23 INFO - https://queue.taskcluster.net/v1/task/WP2Ilp0jQ4eDbNgq8ejirw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:21:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WP2Ilp0jQ4eDbNgq8ejirw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:21:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WP2Ilp0jQ4eDbNgq8ejirw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:21:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WP2Ilp0jQ4eDbNgq8ejirw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:21:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WP2Ilp0jQ4eDbNgq8ejirw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:21:26 INFO - Downloaded 24440968 bytes. 08:21:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:21:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:21:28 INFO - Return code: 0 08:21:28 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')]} 08:21:28 INFO - https://queue.taskcluster.net/v1/task/WP2Ilp0jQ4eDbNgq8ejirw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:21:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WP2Ilp0jQ4eDbNgq8ejirw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 08:21:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WP2Ilp0jQ4eDbNgq8ejirw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 08:21:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WP2Ilp0jQ4eDbNgq8ejirw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 08:21:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WP2Ilp0jQ4eDbNgq8ejirw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:21:30 INFO - Downloaded 10833369 bytes. 08:21:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:21:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 08:21:30 INFO - Return code: 0 08:21:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:30 INFO - https://queue.taskcluster.net/v1/task/WP2Ilp0jQ4eDbNgq8ejirw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:21:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WP2Ilp0jQ4eDbNgq8ejirw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:21:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WP2Ilp0jQ4eDbNgq8ejirw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:21:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WP2Ilp0jQ4eDbNgq8ejirw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:21:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WP2Ilp0jQ4eDbNgq8ejirw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:21:32 INFO - Downloaded 59155860 bytes. 08:21:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WP2Ilp0jQ4eDbNgq8ejirw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:21:32 INFO - mkdir: /builds/slave/test/properties 08:21:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:21:32 INFO - Writing to file /builds/slave/test/properties/build_url 08:21:32 INFO - Contents: 08:21:32 INFO - build_url:https://queue.taskcluster.net/v1/task/WP2Ilp0jQ4eDbNgq8ejirw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:21:33 INFO - Running post-action listener: _resource_record_post_action 08:21:33 INFO - Running post-action listener: set_extra_try_arguments 08:21:33 INFO - ##### 08:21:33 INFO - ##### Finished download-and-extract step (success) 08:21:33 INFO - ##### 08:21:33 INFO - ##### 08:21:33 INFO - ##### Running populate-webroot step. 08:21:33 INFO - ##### 08:21:33 INFO - Running pre-action listener: _resource_record_pre_action 08:21:33 INFO - Running main action method: populate_webroot 08:21:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:21:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:21:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:21:33 INFO - '--tppagecycles', 08:21:33 INFO - '7'], 08:21:33 INFO - 'tests': ['tsvgm']}}, 08:21:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:21:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:21:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:21:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:21:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:21:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:21:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:21:33 INFO - 'talos_options': ['--disable-e10s'], 08:21:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:21:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:21:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:21:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:21:33 INFO - 'talos_options': ['--disable-e10s'], 08:21:33 INFO - 'tests': ['damp', 'tps']}, 08:21:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:21:33 INFO - 'tests': ['damp', 'tps']}, 08:21:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:21:33 INFO - 'tests': ['dromaeo_dom']}, 08:21:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:21:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:21:33 INFO - 'tests': ['a11yr', 08:21:33 INFO - 'ts_paint', 08:21:33 INFO - 'tpaint', 08:21:33 INFO - 'sessionrestore', 08:21:33 INFO - 'sessionrestore_no_auto_restore', 08:21:33 INFO - 'tabpaint']}, 08:21:33 INFO - 'other-e10s': {'tests': ['a11yr', 08:21:33 INFO - 'ts_paint', 08:21:33 INFO - 'tpaint', 08:21:33 INFO - 'sessionrestore', 08:21:33 INFO - 'sessionrestore_no_auto_restore', 08:21:33 INFO - 'tabpaint']}, 08:21:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:21:33 INFO - 'ts_paint', 08:21:33 INFO - 'tpaint', 08:21:33 INFO - 'sessionrestore', 08:21:33 INFO - 'sessionrestore_no_auto_restore', 08:21:33 INFO - 'tabpaint']}, 08:21:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:21:33 INFO - 'ts_paint', 08:21:33 INFO - 'tpaint', 08:21:33 INFO - 'sessionrestore', 08:21:33 INFO - 'sessionrestore_no_auto_restore', 08:21:33 INFO - 'tabpaint']}, 08:21:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:21:33 INFO - 'tests': ['a11yr', 08:21:33 INFO - 'ts_paint', 08:21:33 INFO - 'tpaint', 08:21:33 INFO - 'sessionrestore', 08:21:33 INFO - 'sessionrestore_no_auto_restore', 08:21:33 INFO - 'tabpaint']}, 08:21:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:21:33 INFO - 'tests': ['a11yr', 08:21:33 INFO - 'ts_paint', 08:21:33 INFO - 'tpaint', 08:21:33 INFO - 'sessionrestore', 08:21:33 INFO - 'sessionrestore_no_auto_restore', 08:21:33 INFO - 'tabpaint']}, 08:21:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:21:33 INFO - 'tests': ['tsvgx', 08:21:33 INFO - 'tsvgr_opacity', 08:21:33 INFO - 'tart', 08:21:33 INFO - 'tscrollx', 08:21:33 INFO - 'cart']}, 08:21:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:21:33 INFO - 'tsvgr_opacity', 08:21:33 INFO - 'tart', 08:21:33 INFO - 'tscrollx', 08:21:33 INFO - 'cart']}, 08:21:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:21:33 INFO - 'talos_options': ['--disable-e10s'], 08:21:33 INFO - 'tests': ['tp5o']}, 08:21:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:21:33 INFO - 'tests': ['tp5o']}, 08:21:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:21:33 INFO - 'talos_options': ['--disable-e10s', 08:21:33 INFO - '--xperf_path', 08:21:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:21:33 INFO - 'tests': ['tp5n']}, 08:21:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:21:33 INFO - 'talos_options': ['--xperf_path', 08:21:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:21:33 INFO - 'tests': ['tp5n']}}, 08:21:33 INFO - 'talos.zip': {'path': '', 08:21:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:21:33 INFO - Running post-action listener: _resource_record_post_action 08:21:33 INFO - ##### 08:21:33 INFO - ##### Finished populate-webroot step (success) 08:21:33 INFO - ##### 08:21:33 INFO - ##### 08:21:33 INFO - ##### Running create-virtualenv step. 08:21:33 INFO - ##### 08:21:33 INFO - Running pre-action listener: _resource_record_pre_action 08:21:33 INFO - Running main action method: create_virtualenv 08:21:33 INFO - Creating virtualenv /builds/slave/test/build/venv 08:21:33 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 08:21:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:21:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:21:34 INFO - Using real prefix '/usr' 08:21:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:21:34 INFO - Installing distribute.............................................................................................................................................................................................done. 08:21:36 INFO - Installing pip.................done. 08:21:36 INFO - Return code: 0 08:21:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:21:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:36 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 0x7fb6fd0c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x190d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19da190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a6c110>, '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 0x19d8230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19d86c0>, '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': '1f5564757af27664ca02d71f000001b0-1464966917.239381-2065992589', '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 08:21:36 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 08:21:36 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 08:21:36 INFO - Using env: {'DISPLAY': ':0', 08:21:36 INFO - 'HOME': '/home/cltbld', 08:21:36 INFO - 'LANG': 'en_US.UTF-8', 08:21:36 INFO - 'LANGUAGE': 'en_US:en', 08:21:36 INFO - 'LOGNAME': 'cltbld', 08:21:36 INFO - 'MAIL': '/var/mail/cltbld', 08:21:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:36 INFO - 'MOZ_NO_REMOTE': '1', 08:21:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:36 INFO - 'NO_EM_RESTART': '1', 08:21:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:36 INFO - 'PWD': '/builds/slave/test', 08:21:36 INFO - 'SHELL': '/bin/bash', 08:21:36 INFO - 'SHLVL': '1', 08:21:36 INFO - 'TERM': 'linux', 08:21:36 INFO - 'TMOUT': '86400', 08:21:36 INFO - 'USER': 'cltbld', 08:21:36 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1464966917.239381-2065992589', 08:21:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:36 INFO - '_': '/tools/buildbot/bin/python'} 08:21:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:37 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 08:21:37 INFO - Cleaning up... 08:21:37 INFO - Return code: 0 08:21:37 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:21: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')]} 08:21:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21: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')]} 08:21:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb6fd0c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x190d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19da190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a6c110>, '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 0x19d8230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19d86c0>, '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': '1f5564757af27664ca02d71f000001b0-1464966917.239381-2065992589', '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 08:21:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:21:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:21:37 INFO - Using env: {'DISPLAY': ':0', 08:21:37 INFO - 'HOME': '/home/cltbld', 08:21:37 INFO - 'LANG': 'en_US.UTF-8', 08:21:37 INFO - 'LANGUAGE': 'en_US:en', 08:21:37 INFO - 'LOGNAME': 'cltbld', 08:21:37 INFO - 'MAIL': '/var/mail/cltbld', 08:21:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:37 INFO - 'MOZ_NO_REMOTE': '1', 08:21:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:37 INFO - 'NO_EM_RESTART': '1', 08:21:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:37 INFO - 'PWD': '/builds/slave/test', 08:21:37 INFO - 'SHELL': '/bin/bash', 08:21:37 INFO - 'SHLVL': '1', 08:21:37 INFO - 'TERM': 'linux', 08:21:37 INFO - 'TMOUT': '86400', 08:21:37 INFO - 'USER': 'cltbld', 08:21:37 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1464966917.239381-2065992589', 08:21:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:37 INFO - '_': '/tools/buildbot/bin/python'} 08:21:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:37 INFO - Downloading/unpacking psutil>=3.1.1 08:21:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:21:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:21:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:21:39 INFO - Installing collected packages: psutil 08:21:39 INFO - Running setup.py install for psutil 08:21:39 INFO - building 'psutil._psutil_linux' extension 08:21:39 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 08:21:40 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 08:21:41 INFO - building 'psutil._psutil_posix' extension 08:21:41 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 08:21:41 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 08:21:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:21:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:21:41 INFO - Successfully installed psutil 08:21:41 INFO - Cleaning up... 08:21:41 INFO - Return code: 0 08:21:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:21:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6fd0c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x190d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19da190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a6c110>, '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 0x19d8230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19d86c0>, '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': '1f5564757af27664ca02d71f000001b0-1464966917.239381-2065992589', '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 08:21:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:21:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:21:41 INFO - Using env: {'DISPLAY': ':0', 08:21:41 INFO - 'HOME': '/home/cltbld', 08:21:41 INFO - 'LANG': 'en_US.UTF-8', 08:21:41 INFO - 'LANGUAGE': 'en_US:en', 08:21:41 INFO - 'LOGNAME': 'cltbld', 08:21:41 INFO - 'MAIL': '/var/mail/cltbld', 08:21:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:41 INFO - 'MOZ_NO_REMOTE': '1', 08:21:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:41 INFO - 'NO_EM_RESTART': '1', 08:21:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:41 INFO - 'PWD': '/builds/slave/test', 08:21:41 INFO - 'SHELL': '/bin/bash', 08:21:41 INFO - 'SHLVL': '1', 08:21:41 INFO - 'TERM': 'linux', 08:21:41 INFO - 'TMOUT': '86400', 08:21:41 INFO - 'USER': 'cltbld', 08:21:41 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1464966917.239381-2065992589', 08:21:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:41 INFO - '_': '/tools/buildbot/bin/python'} 08:21:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:21:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:21:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:21:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:21:43 INFO - Installing collected packages: mozsystemmonitor 08:21:43 INFO - Running setup.py install for mozsystemmonitor 08:21:43 INFO - Successfully installed mozsystemmonitor 08:21:43 INFO - Cleaning up... 08:21:43 INFO - Return code: 0 08:21:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:21:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb6fd0c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x190d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19da190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a6c110>, '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 0x19d8230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19d86c0>, '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': '1f5564757af27664ca02d71f000001b0-1464966917.239381-2065992589', '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 08:21:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:21:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:21:43 INFO - Using env: {'DISPLAY': ':0', 08:21:43 INFO - 'HOME': '/home/cltbld', 08:21:43 INFO - 'LANG': 'en_US.UTF-8', 08:21:43 INFO - 'LANGUAGE': 'en_US:en', 08:21:43 INFO - 'LOGNAME': 'cltbld', 08:21:43 INFO - 'MAIL': '/var/mail/cltbld', 08:21:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:43 INFO - 'MOZ_NO_REMOTE': '1', 08:21:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:43 INFO - 'NO_EM_RESTART': '1', 08:21:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:43 INFO - 'PWD': '/builds/slave/test', 08:21:43 INFO - 'SHELL': '/bin/bash', 08:21:43 INFO - 'SHLVL': '1', 08:21:43 INFO - 'TERM': 'linux', 08:21:43 INFO - 'TMOUT': '86400', 08:21:43 INFO - 'USER': 'cltbld', 08:21:43 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1464966917.239381-2065992589', 08:21:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:43 INFO - '_': '/tools/buildbot/bin/python'} 08:21:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:43 INFO - Downloading/unpacking jsonschema==2.5.1 08:21:43 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 08:21:43 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 08:21:43 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 08:21:43 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 08:21:43 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 08:21:43 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 08:21:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:21:45 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:21: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 08:21: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 08:21: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 08:21: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 08:21: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 08:21: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 08:21:45 INFO - Downloading functools32-3.2.3-2.tar.gz 08:21:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:21:45 INFO - warning: no files found matching '*.txt' 08:21:45 INFO - no previously-included directories found matching 'build' 08:21:45 INFO - no previously-included directories found matching 'dist' 08:21:45 INFO - no previously-included directories found matching '.git*' 08:21:45 INFO - Installing collected packages: jsonschema, functools32 08:21:45 INFO - Running setup.py install for functools32 08:21:46 INFO - warning: no files found matching '*.txt' 08:21:46 INFO - no previously-included directories found matching 'build' 08:21:46 INFO - no previously-included directories found matching 'dist' 08:21:46 INFO - no previously-included directories found matching '.git*' 08:21:46 INFO - Successfully installed jsonschema functools32 08:21:46 INFO - Cleaning up... 08:21:46 INFO - Return code: 0 08:21:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:21:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb6fd0c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x190d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19da190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a6c110>, '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 0x19d8230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19d86c0>, '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': '1f5564757af27664ca02d71f000001b0-1464966917.239381-2065992589', '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 08:21:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:21:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:21:46 INFO - Using env: {'DISPLAY': ':0', 08:21:46 INFO - 'HOME': '/home/cltbld', 08:21:46 INFO - 'LANG': 'en_US.UTF-8', 08:21:46 INFO - 'LANGUAGE': 'en_US:en', 08:21:46 INFO - 'LOGNAME': 'cltbld', 08:21:46 INFO - 'MAIL': '/var/mail/cltbld', 08:21:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:46 INFO - 'MOZ_NO_REMOTE': '1', 08:21:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:46 INFO - 'NO_EM_RESTART': '1', 08:21:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:46 INFO - 'PWD': '/builds/slave/test', 08:21:46 INFO - 'SHELL': '/bin/bash', 08:21:46 INFO - 'SHLVL': '1', 08:21:46 INFO - 'TERM': 'linux', 08:21:46 INFO - 'TMOUT': '86400', 08:21:46 INFO - 'USER': 'cltbld', 08:21:46 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1464966917.239381-2065992589', 08:21:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:46 INFO - '_': '/tools/buildbot/bin/python'} 08:21:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:46 INFO - Downloading/unpacking blobuploader==1.2.4 08:21:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:48 INFO - Downloading blobuploader-1.2.4.tar.gz 08:21:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:21:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:21:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:21:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:21:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:48 INFO - Downloading docopt-0.6.1.tar.gz 08:21:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:21:49 INFO - Installing collected packages: blobuploader, requests, docopt 08:21:49 INFO - Running setup.py install for blobuploader 08:21:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:21:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:21:49 INFO - Running setup.py install for requests 08:21:49 INFO - Running setup.py install for docopt 08:21:49 INFO - Successfully installed blobuploader requests docopt 08:21:49 INFO - Cleaning up... 08:21:49 INFO - Return code: 0 08:21:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:21:49 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')]} 08:21:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:49 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')]} 08:21:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:49 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 0x7fb6fd0c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x190d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19da190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a6c110>, '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 0x19d8230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19d86c0>, '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': '1f5564757af27664ca02d71f000001b0-1464966917.239381-2065992589', '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 08:21:49 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 08:21:49 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 08:21:49 INFO - Using env: {'DISPLAY': ':0', 08:21:49 INFO - 'HOME': '/home/cltbld', 08:21:49 INFO - 'LANG': 'en_US.UTF-8', 08:21:49 INFO - 'LANGUAGE': 'en_US:en', 08:21:49 INFO - 'LOGNAME': 'cltbld', 08:21:49 INFO - 'MAIL': '/var/mail/cltbld', 08:21:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:49 INFO - 'MOZ_NO_REMOTE': '1', 08:21:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:49 INFO - 'NO_EM_RESTART': '1', 08:21:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:49 INFO - 'PWD': '/builds/slave/test', 08:21:49 INFO - 'SHELL': '/bin/bash', 08:21:49 INFO - 'SHLVL': '1', 08:21:49 INFO - 'TERM': 'linux', 08:21:49 INFO - 'TMOUT': '86400', 08:21:49 INFO - 'USER': 'cltbld', 08:21:49 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1464966917.239381-2065992589', 08:21:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:49 INFO - '_': '/tools/buildbot/bin/python'} 08:21:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:21:49 INFO - Running setup.py (path:/tmp/pip-jGLZYW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:21:49 INFO - Running setup.py (path:/tmp/pip-qcpStb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:21:49 INFO - Running setup.py (path:/tmp/pip-9Y8TGg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:21:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:21:50 INFO - Running setup.py (path:/tmp/pip-tqkzXn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:21:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:21:50 INFO - Running setup.py (path:/tmp/pip-q7FWmd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:21:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:21:50 INFO - Running setup.py (path:/tmp/pip-520MEw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:21:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:21:50 INFO - Running setup.py (path:/tmp/pip-Q1Parx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:21:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:21:50 INFO - Running setup.py (path:/tmp/pip-BUB1n4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:21:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:21:50 INFO - Running setup.py (path:/tmp/pip-URb4cb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:21:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:21:50 INFO - Running setup.py (path:/tmp/pip-RwvNV2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:21:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:21:50 INFO - Running setup.py (path:/tmp/pip-KpMxGQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:21:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:21:50 INFO - Running setup.py (path:/tmp/pip-TXjn3r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:21:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:21:50 INFO - Running setup.py (path:/tmp/pip-bN8kPy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:21:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:21:50 INFO - Running setup.py (path:/tmp/pip-KScbQG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:21:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:21:50 INFO - Running setup.py (path:/tmp/pip-oh83fd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:21:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:21:50 INFO - Running setup.py (path:/tmp/pip-YgIaml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:21:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:21:50 INFO - Running setup.py (path:/tmp/pip-vUI_3b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:21:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:21:51 INFO - Running setup.py install for manifestparser 08:21:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:21:51 INFO - Running setup.py install for mozcrash 08:21:51 INFO - Running setup.py install for mozdebug 08:21:51 INFO - Running setup.py install for mozdevice 08:21:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:21:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:21:51 INFO - Running setup.py install for mozfile 08:21:51 INFO - Running setup.py install for mozhttpd 08:21:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:21:51 INFO - Running setup.py install for mozinfo 08:21:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:21:51 INFO - Running setup.py install for mozInstall 08:21:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:21:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:21:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:21:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:21:51 INFO - Running setup.py install for mozleak 08:21:51 INFO - Running setup.py install for mozlog 08:21:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:21:52 INFO - Running setup.py install for moznetwork 08:21:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:21:52 INFO - Running setup.py install for mozprocess 08:21:52 INFO - Running setup.py install for mozprofile 08:21:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:21:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:21:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:21:52 INFO - Running setup.py install for mozrunner 08:21:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:21:52 INFO - Running setup.py install for mozscreenshot 08:21:52 INFO - Running setup.py install for moztest 08:21:52 INFO - Running setup.py install for mozversion 08:21:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:21:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:21:52 INFO - Cleaning up... 08:21:52 INFO - Return code: 0 08:21:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:21:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:52 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 0x7fb6fd0c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x190d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19da190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a6c110>, '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 0x19d8230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19d86c0>, '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': '1f5564757af27664ca02d71f000001b0-1464966917.239381-2065992589', '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 08:21:52 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 08:21:52 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 08:21:52 INFO - Using env: {'DISPLAY': ':0', 08:21:52 INFO - 'HOME': '/home/cltbld', 08:21:52 INFO - 'LANG': 'en_US.UTF-8', 08:21:52 INFO - 'LANGUAGE': 'en_US:en', 08:21:52 INFO - 'LOGNAME': 'cltbld', 08:21:52 INFO - 'MAIL': '/var/mail/cltbld', 08:21:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:52 INFO - 'MOZ_NO_REMOTE': '1', 08:21:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:52 INFO - 'NO_EM_RESTART': '1', 08:21:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:52 INFO - 'PWD': '/builds/slave/test', 08:21:52 INFO - 'SHELL': '/bin/bash', 08:21:52 INFO - 'SHLVL': '1', 08:21:52 INFO - 'TERM': 'linux', 08:21:52 INFO - 'TMOUT': '86400', 08:21:52 INFO - 'USER': 'cltbld', 08:21:52 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1464966917.239381-2065992589', 08:21:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:52 INFO - '_': '/tools/buildbot/bin/python'} 08:21:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:21:53 INFO - Running setup.py (path:/tmp/pip-7m664q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:21:53 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)) 08:21:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:21:53 INFO - Running setup.py (path:/tmp/pip-KvGMex-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:21:53 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)) 08:21:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:21:53 INFO - Running setup.py (path:/tmp/pip-Jbu17x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:21:53 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)) 08:21:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:21:53 INFO - Running setup.py (path:/tmp/pip-6TliPf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:21:53 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)) 08:21:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:21:53 INFO - Running setup.py (path:/tmp/pip-PnSa4N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:21:53 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)) 08:21:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:21:53 INFO - Running setup.py (path:/tmp/pip-3KAsTa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:21:53 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)) 08:21:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:21:53 INFO - Running setup.py (path:/tmp/pip-C4HvcP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:21:53 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)) 08:21:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:21:53 INFO - Running setup.py (path:/tmp/pip-jpJ0f8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:21:53 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)) 08:21:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:21:53 INFO - Running setup.py (path:/tmp/pip-oX94bM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:21:53 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)) 08:21:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:21:53 INFO - Running setup.py (path:/tmp/pip-md0lkn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:21:53 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)) 08:21:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:21:53 INFO - Running setup.py (path:/tmp/pip-yMYN9o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:21:53 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)) 08:21:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:21:53 INFO - Running setup.py (path:/tmp/pip-eqiOFF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:21:53 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)) 08:21:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:21:53 INFO - Running setup.py (path:/tmp/pip-me_Sdx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:21:54 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)) 08:21:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:21:54 INFO - Running setup.py (path:/tmp/pip-j_91UX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:21:54 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)) 08:21:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:21:54 INFO - Running setup.py (path:/tmp/pip-7UEPvi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:21:54 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)) 08:21:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:21:54 INFO - Running setup.py (path:/tmp/pip-9uFScI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:21:54 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)) 08:21:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:21:54 INFO - Running setup.py (path:/tmp/pip-3cdGvB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:21:54 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)) 08:21:54 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)) 08:21:54 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)) 08:21:54 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)) 08:21:54 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)) 08:21:54 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)) 08:21:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:21:54 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 08:21:54 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 08:21:54 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 08:21:54 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 08:21:54 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 08:21:54 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 08:21:56 INFO - Downloading blessings-1.6.tar.gz 08:21:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:21:56 INFO - Installing collected packages: blessings 08:21:56 INFO - Running setup.py install for blessings 08:21:56 INFO - Successfully installed blessings 08:21:56 INFO - Cleaning up... 08:21:56 INFO - Return code: 0 08:21:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:21:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:21:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:21:56 INFO - Reading from file tmpfile_stdout 08:21:56 INFO - Current package versions: 08:21:56 INFO - argparse == 1.2.1 08:21:56 INFO - blessings == 1.6 08:21:56 INFO - blobuploader == 1.2.4 08:21:56 INFO - docopt == 0.6.1 08:21:56 INFO - functools32 == 3.2.3-2 08:21:56 INFO - jsonschema == 2.5.1 08:21:56 INFO - manifestparser == 1.1 08:21:56 INFO - mozInstall == 1.12 08:21:56 INFO - mozcrash == 0.17 08:21:56 INFO - mozdebug == 0.1 08:21:56 INFO - mozdevice == 0.48 08:21:56 INFO - mozfile == 1.2 08:21:56 INFO - mozhttpd == 0.7 08:21:56 INFO - mozinfo == 0.9 08:21:56 INFO - mozleak == 0.1 08:21:56 INFO - mozlog == 3.2 08:21:56 INFO - moznetwork == 0.27 08:21:56 INFO - mozprocess == 0.22 08:21:56 INFO - mozprofile == 0.28 08:21:56 INFO - mozrunner == 6.11 08:21:56 INFO - mozscreenshot == 0.1 08:21:56 INFO - mozsystemmonitor == 0.3 08:21:56 INFO - moztest == 0.7 08:21:56 INFO - mozversion == 1.4 08:21:56 INFO - psutil == 3.1.1 08:21:56 INFO - requests == 1.2.3 08:21:56 INFO - wsgiref == 0.1.2 08:21:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:21:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:56 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 0x7fb6fd0c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x190d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19da190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a6c110>, '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 0x19d8230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19d86c0>, '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': '1f5564757af27664ca02d71f000001b0-1464966917.239381-2065992589', '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 08:21:56 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 08:21:56 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 08:21:56 INFO - Using env: {'DISPLAY': ':0', 08:21:56 INFO - 'HOME': '/home/cltbld', 08:21:56 INFO - 'LANG': 'en_US.UTF-8', 08:21:56 INFO - 'LANGUAGE': 'en_US:en', 08:21:56 INFO - 'LOGNAME': 'cltbld', 08:21:56 INFO - 'MAIL': '/var/mail/cltbld', 08:21:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:56 INFO - 'MOZ_NO_REMOTE': '1', 08:21:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:56 INFO - 'NO_EM_RESTART': '1', 08:21:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:56 INFO - 'PWD': '/builds/slave/test', 08:21:56 INFO - 'SHELL': '/bin/bash', 08:21:56 INFO - 'SHLVL': '1', 08:21:56 INFO - 'TERM': 'linux', 08:21:56 INFO - 'TMOUT': '86400', 08:21:56 INFO - 'USER': 'cltbld', 08:21:56 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1464966917.239381-2065992589', 08:21:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:56 INFO - '_': '/tools/buildbot/bin/python'} 08:21:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:56 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)) 08:21:56 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)) 08:21:56 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)) 08:21:56 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)) 08:21:56 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)) 08:21:56 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)) 08:21:56 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)) 08:21:56 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)) 08:21:56 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)) 08:21:56 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)) 08:21:56 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)) 08:21:56 INFO - Cleaning up... 08:21:56 INFO - Return code: 0 08:21:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:21:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:56 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 0x7fb6fd0c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x190d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19da190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a6c110>, '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 0x19d8230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19d86c0>, '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': '1f5564757af27664ca02d71f000001b0-1464966917.239381-2065992589', '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 08:21:56 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 08:21:56 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 08:21:56 INFO - Using env: {'DISPLAY': ':0', 08:21:56 INFO - 'HOME': '/home/cltbld', 08:21:56 INFO - 'LANG': 'en_US.UTF-8', 08:21:56 INFO - 'LANGUAGE': 'en_US:en', 08:21:56 INFO - 'LOGNAME': 'cltbld', 08:21:56 INFO - 'MAIL': '/var/mail/cltbld', 08:21:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:56 INFO - 'MOZ_NO_REMOTE': '1', 08:21:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:56 INFO - 'NO_EM_RESTART': '1', 08:21:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:56 INFO - 'PWD': '/builds/slave/test', 08:21:56 INFO - 'SHELL': '/bin/bash', 08:21:56 INFO - 'SHLVL': '1', 08:21:56 INFO - 'TERM': 'linux', 08:21:56 INFO - 'TMOUT': '86400', 08:21:56 INFO - 'USER': 'cltbld', 08:21:56 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1464966917.239381-2065992589', 08:21:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:56 INFO - '_': '/tools/buildbot/bin/python'} 08:21:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:57 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:21:57 INFO - Cleaning up... 08:21:57 INFO - Return code: 0 08:21:57 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:21:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6fd0c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x190d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19da190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a6c110>, '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 0x19d8230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19d86c0>, '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': '1f5564757af27664ca02d71f000001b0-1464966917.239381-2065992589', '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 08:21:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 08:21:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 08:21:57 INFO - Using env: {'DISPLAY': ':0', 08:21:57 INFO - 'HOME': '/home/cltbld', 08:21:57 INFO - 'LANG': 'en_US.UTF-8', 08:21:57 INFO - 'LANGUAGE': 'en_US:en', 08:21:57 INFO - 'LOGNAME': 'cltbld', 08:21:57 INFO - 'MAIL': '/var/mail/cltbld', 08:21:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:57 INFO - 'MOZ_NO_REMOTE': '1', 08:21:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:57 INFO - 'NO_EM_RESTART': '1', 08:21:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:57 INFO - 'PWD': '/builds/slave/test', 08:21:57 INFO - 'SHELL': '/bin/bash', 08:21:57 INFO - 'SHLVL': '1', 08:21:57 INFO - 'TERM': 'linux', 08:21:57 INFO - 'TMOUT': '86400', 08:21:57 INFO - 'USER': 'cltbld', 08:21:57 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1464966917.239381-2065992589', 08:21:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:57 INFO - '_': '/tools/buildbot/bin/python'} 08:21:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:57 INFO - Downloading/unpacking flake8 08:21:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:59 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:21:59 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:21:59 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 08:21:59 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 08:21:59 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 08:21:59 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 08:21:59 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 08:21:59 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 08:21:59 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:21:59 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:21:59 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 08:21:59 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 08:21:59 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 08:21:59 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 08:21:59 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 08:21:59 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 08:21:59 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:21:59 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 08:21:59 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 08:21:59 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 08:21:59 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 08:21:59 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 08:21:59 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 08:21:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:21:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:21:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:21:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:21:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:21:59 INFO - no previously-included directories found matching 'docs/_build' 08:21:59 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:21:59 INFO - Running setup.py install for pep8 08:22:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:22:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:22:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:22:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:22:00 INFO - no previously-included directories found matching 'docs/_build' 08:22:00 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:22:00 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:22:00 INFO - Cleaning up... 08:22:00 INFO - Return code: 0 08:22:00 INFO - Running post-action listener: _resource_record_post_action 08:22:00 INFO - Running post-action listener: _start_resource_monitoring 08:22:00 INFO - Starting resource monitoring. 08:22:00 INFO - ##### 08:22:00 INFO - ##### Finished create-virtualenv step (success) 08:22:00 INFO - ##### 08:22:00 INFO - ##### 08:22:00 INFO - ##### Running install step. 08:22:00 INFO - ##### 08:22:00 INFO - Running pre-action listener: _resource_record_pre_action 08:22:00 INFO - Running main action method: install 08:22:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:22:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:22:00 INFO - Reading from file tmpfile_stdout 08:22:00 INFO - Detecting whether we're running mozinstall >=1.0... 08:22:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:22:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:22:00 INFO - Reading from file tmpfile_stdout 08:22:00 INFO - Output received: 08:22:00 INFO - Usage: mozinstall [options] installer 08:22:00 INFO - Options: 08:22:00 INFO - -h, --help show this help message and exit 08:22:00 INFO - -d DEST, --destination=DEST 08:22:00 INFO - Directory to install application into. [default: 08:22:00 INFO - "/builds/slave/test"] 08:22:00 INFO - --app=APP Application being installed. [default: firefox] 08:22:00 INFO - mkdir: /builds/slave/test/build/application 08:22:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:22:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:22:17 INFO - Reading from file tmpfile_stdout 08:22:17 INFO - Output received: 08:22:17 INFO - /builds/slave/test/build/application/firefox/firefox 08:22:17 INFO - Running post-action listener: _resource_record_post_action 08:22:17 INFO - ##### 08:22:17 INFO - ##### Finished install step (success) 08:22:17 INFO - ##### 08:22:17 INFO - ##### 08:22:17 INFO - ##### Running run-tests step. 08:22:17 INFO - ##### 08:22:17 INFO - Running pre-action listener: _resource_record_pre_action 08:22:17 INFO - Running main action method: run_tests 08:22:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:22:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:22:17 INFO - Python 2.7.3 08:22:17 INFO - Return code: 0 08:22:17 INFO - grabbing minidump binary from tooltool 08:22: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')]} 08:22:17 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 0x1a6c110>, '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 0x19d8230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19d86c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:22:17 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 08:22:17 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 08:22:17 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 08:22:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:22:17 INFO - Return code: 0 08:22:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:22:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:22:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:22:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:22:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:22:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:22:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:22:18 INFO - Return code: 0 08:22:18 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/WP2Ilp0jQ4eDbNgq8ejirw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--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 08:22:18 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/WP2Ilp0jQ4eDbNgq8ejirw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-027 --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 08:22:18 INFO - Using env: {'DISPLAY': ':0', 08:22:18 INFO - 'HOME': '/home/cltbld', 08:22:18 INFO - 'LANG': 'en_US.UTF-8', 08:22:18 INFO - 'LANGUAGE': 'en_US:en', 08:22:18 INFO - 'LOGNAME': 'cltbld', 08:22:18 INFO - 'MAIL': '/var/mail/cltbld', 08:22:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:22:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:22:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:22:18 INFO - 'MOZ_NO_REMOTE': '1', 08:22:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:22:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:22:18 INFO - 'NO_EM_RESTART': '1', 08:22:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:22:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:22:18 INFO - 'PWD': '/builds/slave/test', 08:22:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:22:18 INFO - 'SHELL': '/bin/bash', 08:22:18 INFO - 'SHLVL': '1', 08:22:18 INFO - 'TERM': 'linux', 08:22:18 INFO - 'TMOUT': '86400', 08:22:18 INFO - 'USER': 'cltbld', 08:22:18 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1464966917.239381-2065992589', 08:22:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:22:18 INFO - '_': '/tools/buildbot/bin/python'} 08:22:18 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/WP2Ilp0jQ4eDbNgq8ejirw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--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 08:22:18 INFO - mozversion application_buildid: 20160603053007 08:22:18 INFO - mozversion application_changeset: 0ef7cc6b42c72be6ef8d0786fb1f5371c11e9e32 08:22:18 INFO - mozversion application_display_name: Nightly 08:22:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:22:18 INFO - mozversion application_name: Firefox 08:22:18 INFO - mozversion application_remotingname: firefox 08:22:18 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:22:18 INFO - mozversion application_vendor: Mozilla 08:22:18 INFO - mozversion application_version: 49.0a1 08:22:18 INFO - mozversion platform_buildid: 20160603053007 08:22:18 INFO - mozversion platform_changeset: 0ef7cc6b42c72be6ef8d0786fb1f5371c11e9e32 08:22:18 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:22:18 INFO - mozversion platform_version: 49.0a1 08:22:18 INFO - using testdate: 1464967338 08:22:18 INFO - actual date: 1464967338 08:22:18 INFO - starting webserver on 'localhost:44560' 08:22:18 INFO - SUITE-START | Running 2 tests 08:22:18 INFO - TEST-START | dromaeo_css 08:22:18 INFO - operating with platform_type : linux_ 08:22:18 INFO - Initialising browser for dromaeo_css test... 08:22:18 INFO - TEST-INFO | started process 3332 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPM9WCr/profile http://localhost:44560/getInfo.html) 08:22:24 INFO - PROCESS | 3332 | __metrics Screen width/height:1600/1200 08:22:24 INFO - PROCESS | 3332 | colorDepth:24 08:22:24 INFO - PROCESS | 3332 | Browser inner width/height: 1024/697 08:22:24 INFO - PROCESS | 3332 | __metrics 08:22:27 ERROR - PROCESS | 3332 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:22:27 INFO - TEST-INFO | 3332: exit 0 08:22:27 INFO - Browser initialized. 08:22:27 INFO - Running cycle 1/1 for dromaeo_css test... 08:22:27 INFO - TEST-INFO | started process 3416 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPM9WCr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:22:39 INFO - PROCESS | 3416 | RSS: Main: 157040640 08:22:39 INFO - PROCESS | 3416 | 08:23:30 INFO - PROCESS | 3416 | 1464967410775 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] 08:25:38 INFO - PROCESS | 3416 | Cycle 1(1): loaded http://localhost:44560/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44560/tests/dromaeo/cssquery-ext.html) 08:25:39 INFO - PROCESS | 3416 | RSS: Main: 247349248 08:25:39 INFO - PROCESS | 3416 | 08:28:42 INFO - PROCESS | 3416 | Cycle 1(1): loaded http://localhost:44560/tests/dromaeo/cssquery-ext.html (next: http://localhost:44560/tests/dromaeo/cssquery-jquery.html) 08:28:42 INFO - PROCESS | 3416 | RSS: Main: 247828480 08:28:42 INFO - PROCESS | 3416 | 08:31:44 INFO - PROCESS | 3416 | Cycle 1(1): loaded http://localhost:44560/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44560/tests/dromaeo/cssquery-mootools.html) 08:31:45 INFO - PROCESS | 3416 | RSS: Main: 245608448 08:31:45 INFO - PROCESS | 3416 | 08:34:47 INFO - PROCESS | 3416 | Cycle 1(1): loaded http://localhost:44560/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44560/tests/dromaeo/cssquery-prototype.html) 08:34:48 INFO - PROCESS | 3416 | RSS: Main: 238952448 08:34:48 INFO - PROCESS | 3416 | 08:37:50 INFO - PROCESS | 3416 | Cycle 1(1): loaded http://localhost:44560/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44560/tests/dromaeo/cssquery-yui.html) 08:37:51 INFO - PROCESS | 3416 | RSS: Main: 233406464 08:37:51 INFO - PROCESS | 3416 | 08:40:54 INFO - PROCESS | 3416 | Cycle 1(1): loaded http://localhost:44560/tests/dromaeo/cssquery-yui.html (next: http://localhost:44560/tests/dromaeo/cssquery-dojo.html) 08:40:54 INFO - PROCESS | 3416 | RSS: Main: 279564288 08:40:54 INFO - PROCESS | 3416 | 08:40:54 INFO - PROCESS | 3416 | __start_tp_report 08:40:54 INFO - PROCESS | 3416 | _x_x_mozilla_page_load 08:40:54 INFO - PROCESS | 3416 | _x_x_mozilla_page_load_details 08:40:54 INFO - PROCESS | 3416 | |i|pagename|runs| 08:40:54 INFO - PROCESS | 3416 | |0;dojo.html;3087.6294844618633;3105.5031195008796;3117.906462806116;3132.3422081362914;3155.195425166582;5248.5538729207965;5316.840494785158;5333.4399888011785;5403.540699040582;5427.348718153818;5373;5411.080116380215;5443.510084092431;5452.509274165324;5462.20797984292;4878.512148785111;4960.280759289901;4970.105381031413;4979;5133.871653208681;5048.192289233723;5061.772220250097;5103.26002729604;5105.566026887719;5125.077486052509;4808.326834243208;4922.680025798348;4927.704337739747;4929.876753081166;4975.154223781966;4902.215645496739;4915.4347250065985;4966.15575352191;4968;5017.89964200714;4862.41651001882;4919.458859525449;4940.184869496528;4955.380577427822;5015.32293140425;5292.92060619091;5296.152615581488;5344.866378340534;5386.569074474032;5417.187421886709;5864.736086876101;5873.853153671193;5882.264716910387;5895.734691938873;5896.439838215363;5693.231413759131;5764.7117644117625;5846.883062338729;5936.406359364072;5977.013792724239;5457.699826509501;5498.230247765316;5498.285222920995;5511.972440137773;5515.227868098469;6002.0996850472775;6013.579049466495;6017.548683848729;6020.4280593343565;6023.45788879003;5615.943840561542;5651.689157096317;5674.943250567524;5695.1741997410145;5799.507041901401;5811.099279611667;5864.765409383577;5874.060150375919;5878.206442130343;5883.411658834082;5766.192733017381;5787.652740835563;5787.826365209051;5805.332386775575;5805.738741756547;5569.721513924287;5828.446297601721;5861.912071318934;5885.117232415172;5906.438888305604;4440.511543730187;4448.644108471314;4450.799714012813;4460.30865215892;4485.25993211123;3871.070942973666;3926.5680775114715;3985.0834308109297;4005.499312585927;4031.1937612477623;5330.893382132335;5512.3385193777;5566.638168519034;5571.860703482364;5574.414686457944;5886.823395298148;5908.14331921869;5913.231279933667;5924.200232968494;5941.881162376728;5436.70098144598;5552.056150454432;5558.805441809598;5581.665100094007;5582.525485333792;4831;4834.395700537433;4844.75776211188;4874.512548745168;4884.658073934862;6030.849228769316;6032.336442991267;6034.39656034393;6036.607620504741;6042.425969532887;5681.8863622726485;5750.338711048115;5816.418358164319;5823.388544202798;5824.854378640398;5974.731137098928;6028.367021462858;6083.361247068994;6084.574079814371;6085.513158947362;5705.486506214461;5748.856278593069;5752.884942301214;5756.194132821324;5761.962846687637;5770.682612456355;5788.82633520995;5828.446297601721;5835.095560188008;5852.239208902815;5603.10350343943;5657.858553536194;5660.264165658438;5662.490375866192;5668.858278543069;5654.491095801398;5655.0103731847585;5658.519025882846;5661.0659241226385;5661.858453538694;5482.150266708507;5568.610197286313;5569.136783798518;5575.163725441054;5577.45133166124;5692.800751973661;5758.107493338539;5758.62568933018;5820.068788993741;5858.062709966385;5649.12438572022;5651.858703532444;5657.717114144359;5662.292213473316;5677.432256774455 08:40:54 INFO - PROCESS | 3416 | |1;ext.html;609.4240942309518;624.1698540940549;634.0964126120278;642.6979319719733;650.2652003236342;43546.56453435465;44960.550394496044;45217.095658086815;49447;49497;46212.306815397715;46962.7651861741;46978.295325570056;47020.29469557959;47081.76459117708;8734.344924130699;8887.511186884718;8901.955490222539;8903.77740556488;8906.42108262964;8845.734627961172;8894.777630559223;8929.062448442917;8930.330225233101;8938.553072346389;8934.955325223365;8985.101489851028;8992.145746154105;8995.055519170492;8996.055414181516;8893.777655558599;8900.19898209161;8937.776555586097;8953.10468953106;8956.999999999967;8750.69372571957;8844.204021638083;8849.60176792046;8850.778730531723;8850.822983540293;42137.578624213675;42506.937326566775;42555;42556;42671.57328426738;3511.5610548681416;3695.8521659133603;3720.0885782983073;3844.75009124406;4272.230998420283;33291.500627490605;33650.83174584136;33907;33995;35033.824830875936;4260.829566817354;4444.20004399208;4535.614472769818;4548.090381923628;4554.612857907082;342843;342898;344420;344469;346090;62209;62303.6884815573;62541;62622.37377626165;62670.68664656648;65878;65998.34001659922;66247;66304.33695662982;66339.33660663331;17259;17419.56451088733;17443.65112697739;17449.91275043642;17471.912640436716;11913.58302459427;11957.940210298893;11985.880141198651;11989.88010119905;12051.975582075447;17934.50394234035;19701.901490492743;19748.70376944347;19853.60292794136;20022.49943751389;6944.618046007518;6985.1617805863625;7037.6481175941;7289.198188199294;7298.190196774174;755.1245906025667;1068.4657671164418;1081.1891081688734;1086.4513420722485;1187.1689817127872;32310.35379292401;33486.66513334884;33509.66490335114;33550.832245839105;33954.830225849204;1161.9535218591332;1168.2873447197373;1176.952921883115;1201.1351826684772;1239.7148655809215;17160.570985725208;17330.913345433193;17377.391791287246;17422.303107875545;17443.082659051317;548652.2567387137;551262;556269;557629;558393;60687.69656151691;61441;61551;61637.38362616406;61643.69178154081;1231.8152277158497;1301.0892375337303;1361.795730640392;1378.4348417148922;1380.2132784312846;30465;34601.134971625914;34715.13212169716;34721.30557388889;34925.65074349326;52831.207531886284;53098.4690153109;53389.73305133449;53442;53467.19799203093;313005;314055;314215;315011;315016;25670.358241044123;27560.448791023668;28506.57240141358;28743;28765.28086797847;49342.50657493379;49926.50073499219;50107.74946125246;50690.74654626851;51454.48545514647;40042;41379.58620413757;41908;41910.79044604879;43030;41764.1647167061;41872.79063604662;42085.78957105195;42260;42457.787711061246;41825.790871046665;42477.57522424736;43175.35236971511;43261.78369108134;43440.78279608582;34190;36929.44605830861;37388;37430.438543421325;37468.43797343096;28099.859500702365;28299.24265012864;28345.716542835133;28436.43127137487;28607 08:40:54 INFO - PROCESS | 3416 | |2;jquery.html;385.11807959772113;388.79005337117957;395.3279424977539;398.4640658314567;413.1386060064765;14401.423943042291;17042;18368.448946531593;19766;19789.40631781047;14606.926965365159;15386.61533461664;15529.22353882307;19548.511287217825;19687.310944116958;5532.3914369419335;5566.192902029194;5649.915251271234;5654.038813401731;5656.038473459522;4046.3930410438375;5591.580631452637;5612.438756124396;5618.831435056934;6077.878442431171;6302.306746257908;6381.872362552746;6395.104685344056;6405.42351188393;6406.935930640704;6199.535034872402;6329.36706329368;6374.713137908805;6413.198350206224;6433.420992110686;5618.269624948731;5625.634333768292;5638.407967163471;5643.887122257573;5646;13989.090709103875;16175.838241617668;20537.38387848367;21792.128314867547;21805.781942180532;2232.955340893173;2422.854628722265;2449.216250799745;2791.3294018365987;3009.849507524615;9974.251931105196;10156.23828212887;10360.481975901175;10536.26246162769;11417.31496110236;1946.4355336952267;1949.33722534339;2006.9899650501654;2015.4759762461865;2189.4854709143337;79401.60299198524;80754.99999999942;83262.58368708179;83868.17430772631;84399;10190.898091019144;10276.897231027595;10332.483375831178;10582.94708526468;10730.73173170677;13969.23169225682;13971.161730296215;14001.85998140026;14022.85977140236;14040.578782636538;7413.8146546336775;7418;7646.120696119906;7917.247861453153;8000.279974802295;7326;7408.370288525428;7482.3639990601405;7899;8191.508509489449;4583.770811459481;4713.222318317507;4738.715677059387;4785.138675038526;4863.197572400514;1884.9717254241198;1900.4678689966831;1940.5730739237345;1996.2314508913882;2005.1077270614728;1048.3762161513887;1056.9894301057045;1064.1486810551528;1069.2942657845786;1085.473545330514;18340.266389344277;18649.160787764584;18780.7182892254;18853.340133095277;19314.13086411115;990.108901988202;1027.4965267019106;1028.7428142964259;1032.607609108534;1035.9015893490107;10132.44271565071;10601.575936962436;10610.750639919019;10651.414172220602;10792.244542881923;445757;462770;466475;480243;482975;54497.72751136219;67081.66459167673;91528;91828.08171918195;92013;1001.8497225416392;1051.6266725312557;1074.7796701676139;1075.2150929821273;1085.1102096280974;15543.37826486973;16798.580035498722;16957.576060598585;17039.659206816043;17314.65370692604;40724.18551628892;41802;41948.37077443902;42122.57877421309;42512.36231456592;56490;57791.422085778606;58585.414145858;58963.41036589751;59404.70297648657;8446.239838414573;8539.188777066169;8666.653333866827;8783;8857.689980850639;9747.561359738971;12914.547990820276;13271.601851944457;13276.668083297995;13414.12808167466;11710.94144529272;11721.765564688829;11844.407779610812;12119.757604847677;12144.210626309261;11477.426128693698;11672.941635291769;11729.237599556001;11891.76216475683;12057.095717821023;11463.140264480364;11583.594574189863;11603.303801771921;11684.18210725241;11712.941435292769;8055.516668999879;8274.462159959583;8401.411901166859;8402.453840500348;8465.492070475791;10831.620893268699;11118.332900026024;11239.55041798319;11328.376939268419;11340.262882912584 08:40:54 INFO - PROCESS | 3416 | |3;mootools.html;1327.117466884522;1512.8260250071241;1547.149068012593;1699.5496193508723;1831.844293235075;8648.351373646978;8985.685501007467;9004.45973241606;9106.726798196065;9110.453372797636;8859.46843189409;9058.637654493828;9068.455892646445;9068.591913363898;9071.410358326704;2081.2819577245828;2292.33522278539;2370.146747171017;2370.2059809963685;2391.629297458888;2358.1157066100213;2394.0543485323287;2395.4370722880108;2396.341006223285;2398.64020396941;2307.792298693117;2359.764023597635;2360.3155085025323;2363.7872591466767;2364.054378248697;2044.846636502261;2314.953700925972;2368.1948137633117;2372.7034120734907;2381.4641705616273;2309.4226443389152;2334.054707843326;2339.7660233976635;2346.389938615955;2347.812175025994;8728.738137855875;8777.517236551987;8789.208971192624;8790.956045219797;8791.428557143829;5123.718195499246;5286.524212820865;5287.07476191665;5290.0477913975465;5291.708956007418;3339.5825521809775;3478.8782392616135;3517.120719820045;3521.5950165730756;3533.4523148911703;1172.976540469186;1203.0495908232485;1213.3326670331282;1228.7112528555783;1229.8524177098716;12365.134440589163;12537.74924501505;12594.937025314815;12609.936950315281;12614.180078294881;4705.435347758223;4719.7404142772475;4756.976215118972;4768.904621907612;4777.283407488904;10564.260501764957;10660.733481663021;10666.893331066745;10670.199735019749;10680.732981675521;4839.467658557556;5243.239730239094;5338.652987555796;5351.117065684196;5353.277307563507;4772.522747725269;4899.240617704261;4908.11653902301;4936.284238785356;4944.653874228841;3991.8055610803444;4055.655269302142;4157.958420415817;4196.139791342767;4204.51648060477;1255.8492980842357;1265.7405231927432;1290.2774446310095;1300.2718477652545;1310.9803352949714;967.7677357434166;997.2022382094295;1007.0986467111894;1013.1287093099928;1021.5352014833381;5751.971240143773;5951.434613711691;5975.19334889793;6106.786262480792;6221.253449585988;464.4797826434415;467.5558219691307;473.1648640150138;482.4548260465721;482.73449602718364;3996.8601098961976;4115.609017143366;4148.8133034013545;4155.750654960712;4162.021924847659;10976.286541374786;11229.719257018476;11329.43352832355;11332.2067455279;11344.886551134548;10639.73400664974;11086.722831929266;11113.333200008025;11221.990020898158;11227.55089796399;8292.626831792584;8393.580320983927;8417.452865563597;8424.915750842536;8469.449485783527;5756.884862302814;5967.76128954837;5995.550333725076;6103.816885493442;6185.158590635494;10032.448215348226;10189.082982531607;10417.843732344172;10425.895741042492;10431.061204491632;10373.844392334271;10376.481175941324;10468.110210632181;10474.109700675528;10481.790364192826;7298.781036568911;7482.663280152515;7495.100587929265;7625.123110842324;7967.442279040643;8129.065157506726;8259.83480330402;8425.70510032146;8426.241638252586;8623.956880215559;7863;7973.72091976778;8049.879251811345;8153.8369232616205;8164.510129392255;7446;7580.658870350958;7629.7329593463965;7697.191794861683;7770.883436748566;7018.789436316919;7089.503734738519;7209;7220.169680486812;7229.963850180716;5172.431032586337;5214.452482489436;5333.626646134733;5356.839294821161;5443.237946687546;5160.612954028388;5207.505286997729;5251.658642188246;5388.892222155613;5421.457854214547 08:40:54 INFO - PROCESS | 3416 | |4;prototype.html;318.20448877805484;327.90326853578193;333.2551746845801;336.58599922095834;337.0848147280134;5246;5276.786339142;5308.920366194506;5318.734063296829;5318.867028324294;5007.49925007499;5049;5107.284980102789;5124.590032797377;5216.8695782605355;3993.54074281457;4032.3951407288846;4063.3092374296293;4120.773357465338;4136.3381858902585;4044.8382064717525;4096.651784598313;4106.342985122381;4116.958830411688;4131.462909821719;3924.097457584757;4076.1236334188143;4093.6520395766247;4111.259973204822;4163.250614889319;4037.454943582608;4046.979765101156;4057.1479989202303;4129.648979836733;4134.7182373464175;3538.3454060998542;3551.982240088809;3552.7513074084823;3609.2420591675777;3620.837062332201;4856.737248315428;5109.259157422191;5140.149546163379;5161.845144645629;5168.9741551292;4681.648876334254;4682.695624784412;4716.858494245143;4726.2201736713405;4736.171170045228;5426.62013659044;5453.345598528163;5487.5609951203805;5488.451154884519;5492.725363731797;3836.827342769554;3959.703022273341;3964.405339199114;3974.9006274843073;3982.820773065219;5583.637063590853;5627.352854421753;5629.577781666391;5630.915536266959;5708.628939118944;3967.3652215645934;3988.0428697112484;3990.541087774943;4013.678905687538;4014.611306272763;4067.491563554556;4086.4483294755423;4087.6525495332635;4103.343465045578;4107.342825147962;4531.274996000624;4653.534646535387;4667.509911459248;4673.009274064601;4685.797675092701;5316.787328506894;5383.488568586056;5448.128299472065;5478.876830249789;5509.917351239735;1336.8061631063442;1359.592122363287;1388.3752311459682;1396.9732246798594;1405.2341473896752;891.2736120062128;891.5542228885557;908.7550056422612;913.8126684029758;924.0159230419582;4733.83431579893;4756.9286460703115;4775.95224047762;4789.401324834395;4814.350062741485;4981.601471882241;4988.127077761377;5021.548060674557;5022.51385564148;5040.722760248148;4555.726656400627;4733.905321893543;4786.856394308176;4789.9042019160115;4848.539388758062;2643.8149329546745;2647.2455350225096;2670.559357705996;2675.826071305398;2682.9060982865894;5056;5146.511081447256;5151.8196863109615;5163.483651634881;5169.483051694876;4831.444383895827;5025.095482813055;5031.647784655039;5057.949420505748;5058.46886076964;5098.796048158032;5131.230315452712;5139.897202055938;5141.434442211354;5158.509941555546;4967.130752118293;4971.254311853251;4997.3758528477665;5019.272205530251;5035.194368900959;4891.5353041461;4925.1627223372825;4942.283368911416;5236.895262094813;5683.863227354628;5797.8114486531;5806.506446952057;5818.592698511233;5931.4068593142065;5945.494632956247;4011.2779699654343;4025.8590949316635;4035.648057900636;4043.73715708478;4057.6145266199665;5410.458954104558;5573.331200255995;5647.407022262603;5683.460071293221;5698.971505142447;5435.619506634655;5545.473180047889;5556.805511807067;5574.219609254626;5604.971975140098;5538.307711536058;5541.6145963509125;5554.472325129106;5562.554995600423;5582.766893242735;5212.687238765686;5422.9186562202385;5451.863703407446;5466.3986961435;5477.808276710455;5545.112781954868;5575.693336866511;5583.441655834384;5594.384617692132;5608.915866262091;5408.781774843961;5466.535344495763;5469.206964989975;5480.753366098455;5490.176473529003 08:40:54 INFO - PROCESS | 3416 | |5;yui.html;746.6005686957476;806.1978331560097;835.4945258118842;836.3810780022783;843.3379796859466;15239.923800380997;15324.387024519006;15903.602409939756;16055.036697798125;16060.678786424265;13954.092983956036;13973.161610303388;13989.790153147711;13992.440302387919;14041.29793510323;686.9931300687005;802.626778547975;818.3494122172887;832.1179549677331;832.3258160889699;815.4006804998321;826.5082276045773;828.1139181076251;828.1511450762986;828.3828547731948;875.7591662292857;880.7137680253911;880.828238493494;880.8942926848755;881.6209030117047;704.3519961635283;841.8779277004861;862.1637012098255;873.4104479476359;873.8164985353084;626.9843253918643;628.0610487321438;628.2994461175801;629.3486241739823;629.4492319220682;15178.848211517854;15199.316030778642;15204.08775473464;15220.771688424682;15235.314410851539;14041.64895877601;14516.05645633041;14548.345324460424;14740.11559306445;14774.481349565134;12861.67845803853;13072.08495405322;13134.60596182116;13197.604071877859;13634.181949083088;4353.412289340962;4445.533219012022;4445.933311000337;4470.530594287618;4628.861134165981;72911.27088729097;73171.26828731698;73735.26264737337;74100.62949685217;74334.25665743327;11152.776944461066;11642.825357619642;11673.299602023906;11696.005839503738;11751.647450576496;21083.78916210849;21182.47043823886;21216.36350909475;21247.893760531406;21254.78745212559;8419.326453883674;8483.660653573912;8691.695790647296;8712.172343627346;8868.33487488428;4627.305904114342;4639.2113340731485;4650.279206722963;4765.571098601074;4857.271409288635;3357.5803024621923;3420.3159368126476;3460.2733425980828;3462.6883580477374;3463.2554000889427;605.642670824207;615.7075389190188;620.2092332276384;621.1862460177182;645.0904225042667;626.5113211694885;657.9671016449158;696.7944456385277;719.4783781758183;730.4010711216752;8970.641174352953;9243.584038718274;9277.536123193813;9279.536023198812;9591.952040239754;672.922613899398;714.4070421550101;718.9065421495277;720.5291168300786;721.8051126195897;4279.2083464559155;4420.9336859947125;4429.269170586882;4441.289393697058;4539.387182730356;91419;93738;94003.52998235101;107236;107954;62263.68868155721;83104.16895830964;95401.52299238459;98246.5087674557;100074.49962750285;86691.13308866957;87710.22636697016;88660.5566972174;89172;91595.54202228946;8557.871631925402;8635;8670.869936950825;8874.112588741074;9405.294602904947;37911.81044094762;40971.79514102411;48229.75885120552;49703;51385.229221562455;71707.28292717006;73180.26819731735;74390.62804685942;75045.24954750601;78155.60922195352;10742.721449523975;10858.728531786768;10916.454177291262;11259;11576.94211528937;11410.885891141314;11716.94141529287;11771.293722376684;11880.981899330523;12091.516339346328;11939.283642981449;11996.280223186637;12064;12157.452914618687;12534.811977820158;11838.752142271745;11848.111391645833;11936.52253909834;12139.514419423123;12436.689082773004;11794.29234245948;11826.645200643994;11951.641450756491;11966.521339146337;11974;9543.236541076558;9886.85169722469;9985.950070249603;10001.499925003574;10011.749706257111;9911.355761875455;9971.700848974542;10105.494725263561;10117.949410252902;10188.745281368025 08:40:54 INFO - PROCESS | 3416 | __end_tp_report 08:40:54 INFO - PROCESS | 3416 | __start_cc_report 08:40:54 INFO - PROCESS | 3416 | _x_x_mozilla_cycle_collect,908 08:40:54 INFO - PROCESS | 3416 | __end_cc_report 08:40:54 INFO - PROCESS | 3416 | __startTimestamp1464968454502__endTimestamp 08:40:54 INFO - PROCESS | 3416 | 08:40:54 INFO - PROCESS | 3416 | ------- Summary: start ------- 08:40:54 INFO - PROCESS | 3416 | Number of tests: 6 08:40:54 INFO - PROCESS | 3416 | 08:40:54 INFO - PROCESS | 3416 | [#0] dojo.html Cycles:165 Average:5408.44 Median:5615.94 stddev:625.03 (11.1%) stddev-sans-first:599.85 08:40:54 INFO - PROCESS | 3416 | Values: 3087.6 3105.5 3117.9 3132.3 3155.2 5248.6 5316.8 5333.4 5403.5 5427.3 5373.0 5411.1 5443.5 5452.5 5462.2 4878.5 4960.3 4970.1 4979.0 5133.9 5048.2 5061.8 5103.3 5105.6 5125.1 4808.3 4922.7 4927.7 4929.9 4975.2 4902.2 4915.4 4966.2 4968.0 5017.9 4862.4 4919.5 4940.2 4955.4 5015.3 5292.9 5296.2 5344.9 5386.6 5417.2 5864.7 5873.9 5882.3 5895.7 5896.4 5693.2 5764.7 5846.9 5936.4 5977.0 5457.7 5498.2 5498.3 5512.0 5515.2 6002.1 6013.6 6017.5 6020.4 6023.5 5615.9 5651.7 5674.9 5695.2 5799.5 5811.1 5864.8 5874.1 5878.2 5883.4 5766.2 5787.7 5787.8 5805.3 5805.7 5569.7 5828.4 5861.9 5885.1 5906.4 4440.5 4448.6 4450.8 4460.3 4485.3 3871.1 3926.6 3985.1 4005.5 4031.2 5330.9 5512.3 5566.6 5571.9 5574.4 5886.8 5908.1 5913.2 5924.2 5941.9 5436.7 5552.1 5558.8 5581.7 5582.5 4831.0 4834.4 4844.8 4874.5 4884.7 6030.8 6032.3 6034.4 6036.6 6042.4 5681.9 5750.3 5816.4 5823.4 5824.9 5974.7 6028.4 6083.4 6084.6 6085.5 5705.5 5748.9 5752.9 5756.2 5762.0 5770.7 5788.8 5828.4 5835.1 5852.2 5603.1 5657.9 5660.3 5662.5 5668.9 5654.5 5655.0 5658.5 5661.1 5661.9 5482.2 5568.6 5569.1 5575.2 5577.5 5692.8 5758.1 5758.6 5820.1 5858.1 5649.1 5651.9 5657.7 5662.3 5677.4 08:40:54 INFO - PROCESS | 3416 | 08:40:54 INFO - PROCESS | 3416 | [#1] ext.html Cycles:180 Average:58145.78 Median:42530.97 stddev:110836.23 (260.6%) stddev-sans-first:111062.97 08:40:54 INFO - PROCESS | 3416 | Values: 609.4 624.2 634.1 642.7 650.3 43546.6 44960.6 45217.1 49447.0 49497.0 46212.3 46962.8 46978.3 47020.3 47081.8 8734.3 8887.5 8902.0 8903.8 8906.4 8845.7 8894.8 8929.1 8930.3 8938.6 8935.0 8985.1 8992.1 8995.1 8996.1 8893.8 8900.2 8937.8 8953.1 8957.0 8750.7 8844.2 8849.6 8850.8 8850.8 42137.6 42506.9 42555.0 42556.0 42671.6 3511.6 3695.9 3720.1 3844.8 4272.2 33291.5 33650.8 33907.0 33995.0 35033.8 4260.8 4444.2 4535.6 4548.1 4554.6 342843.0 342898.0 344420.0 344469.0 346090.0 62209.0 62303.7 62541.0 62622.4 62670.7 65878.0 65998.3 66247.0 66304.3 66339.3 17259.0 17419.6 17443.7 17449.9 17471.9 11913.6 11957.9 11985.9 11989.9 12052.0 17934.5 19701.9 19748.7 19853.6 20022.5 6944.6 6985.2 7037.6 7289.2 7298.2 755.1 1068.5 1081.2 1086.5 1187.2 32310.4 33486.7 33509.7 33550.8 33954.8 1162.0 1168.3 1177.0 1201.1 1239.7 17160.6 17330.9 17377.4 17422.3 17443.1 548652.3 551262.0 556269.0 557629.0 558393.0 60687.7 61441.0 61551.0 61637.4 61643.7 1231.8 1301.1 1361.8 1378.4 1380.2 30465.0 34601.1 34715.1 34721.3 34925.7 52831.2 53098.5 53389.7 53442.0 53467.2 313005.0 314055.0 314215.0 315011.0 315016.0 25670.4 27560.4 28506.6 28743.0 28765.3 49342.5 49926.5 50107.7 50690.7 51454.5 40042.0 41379.6 41908.0 41910.8 43030.0 41764.2 41872.8 42085.8 42260.0 42457.8 41825.8 42477.6 43175.4 43261.8 43440.8 34190.0 36929.4 37388.0 37430.4 37468.4 28099.9 28299.2 28345.7 28436.4 28607.0 08:40:54 INFO - PROCESS | 3416 | 08:40:54 INFO - PROCESS | 3416 | [#2] jquery.html Cycles:180 Average:27766.76 Median:11997.63 stddev:77117.58 (642.8%) stddev-sans-first:77306.51 08:40:54 INFO - PROCESS | 3416 | Values: 385.1 388.8 395.3 398.5 413.1 14401.4 17042.0 18368.4 19766.0 19789.4 14606.9 15386.6 15529.2 19548.5 19687.3 5532.4 5566.2 5649.9 5654.0 5656.0 4046.4 5591.6 5612.4 5618.8 6077.9 6302.3 6381.9 6395.1 6405.4 6406.9 6199.5 6329.4 6374.7 6413.2 6433.4 5618.3 5625.6 5638.4 5643.9 5646.0 13989.1 16175.8 20537.4 21792.1 21805.8 2233.0 2422.9 2449.2 2791.3 3009.8 9974.3 10156.2 10360.5 10536.3 11417.3 1946.4 1949.3 2007.0 2015.5 2189.5 79401.6 80755.0 83262.6 83868.2 84399.0 10190.9 10276.9 10332.5 10582.9 10730.7 13969.2 13971.2 14001.9 14022.9 14040.6 7413.8 7418.0 7646.1 7917.2 8000.3 7326.0 7408.4 7482.4 7899.0 8191.5 4583.8 4713.2 4738.7 4785.1 4863.2 1885.0 1900.5 1940.6 1996.2 2005.1 1048.4 1057.0 1064.1 1069.3 1085.5 18340.3 18649.2 18780.7 18853.3 19314.1 990.1 1027.5 1028.7 1032.6 1035.9 10132.4 10601.6 10610.8 10651.4 10792.2 445757.0 462770.0 466475.0 480243.0 482975.0 54497.7 67081.7 91528.0 91828.1 92013.0 1001.8 1051.6 1074.8 1075.2 1085.1 15543.4 16798.6 16957.6 17039.7 17314.7 40724.2 41802.0 41948.4 42122.6 42512.4 56490.0 57791.4 58585.4 58963.4 59404.7 8446.2 8539.2 8666.7 8783.0 8857.7 9747.6 12914.5 13271.6 13276.7 13414.1 11710.9 11721.8 11844.4 12119.8 12144.2 11477.4 11672.9 11729.2 11891.8 12057.1 11463.1 11583.6 11603.3 11684.2 11712.9 8055.5 8274.5 8401.4 8402.5 8465.5 10831.6 11118.3 11239.6 11328.4 11340.3 08:40:54 INFO - PROCESS | 3416 | 08:40:54 INFO - PROCESS | 3416 | [#3] mootools.html Cycles:180 Average:5883.85 Median:4712.59 stddev:3380.37 (71.7%) stddev-sans-first:3372.51 08:40:54 INFO - PROCESS | 3416 | Values: 1327.1 1512.8 1547.1 1699.5 1831.8 8648.4 8985.7 9004.5 9106.7 9110.5 8859.5 9058.6 9068.5 9068.6 9071.4 2081.3 2292.3 2370.1 2370.2 2391.6 2358.1 2394.1 2395.4 2396.3 2398.6 2307.8 2359.8 2360.3 2363.8 2364.1 2044.8 2315.0 2368.2 2372.7 2381.5 2309.4 2334.1 2339.8 2346.4 2347.8 8728.7 8777.5 8789.2 8791.0 8791.4 5123.7 5286.5 5287.1 5290.0 5291.7 3339.6 3478.9 3517.1 3521.6 3533.5 1173.0 1203.0 1213.3 1228.7 1229.9 12365.1 12537.7 12594.9 12609.9 12614.2 4705.4 4719.7 4757.0 4768.9 4777.3 10564.3 10660.7 10666.9 10670.2 10680.7 4839.5 5243.2 5338.7 5351.1 5353.3 4772.5 4899.2 4908.1 4936.3 4944.7 3991.8 4055.7 4158.0 4196.1 4204.5 1255.8 1265.7 1290.3 1300.3 1311.0 967.8 997.2 1007.1 1013.1 1021.5 5752.0 5951.4 5975.2 6106.8 6221.3 464.5 467.6 473.2 482.5 482.7 3996.9 4115.6 4148.8 4155.8 4162.0 10976.3 11229.7 11329.4 11332.2 11344.9 10639.7 11086.7 11113.3 11222.0 11227.6 8292.6 8393.6 8417.5 8424.9 8469.4 5756.9 5967.8 5995.6 6103.8 6185.2 10032.4 10189.1 10417.8 10425.9 10431.1 10373.8 10376.5 10468.1 10474.1 10481.8 7298.8 7482.7 7495.1 7625.1 7967.4 8129.1 8259.8 8425.7 8426.2 8624.0 7863.0 7973.7 8049.9 8153.8 8164.5 7446.0 7580.7 7629.7 7697.2 7770.9 7018.8 7089.5 7209.0 7220.2 7230.0 5172.4 5214.5 5333.6 5356.8 5443.2 5160.6 5207.5 5251.7 5388.9 5421.5 08:40:54 INFO - PROCESS | 3416 | 08:40:54 INFO - PROCESS | 3416 | [#4] prototype.html Cycles:180 Average:4487.60 Median:5013.39 stddev:1304.29 (26.0%) stddev-sans-first:1269.85 08:40:54 INFO - PROCESS | 3416 | Values: 318.2 327.9 333.3 336.6 337.1 5246.0 5276.8 5308.9 5318.7 5318.9 5007.5 5049.0 5107.3 5124.6 5216.9 3993.5 4032.4 4063.3 4120.8 4136.3 4044.8 4096.7 4106.3 4117.0 4131.5 3924.1 4076.1 4093.7 4111.3 4163.3 4037.5 4047.0 4057.1 4129.6 4134.7 3538.3 3552.0 3552.8 3609.2 3620.8 4856.7 5109.3 5140.1 5161.8 5169.0 4681.6 4682.7 4716.9 4726.2 4736.2 5426.6 5453.3 5487.6 5488.5 5492.7 3836.8 3959.7 3964.4 3974.9 3982.8 5583.6 5627.4 5629.6 5630.9 5708.6 3967.4 3988.0 3990.5 4013.7 4014.6 4067.5 4086.4 4087.7 4103.3 4107.3 4531.3 4653.5 4667.5 4673.0 4685.8 5316.8 5383.5 5448.1 5478.9 5509.9 1336.8 1359.6 1388.4 1397.0 1405.2 891.3 891.6 908.8 913.8 924.0 4733.8 4756.9 4776.0 4789.4 4814.4 4981.6 4988.1 5021.5 5022.5 5040.7 4555.7 4733.9 4786.9 4789.9 4848.5 2643.8 2647.2 2670.6 2675.8 2682.9 5056.0 5146.5 5151.8 5163.5 5169.5 4831.4 5025.1 5031.6 5057.9 5058.5 5098.8 5131.2 5139.9 5141.4 5158.5 4967.1 4971.3 4997.4 5019.3 5035.2 4891.5 4925.2 4942.3 5236.9 5683.9 5797.8 5806.5 5818.6 5931.4 5945.5 4011.3 4025.9 4035.6 4043.7 4057.6 5410.5 5573.3 5647.4 5683.5 5699.0 5435.6 5545.5 5556.8 5574.2 5605.0 5538.3 5541.6 5554.5 5562.6 5582.8 5212.7 5422.9 5451.9 5466.4 5477.8 5545.1 5575.7 5583.4 5594.4 5608.9 5408.8 5466.5 5469.2 5480.8 5490.2 08:40:54 INFO - PROCESS | 3416 | 08:40:54 INFO - PROCESS | 3416 | [#5] yui.html Cycles:180 Average:19557.47 Median:27280.14 stddev:27863.05 (102.1%) stddev-sans-first:27905.41 08:40:54 INFO - PROCESS | 3416 | Values: 746.6 806.2 835.5 836.4 843.3 15239.9 15324.4 15903.6 16055.0 16060.7 13954.1 13973.2 13989.8 13992.4 14041.3 687.0 802.6 818.3 832.1 832.3 815.4 826.5 828.1 828.2 828.4 875.8 880.7 880.8 880.9 881.6 704.4 841.9 862.2 873.4 873.8 627.0 628.1 628.3 629.3 629.4 15178.8 15199.3 15204.1 15220.8 15235.3 14041.6 14516.1 14548.3 14740.1 14774.5 12861.7 13072.1 13134.6 13197.6 13634.2 4353.4 4445.5 4445.9 4470.5 4628.9 72911.3 73171.3 73735.3 74100.6 74334.3 11152.8 11642.8 11673.3 11696.0 11751.6 21083.8 21182.5 21216.4 21247.9 21254.8 8419.3 8483.7 8691.7 8712.2 8868.3 4627.3 4639.2 4650.3 4765.6 4857.3 3357.6 3420.3 3460.3 3462.7 3463.3 605.6 615.7 620.2 621.2 645.1 626.5 658.0 696.8 719.5 730.4 8970.6 9243.6 9277.5 9279.5 9592.0 672.9 714.4 718.9 720.5 721.8 4279.2 4420.9 4429.3 4441.3 4539.4 91419.0 93738.0 94003.5 107236.0 107954.0 62263.7 83104.2 95401.5 98246.5 100074.5 86691.1 87710.2 88660.6 89172.0 91595.5 8557.9 8635.0 8670.9 8874.1 9405.3 37911.8 40971.8 48229.8 49703.0 51385.2 71707.3 73180.3 74390.6 75045.2 78155.6 10742.7 10858.7 10916.5 11259.0 11576.9 11410.9 11716.9 11771.3 11881.0 12091.5 11939.3 11996.3 12064.0 12157.5 12534.8 11838.8 11848.1 11936.5 12139.5 12436.7 11794.3 11826.6 11951.6 11966.5 11974.0 9543.2 9886.9 9986.0 10001.5 10011.7 9911.4 9971.7 10105.5 10117.9 10188.7 08:40:54 INFO - PROCESS | 3416 | -------- Summary: end -------- 08:40:54 INFO - PROCESS | 3416 | 08:40:55 INFO - TEST-INFO | 3416: exit 0 08:40:55 INFO - TEST-OK | dromaeo_css | took 1116685ms 08:40:55 INFO - TEST-START | kraken 08:40:55 INFO - operating with platform_type : linux_ 08:40:55 INFO - Initialising browser for kraken test... 08:40:55 INFO - TEST-INFO | started process 3598 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpv6_7qh/profile http://localhost:44560/getInfo.html) 08:40:59 INFO - PROCESS | 3598 | __metrics Screen width/height:1600/1200 08:40:59 INFO - PROCESS | 3598 | colorDepth:24 08:40:59 INFO - PROCESS | 3598 | Browser inner width/height: 1024/697 08:40:59 INFO - PROCESS | 3598 | __metrics 08:41:00 ERROR - PROCESS | 3598 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:41:01 INFO - TEST-INFO | 3598: exit 0 08:41:01 INFO - Browser initialized. 08:41:01 INFO - Running cycle 1/1 for kraken test... 08:41:01 INFO - TEST-INFO | started process 3680 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpv6_7qh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:41:13 INFO - PROCESS | 3680 | RSS: Main: 156020736 08:41:13 INFO - PROCESS | 3680 | 08:41:15 INFO - PROCESS | 3680 | Cycle 1(1): loaded http://localhost:44560/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44560/tests/kraken/driver.html?testName=audio-beat-detection) 08:41:16 INFO - PROCESS | 3680 | RSS: Main: 214659072 08:41:16 INFO - PROCESS | 3680 | 08:41:19 INFO - PROCESS | 3680 | Cycle 1(1): loaded http://localhost:44560/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44560/tests/kraken/driver.html?testName=audio-dft) 08:41:19 INFO - PROCESS | 3680 | RSS: Main: 201486336 08:41:19 INFO - PROCESS | 3680 | 08:41:22 INFO - PROCESS | 3680 | Cycle 1(1): loaded http://localhost:44560/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44560/tests/kraken/driver.html?testName=audio-fft) 08:41:23 INFO - PROCESS | 3680 | RSS: Main: 268783616 08:41:23 INFO - PROCESS | 3680 | 08:41:25 INFO - PROCESS | 3680 | Cycle 1(1): loaded http://localhost:44560/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44560/tests/kraken/driver.html?testName=audio-oscillator) 08:41:26 INFO - PROCESS | 3680 | RSS: Main: 179671040 08:41:26 INFO - PROCESS | 3680 | 08:41:28 INFO - PROCESS | 3680 | Cycle 1(1): loaded http://localhost:44560/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44560/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:41:28 INFO - PROCESS | 3680 | RSS: Main: 183914496 08:41:28 INFO - PROCESS | 3680 | 08:41:31 INFO - PROCESS | 3680 | Cycle 1(1): loaded http://localhost:44560/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44560/tests/kraken/driver.html?testName=imaging-darkroom) 08:41:32 INFO - PROCESS | 3680 | RSS: Main: 218546176 08:41:32 INFO - PROCESS | 3680 | 08:41:35 INFO - PROCESS | 3680 | Cycle 1(1): loaded http://localhost:44560/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44560/tests/kraken/driver.html?testName=imaging-desaturate) 08:41:36 INFO - PROCESS | 3680 | RSS: Main: 220573696 08:41:36 INFO - PROCESS | 3680 | 08:41:39 INFO - PROCESS | 3680 | Cycle 1(1): loaded http://localhost:44560/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44560/tests/kraken/driver.html?testName=json-parse-financial) 08:41:39 INFO - PROCESS | 3680 | RSS: Main: 220598272 08:41:39 INFO - PROCESS | 3680 | 08:41:41 INFO - PROCESS | 3680 | Cycle 1(1): loaded http://localhost:44560/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44560/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:41:42 INFO - PROCESS | 3680 | RSS: Main: 206827520 08:41:42 INFO - PROCESS | 3680 | 08:41:43 INFO - PROCESS | 3680 | Cycle 1(1): loaded http://localhost:44560/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44560/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:41:44 INFO - PROCESS | 3680 | RSS: Main: 210636800 08:41:44 INFO - PROCESS | 3680 | 08:41:46 INFO - PROCESS | 3680 | Cycle 1(1): loaded http://localhost:44560/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44560/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:41:47 INFO - PROCESS | 3680 | RSS: Main: 216764416 08:41:47 INFO - PROCESS | 3680 | 08:41:49 INFO - PROCESS | 3680 | Cycle 1(1): loaded http://localhost:44560/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44560/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:41:50 INFO - PROCESS | 3680 | RSS: Main: 222564352 08:41:50 INFO - PROCESS | 3680 | 08:41:53 INFO - PROCESS | 3680 | Cycle 1(1): loaded http://localhost:44560/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44560/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:41:53 INFO - PROCESS | 3680 | RSS: Main: 222724096 08:41:53 INFO - PROCESS | 3680 | 08:41:55 INFO - PROCESS | 3680 | Cycle 1(1): loaded http://localhost:44560/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44560/tests/kraken/driver.html?testName=ai-astar) 08:41:55 INFO - PROCESS | 3680 | RSS: Main: 265732096 08:41:55 INFO - PROCESS | 3680 | 08:41:55 INFO - PROCESS | 3680 | __start_tp_report 08:41:55 INFO - PROCESS | 3680 | _x_x_mozilla_page_load 08:41:55 INFO - PROCESS | 3680 | _x_x_mozilla_page_load_details 08:41:55 INFO - PROCESS | 3680 | |i|pagename|runs| 08:41:55 INFO - PROCESS | 3680 | |0;ai-astar;109;113;109;111;109;110;110;109;109;109 08:41:55 INFO - PROCESS | 3680 | |1;audio-beat-detection;161;126;138;154;129;153;154;125;180;124 08:41:55 INFO - PROCESS | 3680 | |2;audio-dft;162;160;160;161;162;164;162;160;160;161 08:41:55 INFO - PROCESS | 3680 | |3;audio-fft;75;75;75;123;75;75;74;75;103;74 08:41:55 INFO - PROCESS | 3680 | |4;audio-oscillator;83;85;108;86;85;85;122;86;84;126 08:41:55 INFO - PROCESS | 3680 | |5;imaging-gaussian-blur;117;116;117;117;117;117;117;117;117;117 08:41:55 INFO - PROCESS | 3680 | |6;imaging-darkroom;147;147;146;147;147;146;146;147;146;145 08:41:55 INFO - PROCESS | 3680 | |7;imaging-desaturate;96;95;95;95;95;95;95;95;95;96 08:41:55 INFO - PROCESS | 3680 | |8;json-parse-financial;53;53;53;55;55;53;53;53;53;54 08:41:55 INFO - PROCESS | 3680 | |9;json-stringify-tinderbox;62;62;62;61;62;62;62;62;61;63 08:41:55 INFO - PROCESS | 3680 | |10;stanford-crypto-aes;78;84;79;80;81;79;80;80;111;79 08:41:55 INFO - PROCESS | 3680 | |11;stanford-crypto-ccm;123;123;123;119;121;123;134;130;126;130 08:41:55 INFO - PROCESS | 3680 | |12;stanford-crypto-pbkdf2;161;162;161;161;160;163;163;164;174;163 08:41:55 INFO - PROCESS | 3680 | |13;stanford-crypto-sha256-iterative;63;64;64;63;62;64;65;62;63;67 08:41:55 INFO - PROCESS | 3680 | __end_tp_report 08:41:55 INFO - PROCESS | 3680 | __start_cc_report 08:41:55 INFO - PROCESS | 3680 | _x_x_mozilla_cycle_collect,1589 08:41:55 INFO - PROCESS | 3680 | __end_cc_report 08:41:55 INFO - PROCESS | 3680 | __startTimestamp1464968515583__endTimestamp 08:41:55 INFO - PROCESS | 3680 | 08:41:55 INFO - PROCESS | 3680 | ------- Summary: start ------- 08:41:55 INFO - PROCESS | 3680 | Number of tests: 14 08:41:55 INFO - PROCESS | 3680 | 08:41:55 INFO - PROCESS | 3680 | [#0] ai-astar Cycles:10 Average:109.80 Median:109.50 stddev:1.32 (1.2%) stddev-sans-first:1.36 08:41:55 INFO - PROCESS | 3680 | Values: 109.0 113.0 109.0 111.0 109.0 110.0 110.0 109.0 109.0 109.0 08:41:55 INFO - PROCESS | 3680 | 08:41:55 INFO - PROCESS | 3680 | [#1] audio-beat-detection Cycles:10 Average:144.40 Median:153.50 stddev:18.89 (12.3%) stddev-sans-first:19.05 08:41:55 INFO - PROCESS | 3680 | Values: 161.0 126.0 138.0 154.0 129.0 153.0 154.0 125.0 180.0 124.0 08:41:55 INFO - PROCESS | 3680 | 08:41:55 INFO - PROCESS | 3680 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.50 stddev:1.32 (0.8%) stddev-sans-first:1.36 08:41:55 INFO - PROCESS | 3680 | Values: 162.0 160.0 160.0 161.0 162.0 164.0 162.0 160.0 160.0 161.0 08:41:55 INFO - PROCESS | 3680 | 08:41:55 INFO - PROCESS | 3680 | [#3] audio-fft Cycles:10 Average:82.40 Median:75.00 stddev:16.81 (22.4%) stddev-sans-first:17.61 08:41:55 INFO - PROCESS | 3680 | Values: 75.0 75.0 75.0 123.0 75.0 75.0 74.0 75.0 103.0 74.0 08:41:55 INFO - PROCESS | 3680 | 08:41:55 INFO - PROCESS | 3680 | [#4] audio-oscillator Cycles:10 Average:95.00 Median:85.00 stddev:16.95 (19.9%) stddev-sans-first:17.41 08:41:55 INFO - PROCESS | 3680 | Values: 83.0 85.0 108.0 86.0 85.0 85.0 122.0 86.0 84.0 126.0 08:41:55 INFO - PROCESS | 3680 | 08:41:55 INFO - PROCESS | 3680 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 08:41:55 INFO - PROCESS | 3680 | Values: 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 08:41:55 INFO - PROCESS | 3680 | 08:41:55 INFO - PROCESS | 3680 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 08:41:55 INFO - PROCESS | 3680 | Values: 147.0 147.0 146.0 147.0 147.0 146.0 146.0 147.0 146.0 145.0 08:41:55 INFO - PROCESS | 3680 | 08:41:55 INFO - PROCESS | 3680 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 08:41:55 INFO - PROCESS | 3680 | Values: 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 08:41:55 INFO - PROCESS | 3680 | 08:41:55 INFO - PROCESS | 3680 | [#8] json-parse-financial Cycles:10 Average:53.50 Median:53.00 stddev:0.85 (1.6%) stddev-sans-first:0.88 08:41:55 INFO - PROCESS | 3680 | Values: 53.0 53.0 53.0 55.0 55.0 53.0 53.0 53.0 53.0 54.0 08:41:55 INFO - PROCESS | 3680 | 08:41:55 INFO - PROCESS | 3680 | [#9] json-stringify-tinderbox Cycles:10 Average:61.90 Median:62.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 08:41:55 INFO - PROCESS | 3680 | Values: 62.0 62.0 62.0 61.0 62.0 62.0 62.0 62.0 61.0 63.0 08:41:55 INFO - PROCESS | 3680 | 08:41:55 INFO - PROCESS | 3680 | [#10] stanford-crypto-aes Cycles:10 Average:83.10 Median:80.00 stddev:9.94 (12.4%) stddev-sans-first:10.37 08:41:55 INFO - PROCESS | 3680 | Values: 78.0 84.0 79.0 80.0 81.0 79.0 80.0 80.0 111.0 79.0 08:41:55 INFO - PROCESS | 3680 | 08:41:55 INFO - PROCESS | 3680 | [#11] stanford-crypto-ccm Cycles:10 Average:125.20 Median:124.50 stddev:4.71 (3.8%) stddev-sans-first:4.93 08:41:55 INFO - PROCESS | 3680 | Values: 123.0 123.0 123.0 119.0 121.0 123.0 134.0 130.0 126.0 130.0 08:41:55 INFO - PROCESS | 3680 | 08:41:55 INFO - PROCESS | 3680 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.20 Median:163.00 stddev:3.99 (2.5%) stddev-sans-first:4.16 08:41:55 INFO - PROCESS | 3680 | Values: 161.0 162.0 161.0 161.0 160.0 163.0 163.0 164.0 174.0 163.0 08:41:55 INFO - PROCESS | 3680 | 08:41:55 INFO - PROCESS | 3680 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.70 Median:64.00 stddev:1.49 (2.3%) stddev-sans-first:1.56 08:41:55 INFO - PROCESS | 3680 | Values: 63.0 64.0 64.0 63.0 62.0 64.0 65.0 62.0 63.0 67.0 08:41:55 INFO - PROCESS | 3680 | -------- Summary: end -------- 08:41:55 INFO - PROCESS | 3680 | 08:41:56 INFO - TEST-INFO | 3680: exit 0 08:41:56 INFO - TEST-OK | kraken | took 61331ms 08:41:56 INFO - SUITE-END | took 1178s 08:41:56 INFO - Completed test suite (00:19:38) 08:41:56 INFO - javascript benchmark 08:41:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3087.6294844618633, 3105.5031195008796, 3117.906462806116, 3132.3422081362914, 3155.195425166582, 5248.5538729207965, 5316.840494785158, 5333.4399888011785, 5403.540699040582, 5427.348718153818, 5373.0, 5411.080116380215, 5443.510084092431, 5452.509274165324, 5462.20797984292, 4878.512148785111, 4960.280759289901, 4970.105381031413, 4979.0, 5133.871653208681, 5048.192289233723, 5061.772220250097, 5103.26002729604, 5105.566026887719, 5125.077486052509, 4808.326834243208, 4922.680025798348, 4927.704337739747, 4929.876753081166, 4975.154223781966, 4902.215645496739, 4915.4347250065985, 4966.15575352191, 4968.0, 5017.89964200714, 4862.41651001882, 4919.458859525449, 4940.184869496528, 4955.380577427822, 5015.32293140425, 5292.92060619091, 5296.152615581488, 5344.866378340534, 5386.569074474032, 5417.187421886709, 5864.736086876101, 5873.853153671193, 5882.264716910387, 5895.734691938873, 5896.439838215363, 5693.231413759131, 5764.7117644117625, 5846.883062338729, 5936.406359364072, 5977.013792724239, 5457.699826509501, 5498.230247765316, 5498.285222920995, 5511.972440137773, 5515.227868098469, 6002.0996850472775, 6013.579049466495, 6017.548683848729, 6020.4280593343565, 6023.45788879003, 5615.943840561542, 5651.689157096317, 5674.943250567524, 5695.1741997410145, 5799.507041901401, 5811.099279611667, 5864.765409383577, 5874.060150375919, 5878.206442130343, 5883.411658834082, 5766.192733017381, 5787.652740835563, 5787.826365209051, 5805.332386775575, 5805.738741756547, 5569.721513924287, 5828.446297601721, 5861.912071318934, 5885.117232415172, 5906.438888305604, 4440.511543730187, 4448.644108471314, 4450.799714012813, 4460.30865215892, 4485.25993211123, 3871.070942973666, 3926.5680775114715, 3985.0834308109297, 4005.499312585927, 4031.1937612477623, 5330.893382132335, 5512.3385193777, 5566.638168519034, 5571.860703482364, 5574.414686457944, 5886.823395298148, 5908.14331921869, 5913.231279933667, 5924.200232968494, 5941.881162376728, 5436.70098144598, 5552.056150454432, 5558.805441809598, 5581.665100094007, 5582.525485333792, 4831.0, 4834.395700537433, 4844.75776211188, 4874.512548745168, 4884.658073934862, 6030.849228769316, 6032.336442991267, 6034.39656034393, 6036.607620504741, 6042.425969532887, 5681.8863622726485, 5750.338711048115, 5816.418358164319, 5823.388544202798, 5824.854378640398, 5974.731137098928, 6028.367021462858, 6083.361247068994, 6084.574079814371, 6085.513158947362, 5705.486506214461, 5748.856278593069, 5752.884942301214, 5756.194132821324, 5761.962846687637, 5770.682612456355, 5788.82633520995, 5828.446297601721, 5835.095560188008, 5852.239208902815, 5603.10350343943, 5657.858553536194, 5660.264165658438, 5662.490375866192, 5668.858278543069, 5654.491095801398, 5655.0103731847585, 5658.519025882846, 5661.0659241226385, 5661.858453538694, 5482.150266708507, 5568.610197286313, 5569.136783798518, 5575.163725441054, 5577.45133166124, 5692.800751973661, 5758.107493338539, 5758.62568933018, 5820.068788993741, 5858.062709966385, 5649.12438572022, 5651.858703532444, 5657.717114144359, 5662.292213473316, 5677.432256774455], "value": 5365.435279235893, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [609.4240942309518, 624.1698540940549, 634.0964126120278, 642.6979319719733, 650.2652003236342, 43546.56453435465, 44960.550394496044, 45217.095658086815, 49447.0, 49497.0, 46212.306815397715, 46962.7651861741, 46978.295325570056, 47020.29469557959, 47081.76459117708, 8734.344924130699, 8887.511186884718, 8901.955490222539, 8903.77740556488, 8906.42108262964, 8845.734627961172, 8894.777630559223, 8929.062448442917, 8930.330225233101, 8938.553072346389, 8934.955325223365, 8985.101489851028, 8992.145746154105, 8995.055519170492, 8996.055414181516, 8893.777655558599, 8900.19898209161, 8937.776555586097, 8953.10468953106, 8956.999999999967, 8750.69372571957, 8844.204021638083, 8849.60176792046, 8850.778730531723, 8850.822983540293, 42137.578624213675, 42506.937326566775, 42555.0, 42556.0, 42671.57328426738, 3511.5610548681416, 3695.8521659133603, 3720.0885782983073, 3844.75009124406, 4272.230998420283, 33291.500627490605, 33650.83174584136, 33907.0, 33995.0, 35033.824830875936, 4260.829566817354, 4444.20004399208, 4535.614472769818, 4548.090381923628, 4554.612857907082, 342843.0, 342898.0, 344420.0, 344469.0, 346090.0, 62209.0, 62303.6884815573, 62541.0, 62622.37377626165, 62670.68664656648, 65878.0, 65998.34001659922, 66247.0, 66304.33695662982, 66339.33660663331, 17259.0, 17419.56451088733, 17443.65112697739, 17449.91275043642, 17471.912640436716, 11913.58302459427, 11957.940210298893, 11985.880141198651, 11989.88010119905, 12051.975582075447, 17934.50394234035, 19701.901490492743, 19748.70376944347, 19853.60292794136, 20022.49943751389, 6944.618046007518, 6985.1617805863625, 7037.6481175941, 7289.198188199294, 7298.190196774174, 755.1245906025667, 1068.4657671164418, 1081.1891081688734, 1086.4513420722485, 1187.1689817127872, 32310.35379292401, 33486.66513334884, 33509.66490335114, 33550.832245839105, 33954.830225849204, 1161.9535218591332, 1168.2873447197373, 1176.952921883115, 1201.1351826684772, 1239.7148655809215, 17160.570985725208, 17330.913345433193, 17377.391791287246, 17422.303107875545, 17443.082659051317, 548652.2567387137, 551262.0, 556269.0, 557629.0, 558393.0, 60687.69656151691, 61441.0, 61551.0, 61637.38362616406, 61643.69178154081, 1231.8152277158497, 1301.0892375337303, 1361.795730640392, 1378.4348417148922, 1380.2132784312846, 30465.0, 34601.134971625914, 34715.13212169716, 34721.30557388889, 34925.65074349326, 52831.207531886284, 53098.4690153109, 53389.73305133449, 53442.0, 53467.19799203093, 313005.0, 314055.0, 314215.0, 315011.0, 315016.0, 25670.358241044123, 27560.448791023668, 28506.57240141358, 28743.0, 28765.28086797847, 49342.50657493379, 49926.50073499219, 50107.74946125246, 50690.74654626851, 51454.48545514647, 40042.0, 41379.58620413757, 41908.0, 41910.79044604879, 43030.0, 41764.1647167061, 41872.79063604662, 42085.78957105195, 42260.0, 42457.787711061246, 41825.790871046665, 42477.57522424736, 43175.35236971511, 43261.78369108134, 43440.78279608582, 34190.0, 36929.44605830861, 37388.0, 37430.438543421325, 37468.43797343096, 28099.859500702365, 28299.24265012864, 28345.716542835133, 28436.43127137487, 28607.0], "value": 20461.866235545294, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.11807959772113, 388.79005337117957, 395.3279424977539, 398.4640658314567, 413.1386060064765, 14401.423943042291, 17042.0, 18368.448946531593, 19766.0, 19789.40631781047, 14606.926965365159, 15386.61533461664, 15529.22353882307, 19548.511287217825, 19687.310944116958, 5532.3914369419335, 5566.192902029194, 5649.915251271234, 5654.038813401731, 5656.038473459522, 4046.3930410438375, 5591.580631452637, 5612.438756124396, 5618.831435056934, 6077.878442431171, 6302.306746257908, 6381.872362552746, 6395.104685344056, 6405.42351188393, 6406.935930640704, 6199.535034872402, 6329.36706329368, 6374.713137908805, 6413.198350206224, 6433.420992110686, 5618.269624948731, 5625.634333768292, 5638.407967163471, 5643.887122257573, 5646.0, 13989.090709103875, 16175.838241617668, 20537.38387848367, 21792.128314867547, 21805.781942180532, 2232.955340893173, 2422.854628722265, 2449.216250799745, 2791.3294018365987, 3009.849507524615, 9974.251931105196, 10156.23828212887, 10360.481975901175, 10536.26246162769, 11417.31496110236, 1946.4355336952267, 1949.33722534339, 2006.9899650501654, 2015.4759762461865, 2189.4854709143337, 79401.60299198524, 80754.99999999942, 83262.58368708179, 83868.17430772631, 84399.0, 10190.898091019144, 10276.897231027595, 10332.483375831178, 10582.94708526468, 10730.73173170677, 13969.23169225682, 13971.161730296215, 14001.85998140026, 14022.85977140236, 14040.578782636538, 7413.8146546336775, 7418.0, 7646.120696119906, 7917.247861453153, 8000.279974802295, 7326.0, 7408.370288525428, 7482.3639990601405, 7899.0, 8191.508509489449, 4583.770811459481, 4713.222318317507, 4738.715677059387, 4785.138675038526, 4863.197572400514, 1884.9717254241198, 1900.4678689966831, 1940.5730739237345, 1996.2314508913882, 2005.1077270614728, 1048.3762161513887, 1056.9894301057045, 1064.1486810551528, 1069.2942657845786, 1085.473545330514, 18340.266389344277, 18649.160787764584, 18780.7182892254, 18853.340133095277, 19314.13086411115, 990.108901988202, 1027.4965267019106, 1028.7428142964259, 1032.607609108534, 1035.9015893490107, 10132.44271565071, 10601.575936962436, 10610.750639919019, 10651.414172220602, 10792.244542881923, 445757.0, 462770.0, 466475.0, 480243.0, 482975.0, 54497.72751136219, 67081.66459167673, 91528.0, 91828.08171918195, 92013.0, 1001.8497225416392, 1051.6266725312557, 1074.7796701676139, 1075.2150929821273, 1085.1102096280974, 15543.37826486973, 16798.580035498722, 16957.576060598585, 17039.659206816043, 17314.65370692604, 40724.18551628892, 41802.0, 41948.37077443902, 42122.57877421309, 42512.36231456592, 56490.0, 57791.422085778606, 58585.414145858, 58963.41036589751, 59404.70297648657, 8446.239838414573, 8539.188777066169, 8666.653333866827, 8783.0, 8857.689980850639, 9747.561359738971, 12914.547990820276, 13271.601851944457, 13276.668083297995, 13414.12808167466, 11710.94144529272, 11721.765564688829, 11844.407779610812, 12119.757604847677, 12144.210626309261, 11477.426128693698, 11672.941635291769, 11729.237599556001, 11891.76216475683, 12057.095717821023, 11463.140264480364, 11583.594574189863, 11603.303801771921, 11684.18210725241, 11712.941435292769, 8055.516668999879, 8274.462159959583, 8401.411901166859, 8402.453840500348, 8465.492070475791, 10831.620893268699, 11118.332900026024, 11239.55041798319, 11328.376939268419, 11340.262882912584], "value": 9086.273687357903, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1327.117466884522, 1512.8260250071241, 1547.149068012593, 1699.5496193508723, 1831.844293235075, 8648.351373646978, 8985.685501007467, 9004.45973241606, 9106.726798196065, 9110.453372797636, 8859.46843189409, 9058.637654493828, 9068.455892646445, 9068.591913363898, 9071.410358326704, 2081.2819577245828, 2292.33522278539, 2370.146747171017, 2370.2059809963685, 2391.629297458888, 2358.1157066100213, 2394.0543485323287, 2395.4370722880108, 2396.341006223285, 2398.64020396941, 2307.792298693117, 2359.764023597635, 2360.3155085025323, 2363.7872591466767, 2364.054378248697, 2044.846636502261, 2314.953700925972, 2368.1948137633117, 2372.7034120734907, 2381.4641705616273, 2309.4226443389152, 2334.054707843326, 2339.7660233976635, 2346.389938615955, 2347.812175025994, 8728.738137855875, 8777.517236551987, 8789.208971192624, 8790.956045219797, 8791.428557143829, 5123.718195499246, 5286.524212820865, 5287.07476191665, 5290.0477913975465, 5291.708956007418, 3339.5825521809775, 3478.8782392616135, 3517.120719820045, 3521.5950165730756, 3533.4523148911703, 1172.976540469186, 1203.0495908232485, 1213.3326670331282, 1228.7112528555783, 1229.8524177098716, 12365.134440589163, 12537.74924501505, 12594.937025314815, 12609.936950315281, 12614.180078294881, 4705.435347758223, 4719.7404142772475, 4756.976215118972, 4768.904621907612, 4777.283407488904, 10564.260501764957, 10660.733481663021, 10666.893331066745, 10670.199735019749, 10680.732981675521, 4839.467658557556, 5243.239730239094, 5338.652987555796, 5351.117065684196, 5353.277307563507, 4772.522747725269, 4899.240617704261, 4908.11653902301, 4936.284238785356, 4944.653874228841, 3991.8055610803444, 4055.655269302142, 4157.958420415817, 4196.139791342767, 4204.51648060477, 1255.8492980842357, 1265.7405231927432, 1290.2774446310095, 1300.2718477652545, 1310.9803352949714, 967.7677357434166, 997.2022382094295, 1007.0986467111894, 1013.1287093099928, 1021.5352014833381, 5751.971240143773, 5951.434613711691, 5975.19334889793, 6106.786262480792, 6221.253449585988, 464.4797826434415, 467.5558219691307, 473.1648640150138, 482.4548260465721, 482.73449602718364, 3996.8601098961976, 4115.609017143366, 4148.8133034013545, 4155.750654960712, 4162.021924847659, 10976.286541374786, 11229.719257018476, 11329.43352832355, 11332.2067455279, 11344.886551134548, 10639.73400664974, 11086.722831929266, 11113.333200008025, 11221.990020898158, 11227.55089796399, 8292.626831792584, 8393.580320983927, 8417.452865563597, 8424.915750842536, 8469.449485783527, 5756.884862302814, 5967.76128954837, 5995.550333725076, 6103.816885493442, 6185.158590635494, 10032.448215348226, 10189.082982531607, 10417.843732344172, 10425.895741042492, 10431.061204491632, 10373.844392334271, 10376.481175941324, 10468.110210632181, 10474.109700675528, 10481.790364192826, 7298.781036568911, 7482.663280152515, 7495.100587929265, 7625.123110842324, 7967.442279040643, 8129.065157506726, 8259.83480330402, 8425.70510032146, 8426.241638252586, 8623.956880215559, 7863.0, 7973.72091976778, 8049.879251811345, 8153.8369232616205, 8164.510129392255, 7446.0, 7580.658870350958, 7629.7329593463965, 7697.191794861683, 7770.883436748566, 7018.789436316919, 7089.503734738519, 7209.0, 7220.169680486812, 7229.963850180716, 5172.431032586337, 5214.452482489436, 5333.626646134733, 5356.839294821161, 5443.237946687546, 5160.612954028388, 5207.505286997729, 5251.658642188246, 5388.892222155613, 5421.457854214547], "value": 4630.07838062019, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [318.20448877805484, 327.90326853578193, 333.2551746845801, 336.58599922095834, 337.0848147280134, 5246.0, 5276.786339142, 5308.920366194506, 5318.734063296829, 5318.867028324294, 5007.49925007499, 5049.0, 5107.284980102789, 5124.590032797377, 5216.8695782605355, 3993.54074281457, 4032.3951407288846, 4063.3092374296293, 4120.773357465338, 4136.3381858902585, 4044.8382064717525, 4096.651784598313, 4106.342985122381, 4116.958830411688, 4131.462909821719, 3924.097457584757, 4076.1236334188143, 4093.6520395766247, 4111.259973204822, 4163.250614889319, 4037.454943582608, 4046.979765101156, 4057.1479989202303, 4129.648979836733, 4134.7182373464175, 3538.3454060998542, 3551.982240088809, 3552.7513074084823, 3609.2420591675777, 3620.837062332201, 4856.737248315428, 5109.259157422191, 5140.149546163379, 5161.845144645629, 5168.9741551292, 4681.648876334254, 4682.695624784412, 4716.858494245143, 4726.2201736713405, 4736.171170045228, 5426.62013659044, 5453.345598528163, 5487.5609951203805, 5488.451154884519, 5492.725363731797, 3836.827342769554, 3959.703022273341, 3964.405339199114, 3974.9006274843073, 3982.820773065219, 5583.637063590853, 5627.352854421753, 5629.577781666391, 5630.915536266959, 5708.628939118944, 3967.3652215645934, 3988.0428697112484, 3990.541087774943, 4013.678905687538, 4014.611306272763, 4067.491563554556, 4086.4483294755423, 4087.6525495332635, 4103.343465045578, 4107.342825147962, 4531.274996000624, 4653.534646535387, 4667.509911459248, 4673.009274064601, 4685.797675092701, 5316.787328506894, 5383.488568586056, 5448.128299472065, 5478.876830249789, 5509.917351239735, 1336.8061631063442, 1359.592122363287, 1388.3752311459682, 1396.9732246798594, 1405.2341473896752, 891.2736120062128, 891.5542228885557, 908.7550056422612, 913.8126684029758, 924.0159230419582, 4733.83431579893, 4756.9286460703115, 4775.95224047762, 4789.401324834395, 4814.350062741485, 4981.601471882241, 4988.127077761377, 5021.548060674557, 5022.51385564148, 5040.722760248148, 4555.726656400627, 4733.905321893543, 4786.856394308176, 4789.9042019160115, 4848.539388758062, 2643.8149329546745, 2647.2455350225096, 2670.559357705996, 2675.826071305398, 2682.9060982865894, 5056.0, 5146.511081447256, 5151.8196863109615, 5163.483651634881, 5169.483051694876, 4831.444383895827, 5025.095482813055, 5031.647784655039, 5057.949420505748, 5058.46886076964, 5098.796048158032, 5131.230315452712, 5139.897202055938, 5141.434442211354, 5158.509941555546, 4967.130752118293, 4971.254311853251, 4997.3758528477665, 5019.272205530251, 5035.194368900959, 4891.5353041461, 4925.1627223372825, 4942.283368911416, 5236.895262094813, 5683.863227354628, 5797.8114486531, 5806.506446952057, 5818.592698511233, 5931.4068593142065, 5945.494632956247, 4011.2779699654343, 4025.8590949316635, 4035.648057900636, 4043.73715708478, 4057.6145266199665, 5410.458954104558, 5573.331200255995, 5647.407022262603, 5683.460071293221, 5698.971505142447, 5435.619506634655, 5545.473180047889, 5556.805511807067, 5574.219609254626, 5604.971975140098, 5538.307711536058, 5541.6145963509125, 5554.472325129106, 5562.554995600423, 5582.766893242735, 5212.687238765686, 5422.9186562202385, 5451.863703407446, 5466.3986961435, 5477.808276710455, 5545.112781954868, 5575.693336866511, 5583.441655834384, 5594.384617692132, 5608.915866262091, 5408.781774843961, 5466.535344495763, 5469.206964989975, 5480.753366098455, 5490.176473529003], "value": 4074.087272847771, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [746.6005686957476, 806.1978331560097, 835.4945258118842, 836.3810780022783, 843.3379796859466, 15239.923800380997, 15324.387024519006, 15903.602409939756, 16055.036697798125, 16060.678786424265, 13954.092983956036, 13973.161610303388, 13989.790153147711, 13992.440302387919, 14041.29793510323, 686.9931300687005, 802.626778547975, 818.3494122172887, 832.1179549677331, 832.3258160889699, 815.4006804998321, 826.5082276045773, 828.1139181076251, 828.1511450762986, 828.3828547731948, 875.7591662292857, 880.7137680253911, 880.828238493494, 880.8942926848755, 881.6209030117047, 704.3519961635283, 841.8779277004861, 862.1637012098255, 873.4104479476359, 873.8164985353084, 626.9843253918643, 628.0610487321438, 628.2994461175801, 629.3486241739823, 629.4492319220682, 15178.848211517854, 15199.316030778642, 15204.08775473464, 15220.771688424682, 15235.314410851539, 14041.64895877601, 14516.05645633041, 14548.345324460424, 14740.11559306445, 14774.481349565134, 12861.67845803853, 13072.08495405322, 13134.60596182116, 13197.604071877859, 13634.181949083088, 4353.412289340962, 4445.533219012022, 4445.933311000337, 4470.530594287618, 4628.861134165981, 72911.27088729097, 73171.26828731698, 73735.26264737337, 74100.62949685217, 74334.25665743327, 11152.776944461066, 11642.825357619642, 11673.299602023906, 11696.005839503738, 11751.647450576496, 21083.78916210849, 21182.47043823886, 21216.36350909475, 21247.893760531406, 21254.78745212559, 8419.326453883674, 8483.660653573912, 8691.695790647296, 8712.172343627346, 8868.33487488428, 4627.305904114342, 4639.2113340731485, 4650.279206722963, 4765.571098601074, 4857.271409288635, 3357.5803024621923, 3420.3159368126476, 3460.2733425980828, 3462.6883580477374, 3463.2554000889427, 605.642670824207, 615.7075389190188, 620.2092332276384, 621.1862460177182, 645.0904225042667, 626.5113211694885, 657.9671016449158, 696.7944456385277, 719.4783781758183, 730.4010711216752, 8970.641174352953, 9243.584038718274, 9277.536123193813, 9279.536023198812, 9591.952040239754, 672.922613899398, 714.4070421550101, 718.9065421495277, 720.5291168300786, 721.8051126195897, 4279.2083464559155, 4420.9336859947125, 4429.269170586882, 4441.289393697058, 4539.387182730356, 91419.0, 93738.0, 94003.52998235101, 107236.0, 107954.0, 62263.68868155721, 83104.16895830964, 95401.52299238459, 98246.5087674557, 100074.49962750285, 86691.13308866957, 87710.22636697016, 88660.5566972174, 89172.0, 91595.54202228946, 8557.871631925402, 8635.0, 8670.869936950825, 8874.112588741074, 9405.294602904947, 37911.81044094762, 40971.79514102411, 48229.75885120552, 49703.0, 51385.229221562455, 71707.28292717006, 73180.26819731735, 74390.62804685942, 75045.24954750601, 78155.60922195352, 10742.721449523975, 10858.728531786768, 10916.454177291262, 11259.0, 11576.94211528937, 11410.885891141314, 11716.94141529287, 11771.293722376684, 11880.981899330523, 12091.516339346328, 11939.283642981449, 11996.280223186637, 12064.0, 12157.452914618687, 12534.811977820158, 11838.752142271745, 11848.111391645833, 11936.52253909834, 12139.514419423123, 12436.689082773004, 11794.29234245948, 11826.645200643994, 11951.641450756491, 11966.521339146337, 11974.0, 9543.236541076558, 9886.85169722469, 9985.950070249603, 10001.499925003574, 10011.749706257111, 9911.355761875455, 9971.700848974542, 10105.494725263561, 10117.949410252902, 10188.745281368025], "value": 7292.434790437548, "unit": "score"}], "name": "dromaeo_css", "value": 7182.0052948442535, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 113.0, 109.0, 111.0, 109.0, 110.0, 110.0, 109.0, 109.0, 109.0], "value": 109.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 126.0, 138.0, 154.0, 129.0, 153.0, 154.0, 125.0, 180.0, 124.0], "value": 144.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 160.0, 161.0, 162.0, 164.0, 162.0, 160.0, 160.0, 161.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 123.0, 75.0, 75.0, 74.0, 75.0, 103.0, 74.0], "value": 82.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 85.0, 108.0, 86.0, 85.0, 85.0, 122.0, 86.0, 84.0, 126.0], "value": 95.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 147.0, 147.0, 146.0, 146.0, 147.0, 146.0, 145.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 53.0, 55.0, 55.0, 53.0, 53.0, 53.0, 53.0, 54.0], "value": 53.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 61.0, 62.0, 62.0, 62.0, 62.0, 61.0, 63.0], "value": 61.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 84.0, 79.0, 80.0, 81.0, 79.0, 80.0, 80.0, 111.0, 79.0], "value": 83.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 123.0, 123.0, 119.0, 121.0, 123.0, 134.0, 130.0, 126.0, 130.0], "value": 125.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 161.0, 161.0, 160.0, 163.0, 163.0, 164.0, 174.0, 163.0], "value": 163.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 64.0, 63.0, 62.0, 64.0, 65.0, 62.0, 63.0, 67.0], "value": 63.7, "unit": "score"}], "name": "kraken", "value": 1501.9, "alertThreshold": 2.0}]} 08:41:56 INFO - Return code: 0 08:41:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:41:56 ERROR - # TBPL SUCCESS # 08:41:56 INFO - Running post-action listener: _resource_record_post_action 08:41:56 INFO - ##### 08:41:56 INFO - ##### Finished run-tests step (success) 08:41:56 INFO - ##### 08:41:56 INFO - Running post-run listener: _resource_record_post_run 08:41:56 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 7680000; Write bytes: 303349760; Read time: 708; Write time: 249588 08:41:56 INFO - TinderboxPrint: CPU usage
13.2% 08:41:56 INFO - TinderboxPrint: I/O read bytes / time
7,680,000 / 708 08:41:56 INFO - TinderboxPrint: I/O write bytes / time
303,349,760 / 249,588 08:41:56 INFO - TinderboxPrint: CPU idle
8,285.2 (86.8%) 08:41:56 INFO - TinderboxPrint: CPU user
1,214.0 (12.7%) 08:41:56 INFO - TinderboxPrint: Swap in / out
0 / 0 08:41:56 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 15319040; Read time: 0; Write time: 6688 08:41:56 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 5918720; Write bytes: 288030720; Read time: 652; Write time: 242900 08:41:57 INFO - Running post-run listener: _upload_blobber_files 08:41:57 INFO - Blob upload gear active. 08:41:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:41:57 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 08:41:57 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'] 08:41:57 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 08:41:57 INFO - (blobuploader) - INFO - Open directory for files ... 08:41:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:41:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:41:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:42:02 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:42:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:42:02 INFO - (blobuploader) - INFO - Done attempting. 08:42:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:42:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:42:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:42:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:42:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:42:03 INFO - (blobuploader) - INFO - Done attempting. 08:42:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:42:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:42:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:42:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:42:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:42:03 INFO - (blobuploader) - INFO - Done attempting. 08:42:03 INFO - (blobuploader) - INFO - Iteration through files over. 08:42:03 INFO - Return code: 0 08:42:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:42:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:42:03 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/04ee7140c338aa0df4b836fff16c51c026bf49f54901a3f7ab561e9ff656f3cf7c9172ccc06deec5cbb036ab598518b2d32f24349cc498f08fb6ae221bc11ad1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c5569b8a734a4d35f57200880fb773e7d7a56ae289a205c18b356107b27e2f2a8a715ecc5d6d56169c6c3c9284415c622721bad88be6aa5ed54a9c04af34acce", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8a261af39866c8c9ab6a0df3633fda6e677a6c7ccec960624ac8de0ead7b29ddac7ce7e590f0cf9f124b1cb8a6e74e22f6057e1d3226c1e40bc6fe0bc9631097"} 08:42:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:42:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:42:03 INFO - Contents: 08:42:03 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/04ee7140c338aa0df4b836fff16c51c026bf49f54901a3f7ab561e9ff656f3cf7c9172ccc06deec5cbb036ab598518b2d32f24349cc498f08fb6ae221bc11ad1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c5569b8a734a4d35f57200880fb773e7d7a56ae289a205c18b356107b27e2f2a8a715ecc5d6d56169c6c3c9284415c622721bad88be6aa5ed54a9c04af34acce", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8a261af39866c8c9ab6a0df3633fda6e677a6c7ccec960624ac8de0ead7b29ddac7ce7e590f0cf9f124b1cb8a6e74e22f6057e1d3226c1e40bc6fe0bc9631097"} 08:42:03 INFO - Running post-run listener: copy_logs_to_upload_dir 08:42:03 INFO - Copying logs to upload dir... 08:42:03 INFO - mkdir: /builds/slave/test/build/upload/logs 08:42:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1259.906687 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2016-06-03 08:42:04.023402) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-03 08:42:04.027181) ========= 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=1f5564757af27664ca02d71f000001b0-1464966917.239381-2065992589 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/04ee7140c338aa0df4b836fff16c51c026bf49f54901a3f7ab561e9ff656f3cf7c9172ccc06deec5cbb036ab598518b2d32f24349cc498f08fb6ae221bc11ad1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c5569b8a734a4d35f57200880fb773e7d7a56ae289a205c18b356107b27e2f2a8a715ecc5d6d56169c6c3c9284415c622721bad88be6aa5ed54a9c04af34acce", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8a261af39866c8c9ab6a0df3633fda6e677a6c7ccec960624ac8de0ead7b29ddac7ce7e590f0cf9f124b1cb8a6e74e22f6057e1d3226c1e40bc6fe0bc9631097"} build_url:https://queue.taskcluster.net/v1/task/WP2Ilp0jQ4eDbNgq8ejirw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011238 build_url: 'https://queue.taskcluster.net/v1/task/WP2Ilp0jQ4eDbNgq8ejirw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/04ee7140c338aa0df4b836fff16c51c026bf49f54901a3f7ab561e9ff656f3cf7c9172ccc06deec5cbb036ab598518b2d32f24349cc498f08fb6ae221bc11ad1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c5569b8a734a4d35f57200880fb773e7d7a56ae289a205c18b356107b27e2f2a8a715ecc5d6d56169c6c3c9284415c622721bad88be6aa5ed54a9c04af34acce", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8a261af39866c8c9ab6a0df3633fda6e677a6c7ccec960624ac8de0ead7b29ddac7ce7e590f0cf9f124b1cb8a6e74e22f6057e1d3226c1e40bc6fe0bc9631097"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-03 08:42:04.056061) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 08:42:04.056429) ========= 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=1f5564757af27664ca02d71f000001b0-1464966917.239381-2065992589 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004352 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 08:42:04.135817) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-03 08:42:04.136172) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-03 08:42:04.136520) ========= ========= Total master_lag: 0.20 =========