builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-033 starttime: 1465053872.8 results: success (0) buildid: 20160604053002 builduid: 6ac011f5931c45d6bddb84c72300e629 revision: a58743e540f5894ce8d802784bbd16737f5ae2c3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-04 08:24:32.806596) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-04 08:24:32.807130) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-04 08:24:32.807480) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-04 08:24:32.864068) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 08:24:32.864345) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1465052572.726020-1546144322 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-04 08:24:33-- 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% 43.1M=0s 2016-06-04 08:24:33 (43.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.120402 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 08:24:33.005976) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 08:24:33.006266) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1465052572.726020-1546144322 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019374 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 08:24:33.063419) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 08:24:33.063781) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a58743e540f5894ce8d802784bbd16737f5ae2c3 --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 a58743e540f5894ce8d802784bbd16737f5ae2c3 --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=edae0fb5fee9fb758e8af6d3000002a4-1465052572.726020-1546144322 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-04 08:24:33,335 truncating revision to first 12 chars 2016-06-04 08:24:33,335 Setting DEBUG logging. 2016-06-04 08:24:33,335 attempt 1/10 2016-06-04 08:24:33,335 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a58743e540f5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-04 08:24:33,757 unpacking tar archive at: fx-team-a58743e540f5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.754627 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 08:24:33.831722) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-04 08:24:33.832012) ========= script_repo_revision: a58743e540f5894ce8d802784bbd16737f5ae2c3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-04 08:24:33.832469) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-04 08:24:33.832779) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-04 08:24:33.840421) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-06-04 08:24:33.840752) ========= /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=edae0fb5fee9fb758e8af6d3000002a4-1465052572.726020-1546144322 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:24:34 INFO - MultiFileLogger online at 20160604 08:24:34 in /builds/slave/test 08:24:34 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 08:24:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:24:34 INFO - {'append_to_log': False, 08:24:34 INFO - 'base_work_dir': '/builds/slave/test', 08:24:34 INFO - 'blob_upload_branch': 'Fx-Team', 08:24:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:24:34 INFO - 'branch': 'Fx-Team', 08:24:34 INFO - 'buildbot_json_path': 'buildprops.json', 08:24:34 INFO - 'config_files': ('talos/linux_config.py',), 08:24:34 INFO - 'default_actions': ('clobber', 08:24:34 INFO - 'read-buildbot-config', 08:24:34 INFO - 'download-and-extract', 08:24:34 INFO - 'populate-webroot', 08:24:34 INFO - 'create-virtualenv', 08:24:34 INFO - 'install', 08:24:34 INFO - 'run-tests'), 08:24:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:24:34 INFO - 'download_minidump_stackwalk': True, 08:24:34 INFO - 'download_symbols': 'ondemand', 08:24:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:24:34 INFO - 'tooltool.py': '/tools/tooltool.py', 08:24:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:24:34 INFO - '/tools/misc-python/virtualenv.py')}, 08:24:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:24:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:24:34 INFO - 'installer_path': 'installer.exe', 08:24:34 INFO - 'log_level': 'info', 08:24:34 INFO - 'log_name': 'talos', 08:24:34 INFO - 'log_to_console': True, 08:24:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:24:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:24:34 INFO - 'opt_config_files': (), 08:24:34 INFO - 'pip_index': False, 08:24:34 INFO - 'sps_profile': False, 08:24:34 INFO - 'sps_profile_interval': 0, 08:24:34 INFO - 'suite': 'dromaeojs-e10s', 08:24:34 INFO - 'system_bits': '32', 08:24:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:24:34 INFO - 'title': 'talos-linux64-ix-033', 08:24:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:24:34 INFO - 'use_talos_json': True, 08:24:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:24:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:24:34 INFO - 'work_dir': 'build'} 08:24:34 INFO - ##### 08:24:34 INFO - ##### Running clobber step. 08:24:34 INFO - ##### 08:24:34 INFO - Running pre-action listener: _resource_record_pre_action 08:24:34 INFO - Running main action method: clobber 08:24:34 INFO - rmtree: /builds/slave/test/build 08:24:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:24:34 INFO - Running post-action listener: _resource_record_post_action 08:24:34 INFO - ##### 08:24:34 INFO - ##### Finished clobber step (success) 08:24:34 INFO - ##### 08:24:34 INFO - ##### 08:24:34 INFO - ##### Running read-buildbot-config step. 08:24:34 INFO - ##### 08:24:34 INFO - Running pre-action listener: _resource_record_pre_action 08:24:34 INFO - Running main action method: read_buildbot_config 08:24:34 INFO - Using buildbot properties: 08:24:34 INFO - { 08:24:34 INFO - "project": "", 08:24:34 INFO - "product": "firefox", 08:24:34 INFO - "script_repo_revision": "production", 08:24:34 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 08:24:34 INFO - "repository": "", 08:24:34 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 08:24:34 INFO - "buildid": "20160604053002", 08:24:34 INFO - "pgo_build": "True", 08:24:34 INFO - "basedir": "/builds/slave/test", 08:24:34 INFO - "buildnumber": 529, 08:24:34 INFO - "slavename": "talos-linux64-ix-033", 08:24:34 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:24:34 INFO - "platform": "ubuntu64_hw", 08:24:34 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:24:34 INFO - "branch": "fx-team", 08:24:34 INFO - "repo_path": "integration/fx-team", 08:24:34 INFO - "revision": "a58743e540f5894ce8d802784bbd16737f5ae2c3", 08:24:34 INFO - "stage_platform": "linux64-pgo", 08:24:34 INFO - "builduid": "6ac011f5931c45d6bddb84c72300e629", 08:24:34 INFO - "slavebuilddir": "test" 08:24:34 INFO - } 08:24:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/SqQ-v3QzQLyfxXVF-ql0LQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 08:24:34 INFO - Running post-action listener: _resource_record_post_action 08:24:34 INFO - ##### 08:24:34 INFO - ##### Finished read-buildbot-config step (success) 08:24:34 INFO - ##### 08:24:34 INFO - ##### 08:24:34 INFO - ##### Running download-and-extract step. 08:24:34 INFO - ##### 08:24:34 INFO - Running pre-action listener: _resource_record_pre_action 08:24:34 INFO - Running main action method: download_and_extract 08:24:34 INFO - mkdir: /builds/slave/test/build/tests 08: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')]} 08:24:34 INFO - https://queue.taskcluster.net/v1/task/SqQ-v3QzQLyfxXVF-ql0LQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:24:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SqQ-v3QzQLyfxXVF-ql0LQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:24:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SqQ-v3QzQLyfxXVF-ql0LQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:24:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SqQ-v3QzQLyfxXVF-ql0LQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:24:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SqQ-v3QzQLyfxXVF-ql0LQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:24:39 INFO - Downloaded 1361 bytes. 08:24:39 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:24:39 INFO - Using the following test package requirements: 08:24:39 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 08:24:39 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:24:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:24:39 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:24:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:24:39 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:24:39 INFO - u'jsshell-linux-x86_64.zip'], 08:24:39 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:24:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:24:39 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 08:24:39 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:24:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:24:39 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:24:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:24:39 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:24:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:24:39 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:24:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:24:39 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:24:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:24:39 INFO - https://queue.taskcluster.net/v1/task/SqQ-v3QzQLyfxXVF-ql0LQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:24:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SqQ-v3QzQLyfxXVF-ql0LQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:24:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SqQ-v3QzQLyfxXVF-ql0LQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:24:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SqQ-v3QzQLyfxXVF-ql0LQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:24:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SqQ-v3QzQLyfxXVF-ql0LQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:24:53 INFO - Downloaded 24440907 bytes. 08:24:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:24:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:24:54 INFO - Return code: 0 08:24:54 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:24:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:24:54 INFO - https://queue.taskcluster.net/v1/task/SqQ-v3QzQLyfxXVF-ql0LQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:24:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SqQ-v3QzQLyfxXVF-ql0LQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:24:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SqQ-v3QzQLyfxXVF-ql0LQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:24:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SqQ-v3QzQLyfxXVF-ql0LQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:24:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SqQ-v3QzQLyfxXVF-ql0LQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:24:59 INFO - Downloaded 24440907 bytes. 08:24:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:24:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:25:01 INFO - Return code: 0 08:25:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:25:01 INFO - https://queue.taskcluster.net/v1/task/SqQ-v3QzQLyfxXVF-ql0LQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:25:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SqQ-v3QzQLyfxXVF-ql0LQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 08:25:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SqQ-v3QzQLyfxXVF-ql0LQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 08:25:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SqQ-v3QzQLyfxXVF-ql0LQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 08:25:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SqQ-v3QzQLyfxXVF-ql0LQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:25:02 INFO - Downloaded 10833369 bytes. 08:25:02 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:25:02 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 08:25:03 INFO - Return code: 0 08:25: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')]} 08:25:03 INFO - https://queue.taskcluster.net/v1/task/SqQ-v3QzQLyfxXVF-ql0LQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:25:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SqQ-v3QzQLyfxXVF-ql0LQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:25:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SqQ-v3QzQLyfxXVF-ql0LQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:25:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SqQ-v3QzQLyfxXVF-ql0LQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:25:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SqQ-v3QzQLyfxXVF-ql0LQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:25:04 INFO - Downloaded 59144481 bytes. 08:25:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SqQ-v3QzQLyfxXVF-ql0LQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:25:04 INFO - mkdir: /builds/slave/test/properties 08:25:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:25:04 INFO - Writing to file /builds/slave/test/properties/build_url 08:25:04 INFO - Contents: 08:25:04 INFO - build_url:https://queue.taskcluster.net/v1/task/SqQ-v3QzQLyfxXVF-ql0LQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:25:05 INFO - Running post-action listener: _resource_record_post_action 08:25:05 INFO - Running post-action listener: set_extra_try_arguments 08:25:05 INFO - ##### 08:25:05 INFO - ##### Finished download-and-extract step (success) 08:25:05 INFO - ##### 08:25:05 INFO - ##### 08:25:05 INFO - ##### Running populate-webroot step. 08:25:05 INFO - ##### 08:25:05 INFO - Running pre-action listener: _resource_record_pre_action 08:25:05 INFO - Running main action method: populate_webroot 08:25:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:25:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:25:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:25:05 INFO - '--tppagecycles', 08:25:05 INFO - '7'], 08:25:05 INFO - 'tests': ['tsvgm']}}, 08:25:05 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:25:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:25:05 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:25:05 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:25:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:25:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:25:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:25:05 INFO - 'talos_options': ['--disable-e10s'], 08:25:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:25:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:25:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:25:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:25:05 INFO - 'talos_options': ['--disable-e10s'], 08:25:05 INFO - 'tests': ['damp', 'tps']}, 08:25:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:25:05 INFO - 'tests': ['damp', 'tps']}, 08:25:05 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:25:05 INFO - 'tests': ['dromaeo_dom']}, 08:25:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:25:05 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:25:05 INFO - 'tests': ['a11yr', 08:25:05 INFO - 'ts_paint', 08:25:05 INFO - 'tpaint', 08:25:05 INFO - 'sessionrestore', 08:25:05 INFO - 'sessionrestore_no_auto_restore', 08:25:05 INFO - 'tabpaint']}, 08:25:05 INFO - 'other-e10s': {'tests': ['a11yr', 08:25:05 INFO - 'ts_paint', 08:25:05 INFO - 'tpaint', 08:25:05 INFO - 'sessionrestore', 08:25:05 INFO - 'sessionrestore_no_auto_restore', 08:25:05 INFO - 'tabpaint']}, 08:25:05 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:25:05 INFO - 'ts_paint', 08:25:05 INFO - 'tpaint', 08:25:05 INFO - 'sessionrestore', 08:25:05 INFO - 'sessionrestore_no_auto_restore', 08:25:05 INFO - 'tabpaint']}, 08:25:05 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:25:05 INFO - 'ts_paint', 08:25:05 INFO - 'tpaint', 08:25:05 INFO - 'sessionrestore', 08:25:05 INFO - 'sessionrestore_no_auto_restore', 08:25:05 INFO - 'tabpaint']}, 08:25:05 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:25:05 INFO - 'tests': ['a11yr', 08:25:05 INFO - 'ts_paint', 08:25:05 INFO - 'tpaint', 08:25:05 INFO - 'sessionrestore', 08:25:05 INFO - 'sessionrestore_no_auto_restore', 08:25:05 INFO - 'tabpaint']}, 08:25:05 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:25:05 INFO - 'tests': ['a11yr', 08:25:05 INFO - 'ts_paint', 08:25:05 INFO - 'tpaint', 08:25:05 INFO - 'sessionrestore', 08:25:05 INFO - 'sessionrestore_no_auto_restore', 08:25:05 INFO - 'tabpaint']}, 08:25:05 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:25:05 INFO - 'tests': ['tsvgx', 08:25:05 INFO - 'tsvgr_opacity', 08:25:05 INFO - 'tart', 08:25:05 INFO - 'tscrollx', 08:25:05 INFO - 'cart']}, 08:25:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:25:05 INFO - 'tsvgr_opacity', 08:25:05 INFO - 'tart', 08:25:05 INFO - 'tscrollx', 08:25:05 INFO - 'cart']}, 08:25:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:25:05 INFO - 'talos_options': ['--disable-e10s'], 08:25:05 INFO - 'tests': ['tp5o']}, 08:25:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:25:05 INFO - 'tests': ['tp5o']}, 08:25:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:25:05 INFO - 'talos_options': ['--disable-e10s', 08:25:05 INFO - '--xperf_path', 08:25:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:25:05 INFO - 'tests': ['tp5n']}, 08:25:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:25:05 INFO - 'talos_options': ['--xperf_path', 08:25:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:25:05 INFO - 'tests': ['tp5n']}}, 08:25:05 INFO - 'talos.zip': {'path': '', 08:25:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:25:05 INFO - Running post-action listener: _resource_record_post_action 08:25:05 INFO - ##### 08:25:05 INFO - ##### Finished populate-webroot step (success) 08:25:05 INFO - ##### 08:25:05 INFO - ##### 08:25:05 INFO - ##### Running create-virtualenv step. 08:25:05 INFO - ##### 08:25:05 INFO - Running pre-action listener: _resource_record_pre_action 08:25:05 INFO - Running main action method: create_virtualenv 08:25:05 INFO - Creating virtualenv /builds/slave/test/build/venv 08:25:05 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:25:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:25:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:25:05 INFO - Using real prefix '/usr' 08:25:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:25:06 INFO - Installing distribute.............................................................................................................................................................................................done. 08:25:08 INFO - Installing pip.................done. 08:25:08 INFO - Return code: 0 08:25:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:25:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:25:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:25:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:25:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:25:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:08 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 0x7f4c4e840f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x164f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x171c190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ae110>, '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 0x171a230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x171a6c0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1465052572.726020-1546144322', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:25:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:25:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:25:08 INFO - Using env: {'DISPLAY': ':0', 08:25:08 INFO - 'HOME': '/home/cltbld', 08:25:08 INFO - 'LANG': 'en_US.UTF-8', 08:25:08 INFO - 'LANGUAGE': 'en_US:en', 08:25:08 INFO - 'LOGNAME': 'cltbld', 08:25:08 INFO - 'MAIL': '/var/mail/cltbld', 08:25:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:25:08 INFO - 'MOZ_NO_REMOTE': '1', 08:25:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:25:08 INFO - 'NO_EM_RESTART': '1', 08:25:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:25:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:25:08 INFO - 'PWD': '/builds/slave/test', 08:25:08 INFO - 'SHELL': '/bin/bash', 08:25:08 INFO - 'SHLVL': '1', 08:25:08 INFO - 'TERM': 'linux', 08:25:08 INFO - 'TMOUT': '86400', 08:25:08 INFO - 'USER': 'cltbld', 08:25:08 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1465052572.726020-1546144322', 08:25:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:25:08 INFO - '_': '/tools/buildbot/bin/python'} 08:25:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:25:08 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:25:08 INFO - Cleaning up... 08:25:08 INFO - Return code: 0 08:25:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:25:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:25:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:25:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:25:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:25:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:08 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 0x7f4c4e840f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x164f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x171c190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ae110>, '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 0x171a230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x171a6c0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1465052572.726020-1546144322', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:25:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:25:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:25:08 INFO - Using env: {'DISPLAY': ':0', 08:25:08 INFO - 'HOME': '/home/cltbld', 08:25:08 INFO - 'LANG': 'en_US.UTF-8', 08:25:08 INFO - 'LANGUAGE': 'en_US:en', 08:25:08 INFO - 'LOGNAME': 'cltbld', 08:25:08 INFO - 'MAIL': '/var/mail/cltbld', 08:25:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:25:08 INFO - 'MOZ_NO_REMOTE': '1', 08:25:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:25:08 INFO - 'NO_EM_RESTART': '1', 08:25:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:25:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:25:08 INFO - 'PWD': '/builds/slave/test', 08:25:08 INFO - 'SHELL': '/bin/bash', 08:25:08 INFO - 'SHLVL': '1', 08:25:08 INFO - 'TERM': 'linux', 08:25:08 INFO - 'TMOUT': '86400', 08:25:08 INFO - 'USER': 'cltbld', 08:25:08 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1465052572.726020-1546144322', 08:25:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:25:08 INFO - '_': '/tools/buildbot/bin/python'} 08:25:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:25:08 INFO - Downloading/unpacking psutil>=3.1.1 08:25:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:25:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:25:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:25:10 INFO - Installing collected packages: psutil 08:25:10 INFO - Running setup.py install for psutil 08:25:10 INFO - building 'psutil._psutil_linux' extension 08:25:10 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:25:10 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:25:10 INFO - building 'psutil._psutil_posix' extension 08:25:10 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:25:11 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:25:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:25:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:25:11 INFO - Successfully installed psutil 08:25:11 INFO - Cleaning up... 08:25:11 INFO - Return code: 0 08:25:11 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:25: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')]} 08:25:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:25:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25: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')]} 08:25:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:25:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:11 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 0x7f4c4e840f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x164f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x171c190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ae110>, '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 0x171a230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x171a6c0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1465052572.726020-1546144322', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:25:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:25:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:25:11 INFO - Using env: {'DISPLAY': ':0', 08:25:11 INFO - 'HOME': '/home/cltbld', 08:25:11 INFO - 'LANG': 'en_US.UTF-8', 08:25:11 INFO - 'LANGUAGE': 'en_US:en', 08:25:11 INFO - 'LOGNAME': 'cltbld', 08:25:11 INFO - 'MAIL': '/var/mail/cltbld', 08:25:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:25:11 INFO - 'MOZ_NO_REMOTE': '1', 08:25:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:25:11 INFO - 'NO_EM_RESTART': '1', 08:25:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:25:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:25:11 INFO - 'PWD': '/builds/slave/test', 08:25:11 INFO - 'SHELL': '/bin/bash', 08:25:11 INFO - 'SHLVL': '1', 08:25:11 INFO - 'TERM': 'linux', 08:25:11 INFO - 'TMOUT': '86400', 08:25:11 INFO - 'USER': 'cltbld', 08:25:11 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1465052572.726020-1546144322', 08:25:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:25:11 INFO - '_': '/tools/buildbot/bin/python'} 08:25:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:25:11 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:25:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:13 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:25:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:25:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:25:13 INFO - Installing collected packages: mozsystemmonitor 08:25:13 INFO - Running setup.py install for mozsystemmonitor 08:25:13 INFO - Successfully installed mozsystemmonitor 08:25:13 INFO - Cleaning up... 08:25:13 INFO - Return code: 0 08:25:13 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:25:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:25:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:25:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:25:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:25:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:13 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 0x7f4c4e840f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x164f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x171c190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ae110>, '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 0x171a230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x171a6c0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1465052572.726020-1546144322', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:25:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:25:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:25:13 INFO - Using env: {'DISPLAY': ':0', 08:25:13 INFO - 'HOME': '/home/cltbld', 08:25:13 INFO - 'LANG': 'en_US.UTF-8', 08:25:13 INFO - 'LANGUAGE': 'en_US:en', 08:25:13 INFO - 'LOGNAME': 'cltbld', 08:25:13 INFO - 'MAIL': '/var/mail/cltbld', 08:25:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:25:13 INFO - 'MOZ_NO_REMOTE': '1', 08:25:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:25:13 INFO - 'NO_EM_RESTART': '1', 08:25:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:25:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:25:13 INFO - 'PWD': '/builds/slave/test', 08:25:13 INFO - 'SHELL': '/bin/bash', 08:25:13 INFO - 'SHLVL': '1', 08:25:13 INFO - 'TERM': 'linux', 08:25:13 INFO - 'TMOUT': '86400', 08:25:13 INFO - 'USER': 'cltbld', 08:25:13 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1465052572.726020-1546144322', 08:25:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:25:13 INFO - '_': '/tools/buildbot/bin/python'} 08:25:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:25:13 INFO - Downloading/unpacking jsonschema==2.5.1 08:25:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:25:15 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:25:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:15 INFO - Downloading functools32-3.2.3-2.tar.gz 08:25:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:25:15 INFO - warning: no files found matching '*.txt' 08:25:15 INFO - no previously-included directories found matching 'build' 08:25:15 INFO - no previously-included directories found matching 'dist' 08:25:15 INFO - no previously-included directories found matching '.git*' 08:25:15 INFO - Installing collected packages: jsonschema, functools32 08:25:15 INFO - Running setup.py install for functools32 08:25:15 INFO - warning: no files found matching '*.txt' 08:25:15 INFO - no previously-included directories found matching 'build' 08:25:15 INFO - no previously-included directories found matching 'dist' 08:25:15 INFO - no previously-included directories found matching '.git*' 08:25:15 INFO - Successfully installed jsonschema functools32 08:25:15 INFO - Cleaning up... 08:25:16 INFO - Return code: 0 08:25:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:25:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:25:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:25:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:25:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:25:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:16 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 0x7f4c4e840f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x164f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x171c190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ae110>, '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 0x171a230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x171a6c0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1465052572.726020-1546144322', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:25:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:25:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:25:16 INFO - Using env: {'DISPLAY': ':0', 08:25:16 INFO - 'HOME': '/home/cltbld', 08:25:16 INFO - 'LANG': 'en_US.UTF-8', 08:25:16 INFO - 'LANGUAGE': 'en_US:en', 08:25:16 INFO - 'LOGNAME': 'cltbld', 08:25:16 INFO - 'MAIL': '/var/mail/cltbld', 08:25:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:25:16 INFO - 'MOZ_NO_REMOTE': '1', 08:25:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:25:16 INFO - 'NO_EM_RESTART': '1', 08:25:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:25:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:25:16 INFO - 'PWD': '/builds/slave/test', 08:25:16 INFO - 'SHELL': '/bin/bash', 08:25:16 INFO - 'SHLVL': '1', 08:25:16 INFO - 'TERM': 'linux', 08:25:16 INFO - 'TMOUT': '86400', 08:25:16 INFO - 'USER': 'cltbld', 08:25:16 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1465052572.726020-1546144322', 08:25:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:25:16 INFO - '_': '/tools/buildbot/bin/python'} 08:25:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:25:16 INFO - Downloading/unpacking blobuploader==1.2.4 08:25:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:18 INFO - Downloading blobuploader-1.2.4.tar.gz 08:25:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:25:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:25:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:25:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:25:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:18 INFO - Downloading docopt-0.6.1.tar.gz 08:25:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:25:18 INFO - Installing collected packages: blobuploader, requests, docopt 08:25:18 INFO - Running setup.py install for blobuploader 08:25:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:25:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:25:18 INFO - Running setup.py install for requests 08:25:19 INFO - Running setup.py install for docopt 08:25:19 INFO - Successfully installed blobuploader requests docopt 08:25:19 INFO - Cleaning up... 08:25:19 INFO - Return code: 0 08:25:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:25: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')]} 08:25:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:25:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25: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')]} 08:25:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:25:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:19 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 0x7f4c4e840f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x164f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x171c190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ae110>, '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 0x171a230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x171a6c0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1465052572.726020-1546144322', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:25:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:25:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:25:19 INFO - Using env: {'DISPLAY': ':0', 08:25:19 INFO - 'HOME': '/home/cltbld', 08:25:19 INFO - 'LANG': 'en_US.UTF-8', 08:25:19 INFO - 'LANGUAGE': 'en_US:en', 08:25:19 INFO - 'LOGNAME': 'cltbld', 08:25:19 INFO - 'MAIL': '/var/mail/cltbld', 08:25:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:25:19 INFO - 'MOZ_NO_REMOTE': '1', 08:25:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:25:19 INFO - 'NO_EM_RESTART': '1', 08:25:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:25:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:25:19 INFO - 'PWD': '/builds/slave/test', 08:25:19 INFO - 'SHELL': '/bin/bash', 08:25:19 INFO - 'SHLVL': '1', 08:25:19 INFO - 'TERM': 'linux', 08:25:19 INFO - 'TMOUT': '86400', 08:25:19 INFO - 'USER': 'cltbld', 08:25:19 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1465052572.726020-1546144322', 08:25:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:25:19 INFO - '_': '/tools/buildbot/bin/python'} 08:25:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:25:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:25:19 INFO - Running setup.py (path:/tmp/pip-ccgjv7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:25:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:25:19 INFO - Running setup.py (path:/tmp/pip-ZtYdit-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:25:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:25:19 INFO - Running setup.py (path:/tmp/pip-1mJ46f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:25:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:25:19 INFO - Running setup.py (path:/tmp/pip-zCWPTU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:25:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:25:19 INFO - Running setup.py (path:/tmp/pip-hc5WY1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:25:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:25:20 INFO - Running setup.py (path:/tmp/pip-ew7TCb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:25:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:25:20 INFO - Running setup.py (path:/tmp/pip-zDf6os-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:25:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:25:20 INFO - Running setup.py (path:/tmp/pip-B0B27g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:25:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:25:20 INFO - Running setup.py (path:/tmp/pip-yZ9zwz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:25:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:25:20 INFO - Running setup.py (path:/tmp/pip-kMLTQm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:25:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:25:20 INFO - Running setup.py (path:/tmp/pip-VNxImn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:25:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:25:20 INFO - Running setup.py (path:/tmp/pip-GQ6H82-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:25:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:25:20 INFO - Running setup.py (path:/tmp/pip-jeiTAA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:25:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:25:20 INFO - Running setup.py (path:/tmp/pip-mOjqDE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:25:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:25:20 INFO - Running setup.py (path:/tmp/pip-Dr3ZGh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:25:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:25:20 INFO - Running setup.py (path:/tmp/pip-DfMz0f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:25:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:25:20 INFO - Running setup.py (path:/tmp/pip-UNDxow-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:25:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:25:20 INFO - Running setup.py install for manifestparser 08:25:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:25:21 INFO - Running setup.py install for mozcrash 08:25:21 INFO - Running setup.py install for mozdebug 08:25:21 INFO - Running setup.py install for mozdevice 08:25:21 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:25:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:25:21 INFO - Running setup.py install for mozfile 08:25:21 INFO - Running setup.py install for mozhttpd 08:25:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:25:21 INFO - Running setup.py install for mozinfo 08:25:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:25:21 INFO - Running setup.py install for mozInstall 08:25:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:25:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:25:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:25:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:25:21 INFO - Running setup.py install for mozleak 08:25:21 INFO - Running setup.py install for mozlog 08:25:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:25:21 INFO - Running setup.py install for moznetwork 08:25:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:25:22 INFO - Running setup.py install for mozprocess 08:25:22 INFO - Running setup.py install for mozprofile 08:25:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:25:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:25:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:25:22 INFO - Running setup.py install for mozrunner 08:25:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:25:22 INFO - Running setup.py install for mozscreenshot 08:25:22 INFO - Running setup.py install for moztest 08:25:22 INFO - Running setup.py install for mozversion 08:25:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:25:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:25:22 INFO - Cleaning up... 08:25:22 INFO - Return code: 0 08:25:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:25:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:25:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:25:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:25:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:25:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:22 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 0x7f4c4e840f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x164f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x171c190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ae110>, '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 0x171a230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x171a6c0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1465052572.726020-1546144322', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:25:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:25:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:25:22 INFO - Using env: {'DISPLAY': ':0', 08:25:22 INFO - 'HOME': '/home/cltbld', 08:25:22 INFO - 'LANG': 'en_US.UTF-8', 08:25:22 INFO - 'LANGUAGE': 'en_US:en', 08:25:22 INFO - 'LOGNAME': 'cltbld', 08:25:22 INFO - 'MAIL': '/var/mail/cltbld', 08:25:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:25:22 INFO - 'MOZ_NO_REMOTE': '1', 08:25:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:25:22 INFO - 'NO_EM_RESTART': '1', 08:25:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:25:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:25:22 INFO - 'PWD': '/builds/slave/test', 08:25:22 INFO - 'SHELL': '/bin/bash', 08:25:22 INFO - 'SHLVL': '1', 08:25:22 INFO - 'TERM': 'linux', 08:25:22 INFO - 'TMOUT': '86400', 08:25:22 INFO - 'USER': 'cltbld', 08:25:22 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1465052572.726020-1546144322', 08:25:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:25:22 INFO - '_': '/tools/buildbot/bin/python'} 08:25:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:25:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:25:22 INFO - Running setup.py (path:/tmp/pip-8DNfgL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:25:23 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:25:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:25:23 INFO - Running setup.py (path:/tmp/pip-XOvtss-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:25:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:25:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:25:23 INFO - Running setup.py (path:/tmp/pip-L_39mG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:25:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:25:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:25:23 INFO - Running setup.py (path:/tmp/pip-k5Hz8I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:25:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:25:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:25:23 INFO - Running setup.py (path:/tmp/pip-uRfxRc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:25:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:25:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:25:23 INFO - Running setup.py (path:/tmp/pip-vAZpg5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:25:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:25:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:25:23 INFO - Running setup.py (path:/tmp/pip-nbY0Gj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:25:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:25:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:25:23 INFO - Running setup.py (path:/tmp/pip-aoGdHG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:25:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:25:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:25:23 INFO - Running setup.py (path:/tmp/pip-x8HYB9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:25:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:25:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:25:23 INFO - Running setup.py (path:/tmp/pip-rEiJPv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:25:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:25:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:25:23 INFO - Running setup.py (path:/tmp/pip-6s4Zd6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:25:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:25:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:25:23 INFO - Running setup.py (path:/tmp/pip-aM6tfY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:25:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:25:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:25:23 INFO - Running setup.py (path:/tmp/pip-WncQ5f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:25:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:25:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:25:23 INFO - Running setup.py (path:/tmp/pip-WvPlCD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:25:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:25:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:25:23 INFO - Running setup.py (path:/tmp/pip-u_qcJy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:25:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:25:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:25:24 INFO - Running setup.py (path:/tmp/pip-0sCWhz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:25:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:25:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:25:24 INFO - Running setup.py (path:/tmp/pip-1KefOh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:25:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:25:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:25:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:25:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:25:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:25:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:25:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:25:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:26 INFO - Downloading blessings-1.6.tar.gz 08:25:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:25:26 INFO - Installing collected packages: blessings 08:25:26 INFO - Running setup.py install for blessings 08:25:26 INFO - Successfully installed blessings 08:25:26 INFO - Cleaning up... 08:25:26 INFO - Return code: 0 08:25:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:25:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:25:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:25:26 INFO - Reading from file tmpfile_stdout 08:25:26 INFO - Current package versions: 08:25:26 INFO - argparse == 1.2.1 08:25:26 INFO - blessings == 1.6 08:25:26 INFO - blobuploader == 1.2.4 08:25:26 INFO - docopt == 0.6.1 08:25:26 INFO - functools32 == 3.2.3-2 08:25:26 INFO - jsonschema == 2.5.1 08:25:26 INFO - manifestparser == 1.1 08:25:26 INFO - mozInstall == 1.12 08:25:26 INFO - mozcrash == 0.17 08:25:26 INFO - mozdebug == 0.1 08:25:26 INFO - mozdevice == 0.48 08:25:26 INFO - mozfile == 1.2 08:25:26 INFO - mozhttpd == 0.7 08:25:26 INFO - mozinfo == 0.9 08:25:26 INFO - mozleak == 0.1 08:25:26 INFO - mozlog == 3.2 08:25:26 INFO - moznetwork == 0.27 08:25:26 INFO - mozprocess == 0.22 08:25:26 INFO - mozprofile == 0.28 08:25:26 INFO - mozrunner == 6.11 08:25:26 INFO - mozscreenshot == 0.1 08:25:26 INFO - mozsystemmonitor == 0.3 08:25:26 INFO - moztest == 0.7 08:25:26 INFO - mozversion == 1.4 08:25:26 INFO - psutil == 3.1.1 08:25:26 INFO - requests == 1.2.3 08:25:26 INFO - wsgiref == 0.1.2 08:25:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:25:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:25:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:25:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:25:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:25:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:26 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 0x7f4c4e840f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x164f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x171c190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ae110>, '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 0x171a230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x171a6c0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1465052572.726020-1546144322', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:25:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:25:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:25:26 INFO - Using env: {'DISPLAY': ':0', 08:25:26 INFO - 'HOME': '/home/cltbld', 08:25:26 INFO - 'LANG': 'en_US.UTF-8', 08:25:26 INFO - 'LANGUAGE': 'en_US:en', 08:25:26 INFO - 'LOGNAME': 'cltbld', 08:25:26 INFO - 'MAIL': '/var/mail/cltbld', 08:25:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:25:26 INFO - 'MOZ_NO_REMOTE': '1', 08:25:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:25:26 INFO - 'NO_EM_RESTART': '1', 08:25:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:25:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:25:26 INFO - 'PWD': '/builds/slave/test', 08:25:26 INFO - 'SHELL': '/bin/bash', 08:25:26 INFO - 'SHLVL': '1', 08:25:26 INFO - 'TERM': 'linux', 08:25:26 INFO - 'TMOUT': '86400', 08:25:26 INFO - 'USER': 'cltbld', 08:25:26 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1465052572.726020-1546144322', 08:25:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:25:26 INFO - '_': '/tools/buildbot/bin/python'} 08:25:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:25:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:25:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:25:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:25:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:25:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:25:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:25:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:25:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:25:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:25:26 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:25:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:25:26 INFO - Cleaning up... 08:25:26 INFO - Return code: 0 08:25:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:25:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:25:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:25:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:25:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:25:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4c4e840f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x164f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x171c190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ae110>, '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 0x171a230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x171a6c0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1465052572.726020-1546144322', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:25:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:25:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:25:26 INFO - Using env: {'DISPLAY': ':0', 08:25:26 INFO - 'HOME': '/home/cltbld', 08:25:26 INFO - 'LANG': 'en_US.UTF-8', 08:25:26 INFO - 'LANGUAGE': 'en_US:en', 08:25:26 INFO - 'LOGNAME': 'cltbld', 08:25:26 INFO - 'MAIL': '/var/mail/cltbld', 08:25:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:25:26 INFO - 'MOZ_NO_REMOTE': '1', 08:25:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:25:26 INFO - 'NO_EM_RESTART': '1', 08:25:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:25:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:25:26 INFO - 'PWD': '/builds/slave/test', 08:25:26 INFO - 'SHELL': '/bin/bash', 08:25:26 INFO - 'SHLVL': '1', 08:25:26 INFO - 'TERM': 'linux', 08:25:26 INFO - 'TMOUT': '86400', 08:25:26 INFO - 'USER': 'cltbld', 08:25:26 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1465052572.726020-1546144322', 08:25:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:25:26 INFO - '_': '/tools/buildbot/bin/python'} 08:25:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:25:26 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:25:26 INFO - Cleaning up... 08:25:26 INFO - Return code: 0 08:25:26 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:25:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:25:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:25:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:25:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:25:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4c4e840f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x164f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x171c190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ae110>, '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 0x171a230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x171a6c0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1465052572.726020-1546144322', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:25:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 08:25:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 08:25:26 INFO - Using env: {'DISPLAY': ':0', 08:25:26 INFO - 'HOME': '/home/cltbld', 08:25:26 INFO - 'LANG': 'en_US.UTF-8', 08:25:26 INFO - 'LANGUAGE': 'en_US:en', 08:25:26 INFO - 'LOGNAME': 'cltbld', 08:25:26 INFO - 'MAIL': '/var/mail/cltbld', 08:25:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:25:26 INFO - 'MOZ_NO_REMOTE': '1', 08:25:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:25:26 INFO - 'NO_EM_RESTART': '1', 08:25:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:25:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:25:26 INFO - 'PWD': '/builds/slave/test', 08:25:26 INFO - 'SHELL': '/bin/bash', 08:25:26 INFO - 'SHLVL': '1', 08:25:26 INFO - 'TERM': 'linux', 08:25:26 INFO - 'TMOUT': '86400', 08:25:26 INFO - 'USER': 'cltbld', 08:25:26 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1465052572.726020-1546144322', 08:25:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:25:26 INFO - '_': '/tools/buildbot/bin/python'} 08:25:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:25:27 INFO - Downloading/unpacking flake8 08:25: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 08:25: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 08:25: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 08:25: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 08:25: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 08:25: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 08:25:29 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:25:29 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:25:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:29 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:25:29 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:25:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:29 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:25:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:25:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:25:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:25:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:25:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:25:29 INFO - no previously-included directories found matching 'docs/_build' 08:25:29 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:25:29 INFO - Running setup.py install for pep8 08:25:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:25:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:25:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:25:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:25:29 INFO - no previously-included directories found matching 'docs/_build' 08:25:29 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:25:29 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:25:29 INFO - Cleaning up... 08:25:30 INFO - Return code: 0 08:25:30 INFO - Running post-action listener: _resource_record_post_action 08:25:30 INFO - Running post-action listener: _start_resource_monitoring 08:25:30 INFO - Starting resource monitoring. 08:25:30 INFO - ##### 08:25:30 INFO - ##### Finished create-virtualenv step (success) 08:25:30 INFO - ##### 08:25:30 INFO - ##### 08:25:30 INFO - ##### Running install step. 08:25:30 INFO - ##### 08:25:30 INFO - Running pre-action listener: _resource_record_pre_action 08:25:30 INFO - Running main action method: install 08:25:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:25:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:25:30 INFO - Reading from file tmpfile_stdout 08:25:30 INFO - Detecting whether we're running mozinstall >=1.0... 08:25:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:25:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:25:30 INFO - Reading from file tmpfile_stdout 08:25:30 INFO - Output received: 08:25:30 INFO - Usage: mozinstall [options] installer 08:25:30 INFO - Options: 08:25:30 INFO - -h, --help show this help message and exit 08:25:30 INFO - -d DEST, --destination=DEST 08:25:30 INFO - Directory to install application into. [default: 08:25:30 INFO - "/builds/slave/test"] 08:25:30 INFO - --app=APP Application being installed. [default: firefox] 08:25:30 INFO - mkdir: /builds/slave/test/build/application 08:25:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:25:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:25:47 INFO - Reading from file tmpfile_stdout 08:25:47 INFO - Output received: 08:25:47 INFO - /builds/slave/test/build/application/firefox/firefox 08:25:47 INFO - Running post-action listener: _resource_record_post_action 08:25:47 INFO - ##### 08:25:47 INFO - ##### Finished install step (success) 08:25:47 INFO - ##### 08:25:47 INFO - ##### 08:25:47 INFO - ##### Running run-tests step. 08:25:47 INFO - ##### 08:25:47 INFO - Running pre-action listener: _resource_record_pre_action 08:25:47 INFO - Running main action method: run_tests 08:25:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:25:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:25:47 INFO - Python 2.7.3 08:25:47 INFO - Return code: 0 08:25:47 INFO - grabbing minidump binary from tooltool 08:25:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:25:47 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 0x17ae110>, '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 0x171a230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x171a6c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:25:47 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:25:47 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:25:47 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:25:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:25:47 INFO - Return code: 0 08:25:47 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:25:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:25:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:25:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:25:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:25:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:25:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:25:48 INFO - Return code: 0 08:25:48 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/SqQ-v3QzQLyfxXVF-ql0LQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--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 08:25:48 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/SqQ-v3QzQLyfxXVF-ql0LQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-033 --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 08:25:48 INFO - Using env: {'DISPLAY': ':0', 08:25:48 INFO - 'HOME': '/home/cltbld', 08:25:48 INFO - 'LANG': 'en_US.UTF-8', 08:25:48 INFO - 'LANGUAGE': 'en_US:en', 08:25:48 INFO - 'LOGNAME': 'cltbld', 08:25:48 INFO - 'MAIL': '/var/mail/cltbld', 08:25:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:25:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:25:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:25:48 INFO - 'MOZ_NO_REMOTE': '1', 08:25:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:25:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:25:48 INFO - 'NO_EM_RESTART': '1', 08:25:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:25:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:25:48 INFO - 'PWD': '/builds/slave/test', 08:25:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:25:48 INFO - 'SHELL': '/bin/bash', 08:25:48 INFO - 'SHLVL': '1', 08:25:48 INFO - 'TERM': 'linux', 08:25:48 INFO - 'TMOUT': '86400', 08:25:48 INFO - 'USER': 'cltbld', 08:25:48 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1465052572.726020-1546144322', 08:25:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:25:48 INFO - '_': '/tools/buildbot/bin/python'} 08:25:48 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/SqQ-v3QzQLyfxXVF-ql0LQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--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 08:25:48 INFO - mozversion application_buildid: 20160604053002 08:25:48 INFO - mozversion application_changeset: a58743e540f5894ce8d802784bbd16737f5ae2c3 08:25:48 INFO - mozversion application_display_name: Nightly 08:25:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:25:48 INFO - mozversion application_name: Firefox 08:25:48 INFO - mozversion application_remotingname: firefox 08:25:48 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:25:48 INFO - mozversion application_vendor: Mozilla 08:25:48 INFO - mozversion application_version: 49.0a1 08:25:48 INFO - mozversion platform_buildid: 20160604053002 08:25:48 INFO - mozversion platform_changeset: a58743e540f5894ce8d802784bbd16737f5ae2c3 08:25:48 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:25:48 INFO - mozversion platform_version: 49.0a1 08:25:48 INFO - using testdate: 1465053948 08:25:48 INFO - actual date: 1465053948 08:25:48 INFO - starting webserver on 'localhost:42770' 08:25:48 INFO - SUITE-START | Running 2 tests 08:25:48 INFO - TEST-START | dromaeo_css 08:25:48 INFO - operating with platform_type : linux_ 08:25:48 INFO - Initialising browser for dromaeo_css test... 08:25:48 INFO - TEST-INFO | started process 9819 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpafThFk/profile http://localhost:42770/getInfo.html) 08:25:54 INFO - PROCESS | 9819 | __metrics Screen width/height:1600/1200 08:25:54 INFO - PROCESS | 9819 | colorDepth:24 08:25:54 INFO - PROCESS | 9819 | Browser inner width/height: 1024/697 08:25:54 INFO - PROCESS | 9819 | __metrics 08:25:55 ERROR - PROCESS | 9819 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 08:25:56 INFO - TEST-INFO | 9819: exit 0 08:25:56 INFO - Browser initialized. 08:25:56 INFO - Running cycle 1/1 for dromaeo_css test... 08:25:56 INFO - TEST-INFO | started process 9940 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpafThFk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:26:07 INFO - PROCESS | 9940 | RSS: Main: 166604800 08:26:07 INFO - PROCESS | 9940 | 08:26:57 INFO - PROCESS | 9940 | 1465054017569 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 08:29:05 INFO - PROCESS | 9940 | Cycle 1(1): loaded http://localhost:42770/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42770/tests/dromaeo/cssquery-ext.html) 08:29:06 INFO - PROCESS | 9940 | RSS: Main: 171028480 08:29:06 INFO - PROCESS | 9940 | 08:32:08 INFO - PROCESS | 9940 | Cycle 1(1): loaded http://localhost:42770/tests/dromaeo/cssquery-ext.html (next: http://localhost:42770/tests/dromaeo/cssquery-jquery.html) 08:32:08 INFO - PROCESS | 9940 | RSS: Main: 169709568 08:32:08 INFO - PROCESS | 9940 | 08:35:10 INFO - PROCESS | 9940 | Cycle 1(1): loaded http://localhost:42770/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42770/tests/dromaeo/cssquery-mootools.html) 08:35:11 INFO - PROCESS | 9940 | RSS: Main: 171307008 08:35:11 INFO - PROCESS | 9940 | 08:38:12 INFO - PROCESS | 9940 | Cycle 1(1): loaded http://localhost:42770/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42770/tests/dromaeo/cssquery-prototype.html) 08:38:13 INFO - PROCESS | 9940 | RSS: Main: 168960000 08:38:13 INFO - PROCESS | 9940 | 08:41:15 INFO - PROCESS | 9940 | Cycle 1(1): loaded http://localhost:42770/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42770/tests/dromaeo/cssquery-yui.html) 08:41:16 INFO - PROCESS | 9940 | RSS: Main: 171192320 08:41:16 INFO - PROCESS | 9940 | 08:44:18 INFO - PROCESS | 9940 | Cycle 1(1): loaded http://localhost:42770/tests/dromaeo/cssquery-yui.html (next: http://localhost:42770/tests/dromaeo/cssquery-dojo.html) 08:44:19 INFO - PROCESS | 9940 | RSS: Main: 172019712 08:44:19 INFO - PROCESS | 9940 | 08:44:19 INFO - PROCESS | 9940 | __start_tp_report 08:44:19 INFO - PROCESS | 9940 | _x_x_mozilla_page_load 08:44:19 INFO - PROCESS | 9940 | _x_x_mozilla_page_load_details 08:44:19 INFO - PROCESS | 9940 | |i|pagename|runs| 08:44:19 INFO - PROCESS | 9940 | |0;dojo.html;3148.574942382778;3149.0238026211878;3171.9841400792993;3173.190836336735;3181.952270715938;5477.835664930049;5491.807786727465;5498.4501549845;5525.088360420531;5539.861503462405;5339.252504649352;5490;5500.119980803072;5510.090835012218;5545.833624991246;4957.033378491195;4978.900421991558;5068.46781087986;5101.872453188681;5167.250748641445;881.7135132390032;4941.752912354385;5032.723200223986;5111.948880511203;5117.232415137722;5060.342155519796;5070.61970352225;5095.541401273885;5099.260607211952;5100.33695619569;5089.033083714119;5089.41471730752;5089.6691715038405;5090.669106508102;5133.743312834344;4877;5007.4992500749995;5049.596032317406;5057.317262169634;5090.338256026693;5548.334199895998;5559.6664200148125;5561.721913904288;5579;5617.691026993513;5794.5074668653215;6007.429294217086;6010.038393857006;6019.759209631609;6033.5173186145;5979.431953964367;6033.396660333975;6048.909266361008;6052.303985041733;6091.786787462417;5583.3858275589655;5646.209530665669;5650.858728531778;5654.727686270598;5655.4910058094965;6006.759729610854;6042.969785151046;6150.815475535741;6204.627722336674;6216.285127210338;5751.051076572402;5800.419958004166;5847.912281315784;5850.23946886902;5880.529557635379;5917.7928772493615;5927.911081333784;5928.496077833346;5930.822075337746;5938.851528711817;5756.079027355603;5766.5675074368755;5852.15143804146;5898.616589921641;5919.112133180058;5842.211301474246;5931.584789064724;5969.403059694083;5970.194023806731;6031.09533569968;4506.662000349987;4507.504174540798;4525.570070843265;4538.2511885538515;4563.292689633112;3965.107850733562;4044.130511939947;4050.9797451012555;4057.431959525669;4096;5613.859653508695;5654.971725141348;5677.17680936262;5710.828675139753;5712.257406537206;6018.879622407528;6035.336113027563;6053.667048312385;6061.848453788691;6062.363451837582;5596.720163991784;5605.747741351649;5614.129809879475;5704.030314846486;5737;5138.023775482647;5157.535821776059;5161.380634323905;5167.767450464738;5198.116320225571;6173.166622505904;6211.254649442096;6211.472024877936;6225.221847269091;6230.7507699691505;5863.794767183128;5875.471207591338;5891.293044834647;5923.111533270044;6017;6101.572889897665;6112.908306375497;6119.632822030692;6122.663253521099;6126.877462450637;5701.771929122789;5778.393268706725;5794.159846822272;5824.242848429677;5833.591648584558;5779.0464573344925;5891.8510890375965;5924.9703751480965;5932.2584676915385;5963.70181490915;5811;5819.301683797971;5826.271716035496;5850.561207909509;5871.383504731942;5680.801171958961;5845.18167456565;5846.1815345852465;5852.970735146297;5861.853453663693;5626.38109807929;5675.148727690879;5712.65724056558;5716.056850619601;5730.398308177748;5878.735456904535;5927.288725352985;5941.37615550361;5945.078512830518;5976.133460648269;5528.530074943675;5808.6224395414165;5825.825225243249;5827.184194212899;5833.795817146549 08:44:19 INFO - PROCESS | 9940 | |1;ext.html;594.8958932186869;610.7312782375755;631.8072987738741;641.9101325814383;663.1114306828848;44175.77912110439;45657.31514027288;45667.31499027513;45719.314210286786;47713;46173;46801.53198468014;46902.765486172604;47022;47174.29238561416;8795.912040879606;8996.550172491348;9007.054259302777;9010;9045.683401080963;8844.690435834747;8874.068222836606;8936.329775266848;8940.15068568485;8940.687075952343;8918.777030574223;9008.774780630503;9010.59452324647;9012.143846334588;9013.729588112366;8909.77725556863;8938.508382038985;8972.46165230085;8988.77528061797;8996.100389961017;8907.465552066897;8991.730248092568;8996.370254082216;8997.59510822008;9004.41471304363;42888;43006.13987720259;43006.35490467645;43250.89116533924;43317;3546.982265088684;3718.7396882218254;3890;3987.641112299878;4086.9591304086875;32815.179620509436;33156.3368732624;33226.169345766306;33854.83072584646;34079.65920340789;4106.527749308808;4134.607212314825;4181.080312083506;4221.852235171754;4347.7826108694435;343898;344654;346664;348213.99999999744;349450;34622.480662790076;35650.465243021375;58798.70600647055;59448.702756486804;60084.69957650184;36823.4476482853;37095.072623184096;37294.62705372911;37387.252254955296;37400.69097581571;15183.392664293304;15408.460703875311;15436.45972390961;15438.305276262596;15465.149416782186;12786.744265114645;12849.293288869016;12882.355882205853;12891.935540322425;13018.21890686543;8331.875021874677;8385.6226469809;8417.537035462985;8426.188369500587;8447.36644751646;3225.209823593235;3287.556179915681;3295.044437113258;3302.091924720721;3335.983320083384;1016.9880968436453;1026.6509386808373;1066.0778426661038;1086.8532748078908;1183.402381797204;32579.51130733041;32644.510332345035;32771.83614081914;32878.67121328756;33700;1117.7987962166726;1150.4305368842477;1160.280626011878;1166.6849950513315;1177.3877583656451;17210.31158753661;17334.913325433543;17404.303827846743;17481;17595.73606395905;570258;574647;576776;577694;579475;59648.403515965154;59879.40120598825;59991;60110.39889601048;60217.09674354888;1347.5553067487706;1367.6785955300695;1368.2679766325168;1376.2705765944065;1377.8139951106673;31460.842695786374;31594.526082109245;31624.525632115077;32182.67817321797;32722.181945451553;53235.73382133064;53467;53725.731371342896;53897.461025389246;53909;443552;447133;447916;448268;449856;28294.15117546477;28306.2923426916;28609.570856437585;28736.568951466164;28808.423831522832;48809.51190488192;49038.75480622574;49834.25248621201;50029.74985125051;50422.74788626033;41359.586404135574;42662;43032.56967430411;43082.56917430911;43155.78422107869;42085;42293.15413691648;42322.576774231864;42375.57624423716;42567.36148957706;39375.606243937196;41914.58085419229;42075.368869467595;42175.57824421839;42978.570214297455;36321.81839090788;37220.25559488849;37602;39781.40327895026;41003.179936400506;29494;29622.259443514085;29991.70008299889;29992.85003574968;30066.69933300639 08:44:19 INFO - PROCESS | 9940 | |2;jquery.html;385.812880752835;385.8167370499015;391.50865663592185;397.94826672532577;423.13046689054;17651.11744412779;18954.336598219066;19342.806571934278;19451.41645750628;19921.402357929248;18478.260869565234;19040;19421;19454.513637159078;19564.41306760796;5469.835904922838;5584.6090773645865;5695.060315048033;5714.657120572758;5791.449812267828;5674.404187560309;5687.345955215141;5703.0589952657765;5705.6006079574445;5727.914081288784;5425.321834770653;5659.688717120557;5664.178694089354;5671.8582035449235;5681.460261275193;5610.859728506779;5614.9719251403485;5621.80323688671;5628.127640215753;5652.830415087554;4732.100900828831;5012.04771093491;5023.899522009576;5045.4702256262935;5050.520200580939;13429.39567719455;13632.863671363359;22019.339419817272;22452.101915923344;22467.32598022062;2178.4118288062136;2303.4011157099276;2303.527776805751;2363.929082127539;2518.546661600911;9629.133377996013;9937.950310248474;10021.549030293654;10136.594536218616;10381.584736610526;1721.8450339469507;1735.488031030849;1830.7253911913187;1838.944831655039;1895.8767680100887;76602.23397766007;79977.20022799756;80855.59572202161;82463;83852.58073709592;10986.340819550693;11159.888401116048;11290.322580645023;11392.829107563393;11483.311001339946;15455;15503.302351394213;15509.844901551065;15574.143422111665;15577.454789082327;7903.407244456689;8044.155363686846;8153.062397824207;8201.71294004707;8275.172482751677;7488.326050655467;7529.887051694229;7654.464187506821;7674.004758762762;7963.681452741941;4729.337892695025;4758.976205118952;4776.426828780569;4782.187028205213;4878.414590249193;1976.9505762356057;1993.3820515640198;1996.4709352021434;2009.5177157482099;2074.1184996376783;892.3575025981283;948.5209968965628;1007.3351587951917;1065.6536625596711;1066.1311031509294;17756.9112154441;18953.810461895482;19021.80978190228;19469.12388942501;19656.606867862847;1027.866377370937;1031.6956497833157;1063.9787204256027;1081.9937458163984;1110.4392281897751;9868.457234852152;10894.509747061402;10963.671089867317;10967.616133435291;10987.39569323695;430735;433634;448361;453517;453950;57013.42986570164;61961.69019154966;93260.53369733108;95164;95205;947.668316089377;959.1942768074712;968.8788901387327;972.5380444289048;983.2085171437062;16479.423220187236;16824.747628785823;17453.65092698164;17681.557961051076;17736.91131544334;40443.595564043986;42269.154616906875;42324.78837605792;43142.78428607837;43916.560834391246;51744.48255517396;58119.41880581309;59573.40426595852;61364.07953880785;61428.385716144054;5544.203719554231;6234.0337247726675;8407.915920840713;8482.533460659723;8761.430507017023;10956.945215273872;12917.354132293536;13353;13490;13626.659333516742;11742.236754610924;11859.288442693465;11968.222065565711;12002.819957700467;12141.514339426678;7491.288327609086;8597.957010214908;11513.769724605294;11620.128490363088;11942.522299107939;12078.396080196131;12113.576024839089;12136.757264854477;12228.266304021787;12277.508899644272;8704.825903481767;8738.475691458532;8834.160754728291;8914;8919.063498332582;11687.824682629938;11849.940750296539;12119.333436661069;12149.331786751813;12171.513139474677 08:44:19 INFO - PROCESS | 9940 | |3;mootools.html;1500.527333889825;1548.4889986304518;1719.5701074731317;1846.1784505894866;1860.8418284445822;7794.49335793173;8442.409031367806;8479.660813567458;9022.18800307973;9035.141661542151;8527.317814574835;8737.21365077143;8745.125487451252;8753.956230218855;8839.24866386358;2240.484688521641;2283.2008796921027;2291.59897018022;2294.736105347881;2299.3331933739278;2323.0475505042937;2336.8247381446376;2370.7036620422446;2394.174009966559;2394.7605239476;2353.246960972481;2356.2813341930705;2357.0218359380838;2361.173589243768;2370.8933098010543;2285.0859656137595;2291.3927809130596;2302.9654555181687;2323.5585238804574;2324.651302304651;2331.0559223514506;2356.905723771047;2357.1278626907983;2363.3737059679197;2369.5260947810507;8789.516576588285;8803.691870784556;8843.911560884373;8854.114588541159;8868;5179.61152913533;5243.318368612094;5330.253764472977;5332.3867755207875;5341.4925582069645;3449.7067749241346;3517.067976986101;3584.6953008994265;3586.5158203642436;3683.4290684943876;1152.4353066997112;1174.847269854922;1189.2448295332526;1194.1879521925086;2147.269928224411;11874.0500759939;12260.325682087481;12288.201266917711;12305.323207223599;12344.444499997522;4520.434945631796;4528.275475923902;4541.43232095988;4601.033782905627;4676.2985552166765;9701;9718.75703107428;9776.217902567778;9778.9022109778;9798.167155791694;5145.897082058413;5207;5212.5569326607665;5217.6347655664495;5225.686458812484;4307.956920430755;4834.081524510332;4904.2643603459055;4979.427365852901;4982.427020892571;3819.828107735103;3828.9617103829164;3914.725969182187;3948.072203032285;3963.207358528306;1154.740183458732;1158.206628459508;1163.0811658789462;1167.7781221567875;1171.0924033873816;897.8922529296526;1010.4190090697878;1028.9022542858415;1033.8862725100232;1039.8648175737258;5922.822315330547;6095.830168312541;6116.021436570128;6144.354842741448;6201.875962480725;476.2094922428821;478.2706372781536;490.3747721654847;492.5443964332978;492.73638603347035;4349.804258808361;4361.890952726208;4387.583179597933;4389.912201755947;4392.3411488277015;10741.946290268499;11057;11086.501107450184;11103.611373601885;11162.330260184415;10362.585496580203;10783.245172837984;10796.460176991277;10895.673129806119;10906.672799816019;7931.325837303893;7979.4015448841565;8039.397045221632;8043.19568043191;8051.63767630458;6081.452669259611;6386.329435409215;6423.389777971085;6441.806745797634;6446.967765161145;10122.949385253027;10159.288849780445;10223.948880255552;10262.179025678077;10307.175425965755;10160.136388406772;10359.94820025895;10399.948000260252;10449.529771160163;10528.842067369149;7002;7652.120006199359;7679.769606911802;7740.148583655906;7886.605669716377;8786.472811631322;8802.119788021402;8819.11808819113;8874.245689116497;8894.599743011451;7602.581857997642;7735.613219339123;7780.688772449265;7845.490043147177;7862.01724784402;7639.923600763921;7841.607919604111;7891.723789667334;7932.770420584819;7934.166912474107;6951.687174077279;6965.059716938351;7003.474739394667;7009.264027277062;7017.982392553154;5157.690538567698;5246.370435547606;5291.491924801413;5385.299911011543;5423.457654234545;5290.81482148123;5458.6724796512335;5508.173773933942;5513.338399392099;5590.5248053915875 08:44:19 INFO - PROCESS | 9940 | |4;prototype.html;341.155639791516;343.1815120936566;346.71686941490293;349.79886565225;353.506857933183;5605.467480589347;5665.575081868861;5670.3762586115545;5672.347680016799;5708.42915708429;5632.35227948786;5645.435456454353;5654.886902261952;5665.915011274834;5666.858328541788;4201.306784380581;4204.348326009458;4315.755806980368;4342.869713908588;4348.5216626171095;4319.37369081483;4336.891577710567;4340.696151269412;4343.5004974427875;4396.56034396561;4348.97825510872;4360.7819609019425;4380.715253508528;4383.75889326087;4403.713758605681;4289.6997210195295;4331.566843315691;4333.71830830995;4338.978305108486;4348.043430445297;3835.328817456934;3849.788261645608;3854.5738076911443;3858.2283543291455;3893.968098453912;5424.701641409721;5433.755481003325;5439.265699130646;5483.259759932438;5492.642978206404;4894.730789806559;4996.375453068366;5013.997200559903;5035.521625445577;5082.567981721558;5821.62159459638;5822.767089316422;5891.764329426818;5933.465988061095;5945.64326140433;4265.808038638269;4274.829006839754;4281.507626622916;4309.4397728295435;4317.287647538153;6006.429389208019;6030.939690603125;6071.423214794588;6079.665618391031;6119.143319935212;4305.354196870495;4326.956730432718;4334.913301733947;4349.826006959686;4360.978195109004;4442.511323754449;4452.799624016927;4453.376527286183;4454.799534020977;4467.843625473093;4672.182368085571;4853.150698627796;4946.159152944008;4959.628027897922;5045.915128247444;5901.262342207224;5960.4635582797755;5968.045112781934;5978.282606087298;5992.640441573432;1481.5036962617644;1494.9327280272414;1503.225838693074;1507.4723846653583;1508.3137172586446;938.5776400619612;943.8489841625307;989.6882482018285;996.2080146283577;1015.5024038221366;5693.686847223443;5695.943040569624;5707.400722924033;5746;5749.88500229993;5842.912356314659;5904.468597826216;5933.300348341494;5988.461038506555;6008.45501154321;5418.431064738224;5641.605087643826;5730.570207234474;5772.422757724278;5778.422157784188;3242.5298331741765;3264.183954011497;3272.3946069977133;3272.754543409254;3294.950575741366;6195.2255968004;6276.246850377893;6310.873782524323;6374.075759014917;6380.872382552323;6099.645195142653;6167.352427994996;6231.3145553989025;6238.469730072995;6268.592541484789;6043.184170137063;6278.46633036197;6348.587341822767;6348.841278968062;6362.522810789209;6004.078694817616;6042.848928776816;6056.6971651418135;6084.178635884276;6125.754969801336;6066.18106555627;6086.2087928569;6088.056351265561;6090.878182436238;6112.205413296243;6121.908171377344;6273.435390814849;6291.4023167800815;6321.431071203614;6348.143000694847;4304.268274393298;4318.460192475941;4323.54602766705;4326.3943047973935;4342.9348559771;5961.642301461926;6130.233720784902;6139.171211886517;6144.78493252734;6187.412195841388;5951.970240148771;5961.493273071837;5968.641881487125;5983.252093488314;5983.730732117152;5914.497267732291;5947.405259474018;5957.255343082114;6008.579399441997;6023.765128148807;5630;5753.8561535961935;5796.246487956539;5814;5838.474537291664;5921.911171332519;5944.702764861826;5947.375525569752;5978.372270911492;5988.191594134736;5569.721513924369;5800.505782513391;5835.416458354131;5859.882802344015;5863.325717542537 08:44:19 INFO - PROCESS | 9940 | |5;yui.html;746.511035271897;751.9172890981991;811.5982588618634;814.3892080939296;828.184238525053;14622.634434139152;15147;15200;15609.687806243868;15630.374785008615;14649.414023439049;14696.338664760086;14715.26423678817;14791.852081479183;14808.185549794756;654.8461111638785;784.8077221080844;785.8035491127218;792.0574516325582;797.637075130817;798.4331124901327;805.0621026504145;805.9274665280124;808.720991258015;809.6437567470324;862.4523427623442;864.4899509289518;867.0938868882033;868.4008034456236;870.2298465857698;864.8918885139358;864.9783755406133;867.1068799136899;867.635593050917;870.0081906626451;628.0861346740527;629.2449061126666;630.4200135875006;630.7445484578753;631.1479502671402;14572.125672459686;14604.70790584193;14605.342759575844;14667.706645867129;14671.413143474248;14109.223992680398;15129.243537823175;15237.238138093162;15558.455454059054;15648.217589120499;12323.5070597176;12447.253164810141;12542.623721288375;12691.428885700165;12736;3839.827207775657;3910.7458015228917;3963.1083006323347;4014.3175660137845;4034.737742046787;72530.27469725288;74803;75761;76337.23662763412;76509.61745191294;11400;11416.143789215843;11439.656810295704;11588.36264005471;11788.23376480526;20682.379528614165;20703.689444658343;20723.8963805183;20806.1274485294;20916.895415522824;8421.115782842835;8429.662813487392;8458.957705211435;8821.426607270507;8848.690295839615;4232.777841512712;4684.4378674559275;4707.199776038014;4711.387519622427;4810.230363141951;3485.4249048906645;3594.0475773919934;3599.856005759793;4055.2092341993616;4238.449001629769;711.4951876780675;715.6815217228284;719.8812195987708;724.2684888262787;724.822418507469;606.375433303698;622.7602373086395;640.6540468147241;678.2098854834162;737.5611511150856;10019.248556358156;10118.346125278535;10534.841977370346;10612.097971672494;10639.14886809069;731.2504682700169;749.4079677055174;772.5750837039606;779.2986312318845;797.143071198464;4607.262837945913;4617.722936623813;4656.394668693116;4677.064587082597;4752;67811.32188678149;69312.6534367335;70266.64866675736;72477.6376118116;110866;90767.54616226877;94609;94710;95031;96205.5189724047;83427.5828620853;85503;87195;87360.6895896562;88658;9312.075524308186;9549.379290346105;9607.279454041114;9658.951705241428;9848.779757448949;50190.74904625453;50817.745911270205;51271;51410.228846566584;51465.22802157896;67409.3259067403;72147.27852721406;72173.27826721876;73690.63154684192;74452;11601.941990289995;12025;12088.15382923187;12150.57472988441;12207;13360.198388096745;13531.864681353061;13568.321583920962;13731.794023089862;13807.309634518435;12040.578579749666;12307.138500305251;12490;12610.180338277982;12862.807057893951;12839.486420543073;12917;13413.731725365244;13659.658508537366;13741.24423156736;12834.55079072228;12934.676633084247;13118.934405327913;13567.118137321437;13609.591712248648;10555.366677999345;10686.89313106859;10838.078763305208;10870.728231794268;10974.615888443866;10701.304415212986;10983.83524247121;11031.558737650405;11114.27757195812;11147.609833655782 08:44:19 INFO - PROCESS | 9940 | __end_tp_report 08:44:19 INFO - PROCESS | 9940 | __start_cc_report 08:44:19 INFO - PROCESS | 9940 | _x_x_mozilla_cycle_collect,337 08:44:19 INFO - PROCESS | 9940 | __end_cc_report 08:44:19 INFO - PROCESS | 9940 | __startTimestamp1465055059202__endTimestamp 08:44:19 INFO - PROCESS | 9940 | 08:44:19 INFO - PROCESS | 9940 | ------- Summary: start ------- 08:44:19 INFO - PROCESS | 9940 | Number of tests: 6 08:44:19 INFO - PROCESS | 9940 | 08:44:19 INFO - PROCESS | 9940 | [#0] dojo.html Cycles:165 Average:5502.72 Median:5751.05 stddev:732.73 (12.7%) stddev-sans-first:711.32 08:44:19 INFO - PROCESS | 9940 | Values: 3148.6 3149.0 3172.0 3173.2 3182.0 5477.8 5491.8 5498.5 5525.1 5539.9 5339.3 5490.0 5500.1 5510.1 5545.8 4957.0 4978.9 5068.5 5101.9 5167.3 881.7 4941.8 5032.7 5111.9 5117.2 5060.3 5070.6 5095.5 5099.3 5100.3 5089.0 5089.4 5089.7 5090.7 5133.7 4877.0 5007.5 5049.6 5057.3 5090.3 5548.3 5559.7 5561.7 5579.0 5617.7 5794.5 6007.4 6010.0 6019.8 6033.5 5979.4 6033.4 6048.9 6052.3 6091.8 5583.4 5646.2 5650.9 5654.7 5655.5 6006.8 6043.0 6150.8 6204.6 6216.3 5751.1 5800.4 5847.9 5850.2 5880.5 5917.8 5927.9 5928.5 5930.8 5938.9 5756.1 5766.6 5852.2 5898.6 5919.1 5842.2 5931.6 5969.4 5970.2 6031.1 4506.7 4507.5 4525.6 4538.3 4563.3 3965.1 4044.1 4051.0 4057.4 4096.0 5613.9 5655.0 5677.2 5710.8 5712.3 6018.9 6035.3 6053.7 6061.8 6062.4 5596.7 5605.7 5614.1 5704.0 5737.0 5138.0 5157.5 5161.4 5167.8 5198.1 6173.2 6211.3 6211.5 6225.2 6230.8 5863.8 5875.5 5891.3 5923.1 6017.0 6101.6 6112.9 6119.6 6122.7 6126.9 5701.8 5778.4 5794.2 5824.2 5833.6 5779.0 5891.9 5925.0 5932.3 5963.7 5811.0 5819.3 5826.3 5850.6 5871.4 5680.8 5845.2 5846.2 5853.0 5861.9 5626.4 5675.1 5712.7 5716.1 5730.4 5878.7 5927.3 5941.4 5945.1 5976.1 5528.5 5808.6 5825.8 5827.2 5833.8 08:44:19 INFO - PROCESS | 9940 | 08:44:19 INFO - PROCESS | 9940 | [#1] ext.html Cycles:180 Average:60881.14 Median:23198.72 stddev:123992.09 (534.5%) stddev-sans-first:124257.31 08:44:19 INFO - PROCESS | 9940 | Values: 594.9 610.7 631.8 641.9 663.1 44175.8 45657.3 45667.3 45719.3 47713.0 46173.0 46801.5 46902.8 47022.0 47174.3 8795.9 8996.6 9007.1 9010.0 9045.7 8844.7 8874.1 8936.3 8940.2 8940.7 8918.8 9008.8 9010.6 9012.1 9013.7 8909.8 8938.5 8972.5 8988.8 8996.1 8907.5 8991.7 8996.4 8997.6 9004.4 42888.0 43006.1 43006.4 43250.9 43317.0 3547.0 3718.7 3890.0 3987.6 4087.0 32815.2 33156.3 33226.2 33854.8 34079.7 4106.5 4134.6 4181.1 4221.9 4347.8 343898.0 344654.0 346664.0 348214.0 349450.0 34622.5 35650.5 58798.7 59448.7 60084.7 36823.4 37095.1 37294.6 37387.3 37400.7 15183.4 15408.5 15436.5 15438.3 15465.1 12786.7 12849.3 12882.4 12891.9 13018.2 8331.9 8385.6 8417.5 8426.2 8447.4 3225.2 3287.6 3295.0 3302.1 3336.0 1017.0 1026.7 1066.1 1086.9 1183.4 32579.5 32644.5 32771.8 32878.7 33700.0 1117.8 1150.4 1160.3 1166.7 1177.4 17210.3 17334.9 17404.3 17481.0 17595.7 570258.0 574647.0 576776.0 577694.0 579475.0 59648.4 59879.4 59991.0 60110.4 60217.1 1347.6 1367.7 1368.3 1376.3 1377.8 31460.8 31594.5 31624.5 32182.7 32722.2 53235.7 53467.0 53725.7 53897.5 53909.0 443552.0 447133.0 447916.0 448268.0 449856.0 28294.2 28306.3 28609.6 28736.6 28808.4 48809.5 49038.8 49834.3 50029.7 50422.7 41359.6 42662.0 43032.6 43082.6 43155.8 42085.0 42293.2 42322.6 42375.6 42567.4 39375.6 41914.6 42075.4 42175.6 42978.6 36321.8 37220.3 37602.0 39781.4 41003.2 29494.0 29622.3 29991.7 29992.9 30066.7 08:44:19 INFO - PROCESS | 9940 | 08:44:19 INFO - PROCESS | 9940 | [#2] jquery.html Cycles:180 Average:27227.81 Median:394.73 stddev:73352.48 (18583.0%) stddev-sans-first:73530.57 08:44:19 INFO - PROCESS | 9940 | Values: 385.8 385.8 391.5 397.9 423.1 17651.1 18954.3 19342.8 19451.4 19921.4 18478.3 19040.0 19421.0 19454.5 19564.4 5469.8 5584.6 5695.1 5714.7 5791.4 5674.4 5687.3 5703.1 5705.6 5727.9 5425.3 5659.7 5664.2 5671.9 5681.5 5610.9 5615.0 5621.8 5628.1 5652.8 4732.1 5012.0 5023.9 5045.5 5050.5 13429.4 13632.9 22019.3 22452.1 22467.3 2178.4 2303.4 2303.5 2363.9 2518.5 9629.1 9938.0 10021.5 10136.6 10381.6 1721.8 1735.5 1830.7 1838.9 1895.9 76602.2 79977.2 80855.6 82463.0 83852.6 10986.3 11159.9 11290.3 11392.8 11483.3 15455.0 15503.3 15509.8 15574.1 15577.5 7903.4 8044.2 8153.1 8201.7 8275.2 7488.3 7529.9 7654.5 7674.0 7963.7 4729.3 4759.0 4776.4 4782.2 4878.4 1977.0 1993.4 1996.5 2009.5 2074.1 892.4 948.5 1007.3 1065.7 1066.1 17756.9 18953.8 19021.8 19469.1 19656.6 1027.9 1031.7 1064.0 1082.0 1110.4 9868.5 10894.5 10963.7 10967.6 10987.4 430735.0 433634.0 448361.0 453517.0 453950.0 57013.4 61961.7 93260.5 95164.0 95205.0 947.7 959.2 968.9 972.5 983.2 16479.4 16824.7 17453.7 17681.6 17736.9 40443.6 42269.2 42324.8 43142.8 43916.6 51744.5 58119.4 59573.4 61364.1 61428.4 5544.2 6234.0 8407.9 8482.5 8761.4 10956.9 12917.4 13353.0 13490.0 13626.7 11742.2 11859.3 11968.2 12002.8 12141.5 7491.3 8598.0 11513.8 11620.1 11942.5 12078.4 12113.6 12136.8 12228.3 12277.5 8704.8 8738.5 8834.2 8914.0 8919.1 11687.8 11849.9 12119.3 12149.3 12171.5 08:44:19 INFO - PROCESS | 9940 | 08:44:19 INFO - PROCESS | 9940 | [#3] mootools.html Cycles:180 Average:5827.70 Median:477.24 stddev:3282.61 (687.8%) stddev-sans-first:3275.71 08:44:19 INFO - PROCESS | 9940 | Values: 1500.5 1548.5 1719.6 1846.2 1860.8 7794.5 8442.4 8479.7 9022.2 9035.1 8527.3 8737.2 8745.1 8754.0 8839.2 2240.5 2283.2 2291.6 2294.7 2299.3 2323.0 2336.8 2370.7 2394.2 2394.8 2353.2 2356.3 2357.0 2361.2 2370.9 2285.1 2291.4 2303.0 2323.6 2324.7 2331.1 2356.9 2357.1 2363.4 2369.5 8789.5 8803.7 8843.9 8854.1 8868.0 5179.6 5243.3 5330.3 5332.4 5341.5 3449.7 3517.1 3584.7 3586.5 3683.4 1152.4 1174.8 1189.2 1194.2 2147.3 11874.1 12260.3 12288.2 12305.3 12344.4 4520.4 4528.3 4541.4 4601.0 4676.3 9701.0 9718.8 9776.2 9778.9 9798.2 5145.9 5207.0 5212.6 5217.6 5225.7 4308.0 4834.1 4904.3 4979.4 4982.4 3819.8 3829.0 3914.7 3948.1 3963.2 1154.7 1158.2 1163.1 1167.8 1171.1 897.9 1010.4 1028.9 1033.9 1039.9 5922.8 6095.8 6116.0 6144.4 6201.9 476.2 478.3 490.4 492.5 492.7 4349.8 4361.9 4387.6 4389.9 4392.3 10741.9 11057.0 11086.5 11103.6 11162.3 10362.6 10783.2 10796.5 10895.7 10906.7 7931.3 7979.4 8039.4 8043.2 8051.6 6081.5 6386.3 6423.4 6441.8 6447.0 10122.9 10159.3 10223.9 10262.2 10307.2 10160.1 10359.9 10399.9 10449.5 10528.8 7002.0 7652.1 7679.8 7740.1 7886.6 8786.5 8802.1 8819.1 8874.2 8894.6 7602.6 7735.6 7780.7 7845.5 7862.0 7639.9 7841.6 7891.7 7932.8 7934.2 6951.7 6965.1 7003.5 7009.3 7018.0 5157.7 5246.4 5291.5 5385.3 5423.5 5290.8 5458.7 5508.2 5513.3 5590.5 08:44:19 INFO - PROCESS | 9940 | 08:44:19 INFO - PROCESS | 9940 | [#4] prototype.html Cycles:180 Average:4982.09 Median:5701.67 stddev:1473.06 (25.8%) stddev-sans-first:1435.42 08:44:19 INFO - PROCESS | 9940 | Values: 341.2 343.2 346.7 349.8 353.5 5605.5 5665.6 5670.4 5672.3 5708.4 5632.4 5645.4 5654.9 5665.9 5666.9 4201.3 4204.3 4315.8 4342.9 4348.5 4319.4 4336.9 4340.7 4343.5 4396.6 4349.0 4360.8 4380.7 4383.8 4403.7 4289.7 4331.6 4333.7 4339.0 4348.0 3835.3 3849.8 3854.6 3858.2 3894.0 5424.7 5433.8 5439.3 5483.3 5492.6 4894.7 4996.4 5014.0 5035.5 5082.6 5821.6 5822.8 5891.8 5933.5 5945.6 4265.8 4274.8 4281.5 4309.4 4317.3 6006.4 6030.9 6071.4 6079.7 6119.1 4305.4 4327.0 4334.9 4349.8 4361.0 4442.5 4452.8 4453.4 4454.8 4467.8 4672.2 4853.2 4946.2 4959.6 5045.9 5901.3 5960.5 5968.0 5978.3 5992.6 1481.5 1494.9 1503.2 1507.5 1508.3 938.6 943.8 989.7 996.2 1015.5 5693.7 5695.9 5707.4 5746.0 5749.9 5842.9 5904.5 5933.3 5988.5 6008.5 5418.4 5641.6 5730.6 5772.4 5778.4 3242.5 3264.2 3272.4 3272.8 3295.0 6195.2 6276.2 6310.9 6374.1 6380.9 6099.6 6167.4 6231.3 6238.5 6268.6 6043.2 6278.5 6348.6 6348.8 6362.5 6004.1 6042.8 6056.7 6084.2 6125.8 6066.2 6086.2 6088.1 6090.9 6112.2 6121.9 6273.4 6291.4 6321.4 6348.1 4304.3 4318.5 4323.5 4326.4 4342.9 5961.6 6130.2 6139.2 6144.8 6187.4 5952.0 5961.5 5968.6 5983.3 5983.7 5914.5 5947.4 5957.3 6008.6 6023.8 5630.0 5753.9 5796.2 5814.0 5838.5 5921.9 5944.7 5947.4 5978.4 5988.2 5569.7 5800.5 5835.4 5859.9 5863.3 08:44:19 INFO - PROCESS | 9940 | 08:44:19 INFO - PROCESS | 9940 | [#5] yui.html Cycles:180 Average:19457.61 Median:4680.75 stddev:26739.43 (571.3%) stddev-sans-first:26777.53 08:44:19 INFO - PROCESS | 9940 | Values: 746.5 751.9 811.6 814.4 828.2 14622.6 15147.0 15200.0 15609.7 15630.4 14649.4 14696.3 14715.3 14791.9 14808.2 654.8 784.8 785.8 792.1 797.6 798.4 805.1 805.9 808.7 809.6 862.5 864.5 867.1 868.4 870.2 864.9 865.0 867.1 867.6 870.0 628.1 629.2 630.4 630.7 631.1 14572.1 14604.7 14605.3 14667.7 14671.4 14109.2 15129.2 15237.2 15558.5 15648.2 12323.5 12447.3 12542.6 12691.4 12736.0 3839.8 3910.7 3963.1 4014.3 4034.7 72530.3 74803.0 75761.0 76337.2 76509.6 11400.0 11416.1 11439.7 11588.4 11788.2 20682.4 20703.7 20723.9 20806.1 20916.9 8421.1 8429.7 8459.0 8821.4 8848.7 4232.8 4684.4 4707.2 4711.4 4810.2 3485.4 3594.0 3599.9 4055.2 4238.4 711.5 715.7 719.9 724.3 724.8 606.4 622.8 640.7 678.2 737.6 10019.2 10118.3 10534.8 10612.1 10639.1 731.3 749.4 772.6 779.3 797.1 4607.3 4617.7 4656.4 4677.1 4752.0 67811.3 69312.7 70266.6 72477.6 110866.0 90767.5 94609.0 94710.0 95031.0 96205.5 83427.6 85503.0 87195.0 87360.7 88658.0 9312.1 9549.4 9607.3 9659.0 9848.8 50190.7 50817.7 51271.0 51410.2 51465.2 67409.3 72147.3 72173.3 73690.6 74452.0 11601.9 12025.0 12088.2 12150.6 12207.0 13360.2 13531.9 13568.3 13731.8 13807.3 12040.6 12307.1 12490.0 12610.2 12862.8 12839.5 12917.0 13413.7 13659.7 13741.2 12834.6 12934.7 13118.9 13567.1 13609.6 10555.4 10686.9 10838.1 10870.7 10974.6 10701.3 10983.8 11031.6 11114.3 11147.6 08:44:19 INFO - PROCESS | 9940 | -------- Summary: end -------- 08:44:19 INFO - PROCESS | 9940 | 08:44:19 INFO - TEST-INFO | 9940: exit 0 08:44:19 INFO - TEST-OK | dromaeo_css | took 1111613ms 08:44:19 INFO - TEST-START | kraken 08:44:19 INFO - operating with platform_type : linux_ 08:44:19 INFO - Initialising browser for kraken test... 08:44:19 INFO - TEST-INFO | started process 10170 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPT8Rnt/profile http://localhost:42770/getInfo.html) 08:44:25 INFO - PROCESS | 10170 | __metrics Screen width/height:1600/1200 08:44:25 INFO - PROCESS | 10170 | colorDepth:24 08:44:25 INFO - PROCESS | 10170 | Browser inner width/height: 1024/697 08:44:25 INFO - PROCESS | 10170 | __metrics 08:44:26 ERROR - PROCESS | 10170 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 08:44:27 INFO - TEST-INFO | 10170: exit 0 08:44:27 INFO - Browser initialized. 08:44:27 INFO - Running cycle 1/1 for kraken test... 08:44:27 INFO - TEST-INFO | started process 10291 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPT8Rnt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:44:39 INFO - PROCESS | 10291 | RSS: Main: 167567360 08:44:39 INFO - PROCESS | 10291 | 08:44:41 INFO - PROCESS | 10291 | Cycle 1(1): loaded http://localhost:42770/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42770/tests/kraken/driver.html?testName=audio-beat-detection) 08:44:42 INFO - PROCESS | 10291 | RSS: Main: 172769280 08:44:42 INFO - PROCESS | 10291 | 08:44:45 INFO - PROCESS | 10291 | Cycle 1(1): loaded http://localhost:42770/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42770/tests/kraken/driver.html?testName=audio-dft) 08:44:45 INFO - PROCESS | 10291 | RSS: Main: 171970560 08:44:45 INFO - PROCESS | 10291 | 08:44:48 INFO - PROCESS | 10291 | Cycle 1(1): loaded http://localhost:42770/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42770/tests/kraken/driver.html?testName=audio-fft) 08:44:49 INFO - PROCESS | 10291 | RSS: Main: 167149568 08:44:49 INFO - PROCESS | 10291 | 08:44:51 INFO - PROCESS | 10291 | Cycle 1(1): loaded http://localhost:42770/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42770/tests/kraken/driver.html?testName=audio-oscillator) 08:44:51 INFO - PROCESS | 10291 | RSS: Main: 167907328 08:44:51 INFO - PROCESS | 10291 | 08:44:54 INFO - PROCESS | 10291 | Cycle 1(1): loaded http://localhost:42770/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42770/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:44:54 INFO - PROCESS | 10291 | RSS: Main: 167669760 08:44:54 INFO - PROCESS | 10291 | 08:44:57 INFO - PROCESS | 10291 | Cycle 1(1): loaded http://localhost:42770/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42770/tests/kraken/driver.html?testName=imaging-darkroom) 08:44:58 INFO - PROCESS | 10291 | RSS: Main: 167833600 08:44:58 INFO - PROCESS | 10291 | 08:45:01 INFO - PROCESS | 10291 | Cycle 1(1): loaded http://localhost:42770/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42770/tests/kraken/driver.html?testName=imaging-desaturate) 08:45:02 INFO - PROCESS | 10291 | RSS: Main: 168660992 08:45:02 INFO - PROCESS | 10291 | 08:45:05 INFO - PROCESS | 10291 | Cycle 1(1): loaded http://localhost:42770/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42770/tests/kraken/driver.html?testName=json-parse-financial) 08:45:05 INFO - PROCESS | 10291 | RSS: Main: 168435712 08:45:05 INFO - PROCESS | 10291 | 08:45:07 INFO - PROCESS | 10291 | Cycle 1(1): loaded http://localhost:42770/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42770/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:45:08 INFO - PROCESS | 10291 | RSS: Main: 168263680 08:45:08 INFO - PROCESS | 10291 | 08:45:09 INFO - PROCESS | 10291 | Cycle 1(1): loaded http://localhost:42770/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42770/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:45:10 INFO - PROCESS | 10291 | RSS: Main: 168259584 08:45:10 INFO - PROCESS | 10291 | 08:45:12 INFO - PROCESS | 10291 | Cycle 1(1): loaded http://localhost:42770/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42770/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:45:13 INFO - PROCESS | 10291 | RSS: Main: 168665088 08:45:13 INFO - PROCESS | 10291 | 08:45:15 INFO - PROCESS | 10291 | Cycle 1(1): loaded http://localhost:42770/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42770/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:45:16 INFO - PROCESS | 10291 | RSS: Main: 168939520 08:45:16 INFO - PROCESS | 10291 | 08:45:19 INFO - PROCESS | 10291 | Cycle 1(1): loaded http://localhost:42770/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42770/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:45:19 INFO - PROCESS | 10291 | RSS: Main: 168902656 08:45:19 INFO - PROCESS | 10291 | 08:45:21 INFO - PROCESS | 10291 | Cycle 1(1): loaded http://localhost:42770/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42770/tests/kraken/driver.html?testName=ai-astar) 08:45:21 INFO - PROCESS | 10291 | RSS: Main: 169406464 08:45:21 INFO - PROCESS | 10291 | 08:45:21 INFO - PROCESS | 10291 | __start_tp_report 08:45:21 INFO - PROCESS | 10291 | _x_x_mozilla_page_load 08:45:21 INFO - PROCESS | 10291 | _x_x_mozilla_page_load_details 08:45:21 INFO - PROCESS | 10291 | |i|pagename|runs| 08:45:21 INFO - PROCESS | 10291 | |0;ai-astar;112;108;111;110;111;112;110;112;111;112 08:45:21 INFO - PROCESS | 10291 | |1;audio-beat-detection;154;126;157;177;128;149;160;126;189;130 08:45:21 INFO - PROCESS | 10291 | |2;audio-dft;162;162;162;162;162;166;177;167;163;164 08:45:21 INFO - PROCESS | 10291 | |3;audio-fft;75;75;76;151;76;75;76;76;184;77 08:45:21 INFO - PROCESS | 10291 | |4;audio-oscillator;86;85;158;85;87;85;153;85;85;140 08:45:21 INFO - PROCESS | 10291 | |5;imaging-gaussian-blur;117;118;118;117;118;117;117;117;118;117 08:45:21 INFO - PROCESS | 10291 | |6;imaging-darkroom;146;147;147;149;147;148;146;147;147;147 08:45:21 INFO - PROCESS | 10291 | |7;imaging-desaturate;95;96;96;96;96;96;95;97;96;96 08:45:21 INFO - PROCESS | 10291 | |8;json-parse-financial;56;57;56;53;57;65;53;53;56;54 08:45:21 INFO - PROCESS | 10291 | |9;json-stringify-tinderbox;62;62;62;62;63;62;63;62;62;63 08:45:21 INFO - PROCESS | 10291 | |10;stanford-crypto-aes;81;79;81;85;85;83;82;82;103;81 08:45:21 INFO - PROCESS | 10291 | |11;stanford-crypto-ccm;123;129;126;123;122;126;132;135;134;132 08:45:21 INFO - PROCESS | 10291 | |12;stanford-crypto-pbkdf2;165;165;163;161;166;162;165;162;162;163 08:45:21 INFO - PROCESS | 10291 | |13;stanford-crypto-sha256-iterative;72;63;64;65;65;65;73;64;66;64 08:45:21 INFO - PROCESS | 10291 | __end_tp_report 08:45:21 INFO - PROCESS | 10291 | __start_cc_report 08:45:21 INFO - PROCESS | 10291 | _x_x_mozilla_cycle_collect,874 08:45:21 INFO - PROCESS | 10291 | __end_cc_report 08:45:21 INFO - PROCESS | 10291 | __startTimestamp1465055121831__endTimestamp 08:45:21 INFO - PROCESS | 10291 | 08:45:21 INFO - PROCESS | 10291 | ------- Summary: start ------- 08:45:21 INFO - PROCESS | 10291 | Number of tests: 14 08:45:21 INFO - PROCESS | 10291 | 08:45:21 INFO - PROCESS | 10291 | [#0] ai-astar Cycles:10 Average:110.90 Median:111.50 stddev:1.29 (1.2%) stddev-sans-first:1.30 08:45:21 INFO - PROCESS | 10291 | Values: 112.0 108.0 111.0 110.0 111.0 112.0 110.0 112.0 111.0 112.0 08:45:21 INFO - PROCESS | 10291 | 08:45:21 INFO - PROCESS | 10291 | [#1] audio-beat-detection Cycles:10 Average:149.60 Median:155.50 stddev:22.24 (14.3%) stddev-sans-first:23.53 08:45:21 INFO - PROCESS | 10291 | Values: 154.0 126.0 157.0 177.0 128.0 149.0 160.0 126.0 189.0 130.0 08:45:21 INFO - PROCESS | 10291 | 08:45:21 INFO - PROCESS | 10291 | [#2] audio-dft Cycles:10 Average:164.70 Median:163.50 stddev:4.69 (2.9%) stddev-sans-first:4.87 08:45:21 INFO - PROCESS | 10291 | Values: 162.0 162.0 162.0 162.0 162.0 166.0 177.0 167.0 163.0 164.0 08:45:21 INFO - PROCESS | 10291 | 08:45:21 INFO - PROCESS | 10291 | [#3] audio-fft Cycles:10 Average:94.10 Median:76.00 stddev:39.46 (51.9%) stddev-sans-first:41.25 08:45:21 INFO - PROCESS | 10291 | Values: 75.0 75.0 76.0 151.0 76.0 75.0 76.0 76.0 184.0 77.0 08:45:21 INFO - PROCESS | 10291 | 08:45:21 INFO - PROCESS | 10291 | [#4] audio-oscillator Cycles:10 Average:104.90 Median:85.00 stddev:31.66 (37.3%) stddev-sans-first:32.84 08:45:21 INFO - PROCESS | 10291 | Values: 86.0 85.0 158.0 85.0 87.0 85.0 153.0 85.0 85.0 140.0 08:45:21 INFO - PROCESS | 10291 | 08:45:21 INFO - PROCESS | 10291 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 08:45:21 INFO - PROCESS | 10291 | Values: 117.0 118.0 118.0 117.0 118.0 117.0 117.0 117.0 118.0 117.0 08:45:21 INFO - PROCESS | 10291 | 08:45:21 INFO - PROCESS | 10291 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.88 (0.6%) stddev-sans-first:0.83 08:45:21 INFO - PROCESS | 10291 | Values: 146.0 147.0 147.0 149.0 147.0 148.0 146.0 147.0 147.0 147.0 08:45:21 INFO - PROCESS | 10291 | 08:45:21 INFO - PROCESS | 10291 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.50 08:45:21 INFO - PROCESS | 10291 | Values: 95.0 96.0 96.0 96.0 96.0 96.0 95.0 97.0 96.0 96.0 08:45:21 INFO - PROCESS | 10291 | 08:45:21 INFO - PROCESS | 10291 | [#8] json-parse-financial Cycles:10 Average:56.00 Median:56.00 stddev:3.56 (6.4%) stddev-sans-first:3.77 08:45:21 INFO - PROCESS | 10291 | Values: 56.0 57.0 56.0 53.0 57.0 65.0 53.0 53.0 56.0 54.0 08:45:21 INFO - PROCESS | 10291 | 08:45:21 INFO - PROCESS | 10291 | [#9] json-stringify-tinderbox Cycles:10 Average:62.30 Median:62.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 08:45:21 INFO - PROCESS | 10291 | Values: 62.0 62.0 62.0 62.0 63.0 62.0 63.0 62.0 62.0 63.0 08:45:21 INFO - PROCESS | 10291 | 08:45:21 INFO - PROCESS | 10291 | [#10] stanford-crypto-aes Cycles:10 Average:84.20 Median:82.00 stddev:6.86 (8.4%) stddev-sans-first:7.18 08:45:21 INFO - PROCESS | 10291 | Values: 81.0 79.0 81.0 85.0 85.0 83.0 82.0 82.0 103.0 81.0 08:45:21 INFO - PROCESS | 10291 | 08:45:21 INFO - PROCESS | 10291 | [#11] stanford-crypto-ccm Cycles:10 Average:128.20 Median:130.50 stddev:4.85 (3.7%) stddev-sans-first:4.76 08:45:21 INFO - PROCESS | 10291 | Values: 123.0 129.0 126.0 123.0 122.0 126.0 132.0 135.0 134.0 132.0 08:45:21 INFO - PROCESS | 10291 | 08:45:21 INFO - PROCESS | 10291 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.40 Median:164.00 stddev:1.71 (1.0%) stddev-sans-first:1.72 08:45:21 INFO - PROCESS | 10291 | Values: 165.0 165.0 163.0 161.0 166.0 162.0 165.0 162.0 162.0 163.0 08:45:21 INFO - PROCESS | 10291 | 08:45:21 INFO - PROCESS | 10291 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.10 Median:65.00 stddev:3.48 (5.4%) stddev-sans-first:2.96 08:45:21 INFO - PROCESS | 10291 | Values: 72.0 63.0 64.0 65.0 65.0 65.0 73.0 64.0 66.0 64.0 08:45:21 INFO - PROCESS | 10291 | -------- Summary: end -------- 08:45:21 INFO - PROCESS | 10291 | 08:45:22 INFO - TEST-INFO | 10291: exit 0 08:45:22 INFO - TEST-OK | kraken | took 62888ms 08:45:22 INFO - SUITE-END | took 1174s 08:45:22 INFO - Completed test suite (00:19:34) 08:45:22 INFO - javascript benchmark 08:45:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7270.095467799041, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3148.574942382778, 3149.0238026211878, 3171.9841400792993, 3173.190836336735, 3181.952270715938, 5477.835664930049, 5491.807786727465, 5498.4501549845, 5525.088360420531, 5539.861503462405, 5339.252504649352, 5490.0, 5500.119980803072, 5510.090835012218, 5545.833624991246, 4957.033378491195, 4978.900421991558, 5068.46781087986, 5101.872453188681, 5167.250748641445, 881.7135132390032, 4941.752912354385, 5032.723200223986, 5111.948880511203, 5117.232415137722, 5060.342155519796, 5070.61970352225, 5095.541401273885, 5099.260607211952, 5100.33695619569, 5089.033083714119, 5089.41471730752, 5089.6691715038405, 5090.669106508102, 5133.743312834344, 4877.0, 5007.4992500749995, 5049.596032317406, 5057.317262169634, 5090.338256026693, 5548.334199895998, 5559.6664200148125, 5561.721913904288, 5579.0, 5617.691026993513, 5794.5074668653215, 6007.429294217086, 6010.038393857006, 6019.759209631609, 6033.5173186145, 5979.431953964367, 6033.396660333975, 6048.909266361008, 6052.303985041733, 6091.786787462417, 5583.3858275589655, 5646.209530665669, 5650.858728531778, 5654.727686270598, 5655.4910058094965, 6006.759729610854, 6042.969785151046, 6150.815475535741, 6204.627722336674, 6216.285127210338, 5751.051076572402, 5800.419958004166, 5847.912281315784, 5850.23946886902, 5880.529557635379, 5917.7928772493615, 5927.911081333784, 5928.496077833346, 5930.822075337746, 5938.851528711817, 5756.079027355603, 5766.5675074368755, 5852.15143804146, 5898.616589921641, 5919.112133180058, 5842.211301474246, 5931.584789064724, 5969.403059694083, 5970.194023806731, 6031.09533569968, 4506.662000349987, 4507.504174540798, 4525.570070843265, 4538.2511885538515, 4563.292689633112, 3965.107850733562, 4044.130511939947, 4050.9797451012555, 4057.431959525669, 4096.0, 5613.859653508695, 5654.971725141348, 5677.17680936262, 5710.828675139753, 5712.257406537206, 6018.879622407528, 6035.336113027563, 6053.667048312385, 6061.848453788691, 6062.363451837582, 5596.720163991784, 5605.747741351649, 5614.129809879475, 5704.030314846486, 5737.0, 5138.023775482647, 5157.535821776059, 5161.380634323905, 5167.767450464738, 5198.116320225571, 6173.166622505904, 6211.254649442096, 6211.472024877936, 6225.221847269091, 6230.7507699691505, 5863.794767183128, 5875.471207591338, 5891.293044834647, 5923.111533270044, 6017.0, 6101.572889897665, 6112.908306375497, 6119.632822030692, 6122.663253521099, 6126.877462450637, 5701.771929122789, 5778.393268706725, 5794.159846822272, 5824.242848429677, 5833.591648584558, 5779.0464573344925, 5891.8510890375965, 5924.9703751480965, 5932.2584676915385, 5963.70181490915, 5811.0, 5819.301683797971, 5826.271716035496, 5850.561207909509, 5871.383504731942, 5680.801171958961, 5845.18167456565, 5846.1815345852465, 5852.970735146297, 5861.853453663693, 5626.38109807929, 5675.148727690879, 5712.65724056558, 5716.056850619601, 5730.398308177748, 5878.735456904535, 5927.288725352985, 5941.37615550361, 5945.078512830518, 5976.133460648269, 5528.530074943675, 5808.6224395414165, 5825.825225243249, 5827.184194212899, 5833.795817146549], "value": 5453.934256198584, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [594.8958932186869, 610.7312782375755, 631.8072987738741, 641.9101325814383, 663.1114306828848, 44175.77912110439, 45657.31514027288, 45667.31499027513, 45719.314210286786, 47713.0, 46173.0, 46801.53198468014, 46902.765486172604, 47022.0, 47174.29238561416, 8795.912040879606, 8996.550172491348, 9007.054259302777, 9010.0, 9045.683401080963, 8844.690435834747, 8874.068222836606, 8936.329775266848, 8940.15068568485, 8940.687075952343, 8918.777030574223, 9008.774780630503, 9010.59452324647, 9012.143846334588, 9013.729588112366, 8909.77725556863, 8938.508382038985, 8972.46165230085, 8988.77528061797, 8996.100389961017, 8907.465552066897, 8991.730248092568, 8996.370254082216, 8997.59510822008, 9004.41471304363, 42888.0, 43006.13987720259, 43006.35490467645, 43250.89116533924, 43317.0, 3546.982265088684, 3718.7396882218254, 3890.0, 3987.641112299878, 4086.9591304086875, 32815.179620509436, 33156.3368732624, 33226.169345766306, 33854.83072584646, 34079.65920340789, 4106.527749308808, 4134.607212314825, 4181.080312083506, 4221.852235171754, 4347.7826108694435, 343898.0, 344654.0, 346664.0, 348213.99999999744, 349450.0, 34622.480662790076, 35650.465243021375, 58798.70600647055, 59448.702756486804, 60084.69957650184, 36823.4476482853, 37095.072623184096, 37294.62705372911, 37387.252254955296, 37400.69097581571, 15183.392664293304, 15408.460703875311, 15436.45972390961, 15438.305276262596, 15465.149416782186, 12786.744265114645, 12849.293288869016, 12882.355882205853, 12891.935540322425, 13018.21890686543, 8331.875021874677, 8385.6226469809, 8417.537035462985, 8426.188369500587, 8447.36644751646, 3225.209823593235, 3287.556179915681, 3295.044437113258, 3302.091924720721, 3335.983320083384, 1016.9880968436453, 1026.6509386808373, 1066.0778426661038, 1086.8532748078908, 1183.402381797204, 32579.51130733041, 32644.510332345035, 32771.83614081914, 32878.67121328756, 33700.0, 1117.7987962166726, 1150.4305368842477, 1160.280626011878, 1166.6849950513315, 1177.3877583656451, 17210.31158753661, 17334.913325433543, 17404.303827846743, 17481.0, 17595.73606395905, 570258.0, 574647.0, 576776.0, 577694.0, 579475.0, 59648.403515965154, 59879.40120598825, 59991.0, 60110.39889601048, 60217.09674354888, 1347.5553067487706, 1367.6785955300695, 1368.2679766325168, 1376.2705765944065, 1377.8139951106673, 31460.842695786374, 31594.526082109245, 31624.525632115077, 32182.67817321797, 32722.181945451553, 53235.73382133064, 53467.0, 53725.731371342896, 53897.461025389246, 53909.0, 443552.0, 447133.0, 447916.0, 448268.0, 449856.0, 28294.15117546477, 28306.2923426916, 28609.570856437585, 28736.568951466164, 28808.423831522832, 48809.51190488192, 49038.75480622574, 49834.25248621201, 50029.74985125051, 50422.74788626033, 41359.586404135574, 42662.0, 43032.56967430411, 43082.56917430911, 43155.78422107869, 42085.0, 42293.15413691648, 42322.576774231864, 42375.57624423716, 42567.36148957706, 39375.606243937196, 41914.58085419229, 42075.368869467595, 42175.57824421839, 42978.570214297455, 36321.81839090788, 37220.25559488849, 37602.0, 39781.40327895026, 41003.179936400506, 29494.0, 29622.259443514085, 29991.70008299889, 29992.85003574968, 30066.69933300639], "value": 19328.616504145906, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.812880752835, 385.8167370499015, 391.50865663592185, 397.94826672532577, 423.13046689054, 17651.11744412779, 18954.336598219066, 19342.806571934278, 19451.41645750628, 19921.402357929248, 18478.260869565234, 19040.0, 19421.0, 19454.513637159078, 19564.41306760796, 5469.835904922838, 5584.6090773645865, 5695.060315048033, 5714.657120572758, 5791.449812267828, 5674.404187560309, 5687.345955215141, 5703.0589952657765, 5705.6006079574445, 5727.914081288784, 5425.321834770653, 5659.688717120557, 5664.178694089354, 5671.8582035449235, 5681.460261275193, 5610.859728506779, 5614.9719251403485, 5621.80323688671, 5628.127640215753, 5652.830415087554, 4732.100900828831, 5012.04771093491, 5023.899522009576, 5045.4702256262935, 5050.520200580939, 13429.39567719455, 13632.863671363359, 22019.339419817272, 22452.101915923344, 22467.32598022062, 2178.4118288062136, 2303.4011157099276, 2303.527776805751, 2363.929082127539, 2518.546661600911, 9629.133377996013, 9937.950310248474, 10021.549030293654, 10136.594536218616, 10381.584736610526, 1721.8450339469507, 1735.488031030849, 1830.7253911913187, 1838.944831655039, 1895.8767680100887, 76602.23397766007, 79977.20022799756, 80855.59572202161, 82463.0, 83852.58073709592, 10986.340819550693, 11159.888401116048, 11290.322580645023, 11392.829107563393, 11483.311001339946, 15455.0, 15503.302351394213, 15509.844901551065, 15574.143422111665, 15577.454789082327, 7903.407244456689, 8044.155363686846, 8153.062397824207, 8201.71294004707, 8275.172482751677, 7488.326050655467, 7529.887051694229, 7654.464187506821, 7674.004758762762, 7963.681452741941, 4729.337892695025, 4758.976205118952, 4776.426828780569, 4782.187028205213, 4878.414590249193, 1976.9505762356057, 1993.3820515640198, 1996.4709352021434, 2009.5177157482099, 2074.1184996376783, 892.3575025981283, 948.5209968965628, 1007.3351587951917, 1065.6536625596711, 1066.1311031509294, 17756.9112154441, 18953.810461895482, 19021.80978190228, 19469.12388942501, 19656.606867862847, 1027.866377370937, 1031.6956497833157, 1063.9787204256027, 1081.9937458163984, 1110.4392281897751, 9868.457234852152, 10894.509747061402, 10963.671089867317, 10967.616133435291, 10987.39569323695, 430735.0, 433634.0, 448361.0, 453517.0, 453950.0, 57013.42986570164, 61961.69019154966, 93260.53369733108, 95164.0, 95205.0, 947.668316089377, 959.1942768074712, 968.8788901387327, 972.5380444289048, 983.2085171437062, 16479.423220187236, 16824.747628785823, 17453.65092698164, 17681.557961051076, 17736.91131544334, 40443.595564043986, 42269.154616906875, 42324.78837605792, 43142.78428607837, 43916.560834391246, 51744.48255517396, 58119.41880581309, 59573.40426595852, 61364.07953880785, 61428.385716144054, 5544.203719554231, 6234.0337247726675, 8407.915920840713, 8482.533460659723, 8761.430507017023, 10956.945215273872, 12917.354132293536, 13353.0, 13490.0, 13626.659333516742, 11742.236754610924, 11859.288442693465, 11968.222065565711, 12002.819957700467, 12141.514339426678, 7491.288327609086, 8597.957010214908, 11513.769724605294, 11620.128490363088, 11942.522299107939, 12078.396080196131, 12113.576024839089, 12136.757264854477, 12228.266304021787, 12277.508899644272, 8704.825903481767, 8738.475691458532, 8834.160754728291, 8914.0, 8919.063498332582, 11687.824682629938, 11849.940750296539, 12119.333436661069, 12149.331786751813, 12171.513139474677], "value": 9014.954276079881, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1500.527333889825, 1548.4889986304518, 1719.5701074731317, 1846.1784505894866, 1860.8418284445822, 7794.49335793173, 8442.409031367806, 8479.660813567458, 9022.18800307973, 9035.141661542151, 8527.317814574835, 8737.21365077143, 8745.125487451252, 8753.956230218855, 8839.24866386358, 2240.484688521641, 2283.2008796921027, 2291.59897018022, 2294.736105347881, 2299.3331933739278, 2323.0475505042937, 2336.8247381446376, 2370.7036620422446, 2394.174009966559, 2394.7605239476, 2353.246960972481, 2356.2813341930705, 2357.0218359380838, 2361.173589243768, 2370.8933098010543, 2285.0859656137595, 2291.3927809130596, 2302.9654555181687, 2323.5585238804574, 2324.651302304651, 2331.0559223514506, 2356.905723771047, 2357.1278626907983, 2363.3737059679197, 2369.5260947810507, 8789.516576588285, 8803.691870784556, 8843.911560884373, 8854.114588541159, 8868.0, 5179.61152913533, 5243.318368612094, 5330.253764472977, 5332.3867755207875, 5341.4925582069645, 3449.7067749241346, 3517.067976986101, 3584.6953008994265, 3586.5158203642436, 3683.4290684943876, 1152.4353066997112, 1174.847269854922, 1189.2448295332526, 1194.1879521925086, 2147.269928224411, 11874.0500759939, 12260.325682087481, 12288.201266917711, 12305.323207223599, 12344.444499997522, 4520.434945631796, 4528.275475923902, 4541.43232095988, 4601.033782905627, 4676.2985552166765, 9701.0, 9718.75703107428, 9776.217902567778, 9778.9022109778, 9798.167155791694, 5145.897082058413, 5207.0, 5212.5569326607665, 5217.6347655664495, 5225.686458812484, 4307.956920430755, 4834.081524510332, 4904.2643603459055, 4979.427365852901, 4982.427020892571, 3819.828107735103, 3828.9617103829164, 3914.725969182187, 3948.072203032285, 3963.207358528306, 1154.740183458732, 1158.206628459508, 1163.0811658789462, 1167.7781221567875, 1171.0924033873816, 897.8922529296526, 1010.4190090697878, 1028.9022542858415, 1033.8862725100232, 1039.8648175737258, 5922.822315330547, 6095.830168312541, 6116.021436570128, 6144.354842741448, 6201.875962480725, 476.2094922428821, 478.2706372781536, 490.3747721654847, 492.5443964332978, 492.73638603347035, 4349.804258808361, 4361.890952726208, 4387.583179597933, 4389.912201755947, 4392.3411488277015, 10741.946290268499, 11057.0, 11086.501107450184, 11103.611373601885, 11162.330260184415, 10362.585496580203, 10783.245172837984, 10796.460176991277, 10895.673129806119, 10906.672799816019, 7931.325837303893, 7979.4015448841565, 8039.397045221632, 8043.19568043191, 8051.63767630458, 6081.452669259611, 6386.329435409215, 6423.389777971085, 6441.806745797634, 6446.967765161145, 10122.949385253027, 10159.288849780445, 10223.948880255552, 10262.179025678077, 10307.175425965755, 10160.136388406772, 10359.94820025895, 10399.948000260252, 10449.529771160163, 10528.842067369149, 7002.0, 7652.120006199359, 7679.769606911802, 7740.148583655906, 7886.605669716377, 8786.472811631322, 8802.119788021402, 8819.11808819113, 8874.245689116497, 8894.599743011451, 7602.581857997642, 7735.613219339123, 7780.688772449265, 7845.490043147177, 7862.01724784402, 7639.923600763921, 7841.607919604111, 7891.723789667334, 7932.770420584819, 7934.166912474107, 6951.687174077279, 6965.059716938351, 7003.474739394667, 7009.264027277062, 7017.982392553154, 5157.690538567698, 5246.370435547606, 5291.491924801413, 5385.299911011543, 5423.457654234545, 5290.81482148123, 5458.6724796512335, 5508.173773933942, 5513.338399392099, 5590.5248053915875], "value": 4620.794127902996, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [341.155639791516, 343.1815120936566, 346.71686941490293, 349.79886565225, 353.506857933183, 5605.467480589347, 5665.575081868861, 5670.3762586115545, 5672.347680016799, 5708.42915708429, 5632.35227948786, 5645.435456454353, 5654.886902261952, 5665.915011274834, 5666.858328541788, 4201.306784380581, 4204.348326009458, 4315.755806980368, 4342.869713908588, 4348.5216626171095, 4319.37369081483, 4336.891577710567, 4340.696151269412, 4343.5004974427875, 4396.56034396561, 4348.97825510872, 4360.7819609019425, 4380.715253508528, 4383.75889326087, 4403.713758605681, 4289.6997210195295, 4331.566843315691, 4333.71830830995, 4338.978305108486, 4348.043430445297, 3835.328817456934, 3849.788261645608, 3854.5738076911443, 3858.2283543291455, 3893.968098453912, 5424.701641409721, 5433.755481003325, 5439.265699130646, 5483.259759932438, 5492.642978206404, 4894.730789806559, 4996.375453068366, 5013.997200559903, 5035.521625445577, 5082.567981721558, 5821.62159459638, 5822.767089316422, 5891.764329426818, 5933.465988061095, 5945.64326140433, 4265.808038638269, 4274.829006839754, 4281.507626622916, 4309.4397728295435, 4317.287647538153, 6006.429389208019, 6030.939690603125, 6071.423214794588, 6079.665618391031, 6119.143319935212, 4305.354196870495, 4326.956730432718, 4334.913301733947, 4349.826006959686, 4360.978195109004, 4442.511323754449, 4452.799624016927, 4453.376527286183, 4454.799534020977, 4467.843625473093, 4672.182368085571, 4853.150698627796, 4946.159152944008, 4959.628027897922, 5045.915128247444, 5901.262342207224, 5960.4635582797755, 5968.045112781934, 5978.282606087298, 5992.640441573432, 1481.5036962617644, 1494.9327280272414, 1503.225838693074, 1507.4723846653583, 1508.3137172586446, 938.5776400619612, 943.8489841625307, 989.6882482018285, 996.2080146283577, 1015.5024038221366, 5693.686847223443, 5695.943040569624, 5707.400722924033, 5746.0, 5749.88500229993, 5842.912356314659, 5904.468597826216, 5933.300348341494, 5988.461038506555, 6008.45501154321, 5418.431064738224, 5641.605087643826, 5730.570207234474, 5772.422757724278, 5778.422157784188, 3242.5298331741765, 3264.183954011497, 3272.3946069977133, 3272.754543409254, 3294.950575741366, 6195.2255968004, 6276.246850377893, 6310.873782524323, 6374.075759014917, 6380.872382552323, 6099.645195142653, 6167.352427994996, 6231.3145553989025, 6238.469730072995, 6268.592541484789, 6043.184170137063, 6278.46633036197, 6348.587341822767, 6348.841278968062, 6362.522810789209, 6004.078694817616, 6042.848928776816, 6056.6971651418135, 6084.178635884276, 6125.754969801336, 6066.18106555627, 6086.2087928569, 6088.056351265561, 6090.878182436238, 6112.205413296243, 6121.908171377344, 6273.435390814849, 6291.4023167800815, 6321.431071203614, 6348.143000694847, 4304.268274393298, 4318.460192475941, 4323.54602766705, 4326.3943047973935, 4342.9348559771, 5961.642301461926, 6130.233720784902, 6139.171211886517, 6144.78493252734, 6187.412195841388, 5951.970240148771, 5961.493273071837, 5968.641881487125, 5983.252093488314, 5983.730732117152, 5914.497267732291, 5947.405259474018, 5957.255343082114, 6008.579399441997, 6023.765128148807, 5630.0, 5753.8561535961935, 5796.246487956539, 5814.0, 5838.474537291664, 5921.911171332519, 5944.702764861826, 5947.375525569752, 5978.372270911492, 5988.191594134736, 5569.721513924369, 5800.505782513391, 5835.416458354131, 5859.882802344015, 5863.325717542537], "value": 4507.965050028834, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [746.511035271897, 751.9172890981991, 811.5982588618634, 814.3892080939296, 828.184238525053, 14622.634434139152, 15147.0, 15200.0, 15609.687806243868, 15630.374785008615, 14649.414023439049, 14696.338664760086, 14715.26423678817, 14791.852081479183, 14808.185549794756, 654.8461111638785, 784.8077221080844, 785.8035491127218, 792.0574516325582, 797.637075130817, 798.4331124901327, 805.0621026504145, 805.9274665280124, 808.720991258015, 809.6437567470324, 862.4523427623442, 864.4899509289518, 867.0938868882033, 868.4008034456236, 870.2298465857698, 864.8918885139358, 864.9783755406133, 867.1068799136899, 867.635593050917, 870.0081906626451, 628.0861346740527, 629.2449061126666, 630.4200135875006, 630.7445484578753, 631.1479502671402, 14572.125672459686, 14604.70790584193, 14605.342759575844, 14667.706645867129, 14671.413143474248, 14109.223992680398, 15129.243537823175, 15237.238138093162, 15558.455454059054, 15648.217589120499, 12323.5070597176, 12447.253164810141, 12542.623721288375, 12691.428885700165, 12736.0, 3839.827207775657, 3910.7458015228917, 3963.1083006323347, 4014.3175660137845, 4034.737742046787, 72530.27469725288, 74803.0, 75761.0, 76337.23662763412, 76509.61745191294, 11400.0, 11416.143789215843, 11439.656810295704, 11588.36264005471, 11788.23376480526, 20682.379528614165, 20703.689444658343, 20723.8963805183, 20806.1274485294, 20916.895415522824, 8421.115782842835, 8429.662813487392, 8458.957705211435, 8821.426607270507, 8848.690295839615, 4232.777841512712, 4684.4378674559275, 4707.199776038014, 4711.387519622427, 4810.230363141951, 3485.4249048906645, 3594.0475773919934, 3599.856005759793, 4055.2092341993616, 4238.449001629769, 711.4951876780675, 715.6815217228284, 719.8812195987708, 724.2684888262787, 724.822418507469, 606.375433303698, 622.7602373086395, 640.6540468147241, 678.2098854834162, 737.5611511150856, 10019.248556358156, 10118.346125278535, 10534.841977370346, 10612.097971672494, 10639.14886809069, 731.2504682700169, 749.4079677055174, 772.5750837039606, 779.2986312318845, 797.143071198464, 4607.262837945913, 4617.722936623813, 4656.394668693116, 4677.064587082597, 4752.0, 67811.32188678149, 69312.6534367335, 70266.64866675736, 72477.6376118116, 110866.0, 90767.54616226877, 94609.0, 94710.0, 95031.0, 96205.5189724047, 83427.5828620853, 85503.0, 87195.0, 87360.6895896562, 88658.0, 9312.075524308186, 9549.379290346105, 9607.279454041114, 9658.951705241428, 9848.779757448949, 50190.74904625453, 50817.745911270205, 51271.0, 51410.228846566584, 51465.22802157896, 67409.3259067403, 72147.27852721406, 72173.27826721876, 73690.63154684192, 74452.0, 11601.941990289995, 12025.0, 12088.15382923187, 12150.57472988441, 12207.0, 13360.198388096745, 13531.864681353061, 13568.321583920962, 13731.794023089862, 13807.309634518435, 12040.578579749666, 12307.138500305251, 12490.0, 12610.180338277982, 12862.807057893951, 12839.486420543073, 12917.0, 13413.731725365244, 13659.658508537366, 13741.24423156736, 12834.55079072228, 12934.676633084247, 13118.934405327913, 13567.118137321437, 13609.591712248648, 10555.366677999345, 10686.89313106859, 10838.078763305208, 10870.728231794268, 10974.615888443866, 10701.304415212986, 10983.83524247121, 11031.558737650405, 11114.27757195812, 11147.609833655782], "value": 7458.112487987658, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1544.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 108.0, 111.0, 110.0, 111.0, 112.0, 110.0, 112.0, 111.0, 112.0], "value": 110.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 126.0, 157.0, 177.0, 128.0, 149.0, 160.0, 126.0, 189.0, 130.0], "value": 149.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 162.0, 162.0, 166.0, 177.0, 167.0, 163.0, 164.0], "value": 164.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 151.0, 76.0, 75.0, 76.0, 76.0, 184.0, 77.0], "value": 94.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 158.0, 85.0, 87.0, 85.0, 153.0, 85.0, 85.0, 140.0], "value": 104.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 117.0, 118.0, 117.0, 117.0, 117.0, 118.0, 117.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 149.0, 147.0, 148.0, 146.0, 147.0, 147.0, 147.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 97.0, 96.0, 96.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 56.0, 53.0, 57.0, 65.0, 53.0, 53.0, 56.0, 54.0], "value": 56.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 62.0, 63.0, 62.0, 63.0, 62.0, 62.0, 63.0], "value": 62.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 79.0, 81.0, 85.0, 85.0, 83.0, 82.0, 82.0, 103.0, 81.0], "value": 84.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 129.0, 126.0, 123.0, 122.0, 126.0, 132.0, 135.0, 134.0, 132.0], "value": 128.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 165.0, 163.0, 161.0, 166.0, 162.0, 165.0, 162.0, 162.0, 163.0], "value": 163.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 63.0, 64.0, 65.0, 65.0, 65.0, 73.0, 64.0, 66.0, 64.0], "value": 66.1, "unit": "score"}]}]} 08:45:23 INFO - Return code: 0 08:45:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:45:23 ERROR - # TBPL SUCCESS # 08:45:23 INFO - Running post-action listener: _resource_record_post_action 08:45:23 INFO - ##### 08:45:23 INFO - ##### Finished run-tests step (success) 08:45:23 INFO - ##### 08:45:23 INFO - Running post-run listener: _resource_record_post_run 08:45:23 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 540409856; Read time: 276; Write time: 650652 08:45:23 INFO - TinderboxPrint: CPU usage
13.4% 08:45:23 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 276 08:45:23 INFO - TinderboxPrint: I/O write bytes / time
540,409,856 / 650,652 08:45:23 INFO - TinderboxPrint: CPU idle
8,239.9 (86.6%) 08:45:23 INFO - TinderboxPrint: CPU user
1,218.1 (12.8%) 08:45:23 INFO - TinderboxPrint: Swap in / out
0 / 0 08:45:23 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 248147968; Read time: 0; Write time: 370000 08:45:23 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 292261888; Read time: 276; Write time: 280652 08:45:23 INFO - Running post-run listener: _upload_blobber_files 08:45:23 INFO - Blob upload gear active. 08:45:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:45:23 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:45:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:45:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:45:24 INFO - (blobuploader) - INFO - Open directory for files ... 08:45:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:45:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:45:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:45:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:45:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:45:25 INFO - (blobuploader) - INFO - Done attempting. 08:45:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:45:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:45:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:45:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:45:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:45:28 INFO - (blobuploader) - INFO - Done attempting. 08:45:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:45:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:45:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:45:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:45:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:45:29 INFO - (blobuploader) - INFO - Done attempting. 08:45:29 INFO - (blobuploader) - INFO - Iteration through files over. 08:45:29 INFO - Return code: 0 08:45:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:45:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:45:29 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ac7bc5bf4d08066bd03de798bcdb89597909f12166d7e7a6dd67977f63474e4dd880967faf28521140fcc4e64ae66ff459cce90683e3c929e81d0067ac783601", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/256728579a32b34c710166955f879a56b3ded767b3bfaba6e079e01b3685a6d52bff2b470f67af6cf991d752d1809dcf2911d73ffda20f4eb2ee133167d2a3e6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/97cb615310f7f6da01f3ca3c810aaca3cadf0211f5aec5f0fe58fb985be5ed0af248ed51189959b78c6b9f2d28c182ab51fbf69f690cd08a6f9f0ddaaa5cb124"} 08:45:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:45:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:45:29 INFO - Contents: 08:45:29 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ac7bc5bf4d08066bd03de798bcdb89597909f12166d7e7a6dd67977f63474e4dd880967faf28521140fcc4e64ae66ff459cce90683e3c929e81d0067ac783601", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/256728579a32b34c710166955f879a56b3ded767b3bfaba6e079e01b3685a6d52bff2b470f67af6cf991d752d1809dcf2911d73ffda20f4eb2ee133167d2a3e6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/97cb615310f7f6da01f3ca3c810aaca3cadf0211f5aec5f0fe58fb985be5ed0af248ed51189959b78c6b9f2d28c182ab51fbf69f690cd08a6f9f0ddaaa5cb124"} 08:45:29 INFO - Running post-run listener: copy_logs_to_upload_dir 08:45:29 INFO - Copying logs to upload dir... 08:45:29 INFO - mkdir: /builds/slave/test/build/upload/logs 08:45:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.403311 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-06-04 08:45:29.266633) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-04 08:45:29.269879) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1465052572.726020-1546144322 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/ac7bc5bf4d08066bd03de798bcdb89597909f12166d7e7a6dd67977f63474e4dd880967faf28521140fcc4e64ae66ff459cce90683e3c929e81d0067ac783601", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/256728579a32b34c710166955f879a56b3ded767b3bfaba6e079e01b3685a6d52bff2b470f67af6cf991d752d1809dcf2911d73ffda20f4eb2ee133167d2a3e6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/97cb615310f7f6da01f3ca3c810aaca3cadf0211f5aec5f0fe58fb985be5ed0af248ed51189959b78c6b9f2d28c182ab51fbf69f690cd08a6f9f0ddaaa5cb124"} build_url:https://queue.taskcluster.net/v1/task/SqQ-v3QzQLyfxXVF-ql0LQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011468 build_url: 'https://queue.taskcluster.net/v1/task/SqQ-v3QzQLyfxXVF-ql0LQ/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/ac7bc5bf4d08066bd03de798bcdb89597909f12166d7e7a6dd67977f63474e4dd880967faf28521140fcc4e64ae66ff459cce90683e3c929e81d0067ac783601", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/256728579a32b34c710166955f879a56b3ded767b3bfaba6e079e01b3685a6d52bff2b470f67af6cf991d752d1809dcf2911d73ffda20f4eb2ee133167d2a3e6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/97cb615310f7f6da01f3ca3c810aaca3cadf0211f5aec5f0fe58fb985be5ed0af248ed51189959b78c6b9f2d28c182ab51fbf69f690cd08a6f9f0ddaaa5cb124"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-04 08:45:29.294981) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 08:45:29.295307) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1465052572.726020-1546144322 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004470 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 08:45:29.378265) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-04 08:45:29.378593) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-04 08:45:29.378876) ========= ========= Total master_lag: 0.19 =========