builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-056 starttime: 1465201435.72 results: success (0) buildid: 20160605222917 builduid: 249ac4edb00748ec80a4e9677a872098 revision: 824355c9efe2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 01:23:55.722120) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 01:23:55.722506) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 01:23:55.722781) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 01:23:55.760459) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 01:23:55.760771) ========= 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=52faae308a556c440401f8e5000001e8-1465199673.560878-951992028 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-06 01:23:55-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 220M=0s 2016-06-06 01:23:55 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.110175 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 01:23:55.888351) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 01:23:55.891695) ========= 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=52faae308a556c440401f8e5000001e8-1465199673.560878-951992028 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015903 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 01:23:55.941948) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-06 01:23:55.942269) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 824355c9efe2 --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 824355c9efe2 --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=52faae308a556c440401f8e5000001e8-1465199673.560878-951992028 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-06 01:23:56,084 Setting DEBUG logging. 2016-06-06 01:23:56,084 attempt 1/10 2016-06-06 01:23:56,084 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/824355c9efe2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-06 01:23:56,935 unpacking tar archive at: fx-team-824355c9efe2/testing/mozharness/ program finished with exit code 0 elapsedTime=1.918766 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-06 01:23:57.877273) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 01:23:57.877598) ========= script_repo_revision: 824355c9efe2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 01:23:57.878093) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 01:23:57.878360) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 01:23:57.887098) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-06-06 01:23:57.887519) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=52faae308a556c440401f8e5000001e8-1465199673.560878-951992028 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:23:58 INFO - MultiFileLogger online at 20160606 01:23:58 in /builds/slave/test 01:23:58 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 01:23:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:23:58 INFO - {'append_to_log': False, 01:23:58 INFO - 'base_work_dir': '/builds/slave/test', 01:23:58 INFO - 'blob_upload_branch': 'Fx-Team', 01:23:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:23:58 INFO - 'branch': 'Fx-Team', 01:23:58 INFO - 'buildbot_json_path': 'buildprops.json', 01:23:58 INFO - 'config_files': ('talos/linux_config.py',), 01:23:58 INFO - 'default_actions': ('clobber', 01:23:58 INFO - 'read-buildbot-config', 01:23:58 INFO - 'download-and-extract', 01:23:58 INFO - 'populate-webroot', 01:23:58 INFO - 'create-virtualenv', 01:23:58 INFO - 'install', 01:23:58 INFO - 'run-tests'), 01:23:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:23:58 INFO - 'download_minidump_stackwalk': True, 01:23:58 INFO - 'download_symbols': 'ondemand', 01:23:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:23:58 INFO - 'tooltool.py': '/tools/tooltool.py', 01:23:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:23:58 INFO - '/tools/misc-python/virtualenv.py')}, 01:23:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:23:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:23:58 INFO - 'installer_path': 'installer.exe', 01:23:58 INFO - 'log_level': 'info', 01:23:58 INFO - 'log_name': 'talos', 01:23:58 INFO - 'log_to_console': True, 01:23:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:23:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:23:58 INFO - 'opt_config_files': (), 01:23:58 INFO - 'pip_index': False, 01:23:58 INFO - 'sps_profile': False, 01:23:58 INFO - 'sps_profile_interval': 0, 01:23:58 INFO - 'suite': 'dromaeojs-e10s', 01:23:58 INFO - 'system_bits': '32', 01:23:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:23:58 INFO - 'title': 'talos-linux64-ix-056', 01:23:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:23:58 INFO - 'use_talos_json': True, 01:23:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:23:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:23:58 INFO - 'work_dir': 'build'} 01:23:58 INFO - ##### 01:23:58 INFO - ##### Running clobber step. 01:23:58 INFO - ##### 01:23:58 INFO - Running pre-action listener: _resource_record_pre_action 01:23:58 INFO - Running main action method: clobber 01:23:58 INFO - rmtree: /builds/slave/test/build 01:23:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:23:58 INFO - Running post-action listener: _resource_record_post_action 01:23:58 INFO - ##### 01:23:58 INFO - ##### Finished clobber step (success) 01:23:58 INFO - ##### 01:23:58 INFO - ##### 01:23:58 INFO - ##### Running read-buildbot-config step. 01:23:58 INFO - ##### 01:23:58 INFO - Running pre-action listener: _resource_record_pre_action 01:23:58 INFO - Running main action method: read_buildbot_config 01:23:58 INFO - Using buildbot properties: 01:23:58 INFO - { 01:23:58 INFO - "project": "", 01:23:58 INFO - "product": "firefox", 01:23:58 INFO - "script_repo_revision": "production", 01:23:58 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 01:23:58 INFO - "repository": "", 01:23:58 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 01:23:58 INFO - "buildid": "20160605222917", 01:23:58 INFO - "pgo_build": "True", 01:23:58 INFO - "basedir": "/builds/slave/test", 01:23:58 INFO - "buildnumber": 423, 01:23:58 INFO - "slavename": "talos-linux64-ix-056", 01:23:58 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 01:23:58 INFO - "platform": "ubuntu64_hw", 01:23:58 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 01:23:58 INFO - "branch": "fx-team", 01:23:58 INFO - "repo_path": "integration/fx-team", 01:23:58 INFO - "revision": "824355c9efe2", 01:23:58 INFO - "stage_platform": "linux64-pgo", 01:23:58 INFO - "builduid": "249ac4edb00748ec80a4e9677a872098", 01:23:58 INFO - "slavebuilddir": "test" 01:23:58 INFO - } 01:23:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/ADRw_p8bRw2YRKSoUmpygw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 01:23:58 INFO - Running post-action listener: _resource_record_post_action 01:23:58 INFO - ##### 01:23:58 INFO - ##### Finished read-buildbot-config step (success) 01:23:58 INFO - ##### 01:23:58 INFO - ##### 01:23:58 INFO - ##### Running download-and-extract step. 01:23:58 INFO - ##### 01:23:58 INFO - Running pre-action listener: _resource_record_pre_action 01:23:58 INFO - Running main action method: download_and_extract 01:23:58 INFO - mkdir: /builds/slave/test/build/tests 01:23:58 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')]} 01:23:58 INFO - https://queue.taskcluster.net/v1/task/ADRw_p8bRw2YRKSoUmpygw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 01:23:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ADRw_p8bRw2YRKSoUmpygw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 01:23:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ADRw_p8bRw2YRKSoUmpygw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 01:23:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ADRw_p8bRw2YRKSoUmpygw/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 01:23:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ADRw_p8bRw2YRKSoUmpygw/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 01:24:00 INFO - Downloaded 1361 bytes. 01:24:00 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 01:24:00 INFO - Using the following test package requirements: 01:24:00 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 01:24:00 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:24:00 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:24:00 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:24:00 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:24:00 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:24:00 INFO - u'jsshell-linux-x86_64.zip'], 01:24:00 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:24:00 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:24:00 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 01:24:00 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:24:00 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:24:00 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:24:00 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:24:00 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:24:00 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:24:00 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:24:00 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:24:00 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:24:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:24:00 INFO - https://queue.taskcluster.net/v1/task/ADRw_p8bRw2YRKSoUmpygw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:24:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ADRw_p8bRw2YRKSoUmpygw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:24:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ADRw_p8bRw2YRKSoUmpygw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:24:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ADRw_p8bRw2YRKSoUmpygw/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 01:24:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ADRw_p8bRw2YRKSoUmpygw/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 01:24:01 INFO - Downloaded 24441139 bytes. 01:24:01 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'] 01:24:01 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 01:24:03 INFO - Return code: 0 01:24:03 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 01:24:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:24:03 INFO - https://queue.taskcluster.net/v1/task/ADRw_p8bRw2YRKSoUmpygw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:24:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ADRw_p8bRw2YRKSoUmpygw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:24:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ADRw_p8bRw2YRKSoUmpygw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:24:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ADRw_p8bRw2YRKSoUmpygw/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 01:24:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ADRw_p8bRw2YRKSoUmpygw/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 01:24:09 INFO - Downloaded 24441139 bytes. 01:24:09 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'] 01:24:09 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 01:24:11 INFO - Return code: 0 01:24:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:24:11 INFO - https://queue.taskcluster.net/v1/task/ADRw_p8bRw2YRKSoUmpygw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:24:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ADRw_p8bRw2YRKSoUmpygw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 01:24:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ADRw_p8bRw2YRKSoUmpygw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 01:24:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ADRw_p8bRw2YRKSoUmpygw/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 01:24:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ADRw_p8bRw2YRKSoUmpygw/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 01:24:14 INFO - Downloaded 10833369 bytes. 01:24:14 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'] 01:24:14 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 01:24:14 INFO - Return code: 0 01:24:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:24:14 INFO - https://queue.taskcluster.net/v1/task/ADRw_p8bRw2YRKSoUmpygw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:24:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ADRw_p8bRw2YRKSoUmpygw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 01:24:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ADRw_p8bRw2YRKSoUmpygw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 01:24:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ADRw_p8bRw2YRKSoUmpygw/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 01:24:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ADRw_p8bRw2YRKSoUmpygw/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 01:24:15 INFO - Downloaded 59156993 bytes. 01:24:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ADRw_p8bRw2YRKSoUmpygw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 01:24:15 INFO - mkdir: /builds/slave/test/properties 01:24:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:24:15 INFO - Writing to file /builds/slave/test/properties/build_url 01:24:15 INFO - Contents: 01:24:15 INFO - build_url:https://queue.taskcluster.net/v1/task/ADRw_p8bRw2YRKSoUmpygw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 01:24:16 INFO - Running post-action listener: _resource_record_post_action 01:24:16 INFO - Running post-action listener: set_extra_try_arguments 01:24:16 INFO - ##### 01:24:16 INFO - ##### Finished download-and-extract step (success) 01:24:16 INFO - ##### 01:24:16 INFO - ##### 01:24:16 INFO - ##### Running populate-webroot step. 01:24:16 INFO - ##### 01:24:16 INFO - Running pre-action listener: _resource_record_pre_action 01:24:16 INFO - Running main action method: populate_webroot 01:24:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:24:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:24:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:24:16 INFO - '--tppagecycles', 01:24:16 INFO - '7'], 01:24:16 INFO - 'tests': ['tsvgm']}}, 01:24:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:24:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:24:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:24:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:24:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:24:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:24:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:24:16 INFO - 'talos_options': ['--disable-e10s'], 01:24:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:24:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:24:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:24:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:24:16 INFO - 'talos_options': ['--disable-e10s'], 01:24:16 INFO - 'tests': ['damp', 'tps']}, 01:24:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:24:16 INFO - 'tests': ['damp', 'tps']}, 01:24:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:24:16 INFO - 'tests': ['dromaeo_dom']}, 01:24:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:24:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:24:16 INFO - 'tests': ['a11yr', 01:24:16 INFO - 'ts_paint', 01:24:16 INFO - 'tpaint', 01:24:16 INFO - 'sessionrestore', 01:24:16 INFO - 'sessionrestore_no_auto_restore', 01:24:16 INFO - 'tabpaint']}, 01:24:16 INFO - 'other-e10s': {'tests': ['a11yr', 01:24:16 INFO - 'ts_paint', 01:24:16 INFO - 'tpaint', 01:24:16 INFO - 'sessionrestore', 01:24:16 INFO - 'sessionrestore_no_auto_restore', 01:24:16 INFO - 'tabpaint']}, 01:24:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:24:16 INFO - 'ts_paint', 01:24:16 INFO - 'tpaint', 01:24:16 INFO - 'sessionrestore', 01:24:16 INFO - 'sessionrestore_no_auto_restore', 01:24:16 INFO - 'tabpaint']}, 01:24:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:24:16 INFO - 'ts_paint', 01:24:16 INFO - 'tpaint', 01:24:16 INFO - 'sessionrestore', 01:24:16 INFO - 'sessionrestore_no_auto_restore', 01:24:16 INFO - 'tabpaint']}, 01:24:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:24:16 INFO - 'tests': ['a11yr', 01:24:16 INFO - 'ts_paint', 01:24:16 INFO - 'tpaint', 01:24:16 INFO - 'sessionrestore', 01:24:16 INFO - 'sessionrestore_no_auto_restore', 01:24:16 INFO - 'tabpaint']}, 01:24:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:24:16 INFO - 'tests': ['a11yr', 01:24:16 INFO - 'ts_paint', 01:24:16 INFO - 'tpaint', 01:24:16 INFO - 'sessionrestore', 01:24:16 INFO - 'sessionrestore_no_auto_restore', 01:24:16 INFO - 'tabpaint']}, 01:24:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:24:16 INFO - 'tests': ['tsvgx', 01:24:16 INFO - 'tsvgr_opacity', 01:24:16 INFO - 'tart', 01:24:16 INFO - 'tscrollx', 01:24:16 INFO - 'cart']}, 01:24:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:24:16 INFO - 'tsvgr_opacity', 01:24:16 INFO - 'tart', 01:24:16 INFO - 'tscrollx', 01:24:16 INFO - 'cart']}, 01:24:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:24:16 INFO - 'talos_options': ['--disable-e10s'], 01:24:16 INFO - 'tests': ['tp5o']}, 01:24:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:24:16 INFO - 'tests': ['tp5o']}, 01:24:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:24:16 INFO - 'talos_options': ['--disable-e10s', 01:24:16 INFO - '--xperf_path', 01:24:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:24:16 INFO - 'tests': ['tp5n']}, 01:24:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:24:16 INFO - 'talos_options': ['--xperf_path', 01:24:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:24:16 INFO - 'tests': ['tp5n']}}, 01:24:16 INFO - 'talos.zip': {'path': '', 01:24:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:24:16 INFO - Running post-action listener: _resource_record_post_action 01:24:16 INFO - ##### 01:24:16 INFO - ##### Finished populate-webroot step (success) 01:24:16 INFO - ##### 01:24:16 INFO - ##### 01:24:16 INFO - ##### Running create-virtualenv step. 01:24:16 INFO - ##### 01:24:16 INFO - Running pre-action listener: _resource_record_pre_action 01:24:16 INFO - Running main action method: create_virtualenv 01:24:16 INFO - Creating virtualenv /builds/slave/test/build/venv 01:24:16 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 01:24:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:24:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:24:16 INFO - Using real prefix '/usr' 01:24:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:24:17 INFO - Installing distribute.............................................................................................................................................................................................done. 01:24:19 INFO - Installing pip.................done. 01:24:19 INFO - Return code: 0 01:24:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:24:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:24:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:24:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:24:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:24:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24:19 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 0x7f2932fcff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b51350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be01c0>, '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 0x1be10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be1550>, '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': '52faae308a556c440401f8e5000001e8-1465199673.560878-951992028', '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 01:24:19 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 01:24:19 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 01:24:19 INFO - Using env: {'DISPLAY': ':0', 01:24:19 INFO - 'HOME': '/home/cltbld', 01:24:19 INFO - 'LANG': 'en_US.UTF-8', 01:24:19 INFO - 'LANGUAGE': 'en_US:en', 01:24:19 INFO - 'LOGNAME': 'cltbld', 01:24:19 INFO - 'MAIL': '/var/mail/cltbld', 01:24:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:24:19 INFO - 'MOZ_NO_REMOTE': '1', 01:24:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:24:19 INFO - 'NO_EM_RESTART': '1', 01:24:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:24:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:24:19 INFO - 'PWD': '/builds/slave/test', 01:24:19 INFO - 'SHELL': '/bin/bash', 01:24:19 INFO - 'SHLVL': '1', 01:24:19 INFO - 'TERM': 'linux', 01:24:19 INFO - 'TMOUT': '86400', 01:24:19 INFO - 'USER': 'cltbld', 01:24:19 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1465199673.560878-951992028', 01:24:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:24:19 INFO - '_': '/tools/buildbot/bin/python'} 01:24:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:24:19 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 01:24:19 INFO - Cleaning up... 01:24:19 INFO - Return code: 0 01:24:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:24:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:24:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:24:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:24:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:24:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24:19 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 0x7f2932fcff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b51350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be01c0>, '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 0x1be10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be1550>, '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': '52faae308a556c440401f8e5000001e8-1465199673.560878-951992028', '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 01:24:19 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 01:24:19 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 01:24:19 INFO - Using env: {'DISPLAY': ':0', 01:24:19 INFO - 'HOME': '/home/cltbld', 01:24:19 INFO - 'LANG': 'en_US.UTF-8', 01:24:19 INFO - 'LANGUAGE': 'en_US:en', 01:24:19 INFO - 'LOGNAME': 'cltbld', 01:24:19 INFO - 'MAIL': '/var/mail/cltbld', 01:24:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:24:19 INFO - 'MOZ_NO_REMOTE': '1', 01:24:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:24:19 INFO - 'NO_EM_RESTART': '1', 01:24:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:24:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:24:19 INFO - 'PWD': '/builds/slave/test', 01:24:19 INFO - 'SHELL': '/bin/bash', 01:24:19 INFO - 'SHLVL': '1', 01:24:19 INFO - 'TERM': 'linux', 01:24:19 INFO - 'TMOUT': '86400', 01:24:19 INFO - 'USER': 'cltbld', 01:24:19 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1465199673.560878-951992028', 01:24:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:24:19 INFO - '_': '/tools/buildbot/bin/python'} 01:24:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:24:19 INFO - Downloading/unpacking psutil>=3.1.1 01:24:19 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 01:24:19 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 01:24:19 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 01:24:19 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 01:24:19 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 01:24:19 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 01:24:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:24:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:24:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:24:21 INFO - Installing collected packages: psutil 01:24:21 INFO - Running setup.py install for psutil 01:24:21 INFO - building 'psutil._psutil_linux' extension 01:24:21 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 01:24:21 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 01:24:21 INFO - building 'psutil._psutil_posix' extension 01:24:21 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 01:24:22 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 01:24:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:24:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:24:22 INFO - Successfully installed psutil 01:24:22 INFO - Cleaning up... 01:24:23 INFO - Return code: 0 01:24:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:24:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:24:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:24:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:24:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:24:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2932fcff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b51350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be01c0>, '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 0x1be10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be1550>, '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': '52faae308a556c440401f8e5000001e8-1465199673.560878-951992028', '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 01:24:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 01:24:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 01:24:23 INFO - Using env: {'DISPLAY': ':0', 01:24:23 INFO - 'HOME': '/home/cltbld', 01:24:23 INFO - 'LANG': 'en_US.UTF-8', 01:24:23 INFO - 'LANGUAGE': 'en_US:en', 01:24:23 INFO - 'LOGNAME': 'cltbld', 01:24:23 INFO - 'MAIL': '/var/mail/cltbld', 01:24:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:24:23 INFO - 'MOZ_NO_REMOTE': '1', 01:24:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:24:23 INFO - 'NO_EM_RESTART': '1', 01:24:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:24:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:24:23 INFO - 'PWD': '/builds/slave/test', 01:24:23 INFO - 'SHELL': '/bin/bash', 01:24:23 INFO - 'SHLVL': '1', 01:24:23 INFO - 'TERM': 'linux', 01:24:23 INFO - 'TMOUT': '86400', 01:24:23 INFO - 'USER': 'cltbld', 01:24:23 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1465199673.560878-951992028', 01:24:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:24:23 INFO - '_': '/tools/buildbot/bin/python'} 01:24:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:24:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:24:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:24:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:24:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:24:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:24:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:24:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:24:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:24:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:24:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:24:25 INFO - Installing collected packages: mozsystemmonitor 01:24:25 INFO - Running setup.py install for mozsystemmonitor 01:24:25 INFO - Successfully installed mozsystemmonitor 01:24:25 INFO - Cleaning up... 01:24:25 INFO - Return code: 0 01:24:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:24:25 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')]} 01:24:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:24:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24:25 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')]} 01:24:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:24:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24:25 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 0x7f2932fcff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b51350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be01c0>, '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 0x1be10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be1550>, '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': '52faae308a556c440401f8e5000001e8-1465199673.560878-951992028', '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 01:24:25 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 01:24:25 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 01:24:25 INFO - Using env: {'DISPLAY': ':0', 01:24:25 INFO - 'HOME': '/home/cltbld', 01:24:25 INFO - 'LANG': 'en_US.UTF-8', 01:24:25 INFO - 'LANGUAGE': 'en_US:en', 01:24:25 INFO - 'LOGNAME': 'cltbld', 01:24:25 INFO - 'MAIL': '/var/mail/cltbld', 01:24:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:24:25 INFO - 'MOZ_NO_REMOTE': '1', 01:24:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:24:25 INFO - 'NO_EM_RESTART': '1', 01:24:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:24:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:24:25 INFO - 'PWD': '/builds/slave/test', 01:24:25 INFO - 'SHELL': '/bin/bash', 01:24:25 INFO - 'SHLVL': '1', 01:24:25 INFO - 'TERM': 'linux', 01:24:25 INFO - 'TMOUT': '86400', 01:24:25 INFO - 'USER': 'cltbld', 01:24:25 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1465199673.560878-951992028', 01:24:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:24:25 INFO - '_': '/tools/buildbot/bin/python'} 01:24:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:24:25 INFO - Downloading/unpacking jsonschema==2.5.1 01:24:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:24:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:24:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:24:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:24:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:24:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:24:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:24:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:24:27 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 01:24:27 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 01:24:27 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 01:24:27 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 01:24:27 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 01:24:27 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 01:24:27 INFO - Downloading functools32-3.2.3-2.tar.gz 01:24:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:24:27 INFO - warning: no files found matching '*.txt' 01:24:27 INFO - no previously-included directories found matching 'build' 01:24:27 INFO - no previously-included directories found matching 'dist' 01:24:27 INFO - no previously-included directories found matching '.git*' 01:24:27 INFO - Installing collected packages: jsonschema, functools32 01:24:27 INFO - Running setup.py install for functools32 01:24:27 INFO - warning: no files found matching '*.txt' 01:24:27 INFO - no previously-included directories found matching 'build' 01:24:27 INFO - no previously-included directories found matching 'dist' 01:24:27 INFO - no previously-included directories found matching '.git*' 01:24:27 INFO - Successfully installed jsonschema functools32 01:24:27 INFO - Cleaning up... 01:24:27 INFO - Return code: 0 01:24:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:24:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:24:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:24:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:24:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:24:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24:27 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 0x7f2932fcff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b51350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be01c0>, '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 0x1be10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be1550>, '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': '52faae308a556c440401f8e5000001e8-1465199673.560878-951992028', '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 01:24:27 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 01:24:27 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 01:24:27 INFO - Using env: {'DISPLAY': ':0', 01:24:27 INFO - 'HOME': '/home/cltbld', 01:24:27 INFO - 'LANG': 'en_US.UTF-8', 01:24:27 INFO - 'LANGUAGE': 'en_US:en', 01:24:27 INFO - 'LOGNAME': 'cltbld', 01:24:27 INFO - 'MAIL': '/var/mail/cltbld', 01:24:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:24:27 INFO - 'MOZ_NO_REMOTE': '1', 01:24:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:24:27 INFO - 'NO_EM_RESTART': '1', 01:24:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:24:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:24:27 INFO - 'PWD': '/builds/slave/test', 01:24:27 INFO - 'SHELL': '/bin/bash', 01:24:27 INFO - 'SHLVL': '1', 01:24:27 INFO - 'TERM': 'linux', 01:24:27 INFO - 'TMOUT': '86400', 01:24:27 INFO - 'USER': 'cltbld', 01:24:27 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1465199673.560878-951992028', 01:24:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:24:27 INFO - '_': '/tools/buildbot/bin/python'} 01:24:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:24:28 INFO - Downloading/unpacking blobuploader==1.2.4 01:24:28 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 01:24:28 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 01:24:28 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 01:24:28 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 01:24:28 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 01:24:28 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 01:24:29 INFO - Downloading blobuploader-1.2.4.tar.gz 01:24:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:24:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:24:30 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 01:24:30 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 01:24:30 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 01:24:30 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 01:24:30 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 01:24:30 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 01:24:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:24:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:24:30 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 01:24:30 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 01:24:30 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 01:24:30 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 01:24:30 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 01:24:30 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 01:24:30 INFO - Downloading docopt-0.6.1.tar.gz 01:24:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:24:30 INFO - Installing collected packages: blobuploader, requests, docopt 01:24:30 INFO - Running setup.py install for blobuploader 01:24:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:24:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:24:30 INFO - Running setup.py install for requests 01:24:31 INFO - Running setup.py install for docopt 01:24:31 INFO - Successfully installed blobuploader requests docopt 01:24:31 INFO - Cleaning up... 01:24:31 INFO - Return code: 0 01:24:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:24:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:24:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:24:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:24:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:24:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24:31 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 0x7f2932fcff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b51350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be01c0>, '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 0x1be10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be1550>, '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': '52faae308a556c440401f8e5000001e8-1465199673.560878-951992028', '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 01:24:31 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 01:24:31 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 01:24:31 INFO - Using env: {'DISPLAY': ':0', 01:24:31 INFO - 'HOME': '/home/cltbld', 01:24:31 INFO - 'LANG': 'en_US.UTF-8', 01:24:31 INFO - 'LANGUAGE': 'en_US:en', 01:24:31 INFO - 'LOGNAME': 'cltbld', 01:24:31 INFO - 'MAIL': '/var/mail/cltbld', 01:24:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:24:31 INFO - 'MOZ_NO_REMOTE': '1', 01:24:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:24:31 INFO - 'NO_EM_RESTART': '1', 01:24:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:24:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:24:31 INFO - 'PWD': '/builds/slave/test', 01:24:31 INFO - 'SHELL': '/bin/bash', 01:24:31 INFO - 'SHLVL': '1', 01:24:31 INFO - 'TERM': 'linux', 01:24:31 INFO - 'TMOUT': '86400', 01:24:31 INFO - 'USER': 'cltbld', 01:24:31 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1465199673.560878-951992028', 01:24:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:24:31 INFO - '_': '/tools/buildbot/bin/python'} 01:24:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:24:31 INFO - Running setup.py (path:/tmp/pip-1YvPwq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:24:31 INFO - Running setup.py (path:/tmp/pip-bRvU07-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:24:31 INFO - Running setup.py (path:/tmp/pip-MdbwVu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:24:31 INFO - Running setup.py (path:/tmp/pip-kooyxS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:24:31 INFO - Running setup.py (path:/tmp/pip-ZNRgbS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:24:31 INFO - Running setup.py (path:/tmp/pip-cQqrb4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:24:31 INFO - Running setup.py (path:/tmp/pip-1mSKY_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:24:32 INFO - Running setup.py (path:/tmp/pip-nAt34y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:24:32 INFO - Running setup.py (path:/tmp/pip-oGn2Ou-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:24:32 INFO - Running setup.py (path:/tmp/pip-5mRozm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:24:32 INFO - Running setup.py (path:/tmp/pip-EVBLYE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:24:32 INFO - Running setup.py (path:/tmp/pip-_k8_ss-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:24:32 INFO - Running setup.py (path:/tmp/pip-8IjGMy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:24:32 INFO - Running setup.py (path:/tmp/pip-TUF2X0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:24:32 INFO - Running setup.py (path:/tmp/pip-dDtBco-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:24:32 INFO - Running setup.py (path:/tmp/pip-tP01W7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:24:32 INFO - Running setup.py (path:/tmp/pip-azyLpi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:24:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:24:32 INFO - Running setup.py install for manifestparser 01:24:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:24:32 INFO - Running setup.py install for mozcrash 01:24:32 INFO - Running setup.py install for mozdebug 01:24:33 INFO - Running setup.py install for mozdevice 01:24:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:24:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:24:33 INFO - Running setup.py install for mozfile 01:24:33 INFO - Running setup.py install for mozhttpd 01:24:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:24:33 INFO - Running setup.py install for mozinfo 01:24:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:24:33 INFO - Running setup.py install for mozInstall 01:24:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:24:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:24:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:24:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:24:33 INFO - Running setup.py install for mozleak 01:24:33 INFO - Running setup.py install for mozlog 01:24:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:24:33 INFO - Running setup.py install for moznetwork 01:24:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:24:33 INFO - Running setup.py install for mozprocess 01:24:34 INFO - Running setup.py install for mozprofile 01:24:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:24:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:24:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:24:34 INFO - Running setup.py install for mozrunner 01:24:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:24:34 INFO - Running setup.py install for mozscreenshot 01:24:34 INFO - Running setup.py install for moztest 01:24:34 INFO - Running setup.py install for mozversion 01:24:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:24:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:24:34 INFO - Cleaning up... 01:24:34 INFO - Return code: 0 01:24:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:24:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:24:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:24:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:24:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:24:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 0x7f2932fcff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b51350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be01c0>, '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 0x1be10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be1550>, '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': '52faae308a556c440401f8e5000001e8-1465199673.560878-951992028', '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 01:24:34 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 01:24:34 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 01:24:34 INFO - Using env: {'DISPLAY': ':0', 01:24:34 INFO - 'HOME': '/home/cltbld', 01:24:34 INFO - 'LANG': 'en_US.UTF-8', 01:24:34 INFO - 'LANGUAGE': 'en_US:en', 01:24:34 INFO - 'LOGNAME': 'cltbld', 01:24:34 INFO - 'MAIL': '/var/mail/cltbld', 01:24:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:24:34 INFO - 'MOZ_NO_REMOTE': '1', 01:24:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:24:34 INFO - 'NO_EM_RESTART': '1', 01:24:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:24:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:24:34 INFO - 'PWD': '/builds/slave/test', 01:24:34 INFO - 'SHELL': '/bin/bash', 01:24:34 INFO - 'SHLVL': '1', 01:24:34 INFO - 'TERM': 'linux', 01:24:34 INFO - 'TMOUT': '86400', 01:24:34 INFO - 'USER': 'cltbld', 01:24:34 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1465199673.560878-951992028', 01:24:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:24:34 INFO - '_': '/tools/buildbot/bin/python'} 01:24:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:24:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:24:34 INFO - Running setup.py (path:/tmp/pip-KysXNu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:24:34 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)) 01:24:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:24:34 INFO - Running setup.py (path:/tmp/pip-OGs35T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:24:34 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)) 01:24:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:24:34 INFO - Running setup.py (path:/tmp/pip-CBHKXh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:24:35 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)) 01:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:24:35 INFO - Running setup.py (path:/tmp/pip-5OvHgq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:24:35 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)) 01:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:24:35 INFO - Running setup.py (path:/tmp/pip-_iiJje-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:24:35 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)) 01:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:24:35 INFO - Running setup.py (path:/tmp/pip-Xgqsql-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:24:35 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)) 01:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:24:35 INFO - Running setup.py (path:/tmp/pip-ndyca6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:24:35 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)) 01:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:24:35 INFO - Running setup.py (path:/tmp/pip-UqHbgD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:24:35 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)) 01:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:24:35 INFO - Running setup.py (path:/tmp/pip-fK0E91-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:24:35 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)) 01:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:24:35 INFO - Running setup.py (path:/tmp/pip-boV8JO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:24:35 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)) 01:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:24:35 INFO - Running setup.py (path:/tmp/pip-nCadZI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:24:35 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)) 01:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:24:35 INFO - Running setup.py (path:/tmp/pip-4AmuTU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:24:35 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)) 01:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:24:35 INFO - Running setup.py (path:/tmp/pip-DKTQMy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:24:35 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)) 01:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:24:35 INFO - Running setup.py (path:/tmp/pip-iUCa7E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:24:35 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)) 01:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:24:35 INFO - Running setup.py (path:/tmp/pip-6EBMJ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:24:35 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)) 01:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:24:35 INFO - Running setup.py (path:/tmp/pip-SFrfcI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:24:35 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)) 01:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:24:35 INFO - Running setup.py (path:/tmp/pip-F3w8YE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:24:36 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)) 01:24:36 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)) 01:24:36 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)) 01:24:36 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)) 01:24:36 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)) 01:24:36 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)) 01:24:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:24:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:24:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:24:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:24:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:24:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:24:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:24:37 INFO - Downloading blessings-1.6.tar.gz 01:24:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:24:38 INFO - Installing collected packages: blessings 01:24:38 INFO - Running setup.py install for blessings 01:24:38 INFO - Successfully installed blessings 01:24:38 INFO - Cleaning up... 01:24:38 INFO - Return code: 0 01:24:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:24:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:24:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:24:38 INFO - Reading from file tmpfile_stdout 01:24:38 INFO - Current package versions: 01:24:38 INFO - argparse == 1.2.1 01:24:38 INFO - blessings == 1.6 01:24:38 INFO - blobuploader == 1.2.4 01:24:38 INFO - docopt == 0.6.1 01:24:38 INFO - functools32 == 3.2.3-2 01:24:38 INFO - jsonschema == 2.5.1 01:24:38 INFO - manifestparser == 1.1 01:24:38 INFO - mozInstall == 1.12 01:24:38 INFO - mozcrash == 0.17 01:24:38 INFO - mozdebug == 0.1 01:24:38 INFO - mozdevice == 0.48 01:24:38 INFO - mozfile == 1.2 01:24:38 INFO - mozhttpd == 0.7 01:24:38 INFO - mozinfo == 0.9 01:24:38 INFO - mozleak == 0.1 01:24:38 INFO - mozlog == 3.2 01:24:38 INFO - moznetwork == 0.27 01:24:38 INFO - mozprocess == 0.22 01:24:38 INFO - mozprofile == 0.28 01:24:38 INFO - mozrunner == 6.11 01:24:38 INFO - mozscreenshot == 0.1 01:24:38 INFO - mozsystemmonitor == 0.3 01:24:38 INFO - moztest == 0.7 01:24:38 INFO - mozversion == 1.4 01:24:38 INFO - psutil == 3.1.1 01:24:38 INFO - requests == 1.2.3 01:24:38 INFO - wsgiref == 0.1.2 01:24:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:24:38 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')]} 01:24:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:24:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24:38 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')]} 01:24:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:24:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24:38 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 0x7f2932fcff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b51350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be01c0>, '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 0x1be10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be1550>, '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': '52faae308a556c440401f8e5000001e8-1465199673.560878-951992028', '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 01:24:38 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 01:24:38 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 01:24:38 INFO - Using env: {'DISPLAY': ':0', 01:24:38 INFO - 'HOME': '/home/cltbld', 01:24:38 INFO - 'LANG': 'en_US.UTF-8', 01:24:38 INFO - 'LANGUAGE': 'en_US:en', 01:24:38 INFO - 'LOGNAME': 'cltbld', 01:24:38 INFO - 'MAIL': '/var/mail/cltbld', 01:24:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:24:38 INFO - 'MOZ_NO_REMOTE': '1', 01:24:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:24:38 INFO - 'NO_EM_RESTART': '1', 01:24:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:24:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:24:38 INFO - 'PWD': '/builds/slave/test', 01:24:38 INFO - 'SHELL': '/bin/bash', 01:24:38 INFO - 'SHLVL': '1', 01:24:38 INFO - 'TERM': 'linux', 01:24:38 INFO - 'TMOUT': '86400', 01:24:38 INFO - 'USER': 'cltbld', 01:24:38 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1465199673.560878-951992028', 01:24:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:24:38 INFO - '_': '/tools/buildbot/bin/python'} 01:24:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:24:38 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)) 01:24:38 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)) 01:24:38 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)) 01:24:38 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)) 01:24:38 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)) 01:24:38 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)) 01:24:38 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)) 01:24:38 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)) 01:24:38 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)) 01:24:38 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)) 01:24:38 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)) 01:24:38 INFO - Cleaning up... 01:24:38 INFO - Return code: 0 01:24:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:24:38 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')]} 01:24:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:24:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24:38 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')]} 01:24:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:24:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24:38 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 0x7f2932fcff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b51350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be01c0>, '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 0x1be10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be1550>, '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': '52faae308a556c440401f8e5000001e8-1465199673.560878-951992028', '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 01:24:38 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 01:24:38 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 01:24:38 INFO - Using env: {'DISPLAY': ':0', 01:24:38 INFO - 'HOME': '/home/cltbld', 01:24:38 INFO - 'LANG': 'en_US.UTF-8', 01:24:38 INFO - 'LANGUAGE': 'en_US:en', 01:24:38 INFO - 'LOGNAME': 'cltbld', 01:24:38 INFO - 'MAIL': '/var/mail/cltbld', 01:24:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:24:38 INFO - 'MOZ_NO_REMOTE': '1', 01:24:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:24:38 INFO - 'NO_EM_RESTART': '1', 01:24:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:24:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:24:38 INFO - 'PWD': '/builds/slave/test', 01:24:38 INFO - 'SHELL': '/bin/bash', 01:24:38 INFO - 'SHLVL': '1', 01:24:38 INFO - 'TERM': 'linux', 01:24:38 INFO - 'TMOUT': '86400', 01:24:38 INFO - 'USER': 'cltbld', 01:24:38 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1465199673.560878-951992028', 01:24:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:24:38 INFO - '_': '/tools/buildbot/bin/python'} 01:24:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:24:38 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:24:38 INFO - Cleaning up... 01:24:38 INFO - Return code: 0 01:24:38 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:24:38 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')]} 01:24:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:24:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24:38 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')]} 01:24:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:24:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24:38 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 0x7f2932fcff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b51350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be01c0>, '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 0x1be10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be1550>, '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': '52faae308a556c440401f8e5000001e8-1465199673.560878-951992028', '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 01:24:38 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 01:24:38 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 01:24:38 INFO - Using env: {'DISPLAY': ':0', 01:24:38 INFO - 'HOME': '/home/cltbld', 01:24:38 INFO - 'LANG': 'en_US.UTF-8', 01:24:38 INFO - 'LANGUAGE': 'en_US:en', 01:24:38 INFO - 'LOGNAME': 'cltbld', 01:24:38 INFO - 'MAIL': '/var/mail/cltbld', 01:24:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:24:38 INFO - 'MOZ_NO_REMOTE': '1', 01:24:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:24:38 INFO - 'NO_EM_RESTART': '1', 01:24:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:24:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:24:38 INFO - 'PWD': '/builds/slave/test', 01:24:38 INFO - 'SHELL': '/bin/bash', 01:24:38 INFO - 'SHLVL': '1', 01:24:38 INFO - 'TERM': 'linux', 01:24:38 INFO - 'TMOUT': '86400', 01:24:38 INFO - 'USER': 'cltbld', 01:24:38 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1465199673.560878-951992028', 01:24:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:24:38 INFO - '_': '/tools/buildbot/bin/python'} 01:24:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:24:39 INFO - Downloading/unpacking flake8 01:24:39 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 01:24:39 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 01:24:39 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 01:24:39 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 01:24:39 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 01:24:39 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 01:24:40 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:24:41 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:24: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 01:24: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 01:24: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 01:24: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 01:24: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 01:24: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 01:24:41 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:24:41 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:24: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 01:24: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 01:24: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 01:24: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 01:24: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 01:24: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 01:24:41 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:24: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 01:24: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 01:24: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 01:24: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 01:24: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 01:24: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 01:24:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:24:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:24:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:24:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:24:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:24:41 INFO - no previously-included directories found matching 'docs/_build' 01:24:41 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:24:41 INFO - Running setup.py install for pep8 01:24:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:24:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:24:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:24:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:24:41 INFO - no previously-included directories found matching 'docs/_build' 01:24:41 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:24:41 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:24:41 INFO - Cleaning up... 01:24:41 INFO - Return code: 0 01:24:41 INFO - Running post-action listener: _resource_record_post_action 01:24:41 INFO - Running post-action listener: _start_resource_monitoring 01:24:42 INFO - Starting resource monitoring. 01:24:42 INFO - ##### 01:24:42 INFO - ##### Finished create-virtualenv step (success) 01:24:42 INFO - ##### 01:24:42 INFO - ##### 01:24:42 INFO - ##### Running install step. 01:24:42 INFO - ##### 01:24:42 INFO - Running pre-action listener: _resource_record_pre_action 01:24:42 INFO - Running main action method: install 01:24:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:24:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:24:42 INFO - Reading from file tmpfile_stdout 01:24:42 INFO - Detecting whether we're running mozinstall >=1.0... 01:24:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:24:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:24:42 INFO - Reading from file tmpfile_stdout 01:24:42 INFO - Output received: 01:24:42 INFO - Usage: mozinstall [options] installer 01:24:42 INFO - Options: 01:24:42 INFO - -h, --help show this help message and exit 01:24:42 INFO - -d DEST, --destination=DEST 01:24:42 INFO - Directory to install application into. [default: 01:24:42 INFO - "/builds/slave/test"] 01:24:42 INFO - --app=APP Application being installed. [default: firefox] 01:24:42 INFO - mkdir: /builds/slave/test/build/application 01:24:42 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'] 01:24:42 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 01:24:59 INFO - Reading from file tmpfile_stdout 01:24:59 INFO - Output received: 01:24:59 INFO - /builds/slave/test/build/application/firefox/firefox 01:24:59 INFO - Running post-action listener: _resource_record_post_action 01:24:59 INFO - ##### 01:24:59 INFO - ##### Finished install step (success) 01:24:59 INFO - ##### 01:24:59 INFO - ##### 01:24:59 INFO - ##### Running run-tests step. 01:24:59 INFO - ##### 01:24:59 INFO - Running pre-action listener: _resource_record_pre_action 01:24:59 INFO - Running main action method: run_tests 01:24:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:24:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:24:59 INFO - Python 2.7.3 01:24:59 INFO - Return code: 0 01:24:59 INFO - grabbing minidump binary from tooltool 01:24:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:24:59 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 0x1be01c0>, '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 0x1be10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be1550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:24:59 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 01:24:59 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 01:24:59 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 01:24:59 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:24:59 INFO - Return code: 0 01:24:59 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:24:59 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:24:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:24:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:24:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:24:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:24:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:25:00 INFO - Return code: 0 01:25:00 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ADRw_p8bRw2YRKSoUmpygw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 01:25:00 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ADRw_p8bRw2YRKSoUmpygw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-056 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 01:25:00 INFO - Using env: {'DISPLAY': ':0', 01:25:00 INFO - 'HOME': '/home/cltbld', 01:25:00 INFO - 'LANG': 'en_US.UTF-8', 01:25:00 INFO - 'LANGUAGE': 'en_US:en', 01:25:00 INFO - 'LOGNAME': 'cltbld', 01:25:00 INFO - 'MAIL': '/var/mail/cltbld', 01:25:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:25:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:25:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:25:00 INFO - 'MOZ_NO_REMOTE': '1', 01:25:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:25:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:25:00 INFO - 'NO_EM_RESTART': '1', 01:25:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:25:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:25:00 INFO - 'PWD': '/builds/slave/test', 01:25:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:25:00 INFO - 'SHELL': '/bin/bash', 01:25:00 INFO - 'SHLVL': '1', 01:25:00 INFO - 'TERM': 'linux', 01:25:00 INFO - 'TMOUT': '86400', 01:25:00 INFO - 'USER': 'cltbld', 01:25:00 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1465199673.560878-951992028', 01:25:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:25:00 INFO - '_': '/tools/buildbot/bin/python'} 01:25:00 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ADRw_p8bRw2YRKSoUmpygw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 01:25:00 INFO - mozversion application_buildid: 20160605222917 01:25:00 INFO - mozversion application_changeset: 824355c9efe23d83f7e67a4b2c9e0e837f7c7771 01:25:00 INFO - mozversion application_display_name: Nightly 01:25:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:25:00 INFO - mozversion application_name: Firefox 01:25:00 INFO - mozversion application_remotingname: firefox 01:25:00 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 01:25:00 INFO - mozversion application_vendor: Mozilla 01:25:00 INFO - mozversion application_version: 49.0a1 01:25:00 INFO - mozversion platform_buildid: 20160605222917 01:25:00 INFO - mozversion platform_changeset: 824355c9efe23d83f7e67a4b2c9e0e837f7c7771 01:25:00 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 01:25:00 INFO - mozversion platform_version: 49.0a1 01:25:00 INFO - using testdate: 1465201500 01:25:00 INFO - actual date: 1465201500 01:25:00 INFO - starting webserver on 'localhost:45515' 01:25:00 INFO - SUITE-START | Running 2 tests 01:25:00 INFO - TEST-START | dromaeo_css 01:25:00 INFO - operating with platform_type : linux_ 01:25:00 INFO - Initialising browser for dromaeo_css test... 01:25:00 INFO - TEST-INFO | started process 6534 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRfraUj/profile http://localhost:45515/getInfo.html) 01:25:05 INFO - PROCESS | 6534 | __metrics Screen width/height:1600/1200 01:25:05 INFO - PROCESS | 6534 | colorDepth:24 01:25:05 INFO - PROCESS | 6534 | Browser inner width/height: 1024/697 01:25:05 INFO - PROCESS | 6534 | __metrics 01:25:06 ERROR - PROCESS | 6534 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 01:25:06 INFO - TEST-INFO | 6534: exit 0 01:25:06 INFO - Browser initialized. 01:25:06 INFO - Running cycle 1/1 for dromaeo_css test... 01:25:06 INFO - TEST-INFO | started process 6656 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRfraUj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:25:18 INFO - PROCESS | 6656 | RSS: Main: 167743488 01:25:18 INFO - PROCESS | 6656 | 01:26:08 INFO - PROCESS | 6656 | 1465201568404 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] 01:28:16 INFO - PROCESS | 6656 | Cycle 1(1): loaded http://localhost:45515/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45515/tests/dromaeo/cssquery-ext.html) 01:28:17 INFO - PROCESS | 6656 | RSS: Main: 172109824 01:28:17 INFO - PROCESS | 6656 | 01:31:19 INFO - PROCESS | 6656 | Cycle 1(1): loaded http://localhost:45515/tests/dromaeo/cssquery-ext.html (next: http://localhost:45515/tests/dromaeo/cssquery-jquery.html) 01:31:19 INFO - PROCESS | 6656 | RSS: Main: 170299392 01:31:19 INFO - PROCESS | 6656 | 01:34:21 INFO - PROCESS | 6656 | Cycle 1(1): loaded http://localhost:45515/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45515/tests/dromaeo/cssquery-mootools.html) 01:34:22 INFO - PROCESS | 6656 | RSS: Main: 171835392 01:34:22 INFO - PROCESS | 6656 | 01:37:24 INFO - PROCESS | 6656 | Cycle 1(1): loaded http://localhost:45515/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45515/tests/dromaeo/cssquery-prototype.html) 01:37:24 INFO - PROCESS | 6656 | RSS: Main: 168636416 01:37:24 INFO - PROCESS | 6656 | 01:40:27 INFO - PROCESS | 6656 | Cycle 1(1): loaded http://localhost:45515/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45515/tests/dromaeo/cssquery-yui.html) 01:40:27 INFO - PROCESS | 6656 | RSS: Main: 170971136 01:40:27 INFO - PROCESS | 6656 | 01:43:30 INFO - PROCESS | 6656 | Cycle 1(1): loaded http://localhost:45515/tests/dromaeo/cssquery-yui.html (next: http://localhost:45515/tests/dromaeo/cssquery-dojo.html) 01:43:31 INFO - PROCESS | 6656 | RSS: Main: 171941888 01:43:31 INFO - PROCESS | 6656 | 01:43:31 INFO - PROCESS | 6656 | __start_tp_report 01:43:31 INFO - PROCESS | 6656 | _x_x_mozilla_page_load 01:43:31 INFO - PROCESS | 6656 | _x_x_mozilla_page_load_details 01:43:31 INFO - PROCESS | 6656 | |i|pagename|runs| 01:43:31 INFO - PROCESS | 6656 | |0;dojo.html;3047;3125.749940004799;3143.764217683673;3161.035884055365;3183.840807959603;5373.274607927929;5401.945980540198;5437.891242175154;5496.697681627509;5523.309586301712;5311.681299122055;5341.252224688546;5426.294581704373;5450.264214331074;5460.180972854074;4761.0239900820425;4771.236602143649;4823.469418363977;4942.703437793726;4965.783383071134;4808.879778005543;5025.3969523657215;5035.471275516073;5040.092783299005;5058.898822023557;4844.927326090129;4884.072026314989;4921.114199444099;4986.927810520738;4987.900241995158;4928.285398617216;4928.926066109011;4940.802367905279;4941.110600091982;5009.524095210985;4867.634927380461;4892.437369702494;4924;4925.138100832376;4966.602671786249;5203.739813009334;5283.920741188886;5296.788128474856;5312.9734351328;5403.945960540423;5802.82591522255;5803.042497987827;5809.82570522885;5812.767489300423;5817.680027598481;5709.885802283972;5838.824835254949;5844.327902291206;5848.239728835267;5864.032434648278;5452.100403433429;5476.17857321405;5496.862578435571;5522.447755224445;5524.723763811793;6026.186464827279;6029.125776762345;6048.213732214784;6056.545759068087;6081.604695694766;5613.943860561424;5671.489565939085;5810.448007439287;5819.79630712923;5821.2141360916585;5778.739956701875;5835.854103647443;5836.8540786479825;5840.036393995028;5913.497352725067;5664.376918538957;5737.540996720252;5778;5785.450382213683;5788.247527821356;5827.242458480455;5836.941630583725;5845.620034697816;5871.060630299132;5886.94113058864;4424.668149888771;4437.489688685778;4446.933296000562;4463.152001119777;4467.5532446755715;3915.099527108781;3939.1924655445564;3962.2075584883137;3965.980170099131;4022.9597704022585;5677.233573467612;5685.346185188673;5698.715064246771;5713.514351280188;5741.942580574224;5996.850078748066;5999.850003749942;6001.909971350433;6002.069679199731;6011.6693581853415;5466.070767969455;5566.805161819317;5573.331200255995;5591.804286849941;5684.8010319638615;5039.571636410946;5050.191969284897;5061.038402703548;5071.771770270347;5078.365204349457;5963.075723262901;5984.102384642251;6015.639061656315;6044.758209671564;6090.908636370458;5756.7121643917635;5842.941570584409;5872.29532456108;5927.170196172626;5962.493188078888;6072.726727297194;6079.209702738615;6081.452669259788;6087.573869829246;6098.146259523759;5583.469570390806;5812.709364531841;5814.651120932757;5823.621464604787;5826.796062137805;5783.913241301299;5856.092305692625;5884.499817515559;5916.3492015877355;5930.110483427347;5712.971435142797;5715.17130016137;5722.399148089391;5730.856728581819;5763.423657634203;5493.983613031602;5644.745986430538;5726.255586773693;5733.455321744427;5737.655740655574;5519.31008623922;5529.889402211853;5582.162675598693;5593.384727680033;5703.62926409782;5698.430156984268;5707.68607726579;5713.9714301429885;5728.484436400744;5757.280339957505;5532.668039917457;5588.944110559005;5629.634073785191;5643.943560564342;5670.092785154356 01:43:31 INFO - PROCESS | 6656 | |1;ext.html;584.3017593975198;615.2985596420081;627.3851625407103;637.2703254773288;640.8333833203367;40974.385384219226;42357.364639530395;42422.78788606056;42720.786396067975;46512.30231546521;42616.78691606538;42868.57131428693;42962.57037429625;43269.35095973555;43343.13313733724;8561.929758780152;8665.39342246043;8677.869831952527;8727.301815854717;8728.869066964;8559.144085591453;8664.0902705216;8723.30213582915;8734.170253825876;8739.126087391242;8760;8794.648214071462;8819.029906710257;8820.823583528325;8825.117488251188;8706.695265665734;8766.868496972551;8780.209781119698;8804.911950880505;8815.206631403173;8500.659973601048;8621.396502244845;8624.051354351017;8627;8646.308295336357;39494.60505394938;39519;39529.20941581181;39763.801180994196;39791.20417591632;3422.4695172248094;3477.113336099304;3502.334556434295;3569.1077230692326;3962.801859907022;29992;30232.546511802342;30699.539506907415;30723.385532289452;30786.53820192699;4249.660027197817;4266.445362102938;4296.076343586144;4356.302991521373;4411.977940110311;262899;263162;263349;264658;264785;54143.45856541384;54207.45792542103;54334.72832635811;54361.45638543564;54400.45599543954;56323.71838140865;56870;56963.14555281674;57001;57049;14589.92705036468;15224.695506089816;15690.921545392428;15758.76361854573;16293.429729959631;12316.13787034899;12407.25556466615;12485.438155283035;12503.937480312541;12525.1232413732;15822.683546329008;15908.840911590736;15974.281157347947;16050;16158;6076.908846367308;6109.205803245639;6130.203073600493;6304;6363.9045414318825;1001.8647482589903;1045.2056437107854;1122.8764835868049;1125.7129431994952;1145.1926391893694;31123.377532449224;31251.531227031614;31706.524402133986;31932.521012184836;32491.837540812143;1071.9892801072046;1088.9292196007393;1115.3140818396628;1153.210051114989;1173.0322483950774;16502.917485412498;16795.580110497336;16952.83047169537;17023.442411903856;17182.312707491812;535549;537607;538113;539709;544127;55870.720646396505;56093.7195314029;56253.71873140608;56307.71846140825;56360.43639563634;1363.0731102850157;1387.486629946926;1410.5556749623836;1413.4770135049891;1415.0660564027692;30400.695993039786;31837.20406989844;31875;31998.52002219922;32451.35097298088;49910;50124.749376254345;50221.74889125531;50264;50323;462403;474274;474819;475250;475292;40475.1904961905;40589.39115913204;40629.39055914223;40657.79671101626;42432;47230.76384618055;47336.7633161832;47692;48111.27833082437;48254;39299;40492;41284.79357603193;41504.547340842924;41759.7912010438;40276;42043.36934945917;43083.569164307955;43333.133337332445;43430.78284608557;40761.79619101885;41264.58735412607;41826.79086604548;41862;44473.55526444694;34149.82925085359;37254.25491490209;37467.62532374641;37696.43455348117;37993.810030949666;28338.14985550437;28489.43021139607;28515.28711782222;28564;28644.283892902844 01:43:31 INFO - PROCESS | 6656 | |2;jquery.html;382.4397258017006;389.351729370598;390.8378023120404;395.663685867013;408.65672834818747;13637.249951252677;15417.15205663688;18000.549986250335;19369.322073727424;19390.321338753147;15554.22228888554;17408.738868916946;18213.7267940981;18251.72622410665;18276.360327388546;5126.641135120543;5215.765290561933;5379.5696344292555;5379.784808607651;5399.9730001349935;5169.974150129244;5266.657667251636;5287.4976877196605;5288.92066619001;5299.152135658295;5379;5700.572457065716;5738.626989245686;5761.193432919374;5766.308043034821;5492;5618.943810561904;6558.442532384729;6587.736490540373;6600.8349791255605;5782.595218334718;5843.240378750777;5854.677992710399;5867.559933004999;5873.941260587382;13988.790168147487;16281.674366512603;20112.09495572703;21179.576408471745;21194.152233910627;2181.3128864407818;2234.932952011426;2270.931872043825;2336.4042169246904;2347.319277409549;9732.70801875945;9935.354201976848;10002.849957250646;10318.89681103187;10429.739256518571;1857.3313607101568;1963.391348681913;1991.3926252492984;1991.4025792262264;2045.7749647538758;47153.29270060952;50912.745436272584;78758.21241787623;78867.6056619719;79006;9759.707208783748;9817.558209880572;10374.481275936172;10516;10613.204009699304;13846.376913038937;13888.097273677178;13918.930405347908;13930;13955.255593050868;7383.334730571307;7641.617919104023;7712.344450721639;7839.84320313602;7855.567943763148;7355.8161045974275;7356.816079598053;7425.071866016748;7475.215102414277;7493.550386976799;4291.442112525352;4295.6778241632;4307.6769242306955;4423.8230470781455;4741.786619602126;1943.5626983928503;1990.1243452880685;2018.1927229108474;2024.1195080140187;2062.896855157236;984.4150917023586;999.9500024998721;1005.5977608956476;1024.9538770755335;1095.7534554725123;18354.265829366675;18628.441146765617;18906;19125;19304.1313140909;971.7619183300137;981.7054883534911;1028.7325295423243;1040.7450174707244;1071.1591400750374;10137.898621013843;10592.417417042137;10611.204159688054;10638.148948084136;10657.62698305571;501298.1689669111;507566;515811;519534;520490;89253.55373223222;92052.53973730089;93196.53401732948;93459;94124;1005.3867141043958;1013.9949300253452;1023.488255872064;1023.7798873242289;1032.230987914009;16147.515574532783;16643.91678041602;16646.916765416096;16811.91594042022;17012.404565840137;40571;40590.79704601458;41198;42419.7879010603;42704.57295427006;56127.71936140293;56280;56739.71630141823;56853;56923.71538142283;5285.603579731459;7510.47426680149;8496.447730897471;8562.357823163413;8751.343649226206;12311.69220769488;13075.607731768063;13155.210687358789;13213.801792972921;13365.599032029055;11284.548618055185;11292.209545331747;11658.591949281734;11701.239419437708;11894.464749086139;5012.072766538202;8372.70223115418;10818;10913.181511386836;11461.942690286494;11482.081433485135;11671.941640291745;11719.707007324885;11752.647420577396;11839.644810655695;8550.657973681233;8701.869471958053;8723.869141962748;8729;8777.517236551796;8579.485230886166;11448.771024579628;11513.30920144794;11619.825702614298;11696.239744416585 01:43:31 INFO - PROCESS | 6656 | |3;mootools.html;1485.294485119568;1493.0742939377585;1555.2767962897258;1622.7484739865324;1635.133379308966;7912.090109637379;8351.791205219872;8487.15128487151;8977.14717101875;8990.91009089908;8347.332213422927;8375.832483350345;8696.826063478728;8715.084916083799;8768.210861022506;2281.7147856517977;2352.6823878776318;2357.8231632627535;2357.8938947747306;2360.598698221298;2257.89839457224;2273.943151421211;2284.9543009139807;2299.356180269519;2330.4290448840056;2300.0914638717695;2307.1232931486097;2310.4339436838;2313.803326717231;2324.732655744586;2226.922057727988;2259.5819773341987;2270.8751018694047;2272.4773302140434;2273.193016479151;2250.797428231467;2252.9211477598205;2267.6258417361114;2271.1710225767642;2277.5900337939165;8701.56492175395;8804.779880502974;8820;8834.823303533893;8881.378303518757;5095.0574143783515;5162.741862906877;5211.088059589557;5221.321228240343;5222.399424066205;3194.265318976625;3219.919502012445;3397.69420752131;3416.8804091856664;3461.4288642373976;1167.171308371049;1190.7320852808136;2120.946976325589;2176.09691977829;2198.857074290166;12092.758144837142;12170.75658486834;12242.571509997197;12275;12328.07539434546;4673.415823022122;4715.41057367829;4799.856004319876;4808.927866082012;4824.300476430968;10425.218108641882;10501.369917804956;10508.579656813794;10524.210684198715;10532.10477109439;5288.391834938954;5351.331083614548;5363.249145119687;5409.053415652245;5428.158635411518;4232.534421213664;4655.441347038377;4797.112534181188;4812.133815913169;4812.278158276216;4092.5676013395073;4119.215888829802;4182.519010313853;4186.885343908488;4202.684798640114;1299.91550549214;1329.2356894785537;1330.0091382256019;1334.7597432462055;1340.2427628390124;964.0600414595713;972.2902281334524;986.7681094942683;995.0745806399973;996.6312464388222;5758.971205143947;5877.324107727581;5885.558583106199;5972.790952316648;6036.15493830864;454.7817047817;459.3018611710182;470.21708854756446;474.2128067408086;476.5377583743763;3837.1558257183933;3945.8027098645525;3987.521497420328;4025.9194816103513;4059.3707975263883;10434.37393756377;10822.080123189617;10873.891261087289;10940.179486538382;10948.124150067975;10021.248406369552;10431.16550675944;10436.895631043744;10727.356358618508;10794.082502987334;8213.301869341054;8214.753557393287;8247.134050924686;8339.374546909006;8386.496810191407;5780.450857168562;5867.295924489089;5869.236999190078;5904.409559044233;6035.698215089315;9685.564149613143;9911.55398007077;9925.503724813874;9940.652077177265;10063.094321511098;10155.086042256233;10432.58269669235;10442;10468.581256749645;10494.265401421828;7144.499885007999;7574.5076570022775;7707.499012564165;7810.843783124419;7846.333061689592;8638.438501497383;8646.956765216133;8691.348148888985;8692.34807389461;8708.433951793113;7384.409247260099;7415.4809163360205;7711.9974403327205;7771.8834217485655;7828.099768526692;7464.664090116066;7597.506162099446;7611.961940190264;7656.80857978555;7741.651625676745;7043.859122817413;7064.82337941535;7116.110486189226;7123.893141602776;7125.394341481032;4762.333273341805;4827.61379089679;4865.635077369282;4964.726940018334;4964.751762411793;4838.879028024327;4859.076775412802;4909.042736666316;4924.556789888928;4952.331435256338 01:43:31 INFO - PROCESS | 6656 | |4;prototype.html;331.2431094948043;333.7630282499425;335.43479237484854;340.7069919868913;342.2538865273704;5584.329880414351;5667.546596272298;5674.914876276859;5705.629134106291;5724.1986121942855;5523.806666766664;5548.640583057147;5551.750171242294;5578.665280083188;5600.103983362663;4116.83865970365;4168.7707176105305;4303.827846886121;4316.287812510932;4388.714733542325;4266.7866606669695;4302.11806579652;4325.178216138939;4331.5884990925815;4343.457067866517;4236.173946080516;4275.700700950934;4288.549702281262;4312.482502099737;4322.524522302544;4023;4272.46594175728;4299.914001719963;4300.311950088002;4302.913087152729;3706.110533471974;3710.3135919854913;3722;3730.4404339349044;3747.4940882980723;5383.407825139271;5399.325084364455;5407.486288802557;5426.321709786277;5429.4570542945785;4648.302754586839;4923.532264434873;4929.827456039057;4942.456329803718;4967.453580106221;5745.942540574624;5798.869220502003;5819.127130930352;5831.825045248649;5837.628157383012;4132.628063474302;4139.77231252281;4152.397902304149;4154.356074808409;4158.293090174678;5817.0512878185855;6009.429104235091;6062.363451837582;6069.605475644069;6090.878182436327;4209.91580168401;4222.78886055696;4228.794793483904;4231.407602935591;4248.277792775174;4308.310670292738;4350.760708161019;4353.303471444617;4360.934585981213;4361.672874534359;4702.694324868872;4930.5069493050405;4944.184209605447;4959.876003099879;4973.975130124326;5878.559108066912;5898.64608123514;5909.409059094142;5946.137810017523;5969.611975221596;1472.6097584140211;1486.8364479907202;1493.5370035289095;1497.951433996207;1498.715244103617;932.3659911260409;940.3323640215524;966.7969726357403;1002.8846682631445;1009.1876039787894;5592.496675299242;5629.324481062299;5632.295963004624;5633.549316054706;5641.392203222062;5899.377671140471;5941.31674857397;5941.613795103304;5943.31651860033;6061.212042434456;5359;5602.551795856321;5686.772529098873;5706.629069110494;5735.426457354315;3212.6346302821207;3214.951775723366;3219.259570298844;3227.209333713255;3251.4635085210675;6055.364186760415;6110.61440794371;6165.938340616626;6247.875042499125;6285.654289014148;6087.878242435215;6118.449339559461;6194.907076393858;6241.656708881055;6247.937520624827;6099.756009759737;6223.0129537822095;6226.937730622726;6233.348162736878;6236.968815155895;5959.404059594006;6039.969800150971;6048.697565121638;6095.4399152357;6097.695115244132;5945.64326140433;5981.671008094422;6030.30651475086;6033.245844269466;6033.456988870847;6179.907301390393;6271.052605275513;6305.842353941188;6305.959516679696;6325.620462772248;4234.809433575558;4235.449391579075;4281.314989601648;4292.570742925683;4314;5843.328017278068;5908.586398952032;6112.938870611237;6121.296050954019;6122.418370254819;5888.852778680567;5907.616004959664;5920;5934.317553481233;5957.672328022;5867.149263356704;5887.322957859729;5890.852728681646;5942.881142377215;5952.58331916779;5545.861353466195;5724.370319264961;5799.82600521985;5803.332616749128;5816.36020037804;5902.734376952962;5966.820995370146;5967.49276311501;5976.312724036791;5982.7008649568215;5644.6613203207935;5772.855678608068;5786.971065144816;5795.1314099521005;5803.78120594663 01:43:31 INFO - PROCESS | 6656 | |5;yui.html;765.1559741024133;809.4859764049828;815.6778072661299;830.4394533689758;837.8240569480411;15246.313915873785;15447.459338923127;15471.845281547181;15580.22098895055;15670.451534196305;14484.42062317506;14551.126932384064;14574.198419086946;14624.926875365634;14931.626709332271;773.9806504837396;803.5941849366092;810.4245985350408;812.760235730461;829.2163905109674;824.9793755156109;829;830.4477522447565;830.7217082277444;830.9861968398544;852.1563651984553;855.8031652719878;855.80744332525;858.1204265627719;859.8753180788782;844.0546587821678;845.3870943565896;846.2764336492272;848.2323497235012;849.647396330522;622.1103821535203;622.4304761143549;622.8567429491197;622.8754249150188;622.987540249197;15636.530904072895;15646.374145034186;15653.530394088195;15750;15757.527274181793;14436.133831970115;14482.71034579313;14591.635209119751;14637.487687930978;14776.926115369355;11936.28382297065;12111.636650900398;12143.93928030363;12267.69330766729;12442;3739.7943113128767;3853.364194907837;3862.7682339059747;3883.572806991229;3895.7662540247675;77567.22432775656;80286.59856700737;80501.59749201275;80636.19363806346;80833.59583202047;11020.173486988508;11138.498767555317;11253.49359278818;11370;11684.12369072323;21688.34934951954;21816;21829.345119646438;21857.234996775038;21907.890460547595;8361;8536.317094632415;8629.439086459486;8752.956235218782;8794.252488538546;4838.274258861199;4847.710583260343;4929.630277729185;4955.281484184845;5125.820596279113;3509.78941263525;3628.165521929971;3630.6006339302658;3637.7635453695425;3639.6178401267484;593.7209511529575;600.9579329446897;606.5056978562458;613.9869215793975;624.4317670919442;638.5211091681239;650.8080116365684;734.3390948146604;758.6510205305622;765.6210175962934;9972.601095956226;10139.239557033252;10322.793544129076;10537.683869483928;10550.525226364833;624.8562830548999;639.9680015999181;675.4157653629575;786.6460092958192;803.8392321535716;4711.764411779466;5025.246213067996;5059.696418214919;5122.820701275437;5130.102232109366;66211;67016.32983670199;67983.66008169927;68160;111083;60694.174056352684;74256.25743742601;92027;94202;95665.52167239258;72436;73572.26427735655;75686.62156689292;86856.565717171;87225;10520.15838732915;10628.415437150721;10824.945875270574;10916.56333746673;10921.945390273315;37994.62005379911;39055.804720976215;39765;48562;51332.74333628308;66367;72108.63945680238;72994.27005729875;73408.26591734227;74541;12302.81545776832;13116.278604676834;13158.539451119164;13448.394822233218;13571.728565428833;14333.56999290023;15472.163635640043;15579.76630350523;15796.36814527406;15857.207139642742;13773.242471663754;13962.4415023402;14081.577552673436;14547;14619.122852628876;13383.19700817954;13507.527236546674;13791.655208619464;14323.928380358031;15149.697006059596;13327.86672133305;13541.729165416833;13857.514986975408;14109.717805644035;14323.355449004612;11042.779144417227;11171.441427928408;11617.593384231512;11903.345316007702;11921.761564768483;11762.76474470523;12323.137380383645;12401.25592464455;12604.87395126037;12769.489220431078 01:43:31 INFO - PROCESS | 6656 | __end_tp_report 01:43:31 INFO - PROCESS | 6656 | __start_cc_report 01:43:31 INFO - PROCESS | 6656 | _x_x_mozilla_cycle_collect,344 01:43:31 INFO - PROCESS | 6656 | __end_cc_report 01:43:31 INFO - PROCESS | 6656 | __startTimestamp1465202611023__endTimestamp 01:43:31 INFO - PROCESS | 6656 | 01:43:31 INFO - PROCESS | 6656 | ------- Summary: start ------- 01:43:31 INFO - PROCESS | 6656 | Number of tests: 6 01:43:31 INFO - PROCESS | 6656 | 01:43:31 INFO - PROCESS | 6656 | [#0] dojo.html Cycles:165 Average:5423.31 Median:5670.09 stddev:633.29 (11.2%) stddev-sans-first:607.18 01:43:31 INFO - PROCESS | 6656 | Values: 3047.0 3125.7 3143.8 3161.0 3183.8 5373.3 5401.9 5437.9 5496.7 5523.3 5311.7 5341.3 5426.3 5450.3 5460.2 4761.0 4771.2 4823.5 4942.7 4965.8 4808.9 5025.4 5035.5 5040.1 5058.9 4844.9 4884.1 4921.1 4986.9 4987.9 4928.3 4928.9 4940.8 4941.1 5009.5 4867.6 4892.4 4924.0 4925.1 4966.6 5203.7 5283.9 5296.8 5313.0 5403.9 5802.8 5803.0 5809.8 5812.8 5817.7 5709.9 5838.8 5844.3 5848.2 5864.0 5452.1 5476.2 5496.9 5522.4 5524.7 6026.2 6029.1 6048.2 6056.5 6081.6 5613.9 5671.5 5810.4 5819.8 5821.2 5778.7 5835.9 5836.9 5840.0 5913.5 5664.4 5737.5 5778.0 5785.5 5788.2 5827.2 5836.9 5845.6 5871.1 5886.9 4424.7 4437.5 4446.9 4463.2 4467.6 3915.1 3939.2 3962.2 3966.0 4023.0 5677.2 5685.3 5698.7 5713.5 5741.9 5996.9 5999.9 6001.9 6002.1 6011.7 5466.1 5566.8 5573.3 5591.8 5684.8 5039.6 5050.2 5061.0 5071.8 5078.4 5963.1 5984.1 6015.6 6044.8 6090.9 5756.7 5842.9 5872.3 5927.2 5962.5 6072.7 6079.2 6081.5 6087.6 6098.1 5583.5 5812.7 5814.7 5823.6 5826.8 5783.9 5856.1 5884.5 5916.3 5930.1 5713.0 5715.2 5722.4 5730.9 5763.4 5494.0 5644.7 5726.3 5733.5 5737.7 5519.3 5529.9 5582.2 5593.4 5703.6 5698.4 5707.7 5714.0 5728.5 5757.3 5532.7 5588.9 5629.6 5643.9 5670.1 01:43:31 INFO - PROCESS | 6656 | 01:43:31 INFO - PROCESS | 6656 | [#1] ext.html Cycles:180 Average:58731.91 Median:42200.37 stddev:117227.24 (277.8%) stddev-sans-first:117474.79 01:43:31 INFO - PROCESS | 6656 | Values: 584.3 615.3 627.4 637.3 640.8 40974.4 42357.4 42422.8 42720.8 46512.3 42616.8 42868.6 42962.6 43269.4 43343.1 8561.9 8665.4 8677.9 8727.3 8728.9 8559.1 8664.1 8723.3 8734.2 8739.1 8760.0 8794.6 8819.0 8820.8 8825.1 8706.7 8766.9 8780.2 8804.9 8815.2 8500.7 8621.4 8624.1 8627.0 8646.3 39494.6 39519.0 39529.2 39763.8 39791.2 3422.5 3477.1 3502.3 3569.1 3962.8 29992.0 30232.5 30699.5 30723.4 30786.5 4249.7 4266.4 4296.1 4356.3 4412.0 262899.0 263162.0 263349.0 264658.0 264785.0 54143.5 54207.5 54334.7 54361.5 54400.5 56323.7 56870.0 56963.1 57001.0 57049.0 14589.9 15224.7 15690.9 15758.8 16293.4 12316.1 12407.3 12485.4 12503.9 12525.1 15822.7 15908.8 15974.3 16050.0 16158.0 6076.9 6109.2 6130.2 6304.0 6363.9 1001.9 1045.2 1122.9 1125.7 1145.2 31123.4 31251.5 31706.5 31932.5 32491.8 1072.0 1088.9 1115.3 1153.2 1173.0 16502.9 16795.6 16952.8 17023.4 17182.3 535549.0 537607.0 538113.0 539709.0 544127.0 55870.7 56093.7 56253.7 56307.7 56360.4 1363.1 1387.5 1410.6 1413.5 1415.1 30400.7 31837.2 31875.0 31998.5 32451.4 49910.0 50124.7 50221.7 50264.0 50323.0 462403.0 474274.0 474819.0 475250.0 475292.0 40475.2 40589.4 40629.4 40657.8 42432.0 47230.8 47336.8 47692.0 48111.3 48254.0 39299.0 40492.0 41284.8 41504.5 41759.8 40276.0 42043.4 43083.6 43333.1 43430.8 40761.8 41264.6 41826.8 41862.0 44473.6 34149.8 37254.3 37467.6 37696.4 37993.8 28338.1 28489.4 28515.3 28564.0 28644.3 01:43:31 INFO - PROCESS | 6656 | 01:43:31 INFO - PROCESS | 6656 | [#2] jquery.html Cycles:180 Average:28731.87 Median:390.09 stddev:84366.70 (21627.2%) stddev-sans-first:84576.51 01:43:31 INFO - PROCESS | 6656 | Values: 382.4 389.4 390.8 395.7 408.7 13637.2 15417.2 18000.5 19369.3 19390.3 15554.2 17408.7 18213.7 18251.7 18276.4 5126.6 5215.8 5379.6 5379.8 5400.0 5170.0 5266.7 5287.5 5288.9 5299.2 5379.0 5700.6 5738.6 5761.2 5766.3 5492.0 5618.9 6558.4 6587.7 6600.8 5782.6 5843.2 5854.7 5867.6 5873.9 13988.8 16281.7 20112.1 21179.6 21194.2 2181.3 2234.9 2270.9 2336.4 2347.3 9732.7 9935.4 10002.8 10318.9 10429.7 1857.3 1963.4 1991.4 1991.4 2045.8 47153.3 50912.7 78758.2 78867.6 79006.0 9759.7 9817.6 10374.5 10516.0 10613.2 13846.4 13888.1 13918.9 13930.0 13955.3 7383.3 7641.6 7712.3 7839.8 7855.6 7355.8 7356.8 7425.1 7475.2 7493.6 4291.4 4295.7 4307.7 4423.8 4741.8 1943.6 1990.1 2018.2 2024.1 2062.9 984.4 1000.0 1005.6 1025.0 1095.8 18354.3 18628.4 18906.0 19125.0 19304.1 971.8 981.7 1028.7 1040.7 1071.2 10137.9 10592.4 10611.2 10638.1 10657.6 501298.2 507566.0 515811.0 519534.0 520490.0 89253.6 92052.5 93196.5 93459.0 94124.0 1005.4 1014.0 1023.5 1023.8 1032.2 16147.5 16643.9 16646.9 16811.9 17012.4 40571.0 40590.8 41198.0 42419.8 42704.6 56127.7 56280.0 56739.7 56853.0 56923.7 5285.6 7510.5 8496.4 8562.4 8751.3 12311.7 13075.6 13155.2 13213.8 13365.6 11284.5 11292.2 11658.6 11701.2 11894.5 5012.1 8372.7 10818.0 10913.2 11461.9 11482.1 11671.9 11719.7 11752.6 11839.6 8550.7 8701.9 8723.9 8729.0 8777.5 8579.5 11448.8 11513.3 11619.8 11696.2 01:43:31 INFO - PROCESS | 6656 | 01:43:31 INFO - PROCESS | 6656 | [#3] mootools.html Cycles:180 Average:5770.40 Median:4779.72 stddev:3272.81 (68.5%) stddev-sans-first:3266.15 01:43:31 INFO - PROCESS | 6656 | Values: 1485.3 1493.1 1555.3 1622.7 1635.1 7912.1 8351.8 8487.2 8977.1 8990.9 8347.3 8375.8 8696.8 8715.1 8768.2 2281.7 2352.7 2357.8 2357.9 2360.6 2257.9 2273.9 2285.0 2299.4 2330.4 2300.1 2307.1 2310.4 2313.8 2324.7 2226.9 2259.6 2270.9 2272.5 2273.2 2250.8 2252.9 2267.6 2271.2 2277.6 8701.6 8804.8 8820.0 8834.8 8881.4 5095.1 5162.7 5211.1 5221.3 5222.4 3194.3 3219.9 3397.7 3416.9 3461.4 1167.2 1190.7 2120.9 2176.1 2198.9 12092.8 12170.8 12242.6 12275.0 12328.1 4673.4 4715.4 4799.9 4808.9 4824.3 10425.2 10501.4 10508.6 10524.2 10532.1 5288.4 5351.3 5363.2 5409.1 5428.2 4232.5 4655.4 4797.1 4812.1 4812.3 4092.6 4119.2 4182.5 4186.9 4202.7 1299.9 1329.2 1330.0 1334.8 1340.2 964.1 972.3 986.8 995.1 996.6 5759.0 5877.3 5885.6 5972.8 6036.2 454.8 459.3 470.2 474.2 476.5 3837.2 3945.8 3987.5 4025.9 4059.4 10434.4 10822.1 10873.9 10940.2 10948.1 10021.2 10431.2 10436.9 10727.4 10794.1 8213.3 8214.8 8247.1 8339.4 8386.5 5780.5 5867.3 5869.2 5904.4 6035.7 9685.6 9911.6 9925.5 9940.7 10063.1 10155.1 10432.6 10442.0 10468.6 10494.3 7144.5 7574.5 7707.5 7810.8 7846.3 8638.4 8647.0 8691.3 8692.3 8708.4 7384.4 7415.5 7712.0 7771.9 7828.1 7464.7 7597.5 7612.0 7656.8 7741.7 7043.9 7064.8 7116.1 7123.9 7125.4 4762.3 4827.6 4865.6 4964.7 4964.8 4838.9 4859.1 4909.0 4924.6 4952.3 01:43:31 INFO - PROCESS | 6656 | 01:43:31 INFO - PROCESS | 6656 | [#4] prototype.html Cycles:180 Average:4927.74 Median:5643.03 stddev:1469.46 (26.0%) stddev-sans-first:1432.51 01:43:31 INFO - PROCESS | 6656 | Values: 331.2 333.8 335.4 340.7 342.3 5584.3 5667.5 5674.9 5705.6 5724.2 5523.8 5548.6 5551.8 5578.7 5600.1 4116.8 4168.8 4303.8 4316.3 4388.7 4266.8 4302.1 4325.2 4331.6 4343.5 4236.2 4275.7 4288.5 4312.5 4322.5 4023.0 4272.5 4299.9 4300.3 4302.9 3706.1 3710.3 3722.0 3730.4 3747.5 5383.4 5399.3 5407.5 5426.3 5429.5 4648.3 4923.5 4929.8 4942.5 4967.5 5745.9 5798.9 5819.1 5831.8 5837.6 4132.6 4139.8 4152.4 4154.4 4158.3 5817.1 6009.4 6062.4 6069.6 6090.9 4209.9 4222.8 4228.8 4231.4 4248.3 4308.3 4350.8 4353.3 4360.9 4361.7 4702.7 4930.5 4944.2 4959.9 4974.0 5878.6 5898.6 5909.4 5946.1 5969.6 1472.6 1486.8 1493.5 1498.0 1498.7 932.4 940.3 966.8 1002.9 1009.2 5592.5 5629.3 5632.3 5633.5 5641.4 5899.4 5941.3 5941.6 5943.3 6061.2 5359.0 5602.6 5686.8 5706.6 5735.4 3212.6 3215.0 3219.3 3227.2 3251.5 6055.4 6110.6 6165.9 6247.9 6285.7 6087.9 6118.4 6194.9 6241.7 6247.9 6099.8 6223.0 6226.9 6233.3 6237.0 5959.4 6040.0 6048.7 6095.4 6097.7 5945.6 5981.7 6030.3 6033.2 6033.5 6179.9 6271.1 6305.8 6306.0 6325.6 4234.8 4235.4 4281.3 4292.6 4314.0 5843.3 5908.6 6112.9 6121.3 6122.4 5888.9 5907.6 5920.0 5934.3 5957.7 5867.1 5887.3 5890.9 5942.9 5952.6 5545.9 5724.4 5799.8 5803.3 5816.4 5902.7 5966.8 5967.5 5976.3 5982.7 5644.7 5772.9 5787.0 5795.1 5803.8 01:43:31 INFO - PROCESS | 6656 | 01:43:31 INFO - PROCESS | 6656 | [#5] yui.html Cycles:180 Average:19107.34 Median:21475.79 stddev:25462.43 (118.6%) stddev-sans-first:25496.61 01:43:31 INFO - PROCESS | 6656 | Values: 765.2 809.5 815.7 830.4 837.8 15246.3 15447.5 15471.8 15580.2 15670.5 14484.4 14551.1 14574.2 14624.9 14931.6 774.0 803.6 810.4 812.8 829.2 825.0 829.0 830.4 830.7 831.0 852.2 855.8 855.8 858.1 859.9 844.1 845.4 846.3 848.2 849.6 622.1 622.4 622.9 622.9 623.0 15636.5 15646.4 15653.5 15750.0 15757.5 14436.1 14482.7 14591.6 14637.5 14776.9 11936.3 12111.6 12143.9 12267.7 12442.0 3739.8 3853.4 3862.8 3883.6 3895.8 77567.2 80286.6 80501.6 80636.2 80833.6 11020.2 11138.5 11253.5 11370.0 11684.1 21688.3 21816.0 21829.3 21857.2 21907.9 8361.0 8536.3 8629.4 8753.0 8794.3 4838.3 4847.7 4929.6 4955.3 5125.8 3509.8 3628.2 3630.6 3637.8 3639.6 593.7 601.0 606.5 614.0 624.4 638.5 650.8 734.3 758.7 765.6 9972.6 10139.2 10322.8 10537.7 10550.5 624.9 640.0 675.4 786.6 803.8 4711.8 5025.2 5059.7 5122.8 5130.1 66211.0 67016.3 67983.7 68160.0 111083.0 60694.2 74256.3 92027.0 94202.0 95665.5 72436.0 73572.3 75686.6 86856.6 87225.0 10520.2 10628.4 10824.9 10916.6 10921.9 37994.6 39055.8 39765.0 48562.0 51332.7 66367.0 72108.6 72994.3 73408.3 74541.0 12302.8 13116.3 13158.5 13448.4 13571.7 14333.6 15472.2 15579.8 15796.4 15857.2 13773.2 13962.4 14081.6 14547.0 14619.1 13383.2 13507.5 13791.7 14323.9 15149.7 13327.9 13541.7 13857.5 14109.7 14323.4 11042.8 11171.4 11617.6 11903.3 11921.8 11762.8 12323.1 12401.3 12604.9 12769.5 01:43:31 INFO - PROCESS | 6656 | -------- Summary: end -------- 01:43:31 INFO - PROCESS | 6656 | 01:43:31 INFO - TEST-INFO | 6656: exit 0 01:43:31 INFO - TEST-OK | dromaeo_css | took 1111424ms 01:43:31 INFO - TEST-START | kraken 01:43:31 INFO - operating with platform_type : linux_ 01:43:31 INFO - Initialising browser for kraken test... 01:43:31 INFO - TEST-INFO | started process 6890 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpv7bx2V/profile http://localhost:45515/getInfo.html) 01:43:36 INFO - PROCESS | 6890 | __metrics Screen width/height:1600/1200 01:43:36 INFO - PROCESS | 6890 | colorDepth:24 01:43:36 INFO - PROCESS | 6890 | Browser inner width/height: 1024/697 01:43:36 INFO - PROCESS | 6890 | __metrics 01:43:37 ERROR - PROCESS | 6890 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 01:43:38 INFO - TEST-INFO | 6890: exit 0 01:43:38 INFO - Browser initialized. 01:43:38 INFO - Running cycle 1/1 for kraken test... 01:43:38 INFO - TEST-INFO | started process 7010 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpv7bx2V/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:43:49 INFO - PROCESS | 7010 | RSS: Main: 167661568 01:43:49 INFO - PROCESS | 7010 | 01:43:52 INFO - PROCESS | 7010 | Cycle 1(1): loaded http://localhost:45515/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45515/tests/kraken/driver.html?testName=audio-beat-detection) 01:43:53 INFO - PROCESS | 7010 | RSS: Main: 172707840 01:43:53 INFO - PROCESS | 7010 | 01:43:56 INFO - PROCESS | 7010 | Cycle 1(1): loaded http://localhost:45515/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45515/tests/kraken/driver.html?testName=audio-dft) 01:43:56 INFO - PROCESS | 7010 | RSS: Main: 171991040 01:43:56 INFO - PROCESS | 7010 | 01:43:59 INFO - PROCESS | 7010 | Cycle 1(1): loaded http://localhost:45515/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45515/tests/kraken/driver.html?testName=audio-fft) 01:44:00 INFO - PROCESS | 7010 | RSS: Main: 166637568 01:44:00 INFO - PROCESS | 7010 | 01:44:02 INFO - PROCESS | 7010 | Cycle 1(1): loaded http://localhost:45515/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45515/tests/kraken/driver.html?testName=audio-oscillator) 01:44:03 INFO - PROCESS | 7010 | RSS: Main: 167514112 01:44:03 INFO - PROCESS | 7010 | 01:44:05 INFO - PROCESS | 7010 | Cycle 1(1): loaded http://localhost:45515/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45515/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:44:05 INFO - PROCESS | 7010 | RSS: Main: 168095744 01:44:05 INFO - PROCESS | 7010 | 01:44:08 INFO - PROCESS | 7010 | Cycle 1(1): loaded http://localhost:45515/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45515/tests/kraken/driver.html?testName=imaging-darkroom) 01:44:09 INFO - PROCESS | 7010 | RSS: Main: 168886272 01:44:09 INFO - PROCESS | 7010 | 01:44:13 INFO - PROCESS | 7010 | Cycle 1(1): loaded http://localhost:45515/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45515/tests/kraken/driver.html?testName=imaging-desaturate) 01:44:13 INFO - PROCESS | 7010 | RSS: Main: 166379520 01:44:13 INFO - PROCESS | 7010 | 01:44:16 INFO - PROCESS | 7010 | Cycle 1(1): loaded http://localhost:45515/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45515/tests/kraken/driver.html?testName=json-parse-financial) 01:44:17 INFO - PROCESS | 7010 | RSS: Main: 167473152 01:44:17 INFO - PROCESS | 7010 | 01:44:18 INFO - PROCESS | 7010 | Cycle 1(1): loaded http://localhost:45515/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45515/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:44:19 INFO - PROCESS | 7010 | RSS: Main: 167878656 01:44:19 INFO - PROCESS | 7010 | 01:44:21 INFO - PROCESS | 7010 | Cycle 1(1): loaded http://localhost:45515/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45515/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:44:21 INFO - PROCESS | 7010 | RSS: Main: 168337408 01:44:21 INFO - PROCESS | 7010 | 01:44:23 INFO - PROCESS | 7010 | Cycle 1(1): loaded http://localhost:45515/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45515/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:44:24 INFO - PROCESS | 7010 | RSS: Main: 168710144 01:44:24 INFO - PROCESS | 7010 | 01:44:27 INFO - PROCESS | 7010 | Cycle 1(1): loaded http://localhost:45515/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45515/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:44:27 INFO - PROCESS | 7010 | RSS: Main: 168878080 01:44:27 INFO - PROCESS | 7010 | 01:44:30 INFO - PROCESS | 7010 | Cycle 1(1): loaded http://localhost:45515/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45515/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:44:31 INFO - PROCESS | 7010 | RSS: Main: 168652800 01:44:31 INFO - PROCESS | 7010 | 01:44:32 INFO - PROCESS | 7010 | Cycle 1(1): loaded http://localhost:45515/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45515/tests/kraken/driver.html?testName=ai-astar) 01:44:33 INFO - PROCESS | 7010 | RSS: Main: 169189376 01:44:33 INFO - PROCESS | 7010 | 01:44:33 INFO - PROCESS | 7010 | __start_tp_report 01:44:33 INFO - PROCESS | 7010 | _x_x_mozilla_page_load 01:44:33 INFO - PROCESS | 7010 | _x_x_mozilla_page_load_details 01:44:33 INFO - PROCESS | 7010 | |i|pagename|runs| 01:44:33 INFO - PROCESS | 7010 | |0;ai-astar;112;104;112;110;113;111;111;111;110;112 01:44:33 INFO - PROCESS | 7010 | |1;audio-beat-detection;153;130;156;174;129;156;155;127;190;128 01:44:33 INFO - PROCESS | 7010 | |2;audio-dft;163;163;165;163;164;172;164;163;165;162 01:44:33 INFO - PROCESS | 7010 | |3;audio-fft;77;76;76;163;77;76;75;74;168;76 01:44:33 INFO - PROCESS | 7010 | |4;audio-oscillator;86;87;147;86;86;86;138;86;86;149 01:44:33 INFO - PROCESS | 7010 | |5;imaging-gaussian-blur;118;119;118;117;118;118;117;118;118;117 01:44:33 INFO - PROCESS | 7010 | |6;imaging-darkroom;150;147;147;148;147;147;147;147;147;148 01:44:33 INFO - PROCESS | 7010 | |7;imaging-desaturate;97;95;96;95;97;96;99;95;96;95 01:44:33 INFO - PROCESS | 7010 | |8;json-parse-financial;59;54;53;54;54;54;55;56;54;54 01:44:33 INFO - PROCESS | 7010 | |9;json-stringify-tinderbox;63;66;63;64;65;64;64;63;64;64 01:44:33 INFO - PROCESS | 7010 | |10;stanford-crypto-aes;81;80;82;84;82;90;85;82;106;80 01:44:33 INFO - PROCESS | 7010 | |11;stanford-crypto-ccm;127;122;130;142;128;121;139;134;127;132 01:44:33 INFO - PROCESS | 7010 | |12;stanford-crypto-pbkdf2;164;160;164;159;167;164;159;158;166;160 01:44:33 INFO - PROCESS | 7010 | |13;stanford-crypto-sha256-iterative;64;75;64;63;66;65;64;67;62;63 01:44:33 INFO - PROCESS | 7010 | __end_tp_report 01:44:33 INFO - PROCESS | 7010 | __start_cc_report 01:44:33 INFO - PROCESS | 7010 | _x_x_mozilla_cycle_collect,897 01:44:33 INFO - PROCESS | 7010 | __end_cc_report 01:44:33 INFO - PROCESS | 7010 | __startTimestamp1465202673076__endTimestamp 01:44:33 INFO - PROCESS | 7010 | 01:44:33 INFO - PROCESS | 7010 | ------- Summary: start ------- 01:44:33 INFO - PROCESS | 7010 | Number of tests: 14 01:44:33 INFO - PROCESS | 7010 | 01:44:33 INFO - PROCESS | 7010 | [#0] ai-astar Cycles:10 Average:110.60 Median:111.50 stddev:2.50 (2.2%) stddev-sans-first:2.60 01:44:33 INFO - PROCESS | 7010 | Values: 112.0 104.0 112.0 110.0 113.0 111.0 111.0 111.0 110.0 112.0 01:44:33 INFO - PROCESS | 7010 | 01:44:33 INFO - PROCESS | 7010 | [#1] audio-beat-detection Cycles:10 Average:149.80 Median:155.50 stddev:21.44 (13.8%) stddev-sans-first:22.71 01:44:33 INFO - PROCESS | 7010 | Values: 153.0 130.0 156.0 174.0 129.0 156.0 155.0 127.0 190.0 128.0 01:44:33 INFO - PROCESS | 7010 | 01:44:33 INFO - PROCESS | 7010 | [#2] audio-dft Cycles:10 Average:164.40 Median:164.00 stddev:2.84 (1.7%) stddev-sans-first:2.96 01:44:33 INFO - PROCESS | 7010 | Values: 163.0 163.0 165.0 163.0 164.0 172.0 164.0 163.0 165.0 162.0 01:44:33 INFO - PROCESS | 7010 | 01:44:33 INFO - PROCESS | 7010 | [#3] audio-fft Cycles:10 Average:93.80 Median:76.00 stddev:37.82 (49.8%) stddev-sans-first:39.62 01:44:33 INFO - PROCESS | 7010 | Values: 77.0 76.0 76.0 163.0 77.0 76.0 75.0 74.0 168.0 76.0 01:44:33 INFO - PROCESS | 7010 | 01:44:33 INFO - PROCESS | 7010 | [#4] audio-oscillator Cycles:10 Average:103.70 Median:86.00 stddev:28.41 (33.0%) stddev-sans-first:29.40 01:44:33 INFO - PROCESS | 7010 | Values: 86.0 87.0 147.0 86.0 86.0 86.0 138.0 86.0 86.0 149.0 01:44:33 INFO - PROCESS | 7010 | 01:44:33 INFO - PROCESS | 7010 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 01:44:33 INFO - PROCESS | 7010 | Values: 118.0 119.0 118.0 117.0 118.0 118.0 117.0 118.0 118.0 117.0 01:44:33 INFO - PROCESS | 7010 | 01:44:33 INFO - PROCESS | 7010 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:147.00 stddev:0.97 (0.7%) stddev-sans-first:0.44 01:44:33 INFO - PROCESS | 7010 | Values: 150.0 147.0 147.0 148.0 147.0 147.0 147.0 147.0 147.0 148.0 01:44:33 INFO - PROCESS | 7010 | 01:44:33 INFO - PROCESS | 7010 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:1.29 (1.3%) stddev-sans-first:1.32 01:44:33 INFO - PROCESS | 7010 | Values: 97.0 95.0 96.0 95.0 97.0 96.0 99.0 95.0 96.0 95.0 01:44:33 INFO - PROCESS | 7010 | 01:44:33 INFO - PROCESS | 7010 | [#8] json-parse-financial Cycles:10 Average:54.70 Median:54.00 stddev:1.70 (3.2%) stddev-sans-first:0.83 01:44:33 INFO - PROCESS | 7010 | Values: 59.0 54.0 53.0 54.0 54.0 54.0 55.0 56.0 54.0 54.0 01:44:33 INFO - PROCESS | 7010 | 01:44:33 INFO - PROCESS | 7010 | [#9] json-stringify-tinderbox Cycles:10 Average:64.00 Median:64.00 stddev:0.94 (1.5%) stddev-sans-first:0.93 01:44:33 INFO - PROCESS | 7010 | Values: 63.0 66.0 63.0 64.0 65.0 64.0 64.0 63.0 64.0 64.0 01:44:33 INFO - PROCESS | 7010 | 01:44:33 INFO - PROCESS | 7010 | [#10] stanford-crypto-aes Cycles:10 Average:85.20 Median:82.00 stddev:7.89 (9.6%) stddev-sans-first:8.22 01:44:33 INFO - PROCESS | 7010 | Values: 81.0 80.0 82.0 84.0 82.0 90.0 85.0 82.0 106.0 80.0 01:44:33 INFO - PROCESS | 7010 | 01:44:33 INFO - PROCESS | 7010 | [#11] stanford-crypto-ccm Cycles:10 Average:130.20 Median:131.00 stddev:6.76 (5.2%) stddev-sans-first:7.07 01:44:33 INFO - PROCESS | 7010 | Values: 127.0 122.0 130.0 142.0 128.0 121.0 139.0 134.0 127.0 132.0 01:44:33 INFO - PROCESS | 7010 | 01:44:33 INFO - PROCESS | 7010 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.10 Median:164.00 stddev:3.25 (2.0%) stddev-sans-first:3.37 01:44:33 INFO - PROCESS | 7010 | Values: 164.0 160.0 164.0 159.0 167.0 164.0 159.0 158.0 166.0 160.0 01:44:33 INFO - PROCESS | 7010 | 01:44:33 INFO - PROCESS | 7010 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.30 Median:64.50 stddev:3.71 (5.8%) stddev-sans-first:3.91 01:44:33 INFO - PROCESS | 7010 | Values: 64.0 75.0 64.0 63.0 66.0 65.0 64.0 67.0 62.0 63.0 01:44:33 INFO - PROCESS | 7010 | -------- Summary: end -------- 01:44:33 INFO - PROCESS | 7010 | 01:44:33 INFO - TEST-INFO | 7010: exit 0 01:44:34 INFO - TEST-OK | kraken | took 62325ms 01:44:34 INFO - SUITE-END | took 1173s 01:44:34 INFO - Completed test suite (00:19:33) 01:44:34 INFO - javascript benchmark 01:44:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7254.82990387691, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3047.0, 3125.749940004799, 3143.764217683673, 3161.035884055365, 3183.840807959603, 5373.274607927929, 5401.945980540198, 5437.891242175154, 5496.697681627509, 5523.309586301712, 5311.681299122055, 5341.252224688546, 5426.294581704373, 5450.264214331074, 5460.180972854074, 4761.0239900820425, 4771.236602143649, 4823.469418363977, 4942.703437793726, 4965.783383071134, 4808.879778005543, 5025.3969523657215, 5035.471275516073, 5040.092783299005, 5058.898822023557, 4844.927326090129, 4884.072026314989, 4921.114199444099, 4986.927810520738, 4987.900241995158, 4928.285398617216, 4928.926066109011, 4940.802367905279, 4941.110600091982, 5009.524095210985, 4867.634927380461, 4892.437369702494, 4924.0, 4925.138100832376, 4966.602671786249, 5203.739813009334, 5283.920741188886, 5296.788128474856, 5312.9734351328, 5403.945960540423, 5802.82591522255, 5803.042497987827, 5809.82570522885, 5812.767489300423, 5817.680027598481, 5709.885802283972, 5838.824835254949, 5844.327902291206, 5848.239728835267, 5864.032434648278, 5452.100403433429, 5476.17857321405, 5496.862578435571, 5522.447755224445, 5524.723763811793, 6026.186464827279, 6029.125776762345, 6048.213732214784, 6056.545759068087, 6081.604695694766, 5613.943860561424, 5671.489565939085, 5810.448007439287, 5819.79630712923, 5821.2141360916585, 5778.739956701875, 5835.854103647443, 5836.8540786479825, 5840.036393995028, 5913.497352725067, 5664.376918538957, 5737.540996720252, 5778.0, 5785.450382213683, 5788.247527821356, 5827.242458480455, 5836.941630583725, 5845.620034697816, 5871.060630299132, 5886.94113058864, 4424.668149888771, 4437.489688685778, 4446.933296000562, 4463.152001119777, 4467.5532446755715, 3915.099527108781, 3939.1924655445564, 3962.2075584883137, 3965.980170099131, 4022.9597704022585, 5677.233573467612, 5685.346185188673, 5698.715064246771, 5713.514351280188, 5741.942580574224, 5996.850078748066, 5999.850003749942, 6001.909971350433, 6002.069679199731, 6011.6693581853415, 5466.070767969455, 5566.805161819317, 5573.331200255995, 5591.804286849941, 5684.8010319638615, 5039.571636410946, 5050.191969284897, 5061.038402703548, 5071.771770270347, 5078.365204349457, 5963.075723262901, 5984.102384642251, 6015.639061656315, 6044.758209671564, 6090.908636370458, 5756.7121643917635, 5842.941570584409, 5872.29532456108, 5927.170196172626, 5962.493188078888, 6072.726727297194, 6079.209702738615, 6081.452669259788, 6087.573869829246, 6098.146259523759, 5583.469570390806, 5812.709364531841, 5814.651120932757, 5823.621464604787, 5826.796062137805, 5783.913241301299, 5856.092305692625, 5884.499817515559, 5916.3492015877355, 5930.110483427347, 5712.971435142797, 5715.17130016137, 5722.399148089391, 5730.856728581819, 5763.423657634203, 5493.983613031602, 5644.745986430538, 5726.255586773693, 5733.455321744427, 5737.655740655574, 5519.31008623922, 5529.889402211853, 5582.162675598693, 5593.384727680033, 5703.62926409782, 5698.430156984268, 5707.68607726579, 5713.9714301429885, 5728.484436400744, 5757.280339957505, 5532.668039917457, 5588.944110559005, 5629.634073785191, 5643.943560564342, 5670.092785154356], "value": 5379.43051144712, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [584.3017593975198, 615.2985596420081, 627.3851625407103, 637.2703254773288, 640.8333833203367, 40974.385384219226, 42357.364639530395, 42422.78788606056, 42720.786396067975, 46512.30231546521, 42616.78691606538, 42868.57131428693, 42962.57037429625, 43269.35095973555, 43343.13313733724, 8561.929758780152, 8665.39342246043, 8677.869831952527, 8727.301815854717, 8728.869066964, 8559.144085591453, 8664.0902705216, 8723.30213582915, 8734.170253825876, 8739.126087391242, 8760.0, 8794.648214071462, 8819.029906710257, 8820.823583528325, 8825.117488251188, 8706.695265665734, 8766.868496972551, 8780.209781119698, 8804.911950880505, 8815.206631403173, 8500.659973601048, 8621.396502244845, 8624.051354351017, 8627.0, 8646.308295336357, 39494.60505394938, 39519.0, 39529.20941581181, 39763.801180994196, 39791.20417591632, 3422.4695172248094, 3477.113336099304, 3502.334556434295, 3569.1077230692326, 3962.801859907022, 29992.0, 30232.546511802342, 30699.539506907415, 30723.385532289452, 30786.53820192699, 4249.660027197817, 4266.445362102938, 4296.076343586144, 4356.302991521373, 4411.977940110311, 262899.0, 263162.0, 263349.0, 264658.0, 264785.0, 54143.45856541384, 54207.45792542103, 54334.72832635811, 54361.45638543564, 54400.45599543954, 56323.71838140865, 56870.0, 56963.14555281674, 57001.0, 57049.0, 14589.92705036468, 15224.695506089816, 15690.921545392428, 15758.76361854573, 16293.429729959631, 12316.13787034899, 12407.25556466615, 12485.438155283035, 12503.937480312541, 12525.1232413732, 15822.683546329008, 15908.840911590736, 15974.281157347947, 16050.0, 16158.0, 6076.908846367308, 6109.205803245639, 6130.203073600493, 6304.0, 6363.9045414318825, 1001.8647482589903, 1045.2056437107854, 1122.8764835868049, 1125.7129431994952, 1145.1926391893694, 31123.377532449224, 31251.531227031614, 31706.524402133986, 31932.521012184836, 32491.837540812143, 1071.9892801072046, 1088.9292196007393, 1115.3140818396628, 1153.210051114989, 1173.0322483950774, 16502.917485412498, 16795.580110497336, 16952.83047169537, 17023.442411903856, 17182.312707491812, 535549.0, 537607.0, 538113.0, 539709.0, 544127.0, 55870.720646396505, 56093.7195314029, 56253.71873140608, 56307.71846140825, 56360.43639563634, 1363.0731102850157, 1387.486629946926, 1410.5556749623836, 1413.4770135049891, 1415.0660564027692, 30400.695993039786, 31837.20406989844, 31875.0, 31998.52002219922, 32451.35097298088, 49910.0, 50124.749376254345, 50221.74889125531, 50264.0, 50323.0, 462403.0, 474274.0, 474819.0, 475250.0, 475292.0, 40475.1904961905, 40589.39115913204, 40629.39055914223, 40657.79671101626, 42432.0, 47230.76384618055, 47336.7633161832, 47692.0, 48111.27833082437, 48254.0, 39299.0, 40492.0, 41284.79357603193, 41504.547340842924, 41759.7912010438, 40276.0, 42043.36934945917, 43083.569164307955, 43333.133337332445, 43430.78284608557, 40761.79619101885, 41264.58735412607, 41826.79086604548, 41862.0, 44473.55526444694, 34149.82925085359, 37254.25491490209, 37467.62532374641, 37696.43455348117, 37993.810030949666, 28338.14985550437, 28489.43021139607, 28515.28711782222, 28564.0, 28644.283892902844], "value": 19849.37667820146, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.4397258017006, 389.351729370598, 390.8378023120404, 395.663685867013, 408.65672834818747, 13637.249951252677, 15417.15205663688, 18000.549986250335, 19369.322073727424, 19390.321338753147, 15554.22228888554, 17408.738868916946, 18213.7267940981, 18251.72622410665, 18276.360327388546, 5126.641135120543, 5215.765290561933, 5379.5696344292555, 5379.784808607651, 5399.9730001349935, 5169.974150129244, 5266.657667251636, 5287.4976877196605, 5288.92066619001, 5299.152135658295, 5379.0, 5700.572457065716, 5738.626989245686, 5761.193432919374, 5766.308043034821, 5492.0, 5618.943810561904, 6558.442532384729, 6587.736490540373, 6600.8349791255605, 5782.595218334718, 5843.240378750777, 5854.677992710399, 5867.559933004999, 5873.941260587382, 13988.790168147487, 16281.674366512603, 20112.09495572703, 21179.576408471745, 21194.152233910627, 2181.3128864407818, 2234.932952011426, 2270.931872043825, 2336.4042169246904, 2347.319277409549, 9732.70801875945, 9935.354201976848, 10002.849957250646, 10318.89681103187, 10429.739256518571, 1857.3313607101568, 1963.391348681913, 1991.3926252492984, 1991.4025792262264, 2045.7749647538758, 47153.29270060952, 50912.745436272584, 78758.21241787623, 78867.6056619719, 79006.0, 9759.707208783748, 9817.558209880572, 10374.481275936172, 10516.0, 10613.204009699304, 13846.376913038937, 13888.097273677178, 13918.930405347908, 13930.0, 13955.255593050868, 7383.334730571307, 7641.617919104023, 7712.344450721639, 7839.84320313602, 7855.567943763148, 7355.8161045974275, 7356.816079598053, 7425.071866016748, 7475.215102414277, 7493.550386976799, 4291.442112525352, 4295.6778241632, 4307.6769242306955, 4423.8230470781455, 4741.786619602126, 1943.5626983928503, 1990.1243452880685, 2018.1927229108474, 2024.1195080140187, 2062.896855157236, 984.4150917023586, 999.9500024998721, 1005.5977608956476, 1024.9538770755335, 1095.7534554725123, 18354.265829366675, 18628.441146765617, 18906.0, 19125.0, 19304.1313140909, 971.7619183300137, 981.7054883534911, 1028.7325295423243, 1040.7450174707244, 1071.1591400750374, 10137.898621013843, 10592.417417042137, 10611.204159688054, 10638.148948084136, 10657.62698305571, 501298.1689669111, 507566.0, 515811.0, 519534.0, 520490.0, 89253.55373223222, 92052.53973730089, 93196.53401732948, 93459.0, 94124.0, 1005.3867141043958, 1013.9949300253452, 1023.488255872064, 1023.7798873242289, 1032.230987914009, 16147.515574532783, 16643.91678041602, 16646.916765416096, 16811.91594042022, 17012.404565840137, 40571.0, 40590.79704601458, 41198.0, 42419.7879010603, 42704.57295427006, 56127.71936140293, 56280.0, 56739.71630141823, 56853.0, 56923.71538142283, 5285.603579731459, 7510.47426680149, 8496.447730897471, 8562.357823163413, 8751.343649226206, 12311.69220769488, 13075.607731768063, 13155.210687358789, 13213.801792972921, 13365.599032029055, 11284.548618055185, 11292.209545331747, 11658.591949281734, 11701.239419437708, 11894.464749086139, 5012.072766538202, 8372.70223115418, 10818.0, 10913.181511386836, 11461.942690286494, 11482.081433485135, 11671.941640291745, 11719.707007324885, 11752.647420577396, 11839.644810655695, 8550.657973681233, 8701.869471958053, 8723.869141962748, 8729.0, 8777.517236551796, 8579.485230886166, 11448.771024579628, 11513.30920144794, 11619.825702614298, 11696.239744416585], "value": 8862.255616121542, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1485.294485119568, 1493.0742939377585, 1555.2767962897258, 1622.7484739865324, 1635.133379308966, 7912.090109637379, 8351.791205219872, 8487.15128487151, 8977.14717101875, 8990.91009089908, 8347.332213422927, 8375.832483350345, 8696.826063478728, 8715.084916083799, 8768.210861022506, 2281.7147856517977, 2352.6823878776318, 2357.8231632627535, 2357.8938947747306, 2360.598698221298, 2257.89839457224, 2273.943151421211, 2284.9543009139807, 2299.356180269519, 2330.4290448840056, 2300.0914638717695, 2307.1232931486097, 2310.4339436838, 2313.803326717231, 2324.732655744586, 2226.922057727988, 2259.5819773341987, 2270.8751018694047, 2272.4773302140434, 2273.193016479151, 2250.797428231467, 2252.9211477598205, 2267.6258417361114, 2271.1710225767642, 2277.5900337939165, 8701.56492175395, 8804.779880502974, 8820.0, 8834.823303533893, 8881.378303518757, 5095.0574143783515, 5162.741862906877, 5211.088059589557, 5221.321228240343, 5222.399424066205, 3194.265318976625, 3219.919502012445, 3397.69420752131, 3416.8804091856664, 3461.4288642373976, 1167.171308371049, 1190.7320852808136, 2120.946976325589, 2176.09691977829, 2198.857074290166, 12092.758144837142, 12170.75658486834, 12242.571509997197, 12275.0, 12328.07539434546, 4673.415823022122, 4715.41057367829, 4799.856004319876, 4808.927866082012, 4824.300476430968, 10425.218108641882, 10501.369917804956, 10508.579656813794, 10524.210684198715, 10532.10477109439, 5288.391834938954, 5351.331083614548, 5363.249145119687, 5409.053415652245, 5428.158635411518, 4232.534421213664, 4655.441347038377, 4797.112534181188, 4812.133815913169, 4812.278158276216, 4092.5676013395073, 4119.215888829802, 4182.519010313853, 4186.885343908488, 4202.684798640114, 1299.91550549214, 1329.2356894785537, 1330.0091382256019, 1334.7597432462055, 1340.2427628390124, 964.0600414595713, 972.2902281334524, 986.7681094942683, 995.0745806399973, 996.6312464388222, 5758.971205143947, 5877.324107727581, 5885.558583106199, 5972.790952316648, 6036.15493830864, 454.7817047817, 459.3018611710182, 470.21708854756446, 474.2128067408086, 476.5377583743763, 3837.1558257183933, 3945.8027098645525, 3987.521497420328, 4025.9194816103513, 4059.3707975263883, 10434.37393756377, 10822.080123189617, 10873.891261087289, 10940.179486538382, 10948.124150067975, 10021.248406369552, 10431.16550675944, 10436.895631043744, 10727.356358618508, 10794.082502987334, 8213.301869341054, 8214.753557393287, 8247.134050924686, 8339.374546909006, 8386.496810191407, 5780.450857168562, 5867.295924489089, 5869.236999190078, 5904.409559044233, 6035.698215089315, 9685.564149613143, 9911.55398007077, 9925.503724813874, 9940.652077177265, 10063.094321511098, 10155.086042256233, 10432.58269669235, 10442.0, 10468.581256749645, 10494.265401421828, 7144.499885007999, 7574.5076570022775, 7707.499012564165, 7810.843783124419, 7846.333061689592, 8638.438501497383, 8646.956765216133, 8691.348148888985, 8692.34807389461, 8708.433951793113, 7384.409247260099, 7415.4809163360205, 7711.9974403327205, 7771.8834217485655, 7828.099768526692, 7464.664090116066, 7597.506162099446, 7611.961940190264, 7656.80857978555, 7741.651625676745, 7043.859122817413, 7064.82337941535, 7116.110486189226, 7123.893141602776, 7125.394341481032, 4762.333273341805, 4827.61379089679, 4865.635077369282, 4964.726940018334, 4964.751762411793, 4838.879028024327, 4859.076775412802, 4909.042736666316, 4924.556789888928, 4952.331435256338], "value": 4588.140523837552, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [331.2431094948043, 333.7630282499425, 335.43479237484854, 340.7069919868913, 342.2538865273704, 5584.329880414351, 5667.546596272298, 5674.914876276859, 5705.629134106291, 5724.1986121942855, 5523.806666766664, 5548.640583057147, 5551.750171242294, 5578.665280083188, 5600.103983362663, 4116.83865970365, 4168.7707176105305, 4303.827846886121, 4316.287812510932, 4388.714733542325, 4266.7866606669695, 4302.11806579652, 4325.178216138939, 4331.5884990925815, 4343.457067866517, 4236.173946080516, 4275.700700950934, 4288.549702281262, 4312.482502099737, 4322.524522302544, 4023.0, 4272.46594175728, 4299.914001719963, 4300.311950088002, 4302.913087152729, 3706.110533471974, 3710.3135919854913, 3722.0, 3730.4404339349044, 3747.4940882980723, 5383.407825139271, 5399.325084364455, 5407.486288802557, 5426.321709786277, 5429.4570542945785, 4648.302754586839, 4923.532264434873, 4929.827456039057, 4942.456329803718, 4967.453580106221, 5745.942540574624, 5798.869220502003, 5819.127130930352, 5831.825045248649, 5837.628157383012, 4132.628063474302, 4139.77231252281, 4152.397902304149, 4154.356074808409, 4158.293090174678, 5817.0512878185855, 6009.429104235091, 6062.363451837582, 6069.605475644069, 6090.878182436327, 4209.91580168401, 4222.78886055696, 4228.794793483904, 4231.407602935591, 4248.277792775174, 4308.310670292738, 4350.760708161019, 4353.303471444617, 4360.934585981213, 4361.672874534359, 4702.694324868872, 4930.5069493050405, 4944.184209605447, 4959.876003099879, 4973.975130124326, 5878.559108066912, 5898.64608123514, 5909.409059094142, 5946.137810017523, 5969.611975221596, 1472.6097584140211, 1486.8364479907202, 1493.5370035289095, 1497.951433996207, 1498.715244103617, 932.3659911260409, 940.3323640215524, 966.7969726357403, 1002.8846682631445, 1009.1876039787894, 5592.496675299242, 5629.324481062299, 5632.295963004624, 5633.549316054706, 5641.392203222062, 5899.377671140471, 5941.31674857397, 5941.613795103304, 5943.31651860033, 6061.212042434456, 5359.0, 5602.551795856321, 5686.772529098873, 5706.629069110494, 5735.426457354315, 3212.6346302821207, 3214.951775723366, 3219.259570298844, 3227.209333713255, 3251.4635085210675, 6055.364186760415, 6110.61440794371, 6165.938340616626, 6247.875042499125, 6285.654289014148, 6087.878242435215, 6118.449339559461, 6194.907076393858, 6241.656708881055, 6247.937520624827, 6099.756009759737, 6223.0129537822095, 6226.937730622726, 6233.348162736878, 6236.968815155895, 5959.404059594006, 6039.969800150971, 6048.697565121638, 6095.4399152357, 6097.695115244132, 5945.64326140433, 5981.671008094422, 6030.30651475086, 6033.245844269466, 6033.456988870847, 6179.907301390393, 6271.052605275513, 6305.842353941188, 6305.959516679696, 6325.620462772248, 4234.809433575558, 4235.449391579075, 4281.314989601648, 4292.570742925683, 4314.0, 5843.328017278068, 5908.586398952032, 6112.938870611237, 6121.296050954019, 6122.418370254819, 5888.852778680567, 5907.616004959664, 5920.0, 5934.317553481233, 5957.672328022, 5867.149263356704, 5887.322957859729, 5890.852728681646, 5942.881142377215, 5952.58331916779, 5545.861353466195, 5724.370319264961, 5799.82600521985, 5803.332616749128, 5816.36020037804, 5902.734376952962, 5966.820995370146, 5967.49276311501, 5976.312724036791, 5982.7008649568215, 5644.6613203207935, 5772.855678608068, 5786.971065144816, 5795.1314099521005, 5803.78120594663], "value": 4454.111493303971, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [765.1559741024133, 809.4859764049828, 815.6778072661299, 830.4394533689758, 837.8240569480411, 15246.313915873785, 15447.459338923127, 15471.845281547181, 15580.22098895055, 15670.451534196305, 14484.42062317506, 14551.126932384064, 14574.198419086946, 14624.926875365634, 14931.626709332271, 773.9806504837396, 803.5941849366092, 810.4245985350408, 812.760235730461, 829.2163905109674, 824.9793755156109, 829.0, 830.4477522447565, 830.7217082277444, 830.9861968398544, 852.1563651984553, 855.8031652719878, 855.80744332525, 858.1204265627719, 859.8753180788782, 844.0546587821678, 845.3870943565896, 846.2764336492272, 848.2323497235012, 849.647396330522, 622.1103821535203, 622.4304761143549, 622.8567429491197, 622.8754249150188, 622.987540249197, 15636.530904072895, 15646.374145034186, 15653.530394088195, 15750.0, 15757.527274181793, 14436.133831970115, 14482.71034579313, 14591.635209119751, 14637.487687930978, 14776.926115369355, 11936.28382297065, 12111.636650900398, 12143.93928030363, 12267.69330766729, 12442.0, 3739.7943113128767, 3853.364194907837, 3862.7682339059747, 3883.572806991229, 3895.7662540247675, 77567.22432775656, 80286.59856700737, 80501.59749201275, 80636.19363806346, 80833.59583202047, 11020.173486988508, 11138.498767555317, 11253.49359278818, 11370.0, 11684.12369072323, 21688.34934951954, 21816.0, 21829.345119646438, 21857.234996775038, 21907.890460547595, 8361.0, 8536.317094632415, 8629.439086459486, 8752.956235218782, 8794.252488538546, 4838.274258861199, 4847.710583260343, 4929.630277729185, 4955.281484184845, 5125.820596279113, 3509.78941263525, 3628.165521929971, 3630.6006339302658, 3637.7635453695425, 3639.6178401267484, 593.7209511529575, 600.9579329446897, 606.5056978562458, 613.9869215793975, 624.4317670919442, 638.5211091681239, 650.8080116365684, 734.3390948146604, 758.6510205305622, 765.6210175962934, 9972.601095956226, 10139.239557033252, 10322.793544129076, 10537.683869483928, 10550.525226364833, 624.8562830548999, 639.9680015999181, 675.4157653629575, 786.6460092958192, 803.8392321535716, 4711.764411779466, 5025.246213067996, 5059.696418214919, 5122.820701275437, 5130.102232109366, 66211.0, 67016.32983670199, 67983.66008169927, 68160.0, 111083.0, 60694.174056352684, 74256.25743742601, 92027.0, 94202.0, 95665.52167239258, 72436.0, 73572.26427735655, 75686.62156689292, 86856.565717171, 87225.0, 10520.15838732915, 10628.415437150721, 10824.945875270574, 10916.56333746673, 10921.945390273315, 37994.62005379911, 39055.804720976215, 39765.0, 48562.0, 51332.74333628308, 66367.0, 72108.63945680238, 72994.27005729875, 73408.26591734227, 74541.0, 12302.81545776832, 13116.278604676834, 13158.539451119164, 13448.394822233218, 13571.728565428833, 14333.56999290023, 15472.163635640043, 15579.76630350523, 15796.36814527406, 15857.207139642742, 13773.242471663754, 13962.4415023402, 14081.577552673436, 14547.0, 14619.122852628876, 13383.19700817954, 13507.527236546674, 13791.655208619464, 14323.928380358031, 15149.697006059596, 13327.86672133305, 13541.729165416833, 13857.514986975408, 14109.717805644035, 14323.355449004612, 11042.779144417227, 11171.441427928408, 11617.593384231512, 11903.345316007702, 11921.761564768483, 11762.76474470523, 12323.137380383645, 12401.25592464455, 12604.87395126037, 12769.489220431078], "value": 7538.691419637393, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1545.1999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 104.0, 112.0, 110.0, 113.0, 111.0, 111.0, 111.0, 110.0, 112.0], "value": 110.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 130.0, 156.0, 174.0, 129.0, 156.0, 155.0, 127.0, 190.0, 128.0], "value": 149.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 165.0, 163.0, 164.0, 172.0, 164.0, 163.0, 165.0, 162.0], "value": 164.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 76.0, 163.0, 77.0, 76.0, 75.0, 74.0, 168.0, 76.0], "value": 93.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 147.0, 86.0, 86.0, 86.0, 138.0, 86.0, 86.0, 149.0], "value": 103.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 119.0, 118.0, 117.0, 118.0, 118.0, 117.0, 118.0, 118.0, 117.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 147.0, 147.0, 148.0, 147.0, 147.0, 147.0, 147.0, 147.0, 148.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 95.0, 96.0, 95.0, 97.0, 96.0, 99.0, 95.0, 96.0, 95.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 54.0, 53.0, 54.0, 54.0, 54.0, 55.0, 56.0, 54.0, 54.0], "value": 54.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 66.0, 63.0, 64.0, 65.0, 64.0, 64.0, 63.0, 64.0, 64.0], "value": 64.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 82.0, 84.0, 82.0, 90.0, 85.0, 82.0, 106.0, 80.0], "value": 85.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 122.0, 130.0, 142.0, 128.0, 121.0, 139.0, 134.0, 127.0, 132.0], "value": 130.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 160.0, 164.0, 159.0, 167.0, 164.0, 159.0, 158.0, 166.0, 160.0], "value": 162.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 75.0, 64.0, 63.0, 66.0, 65.0, 64.0, 67.0, 62.0, 63.0], "value": 65.3, "unit": "score"}]}]} 01:44:34 INFO - Return code: 0 01:44:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:44:34 ERROR - # TBPL SUCCESS # 01:44:34 INFO - Running post-action listener: _resource_record_post_action 01:44:34 INFO - ##### 01:44:34 INFO - ##### Finished run-tests step (success) 01:44:34 INFO - ##### 01:44:34 INFO - Running post-run listener: _resource_record_post_run 01:44:34 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 303104; Write bytes: 303607808; Read time: 520; Write time: 233944 01:44:34 INFO - TinderboxPrint: CPU usage
13.4% 01:44:34 INFO - TinderboxPrint: I/O read bytes / time
303,104 / 520 01:44:34 INFO - TinderboxPrint: I/O write bytes / time
303,607,808 / 233,944 01:44:34 INFO - TinderboxPrint: CPU idle
8,229.9 (86.5%) 01:44:34 INFO - TinderboxPrint: CPU user
1,223.5 (12.9%) 01:44:34 INFO - TinderboxPrint: Swap in / out
0 / 0 01:44:34 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 16609280; Read time: 0; Write time: 6008 01:44:34 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 303104; Write bytes: 286998528; Read time: 520; Write time: 227936 01:44:35 INFO - Running post-run listener: _upload_blobber_files 01:44:35 INFO - Blob upload gear active. 01:44:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:44:35 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 01:44:35 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'] 01:44:35 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 01:44:35 INFO - (blobuploader) - INFO - Open directory for files ... 01:44:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 01:44:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:44:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:44:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 01:44:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:44:36 INFO - (blobuploader) - INFO - Done attempting. 01:44:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:44:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:44:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:44:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:44:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:44:40 INFO - (blobuploader) - INFO - Done attempting. 01:44:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 01:44:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:44:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:44:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 01:44:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:44:41 INFO - (blobuploader) - INFO - Done attempting. 01:44:41 INFO - (blobuploader) - INFO - Iteration through files over. 01:44:41 INFO - Return code: 0 01:44:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:44:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:44:41 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8584de475b74b245ac3d34f97ba849890d7e34b3469e4b99b7f76addd5067aa74422e8c6171b5011f577bdc31d9cf3122615c52a531370903057628b45cc0d0b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8b76df53c296409dc8241edf395f991b05352c657d62243cafd25b1d31f413779d94f8b5178037437685f40ee858e95533e446e9a67db28c434b3c95787e82ea", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/24425ad5f2633020b21e0fee9fa1213861171a0c0a5db42deb63890beeec33a2247cdf99cf02d374b7e8ace222a1b9e76f0ee5151c23e2929056988f51a2a74c"} 01:44:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:44:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:44:41 INFO - Contents: 01:44:41 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8584de475b74b245ac3d34f97ba849890d7e34b3469e4b99b7f76addd5067aa74422e8c6171b5011f577bdc31d9cf3122615c52a531370903057628b45cc0d0b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8b76df53c296409dc8241edf395f991b05352c657d62243cafd25b1d31f413779d94f8b5178037437685f40ee858e95533e446e9a67db28c434b3c95787e82ea", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/24425ad5f2633020b21e0fee9fa1213861171a0c0a5db42deb63890beeec33a2247cdf99cf02d374b7e8ace222a1b9e76f0ee5151c23e2929056988f51a2a74c"} 01:44:41 INFO - Running post-run listener: copy_logs_to_upload_dir 01:44:41 INFO - Copying logs to upload dir... 01:44:41 INFO - mkdir: /builds/slave/test/build/upload/logs 01:44:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.488091 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-06-06 01:44:41.369420) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 01:44:41.372906) ========= 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=52faae308a556c440401f8e5000001e8-1465199673.560878-951992028 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8584de475b74b245ac3d34f97ba849890d7e34b3469e4b99b7f76addd5067aa74422e8c6171b5011f577bdc31d9cf3122615c52a531370903057628b45cc0d0b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8b76df53c296409dc8241edf395f991b05352c657d62243cafd25b1d31f413779d94f8b5178037437685f40ee858e95533e446e9a67db28c434b3c95787e82ea", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/24425ad5f2633020b21e0fee9fa1213861171a0c0a5db42deb63890beeec33a2247cdf99cf02d374b7e8ace222a1b9e76f0ee5151c23e2929056988f51a2a74c"} build_url:https://queue.taskcluster.net/v1/task/ADRw_p8bRw2YRKSoUmpygw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011225 build_url: 'https://queue.taskcluster.net/v1/task/ADRw_p8bRw2YRKSoUmpygw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8584de475b74b245ac3d34f97ba849890d7e34b3469e4b99b7f76addd5067aa74422e8c6171b5011f577bdc31d9cf3122615c52a531370903057628b45cc0d0b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8b76df53c296409dc8241edf395f991b05352c657d62243cafd25b1d31f413779d94f8b5178037437685f40ee858e95533e446e9a67db28c434b3c95787e82ea", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/24425ad5f2633020b21e0fee9fa1213861171a0c0a5db42deb63890beeec33a2247cdf99cf02d374b7e8ace222a1b9e76f0ee5151c23e2929056988f51a2a74c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 01:44:41.397070) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 01:44:41.397373) ========= 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=52faae308a556c440401f8e5000001e8-1465199673.560878-951992028 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004444 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 01:44:41.482606) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 01:44:41.482925) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 01:44:41.483201) ========= ========= Total master_lag: 0.16 =========