builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-026 starttime: 1490197451.41 results: success (0) revision: 00c595de162736689a83e894a84f9eb99a5fa6ac ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-22 08:44:11.414846) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-22 08:44:11.415530) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-22 08:44:11.416024) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-22 08:44:11.428665) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-22 08:44:11.429091) ========= 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=41bf3e9aed84707956354da8000001c5-1490197451.206139-910668056 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-22 08:44:11-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2017-03-22 08:44:12 (225 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.174174 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-22 08:44:11.615923) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-22 08:44:11.616306) ========= 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=41bf3e9aed84707956354da8000001c5-1490197451.206139-910668056 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015021 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-22 08:44:11.667261) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-22 08:44:11.667619) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 00c595de162736689a83e894a84f9eb99a5fa6ac --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 00c595de162736689a83e894a84f9eb99a5fa6ac --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=41bf3e9aed84707956354da8000001c5-1490197451.206139-910668056 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-22 08:44:12,214 truncating revision to first 12 chars 2017-03-22 08:44:12,214 Setting DEBUG logging. 2017-03-22 08:44:12,214 attempt 1/10 2017-03-22 08:44:12,214 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/00c595de1627?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-22 08:44:13,044 unpacking tar archive at: mozilla-central-00c595de1627/testing/mozharness/ program finished with exit code 0 elapsedTime=1.126386 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-22 08:44:12.808941) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-22 08:44:12.809596) ========= script_repo_revision: 00c595de162736689a83e894a84f9eb99a5fa6ac ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-22 08:44:12.810282) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-22 08:44:12.810735) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-22 08:44:12.821614) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-03-22 08:44:12.822064) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=41bf3e9aed84707956354da8000001c5-1490197451.206139-910668056 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:44:13 INFO - MultiFileLogger online at 20170322 08:44:13 in /builds/slave/test 08:44:13 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 08:44:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:44:13 INFO - {'append_to_log': False, 08:44:13 INFO - 'base_work_dir': '/builds/slave/test', 08:44:13 INFO - 'blob_upload_branch': 'Firefox', 08:44:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:44:13 INFO - 'branch': 'Firefox', 08:44:13 INFO - 'buildbot_json_path': 'buildprops.json', 08:44:13 INFO - 'config_files': ('talos/linux_config.py',), 08:44:13 INFO - 'default_actions': ('clobber', 08:44:13 INFO - 'read-buildbot-config', 08:44:13 INFO - 'download-and-extract', 08:44:13 INFO - 'populate-webroot', 08:44:13 INFO - 'create-virtualenv', 08:44:13 INFO - 'install', 08:44:13 INFO - 'run-tests'), 08:44:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:44:13 INFO - 'download_minidump_stackwalk': True, 08:44:13 INFO - 'download_symbols': 'ondemand', 08:44:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:44:13 INFO - 'tooltool.py': '/tools/tooltool.py', 08:44:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:44:13 INFO - '/tools/misc-python/virtualenv.py')}, 08:44:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:44:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:44:13 INFO - 'gecko_profile': False, 08:44:13 INFO - 'gecko_profile_interval': 0, 08:44:13 INFO - 'installer_path': 'installer.exe', 08:44:13 INFO - 'log_level': 'info', 08:44:13 INFO - 'log_name': 'talos', 08:44:13 INFO - 'log_to_console': True, 08:44:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:44:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:44:13 INFO - 'opt_config_files': (), 08:44:13 INFO - 'pip_index': False, 08:44:13 INFO - 'suite': 'dromaeojs', 08:44:13 INFO - 'system_bits': '32', 08:44:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:44:13 INFO - 'title': 'talos-linux64-ix-026', 08:44:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:44:13 INFO - 'use_talos_json': True, 08:44:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:44:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:44:13 INFO - 'work_dir': 'build'} 08:44:13 INFO - [mozharness: 2017-03-22 15:44:13.474104Z] Running clobber step. 08:44:13 INFO - Running pre-action listener: _resource_record_pre_action 08:44:13 INFO - Running main action method: clobber 08:44:13 INFO - rmtree: /builds/slave/test/build 08:44:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:44:14 INFO - Running post-action listener: _resource_record_post_action 08:44:14 INFO - [mozharness: 2017-03-22 15:44:14.940733Z] Finished clobber step (success) 08:44:14 INFO - [mozharness: 2017-03-22 15:44:14.940837Z] Running read-buildbot-config step. 08:44:14 INFO - Running pre-action listener: _resource_record_pre_action 08:44:14 INFO - Running main action method: read_buildbot_config 08:44:14 INFO - Using buildbot properties: 08:44:14 INFO - { 08:44:14 INFO - "project": "", 08:44:14 INFO - "product": "firefox", 08:44:14 INFO - "who": "ffxbld@noreply.mozilla.org", 08:44:14 INFO - "installer_path": "public/build/target.tar.bz2", 08:44:14 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 08:44:14 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 08:44:14 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 08:44:14 INFO - "stage_platform": "linux64-pgo", 08:44:14 INFO - "basedir": "/builds/slave/test", 08:44:14 INFO - "buildnumber": 90, 08:44:14 INFO - "platform": "ubuntu64_hw", 08:44:14 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:44:14 INFO - "slavebuilddir": "test", 08:44:14 INFO - "taskId": "IvB54SmJTQ6NS_3EHVxAUg", 08:44:14 INFO - "branch": "mozilla-central", 08:44:14 INFO - "script_repo_revision": "production", 08:44:14 INFO - "revision": "00c595de162736689a83e894a84f9eb99a5fa6ac", 08:44:14 INFO - "slavename": "talos-linux64-ix-026", 08:44:14 INFO - "repo_path": "mozilla-central" 08:44:14 INFO - } 08:44:14 INFO - Finding installer, test and symbols from parent task. 08:44:14 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IvB54SmJTQ6NS_3EHVxAUg'}, attempt #1 08:44:15 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IvB54SmJTQ6NS_3EHVxAUg'}, attempt #1 08:44:15 INFO - Task dependencies: exjF_Lr0R1qiOfiOZfgSEA 08:44:15 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/exjF_Lr0R1qiOfiOZfgSEA'}, attempt #1 08:44:16 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/exjF_Lr0R1qiOfiOZfgSEA/artifacts/public/build/target.tar.bz2 08:44:16 INFO - Set test_url: https://queue.taskcluster.net/v1/task/exjF_Lr0R1qiOfiOZfgSEA/artifacts/public/build/test_packages.json 08:44:16 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/exjF_Lr0R1qiOfiOZfgSEA/artifacts/public/build/target.crashreporter-symbols.zip 08:44:16 INFO - Running post-action listener: _resource_record_post_action 08:44:16 INFO - [mozharness: 2017-03-22 15:44:16.331511Z] Finished read-buildbot-config step (success) 08:44:16 INFO - [mozharness: 2017-03-22 15:44:16.331728Z] Running download-and-extract step. 08:44:16 INFO - Running pre-action listener: _resource_record_pre_action 08:44:16 INFO - Running main action method: download_and_extract 08:44:16 INFO - mkdir: /builds/slave/test/build/tests 08:44: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:44:16 INFO - trying https://queue.taskcluster.net/v1/task/exjF_Lr0R1qiOfiOZfgSEA/artifacts/public/build/target.test_packages.json 08:44:16 INFO - Downloading https://queue.taskcluster.net/v1/task/exjF_Lr0R1qiOfiOZfgSEA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 08:44:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/exjF_Lr0R1qiOfiOZfgSEA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 08:44:16 INFO - Downloaded 986 bytes. 08:44:16 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 08:44:16 INFO - Using the following test package requirements: 08:44:16 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 08:44:16 INFO - u'common': [u'target.common.tests.zip'], 08:44:16 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 08:44:16 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 08:44:16 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 08:44:16 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 08:44:16 INFO - u'mozbase': [u'target.common.tests.zip'], 08:44:16 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 08:44:16 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 08:44:16 INFO - u'web-platform': [u'target.common.tests.zip', 08:44:16 INFO - u'target.web-platform.tests.zip'], 08:44:16 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 08:44:16 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 08:44:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/exjF_Lr0R1qiOfiOZfgSEA/artifacts/public/build/target.common.tests.zip 08:44:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/exjF_Lr0R1qiOfiOZfgSEA/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:44:16 INFO - Fetch https://queue.taskcluster.net/v1/task/exjF_Lr0R1qiOfiOZfgSEA/artifacts/public/build/target.common.tests.zip into memory 08:44:18 INFO - Expected file size: 60243878 08:44:18 INFO - Obtained file size: 60243878 08:44:27 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 08:44:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/exjF_Lr0R1qiOfiOZfgSEA/artifacts/public/build/target.common.tests.zip 08:44:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/exjF_Lr0R1qiOfiOZfgSEA/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:44:27 INFO - Fetch https://queue.taskcluster.net/v1/task/exjF_Lr0R1qiOfiOZfgSEA/artifacts/public/build/target.common.tests.zip into memory 08:44:29 INFO - Expected file size: 60243878 08:44:29 INFO - Obtained file size: 60243878 08:44:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/exjF_Lr0R1qiOfiOZfgSEA/artifacts/public/build/target.talos.tests.zip 08:44:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/exjF_Lr0R1qiOfiOZfgSEA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 08:44:39 INFO - Fetch https://queue.taskcluster.net/v1/task/exjF_Lr0R1qiOfiOZfgSEA/artifacts/public/build/target.talos.tests.zip into memory 08:44:40 INFO - Expected file size: 14404171 08:44:40 INFO - Obtained file size: 14404171 08:44:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:44:40 INFO - trying https://queue.taskcluster.net/v1/task/exjF_Lr0R1qiOfiOZfgSEA/artifacts/public/build/target.tar.bz2 08:44:40 INFO - Downloading https://queue.taskcluster.net/v1/task/exjF_Lr0R1qiOfiOZfgSEA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 08:44:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/exjF_Lr0R1qiOfiOZfgSEA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 08:44:41 INFO - Downloaded 67326226 bytes. 08:44:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/exjF_Lr0R1qiOfiOZfgSEA/artifacts/public/build/target.tar.bz2 08:44:41 INFO - mkdir: /builds/slave/test/properties 08:44:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:44:41 INFO - Writing to file /builds/slave/test/properties/build_url 08:44:41 INFO - Contents: 08:44:41 INFO - build_url:https://queue.taskcluster.net/v1/task/exjF_Lr0R1qiOfiOZfgSEA/artifacts/public/build/target.tar.bz2 08:44:41 INFO - Running post-action listener: _resource_record_post_action 08:44:41 INFO - Running post-action listener: set_extra_try_arguments 08:44:41 INFO - [mozharness: 2017-03-22 15:44:41.942554Z] Finished download-and-extract step (success) 08:44:41 INFO - [mozharness: 2017-03-22 15:44:41.942651Z] Running populate-webroot step. 08:44:41 INFO - Running pre-action listener: _resource_record_pre_action 08:44:41 INFO - Running main action method: populate_webroot 08:44:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:44:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:44:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:44:41 INFO - '--tppagecycles', 08:44:41 INFO - '7'], 08:44:41 INFO - 'tests': ['tsvgm']}}, 08:44:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:44:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:44:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:44:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:44:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:44:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:44:41 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:44:41 INFO - 'talos_options': ['--disable-e10s'], 08:44:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:44:41 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:44:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:44:41 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:44:41 INFO - 'talos_options': ['--disable-e10s'], 08:44:41 INFO - 'tests': ['damp', 'tps']}, 08:44:41 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:44:41 INFO - 'tests': ['damp', 'tps']}, 08:44:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:44:41 INFO - 'tests': ['dromaeo_dom']}, 08:44:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:44:41 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:44:41 INFO - 'tests': ['basic_compositor_video']}, 08:44:41 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:44:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:44:41 INFO - 'tests': ['a11yr', 08:44:41 INFO - 'ts_paint', 08:44:41 INFO - 'tpaint', 08:44:41 INFO - 'sessionrestore', 08:44:41 INFO - 'sessionrestore_no_auto_restore', 08:44:41 INFO - 'tabpaint']}, 08:44:41 INFO - 'other-e10s': {'tests': ['a11yr', 08:44:41 INFO - 'ts_paint', 08:44:41 INFO - 'tpaint', 08:44:41 INFO - 'sessionrestore', 08:44:41 INFO - 'sessionrestore_no_auto_restore', 08:44:41 INFO - 'tabpaint']}, 08:44:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:44:41 INFO - 'ts_paint', 08:44:41 INFO - 'tpaint', 08:44:41 INFO - 'sessionrestore', 08:44:41 INFO - 'sessionrestore_no_auto_restore', 08:44:41 INFO - 'tabpaint']}, 08:44:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:44:41 INFO - 'ts_paint', 08:44:41 INFO - 'tpaint', 08:44:41 INFO - 'sessionrestore', 08:44:41 INFO - 'sessionrestore_no_auto_restore', 08:44:41 INFO - 'tabpaint']}, 08:44:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:44:41 INFO - 'tests': ['a11yr', 08:44:41 INFO - 'ts_paint', 08:44:41 INFO - 'tpaint', 08:44:41 INFO - 'sessionrestore', 08:44:41 INFO - 'sessionrestore_no_auto_restore', 08:44:41 INFO - 'tabpaint']}, 08:44:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:44:41 INFO - 'tests': ['a11yr', 08:44:41 INFO - 'ts_paint', 08:44:41 INFO - 'tpaint', 08:44:41 INFO - 'sessionrestore', 08:44:41 INFO - 'sessionrestore_no_auto_restore', 08:44:41 INFO - 'tabpaint']}, 08:44:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:44:41 INFO - 'tests': ['tsvgx', 08:44:41 INFO - 'tsvgr_opacity', 08:44:41 INFO - 'tart', 08:44:41 INFO - 'tscrollx', 08:44:41 INFO - 'cart', 08:44:41 INFO - 'tsvg_static']}, 08:44:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:44:41 INFO - 'tsvgr_opacity', 08:44:41 INFO - 'tart', 08:44:41 INFO - 'tscrollx', 08:44:41 INFO - 'cart', 08:44:41 INFO - 'tsvg_static']}, 08:44:41 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:44:41 INFO - 'talos_options': ['--disable-e10s'], 08:44:41 INFO - 'tests': ['tp5o']}, 08:44:41 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:44:41 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:44:41 INFO - 'talos_options': ['--disable-e10s', 08:44:41 INFO - '--xperf_path', 08:44:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:44:41 INFO - 'tests': ['tp5n']}, 08:44:41 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:44:41 INFO - 'talos_options': ['--xperf_path', 08:44:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:44:41 INFO - 'tests': ['tp5n']}}, 08:44:41 INFO - 'talos.zip': {'path': '', 08:44:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:44:41 INFO - Running post-action listener: _resource_record_post_action 08:44:41 INFO - [mozharness: 2017-03-22 15:44:41.960898Z] Finished populate-webroot step (success) 08:44:41 INFO - [mozharness: 2017-03-22 15:44:41.960989Z] Running create-virtualenv step. 08:44:41 INFO - Running pre-action listener: _resource_record_pre_action 08:44:41 INFO - Running main action method: create_virtualenv 08:44:41 INFO - Creating virtualenv /builds/slave/test/build/venv 08:44:41 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:44:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:44:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:44:42 INFO - Using real prefix '/usr' 08:44:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:44:42 INFO - Installing distribute.............................................................................................................................................................................................done. 08:44:44 INFO - Installing pip.................done. 08:44:44 INFO - Return code: 0 08:44:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:44:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:44:44 INFO - Reading from file tmpfile_stdout 08:44:44 INFO - Output received: 08:44:44 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 08:44:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:44:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:44:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:44:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:44:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:44:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x192c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1969a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bca310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc7400>, '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 0x1bc83b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc8840>, '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': '41bf3e9aed84707956354da8000001c5-1490197451.206139-910668056', '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:44:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:44:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:44:44 INFO - Using env: {'DISPLAY': ':0', 08:44:44 INFO - 'HOME': '/home/cltbld', 08:44:44 INFO - 'LANG': 'en_US.UTF-8', 08:44:44 INFO - 'LANGUAGE': 'en_US:en', 08:44:44 INFO - 'LOGNAME': 'cltbld', 08:44:44 INFO - 'MAIL': '/var/mail/cltbld', 08:44:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:44:44 INFO - 'MOZ_NO_REMOTE': '1', 08:44:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:44:44 INFO - 'NO_EM_RESTART': '1', 08:44:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:44:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:44:44 INFO - 'PWD': '/builds/slave/test', 08:44:44 INFO - 'SHELL': '/bin/bash', 08:44:44 INFO - 'SHLVL': '1', 08:44:44 INFO - 'TERM': 'linux', 08:44:44 INFO - 'TMOUT': '86400', 08:44:44 INFO - 'USER': 'cltbld', 08:44:44 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1490197451.206139-910668056', 08:44:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:44:44 INFO - '_': '/tools/buildbot/bin/python'} 08:44:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:44:44 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:44:44 INFO - Cleaning up... 08:44:44 INFO - Return code: 0 08:44:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:44:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:44:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:44:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:44:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:44:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x192c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1969a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bca310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc7400>, '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 0x1bc83b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc8840>, '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': '41bf3e9aed84707956354da8000001c5-1490197451.206139-910668056', '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:44:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:44:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:44:44 INFO - Using env: {'DISPLAY': ':0', 08:44:44 INFO - 'HOME': '/home/cltbld', 08:44:44 INFO - 'LANG': 'en_US.UTF-8', 08:44:44 INFO - 'LANGUAGE': 'en_US:en', 08:44:44 INFO - 'LOGNAME': 'cltbld', 08:44:44 INFO - 'MAIL': '/var/mail/cltbld', 08:44:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:44:44 INFO - 'MOZ_NO_REMOTE': '1', 08:44:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:44:44 INFO - 'NO_EM_RESTART': '1', 08:44:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:44:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:44:44 INFO - 'PWD': '/builds/slave/test', 08:44:44 INFO - 'SHELL': '/bin/bash', 08:44:44 INFO - 'SHLVL': '1', 08:44:44 INFO - 'TERM': 'linux', 08:44:44 INFO - 'TMOUT': '86400', 08:44:44 INFO - 'USER': 'cltbld', 08:44:44 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1490197451.206139-910668056', 08:44:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:44:44 INFO - '_': '/tools/buildbot/bin/python'} 08:44:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:44:45 INFO - Downloading/unpacking psutil>=3.1.1 08:44:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:44:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:44:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:44:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:44:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:44:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:44:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:44:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:44:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:44:47 INFO - Installing collected packages: psutil 08:44:47 INFO - Running setup.py install for psutil 08:44:47 INFO - building 'psutil._psutil_linux' extension 08:44:47 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:44:47 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:44:47 INFO - building 'psutil._psutil_posix' extension 08:44:47 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:44:47 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:44:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:44:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:44:47 INFO - Successfully installed psutil 08:44:47 INFO - Cleaning up... 08:44:47 INFO - Return code: 0 08:44:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:44: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:44:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:44:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:44:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:44:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:47 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 0x192c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1969a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bca310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc7400>, '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 0x1bc83b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc8840>, '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': '41bf3e9aed84707956354da8000001c5-1490197451.206139-910668056', '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:44:47 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:44:47 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:44:47 INFO - Using env: {'DISPLAY': ':0', 08:44:47 INFO - 'HOME': '/home/cltbld', 08:44:47 INFO - 'LANG': 'en_US.UTF-8', 08:44:47 INFO - 'LANGUAGE': 'en_US:en', 08:44:47 INFO - 'LOGNAME': 'cltbld', 08:44:47 INFO - 'MAIL': '/var/mail/cltbld', 08:44:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:44:47 INFO - 'MOZ_NO_REMOTE': '1', 08:44:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:44:47 INFO - 'NO_EM_RESTART': '1', 08:44:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:44:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:44:47 INFO - 'PWD': '/builds/slave/test', 08:44:47 INFO - 'SHELL': '/bin/bash', 08:44:47 INFO - 'SHLVL': '1', 08:44:47 INFO - 'TERM': 'linux', 08:44:47 INFO - 'TMOUT': '86400', 08:44:47 INFO - 'USER': 'cltbld', 08:44:47 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1490197451.206139-910668056', 08:44:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:44:47 INFO - '_': '/tools/buildbot/bin/python'} 08:44:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:44:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:44:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:44:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:44:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:44:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:44:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:44:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:44:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:44:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:44:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:44:50 INFO - Installing collected packages: mozsystemmonitor 08:44:50 INFO - Running setup.py install for mozsystemmonitor 08:44:50 INFO - Successfully installed mozsystemmonitor 08:44:50 INFO - Cleaning up... 08:44:50 INFO - Return code: 0 08:44:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:44:50 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:44:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:44:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:50 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:44:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:44:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:50 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 0x192c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1969a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bca310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc7400>, '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 0x1bc83b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc8840>, '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': '41bf3e9aed84707956354da8000001c5-1490197451.206139-910668056', '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:44:50 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:44:50 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:44:50 INFO - Using env: {'DISPLAY': ':0', 08:44:50 INFO - 'HOME': '/home/cltbld', 08:44:50 INFO - 'LANG': 'en_US.UTF-8', 08:44:50 INFO - 'LANGUAGE': 'en_US:en', 08:44:50 INFO - 'LOGNAME': 'cltbld', 08:44:50 INFO - 'MAIL': '/var/mail/cltbld', 08:44:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:44:50 INFO - 'MOZ_NO_REMOTE': '1', 08:44:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:44:50 INFO - 'NO_EM_RESTART': '1', 08:44:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:44:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:44:50 INFO - 'PWD': '/builds/slave/test', 08:44:50 INFO - 'SHELL': '/bin/bash', 08:44:50 INFO - 'SHLVL': '1', 08:44:50 INFO - 'TERM': 'linux', 08:44:50 INFO - 'TMOUT': '86400', 08:44:50 INFO - 'USER': 'cltbld', 08:44:50 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1490197451.206139-910668056', 08:44:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:44:50 INFO - '_': '/tools/buildbot/bin/python'} 08:44:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:44:50 INFO - Downloading/unpacking jsonschema==2.5.1 08:44:50 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:44:50 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:44:50 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:44:50 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:44:50 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:44:50 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:44:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:44:52 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:44:52 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:44:52 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:44:52 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:44:52 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:44:52 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:44:52 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:44:52 INFO - Downloading functools32-3.2.3-2.tar.gz 08:44:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:44:52 INFO - warning: no files found matching '*.txt' 08:44:52 INFO - no previously-included directories found matching 'build' 08:44:52 INFO - no previously-included directories found matching 'dist' 08:44:52 INFO - no previously-included directories found matching '.git*' 08:44:52 INFO - Installing collected packages: jsonschema, functools32 08:44:52 INFO - Running setup.py install for functools32 08:44:52 INFO - warning: no files found matching '*.txt' 08:44:52 INFO - no previously-included directories found matching 'build' 08:44:52 INFO - no previously-included directories found matching 'dist' 08:44:52 INFO - no previously-included directories found matching '.git*' 08:44:52 INFO - Successfully installed jsonschema functools32 08:44:52 INFO - Cleaning up... 08:44:53 INFO - Return code: 0 08:44:53 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:44:53 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:44:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:44:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:53 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:44:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:44:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:53 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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x192c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1969a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bca310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc7400>, '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 0x1bc83b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc8840>, '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': '41bf3e9aed84707956354da8000001c5-1490197451.206139-910668056', '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:44:53 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', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:44:53 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 functools32==3.2.3-2 08:44:53 INFO - Using env: {'DISPLAY': ':0', 08:44:53 INFO - 'HOME': '/home/cltbld', 08:44:53 INFO - 'LANG': 'en_US.UTF-8', 08:44:53 INFO - 'LANGUAGE': 'en_US:en', 08:44:53 INFO - 'LOGNAME': 'cltbld', 08:44:53 INFO - 'MAIL': '/var/mail/cltbld', 08:44:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:44:53 INFO - 'MOZ_NO_REMOTE': '1', 08:44:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:44:53 INFO - 'NO_EM_RESTART': '1', 08:44:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:44:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:44:53 INFO - 'PWD': '/builds/slave/test', 08:44:53 INFO - 'SHELL': '/bin/bash', 08:44:53 INFO - 'SHLVL': '1', 08:44:53 INFO - 'TERM': 'linux', 08:44:53 INFO - 'TMOUT': '86400', 08:44:53 INFO - 'USER': 'cltbld', 08:44:53 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1490197451.206139-910668056', 08:44:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:44:53 INFO - '_': '/tools/buildbot/bin/python'} 08:44:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:44:53 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:44:53 INFO - Cleaning up... 08:44:53 INFO - Return code: 0 08:44:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:44:53 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:44:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:44:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:53 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:44:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:44:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:53 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 0x192c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1969a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bca310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc7400>, '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 0x1bc83b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc8840>, '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': '41bf3e9aed84707956354da8000001c5-1490197451.206139-910668056', '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:44:53 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:44:53 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:44:53 INFO - Using env: {'DISPLAY': ':0', 08:44:53 INFO - 'HOME': '/home/cltbld', 08:44:53 INFO - 'LANG': 'en_US.UTF-8', 08:44:53 INFO - 'LANGUAGE': 'en_US:en', 08:44:53 INFO - 'LOGNAME': 'cltbld', 08:44:53 INFO - 'MAIL': '/var/mail/cltbld', 08:44:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:44:53 INFO - 'MOZ_NO_REMOTE': '1', 08:44:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:44:53 INFO - 'NO_EM_RESTART': '1', 08:44:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:44:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:44:53 INFO - 'PWD': '/builds/slave/test', 08:44:53 INFO - 'SHELL': '/bin/bash', 08:44:53 INFO - 'SHLVL': '1', 08:44:53 INFO - 'TERM': 'linux', 08:44:53 INFO - 'TMOUT': '86400', 08:44:53 INFO - 'USER': 'cltbld', 08:44:53 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1490197451.206139-910668056', 08:44:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:44:53 INFO - '_': '/tools/buildbot/bin/python'} 08:44:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:44:53 INFO - Downloading/unpacking blobuploader==1.2.4 08:44:53 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:44:53 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:44:53 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:44:53 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:44:53 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:44:53 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:44:55 INFO - Downloading blobuploader-1.2.4.tar.gz 08:44:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:44:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:44:55 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:44:55 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:44:55 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:44:55 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:44:55 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:44:55 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:44:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:44:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:44:56 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:44:56 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:44:56 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:44:56 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:44:56 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:44:56 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:44:56 INFO - Downloading docopt-0.6.1.tar.gz 08:44:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:44:56 INFO - Installing collected packages: blobuploader, requests, docopt 08:44:56 INFO - Running setup.py install for blobuploader 08:44:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:44:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:44:56 INFO - Running setup.py install for requests 08:44:56 INFO - Running setup.py install for docopt 08:44:56 INFO - Successfully installed blobuploader requests docopt 08:44:56 INFO - Cleaning up... 08:44:56 INFO - Return code: 0 08:44:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:44:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:44:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:44:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:44:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:44:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:56 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 0x192c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1969a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bca310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc7400>, '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 0x1bc83b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc8840>, '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': '41bf3e9aed84707956354da8000001c5-1490197451.206139-910668056', '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:44:56 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:44:56 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:44:56 INFO - Using env: {'DISPLAY': ':0', 08:44:56 INFO - 'HOME': '/home/cltbld', 08:44:56 INFO - 'LANG': 'en_US.UTF-8', 08:44:56 INFO - 'LANGUAGE': 'en_US:en', 08:44:56 INFO - 'LOGNAME': 'cltbld', 08:44:56 INFO - 'MAIL': '/var/mail/cltbld', 08:44:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:44:56 INFO - 'MOZ_NO_REMOTE': '1', 08:44:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:44:56 INFO - 'NO_EM_RESTART': '1', 08:44:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:44:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:44:56 INFO - 'PWD': '/builds/slave/test', 08:44:56 INFO - 'SHELL': '/bin/bash', 08:44:56 INFO - 'SHLVL': '1', 08:44:56 INFO - 'TERM': 'linux', 08:44:56 INFO - 'TMOUT': '86400', 08:44:56 INFO - 'USER': 'cltbld', 08:44:56 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1490197451.206139-910668056', 08:44:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:44:56 INFO - '_': '/tools/buildbot/bin/python'} 08:44:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:44:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:44:57 INFO - Running setup.py (path:/tmp/pip-e3ZQnV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:44:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:44:57 INFO - Running setup.py (path:/tmp/pip-KHvR0V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:44:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:44:57 INFO - Running setup.py (path:/tmp/pip-Ubamkl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:44:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:44:57 INFO - Running setup.py (path:/tmp/pip-Sw3oVp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:44:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:44:57 INFO - Running setup.py (path:/tmp/pip-KtWO79-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:44:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:44:57 INFO - Running setup.py (path:/tmp/pip-oVuGgz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:44:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:44:57 INFO - Running setup.py (path:/tmp/pip-mcsKu5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:44:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:44:57 INFO - Running setup.py (path:/tmp/pip-6RiwlH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:44:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:44:57 INFO - Running setup.py (path:/tmp/pip-2C9VD4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:44:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:44:57 INFO - Running setup.py (path:/tmp/pip-UFMSc2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:44:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:44:57 INFO - Running setup.py (path:/tmp/pip-lB4C_A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:44:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:44:57 INFO - Running setup.py (path:/tmp/pip-ArFCjm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:44:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:44:58 INFO - Running setup.py (path:/tmp/pip-Qolpad-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:44:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:44:58 INFO - Running setup.py (path:/tmp/pip-pQFTyu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:44:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:44:58 INFO - Running setup.py (path:/tmp/pip-5kqyYW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:44:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:44:58 INFO - Running setup.py (path:/tmp/pip-4ZpAho-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:44:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:44:58 INFO - Running setup.py (path:/tmp/pip-gvVtYb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:44:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:44:58 INFO - Running setup.py install for manifestparser 08:44:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:44:58 INFO - Running setup.py install for mozcrash 08:44:58 INFO - Running setup.py install for mozdebug 08:44:58 INFO - Running setup.py install for mozdevice 08:44:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:44:58 INFO - Running setup.py install for mozfile 08:44:58 INFO - Running setup.py install for mozhttpd 08:44:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:44:58 INFO - Running setup.py install for mozinfo 08:44:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:44:59 INFO - Running setup.py install for mozInstall 08:44:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:44:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:44:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:44:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:44:59 INFO - Running setup.py install for mozleak 08:44:59 INFO - Running setup.py install for mozlog 08:44:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:44:59 INFO - Running setup.py install for moznetwork 08:44:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:44:59 INFO - Running setup.py install for mozprocess 08:44:59 INFO - Running setup.py install for mozprofile 08:44:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:44:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:44:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:44:59 INFO - Running setup.py install for mozrunner 08:44:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:44:59 INFO - Running setup.py install for mozscreenshot 08:44:59 INFO - Running setup.py install for moztest 08:45:00 INFO - Running setup.py install for mozversion 08:45:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:45:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:45:00 INFO - Cleaning up... 08:45:00 INFO - Return code: 0 08:45:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:45:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:00 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 0x192c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1969a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bca310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc7400>, '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 0x1bc83b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc8840>, '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': '41bf3e9aed84707956354da8000001c5-1490197451.206139-910668056', '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:45:00 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:45:00 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:45:00 INFO - Using env: {'DISPLAY': ':0', 08:45:00 INFO - 'HOME': '/home/cltbld', 08:45:00 INFO - 'LANG': 'en_US.UTF-8', 08:45:00 INFO - 'LANGUAGE': 'en_US:en', 08:45:00 INFO - 'LOGNAME': 'cltbld', 08:45:00 INFO - 'MAIL': '/var/mail/cltbld', 08:45:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:00 INFO - 'MOZ_NO_REMOTE': '1', 08:45:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:45:00 INFO - 'NO_EM_RESTART': '1', 08:45:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:45:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:00 INFO - 'PWD': '/builds/slave/test', 08:45:00 INFO - 'SHELL': '/bin/bash', 08:45:00 INFO - 'SHLVL': '1', 08:45:00 INFO - 'TERM': 'linux', 08:45:00 INFO - 'TMOUT': '86400', 08:45:00 INFO - 'USER': 'cltbld', 08:45:00 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1490197451.206139-910668056', 08:45:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:00 INFO - '_': '/tools/buildbot/bin/python'} 08:45:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:45:00 INFO - Running setup.py (path:/tmp/pip-tPKtzM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:45:00 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:45:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:45:00 INFO - Running setup.py (path:/tmp/pip-0yUYjk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:45:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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:45:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:45:00 INFO - Running setup.py (path:/tmp/pip-r9KRVk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:45:00 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:45:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:45:00 INFO - Running setup.py (path:/tmp/pip-CI0MZb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:45:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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:45:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:45:00 INFO - Running setup.py (path:/tmp/pip-ODvZjr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:45:00 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:45:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:45:00 INFO - Running setup.py (path:/tmp/pip-dnCEHS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:45:00 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:45:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:45:00 INFO - Running setup.py (path:/tmp/pip-9_PAtN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:45:00 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:45:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:45:00 INFO - Running setup.py (path:/tmp/pip-ZFulEx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:45:00 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:45:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:45:00 INFO - Running setup.py (path:/tmp/pip-IDqRrs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:45:01 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:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:45:01 INFO - Running setup.py (path:/tmp/pip-TsRkZf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:45:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:45:01 INFO - Running setup.py (path:/tmp/pip-bnEL7k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:45:01 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:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:45:01 INFO - Running setup.py (path:/tmp/pip-6jPDbm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:45:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:45:01 INFO - Running setup.py (path:/tmp/pip-LqFBzp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:45:01 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:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:45:01 INFO - Running setup.py (path:/tmp/pip-hmaDJr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:45:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:45:01 INFO - Running setup.py (path:/tmp/pip-24e5h9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:45:01 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:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:45:01 INFO - Running setup.py (path:/tmp/pip-yk6FOG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:45:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:45:01 INFO - Running setup.py (path:/tmp/pip-l8E3a6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:45:01 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:45:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:45:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:45:01 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:45:01 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:45:01 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:45:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:45:01 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:45:01 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:45:01 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:45:01 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:45:01 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:45:01 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:45:03 INFO - Downloading blessings-1.6.tar.gz 08:45:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:45:03 INFO - Installing collected packages: blessings 08:45:03 INFO - Running setup.py install for blessings 08:45:03 INFO - Successfully installed blessings 08:45:03 INFO - Cleaning up... 08:45:03 INFO - Return code: 0 08:45:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:45:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:45:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:45:04 INFO - Reading from file tmpfile_stdout 08:45:04 INFO - Current package versions: 08:45:04 INFO - argparse == 1.2.1 08:45:04 INFO - blessings == 1.6 08:45:04 INFO - blobuploader == 1.2.4 08:45:04 INFO - docopt == 0.6.1 08:45:04 INFO - functools32 == 3.2.3-2 08:45:04 INFO - jsonschema == 2.5.1 08:45:04 INFO - manifestparser == 1.1 08:45:04 INFO - mozInstall == 1.12 08:45:04 INFO - mozcrash == 1.0 08:45:04 INFO - mozdebug == 0.1 08:45:04 INFO - mozdevice == 0.49 08:45:04 INFO - mozfile == 1.2 08:45:04 INFO - mozhttpd == 0.7 08:45:04 INFO - mozinfo == 0.9 08:45:04 INFO - mozleak == 0.1 08:45:04 INFO - mozlog == 3.4 08:45:04 INFO - moznetwork == 0.27 08:45:04 INFO - mozprocess == 0.25 08:45:04 INFO - mozprofile == 0.28 08:45:04 INFO - mozrunner == 6.13 08:45:04 INFO - mozscreenshot == 0.1 08:45:04 INFO - mozsystemmonitor == 0.3 08:45:04 INFO - moztest == 0.8 08:45:04 INFO - mozversion == 1.4 08:45:04 INFO - psutil == 3.1.1 08:45:04 INFO - requests == 1.2.3 08:45:04 INFO - wsgiref == 0.1.2 08:45:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:45:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:04 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 0x192c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1969a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bca310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc7400>, '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 0x1bc83b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc8840>, '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': '41bf3e9aed84707956354da8000001c5-1490197451.206139-910668056', '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:45:04 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:45:04 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:45:04 INFO - Using env: {'DISPLAY': ':0', 08:45:04 INFO - 'HOME': '/home/cltbld', 08:45:04 INFO - 'LANG': 'en_US.UTF-8', 08:45:04 INFO - 'LANGUAGE': 'en_US:en', 08:45:04 INFO - 'LOGNAME': 'cltbld', 08:45:04 INFO - 'MAIL': '/var/mail/cltbld', 08:45:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:04 INFO - 'MOZ_NO_REMOTE': '1', 08:45:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:45:04 INFO - 'NO_EM_RESTART': '1', 08:45:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:45:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:04 INFO - 'PWD': '/builds/slave/test', 08:45:04 INFO - 'SHELL': '/bin/bash', 08:45:04 INFO - 'SHLVL': '1', 08:45:04 INFO - 'TERM': 'linux', 08:45:04 INFO - 'TMOUT': '86400', 08:45:04 INFO - 'USER': 'cltbld', 08:45:04 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1490197451.206139-910668056', 08:45:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:04 INFO - '_': '/tools/buildbot/bin/python'} 08:45:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:04 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:45:04 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:45:04 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:45:04 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:45:04 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:45:04 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:45:04 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:45:04 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:45:04 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:45:04 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:45:04 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:45:04 INFO - Cleaning up... 08:45:04 INFO - Return code: 0 08:45:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:45:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:04 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 0x192c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1969a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bca310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc7400>, '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 0x1bc83b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc8840>, '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': '41bf3e9aed84707956354da8000001c5-1490197451.206139-910668056', '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:45:04 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:45:04 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:45:04 INFO - Using env: {'DISPLAY': ':0', 08:45:04 INFO - 'HOME': '/home/cltbld', 08:45:04 INFO - 'LANG': 'en_US.UTF-8', 08:45:04 INFO - 'LANGUAGE': 'en_US:en', 08:45:04 INFO - 'LOGNAME': 'cltbld', 08:45:04 INFO - 'MAIL': '/var/mail/cltbld', 08:45:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:04 INFO - 'MOZ_NO_REMOTE': '1', 08:45:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:45:04 INFO - 'NO_EM_RESTART': '1', 08:45:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:45:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:04 INFO - 'PWD': '/builds/slave/test', 08:45:04 INFO - 'SHELL': '/bin/bash', 08:45:04 INFO - 'SHLVL': '1', 08:45:04 INFO - 'TERM': 'linux', 08:45:04 INFO - 'TMOUT': '86400', 08:45:04 INFO - 'USER': 'cltbld', 08:45:04 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1490197451.206139-910668056', 08:45:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:04 INFO - '_': '/tools/buildbot/bin/python'} 08:45:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:45:04 INFO - Cleaning up... 08:45:04 INFO - Return code: 0 08:45:04 INFO - Running post-action listener: _resource_record_post_action 08:45:04 INFO - Running post-action listener: _start_resource_monitoring 08:45:04 INFO - Starting resource monitoring. 08:45:04 INFO - [mozharness: 2017-03-22 15:45:04.588593Z] Finished create-virtualenv step (success) 08:45:04 INFO - [mozharness: 2017-03-22 15:45:04.589125Z] Running install step. 08:45:04 INFO - Running pre-action listener: _resource_record_pre_action 08:45:04 INFO - Running main action method: install 08:45:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:45:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:45:04 INFO - Reading from file tmpfile_stdout 08:45:04 INFO - Detecting whether we're running mozinstall >=1.0... 08:45:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:45:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:45:04 INFO - Reading from file tmpfile_stdout 08:45:04 INFO - Output received: 08:45:04 INFO - Usage: mozinstall [options] installer 08:45:04 INFO - Options: 08:45:04 INFO - -h, --help show this help message and exit 08:45:04 INFO - -d DEST, --destination=DEST 08:45:04 INFO - Directory to install application into. [default: 08:45:04 INFO - "/builds/slave/test"] 08:45:04 INFO - --app=APP Application being installed. [default: firefox] 08:45:04 INFO - mkdir: /builds/slave/test/build/application 08:45:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:45:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 08:45:21 INFO - Reading from file tmpfile_stdout 08:45:21 INFO - Output received: 08:45:21 INFO - /builds/slave/test/build/application/firefox/firefox 08:45:21 INFO - Running post-action listener: _resource_record_post_action 08:45:21 INFO - [mozharness: 2017-03-22 15:45:21.604636Z] Finished install step (success) 08:45:21 INFO - [mozharness: 2017-03-22 15:45:21.604854Z] Running run-tests step. 08:45:21 INFO - Running pre-action listener: _resource_record_pre_action 08:45:21 INFO - Running main action method: run_tests 08:45:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:45:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:45:21 INFO - Python 2.7.3 08:45:21 INFO - Return code: 0 08:45:21 INFO - grabbing minidump binary from tooltool 08:45:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:21 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 0x1bc7400>, '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 0x1bc83b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc8840>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:45:21 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:45:21 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:45:21 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:45:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:45:21 INFO - Return code: 0 08:45:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:45:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:45:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:45:21 INFO - ENV: RUST_BACKTRACE is now 1 08:45:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:45:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:45:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/exjF_Lr0R1qiOfiOZfgSEA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:45:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/exjF_Lr0R1qiOfiOZfgSEA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-026 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:45:21 INFO - Using env: {'DISPLAY': ':0', 08:45:21 INFO - 'HOME': '/home/cltbld', 08:45:21 INFO - 'LANG': 'en_US.UTF-8', 08:45:21 INFO - 'LANGUAGE': 'en_US:en', 08:45:21 INFO - 'LOGNAME': 'cltbld', 08:45:21 INFO - 'MAIL': '/var/mail/cltbld', 08:45:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:45:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:45:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:21 INFO - 'MOZ_NO_REMOTE': '1', 08:45:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:45:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:45:21 INFO - 'NO_EM_RESTART': '1', 08:45:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:45:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:21 INFO - 'PWD': '/builds/slave/test', 08:45:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:45:21 INFO - 'RUST_BACKTRACE': '1', 08:45:21 INFO - 'SHELL': '/bin/bash', 08:45:21 INFO - 'SHLVL': '1', 08:45:21 INFO - 'TERM': 'linux', 08:45:21 INFO - 'TMOUT': '86400', 08:45:21 INFO - 'USER': 'cltbld', 08:45:21 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1490197451.206139-910668056', 08:45:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:21 INFO - '_': '/tools/buildbot/bin/python'} 08:45:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/exjF_Lr0R1qiOfiOZfgSEA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:45:21 INFO - mozversion application_buildid: 20170322145025 08:45:21 INFO - mozversion application_changeset: 00c595de162736689a83e894a84f9eb99a5fa6ac 08:45:21 INFO - mozversion application_display_name: Nightly 08:45:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:45:21 INFO - mozversion application_name: Firefox 08:45:21 INFO - mozversion application_remotingname: firefox 08:45:21 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:45:21 INFO - mozversion application_vendor: Mozilla 08:45:21 INFO - mozversion application_version: 55.0a1 08:45:21 INFO - mozversion platform_buildid: 20170322145025 08:45:21 INFO - mozversion platform_changeset: 00c595de162736689a83e894a84f9eb99a5fa6ac 08:45:21 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:45:21 INFO - mozversion platform_version: 55.0a1 08:45:21 INFO - using testdate: 1490197521 08:45:21 INFO - actual date: 1490197521 08:45:21 INFO - starting webserver on 'localhost:58215' 08:45:21 INFO - SUITE-START | Running 2 tests 08:45:21 INFO - TEST-START | dromaeo_css 08:45:21 INFO - operating with platform_type : linux_ 08:45:21 INFO - Initialising browser for dromaeo_css test... 08:45:21 INFO - TEST-INFO | started process 23409 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1_1Q8a/profile http://localhost:58215/getInfo.html) 08:45:25 INFO - PID 23409 | __metrics Screen width/height:1600/1200 08:45:25 INFO - PID 23409 | colorDepth:24 08:45:25 INFO - PID 23409 | Browser inner width/height: 1024/697 08:45:25 INFO - PID 23409 | __metrics 08:45:26 INFO - PID 23409 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:45:26 INFO - PID 23409 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:45:27 INFO - TEST-INFO | 23409: exit 0 08:45:27 INFO - Browser initialized. 08:45:27 INFO - Running cycle 1/1 for dromaeo_css test... 08:45:27 INFO - TEST-INFO | started process 23508 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1_1Q8a/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:45:39 INFO - PID 23508 | RSS: Main: 145158144 08:45:39 INFO - PID 23508 | 08:48:41 INFO - PID 23508 | Cycle 1(1): loaded http://localhost:58215/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58215/tests/dromaeo/cssquery-ext.html) 08:48:43 INFO - PID 23508 | RSS: Main: 304984064 08:48:43 INFO - PID 23508 | 08:50:29 INFO - PID 23508 | ************************* 08:50:29 INFO - PID 23508 | A coding exception was thrown and uncaught in a Task. 08:50:29 INFO - PID 23508 | 08:50:29 ERROR - PID 23508 | Full message: TypeError: NetworkError when attempting to fetch resource. 08:50:29 INFO - PID 23508 | Full stack: 08:50:29 INFO - PID 23508 | ************************* 08:51:46 INFO - PID 23508 | Cycle 1(1): loaded http://localhost:58215/tests/dromaeo/cssquery-ext.html (next: http://localhost:58215/tests/dromaeo/cssquery-jquery.html) 08:51:46 INFO - PID 23508 | RSS: Main: 230215680 08:51:46 INFO - PID 23508 | 08:54:48 INFO - PID 23508 | Cycle 1(1): loaded http://localhost:58215/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58215/tests/dromaeo/cssquery-mootools.html) 08:54:49 INFO - PID 23508 | RSS: Main: 177315840 08:54:49 INFO - PID 23508 | 08:57:51 INFO - PID 23508 | Cycle 1(1): loaded http://localhost:58215/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58215/tests/dromaeo/cssquery-prototype.html) 08:57:51 INFO - PID 23508 | RSS: Main: 198676480 08:57:51 INFO - PID 23508 | 09:00:54 INFO - PID 23508 | Cycle 1(1): loaded http://localhost:58215/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58215/tests/dromaeo/cssquery-yui.html) 09:00:55 INFO - PID 23508 | RSS: Main: 183848960 09:00:55 INFO - PID 23508 | 09:03:57 INFO - PID 23508 | Cycle 1(1): loaded http://localhost:58215/tests/dromaeo/cssquery-yui.html (next: http://localhost:58215/tests/dromaeo/cssquery-dojo.html) 09:03:58 INFO - PID 23508 | RSS: Main: 252272640 09:03:58 INFO - PID 23508 | 09:03:58 INFO - PID 23508 | __start_tp_report 09:03:58 INFO - PID 23508 | _x_x_mozilla_page_load 09:03:58 INFO - PID 23508 | _x_x_mozilla_page_load_details 09:03:58 INFO - PID 23508 | |i|pagename|runs| 09:03:58 INFO - PID 23508 | |0;dojo.html;3270.1661076425517;3289.309245058539;3315.0386387947497;3318.5851768528933;3348.9665103348975;5705.2012718219485;5788.681622510766;5802.535797136229;5807.854803629912;5809.099589563619;5706.800261990831;5728.513076388502;5735.684537350444;5783.132530120484;5870.970645146768;5139.383274007125;5207.3490813648195;5239.973800130994;5240.816571420001;5276.445973172819;5238.738063096849;5241.633085684004;5253.3170687810725;5255.316808814849;5255.842324730264;5092;5119.308893299394;5148.6910785353;5162.148245539482;5194.610404219679;5217.947820521784;5260;5275.973620131875;5302.019126461579;5304.416514183436;5144.022635699205;5196.246544251062;5200.97399513;5204.76578553966;5260.13207820713;5633.943660563424;5788.131780232957;5800.506956908668;5801.82594522165;5803.767849286023;6137.775380989496;6143.788236234952;6153.815385538441;6157.107219453154;6210.751569937197;6243.687815609247;6249;6260.373962603749;6266.811995640092;6268.623882567015;5720;5819.156222347736;5829.679367634821;5836.620619659709;5868.061110222344;6201.937980620226;6274.435300822948;6357.904631430532;6374.745010199633;6381.1385462962835;6184.938150618526;6196.535259855529;6203.8138855834395;6209.441150296405;6215.378462153749;6309.495240380758;6311.842203944846;6314.747410103544;6318.115463835067;6320.8419789504715;6102.69486525672;6120.569035656853;6165.753369865245;6290.339514351019;6296.087067375205;6184.319724830265;6241.906371404432;6252.968735156295;6261.123442718023;6271.059341098871;4762;4762.214234651313;4762.59517940972;4794.424669039738;4806.014766972762;4216.536181020086;4224.155168966219;4234.2801723706425;4239.173361194537;4272.316429371348;5655.575831812631;5671.092625179951;5822.155787410802;5878.11828225761;5885.823425297248;6214;6264.59280146789;6264.812055638247;6271.905921411182;6273.1844860167885;5793.246877905845;5799;5800.390958949334;5805.709714514257;5841.386654401312;5162.432132465426;5223.817166399233;5285.233641122093;5285.286486324374;5322.627416080914;6434.292227854932;6491.51313651478;6499.155109835691;6500.187476565335;6503.674816259263;6145.201123853871;6216.751329946932;6233.719482623384;6257.436830685078;6286.7799627014665;6397.944339183982;6463.3213512580505;6469.547131700736;6473.449756770538;6488;6114.419130182626;6156.230471191101;6158.568900176944;6168.414000669929;6169.259688837368;6135.969320153371;6312.368763123651;6323.399277068671;6327.145835312358;6330.335314791881;6034.39656034393;6056.121862329849;6077;6079.696015199134;6097.908531372122;6045.818625441244;6090.390960903874;6092.482139018233;6100.298465676504;6102.786402475892;6052;6082.452579267887;6083.330833608388;6100.969495152496;6104.236970378703;6006.549508786771;6061.121137434959;6066.636001839904;6070;6091.416231779681;6016.699165041818;6019.428154325332;6027.487663548647;6047.848803779941;6066.636001839904 09:03:58 INFO - PID 23508 | |1;ext.html;722.458156382713;796.0566728426815;812.3135950122148;1122.326604037577;1134.8865113488657;28738.42523149536;35094;35646.46530302044;35738;35990.280194396095;37467.43798843013;37872.621273787256;38240.42639360412;38303.808480957625;38312;6045.214122164112;6197.03945888388;7963.243491868263;8131.959340203291;8256.133106023872;7848.175941526143;8055.7583272501915;8059;8060.476069055522;8100.432969692124;8145.918540814605;8237.423380363376;8257.133001034896;8258;8259.339252859787;8294.37792165587;8340.833183336359;8347.165283471664;8349.499030058216;8355.540445275508;7864.05631324239;7886.329661978739;7915.960420197862;7928.207179282083;7930.206979302081;40089.59910400888;40180.39729404061;40306.395404068964;40376.59623403758;40378;2962.0817546560634;2983.0603359941765;2991.1176203020163;2991.3718119194996;3025.258811591152;27496;27537.724622753718;27581.31046723828;27890.816377543328;28042.719572804213;3579.7315201359743;3596.3886139356373;3605.152789094561;3616.801075940822;3644.817759112034;188454;189488;189731.99999999863;189871;190473;46774;46816;46823.84937656855;46830.29754553684;46861.76569117133;49561.50438495641;49676.75161624241;49735.25397119046;49920.50079499231;49980.250296244856;14071.507497237548;14219.85780142206;14247.073940193854;14257.714845703027;14261.928690356483;9452.43285402878;9577.329586928987;10905;11274.210805243718;11301;13959.720805583831;14274.643133921527;14291.285435728172;14386.28068596566;14450.710985780226;5763.769449222068;5782.971085144547;5816.098504731774;5872.471477567039;5881.2942446906645;1016.9288149829441;1040.1990467340106;1048.119579553179;1057.413135709673;1066.248294952057;24353.391165220655;25009.249722508353;25083.498330033297;25100.497990040098;25147.62278565823;1129.8474705914596;1136.3466007045981;1137.4824454873012;1151.9712007199719;1160.4197901049474;12686.80969785454;12965.870341296466;13137.408816603276;13145.145565538209;13151.145175563557;336136;336692;338872;338992;339000;55079;55394.16908746372;55410.303196940375;55468.44531554633;55495.722521387135;1426.18707336817;1479.6744716162427;1484.7327481053298;1505.6160679026777;1511.5012046024785;23029.193978210682;24306.63540046936;24361.26916192517;24362.28088847566;24374.87812560926;38071.428928566645;38116.618833811306;38313.4252986211;38332.80833595814;38376.232475350895;278794;279154.20845791284;279344;279719;279783;25737.227883163534;25795.32330398518;34109;34173.82913085419;34328.31343373169;35880.64119358773;36380.726674566264;36424;36731;37399.62600373961;30177.245568860955;30866.228344291572;30894.53658195084;31118.688813111577;32413.513797292588;30274.394512110073;30306;30677.846610766803;30696.232594185323;31890;32274.838625806722;32968;33084.834575826964;34470;35555.11112222215;27592.172234832986;29532;29695;29946;30390.240243994078;25376.492470150864;26503.204903852915;26543.469130617665;26608.07110828914;26765.464690706467 09:03:58 INFO - PID 23508 | |2;jquery.html;381.82699321033294;436.4130244820716;436.556894751827;458.73622666966503;458.9977050114749;18266.90866545667;18971.905140474297;19518.414447566578;19571;19704;20640.1743930243;21118.89440552799;21364.145434182614;21906.23328183514;21993.450163745874;5919.200907877446;6039.849003774919;6086.573939824214;6103.26760788706;6104.053871649901;5666.206731057655;6001.60989535681;6002.669853158096;6008.939910600903;6012.699365031731;5716.314042314907;5999.280086389639;6002.939970600303;6007.339192688801;6013.639181649093;5907.852303692399;5998.070299103646;6016.308124565688;6016.368281330485;6017.578769486137;5359.892802143935;5389.892202155974;5418.4039755626845;5418.674879507203;5419.566434685255;24656.753432465626;24696.629550556576;24833.255002349957;24886.50226995468;24977.750222497725;2000.5298754792611;2001.8798872067723;2004.8095430934038;2027.0675489274952;2058.207590077831;15115.924420377938;15266.923665381713;15273.465428710053;15506;15990.680186396323;1862.6833438315518;1885.1705249690092;1893.422506135628;1925.6918892977055;1946.9221231150736;101248;104026;104410;107917;109599.90400095977;10931.453427328603;12186.634400967985;12466.501339946482;12502.24950510886;12762.489500420064;15354.692906142038;16370.263338149813;16586;16672.249748761336;16764.664706705797;8404.285635721033;8486.0665326814;8584.785380365416;8679.305655547541;8710.085441028728;7823.647935842901;7923.6830526778285;7952.0457545093805;8090.797730056678;8096.352291816641;7737.535747855147;7908.090569584457;7910.841783164305;7975.162607926084;8007.398520295964;2206.3491270075365;2220.8112310453794;2262.6379779235244;2263.9094436222695;2313.2250696016686;967.7483854197959;974.7758015656439;997.8303688372849;1007.9244056695777;1011.5397494140149;19561.413157605293;20007.099680514413;20108.296209632594;20278.69581956272;20318;1018.3991445047458;1023.698009087321;1024.959001639926;1030.5929157982705;1030.644427672452;9898.686266970913;10897.333705312669;10900.360383743728;10902.400367979837;10958.616448424425;296823;301415;494130;661986;670524;103911.4804425973;105248.47375763225;105483;107054;108688;1118.424011634009;1150.988490115088;1183.508843829801;1193.928364298145;1195.49789088583;15970.9201453992;16691.749623755895;16839.66320673604;16956.745648815526;16964.575885602957;45094.549054510346;46448.53551464442;46675;46751.766241168574;47347.844780178355;61450;62923;63421.36578634154;63829;64676.67661661661;8670.91329086701;8895.288376929959;8928.910710892807;9067.727968160965;9265.397749146285;13622.455101795817;13805.447782088604;13841.307934603028;13965.835295529208;14276.643083922985;10986.242201248082;11463.828042579202;11679.416029198675;11695.298282103102;12279.69300767488;11789.233699809485;11857.940710296738;12271.815922761345;12495.625131246077;12631.431585578488;12147.574834880737;12269.87730122723;12270.509179632714;12276.079294053161;12345.321007344683;8800.427972181787;8964.193222609736;9031.548422578977;9171.495567743572;9214.216791572791;11615.30308181478;11807.527698892292;11888.34614096233;11916.702082448008;12316.445759940645 09:03:58 INFO - PID 23508 | |3;mootools.html;1269.3272565540265;1323.7948118041706;1324.668832791802;1329.995853130886;1349.696318328376;10213.489325533721;10588.258821882451;10631.574737010511;10635.042846143846;10638.680839574816;10336.586536538529;10644.095251903598;10909;10960.725981850457;10980.945095274512;2202.48241663209;2249.3589327041796;2250.7636698146703;2251.6059689554345;2251.7072780538506;1838.3473866777301;2062.669972804352;2123.458518077888;2130.3182981445943;2130.872147671137;1921.4043646469638;2093.424308315218;2174.0760176924823;2176.3906106290265;2177.074743234119;2090.216168936649;2096.6330892093824;2100.222917520512;2110.9788902110936;2114.7885211478883;2047.1708957872086;2107.1360742095667;2107.1782005018053;2108.0513768803944;2110.9894450527804;11012.17408694343;11080.390578518178;11090.112790976702;11096;11109.72225694356;6013.789517366871;6175.845603859894;6200.224971878515;6203.162573052626;6206.603514209267;3548.769329993542;3602.621724718893;3860.478835357219;3878.7866667333287;3891.0272431892026;1298.7727147749106;1307.9869201308056;1319.5051855554168;1357.945682172712;1382.260490637514;16193.595160120973;16257.10585917774;16308.429204977769;16308.75536866948;16313.102779347131;4862.95137048625;5087.516685914832;5160.716160611202;5223.52988231061;5278.788848446096;12097.697557561132;12119.091068169746;12126.211796233216;12136.211146275464;12196.207246528948;6105.8473538161015;6110.572259941761;6120.8163755086525;6134.6625935573975;6144.2319710036245;5598.160275958558;5670.943290567124;5684.062129748628;5713.600047996601;5729.427057294237;3994.5365550160204;4062.695297852673;4082.1835632873544;4087.5912408758886;4106.281400754856;1140.914431417647;1163.406662602079;1166.8949794518535;1179.628417048627;1185.82805493203;618.5330075792838;775.4726785785607;806.7173194620582;807.4993504027541;807.9555624440594;6025.15647809307;6325.746970121144;6389.105525226472;6428.132202152743;6613.570117942415;922.9215516681023;933.9859902101474;941.6798288581915;963.8313295173317;972.9221662267001;3879.592642772525;3924.7252692311263;3951.68386529077;4074.083331250445;4085.3667681509414;14256.501022464165;14741.778873316909;14744.96785225024;14753.704925901422;14754.409823606935;14227.857721422653;14334.993100965874;14390.496332628518;14418.351174197187;14419.927900360432;9957.302988790716;10377.221708371902;10508.632197873038;10514.947425262671;10534.420606866695;6303.243610766737;6450.7097180627925;6457.031445283245;6471.126397936218;6490.123833282447;12622.116451848282;12989.805152922903;13030.218186908816;13065.216087034809;13075.60773176768;13006.609801705965;13028.739425211254;13170.80243796363;13300.201987880759;13443.327833608086;8541.188587084218;8676.783080422787;8684.609192586222;8747.737567872973;8755.255803256794;9878.110970012733;9884.11043006133;9906.752331191778;9963.25275604347;10029.548670309707;8605.827883442422;8791.208791208823;8902;8902.910970890209;9051.54742262871;8804.867926980973;8945.776355590902;8963.865542016745;8973.641054357753;9080.137386948229;7559.735409260649;7618.123915749759;7716.2669546393;7717;7725.5364678119495;5920.644761314335;5949.464548190511;5986.9401305986385;6244.875102498016;6267.96866015667;5779.653220806765;5811.883762324815;5838.474537291664;5944.078667806497;5970.462658360769 09:03:58 INFO - PID 23508 | |4;prototype.html;397.93434083376246;413.45630495897893;426.8996785755347;430.81905599648167;435.71460693245916;5630.971845140769;5786.82639520814;5800.506956908663;5807.186993820868;5870.941290587088;5601.831945041656;5759.337676167242;5789.507891829189;5792.739326730297;5844.707764611774;4622.214223581982;4649.163150632885;4659.370984917026;4660.207764679995;4672.252439609663;4543.250363689987;4636.652251081166;4665.113628410608;4670.439547254335;4674.439067311911;4574.1080489304595;4595.425571803525;4595.448546174463;4597.747123908183;4601.263797792354;4600.286955521866;4613.423322084739;4620.607248383892;4623;4625.398698169233;4006.399040143973;4153.1070819773595;4178.22702799983;4208.095259519218;4221.810018549173;5683.829485115453;5719.370869204426;5726.3700992890745;5761.827145185651;5762.3373312069225;5457.754401051962;5471;5474.644148130359;5481.095619222863;5496.450354964471;6148;6237;6243.906341404882;6255.718492667841;6295;4667.883302917454;4669.369635099252;4669.777853281225;4687.906241875144;4693.131770622445;6403.263624683174;6512.511561632897;6520.282768895418;6544.574602650765;6602.504812139109;4808.374911261513;4813.518648135228;4841.443234028062;4842.15262329091;4846;4877.6829506081995;4896.730679812573;4901.289313049588;4924.630652701062;4930.704157750546;5216.347956505437;5401.5948803839865;5417.10617748075;5437.619366644376;5451.236826844245;5874.765009399576;6263.812085637438;6265.122882796412;6265.310815810257;6277.309495955441;1609.340170530077;1631.3474610156034;1682.2093616000461;1689.4087069525813;1691.4756425508133;1175.535663412947;1209.8790120988008;1210.8304837322783;1217.7747116783423;1220.713132413882;5885.117232415087;5900.262467191601;5903.822885313448;5931.317898441648;5931.7923872665115;6346.174997250328;6352.522516218678;6375.936240637627;6391.552591318563;6394.936050639527;5781.5952883298605;5794.739236734357;5901.616394934315;5908;5916.319623243296;3347.5313456116164;3367.107716455141;3389.3729660012978;3397.2695870387984;3402.1154499829727;6227.875442491216;6518.73925042993;6546.541742078009;6598.60408375499;6613.173353330833;6508.958566629317;6510.316416776265;6510.804675859732;6549.803505894831;6566.146400967844;6279.340669229757;6523.739050438119;6525.282218955911;6587.176602924635;6597.80206593803;6315.368463153832;6343.746250149942;6384.553081284265;6395;6405.647689376942;6197.411245931629;6217.906731399123;6272.937270627235;6276.403741644536;6287.685615719287;6430.196225471816;6493.188351456068;6513.283538810632;6516.73933042673;6521.445677117498;4497.370368148528;4498.820047198075;4498.820047198206;4515.75163366018;4526.366308716848;6197.692603640607;6326.620402775849;6360.268569114426;6380.840478988062;6414.711337989895;6225.937740622536;6230.906536401867;6233.127362169391;6238.594491358047;6255.18682571281;6028.638281703112;6218.253809542884;6222.346653601307;6243.531735119975;6255.937440625536;6188.876222475616;6196.676246407597;6207.224096987877;6230.563860529719;6235.812925612239;6167.414095660905;6178.536609754196;6249.562530622995;6262.373762623702;6269.592476489013;5753.280839895013;6033.698315084141;6064.423879731418;6097.2988106366565;6125.111858780363 09:03:58 INFO - PID 23508 | |5;yui.html;739.6080077558893;745.4409193105171;748.4162353364371;751.6054071612405;752.3417010116148;13314.334283285845;13726.656833579165;13732;13753.724925501496;13839.51561695341;13377.93311033446;13402.46390144393;13556.32218389079;13561.457541698344;13896.51362202323;801.7474495533917;806.5402720449346;824.8391563645091;830.1822704635929;834.5368320582074;819;821.2444551013082;821.4208982667235;822.1244374740882;822.3503432288485;864.8313578852126;868.4745728834059;870.6647940542873;871.1984973824098;872.0276891266225;861.0614430271004;862.3446180902497;863.404251066762;864.006392648453;867.2108381372952;630.5932673425615;633.9524535659843;634.6414275934083;634.8952422850224;639.8976163813768;13453;13762.24307663078;13777.517786877512;13786.448542058306;14021;13823.723525529433;14360.425582976668;14461.49384771528;14523;14595.124292542481;11430.188847893809;11577.189596728233;11650.6504804856;11665.300081995107;12071.517139314417;3036.225762430588;3056.5415187721796;3063.5711000459955;3068.5243787212794;3191.0745883693935;83797.16202837955;85097.14902850954;85637.57181214116;85754.14245857524;85758.14241857563;10368.222383321281;10414.427206503715;10576.20678449104;10639.095676867399;10679.572817087384;21945.231916882833;22172;22234.332970010924;22434.10263589471;22484.98817553214;7393;7403.296686814744;7421.666025028887;7441.107067151868;7565;3891.5524714658177;3966.5438474575217;4009.578994205625;4103.4460347853255;4108.281050816096;4036.737612055207;4079.673626109904;4084.571120032354;4085.4484644572603;4108.630223279919;731.41648331362;735.7204262380261;737.3916518871952;738.243300616872;741.9146798118178;600.4865839706988;618.9597676151036;622.5766478794372;627.5087901032892;652.55952232244;9265.583048762686;9335.159835614828;9342.813143737087;9727.513624318755;9828.262880284008;598.4524160393279;600.6816387314731;624.1823211592828;629.2291942370651;648;4762.904741905142;4872.439669437989;4887.79939635925;4894.987121061975;4931.087748766489;74166.62916685382;74778.39162062867;76273;76305.23694762982;79491;57449.712751435974;58082.09589520507;61979.690101550106;70346.64826675833;70570.64714676393;57039;57181.42818571844;58135.70932145397;58844.117338239106;59468.405315946286;10021.699349019542;10342.689719308433;10459;10544.15646748243;10633.468326583794;31105.222369440038;31311.84344078265;31382.215444614067;31681.84159079282;32007;39070.80464597659;39320;48379.5162048375;55555.444445555026;56613.433865660816;12055.57805476804;12527.436265368262;12580.874191258337;12715.364231788559;12926.741465170831;12822.679433013876;13154.408051637507;13166.210027398387;13246.47122692707;13639.727205455636;12347.69130771738;12624.74750505003;12803.807942880678;12891.677708057374;13557.095732559848;12182.451789669309;12278.14053016316;12535.435905384462;12740.490380385052;13687.657808554866;11688.88311116878;12039.75920481568;12326.100988034144;12349.691257718629;12442;11607;11789.065027499397;11955.581554645545;12115.663082258896;12627.11610187278;10606.628767993083;11310.773784524428;11864.22882512634;12015.639530814089;12199 09:03:58 INFO - PID 23508 | __end_tp_report 09:03:58 INFO - PID 23508 | __start_cc_report 09:03:58 INFO - PID 23508 | _x_x_mozilla_cycle_collect,1643 09:03:58 INFO - PID 23508 | __end_cc_report 09:03:58 INFO - PID 23508 | __startTimestamp1490198638201__endTimestamp 09:03:58 INFO - PID 23508 | 09:03:58 INFO - PID 23508 | ------- Summary: start ------- 09:03:58 INFO - PID 23508 | Number of tests: 6 09:03:58 INFO - PID 23508 | 09:03:58 INFO - PID 23508 | [#0] dojo.html Cycles:165 Average:5766.02 Median:6052.00 stddev:679.07 (11.2%) stddev-sans-first:652.32 09:03:58 INFO - PID 23508 | Values: 3270.2 3289.3 3315.0 3318.6 3349.0 5705.2 5788.7 5802.5 5807.9 5809.1 5706.8 5728.5 5735.7 5783.1 5871.0 5139.4 5207.3 5240.0 5240.8 5276.4 5238.7 5241.6 5253.3 5255.3 5255.8 5092.0 5119.3 5148.7 5162.1 5194.6 5217.9 5260.0 5276.0 5302.0 5304.4 5144.0 5196.2 5201.0 5204.8 5260.1 5633.9 5788.1 5800.5 5801.8 5803.8 6137.8 6143.8 6153.8 6157.1 6210.8 6243.7 6249.0 6260.4 6266.8 6268.6 5720.0 5819.2 5829.7 5836.6 5868.1 6201.9 6274.4 6357.9 6374.7 6381.1 6184.9 6196.5 6203.8 6209.4 6215.4 6309.5 6311.8 6314.7 6318.1 6320.8 6102.7 6120.6 6165.8 6290.3 6296.1 6184.3 6241.9 6253.0 6261.1 6271.1 4762.0 4762.2 4762.6 4794.4 4806.0 4216.5 4224.2 4234.3 4239.2 4272.3 5655.6 5671.1 5822.2 5878.1 5885.8 6214.0 6264.6 6264.8 6271.9 6273.2 5793.2 5799.0 5800.4 5805.7 5841.4 5162.4 5223.8 5285.2 5285.3 5322.6 6434.3 6491.5 6499.2 6500.2 6503.7 6145.2 6216.8 6233.7 6257.4 6286.8 6397.9 6463.3 6469.5 6473.4 6488.0 6114.4 6156.2 6158.6 6168.4 6169.3 6136.0 6312.4 6323.4 6327.1 6330.3 6034.4 6056.1 6077.0 6079.7 6097.9 6045.8 6090.4 6092.5 6100.3 6102.8 6052.0 6082.5 6083.3 6101.0 6104.2 6006.5 6061.1 6066.6 6070.0 6091.4 6016.7 6019.4 6027.5 6047.8 6066.6 09:03:58 INFO - PID 23508 | 09:03:58 INFO - PID 23508 | [#1] ext.html Cycles:180 Average:42053.84 Median:184610.42 stddev:72452.66 (39.2%) stddev-sans-first:72589.45 09:03:58 INFO - PID 23508 | Values: 722.5 796.1 812.3 1122.3 1134.9 28738.4 35094.0 35646.5 35738.0 35990.3 37467.4 37872.6 38240.4 38303.8 38312.0 6045.2 6197.0 7963.2 8132.0 8256.1 7848.2 8055.8 8059.0 8060.5 8100.4 8145.9 8237.4 8257.1 8258.0 8259.3 8294.4 8340.8 8347.2 8349.5 8355.5 7864.1 7886.3 7916.0 7928.2 7930.2 40089.6 40180.4 40306.4 40376.6 40378.0 2962.1 2983.1 2991.1 2991.4 3025.3 27496.0 27537.7 27581.3 27890.8 28042.7 3579.7 3596.4 3605.2 3616.8 3644.8 188454.0 189488.0 189732.0 189871.0 190473.0 46774.0 46816.0 46823.8 46830.3 46861.8 49561.5 49676.8 49735.3 49920.5 49980.3 14071.5 14219.9 14247.1 14257.7 14261.9 9452.4 9577.3 10905.0 11274.2 11301.0 13959.7 14274.6 14291.3 14386.3 14450.7 5763.8 5783.0 5816.1 5872.5 5881.3 1016.9 1040.2 1048.1 1057.4 1066.2 24353.4 25009.2 25083.5 25100.5 25147.6 1129.8 1136.3 1137.5 1152.0 1160.4 12686.8 12965.9 13137.4 13145.1 13151.1 336136.0 336692.0 338872.0 338992.0 339000.0 55079.0 55394.2 55410.3 55468.4 55495.7 1426.2 1479.7 1484.7 1505.6 1511.5 23029.2 24306.6 24361.3 24362.3 24374.9 38071.4 38116.6 38313.4 38332.8 38376.2 278794.0 279154.2 279344.0 279719.0 279783.0 25737.2 25795.3 34109.0 34173.8 34328.3 35880.6 36380.7 36424.0 36731.0 37399.6 30177.2 30866.2 30894.5 31118.7 32413.5 30274.4 30306.0 30677.8 30696.2 31890.0 32274.8 32968.0 33084.8 34470.0 35555.1 27592.2 29532.0 29695.0 29946.0 30390.2 25376.5 26503.2 26543.5 26608.1 26765.5 09:03:58 INFO - PID 23508 | 09:03:58 INFO - PID 23508 | [#2] jquery.html Cycles:180 Average:30736.84 Median:11349.19 stddev:85373.94 (752.2%) stddev-sans-first:85583.01 09:03:58 INFO - PID 23508 | Values: 381.8 436.4 436.6 458.7 459.0 18266.9 18971.9 19518.4 19571.0 19704.0 20640.2 21118.9 21364.1 21906.2 21993.5 5919.2 6039.8 6086.6 6103.3 6104.1 5666.2 6001.6 6002.7 6008.9 6012.7 5716.3 5999.3 6002.9 6007.3 6013.6 5907.9 5998.1 6016.3 6016.4 6017.6 5359.9 5389.9 5418.4 5418.7 5419.6 24656.8 24696.6 24833.3 24886.5 24977.8 2000.5 2001.9 2004.8 2027.1 2058.2 15115.9 15266.9 15273.5 15506.0 15990.7 1862.7 1885.2 1893.4 1925.7 1946.9 101248.0 104026.0 104410.0 107917.0 109599.9 10931.5 12186.6 12466.5 12502.2 12762.5 15354.7 16370.3 16586.0 16672.2 16764.7 8404.3 8486.1 8584.8 8679.3 8710.1 7823.6 7923.7 7952.0 8090.8 8096.4 7737.5 7908.1 7910.8 7975.2 8007.4 2206.3 2220.8 2262.6 2263.9 2313.2 967.7 974.8 997.8 1007.9 1011.5 19561.4 20007.1 20108.3 20278.7 20318.0 1018.4 1023.7 1025.0 1030.6 1030.6 9898.7 10897.3 10900.4 10902.4 10958.6 296823.0 301415.0 494130.0 661986.0 670524.0 103911.5 105248.5 105483.0 107054.0 108688.0 1118.4 1151.0 1183.5 1193.9 1195.5 15970.9 16691.7 16839.7 16956.7 16964.6 45094.5 46448.5 46675.0 46751.8 47347.8 61450.0 62923.0 63421.4 63829.0 64676.7 8670.9 8895.3 8928.9 9067.7 9265.4 13622.5 13805.4 13841.3 13965.8 14276.6 10986.2 11463.8 11679.4 11695.3 12279.7 11789.2 11857.9 12271.8 12495.6 12631.4 12147.6 12269.9 12270.5 12276.1 12345.3 8800.4 8964.2 9031.5 9171.5 9214.2 11615.3 11807.5 11888.3 11916.7 12316.4 09:03:58 INFO - PID 23508 | 09:03:58 INFO - PID 23508 | [#3] mootools.html Cycles:180 Average:6838.23 Median:3575.70 stddev:4431.61 (123.9%) stddev-sans-first:4424.28 09:03:58 INFO - PID 23508 | Values: 1269.3 1323.8 1324.7 1330.0 1349.7 10213.5 10588.3 10631.6 10635.0 10638.7 10336.6 10644.1 10909.0 10960.7 10980.9 2202.5 2249.4 2250.8 2251.6 2251.7 1838.3 2062.7 2123.5 2130.3 2130.9 1921.4 2093.4 2174.1 2176.4 2177.1 2090.2 2096.6 2100.2 2111.0 2114.8 2047.2 2107.1 2107.2 2108.1 2111.0 11012.2 11080.4 11090.1 11096.0 11109.7 6013.8 6175.8 6200.2 6203.2 6206.6 3548.8 3602.6 3860.5 3878.8 3891.0 1298.8 1308.0 1319.5 1357.9 1382.3 16193.6 16257.1 16308.4 16308.8 16313.1 4863.0 5087.5 5160.7 5223.5 5278.8 12097.7 12119.1 12126.2 12136.2 12196.2 6105.8 6110.6 6120.8 6134.7 6144.2 5598.2 5670.9 5684.1 5713.6 5729.4 3994.5 4062.7 4082.2 4087.6 4106.3 1140.9 1163.4 1166.9 1179.6 1185.8 618.5 775.5 806.7 807.5 808.0 6025.2 6325.7 6389.1 6428.1 6613.6 922.9 934.0 941.7 963.8 972.9 3879.6 3924.7 3951.7 4074.1 4085.4 14256.5 14741.8 14745.0 14753.7 14754.4 14227.9 14335.0 14390.5 14418.4 14419.9 9957.3 10377.2 10508.6 10514.9 10534.4 6303.2 6450.7 6457.0 6471.1 6490.1 12622.1 12989.8 13030.2 13065.2 13075.6 13006.6 13028.7 13170.8 13300.2 13443.3 8541.2 8676.8 8684.6 8747.7 8755.3 9878.1 9884.1 9906.8 9963.3 10029.5 8605.8 8791.2 8902.0 8902.9 9051.5 8804.9 8945.8 8963.9 8973.6 9080.1 7559.7 7618.1 7716.3 7717.0 7725.5 5920.6 5949.5 5986.9 6244.9 6268.0 5779.7 5811.9 5838.5 5944.1 5970.5 09:03:58 INFO - PID 23508 | 09:03:58 INFO - PID 23508 | [#4] prototype.html Cycles:180 Average:5258.99 Median:5825.95 stddev:1500.12 (25.7%) stddev-sans-first:1459.29 09:03:58 INFO - PID 23508 | Values: 397.9 413.5 426.9 430.8 435.7 5631.0 5786.8 5800.5 5807.2 5870.9 5601.8 5759.3 5789.5 5792.7 5844.7 4622.2 4649.2 4659.4 4660.2 4672.3 4543.3 4636.7 4665.1 4670.4 4674.4 4574.1 4595.4 4595.4 4597.7 4601.3 4600.3 4613.4 4620.6 4623.0 4625.4 4006.4 4153.1 4178.2 4208.1 4221.8 5683.8 5719.4 5726.4 5761.8 5762.3 5457.8 5471.0 5474.6 5481.1 5496.5 6148.0 6237.0 6243.9 6255.7 6295.0 4667.9 4669.4 4669.8 4687.9 4693.1 6403.3 6512.5 6520.3 6544.6 6602.5 4808.4 4813.5 4841.4 4842.2 4846.0 4877.7 4896.7 4901.3 4924.6 4930.7 5216.3 5401.6 5417.1 5437.6 5451.2 5874.8 6263.8 6265.1 6265.3 6277.3 1609.3 1631.3 1682.2 1689.4 1691.5 1175.5 1209.9 1210.8 1217.8 1220.7 5885.1 5900.3 5903.8 5931.3 5931.8 6346.2 6352.5 6375.9 6391.6 6394.9 5781.6 5794.7 5901.6 5908.0 5916.3 3347.5 3367.1 3389.4 3397.3 3402.1 6227.9 6518.7 6546.5 6598.6 6613.2 6509.0 6510.3 6510.8 6549.8 6566.1 6279.3 6523.7 6525.3 6587.2 6597.8 6315.4 6343.7 6384.6 6395.0 6405.6 6197.4 6217.9 6272.9 6276.4 6287.7 6430.2 6493.2 6513.3 6516.7 6521.4 4497.4 4498.8 4498.8 4515.8 4526.4 6197.7 6326.6 6360.3 6380.8 6414.7 6225.9 6230.9 6233.1 6238.6 6255.2 6028.6 6218.3 6222.3 6243.5 6255.9 6188.9 6196.7 6207.2 6230.6 6235.8 6167.4 6178.5 6249.6 6262.4 6269.6 5753.3 6033.7 6064.4 6097.3 6125.1 09:03:58 INFO - PID 23508 | 09:03:58 INFO - PID 23508 | [#5] yui.html Cycles:180 Average:16654.03 Median:4058.21 stddev:21668.77 (533.9%) stddev-sans-first:21696.61 09:03:58 INFO - PID 23508 | Values: 739.6 745.4 748.4 751.6 752.3 13314.3 13726.7 13732.0 13753.7 13839.5 13377.9 13402.5 13556.3 13561.5 13896.5 801.7 806.5 824.8 830.2 834.5 819.0 821.2 821.4 822.1 822.4 864.8 868.5 870.7 871.2 872.0 861.1 862.3 863.4 864.0 867.2 630.6 634.0 634.6 634.9 639.9 13453.0 13762.2 13777.5 13786.4 14021.0 13823.7 14360.4 14461.5 14523.0 14595.1 11430.2 11577.2 11650.7 11665.3 12071.5 3036.2 3056.5 3063.6 3068.5 3191.1 83797.2 85097.1 85637.6 85754.1 85758.1 10368.2 10414.4 10576.2 10639.1 10679.6 21945.2 22172.0 22234.3 22434.1 22485.0 7393.0 7403.3 7421.7 7441.1 7565.0 3891.6 3966.5 4009.6 4103.4 4108.3 4036.7 4079.7 4084.6 4085.4 4108.6 731.4 735.7 737.4 738.2 741.9 600.5 619.0 622.6 627.5 652.6 9265.6 9335.2 9342.8 9727.5 9828.3 598.5 600.7 624.2 629.2 648.0 4762.9 4872.4 4887.8 4895.0 4931.1 74166.6 74778.4 76273.0 76305.2 79491.0 57449.7 58082.1 61979.7 70346.6 70570.6 57039.0 57181.4 58135.7 58844.1 59468.4 10021.7 10342.7 10459.0 10544.2 10633.5 31105.2 31311.8 31382.2 31681.8 32007.0 39070.8 39320.0 48379.5 55555.4 56613.4 12055.6 12527.4 12580.9 12715.4 12926.7 12822.7 13154.4 13166.2 13246.5 13639.7 12347.7 12624.7 12803.8 12891.7 13557.1 12182.5 12278.1 12535.4 12740.5 13687.7 11688.9 12039.8 12326.1 12349.7 12442.0 11607.0 11789.1 11955.6 12115.7 12627.1 10606.6 11310.8 11864.2 12015.6 12199.0 09:03:58 INFO - PID 23508 | -------- Summary: end -------- 09:03:58 INFO - PID 23508 | 09:03:59 INFO - TEST-INFO | 23508: exit 0 09:03:59 INFO - TEST-OK | dromaeo_css | took 1117133ms 09:03:59 INFO - TEST-START | kraken 09:03:59 INFO - operating with platform_type : linux_ 09:03:59 INFO - Initialising browser for kraken test... 09:03:59 INFO - TEST-INFO | started process 23831 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjNSazP/profile http://localhost:58215/getInfo.html) 09:04:02 INFO - PID 23831 | __metrics Screen width/height:1600/1200 09:04:02 INFO - PID 23831 | colorDepth:24 09:04:02 INFO - PID 23831 | Browser inner width/height: 1024/697 09:04:02 INFO - PID 23831 | __metrics 09:04:03 INFO - PID 23831 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:04:03 INFO - PID 23831 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:04:04 INFO - TEST-INFO | 23831: exit 0 09:04:04 INFO - Browser initialized. 09:04:04 INFO - Running cycle 1/1 for kraken test... 09:04:04 INFO - TEST-INFO | started process 23927 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjNSazP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:04:16 INFO - PID 23927 | RSS: Main: 144482304 09:04:16 INFO - PID 23927 | 09:04:19 INFO - PID 23927 | Cycle 1(1): loaded http://localhost:58215/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58215/tests/kraken/driver.html?testName=audio-beat-detection) 09:04:19 INFO - PID 23927 | RSS: Main: 200667136 09:04:19 INFO - PID 23927 | 09:04:22 INFO - PID 23927 | Cycle 1(1): loaded http://localhost:58215/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58215/tests/kraken/driver.html?testName=audio-dft) 09:04:23 INFO - PID 23927 | RSS: Main: 179007488 09:04:23 INFO - PID 23927 | 09:04:26 INFO - PID 23927 | Cycle 1(1): loaded http://localhost:58215/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58215/tests/kraken/driver.html?testName=audio-fft) 09:04:26 INFO - PID 23927 | RSS: Main: 260833280 09:04:26 INFO - PID 23927 | 09:04:28 INFO - PID 23927 | Cycle 1(1): loaded http://localhost:58215/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58215/tests/kraken/driver.html?testName=audio-oscillator) 09:04:29 INFO - PID 23927 | RSS: Main: 173580288 09:04:29 INFO - PID 23927 | 09:04:31 INFO - PID 23927 | Cycle 1(1): loaded http://localhost:58215/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58215/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:04:32 INFO - PID 23927 | RSS: Main: 176390144 09:04:32 INFO - PID 23927 | 09:04:35 INFO - PID 23927 | Cycle 1(1): loaded http://localhost:58215/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58215/tests/kraken/driver.html?testName=imaging-darkroom) 09:04:35 INFO - PID 23927 | RSS: Main: 215343104 09:04:35 INFO - PID 23927 | 09:04:39 INFO - PID 23927 | Cycle 1(1): loaded http://localhost:58215/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58215/tests/kraken/driver.html?testName=imaging-desaturate) 09:04:39 INFO - PID 23927 | RSS: Main: 225509376 09:04:39 INFO - PID 23927 | 09:04:42 INFO - PID 23927 | Cycle 1(1): loaded http://localhost:58215/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58215/tests/kraken/driver.html?testName=json-parse-financial) 09:04:43 INFO - PID 23927 | RSS: Main: 233906176 09:04:43 INFO - PID 23927 | 09:04:44 INFO - PID 23927 | Cycle 1(1): loaded http://localhost:58215/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58215/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:04:45 INFO - PID 23927 | RSS: Main: 177963008 09:04:45 INFO - PID 23927 | 09:04:46 INFO - PID 23927 | Cycle 1(1): loaded http://localhost:58215/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58215/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:04:47 INFO - PID 23927 | RSS: Main: 184229888 09:04:47 INFO - PID 23927 | 09:04:49 INFO - PID 23927 | Cycle 1(1): loaded http://localhost:58215/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58215/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:04:50 INFO - PID 23927 | RSS: Main: 193957888 09:04:50 INFO - PID 23927 | 09:04:52 INFO - PID 23927 | Cycle 1(1): loaded http://localhost:58215/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58215/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:04:53 INFO - PID 23927 | RSS: Main: 203292672 09:04:53 INFO - PID 23927 | 09:04:56 INFO - PID 23927 | Cycle 1(1): loaded http://localhost:58215/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58215/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:04:57 INFO - PID 23927 | RSS: Main: 200183808 09:04:57 INFO - PID 23927 | 09:04:58 INFO - PID 23927 | Cycle 1(1): loaded http://localhost:58215/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58215/tests/kraken/driver.html?testName=ai-astar) 09:04:59 INFO - PID 23927 | RSS: Main: 269004800 09:04:59 INFO - PID 23927 | 09:04:59 INFO - PID 23927 | __start_tp_report 09:04:59 INFO - PID 23927 | _x_x_mozilla_page_load 09:04:59 INFO - PID 23927 | _x_x_mozilla_page_load_details 09:04:59 INFO - PID 23927 | |i|pagename|runs| 09:04:59 INFO - PID 23927 | |0;ai-astar;100;109;109;110;109;109;110;112;109;108 09:04:59 INFO - PID 23927 | |1;audio-beat-detection;151;121;117;151;118;118;118;121;138;123 09:04:59 INFO - PID 23927 | |2;audio-dft;162;172;161;162;160;162;162;160;162;162 09:04:59 INFO - PID 23927 | |3;audio-fft;74;76;74;110;74;74;75;73;92;74 09:04:59 INFO - PID 23927 | |4;audio-oscillator;83;83;110;83;82;82;96;82;82;111 09:04:59 INFO - PID 23927 | |5;imaging-gaussian-blur;113;113;113;113;113;113;113;113;112;113 09:04:59 INFO - PID 23927 | |6;imaging-darkroom;147;148;149;146;147;146;148;146;146;147 09:04:59 INFO - PID 23927 | |7;imaging-desaturate;94;93;94;94;94;94;94;94;94;94 09:04:59 INFO - PID 23927 | |8;json-parse-financial;58;56;56;57;58;59;58;59;57;58 09:04:59 INFO - PID 23927 | |9;json-stringify-tinderbox;55;56;55;55;55;55;55;55;56;55 09:04:59 INFO - PID 23927 | |10;stanford-crypto-aes;81;82;82;80;79;80;80;79;79;81 09:04:59 INFO - PID 23927 | |11;stanford-crypto-ccm;128;134;125;135;127;126;126;126;174;129 09:04:59 INFO - PID 23927 | |12;stanford-crypto-pbkdf2;183;189;185;184;184;181;186;181;186;183 09:04:59 INFO - PID 23927 | |13;stanford-crypto-sha256-iterative;65;65;65;64;67;63;66;63;67;63 09:04:59 INFO - PID 23927 | __end_tp_report 09:04:59 INFO - PID 23927 | __start_cc_report 09:04:59 INFO - PID 23927 | _x_x_mozilla_cycle_collect,1729 09:04:59 INFO - PID 23927 | __end_cc_report 09:04:59 INFO - PID 23927 | __startTimestamp1490198699108__endTimestamp 09:04:59 INFO - PID 23927 | 09:04:59 INFO - PID 23927 | ------- Summary: start ------- 09:04:59 INFO - PID 23927 | Number of tests: 14 09:04:59 INFO - PID 23927 | 09:04:59 INFO - PID 23927 | [#0] ai-astar Cycles:10 Average:108.50 Median:109.00 stddev:3.17 (2.9%) stddev-sans-first:1.13 09:04:59 INFO - PID 23927 | Values: 100.0 109.0 109.0 110.0 109.0 109.0 110.0 112.0 109.0 108.0 09:04:59 INFO - PID 23927 | 09:04:59 INFO - PID 23927 | [#1] audio-beat-detection Cycles:10 Average:127.60 Median:122.00 stddev:13.75 (11.3%) stddev-sans-first:11.68 09:04:59 INFO - PID 23927 | Values: 151.0 121.0 117.0 151.0 118.0 118.0 118.0 121.0 138.0 123.0 09:04:59 INFO - PID 23927 | 09:04:59 INFO - PID 23927 | [#2] audio-dft Cycles:10 Average:162.50 Median:162.00 stddev:3.44 (2.1%) stddev-sans-first:3.64 09:04:59 INFO - PID 23927 | Values: 162.0 172.0 161.0 162.0 160.0 162.0 162.0 160.0 162.0 162.0 09:04:59 INFO - PID 23927 | 09:04:59 INFO - PID 23927 | [#3] audio-fft Cycles:10 Average:79.60 Median:74.00 stddev:12.08 (16.3%) stddev-sans-first:12.64 09:04:59 INFO - PID 23927 | Values: 74.0 76.0 74.0 110.0 74.0 74.0 75.0 73.0 92.0 74.0 09:04:59 INFO - PID 23927 | 09:04:59 INFO - PID 23927 | [#4] audio-oscillator Cycles:10 Average:89.40 Median:82.50 stddev:11.91 (14.4%) stddev-sans-first:12.40 09:04:59 INFO - PID 23927 | Values: 83.0 83.0 110.0 83.0 82.0 82.0 96.0 82.0 82.0 111.0 09:04:59 INFO - PID 23927 | 09:04:59 INFO - PID 23927 | [#5] imaging-gaussian-blur Cycles:10 Average:112.90 Median:113.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 09:04:59 INFO - PID 23927 | Values: 113.0 113.0 113.0 113.0 113.0 113.0 113.0 113.0 112.0 113.0 09:04:59 INFO - PID 23927 | 09:04:59 INFO - PID 23927 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:1.05 (0.7%) stddev-sans-first:1.12 09:04:59 INFO - PID 23927 | Values: 147.0 148.0 149.0 146.0 147.0 146.0 148.0 146.0 146.0 147.0 09:04:59 INFO - PID 23927 | 09:04:59 INFO - PID 23927 | [#7] imaging-desaturate Cycles:10 Average:93.90 Median:94.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 09:04:59 INFO - PID 23927 | Values: 94.0 93.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 09:04:59 INFO - PID 23927 | 09:04:59 INFO - PID 23927 | [#8] json-parse-financial Cycles:10 Average:57.60 Median:58.00 stddev:1.07 (1.9%) stddev-sans-first:1.13 09:04:59 INFO - PID 23927 | Values: 58.0 56.0 56.0 57.0 58.0 59.0 58.0 59.0 57.0 58.0 09:04:59 INFO - PID 23927 | 09:04:59 INFO - PID 23927 | [#9] json-stringify-tinderbox Cycles:10 Average:55.20 Median:55.00 stddev:0.42 (0.8%) stddev-sans-first:0.44 09:04:59 INFO - PID 23927 | Values: 55.0 56.0 55.0 55.0 55.0 55.0 55.0 55.0 56.0 55.0 09:04:59 INFO - PID 23927 | 09:04:59 INFO - PID 23927 | [#10] stanford-crypto-aes Cycles:10 Average:80.30 Median:80.50 stddev:1.16 (1.4%) stddev-sans-first:1.20 09:04:59 INFO - PID 23927 | Values: 81.0 82.0 82.0 80.0 79.0 80.0 80.0 79.0 79.0 81.0 09:04:59 INFO - PID 23927 | 09:04:59 INFO - PID 23927 | [#11] stanford-crypto-ccm Cycles:10 Average:133.00 Median:128.50 stddev:14.81 (11.5%) stddev-sans-first:15.60 09:04:59 INFO - PID 23927 | Values: 128.0 134.0 125.0 135.0 127.0 126.0 126.0 126.0 174.0 129.0 09:04:59 INFO - PID 23927 | 09:04:59 INFO - PID 23927 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:184.20 Median:184.50 stddev:2.44 (1.3%) stddev-sans-first:2.55 09:04:59 INFO - PID 23927 | Values: 183.0 189.0 185.0 184.0 184.0 181.0 186.0 181.0 186.0 183.0 09:04:59 INFO - PID 23927 | 09:04:59 INFO - PID 23927 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.80 Median:65.00 stddev:1.55 (2.4%) stddev-sans-first:1.64 09:04:59 INFO - PID 23927 | Values: 65.0 65.0 65.0 64.0 67.0 63.0 66.0 63.0 67.0 63.0 09:04:59 INFO - PID 23927 | -------- Summary: end -------- 09:04:59 INFO - PID 23927 | 09:05:00 INFO - TEST-INFO | 23927: exit 0 09:05:00 INFO - TEST-OK | kraken | took 61160ms 09:05:00 INFO - SUITE-END | took 1178s 09:05:00 INFO - Completed test suite (00:19:38) 09:05:00 INFO - javascript benchmark 09:05:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7398.71141176497, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3270.1661076425517, 3289.309245058539, 3315.0386387947497, 3318.5851768528933, 3348.9665103348975, 5705.2012718219485, 5788.681622510766, 5802.535797136229, 5807.854803629912, 5809.099589563619, 5706.800261990831, 5728.513076388502, 5735.684537350444, 5783.132530120484, 5870.970645146768, 5139.383274007125, 5207.3490813648195, 5239.973800130994, 5240.816571420001, 5276.445973172819, 5238.738063096849, 5241.633085684004, 5253.3170687810725, 5255.316808814849, 5255.842324730264, 5092.0, 5119.308893299394, 5148.6910785353, 5162.148245539482, 5194.610404219679, 5217.947820521784, 5260.0, 5275.973620131875, 5302.019126461579, 5304.416514183436, 5144.022635699205, 5196.246544251062, 5200.97399513, 5204.76578553966, 5260.13207820713, 5633.943660563424, 5788.131780232957, 5800.506956908668, 5801.82594522165, 5803.767849286023, 6137.775380989496, 6143.788236234952, 6153.815385538441, 6157.107219453154, 6210.751569937197, 6243.687815609247, 6249.0, 6260.373962603749, 6266.811995640092, 6268.623882567015, 5720.0, 5819.156222347736, 5829.679367634821, 5836.620619659709, 5868.061110222344, 6201.937980620226, 6274.435300822948, 6357.904631430532, 6374.745010199633, 6381.1385462962835, 6184.938150618526, 6196.535259855529, 6203.8138855834395, 6209.441150296405, 6215.378462153749, 6309.495240380758, 6311.842203944846, 6314.747410103544, 6318.115463835067, 6320.8419789504715, 6102.69486525672, 6120.569035656853, 6165.753369865245, 6290.339514351019, 6296.087067375205, 6184.319724830265, 6241.906371404432, 6252.968735156295, 6261.123442718023, 6271.059341098871, 4762.0, 4762.214234651313, 4762.59517940972, 4794.424669039738, 4806.014766972762, 4216.536181020086, 4224.155168966219, 4234.2801723706425, 4239.173361194537, 4272.316429371348, 5655.575831812631, 5671.092625179951, 5822.155787410802, 5878.11828225761, 5885.823425297248, 6214.0, 6264.59280146789, 6264.812055638247, 6271.905921411182, 6273.1844860167885, 5793.246877905845, 5799.0, 5800.390958949334, 5805.709714514257, 5841.386654401312, 5162.432132465426, 5223.817166399233, 5285.233641122093, 5285.286486324374, 5322.627416080914, 6434.292227854932, 6491.51313651478, 6499.155109835691, 6500.187476565335, 6503.674816259263, 6145.201123853871, 6216.751329946932, 6233.719482623384, 6257.436830685078, 6286.7799627014665, 6397.944339183982, 6463.3213512580505, 6469.547131700736, 6473.449756770538, 6488.0, 6114.419130182626, 6156.230471191101, 6158.568900176944, 6168.414000669929, 6169.259688837368, 6135.969320153371, 6312.368763123651, 6323.399277068671, 6327.145835312358, 6330.335314791881, 6034.39656034393, 6056.121862329849, 6077.0, 6079.696015199134, 6097.908531372122, 6045.818625441244, 6090.390960903874, 6092.482139018233, 6100.298465676504, 6102.786402475892, 6052.0, 6082.452579267887, 6083.330833608388, 6100.969495152496, 6104.236970378703, 6006.549508786771, 6061.121137434959, 6066.636001839904, 6070.0, 6091.416231779681, 6016.699165041818, 6019.428154325332, 6027.487663548647, 6047.848803779941, 6066.636001839904], "value": 5718.478555382083, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [722.458156382713, 796.0566728426815, 812.3135950122148, 1122.326604037577, 1134.8865113488657, 28738.42523149536, 35094.0, 35646.46530302044, 35738.0, 35990.280194396095, 37467.43798843013, 37872.621273787256, 38240.42639360412, 38303.808480957625, 38312.0, 6045.214122164112, 6197.03945888388, 7963.243491868263, 8131.959340203291, 8256.133106023872, 7848.175941526143, 8055.7583272501915, 8059.0, 8060.476069055522, 8100.432969692124, 8145.918540814605, 8237.423380363376, 8257.133001034896, 8258.0, 8259.339252859787, 8294.37792165587, 8340.833183336359, 8347.165283471664, 8349.499030058216, 8355.540445275508, 7864.05631324239, 7886.329661978739, 7915.960420197862, 7928.207179282083, 7930.206979302081, 40089.59910400888, 40180.39729404061, 40306.395404068964, 40376.59623403758, 40378.0, 2962.0817546560634, 2983.0603359941765, 2991.1176203020163, 2991.3718119194996, 3025.258811591152, 27496.0, 27537.724622753718, 27581.31046723828, 27890.816377543328, 28042.719572804213, 3579.7315201359743, 3596.3886139356373, 3605.152789094561, 3616.801075940822, 3644.817759112034, 188454.0, 189488.0, 189731.99999999863, 189871.0, 190473.0, 46774.0, 46816.0, 46823.84937656855, 46830.29754553684, 46861.76569117133, 49561.50438495641, 49676.75161624241, 49735.25397119046, 49920.50079499231, 49980.250296244856, 14071.507497237548, 14219.85780142206, 14247.073940193854, 14257.714845703027, 14261.928690356483, 9452.43285402878, 9577.329586928987, 10905.0, 11274.210805243718, 11301.0, 13959.720805583831, 14274.643133921527, 14291.285435728172, 14386.28068596566, 14450.710985780226, 5763.769449222068, 5782.971085144547, 5816.098504731774, 5872.471477567039, 5881.2942446906645, 1016.9288149829441, 1040.1990467340106, 1048.119579553179, 1057.413135709673, 1066.248294952057, 24353.391165220655, 25009.249722508353, 25083.498330033297, 25100.497990040098, 25147.62278565823, 1129.8474705914596, 1136.3466007045981, 1137.4824454873012, 1151.9712007199719, 1160.4197901049474, 12686.80969785454, 12965.870341296466, 13137.408816603276, 13145.145565538209, 13151.145175563557, 336136.0, 336692.0, 338872.0, 338992.0, 339000.0, 55079.0, 55394.16908746372, 55410.303196940375, 55468.44531554633, 55495.722521387135, 1426.18707336817, 1479.6744716162427, 1484.7327481053298, 1505.6160679026777, 1511.5012046024785, 23029.193978210682, 24306.63540046936, 24361.26916192517, 24362.28088847566, 24374.87812560926, 38071.428928566645, 38116.618833811306, 38313.4252986211, 38332.80833595814, 38376.232475350895, 278794.0, 279154.20845791284, 279344.0, 279719.0, 279783.0, 25737.227883163534, 25795.32330398518, 34109.0, 34173.82913085419, 34328.31343373169, 35880.64119358773, 36380.726674566264, 36424.0, 36731.0, 37399.62600373961, 30177.245568860955, 30866.228344291572, 30894.53658195084, 31118.688813111577, 32413.513797292588, 30274.394512110073, 30306.0, 30677.846610766803, 30696.232594185323, 31890.0, 32274.838625806722, 32968.0, 33084.834575826964, 34470.0, 35555.11112222215, 27592.172234832986, 29532.0, 29695.0, 29946.0, 30390.240243994078, 25376.492470150864, 26503.204903852915, 26543.469130617665, 26608.07110828914, 26765.464690706467], "value": 16997.588859157546, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [381.82699321033294, 436.4130244820716, 436.556894751827, 458.73622666966503, 458.9977050114749, 18266.90866545667, 18971.905140474297, 19518.414447566578, 19571.0, 19704.0, 20640.1743930243, 21118.89440552799, 21364.145434182614, 21906.23328183514, 21993.450163745874, 5919.200907877446, 6039.849003774919, 6086.573939824214, 6103.26760788706, 6104.053871649901, 5666.206731057655, 6001.60989535681, 6002.669853158096, 6008.939910600903, 6012.699365031731, 5716.314042314907, 5999.280086389639, 6002.939970600303, 6007.339192688801, 6013.639181649093, 5907.852303692399, 5998.070299103646, 6016.308124565688, 6016.368281330485, 6017.578769486137, 5359.892802143935, 5389.892202155974, 5418.4039755626845, 5418.674879507203, 5419.566434685255, 24656.753432465626, 24696.629550556576, 24833.255002349957, 24886.50226995468, 24977.750222497725, 2000.5298754792611, 2001.8798872067723, 2004.8095430934038, 2027.0675489274952, 2058.207590077831, 15115.924420377938, 15266.923665381713, 15273.465428710053, 15506.0, 15990.680186396323, 1862.6833438315518, 1885.1705249690092, 1893.422506135628, 1925.6918892977055, 1946.9221231150736, 101248.0, 104026.0, 104410.0, 107917.0, 109599.90400095977, 10931.453427328603, 12186.634400967985, 12466.501339946482, 12502.24950510886, 12762.489500420064, 15354.692906142038, 16370.263338149813, 16586.0, 16672.249748761336, 16764.664706705797, 8404.285635721033, 8486.0665326814, 8584.785380365416, 8679.305655547541, 8710.085441028728, 7823.647935842901, 7923.6830526778285, 7952.0457545093805, 8090.797730056678, 8096.352291816641, 7737.535747855147, 7908.090569584457, 7910.841783164305, 7975.162607926084, 8007.398520295964, 2206.3491270075365, 2220.8112310453794, 2262.6379779235244, 2263.9094436222695, 2313.2250696016686, 967.7483854197959, 974.7758015656439, 997.8303688372849, 1007.9244056695777, 1011.5397494140149, 19561.413157605293, 20007.099680514413, 20108.296209632594, 20278.69581956272, 20318.0, 1018.3991445047458, 1023.698009087321, 1024.959001639926, 1030.5929157982705, 1030.644427672452, 9898.686266970913, 10897.333705312669, 10900.360383743728, 10902.400367979837, 10958.616448424425, 296823.0, 301415.0, 494130.0, 661986.0, 670524.0, 103911.4804425973, 105248.47375763225, 105483.0, 107054.0, 108688.0, 1118.424011634009, 1150.988490115088, 1183.508843829801, 1193.928364298145, 1195.49789088583, 15970.9201453992, 16691.749623755895, 16839.66320673604, 16956.745648815526, 16964.575885602957, 45094.549054510346, 46448.53551464442, 46675.0, 46751.766241168574, 47347.844780178355, 61450.0, 62923.0, 63421.36578634154, 63829.0, 64676.67661661661, 8670.91329086701, 8895.288376929959, 8928.910710892807, 9067.727968160965, 9265.397749146285, 13622.455101795817, 13805.447782088604, 13841.307934603028, 13965.835295529208, 14276.643083922985, 10986.242201248082, 11463.828042579202, 11679.416029198675, 11695.298282103102, 12279.69300767488, 11789.233699809485, 11857.940710296738, 12271.815922761345, 12495.625131246077, 12631.431585578488, 12147.574834880737, 12269.87730122723, 12270.509179632714, 12276.079294053161, 12345.321007344683, 8800.427972181787, 8964.193222609736, 9031.548422578977, 9171.495567743572, 9214.216791572791, 11615.30308181478, 11807.527698892292, 11888.34614096233, 11916.702082448008, 12316.445759940645], "value": 9902.210051045839, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1269.3272565540265, 1323.7948118041706, 1324.668832791802, 1329.995853130886, 1349.696318328376, 10213.489325533721, 10588.258821882451, 10631.574737010511, 10635.042846143846, 10638.680839574816, 10336.586536538529, 10644.095251903598, 10909.0, 10960.725981850457, 10980.945095274512, 2202.48241663209, 2249.3589327041796, 2250.7636698146703, 2251.6059689554345, 2251.7072780538506, 1838.3473866777301, 2062.669972804352, 2123.458518077888, 2130.3182981445943, 2130.872147671137, 1921.4043646469638, 2093.424308315218, 2174.0760176924823, 2176.3906106290265, 2177.074743234119, 2090.216168936649, 2096.6330892093824, 2100.222917520512, 2110.9788902110936, 2114.7885211478883, 2047.1708957872086, 2107.1360742095667, 2107.1782005018053, 2108.0513768803944, 2110.9894450527804, 11012.17408694343, 11080.390578518178, 11090.112790976702, 11096.0, 11109.72225694356, 6013.789517366871, 6175.845603859894, 6200.224971878515, 6203.162573052626, 6206.603514209267, 3548.769329993542, 3602.621724718893, 3860.478835357219, 3878.7866667333287, 3891.0272431892026, 1298.7727147749106, 1307.9869201308056, 1319.5051855554168, 1357.945682172712, 1382.260490637514, 16193.595160120973, 16257.10585917774, 16308.429204977769, 16308.75536866948, 16313.102779347131, 4862.95137048625, 5087.516685914832, 5160.716160611202, 5223.52988231061, 5278.788848446096, 12097.697557561132, 12119.091068169746, 12126.211796233216, 12136.211146275464, 12196.207246528948, 6105.8473538161015, 6110.572259941761, 6120.8163755086525, 6134.6625935573975, 6144.2319710036245, 5598.160275958558, 5670.943290567124, 5684.062129748628, 5713.600047996601, 5729.427057294237, 3994.5365550160204, 4062.695297852673, 4082.1835632873544, 4087.5912408758886, 4106.281400754856, 1140.914431417647, 1163.406662602079, 1166.8949794518535, 1179.628417048627, 1185.82805493203, 618.5330075792838, 775.4726785785607, 806.7173194620582, 807.4993504027541, 807.9555624440594, 6025.15647809307, 6325.746970121144, 6389.105525226472, 6428.132202152743, 6613.570117942415, 922.9215516681023, 933.9859902101474, 941.6798288581915, 963.8313295173317, 972.9221662267001, 3879.592642772525, 3924.7252692311263, 3951.68386529077, 4074.083331250445, 4085.3667681509414, 14256.501022464165, 14741.778873316909, 14744.96785225024, 14753.704925901422, 14754.409823606935, 14227.857721422653, 14334.993100965874, 14390.496332628518, 14418.351174197187, 14419.927900360432, 9957.302988790716, 10377.221708371902, 10508.632197873038, 10514.947425262671, 10534.420606866695, 6303.243610766737, 6450.7097180627925, 6457.031445283245, 6471.126397936218, 6490.123833282447, 12622.116451848282, 12989.805152922903, 13030.218186908816, 13065.216087034809, 13075.60773176768, 13006.609801705965, 13028.739425211254, 13170.80243796363, 13300.201987880759, 13443.327833608086, 8541.188587084218, 8676.783080422787, 8684.609192586222, 8747.737567872973, 8755.255803256794, 9878.110970012733, 9884.11043006133, 9906.752331191778, 9963.25275604347, 10029.548670309707, 8605.827883442422, 8791.208791208823, 8902.0, 8902.910970890209, 9051.54742262871, 8804.867926980973, 8945.776355590902, 8963.865542016745, 8973.641054357753, 9080.137386948229, 7559.735409260649, 7618.123915749759, 7716.2669546393, 7717.0, 7725.5364678119495, 5920.644761314335, 5949.464548190511, 5986.9401305986385, 6244.875102498016, 6267.96866015667, 5779.653220806765, 5811.883762324815, 5838.474537291664, 5944.078667806497, 5970.462658360769], "value": 5102.230280653328, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [397.93434083376246, 413.45630495897893, 426.8996785755347, 430.81905599648167, 435.71460693245916, 5630.971845140769, 5786.82639520814, 5800.506956908663, 5807.186993820868, 5870.941290587088, 5601.831945041656, 5759.337676167242, 5789.507891829189, 5792.739326730297, 5844.707764611774, 4622.214223581982, 4649.163150632885, 4659.370984917026, 4660.207764679995, 4672.252439609663, 4543.250363689987, 4636.652251081166, 4665.113628410608, 4670.439547254335, 4674.439067311911, 4574.1080489304595, 4595.425571803525, 4595.448546174463, 4597.747123908183, 4601.263797792354, 4600.286955521866, 4613.423322084739, 4620.607248383892, 4623.0, 4625.398698169233, 4006.399040143973, 4153.1070819773595, 4178.22702799983, 4208.095259519218, 4221.810018549173, 5683.829485115453, 5719.370869204426, 5726.3700992890745, 5761.827145185651, 5762.3373312069225, 5457.754401051962, 5471.0, 5474.644148130359, 5481.095619222863, 5496.450354964471, 6148.0, 6237.0, 6243.906341404882, 6255.718492667841, 6295.0, 4667.883302917454, 4669.369635099252, 4669.777853281225, 4687.906241875144, 4693.131770622445, 6403.263624683174, 6512.511561632897, 6520.282768895418, 6544.574602650765, 6602.504812139109, 4808.374911261513, 4813.518648135228, 4841.443234028062, 4842.15262329091, 4846.0, 4877.6829506081995, 4896.730679812573, 4901.289313049588, 4924.630652701062, 4930.704157750546, 5216.347956505437, 5401.5948803839865, 5417.10617748075, 5437.619366644376, 5451.236826844245, 5874.765009399576, 6263.812085637438, 6265.122882796412, 6265.310815810257, 6277.309495955441, 1609.340170530077, 1631.3474610156034, 1682.2093616000461, 1689.4087069525813, 1691.4756425508133, 1175.535663412947, 1209.8790120988008, 1210.8304837322783, 1217.7747116783423, 1220.713132413882, 5885.117232415087, 5900.262467191601, 5903.822885313448, 5931.317898441648, 5931.7923872665115, 6346.174997250328, 6352.522516218678, 6375.936240637627, 6391.552591318563, 6394.936050639527, 5781.5952883298605, 5794.739236734357, 5901.616394934315, 5908.0, 5916.319623243296, 3347.5313456116164, 3367.107716455141, 3389.3729660012978, 3397.2695870387984, 3402.1154499829727, 6227.875442491216, 6518.73925042993, 6546.541742078009, 6598.60408375499, 6613.173353330833, 6508.958566629317, 6510.316416776265, 6510.804675859732, 6549.803505894831, 6566.146400967844, 6279.340669229757, 6523.739050438119, 6525.282218955911, 6587.176602924635, 6597.80206593803, 6315.368463153832, 6343.746250149942, 6384.553081284265, 6395.0, 6405.647689376942, 6197.411245931629, 6217.906731399123, 6272.937270627235, 6276.403741644536, 6287.685615719287, 6430.196225471816, 6493.188351456068, 6513.283538810632, 6516.73933042673, 6521.445677117498, 4497.370368148528, 4498.820047198075, 4498.820047198206, 4515.75163366018, 4526.366308716848, 6197.692603640607, 6326.620402775849, 6360.268569114426, 6380.840478988062, 6414.711337989895, 6225.937740622536, 6230.906536401867, 6233.127362169391, 6238.594491358047, 6255.18682571281, 6028.638281703112, 6218.253809542884, 6222.346653601307, 6243.531735119975, 6255.937440625536, 6188.876222475616, 6196.676246407597, 6207.224096987877, 6230.563860529719, 6235.812925612239, 6167.414095660905, 6178.536609754196, 6249.562530622995, 6262.373762623702, 6269.592476489013, 5753.280839895013, 6033.698315084141, 6064.423879731418, 6097.2988106366565, 6125.111858780363], "value": 4803.772719615294, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [739.6080077558893, 745.4409193105171, 748.4162353364371, 751.6054071612405, 752.3417010116148, 13314.334283285845, 13726.656833579165, 13732.0, 13753.724925501496, 13839.51561695341, 13377.93311033446, 13402.46390144393, 13556.32218389079, 13561.457541698344, 13896.51362202323, 801.7474495533917, 806.5402720449346, 824.8391563645091, 830.1822704635929, 834.5368320582074, 819.0, 821.2444551013082, 821.4208982667235, 822.1244374740882, 822.3503432288485, 864.8313578852126, 868.4745728834059, 870.6647940542873, 871.1984973824098, 872.0276891266225, 861.0614430271004, 862.3446180902497, 863.404251066762, 864.006392648453, 867.2108381372952, 630.5932673425615, 633.9524535659843, 634.6414275934083, 634.8952422850224, 639.8976163813768, 13453.0, 13762.24307663078, 13777.517786877512, 13786.448542058306, 14021.0, 13823.723525529433, 14360.425582976668, 14461.49384771528, 14523.0, 14595.124292542481, 11430.188847893809, 11577.189596728233, 11650.6504804856, 11665.300081995107, 12071.517139314417, 3036.225762430588, 3056.5415187721796, 3063.5711000459955, 3068.5243787212794, 3191.0745883693935, 83797.16202837955, 85097.14902850954, 85637.57181214116, 85754.14245857524, 85758.14241857563, 10368.222383321281, 10414.427206503715, 10576.20678449104, 10639.095676867399, 10679.572817087384, 21945.231916882833, 22172.0, 22234.332970010924, 22434.10263589471, 22484.98817553214, 7393.0, 7403.296686814744, 7421.666025028887, 7441.107067151868, 7565.0, 3891.5524714658177, 3966.5438474575217, 4009.578994205625, 4103.4460347853255, 4108.281050816096, 4036.737612055207, 4079.673626109904, 4084.571120032354, 4085.4484644572603, 4108.630223279919, 731.41648331362, 735.7204262380261, 737.3916518871952, 738.243300616872, 741.9146798118178, 600.4865839706988, 618.9597676151036, 622.5766478794372, 627.5087901032892, 652.55952232244, 9265.583048762686, 9335.159835614828, 9342.813143737087, 9727.513624318755, 9828.262880284008, 598.4524160393279, 600.6816387314731, 624.1823211592828, 629.2291942370651, 648.0, 4762.904741905142, 4872.439669437989, 4887.79939635925, 4894.987121061975, 4931.087748766489, 74166.62916685382, 74778.39162062867, 76273.0, 76305.23694762982, 79491.0, 57449.712751435974, 58082.09589520507, 61979.690101550106, 70346.64826675833, 70570.64714676393, 57039.0, 57181.42818571844, 58135.70932145397, 58844.117338239106, 59468.405315946286, 10021.699349019542, 10342.689719308433, 10459.0, 10544.15646748243, 10633.468326583794, 31105.222369440038, 31311.84344078265, 31382.215444614067, 31681.84159079282, 32007.0, 39070.80464597659, 39320.0, 48379.5162048375, 55555.444445555026, 56613.433865660816, 12055.57805476804, 12527.436265368262, 12580.874191258337, 12715.364231788559, 12926.741465170831, 12822.679433013876, 13154.408051637507, 13166.210027398387, 13246.47122692707, 13639.727205455636, 12347.69130771738, 12624.74750505003, 12803.807942880678, 12891.677708057374, 13557.095732559848, 12182.451789669309, 12278.14053016316, 12535.435905384462, 12740.490380385052, 13687.657808554866, 11688.88311116878, 12039.75920481568, 12326.100988034144, 12349.691257718629, 12442.0, 11607.0, 11789.065027499397, 11955.581554645545, 12115.663082258896, 12627.11610187278, 10606.628767993083, 11310.773784524428, 11864.22882512634, 12015.639530814089, 12199.0], "value": 6952.851050313774, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1496.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 109.0, 109.0, 110.0, 109.0, 109.0, 110.0, 112.0, 109.0, 108.0], "value": 108.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 121.0, 117.0, 151.0, 118.0, 118.0, 118.0, 121.0, 138.0, 123.0], "value": 127.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 172.0, 161.0, 162.0, 160.0, 162.0, 162.0, 160.0, 162.0, 162.0], "value": 162.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 74.0, 110.0, 74.0, 74.0, 75.0, 73.0, 92.0, 74.0], "value": 79.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 110.0, 83.0, 82.0, 82.0, 96.0, 82.0, 82.0, 111.0], "value": 89.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 113.0, 113.0, 113.0, 113.0, 113.0, 113.0, 112.0, 113.0], "value": 112.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 149.0, 146.0, 147.0, 146.0, 148.0, 146.0, 146.0, 147.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0], "value": 93.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 56.0, 56.0, 57.0, 58.0, 59.0, 58.0, 59.0, 57.0, 58.0], "value": 57.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 55.0, 55.0, 55.0, 55.0, 55.0, 55.0, 56.0, 55.0], "value": 55.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 82.0, 80.0, 79.0, 80.0, 80.0, 79.0, 79.0, 81.0], "value": 80.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 134.0, 125.0, 135.0, 127.0, 126.0, 126.0, 126.0, 174.0, 129.0], "value": 133.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 189.0, 185.0, 184.0, 184.0, 181.0, 186.0, 181.0, 186.0, 183.0], "value": 184.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 64.0, 67.0, 63.0, 66.0, 63.0, 67.0, 63.0], "value": 64.8, "unit": "score"}]}]} 09:05:00 INFO - Return code: 0 09:05:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:05:00 ERROR - # TBPL SUCCESS # 09:05:00 INFO - Running post-action listener: _resource_record_post_action 09:05:00 INFO - [mozharness: 2017-03-22 16:05:00.412245Z] Finished run-tests step (success) 09:05:00 INFO - Running post-run listener: _resource_record_post_run 09:05:00 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 0; Write bytes: 369725440; Read time: 0; Write time: 233552 09:05:00 INFO - TinderboxPrint: CPU usage
12.9% 09:05:00 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 09:05:00 INFO - TinderboxPrint: I/O write bytes / time
369,725,440 / 233,552 09:05:00 INFO - TinderboxPrint: CPU idle
8,307.6 (87.1%) 09:05:00 INFO - TinderboxPrint: CPU user
1,187.5 (12.4%) 09:05:00 INFO - TinderboxPrint: Swap in / out
0 / 0 09:05:00 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 110604288; Read time: 0; Write time: 77056 09:05:00 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 0; Write bytes: 259121152; Read time: 0; Write time: 156496 09:05:01 INFO - Running post-run listener: _upload_blobber_files 09:05:01 INFO - Blob upload gear active. 09:05:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:05:01 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 09:05:01 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:05:01 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:05:01 INFO - (blobuploader) - INFO - Open directory for files ... 09:05:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:05:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:05:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:05:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:05:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:05:02 INFO - (blobuploader) - INFO - Done attempting. 09:05:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:05:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:05:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:05:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:05:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:05:03 INFO - (blobuploader) - INFO - Done attempting. 09:05:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:05:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:05:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:05:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:05:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:05:06 INFO - (blobuploader) - INFO - Done attempting. 09:05:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:05:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:05:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:05:07 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:05:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:05:07 INFO - (blobuploader) - INFO - Done attempting. 09:05:07 INFO - (blobuploader) - INFO - Iteration through files over. 09:05:07 INFO - Return code: 0 09:05:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:05:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:05:07 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/35d07e747545fdf6c04849dc31e7d9119199215e6f724b15d4fe3ab8fbaaebfc8933654e03a24b7c89aad5e3af4635b55dd3de26e3e49072daab229ad1b8ae61", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7d28556a65641a0ce25afffb6c7fe9afb8b1b5d5a5a5b126f466d58e96b6a1e19a7e4fa48a91fb520bba9892469bc80d0c24949df4148932c4b0ae805c31fed2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/585cfccc9603cf70ba99621ac27fe6592c0fb071e7960164c52e7cc54a4a3d4a2c1c351e61c35fdedc25735b3f667d7b0bebc04ef5c9086a3c8f43651e54e77f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7a1f6063abc8b9a39644905a151abffb7b365c275e890a706fa8425a063e6d8eb60b67ae3e1dcd9350684e619cbc658561a89619f5c601f6633f029bde1513d6"} 09:05:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:05:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:05:07 INFO - Contents: 09:05:07 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/35d07e747545fdf6c04849dc31e7d9119199215e6f724b15d4fe3ab8fbaaebfc8933654e03a24b7c89aad5e3af4635b55dd3de26e3e49072daab229ad1b8ae61", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7d28556a65641a0ce25afffb6c7fe9afb8b1b5d5a5a5b126f466d58e96b6a1e19a7e4fa48a91fb520bba9892469bc80d0c24949df4148932c4b0ae805c31fed2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/585cfccc9603cf70ba99621ac27fe6592c0fb071e7960164c52e7cc54a4a3d4a2c1c351e61c35fdedc25735b3f667d7b0bebc04ef5c9086a3c8f43651e54e77f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7a1f6063abc8b9a39644905a151abffb7b365c275e890a706fa8425a063e6d8eb60b67ae3e1dcd9350684e619cbc658561a89619f5c601f6633f029bde1513d6"} 09:05:07 INFO - Running post-run listener: copy_logs_to_upload_dir 09:05:07 INFO - Copying logs to upload dir... 09:05:07 INFO - mkdir: /builds/slave/test/build/upload/logs 09:05:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.101684 ========= master_lag: 0.27 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-03-22 09:05:07.191793) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-22 09:05:07.195689) ========= 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=41bf3e9aed84707956354da8000001c5-1490197451.206139-910668056 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/35d07e747545fdf6c04849dc31e7d9119199215e6f724b15d4fe3ab8fbaaebfc8933654e03a24b7c89aad5e3af4635b55dd3de26e3e49072daab229ad1b8ae61", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7d28556a65641a0ce25afffb6c7fe9afb8b1b5d5a5a5b126f466d58e96b6a1e19a7e4fa48a91fb520bba9892469bc80d0c24949df4148932c4b0ae805c31fed2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/585cfccc9603cf70ba99621ac27fe6592c0fb071e7960164c52e7cc54a4a3d4a2c1c351e61c35fdedc25735b3f667d7b0bebc04ef5c9086a3c8f43651e54e77f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7a1f6063abc8b9a39644905a151abffb7b365c275e890a706fa8425a063e6d8eb60b67ae3e1dcd9350684e619cbc658561a89619f5c601f6633f029bde1513d6"} build_url:https://queue.taskcluster.net/v1/task/exjF_Lr0R1qiOfiOZfgSEA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011451 build_url: 'https://queue.taskcluster.net/v1/task/exjF_Lr0R1qiOfiOZfgSEA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/35d07e747545fdf6c04849dc31e7d9119199215e6f724b15d4fe3ab8fbaaebfc8933654e03a24b7c89aad5e3af4635b55dd3de26e3e49072daab229ad1b8ae61", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7d28556a65641a0ce25afffb6c7fe9afb8b1b5d5a5a5b126f466d58e96b6a1e19a7e4fa48a91fb520bba9892469bc80d0c24949df4148932c4b0ae805c31fed2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/585cfccc9603cf70ba99621ac27fe6592c0fb071e7960164c52e7cc54a4a3d4a2c1c351e61c35fdedc25735b3f667d7b0bebc04ef5c9086a3c8f43651e54e77f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7a1f6063abc8b9a39644905a151abffb7b365c275e890a706fa8425a063e6d8eb60b67ae3e1dcd9350684e619cbc658561a89619f5c601f6633f029bde1513d6"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-22 09:05:07.220476) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-22 09:05:07.220795) ========= 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=41bf3e9aed84707956354da8000001c5-1490197451.206139-910668056 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004589 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-22 09:05:07.306152) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-22 09:05:07.306467) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-22 09:05:07.306992) ========= ========= Total master_lag: 0.43 =========