builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-012 starttime: 1483457109.46 results: success (0) revision: cad2ea346d06ec5a3a70eda912513201dff0c21e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-03 07:25:09.458526) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-03 07:25:09.459006) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-03 07:25:09.459294) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-03 07:25:09.474371) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-03 07:25:09.474740) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1483456911.235964-1506752328 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-03 07:25:10-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 227M=0s 2017-01-03 07:25:10 (227 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.081439 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-03 07:25:09.570371) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-03 07:25:09.570702) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1483456911.235964-1506752328 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016056 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-03 07:25:09.619804) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-03 07:25:09.620174) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev cad2ea346d06ec5a3a70eda912513201dff0c21e --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 cad2ea346d06ec5a3a70eda912513201dff0c21e --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=2c5dd2b0a310ecf02fd87158000001b4-1483456911.235964-1506752328 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-03 07:25:11,069 truncating revision to first 12 chars 2017-01-03 07:25:11,070 Setting DEBUG logging. 2017-01-03 07:25:11,070 attempt 1/10 2017-01-03 07:25:11,070 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/cad2ea346d06?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-03 07:25:11,801 unpacking tar archive at: mozilla-central-cad2ea346d06/testing/mozharness/ program finished with exit code 0 elapsedTime=1.070619 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-03 07:25:10.704415) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-03 07:25:10.704732) ========= script_repo_revision: cad2ea346d06ec5a3a70eda912513201dff0c21e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-03 07:25:10.705110) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-03 07:25:10.705434) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-03 07:25:10.714505) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2017-01-03 07:25:10.714869) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=2c5dd2b0a310ecf02fd87158000001b4-1483456911.235964-1506752328 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:25:12 INFO - MultiFileLogger online at 20170103 07:25:12 in /builds/slave/test 07:25:12 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 07:25:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:25:12 INFO - {'append_to_log': False, 07:25:12 INFO - 'base_work_dir': '/builds/slave/test', 07:25:12 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 07:25:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:25:12 INFO - 'branch': 'Firefox-Non-PGO', 07:25:12 INFO - 'buildbot_json_path': 'buildprops.json', 07:25:12 INFO - 'config_files': ('talos/linux_config.py',), 07:25:12 INFO - 'default_actions': ('clobber', 07:25:12 INFO - 'read-buildbot-config', 07:25:12 INFO - 'download-and-extract', 07:25:12 INFO - 'populate-webroot', 07:25:12 INFO - 'create-virtualenv', 07:25:12 INFO - 'install', 07:25:12 INFO - 'run-tests'), 07:25:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:25:12 INFO - 'download_minidump_stackwalk': True, 07:25:12 INFO - 'download_symbols': 'ondemand', 07:25:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:25:12 INFO - 'tooltool.py': '/tools/tooltool.py', 07:25:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:25:12 INFO - '/tools/misc-python/virtualenv.py')}, 07:25:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:25:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:25:12 INFO - 'installer_path': 'installer.exe', 07:25:12 INFO - 'log_level': 'info', 07:25:12 INFO - 'log_name': 'talos', 07:25:12 INFO - 'log_to_console': True, 07:25:12 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:25:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:25:12 INFO - 'opt_config_files': (), 07:25:12 INFO - 'pip_index': False, 07:25:12 INFO - 'sps_profile': False, 07:25:12 INFO - 'sps_profile_interval': 0, 07:25:12 INFO - 'suite': 'dromaeojs-e10s', 07:25:12 INFO - 'system_bits': '32', 07:25:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:25:12 INFO - 'title': 'talos-linux64-ix-012', 07:25:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:25:12 INFO - 'use_talos_json': True, 07:25:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:25:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:25:12 INFO - 'work_dir': 'build'} 07:25:12 INFO - [mozharness: 2017-01-03 15:25:12.261725Z] Running clobber step. 07:25:12 INFO - Running pre-action listener: _resource_record_pre_action 07:25:12 INFO - Running main action method: clobber 07:25:12 INFO - rmtree: /builds/slave/test/build 07:25:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:25:12 INFO - Running post-action listener: _resource_record_post_action 07:25:12 INFO - [mozharness: 2017-01-03 15:25:12.723640Z] Finished clobber step (success) 07:25:12 INFO - [mozharness: 2017-01-03 15:25:12.723740Z] Running read-buildbot-config step. 07:25:12 INFO - Running pre-action listener: _resource_record_pre_action 07:25:12 INFO - Running main action method: read_buildbot_config 07:25:12 INFO - Using buildbot properties: 07:25:12 INFO - { 07:25:12 INFO - "project": "", 07:25:12 INFO - "product": "firefox", 07:25:12 INFO - "who": "ffxbld@noreply.mozilla.org", 07:25:12 INFO - "installer_path": "public/build/target.tar.bz2", 07:25:12 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 07:25:12 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 07:25:12 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 07:25:12 INFO - "stage_platform": "linux64", 07:25:12 INFO - "basedir": "/builds/slave/test", 07:25:12 INFO - "buildnumber": 341, 07:25:12 INFO - "platform": "ubuntu64_hw", 07:25:12 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 07:25:12 INFO - "slavebuilddir": "test", 07:25:12 INFO - "taskId": "KOv1IRNDQf2paD9qzYN_HQ", 07:25:12 INFO - "branch": "mozilla-central", 07:25:12 INFO - "script_repo_revision": "production", 07:25:12 INFO - "revision": "cad2ea346d06ec5a3a70eda912513201dff0c21e", 07:25:12 INFO - "slavename": "talos-linux64-ix-012", 07:25:12 INFO - "repo_path": "mozilla-central" 07:25:12 INFO - } 07:25:12 INFO - Finding installer, test and symbols from parent task. 07:25:12 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KOv1IRNDQf2paD9qzYN_HQ'}, attempt #1 07:25:13 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KOv1IRNDQf2paD9qzYN_HQ'}, attempt #1 07:25:13 INFO - Task dependencies: bMcVyxPBS166SDW_dKXzkQ 07:25:13 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bMcVyxPBS166SDW_dKXzkQ'}, attempt #1 07:25:14 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/bMcVyxPBS166SDW_dKXzkQ/artifacts/public/build/target.tar.bz2 07:25:14 INFO - Set test_url: https://queue.taskcluster.net/v1/task/bMcVyxPBS166SDW_dKXzkQ/artifacts/public/build/test_packages.json 07:25:14 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/bMcVyxPBS166SDW_dKXzkQ/artifacts/public/build/target.crashreporter-symbols.zip 07:25:14 INFO - Running post-action listener: _resource_record_post_action 07:25:14 INFO - [mozharness: 2017-01-03 15:25:14.102400Z] Finished read-buildbot-config step (success) 07:25:14 INFO - [mozharness: 2017-01-03 15:25:14.102617Z] Running download-and-extract step. 07:25:14 INFO - Running pre-action listener: _resource_record_pre_action 07:25:14 INFO - Running main action method: download_and_extract 07:25:14 INFO - mkdir: /builds/slave/test/build/tests 07:25:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:25:14 INFO - trying https://queue.taskcluster.net/v1/task/bMcVyxPBS166SDW_dKXzkQ/artifacts/public/build/target.test_packages.json 07:25:14 INFO - Downloading https://queue.taskcluster.net/v1/task/bMcVyxPBS166SDW_dKXzkQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 07:25:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bMcVyxPBS166SDW_dKXzkQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 07:25:14 INFO - Downloaded 896 bytes. 07:25:14 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 07:25:14 INFO - Using the following test package requirements: 07:25:14 INFO - {u'common': [u'target.common.tests.zip'], 07:25:14 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 07:25:14 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 07:25:14 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 07:25:14 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 07:25:14 INFO - u'mozbase': [u'target.common.tests.zip'], 07:25:14 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 07:25:14 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 07:25:14 INFO - u'web-platform': [u'target.common.tests.zip', 07:25:14 INFO - u'target.web-platform.tests.zip'], 07:25:14 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 07:25:14 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 07:25:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bMcVyxPBS166SDW_dKXzkQ/artifacts/public/build/target.common.tests.zip 07:25:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bMcVyxPBS166SDW_dKXzkQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 07:25:14 INFO - Fetch https://queue.taskcluster.net/v1/task/bMcVyxPBS166SDW_dKXzkQ/artifacts/public/build/target.common.tests.zip into memory 07:25:15 INFO - Expected file size: 20246919 07:25:15 INFO - Obtained file size: 20246919 07:25:19 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 07:25:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bMcVyxPBS166SDW_dKXzkQ/artifacts/public/build/target.common.tests.zip 07:25:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bMcVyxPBS166SDW_dKXzkQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 07:25:19 INFO - Fetch https://queue.taskcluster.net/v1/task/bMcVyxPBS166SDW_dKXzkQ/artifacts/public/build/target.common.tests.zip into memory 07:25:20 INFO - Expected file size: 20246919 07:25:20 INFO - Obtained file size: 20246919 07:25:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bMcVyxPBS166SDW_dKXzkQ/artifacts/public/build/target.talos.tests.zip 07:25:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bMcVyxPBS166SDW_dKXzkQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 07:25:24 INFO - Fetch https://queue.taskcluster.net/v1/task/bMcVyxPBS166SDW_dKXzkQ/artifacts/public/build/target.talos.tests.zip into memory 07:25:25 INFO - Expected file size: 14409776 07:25:25 INFO - Obtained file size: 14409776 07:25:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:25:25 INFO - trying https://queue.taskcluster.net/v1/task/bMcVyxPBS166SDW_dKXzkQ/artifacts/public/build/target.tar.bz2 07:25:25 INFO - Downloading https://queue.taskcluster.net/v1/task/bMcVyxPBS166SDW_dKXzkQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 07:25:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bMcVyxPBS166SDW_dKXzkQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 07:25:27 INFO - Downloaded 55869480 bytes. 07:25:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bMcVyxPBS166SDW_dKXzkQ/artifacts/public/build/target.tar.bz2 07:25:27 INFO - mkdir: /builds/slave/test/properties 07:25:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:25:27 INFO - Writing to file /builds/slave/test/properties/build_url 07:25:27 INFO - Contents: 07:25:27 INFO - build_url:https://queue.taskcluster.net/v1/task/bMcVyxPBS166SDW_dKXzkQ/artifacts/public/build/target.tar.bz2 07:25:27 INFO - Running post-action listener: _resource_record_post_action 07:25:27 INFO - Running post-action listener: set_extra_try_arguments 07:25:27 INFO - [mozharness: 2017-01-03 15:25:27.890005Z] Finished download-and-extract step (success) 07:25:27 INFO - [mozharness: 2017-01-03 15:25:27.890102Z] Running populate-webroot step. 07:25:27 INFO - Running pre-action listener: _resource_record_pre_action 07:25:27 INFO - Running main action method: populate_webroot 07:25:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:25:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:25:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:25:27 INFO - '--tppagecycles', 07:25:27 INFO - '7'], 07:25:27 INFO - 'tests': ['tsvgm']}}, 07:25:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:25:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:25:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:25:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:25:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:25:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:25:27 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:25:27 INFO - 'talos_options': ['--disable-e10s'], 07:25:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:25:27 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:25:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:25:27 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:25:27 INFO - 'talos_options': ['--disable-e10s'], 07:25:27 INFO - 'tests': ['damp', 'tps']}, 07:25:27 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:25:27 INFO - 'tests': ['damp', 'tps']}, 07:25:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:25:27 INFO - 'tests': ['dromaeo_dom']}, 07:25:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:25:27 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:25:27 INFO - 'tests': ['basic_compositor_video']}, 07:25:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:25:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:25:27 INFO - 'tests': ['a11yr', 07:25:27 INFO - 'ts_paint', 07:25:27 INFO - 'tpaint', 07:25:27 INFO - 'sessionrestore', 07:25:27 INFO - 'sessionrestore_no_auto_restore', 07:25:27 INFO - 'tabpaint']}, 07:25:27 INFO - 'other-e10s': {'tests': ['a11yr', 07:25:27 INFO - 'ts_paint', 07:25:27 INFO - 'tpaint', 07:25:27 INFO - 'sessionrestore', 07:25:27 INFO - 'sessionrestore_no_auto_restore', 07:25:27 INFO - 'tabpaint']}, 07:25:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:25:27 INFO - 'ts_paint', 07:25:27 INFO - 'tpaint', 07:25:27 INFO - 'sessionrestore', 07:25:27 INFO - 'sessionrestore_no_auto_restore', 07:25:27 INFO - 'tabpaint']}, 07:25:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:25:27 INFO - 'ts_paint', 07:25:27 INFO - 'tpaint', 07:25:27 INFO - 'sessionrestore', 07:25:27 INFO - 'sessionrestore_no_auto_restore', 07:25:27 INFO - 'tabpaint']}, 07:25:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:25:27 INFO - 'tests': ['a11yr', 07:25:27 INFO - 'ts_paint', 07:25:27 INFO - 'tpaint', 07:25:27 INFO - 'sessionrestore', 07:25:27 INFO - 'sessionrestore_no_auto_restore', 07:25:27 INFO - 'tabpaint']}, 07:25:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:25:27 INFO - 'tests': ['a11yr', 07:25:27 INFO - 'ts_paint', 07:25:27 INFO - 'tpaint', 07:25:27 INFO - 'sessionrestore', 07:25:27 INFO - 'sessionrestore_no_auto_restore', 07:25:27 INFO - 'tabpaint']}, 07:25:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:25:27 INFO - 'tests': ['tsvgx', 07:25:27 INFO - 'tsvgr_opacity', 07:25:27 INFO - 'tart', 07:25:27 INFO - 'tscrollx', 07:25:27 INFO - 'cart', 07:25:27 INFO - 'tsvg_static']}, 07:25:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:25:27 INFO - 'tsvgr_opacity', 07:25:27 INFO - 'tart', 07:25:27 INFO - 'tscrollx', 07:25:27 INFO - 'cart', 07:25:27 INFO - 'tsvg_static']}, 07:25:27 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:25:27 INFO - 'talos_options': ['--disable-e10s'], 07:25:27 INFO - 'tests': ['tp5o']}, 07:25:27 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:25:27 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:25:27 INFO - 'talos_options': ['--disable-e10s', 07:25:27 INFO - '--xperf_path', 07:25:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:25:27 INFO - 'tests': ['tp5n']}, 07:25:27 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:25:27 INFO - 'talos_options': ['--xperf_path', 07:25:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:25:27 INFO - 'tests': ['tp5n']}}, 07:25:27 INFO - 'talos.zip': {'path': '', 07:25:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:25:27 INFO - Running post-action listener: _resource_record_post_action 07:25:27 INFO - [mozharness: 2017-01-03 15:25:27.903179Z] Finished populate-webroot step (success) 07:25:27 INFO - [mozharness: 2017-01-03 15:25:27.903269Z] Running create-virtualenv step. 07:25:27 INFO - Running pre-action listener: _resource_record_pre_action 07:25:27 INFO - Running main action method: create_virtualenv 07:25:27 INFO - Creating virtualenv /builds/slave/test/build/venv 07:25:27 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 07:25:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:25:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:25:28 INFO - Using real prefix '/usr' 07:25:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:25:28 INFO - Installing distribute.............................................................................................................................................................................................done. 07:25:30 INFO - Installing pip.................done. 07:25:30 INFO - Return code: 0 07:25:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:25:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:25:30 INFO - Reading from file tmpfile_stdout 07:25:30 INFO - Output received: 07:25:30 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) 07:25:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:25:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:25:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:25:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:30 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 0x203b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x214ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23ad480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23aa820>, '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 0x23ab520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23ab9b0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1483456911.235964-1506752328', '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 07:25:30 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 07:25:30 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 07:25:30 INFO - Using env: {'DISPLAY': ':0', 07:25:30 INFO - 'HOME': '/home/cltbld', 07:25:30 INFO - 'LANG': 'en_US.UTF-8', 07:25:30 INFO - 'LANGUAGE': 'en_US:en', 07:25:30 INFO - 'LOGNAME': 'cltbld', 07:25:30 INFO - 'MAIL': '/var/mail/cltbld', 07:25:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:30 INFO - 'MOZ_NO_REMOTE': '1', 07:25:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:25:30 INFO - 'NO_EM_RESTART': '1', 07:25:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:25:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:30 INFO - 'PWD': '/builds/slave/test', 07:25:30 INFO - 'SHELL': '/bin/bash', 07:25:30 INFO - 'SHLVL': '1', 07:25:30 INFO - 'TERM': 'linux', 07:25:30 INFO - 'TMOUT': '86400', 07:25:30 INFO - 'USER': 'cltbld', 07:25:30 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1483456911.235964-1506752328', 07:25:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:30 INFO - '_': '/tools/buildbot/bin/python'} 07:25:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:30 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 07:25:30 INFO - Cleaning up... 07:25:30 INFO - Return code: 0 07:25:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:25:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:25:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:25:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:30 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 0x203b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x214ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23ad480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23aa820>, '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 0x23ab520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23ab9b0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1483456911.235964-1506752328', '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 07:25:30 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 07:25:30 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 07:25:30 INFO - Using env: {'DISPLAY': ':0', 07:25:30 INFO - 'HOME': '/home/cltbld', 07:25:30 INFO - 'LANG': 'en_US.UTF-8', 07:25:30 INFO - 'LANGUAGE': 'en_US:en', 07:25:30 INFO - 'LOGNAME': 'cltbld', 07:25:30 INFO - 'MAIL': '/var/mail/cltbld', 07:25:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:30 INFO - 'MOZ_NO_REMOTE': '1', 07:25:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:25:30 INFO - 'NO_EM_RESTART': '1', 07:25:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:25:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:30 INFO - 'PWD': '/builds/slave/test', 07:25:30 INFO - 'SHELL': '/bin/bash', 07:25:30 INFO - 'SHLVL': '1', 07:25:30 INFO - 'TERM': 'linux', 07:25:30 INFO - 'TMOUT': '86400', 07:25:30 INFO - 'USER': 'cltbld', 07:25:30 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1483456911.235964-1506752328', 07:25:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:30 INFO - '_': '/tools/buildbot/bin/python'} 07:25:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:31 INFO - Downloading/unpacking psutil>=3.1.1 07:25:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:25:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:25:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:25:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:25:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:25:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:25:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:25:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:25:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:25:33 INFO - Installing collected packages: psutil 07:25:33 INFO - Running setup.py install for psutil 07:25:33 INFO - building 'psutil._psutil_linux' extension 07:25:33 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 07:25:33 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 07:25:33 INFO - building 'psutil._psutil_posix' extension 07:25:33 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 07:25:33 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 07:25:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:25:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:25:33 INFO - Successfully installed psutil 07:25:33 INFO - Cleaning up... 07:25:33 INFO - Return code: 0 07:25:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:25:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:25:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:25:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x203b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x214ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23ad480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23aa820>, '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 0x23ab520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23ab9b0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1483456911.235964-1506752328', '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 07:25:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:25:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:25:33 INFO - Using env: {'DISPLAY': ':0', 07:25:33 INFO - 'HOME': '/home/cltbld', 07:25:33 INFO - 'LANG': 'en_US.UTF-8', 07:25:33 INFO - 'LANGUAGE': 'en_US:en', 07:25:33 INFO - 'LOGNAME': 'cltbld', 07:25:33 INFO - 'MAIL': '/var/mail/cltbld', 07:25:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:33 INFO - 'MOZ_NO_REMOTE': '1', 07:25:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:25:33 INFO - 'NO_EM_RESTART': '1', 07:25:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:25:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:33 INFO - 'PWD': '/builds/slave/test', 07:25:33 INFO - 'SHELL': '/bin/bash', 07:25:33 INFO - 'SHLVL': '1', 07:25:33 INFO - 'TERM': 'linux', 07:25:33 INFO - 'TMOUT': '86400', 07:25:33 INFO - 'USER': 'cltbld', 07:25:33 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1483456911.235964-1506752328', 07:25:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:33 INFO - '_': '/tools/buildbot/bin/python'} 07:25:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:25:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:25:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:25:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:25:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:25:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:25:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:25:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:25:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:25:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:25:36 INFO - Installing collected packages: mozsystemmonitor 07:25:36 INFO - Running setup.py install for mozsystemmonitor 07:25:36 INFO - Successfully installed mozsystemmonitor 07:25:36 INFO - Cleaning up... 07:25:36 INFO - Return code: 0 07:25:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:25:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:25:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:25:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x203b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x214ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23ad480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23aa820>, '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 0x23ab520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23ab9b0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1483456911.235964-1506752328', '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 07:25:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:25:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:25:36 INFO - Using env: {'DISPLAY': ':0', 07:25:36 INFO - 'HOME': '/home/cltbld', 07:25:36 INFO - 'LANG': 'en_US.UTF-8', 07:25:36 INFO - 'LANGUAGE': 'en_US:en', 07:25:36 INFO - 'LOGNAME': 'cltbld', 07:25:36 INFO - 'MAIL': '/var/mail/cltbld', 07:25:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:36 INFO - 'MOZ_NO_REMOTE': '1', 07:25:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:25:36 INFO - 'NO_EM_RESTART': '1', 07:25:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:25:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:36 INFO - 'PWD': '/builds/slave/test', 07:25:36 INFO - 'SHELL': '/bin/bash', 07:25:36 INFO - 'SHLVL': '1', 07:25:36 INFO - 'TERM': 'linux', 07:25:36 INFO - 'TMOUT': '86400', 07:25:36 INFO - 'USER': 'cltbld', 07:25:36 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1483456911.235964-1506752328', 07:25:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:36 INFO - '_': '/tools/buildbot/bin/python'} 07:25:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:36 INFO - Downloading/unpacking jsonschema==2.5.1 07:25:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:25:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:25:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:25:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:25:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:25:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:25:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:25:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:25:38 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 07:25:38 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 07:25:38 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 07:25:38 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 07:25:38 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 07:25:38 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 07:25:38 INFO - Downloading functools32-3.2.3-2.tar.gz 07:25:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:25:38 INFO - warning: no files found matching '*.txt' 07:25:38 INFO - no previously-included directories found matching 'build' 07:25:38 INFO - no previously-included directories found matching 'dist' 07:25:38 INFO - no previously-included directories found matching '.git*' 07:25:38 INFO - Installing collected packages: jsonschema, functools32 07:25:38 INFO - Running setup.py install for functools32 07:25:38 INFO - warning: no files found matching '*.txt' 07:25:38 INFO - no previously-included directories found matching 'build' 07:25:38 INFO - no previously-included directories found matching 'dist' 07:25:38 INFO - no previously-included directories found matching '.git*' 07:25:38 INFO - Successfully installed jsonschema functools32 07:25:38 INFO - Cleaning up... 07:25:38 INFO - Return code: 0 07:25:38 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:25:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:25:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:25:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x203b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x214ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23ad480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23aa820>, '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 0x23ab520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23ab9b0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1483456911.235964-1506752328', '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 07:25:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:25:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:25:38 INFO - Using env: {'DISPLAY': ':0', 07:25:38 INFO - 'HOME': '/home/cltbld', 07:25:38 INFO - 'LANG': 'en_US.UTF-8', 07:25:38 INFO - 'LANGUAGE': 'en_US:en', 07:25:38 INFO - 'LOGNAME': 'cltbld', 07:25:38 INFO - 'MAIL': '/var/mail/cltbld', 07:25:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:38 INFO - 'MOZ_NO_REMOTE': '1', 07:25:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:25:38 INFO - 'NO_EM_RESTART': '1', 07:25:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:25:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:38 INFO - 'PWD': '/builds/slave/test', 07:25:38 INFO - 'SHELL': '/bin/bash', 07:25:38 INFO - 'SHLVL': '1', 07:25:38 INFO - 'TERM': 'linux', 07:25:38 INFO - 'TMOUT': '86400', 07:25:38 INFO - 'USER': 'cltbld', 07:25:38 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1483456911.235964-1506752328', 07:25:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:38 INFO - '_': '/tools/buildbot/bin/python'} 07:25:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:39 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:25:39 INFO - Cleaning up... 07:25:39 INFO - Return code: 0 07:25:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:25:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:25:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:25:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:39 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 0x203b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x214ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23ad480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23aa820>, '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 0x23ab520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23ab9b0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1483456911.235964-1506752328', '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 07:25:39 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 07:25:39 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 07:25:39 INFO - Using env: {'DISPLAY': ':0', 07:25:39 INFO - 'HOME': '/home/cltbld', 07:25:39 INFO - 'LANG': 'en_US.UTF-8', 07:25:39 INFO - 'LANGUAGE': 'en_US:en', 07:25:39 INFO - 'LOGNAME': 'cltbld', 07:25:39 INFO - 'MAIL': '/var/mail/cltbld', 07:25:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:39 INFO - 'MOZ_NO_REMOTE': '1', 07:25:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:25:39 INFO - 'NO_EM_RESTART': '1', 07:25:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:25:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:39 INFO - 'PWD': '/builds/slave/test', 07:25:39 INFO - 'SHELL': '/bin/bash', 07:25:39 INFO - 'SHLVL': '1', 07:25:39 INFO - 'TERM': 'linux', 07:25:39 INFO - 'TMOUT': '86400', 07:25:39 INFO - 'USER': 'cltbld', 07:25:39 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1483456911.235964-1506752328', 07:25:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:39 INFO - '_': '/tools/buildbot/bin/python'} 07:25:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:39 INFO - Downloading/unpacking blobuploader==1.2.4 07:25:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:25:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:25:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:25:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:25:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:25:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:25:41 INFO - Downloading blobuploader-1.2.4.tar.gz 07:25:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:25:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:25:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:25:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:25:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:25:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:25:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:25:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:25:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:25:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:25:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:25:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:25:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:25:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:25:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:25:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:25:42 INFO - Downloading docopt-0.6.1.tar.gz 07:25:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:25:42 INFO - Installing collected packages: blobuploader, requests, docopt 07:25:42 INFO - Running setup.py install for blobuploader 07:25:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:25:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:25:42 INFO - Running setup.py install for requests 07:25:42 INFO - Running setup.py install for docopt 07:25:42 INFO - Successfully installed blobuploader requests docopt 07:25:42 INFO - Cleaning up... 07:25:42 INFO - Return code: 0 07:25:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:25:42 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')]} 07:25:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:42 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')]} 07:25:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:42 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 0x203b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x214ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23ad480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23aa820>, '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 0x23ab520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23ab9b0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1483456911.235964-1506752328', '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 07:25:42 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 07:25:42 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 07:25:42 INFO - Using env: {'DISPLAY': ':0', 07:25:42 INFO - 'HOME': '/home/cltbld', 07:25:42 INFO - 'LANG': 'en_US.UTF-8', 07:25:42 INFO - 'LANGUAGE': 'en_US:en', 07:25:42 INFO - 'LOGNAME': 'cltbld', 07:25:42 INFO - 'MAIL': '/var/mail/cltbld', 07:25:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:42 INFO - 'MOZ_NO_REMOTE': '1', 07:25:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:25:42 INFO - 'NO_EM_RESTART': '1', 07:25:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:25:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:42 INFO - 'PWD': '/builds/slave/test', 07:25:42 INFO - 'SHELL': '/bin/bash', 07:25:42 INFO - 'SHLVL': '1', 07:25:42 INFO - 'TERM': 'linux', 07:25:42 INFO - 'TMOUT': '86400', 07:25:42 INFO - 'USER': 'cltbld', 07:25:42 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1483456911.235964-1506752328', 07:25:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:42 INFO - '_': '/tools/buildbot/bin/python'} 07:25:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:25:42 INFO - Running setup.py (path:/tmp/pip-OD5Hbg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:25:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:25:43 INFO - Running setup.py (path:/tmp/pip-FhWGWA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:25:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:25:43 INFO - Running setup.py (path:/tmp/pip-QRErok-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:25:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:25:43 INFO - Running setup.py (path:/tmp/pip-NjF3Pr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:25:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:25:43 INFO - Running setup.py (path:/tmp/pip-KRm4Fq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:25:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:25:43 INFO - Running setup.py (path:/tmp/pip-MWIyAA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:25:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:25:43 INFO - Running setup.py (path:/tmp/pip-wJBWGA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:25:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:25:43 INFO - Running setup.py (path:/tmp/pip-OBSH_N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:25:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:25:43 INFO - Running setup.py (path:/tmp/pip-on_1Wc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:25:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:25:43 INFO - Running setup.py (path:/tmp/pip-pq7aFV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:25:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:25:43 INFO - Running setup.py (path:/tmp/pip-3zfDUb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:25:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:25:43 INFO - Running setup.py (path:/tmp/pip-cfhq1t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:25:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:25:43 INFO - Running setup.py (path:/tmp/pip-Z8iMqL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:25:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:25:43 INFO - Running setup.py (path:/tmp/pip-vSw6pL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:25:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:25:43 INFO - Running setup.py (path:/tmp/pip-Fxrdb9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:25:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:25:44 INFO - Running setup.py (path:/tmp/pip-MPoRjR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:25:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:25:44 INFO - Running setup.py (path:/tmp/pip-kzv6LS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:25:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:25:44 INFO - Running setup.py install for manifestparser 07:25:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:25:44 INFO - Running setup.py install for mozcrash 07:25:44 INFO - Running setup.py install for mozdebug 07:25:44 INFO - Running setup.py install for mozdevice 07:25:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:25:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:25:44 INFO - Running setup.py install for mozfile 07:25:44 INFO - Running setup.py install for mozhttpd 07:25:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:25:44 INFO - Running setup.py install for mozinfo 07:25:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:25:44 INFO - Running setup.py install for mozInstall 07:25:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:25:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:25:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:25:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:25:44 INFO - Running setup.py install for mozleak 07:25:45 INFO - Running setup.py install for mozlog 07:25:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:25:45 INFO - Running setup.py install for moznetwork 07:25:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:25:45 INFO - Running setup.py install for mozprocess 07:25:45 INFO - Running setup.py install for mozprofile 07:25:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:25:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:25:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:25:45 INFO - Running setup.py install for mozrunner 07:25:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:25:45 INFO - Running setup.py install for mozscreenshot 07:25:45 INFO - Running setup.py install for moztest 07:25:45 INFO - Running setup.py install for mozversion 07:25:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:25:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:25:45 INFO - Cleaning up... 07:25:45 INFO - Return code: 0 07:25:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:25:45 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')]} 07:25:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:45 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')]} 07:25:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:45 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 0x203b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x214ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23ad480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23aa820>, '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 0x23ab520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23ab9b0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1483456911.235964-1506752328', '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 07:25:45 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 07:25:45 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 07:25:45 INFO - Using env: {'DISPLAY': ':0', 07:25:45 INFO - 'HOME': '/home/cltbld', 07:25:45 INFO - 'LANG': 'en_US.UTF-8', 07:25:45 INFO - 'LANGUAGE': 'en_US:en', 07:25:45 INFO - 'LOGNAME': 'cltbld', 07:25:45 INFO - 'MAIL': '/var/mail/cltbld', 07:25:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:45 INFO - 'MOZ_NO_REMOTE': '1', 07:25:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:25:45 INFO - 'NO_EM_RESTART': '1', 07:25:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:25:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:45 INFO - 'PWD': '/builds/slave/test', 07:25:45 INFO - 'SHELL': '/bin/bash', 07:25:45 INFO - 'SHLVL': '1', 07:25:45 INFO - 'TERM': 'linux', 07:25:45 INFO - 'TMOUT': '86400', 07:25:45 INFO - 'USER': 'cltbld', 07:25:45 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1483456911.235964-1506752328', 07:25:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:45 INFO - '_': '/tools/buildbot/bin/python'} 07:25:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:25:46 INFO - Running setup.py (path:/tmp/pip-CNL_JE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:25:46 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)) 07:25:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:25:46 INFO - Running setup.py (path:/tmp/pip-hOZXNn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:25:46 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)) 07:25:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:25:46 INFO - Running setup.py (path:/tmp/pip-mz7tcl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:25:46 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)) 07:25:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:25:46 INFO - Running setup.py (path:/tmp/pip-kzPp5R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:25:46 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)) 07:25:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:25:46 INFO - Running setup.py (path:/tmp/pip-qShodu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:25:46 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)) 07:25:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:25:46 INFO - Running setup.py (path:/tmp/pip-dldJzg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:25:46 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)) 07:25:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:25:46 INFO - Running setup.py (path:/tmp/pip-DpTcLI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:25:46 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)) 07:25:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:25:46 INFO - Running setup.py (path:/tmp/pip-B6R1Ng-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:25:46 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)) 07:25:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:25:46 INFO - Running setup.py (path:/tmp/pip-BXKS_t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:25:46 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)) 07:25:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:25:46 INFO - Running setup.py (path:/tmp/pip-MDVvmC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:25:46 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)) 07:25:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:25:46 INFO - Running setup.py (path:/tmp/pip-DHcqLn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:25:47 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)) 07:25:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:25:47 INFO - Running setup.py (path:/tmp/pip-qZa0OV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:25:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 07:25:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:25:47 INFO - Running setup.py (path:/tmp/pip-Nmh237-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:25:47 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)) 07:25:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:25:47 INFO - Running setup.py (path:/tmp/pip-BpMuz8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:25:47 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)) 07:25:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:25:47 INFO - Running setup.py (path:/tmp/pip-n_u7xD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:25:47 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)) 07:25:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:25:47 INFO - Running setup.py (path:/tmp/pip-T9KitT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:25:47 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)) 07:25:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:25:47 INFO - Running setup.py (path:/tmp/pip-wBFbW1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:25:47 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)) 07:25:47 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)) 07:25:47 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)) 07:25:47 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)) 07:25:47 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)) 07:25:47 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)) 07:25:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:25:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:25:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:25:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:25:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:25:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:25:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:25:49 INFO - Downloading blessings-1.6.tar.gz 07:25:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:25:49 INFO - Installing collected packages: blessings 07:25:49 INFO - Running setup.py install for blessings 07:25:49 INFO - Successfully installed blessings 07:25:49 INFO - Cleaning up... 07:25:49 INFO - Return code: 0 07:25:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:25:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:25:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:25:49 INFO - Reading from file tmpfile_stdout 07:25:49 INFO - Current package versions: 07:25:49 INFO - argparse == 1.2.1 07:25:49 INFO - blessings == 1.6 07:25:49 INFO - blobuploader == 1.2.4 07:25:49 INFO - docopt == 0.6.1 07:25:49 INFO - functools32 == 3.2.3-2 07:25:49 INFO - jsonschema == 2.5.1 07:25:49 INFO - manifestparser == 1.1 07:25:49 INFO - mozInstall == 1.12 07:25:49 INFO - mozcrash == 1.0 07:25:49 INFO - mozdebug == 0.1 07:25:49 INFO - mozdevice == 0.49 07:25:49 INFO - mozfile == 1.2 07:25:49 INFO - mozhttpd == 0.7 07:25:49 INFO - mozinfo == 0.9 07:25:49 INFO - mozleak == 0.1 07:25:49 INFO - mozlog == 3.4 07:25:49 INFO - moznetwork == 0.27 07:25:49 INFO - mozprocess == 0.23 07:25:49 INFO - mozprofile == 0.28 07:25:49 INFO - mozrunner == 6.13 07:25:49 INFO - mozscreenshot == 0.1 07:25:49 INFO - mozsystemmonitor == 0.3 07:25:49 INFO - moztest == 0.8 07:25:49 INFO - mozversion == 1.4 07:25:49 INFO - psutil == 3.1.1 07:25:49 INFO - requests == 1.2.3 07:25:49 INFO - wsgiref == 0.1.2 07:25:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:25:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:25:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:25:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:49 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 0x203b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x214ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23ad480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23aa820>, '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 0x23ab520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23ab9b0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1483456911.235964-1506752328', '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 07:25:49 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 07:25:49 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 07:25:49 INFO - Using env: {'DISPLAY': ':0', 07:25:49 INFO - 'HOME': '/home/cltbld', 07:25:49 INFO - 'LANG': 'en_US.UTF-8', 07:25:49 INFO - 'LANGUAGE': 'en_US:en', 07:25:49 INFO - 'LOGNAME': 'cltbld', 07:25:49 INFO - 'MAIL': '/var/mail/cltbld', 07:25:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:49 INFO - 'MOZ_NO_REMOTE': '1', 07:25:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:25:49 INFO - 'NO_EM_RESTART': '1', 07:25:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:25:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:49 INFO - 'PWD': '/builds/slave/test', 07:25:49 INFO - 'SHELL': '/bin/bash', 07:25:49 INFO - 'SHLVL': '1', 07:25:49 INFO - 'TERM': 'linux', 07:25:49 INFO - 'TMOUT': '86400', 07:25:49 INFO - 'USER': 'cltbld', 07:25:49 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1483456911.235964-1506752328', 07:25:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:49 INFO - '_': '/tools/buildbot/bin/python'} 07:25:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:50 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)) 07:25:50 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)) 07:25:50 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)) 07:25:50 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)) 07:25:50 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)) 07:25:50 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)) 07:25:50 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)) 07:25:50 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)) 07:25:50 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)) 07:25:50 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)) 07:25:50 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)) 07:25:50 INFO - Cleaning up... 07:25:50 INFO - Return code: 0 07:25:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:25: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')]} 07:25:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25: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')]} 07:25:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25: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']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x203b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x214ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23ad480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23aa820>, '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 0x23ab520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23ab9b0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1483456911.235964-1506752328', '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 07:25: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'] in /builds/slave/test/build 07:25: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 07:25:50 INFO - Using env: {'DISPLAY': ':0', 07:25:50 INFO - 'HOME': '/home/cltbld', 07:25:50 INFO - 'LANG': 'en_US.UTF-8', 07:25:50 INFO - 'LANGUAGE': 'en_US:en', 07:25:50 INFO - 'LOGNAME': 'cltbld', 07:25:50 INFO - 'MAIL': '/var/mail/cltbld', 07:25:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:50 INFO - 'MOZ_NO_REMOTE': '1', 07:25:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:25:50 INFO - 'NO_EM_RESTART': '1', 07:25:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:25:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:50 INFO - 'PWD': '/builds/slave/test', 07:25:50 INFO - 'SHELL': '/bin/bash', 07:25:50 INFO - 'SHLVL': '1', 07:25:50 INFO - 'TERM': 'linux', 07:25:50 INFO - 'TMOUT': '86400', 07:25:50 INFO - 'USER': 'cltbld', 07:25:50 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1483456911.235964-1506752328', 07:25:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:50 INFO - '_': '/tools/buildbot/bin/python'} 07:25:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:25:50 INFO - Cleaning up... 07:25:50 INFO - Return code: 0 07:25:50 INFO - Running post-action listener: _resource_record_post_action 07:25:50 INFO - Running post-action listener: _start_resource_monitoring 07:25:50 INFO - Starting resource monitoring. 07:25:50 INFO - [mozharness: 2017-01-03 15:25:50.418440Z] Finished create-virtualenv step (success) 07:25:50 INFO - [mozharness: 2017-01-03 15:25:50.418937Z] Running install step. 07:25:50 INFO - Running pre-action listener: _resource_record_pre_action 07:25:50 INFO - Running main action method: install 07:25:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:25:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:25:50 INFO - Reading from file tmpfile_stdout 07:25:50 INFO - Detecting whether we're running mozinstall >=1.0... 07:25:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:25:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:25:50 INFO - Reading from file tmpfile_stdout 07:25:50 INFO - Output received: 07:25:50 INFO - Usage: mozinstall [options] installer 07:25:50 INFO - Options: 07:25:50 INFO - -h, --help show this help message and exit 07:25:50 INFO - -d DEST, --destination=DEST 07:25:50 INFO - Directory to install application into. [default: 07:25:50 INFO - "/builds/slave/test"] 07:25:50 INFO - --app=APP Application being installed. [default: firefox] 07:25:50 INFO - mkdir: /builds/slave/test/build/application 07:25:50 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'] 07:25:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 07:26:06 INFO - Reading from file tmpfile_stdout 07:26:06 INFO - Output received: 07:26:06 INFO - /builds/slave/test/build/application/firefox/firefox 07:26:06 INFO - Running post-action listener: _resource_record_post_action 07:26:06 INFO - [mozharness: 2017-01-03 15:26:06.782185Z] Finished install step (success) 07:26:06 INFO - [mozharness: 2017-01-03 15:26:06.782460Z] Running run-tests step. 07:26:06 INFO - Running pre-action listener: _resource_record_pre_action 07:26:06 INFO - Running main action method: run_tests 07:26:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:26:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:26:06 INFO - Python 2.7.3 07:26:06 INFO - Return code: 0 07:26:06 INFO - grabbing minidump binary from tooltool 07:26:06 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')]} 07:26:06 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 0x23aa820>, '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 0x23ab520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23ab9b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:26:06 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 07:26:06 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 07:26:06 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 07:26:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:26:06 INFO - Return code: 0 07:26:06 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:26:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:26:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:26:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:26:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:26:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bMcVyxPBS166SDW_dKXzkQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 07:26:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bMcVyxPBS166SDW_dKXzkQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-012 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 07:26:06 INFO - Using env: {'DISPLAY': ':0', 07:26:06 INFO - 'HOME': '/home/cltbld', 07:26:06 INFO - 'LANG': 'en_US.UTF-8', 07:26:06 INFO - 'LANGUAGE': 'en_US:en', 07:26:06 INFO - 'LOGNAME': 'cltbld', 07:26:06 INFO - 'MAIL': '/var/mail/cltbld', 07:26:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:26:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:26:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:26:06 INFO - 'MOZ_NO_REMOTE': '1', 07:26:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:26:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:26:06 INFO - 'NO_EM_RESTART': '1', 07:26:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:26:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:26:06 INFO - 'PWD': '/builds/slave/test', 07:26:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:26:06 INFO - 'SHELL': '/bin/bash', 07:26:06 INFO - 'SHLVL': '1', 07:26:06 INFO - 'TERM': 'linux', 07:26:06 INFO - 'TMOUT': '86400', 07:26:06 INFO - 'USER': 'cltbld', 07:26:06 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1483456911.235964-1506752328', 07:26:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:26:06 INFO - '_': '/tools/buildbot/bin/python'} 07:26:06 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bMcVyxPBS166SDW_dKXzkQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 07:26:07 INFO - mozversion application_buildid: 20170103145507 07:26:07 INFO - mozversion application_changeset: cad2ea346d06ec5a3a70eda912513201dff0c21e 07:26:07 INFO - mozversion application_display_name: Nightly 07:26:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:26:07 INFO - mozversion application_name: Firefox 07:26:07 INFO - mozversion application_remotingname: firefox 07:26:07 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:26:07 INFO - mozversion application_vendor: Mozilla 07:26:07 INFO - mozversion application_version: 53.0a1 07:26:07 INFO - mozversion platform_buildid: 20170103145507 07:26:07 INFO - mozversion platform_changeset: cad2ea346d06ec5a3a70eda912513201dff0c21e 07:26:07 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:26:07 INFO - mozversion platform_version: 53.0a1 07:26:07 INFO - using testdate: 1483457167 07:26:07 INFO - actual date: 1483457167 07:26:07 INFO - starting webserver on 'localhost:39004' 07:26:07 INFO - SUITE-START | Running 2 tests 07:26:07 INFO - TEST-START | dromaeo_css 07:26:07 INFO - operating with platform_type : linux_ 07:26:07 INFO - Initialising browser for dromaeo_css test... 07:26:07 INFO - TEST-INFO | started process 688 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGPpPIZ/profile http://localhost:39004/getInfo.html) 07:26:07 INFO - PROCESS | 688 | 1483457167584 addons.xpi WARN Exception running bootstrap method install on shield-recipe-client@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getBoolPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js :: this.install :: line 38" data: no] Stack trace: this.install()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:38 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4986 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2097 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3827 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2831 < callProvider()@resource://gre/modules/AddonManager.jsm:264 < _startProvider()@resource://gre/modules/AddonManager.jsm:771 < startup()@resource://gre/modules/AddonManager.jsm:957 < startup()@resource://gre/modules/AddonManager.jsm:2923 < observe()@resource://gre/components/addonManager.js:65 07:26:11 INFO - PROCESS | 688 | __metrics Screen width/height:1600/1200 07:26:11 INFO - PROCESS | 688 | colorDepth:24 07:26:11 INFO - PROCESS | 688 | Browser inner width/height: 1024/697 07:26:11 INFO - PROCESS | 688 | __metrics 07:26:11 ERROR - PROCESS | 688 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3256: TypeError: this.tabs is undefined 07:26:12 INFO - TEST-INFO | 688: exit 0 07:26:12 INFO - Browser initialized. 07:26:12 INFO - Running cycle 1/1 for dromaeo_css test... 07:26:12 INFO - TEST-INFO | started process 809 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGPpPIZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:26:24 INFO - PROCESS | 809 | RSS: Main: 158773248 07:26:24 INFO - PROCESS | 809 | 07:27:14 INFO - PROCESS | 809 | 1483457234279 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 07:29:28 INFO - PROCESS | 809 | Cycle 1(1): loaded http://localhost:39004/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39004/tests/dromaeo/cssquery-ext.html) 07:29:29 INFO - PROCESS | 809 | RSS: Main: 165232640 07:29:29 INFO - PROCESS | 809 | 07:31:12 INFO - PROCESS | 809 | ************************* 07:31:12 INFO - PROCESS | 809 | A coding exception was thrown and uncaught in a Task. 07:31:12 INFO - PROCESS | 809 | 07:31:12 INFO - PROCESS | 809 | Full message: ReferenceError: fetch is not defined 07:31:12 INFO - PROCESS | 809 | Full stack: apiCall@resource://shield-recipe-client/lib/NormandyApi.jsm:37:5 07:31:12 INFO - PROCESS | 809 | get@resource://shield-recipe-client/lib/NormandyApi.jsm:44:12 07:31:12 INFO - PROCESS | 809 | this.NormandyApi.fetchRecipes<@resource://shield-recipe-client/lib/NormandyApi.jsm:52:34 07:31:12 INFO - PROCESS | 809 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 07:31:12 INFO - PROCESS | 809 | TaskImpl@resource://gre/modules/Task.jsm:277:3 07:31:12 INFO - PROCESS | 809 | asyncFunction@resource://gre/modules/Task.jsm:252:14 07:31:12 INFO - PROCESS | 809 | this.RecipeRunner.start<@resource://shield-recipe-client/lib/RecipeRunner.jsm:64:23 07:31:12 INFO - PROCESS | 809 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 07:31:12 INFO - PROCESS | 809 | TaskImpl@resource://gre/modules/Task.jsm:277:3 07:31:12 INFO - PROCESS | 809 | asyncFunction@resource://gre/modules/Task.jsm:252:14 07:31:12 INFO - PROCESS | 809 | setTimeout_timer@resource://gre/modules/Timer.jsm:30:5 07:31:12 INFO - PROCESS | 809 | 07:31:12 INFO - PROCESS | 809 | ************************* 07:32:32 INFO - PROCESS | 809 | Cycle 1(1): loaded http://localhost:39004/tests/dromaeo/cssquery-ext.html (next: http://localhost:39004/tests/dromaeo/cssquery-jquery.html) 07:32:32 INFO - PROCESS | 809 | RSS: Main: 162328576 07:32:32 INFO - PROCESS | 809 | 07:35:35 INFO - PROCESS | 809 | Cycle 1(1): loaded http://localhost:39004/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39004/tests/dromaeo/cssquery-mootools.html) 07:35:35 INFO - PROCESS | 809 | RSS: Main: 168108032 07:35:35 INFO - PROCESS | 809 | 07:38:37 INFO - PROCESS | 809 | Cycle 1(1): loaded http://localhost:39004/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39004/tests/dromaeo/cssquery-prototype.html) 07:38:38 INFO - PROCESS | 809 | RSS: Main: 163069952 07:38:38 INFO - PROCESS | 809 | 07:41:41 INFO - PROCESS | 809 | Cycle 1(1): loaded http://localhost:39004/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39004/tests/dromaeo/cssquery-yui.html) 07:41:42 INFO - PROCESS | 809 | RSS: Main: 166408192 07:41:42 INFO - PROCESS | 809 | 07:44:45 INFO - PROCESS | 809 | Cycle 1(1): loaded http://localhost:39004/tests/dromaeo/cssquery-yui.html (next: http://localhost:39004/tests/dromaeo/cssquery-dojo.html) 07:44:45 INFO - PROCESS | 809 | RSS: Main: 166617088 07:44:45 INFO - PROCESS | 809 | 07:44:45 INFO - PROCESS | 809 | __start_tp_report 07:44:45 INFO - PROCESS | 809 | _x_x_mozilla_page_load 07:44:45 INFO - PROCESS | 809 | _x_x_mozilla_page_load_details 07:44:45 INFO - PROCESS | 809 | |i|pagename|runs| 07:44:45 INFO - PROCESS | 809 | |0;dojo.html;2598.7141414444413;2602.609608558716;2610.4909542639193;2637.1297471834296;2642.2205449392427;4717.57541821236;4864.246041863508;4882.438519570251;4893.7797799099035;4906.950930490694;4796.568308852203;4819.277108433736;4855.975720121403;4869.707817530951;4926.45808961014;4460.464744230697;4506.346579745935;4538.818447262105;4541.318802179667;4650.2559590465535;4168.7081904266715;4586.899144205383;4634.86095417138;4646.163690535702;4650.604698600623;4405.295152775572;4498.842540511083;4529.456465224162;4542.091581683677;4630.953690463086;4410.779461026936;4429.025614364835;4431.158079964796;4436.511983681825;4535.614472769818;4442.800073996678;4453.933191002137;4468.664850136221;4473.306637471197;4479.574440428154;4784.282357646381;4830;4841.685290456109;4874.4150701916;4883.804647814083;5117.181250999822;5186.247994040843;5187.662801917863;5207.218917162418;5222.503862133091;5258.947410525884;5265.842024739226;5265.86835329116;5281.471852814726;5309.946900530984;4899.044686286175;4909.5090490950615;4909.705417674951;4927.334809800703;4959.479254678279;5181.145111056633;5198.610104242197;5219.791208351623;5293.973530132402;5379.246905433242;5035.169197082514;5055.191169412877;5073.518015788494;5092.694438333712;5137.255098010767;5093.2105523643895;5225.085610018232;5236.92144617831;5241.42344342122;5288.312519372457;5063.0380227756605;5143.459936706667;5186.611004174702;5225.111731005738;5295.602829787781;5210.270562121306;5232.084385232569;5233.110371236899;5235.319408476874;5240.6069544784295;4343.04453020335;4399;4399.252127138394;4400.361947517592;4501.774911254424;3809.7523660961947;3828.2534905693124;3842.077901303667;3864.1305706215876;3869.845206191721;4379;4421.182081314967;4423.535528769497;4430.091831174602;4456.799444025027;5199.818006369759;5219.947800522022;5251.632385732962;5270.025045366543;5280.630355875129;4380.123975204908;4428.889277768081;4435.401220835146;4457.531959144308;4469.08383781324;4674.813007479663;4700.529947005272;4715.3869996900185;4718.9292160617615;4771.284307353924;4768.260919557474;4817.108834865561;4904.166291730415;4904.607631389552;4914.2628605708;5237.528622424;5269.841904742864;5285.101532739367;5287.841364759063;5355.410904800391;4899.706017638953;4900.068986892479;4904.043711476228;4914.778834952364;4955.82654607087;5102.642815003062;5171.715555644476;5197.974010129925;5226.216067589892;5226.686398816083;5205.505476979681;5213.400458947118;5215.55667768244;5264.710440925785;5341.946580534145;5057.949420505748;5083.796648134034;5096.719680417465;5097.158968770112;5106.10643137442;4958.776855041459;4965.925511117264;5057.342545469065;5122.974385128051;5153.845384638467;4908.312836202863;4994.850154495371;5005.174146265826;5038.84883453497;5047.1419858623385;5059.418166910852;5063.113955057924;5075.3402057732255;5080.060188865072;5123.615728820428;4906.582940450102;4951.158303088556;4970.080535101018;4976.2286845539;4989.276554899592 07:44:45 INFO - PROCESS | 809 | |1;ext.html;515.5488947171225;517.8524120625622;522.287078138341;525.910595198816;529.4467281690632;37617.435738463944;39929.401058984105;40043.19913601726;40075.39886901691;43159.78420107895;40093.39859902096;40405.797971010106;40630.79684601573;40756.388654170136;40798.796006019926;7752.186020467854;7922.405819563527;7944.880826787603;9545.90454095457;9892.703218903445;9678;9683;9688.806223875517;9718.854217186712;9804.754881127958;9726.756831079245;9732.464714440703;9743;9777.706668799947;9813.509324533781;9721.854172187423;9741.805163896717;9747.707568772948;9779.46212958287;9786.90213097867;9691.854622180674;9732.464714440703;9757.707268781947;9760.072793084646;9772;34411.4838277426;34522.654773452196;34748.47877281843;34812.477812832825;34815;3592.8203589820405;3686.668199862025;3690.280395322913;3722.7952462614544;3741.9625803741887;26046.08838690656;26193.214203573923;26395.73604263952;26604.201873943814;27410.451790964267;3367.966320336814;3453.930921381558;3537.2571759930447;3573.6605022522817;3580.6240344763687;234847.8257608718;235031;235461;235926;236320;47160.7641961788;47317.76341118272;47753.761231193625;47875.28187077196;48070;49814;49916.25125623118;49947.50052499501;50377.74811125921;50486.9610431172;13186;13410.061295709207;13469.932650336686;13473.124246923919;13494.460221591222;8153.55155466455;8394.118617545191;9955.203583713286;10095.7476063099;10191.490425478696;15936.36254549805;15989.600259993593;16027.759583606256;16041;16229.675406491804;6511;6606.306337834554;6628.668566571652;6656.900146497806;6670.699818508178;780.9414293927978;803.0644299391143;818.8239528501401;823.333100188837;835.0397043400138;27112.32219194536;27822.86088569544;27964.440711185664;28091.297717556816;28404.147875563765;952.6808519146025;959.947202903833;971.1114330387758;985.4678473624163;988.9752756181009;13858.584242472742;14799.408023679147;14925.626859328386;15046.398144074334;15142.242887855784;350829;351093.1133608299;353660;354353;355631;50348;51041.234381484304;51230.74384628053;51385.48614513807;51548.22677659763;1205.785778703437;1220.6155061155707;1225.8651548329676;1227.6685294970487;1240.2248594628538;26110.86944565265;26501;26940.191794246202;27318.453630927666;27372.726272737815;33099;33101.17247068746;33150;33322.33355332831;33326.16684582905;294403.58394624526;295398;297771;297816;299607;24324.87837560801;25295.241142765746;25439.74560254374;25476;25600.487990240465;36454;36707.81646091752;37189.62810371862;37232.44151337786;37750.811245943594;31992;32084.19789505281;32302.19244518906;32487.512687310184;33271.83364083164;31891;32074.358512829145;32214.19464513406;32531.674683253812;32881.34237315288;32147.839260803546;32527;32856.342873141926;35298.823505882305;35564;26515.29133599063;29190.70809291965;30657.846710766302;30851.537226942062;31078.533821992234;23170.536589268457;23390.883045584662;23773.524529508966;23880.88059559691;23976.160834370712 07:44:45 INFO - PROCESS | 809 | |2;jquery.html;373.7888093227327;374.6209193078431;382.6728147433943;387.903024243939;403.6770583533175;15298.235088245585;15917.68164636708;16558.503244902673;16611.252493637785;16658.916705416486;13102.541411050615;16099;16425;16426.17869106543;16507;4493.662975276851;4740.668153229275;4748.3827102476625;4754.477007529169;4754.477007529186;4663.580277775;5150.768215430315;5406.216098665691;5445.809396671118;5482.862928426782;5478.671279723229;5484.643498172606;5486.423925487826;5488.231647569343;5497.752601132938;5237.842864714045;5380.273663055476;5427.131658934591;5428.864278393033;5436.864078398052;5262.447443018466;5270.1040823060175;5272.578193744491;5282.234076058989;5282.65662731925;11601.651950441501;11683.065354771597;11828.053755699524;11836.644900652995;12105.515779368814;2051.0770153430867;2123.458518077896;2142.1645558232303;2158.4711745622267;2170.9891450542805;8937.374383793072;8973.641054357819;8978.595963181673;9325.300602454843;9369.906300936971;1644.0957473389587;1703.5996540812898;1726.507945235602;1729.0749449044702;1739.91300434979;62011.37988620101;62291.37708622901;62840.37159628391;63224.36775632231;64486.03270950892;9684.661036863676;9828.459434731158;10014.599416023424;10017.649382271586;10136;13522.391492382867;13533.255670937997;13537;13541.1198272112;13565.525206617918;6877.552959057645;7060.858782824314;7174.964125179341;7310.52481588695;7331.596762178131;6794.966025169842;6811.318868113149;6950.513464057569;6975.546589471668;6998.68505917235;4206.684498662613;4276.273033584298;4340.587644173798;4395.846145384896;4443.111377724404;1543.5986643472777;1613.580469078048;1621.2056092514583;1888.9127514097;1903.7049257364854;813.4021494201756;822.3256929317902;832.6003518311123;847.9448835825651;854.8033952191031;15971.201439928189;16156.67686646284;16337.101459419608;16385.754213686803;16583.092944311316;809.3080416244144;813.5525460996429;817.4073796497491;819.1767273889702;839.5340585974842;8855;9089.136532029446;9206.815863682688;9457.38526995743;9459.810803784023;311642;342807;347396;347661;348596;57404.13893791597;70680;70738.64630676917;73568.26431735721;73887.63056184685;425.72115264501804;447.55021203690734;451.3004842494187;451.6522277846106;451.7334772484184;9387.342885997914;10121.949390253001;10129.848052279074;10153.543090560795;10283.897161028593;27919.720802792526;29175;33444;34312.485312720826;37176.44235336418;41247.01918221781;43390.56609433991;43827.56172438235;43916.34125488184;46399.76800115978;5469.617126801086;7592.8861067082935;7900.920990790019;7942.44402891792;8012.198780121941;10776.946115269373;12077.51689932393;12090.697732556757;12141;12223.63468680668;5188.662736922088;9373.671921482715;9627.470489123165;10317.329373590692;10614.877024595266;4893.828715994923;7597.924020759942;9362.157405833508;9735.561899714672;10362.533685983997;9360.625574976924;9376.906230937604;9502.144806967406;9742.75643108928;10213.948930255301;7458.701651933862;7767.961160194162;7782.649780759766;7861.2531809478005;7934.2859142677435;9506.857397139187;9676.516174191403;9787.755306117404;9845.655402060893;10010 07:44:45 INFO - PROCESS | 809 | |3;mootools.html;1316.5984374765696;1339.7052648417346;1345.650130965949;1345.6703107738606;1346.1519242876989;6711.328867113286;6896.310368963113;7049.54177978431;7500.737474188404;7514.211007844179;7035.226125126232;7237.819054523639;7285.672144753486;7502.21226771188;7504.774856754292;2123.2568600989684;2174.8586341887726;2178.934631961036;2183.0612836480386;2190.408589680785;2130.8401869859745;2154.644483660194;2200.7689192634784;2205.94485137872;2224.043661225672;2169.9891500542476;2197.121151539381;2204.7464541577765;2206.305013920618;2212.214663794354;2075.1595603780415;2098.412444515538;2099.3387083068937;2101.989490052555;2124.1715730864976;2141.4004078857943;2143.2820005298245;2162.2107930605216;2167.0898222746328;2172.0985790896757;7409.333160015624;7571.205023472567;7577;7593.126790419062;7605.6577454014705;4545.454545454533;4691.343211950296;4701.271302948048;4701.929471057937;4716.410448693913;2753.559430491112;2933.662628797694;2992.326726486545;3001.0846691759007;3026.8335241561704;1116.5366372955214;1177.3171560494893;1206.6983254186453;1206.8853458921387;1229.9385030748517;9811.705648830475;9885.703428897144;9895.406275623485;9927.354721943051;9931.950340248324;3834.1373191032353;3922.6077392260545;3961.8217180226957;3994.560598334181;4075.775832329191;7931.643076061591;7945.880811787828;7959.761207163794;7960.243776841191;7963.641636126388;4452.332150177434;4515.322701594787;4520.88697782558;4560.179167749837;4563.931541026887;4181.874543763692;4239.300515414983;4256.425382573375;4261.126469073833;4267.615914567704;3108.6425061117807;3177.158053115926;3190.920226994344;3209.9197520062185;3252.3820474109843;907.8456662367413;929.3921515777743;974.7319487141093;976.6728146071003;986.6102889358663;692.2592825676578;701.1446035836271;708.2775568919673;720.3660778514874;734.5262305812721;4865.12427762999;4900.8774780630765;5094.337736094284;5145.331106956071;5145.691258524501;825.0923983618092;826.8883700700449;831.2934006094771;836.5566249887569;837.9203975622306;3422.4524076147695;3480.9477857832153;3503.824808759603;3549.112721819545;3606;8301.626426810688;8652.653893844301;8685;8711.303095752324;8715.52064636451;8495.1080136586;8535.914640853636;8566.3146948244;8575.313974881994;8646.481211127353;6654.467642588581;6796.76211332601;6836.042953986446;6858;6867.862642747117;4849.102915960559;4903.362562866804;4927.433345165352;4951.306817045544;5109.233614957638;7859.52842829432;7886.72396466121;7926;7983.760487185394;8013.759587212393;7933.523988560705;7996.920030799618;8024.679012839421;8111.310538604049;8124.431289809657;5976.372480889444;6055.486128467883;6056.091586262096;6060.969695151496;6072.14989901423;6808.659567021728;6866.141732283465;6904;6953.6523173842115;6968.651567421507;6176.104464852481;6196.907046394398;6231.189945307262;6241.095041219089;6272.09054687077;6093;6172.135900973957;6219.129321894848;6222.471089957223;6284.748610055546;5618.494335509824;5694.259746232963;5726.770929162787;5743.483086522233;5759.8560035999435;4257.254980378483;4284.143171365677;4354.281543545406;4404.031113155229;4476.507584165674;4078.4697989262395;4177.665786737114;4302.204092242945;4391.934120988251;4416.646668266595 07:44:45 INFO - PROCESS | 809 | |4;prototype.html;343.4813431718106;349.8950314905529;353.0221287034913;355.3000588839986;355.6550146358032;4887.340209071775;4908.803647854091;4927.433345165307;4971.627127965399;4975.2039673652225;4905.288733133702;4917.4836642152595;4920.458749537548;4920.483349248322;4924.261360795874;3700.9259814803686;3825.3114439400897;3865.845366185363;3950.308695978214;3957.168994511156;3953.1339778660526;3957.1508513870112;3964.6828253739777;3968.424578436125;3969.9951524480243;3936.7047471439614;3938.940915886264;3946.2896678597986;3948.3090459169675;3951.70362222833;3901.7463864848696;3943.3493473576827;3975.70182236332;3993.7803420811842;3994.5406278277787;3556.28874225156;3560.893173204782;3568.7858728476376;3581.2837432513343;3593.9101522461888;4759.785809638574;4785.387032790256;4803.759812009421;4822.1561226785525;4825.276208568707;4569.954300456986;4575.588197062247;4581.702189357681;4583.518730533313;4594.1271158479785;4987.975060124712;5138.897222055575;5148.510891465305;5152.871178220575;5193.532582067632;3803.885883423474;3808.447775072599;3809.580946095927;3813;3819.7135214858995;5259.764600044966;5478.342598888159;5514.338279406456;5516.282883225195;5518.034343989786;3868.6324799144036;3870.477485539416;3888.6111388861455;3890.299746045739;3900.8244628991197;3919.3141200289833;3925.4111883217747;3927.9214415711526;3935.763854168759;3940.310445671996;4429.844955426544;4429.867103986821;4438.667099967515;4441.844535441244;4444.2222611042935;5038.64729468941;5143.228515722672;5183.637145399785;5197.948020519822;5259.447757985433;1374.8863420629323;1385.4275397423996;1389.2220356600337;1391.4295138993166;1398.3637444962517;954.355809828377;995.6664517386612;999.7200783780553;1018.9861088217272;1020.806046851096;4366.868993930188;4368.737875727466;4395.648348132142;4416.823327066945;4424.292113261927;5241.353116676054;5263.210518422267;5272.55183309423;5281.630285879952;5308.681479111188;4252.213340532012;4386.7367957922625;4397.846075387346;4408.448943882015;4421.214634780068;2784.5823126530777;2798.860056997142;2811.6344875166096;2823.3506293552596;2841.4743272494657;4882;4919;4920.778564964585;4931.580815630711;4968.403791544965;5224.451432599599;5362.70505122222;5371.221172929982;5397.433269506645;5516.282883225235;5004.097623378432;5020.347354843847;5034.798608055637;5038.6976781392505;5045.268436076748;5388.515033646991;5414.756335964812;5429.348478182485;5449.700266485382;5462.972685136708;5209.609279303992;5297.358313396221;5336.146216605324;5352.924430771025;5380.757865895966;4841.313071245492;4944.406671199479;4977.552020318189;5034.748262586929;5038.370203724535;3629.764065335745;3712.9443058353604;3761.2101458693983;3770.981145094257;3775.981120094382;5305.540976231413;5309.309789727311;5314.548263397654;5326.25432439451;5358.839234822962;4998.475160108136;5152.6650767699975;5154.407243167084;5175.792968281377;5176.870578235424;5108.846734597968;5164.767585458589;5174.922376164285;5175.327207463006;5175.81884634051;5108.540231379045;5109.97800439906;5129.820456284012;5143.794248230029;5147.845564633067;5031.899362012812;5177.223416487557;5189.299444575085;5204.713740744295;5214.217867319932;5072.771725272298;5076.238564215398;5080.796768129381;5101.51535604117;5104.183330667075 07:44:45 INFO - PROCESS | 809 | |5;yui.html;653.6633633678659;662.0764034172332;688.4526801193051;691.6714560583722;699.8775214337493;12048.7590248195;12635.49458021678;12645;12669.49322027119;12810.359482025897;12753.426095825687;12903.225806451619;12934.223946563212;12986.28575428351;13068.607941761762;812.236497692169;827.5159031966307;828.9999999999969;829.713748756678;830.149097175394;806.9193080691942;815.5799763121968;815.7104227999064;825.7522743177022;845.3490812074699;827.5779352530193;828.2462958707578;831.2767891934026;859.6561375449838;863.9784005399853;856.5931182688236;858.961346739392;859.5014891362995;860.7245681381897;861.0915484164235;624.6938999890067;627.0875875601035;627.0969803482969;627.9246490421178;629.078400143787;12641.367931603383;12866.163699359511;12873.227606343557;12927.09510334277;12959.222446653232;11795.528178872835;12361.69095772604;12443.315617641027;12553.246805191626;13100;9561.713148605553;10610.787784244272;11582.826257606142;11922.403879805976;11964.521419143224;4008.2183974125055;4071.5114186297537;4085.121698834735;4088.5911408858874;4267.4025636410925;67055.66472167657;67905.3209467899;68146.31853681449;68636.31363686349;70477.64761176212;10597.576096956036;10809.459527023617;10821.729456763644;10837.133029357632;10877.347359158475;19476.318328858706;19518.609627807364;19538.609227815363;19540.511487212934;19623.509412264808;6522.249941256721;6601.306862779339;6623.105880706139;6698.83252918681;6789.898151527731;3550.4141816600486;3646.2889736501656;3666.1201311685004;3676.7058635309113;3677.9632203678157;2507.661465702107;2562.8590427526665;2584.2505673354894;2588.314096764359;2627.2118364490957;485.69158584299225;488.4382959596421;490.1324655360064;496.0500641271924;500.294584635662;589.2928485817037;593.6912805341199;595.4373117404098;604.8185544336769;631.7315141065029;7714.344280736088;8400.65586515887;8601.483910965362;8863.512506812187;9057.954710226406;492.69699135032414;506.45050120618805;507.58124547248667;584.5119325363369;643.3694978920684;3873.1091848874917;4182.100848317566;4201.2017716633745;4213.810378532973;4332.675049371247;63830.36169638337;64078.35921640724;65034.34965650378;65187;66911.9632055186;57333.42666573281;57651.71174144186;58041.12938305929;58087;58199.4180058194;50064.49935500598;51433.48566514362;51549.48450515447;51785.48214517882;52383;7774.572398517909;8040.316573091119;8106.351491880518;8128.431009829255;8208.600617723896;34993.475097873044;35126;36290;36314.63685363113;36974.63025369712;43114.353284700126;45568.54431455643;46405.30392044054;47188;47785.28322075102;9494.905050949403;9626.278029147701;10115.898841011496;10121;10473.057424831803;10722;10751.19366047534;10827.296225745302;11268.211225214156;11318.4906679198;10816.621418250323;10930.890691093306;11231.831522527005;11416.143789216008;11455.942720286344;10890.346579205274;11454.885451145381;11483.540658373571;11676.824847627462;11731.296122232694;10286.331388459726;10379.169666426818;10414.114800242065;10613.9469302653;10676.893231067901;8823.161799629024;8912.108789121035;9005.279577633904;9346.579403926704;9415.670451534163;7962.880556791769;8051.959740201261;8058.798530036796;8206.466579672302;8423.620937057969 07:44:45 INFO - PROCESS | 809 | __end_tp_report 07:44:45 INFO - PROCESS | 809 | __start_cc_report 07:44:45 INFO - PROCESS | 809 | _x_x_mozilla_cycle_collect,346 07:44:45 INFO - PROCESS | 809 | __end_cc_report 07:44:45 INFO - PROCESS | 809 | __startTimestamp1483458285275__endTimestamp 07:44:45 INFO - PROCESS | 809 | 07:44:45 INFO - PROCESS | 809 | ------- Summary: start ------- 07:44:45 INFO - PROCESS | 809 | Number of tests: 6 07:44:45 INFO - PROCESS | 809 | 07:44:45 INFO - PROCESS | 809 | [#0] dojo.html Cycles:165 Average:4811.11 Median:4914.78 stddev:522.01 (10.6%) stddev-sans-first:493.92 07:44:45 INFO - PROCESS | 809 | Values: 2598.7 2602.6 2610.5 2637.1 2642.2 4717.6 4864.2 4882.4 4893.8 4907.0 4796.6 4819.3 4856.0 4869.7 4926.5 4460.5 4506.3 4538.8 4541.3 4650.3 4168.7 4586.9 4634.9 4646.2 4650.6 4405.3 4498.8 4529.5 4542.1 4631.0 4410.8 4429.0 4431.2 4436.5 4535.6 4442.8 4453.9 4468.7 4473.3 4479.6 4784.3 4830.0 4841.7 4874.4 4883.8 5117.2 5186.2 5187.7 5207.2 5222.5 5258.9 5265.8 5265.9 5281.5 5309.9 4899.0 4909.5 4909.7 4927.3 4959.5 5181.1 5198.6 5219.8 5294.0 5379.2 5035.2 5055.2 5073.5 5092.7 5137.3 5093.2 5225.1 5236.9 5241.4 5288.3 5063.0 5143.5 5186.6 5225.1 5295.6 5210.3 5232.1 5233.1 5235.3 5240.6 4343.0 4399.0 4399.3 4400.4 4501.8 3809.8 3828.3 3842.1 3864.1 3869.8 4379.0 4421.2 4423.5 4430.1 4456.8 5199.8 5219.9 5251.6 5270.0 5280.6 4380.1 4428.9 4435.4 4457.5 4469.1 4674.8 4700.5 4715.4 4718.9 4771.3 4768.3 4817.1 4904.2 4904.6 4914.3 5237.5 5269.8 5285.1 5287.8 5355.4 4899.7 4900.1 4904.0 4914.8 4955.8 5102.6 5171.7 5198.0 5226.2 5226.7 5205.5 5213.4 5215.6 5264.7 5341.9 5057.9 5083.8 5096.7 5097.2 5106.1 4958.8 4965.9 5057.3 5123.0 5153.8 4908.3 4994.9 5005.2 5038.8 5047.1 5059.4 5063.1 5075.3 5080.1 5123.6 4906.6 4951.2 4970.1 4976.2 4989.3 07:44:45 INFO - PROCESS | 809 | 07:44:45 INFO - PROCESS | 809 | [#1] ext.html Cycles:180 Average:44355.66 Median:178598.63 stddev:78509.24 (44.0%) stddev-sans-first:78660.47 07:44:45 INFO - PROCESS | 809 | Values: 515.5 517.9 522.3 525.9 529.4 37617.4 39929.4 40043.2 40075.4 43159.8 40093.4 40405.8 40630.8 40756.4 40798.8 7752.2 7922.4 7944.9 9545.9 9892.7 9678.0 9683.0 9688.8 9718.9 9804.8 9726.8 9732.5 9743.0 9777.7 9813.5 9721.9 9741.8 9747.7 9779.5 9786.9 9691.9 9732.5 9757.7 9760.1 9772.0 34411.5 34522.7 34748.5 34812.5 34815.0 3592.8 3686.7 3690.3 3722.8 3742.0 26046.1 26193.2 26395.7 26604.2 27410.5 3368.0 3453.9 3537.3 3573.7 3580.6 234847.8 235031.0 235461.0 235926.0 236320.0 47160.8 47317.8 47753.8 47875.3 48070.0 49814.0 49916.3 49947.5 50377.7 50487.0 13186.0 13410.1 13469.9 13473.1 13494.5 8153.6 8394.1 9955.2 10095.7 10191.5 15936.4 15989.6 16027.8 16041.0 16229.7 6511.0 6606.3 6628.7 6656.9 6670.7 780.9 803.1 818.8 823.3 835.0 27112.3 27822.9 27964.4 28091.3 28404.1 952.7 959.9 971.1 985.5 989.0 13858.6 14799.4 14925.6 15046.4 15142.2 350829.0 351093.1 353660.0 354353.0 355631.0 50348.0 51041.2 51230.7 51385.5 51548.2 1205.8 1220.6 1225.9 1227.7 1240.2 26110.9 26501.0 26940.2 27318.5 27372.7 33099.0 33101.2 33150.0 33322.3 33326.2 294403.6 295398.0 297771.0 297816.0 299607.0 24324.9 25295.2 25439.7 25476.0 25600.5 36454.0 36707.8 37189.6 37232.4 37750.8 31992.0 32084.2 32302.2 32487.5 33271.8 31891.0 32074.4 32214.2 32531.7 32881.3 32147.8 32527.0 32856.3 35298.8 35564.0 26515.3 29190.7 30657.8 30851.5 31078.5 23170.5 23390.9 23773.5 23880.9 23976.2 07:44:45 INFO - PROCESS | 809 | 07:44:45 INFO - PROCESS | 809 | [#2] jquery.html Cycles:180 Average:21560.36 Median:4751.43 stddev:56163.05 (1182.0%) stddev-sans-first:56298.08 07:44:45 INFO - PROCESS | 809 | Values: 373.8 374.6 382.7 387.9 403.7 15298.2 15917.7 16558.5 16611.3 16658.9 13102.5 16099.0 16425.0 16426.2 16507.0 4493.7 4740.7 4748.4 4754.5 4754.5 4663.6 5150.8 5406.2 5445.8 5482.9 5478.7 5484.6 5486.4 5488.2 5497.8 5237.8 5380.3 5427.1 5428.9 5436.9 5262.4 5270.1 5272.6 5282.2 5282.7 11601.7 11683.1 11828.1 11836.6 12105.5 2051.1 2123.5 2142.2 2158.5 2171.0 8937.4 8973.6 8978.6 9325.3 9369.9 1644.1 1703.6 1726.5 1729.1 1739.9 62011.4 62291.4 62840.4 63224.4 64486.0 9684.7 9828.5 10014.6 10017.6 10136.0 13522.4 13533.3 13537.0 13541.1 13565.5 6877.6 7060.9 7175.0 7310.5 7331.6 6795.0 6811.3 6950.5 6975.5 6998.7 4206.7 4276.3 4340.6 4395.8 4443.1 1543.6 1613.6 1621.2 1888.9 1903.7 813.4 822.3 832.6 847.9 854.8 15971.2 16156.7 16337.1 16385.8 16583.1 809.3 813.6 817.4 819.2 839.5 8855.0 9089.1 9206.8 9457.4 9459.8 311642.0 342807.0 347396.0 347661.0 348596.0 57404.1 70680.0 70738.6 73568.3 73887.6 425.7 447.6 451.3 451.7 451.7 9387.3 10121.9 10129.8 10153.5 10283.9 27919.7 29175.0 33444.0 34312.5 37176.4 41247.0 43390.6 43827.6 43916.3 46399.8 5469.6 7592.9 7900.9 7942.4 8012.2 10776.9 12077.5 12090.7 12141.0 12223.6 5188.7 9373.7 9627.5 10317.3 10614.9 4893.8 7597.9 9362.2 9735.6 10362.5 9360.6 9376.9 9502.1 9742.8 10213.9 7458.7 7768.0 7782.6 7861.3 7934.3 9506.9 9676.5 9787.8 9845.7 10010.0 07:44:45 INFO - PROCESS | 809 | 07:44:45 INFO - PROCESS | 809 | [#3] mootools.html Cycles:180 Average:4787.29 Median:5656.38 stddev:2565.95 (45.4%) stddev-sans-first:2559.89 07:44:45 INFO - PROCESS | 809 | Values: 1316.6 1339.7 1345.7 1345.7 1346.2 6711.3 6896.3 7049.5 7500.7 7514.2 7035.2 7237.8 7285.7 7502.2 7504.8 2123.3 2174.9 2178.9 2183.1 2190.4 2130.8 2154.6 2200.8 2205.9 2224.0 2170.0 2197.1 2204.7 2206.3 2212.2 2075.2 2098.4 2099.3 2102.0 2124.2 2141.4 2143.3 2162.2 2167.1 2172.1 7409.3 7571.2 7577.0 7593.1 7605.7 4545.5 4691.3 4701.3 4701.9 4716.4 2753.6 2933.7 2992.3 3001.1 3026.8 1116.5 1177.3 1206.7 1206.9 1229.9 9811.7 9885.7 9895.4 9927.4 9932.0 3834.1 3922.6 3961.8 3994.6 4075.8 7931.6 7945.9 7959.8 7960.2 7963.6 4452.3 4515.3 4520.9 4560.2 4563.9 4181.9 4239.3 4256.4 4261.1 4267.6 3108.6 3177.2 3190.9 3209.9 3252.4 907.8 929.4 974.7 976.7 986.6 692.3 701.1 708.3 720.4 734.5 4865.1 4900.9 5094.3 5145.3 5145.7 825.1 826.9 831.3 836.6 837.9 3422.5 3480.9 3503.8 3549.1 3606.0 8301.6 8652.7 8685.0 8711.3 8715.5 8495.1 8535.9 8566.3 8575.3 8646.5 6654.5 6796.8 6836.0 6858.0 6867.9 4849.1 4903.4 4927.4 4951.3 5109.2 7859.5 7886.7 7926.0 7983.8 8013.8 7933.5 7996.9 8024.7 8111.3 8124.4 5976.4 6055.5 6056.1 6061.0 6072.1 6808.7 6866.1 6904.0 6953.7 6968.7 6176.1 6196.9 6231.2 6241.1 6272.1 6093.0 6172.1 6219.1 6222.5 6284.7 5618.5 5694.3 5726.8 5743.5 5759.9 4257.3 4284.1 4354.3 4404.0 4476.5 4078.5 4177.7 4302.2 4391.9 4416.6 07:44:45 INFO - PROCESS | 809 | 07:44:45 INFO - PROCESS | 809 | [#4] prototype.html Cycles:180 Average:4324.82 Median:4907.05 stddev:1221.36 (24.9%) stddev-sans-first:1187.67 07:44:45 INFO - PROCESS | 809 | Values: 343.5 349.9 353.0 355.3 355.7 4887.3 4908.8 4927.4 4971.6 4975.2 4905.3 4917.5 4920.5 4920.5 4924.3 3700.9 3825.3 3865.8 3950.3 3957.2 3953.1 3957.2 3964.7 3968.4 3970.0 3936.7 3938.9 3946.3 3948.3 3951.7 3901.7 3943.3 3975.7 3993.8 3994.5 3556.3 3560.9 3568.8 3581.3 3593.9 4759.8 4785.4 4803.8 4822.2 4825.3 4570.0 4575.6 4581.7 4583.5 4594.1 4988.0 5138.9 5148.5 5152.9 5193.5 3803.9 3808.4 3809.6 3813.0 3819.7 5259.8 5478.3 5514.3 5516.3 5518.0 3868.6 3870.5 3888.6 3890.3 3900.8 3919.3 3925.4 3927.9 3935.8 3940.3 4429.8 4429.9 4438.7 4441.8 4444.2 5038.6 5143.2 5183.6 5197.9 5259.4 1374.9 1385.4 1389.2 1391.4 1398.4 954.4 995.7 999.7 1019.0 1020.8 4366.9 4368.7 4395.6 4416.8 4424.3 5241.4 5263.2 5272.6 5281.6 5308.7 4252.2 4386.7 4397.8 4408.4 4421.2 2784.6 2798.9 2811.6 2823.4 2841.5 4882.0 4919.0 4920.8 4931.6 4968.4 5224.5 5362.7 5371.2 5397.4 5516.3 5004.1 5020.3 5034.8 5038.7 5045.3 5388.5 5414.8 5429.3 5449.7 5463.0 5209.6 5297.4 5336.1 5352.9 5380.8 4841.3 4944.4 4977.6 5034.7 5038.4 3629.8 3712.9 3761.2 3771.0 3776.0 5305.5 5309.3 5314.5 5326.3 5358.8 4998.5 5152.7 5154.4 5175.8 5176.9 5108.8 5164.8 5174.9 5175.3 5175.8 5108.5 5110.0 5129.8 5143.8 5147.8 5031.9 5177.2 5189.3 5204.7 5214.2 5072.8 5076.2 5080.8 5101.5 5104.2 07:44:45 INFO - PROCESS | 809 | 07:44:45 INFO - PROCESS | 809 | [#5] yui.html Cycles:180 Average:14784.58 Median:494.37 stddev:18831.25 (3809.1%) stddev-sans-first:18854.18 07:44:45 INFO - PROCESS | 809 | Values: 653.7 662.1 688.5 691.7 699.9 12048.8 12635.5 12645.0 12669.5 12810.4 12753.4 12903.2 12934.2 12986.3 13068.6 812.2 827.5 829.0 829.7 830.1 806.9 815.6 815.7 825.8 845.3 827.6 828.2 831.3 859.7 864.0 856.6 859.0 859.5 860.7 861.1 624.7 627.1 627.1 627.9 629.1 12641.4 12866.2 12873.2 12927.1 12959.2 11795.5 12361.7 12443.3 12553.2 13100.0 9561.7 10610.8 11582.8 11922.4 11964.5 4008.2 4071.5 4085.1 4088.6 4267.4 67055.7 67905.3 68146.3 68636.3 70477.6 10597.6 10809.5 10821.7 10837.1 10877.3 19476.3 19518.6 19538.6 19540.5 19623.5 6522.2 6601.3 6623.1 6698.8 6789.9 3550.4 3646.3 3666.1 3676.7 3678.0 2507.7 2562.9 2584.3 2588.3 2627.2 485.7 488.4 490.1 496.1 500.3 589.3 593.7 595.4 604.8 631.7 7714.3 8400.7 8601.5 8863.5 9058.0 492.7 506.5 507.6 584.5 643.4 3873.1 4182.1 4201.2 4213.8 4332.7 63830.4 64078.4 65034.3 65187.0 66912.0 57333.4 57651.7 58041.1 58087.0 58199.4 50064.5 51433.5 51549.5 51785.5 52383.0 7774.6 8040.3 8106.4 8128.4 8208.6 34993.5 35126.0 36290.0 36314.6 36974.6 43114.4 45568.5 46405.3 47188.0 47785.3 9494.9 9626.3 10115.9 10121.0 10473.1 10722.0 10751.2 10827.3 11268.2 11318.5 10816.6 10930.9 11231.8 11416.1 11455.9 10890.3 11454.9 11483.5 11676.8 11731.3 10286.3 10379.2 10414.1 10613.9 10676.9 8823.2 8912.1 9005.3 9346.6 9415.7 7962.9 8052.0 8058.8 8206.5 8423.6 07:44:45 INFO - PROCESS | 809 | -------- Summary: end -------- 07:44:45 INFO - PROCESS | 809 | 07:44:46 INFO - TEST-INFO | 809: exit 0 07:44:46 INFO - TEST-OK | dromaeo_css | took 1119091ms 07:44:46 INFO - TEST-START | kraken 07:44:46 INFO - operating with platform_type : linux_ 07:44:46 INFO - Initialising browser for kraken test... 07:44:46 INFO - TEST-INFO | started process 1279 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7uRzZH/profile http://localhost:39004/getInfo.html) 07:44:46 INFO - PROCESS | 1279 | 1483458286661 addons.xpi WARN Exception running bootstrap method install on shield-recipe-client@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getBoolPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js :: this.install :: line 38" data: no] Stack trace: this.install()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:38 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4986 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2097 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3827 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2831 < callProvider()@resource://gre/modules/AddonManager.jsm:264 < _startProvider()@resource://gre/modules/AddonManager.jsm:771 < startup()@resource://gre/modules/AddonManager.jsm:957 < startup()@resource://gre/modules/AddonManager.jsm:2923 < observe()@resource://gre/components/addonManager.js:65 07:44:50 INFO - PROCESS | 1279 | __metrics Screen width/height:1600/1200 07:44:50 INFO - PROCESS | 1279 | colorDepth:24 07:44:50 INFO - PROCESS | 1279 | Browser inner width/height: 1024/697 07:44:50 INFO - PROCESS | 1279 | __metrics 07:44:50 ERROR - PROCESS | 1279 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3256: TypeError: this.tabs is undefined 07:44:51 INFO - TEST-INFO | 1279: exit 0 07:44:51 INFO - Browser initialized. 07:44:51 INFO - Running cycle 1/1 for kraken test... 07:44:51 INFO - TEST-INFO | started process 1398 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7uRzZH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:45:03 INFO - PROCESS | 1398 | RSS: Main: 158003200 07:45:03 INFO - PROCESS | 1398 | 07:45:06 INFO - PROCESS | 1398 | Cycle 1(1): loaded http://localhost:39004/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39004/tests/kraken/driver.html?testName=audio-beat-detection) 07:45:07 INFO - PROCESS | 1398 | RSS: Main: 164085760 07:45:07 INFO - PROCESS | 1398 | 07:45:10 INFO - PROCESS | 1398 | Cycle 1(1): loaded http://localhost:39004/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39004/tests/kraken/driver.html?testName=audio-dft) 07:45:10 INFO - PROCESS | 1398 | RSS: Main: 162144256 07:45:10 INFO - PROCESS | 1398 | 07:45:13 INFO - PROCESS | 1398 | Cycle 1(1): loaded http://localhost:39004/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39004/tests/kraken/driver.html?testName=audio-fft) 07:45:14 INFO - PROCESS | 1398 | RSS: Main: 158928896 07:45:14 INFO - PROCESS | 1398 | 07:45:16 INFO - PROCESS | 1398 | Cycle 1(1): loaded http://localhost:39004/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39004/tests/kraken/driver.html?testName=audio-oscillator) 07:45:17 INFO - PROCESS | 1398 | RSS: Main: 159649792 07:45:17 INFO - PROCESS | 1398 | 07:45:19 INFO - PROCESS | 1398 | Cycle 1(1): loaded http://localhost:39004/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39004/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:45:20 INFO - PROCESS | 1398 | RSS: Main: 160456704 07:45:20 INFO - PROCESS | 1398 | 07:45:23 INFO - PROCESS | 1398 | Cycle 1(1): loaded http://localhost:39004/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39004/tests/kraken/driver.html?testName=imaging-darkroom) 07:45:24 INFO - PROCESS | 1398 | RSS: Main: 164986880 07:45:24 INFO - PROCESS | 1398 | 07:45:27 INFO - PROCESS | 1398 | Cycle 1(1): loaded http://localhost:39004/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39004/tests/kraken/driver.html?testName=imaging-desaturate) 07:45:28 INFO - PROCESS | 1398 | RSS: Main: 161476608 07:45:28 INFO - PROCESS | 1398 | 07:45:31 INFO - PROCESS | 1398 | Cycle 1(1): loaded http://localhost:39004/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39004/tests/kraken/driver.html?testName=json-parse-financial) 07:45:31 INFO - PROCESS | 1398 | RSS: Main: 162930688 07:45:31 INFO - PROCESS | 1398 | 07:45:33 INFO - PROCESS | 1398 | Cycle 1(1): loaded http://localhost:39004/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39004/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:45:34 INFO - PROCESS | 1398 | RSS: Main: 162357248 07:45:34 INFO - PROCESS | 1398 | 07:45:36 INFO - PROCESS | 1398 | Cycle 1(1): loaded http://localhost:39004/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39004/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:45:36 INFO - PROCESS | 1398 | RSS: Main: 162267136 07:45:36 INFO - PROCESS | 1398 | 07:45:38 INFO - PROCESS | 1398 | Cycle 1(1): loaded http://localhost:39004/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39004/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:45:39 INFO - PROCESS | 1398 | RSS: Main: 163160064 07:45:39 INFO - PROCESS | 1398 | 07:45:42 INFO - PROCESS | 1398 | Cycle 1(1): loaded http://localhost:39004/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39004/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:45:43 INFO - PROCESS | 1398 | RSS: Main: 163418112 07:45:43 INFO - PROCESS | 1398 | 07:45:46 INFO - PROCESS | 1398 | Cycle 1(1): loaded http://localhost:39004/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39004/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:45:46 INFO - PROCESS | 1398 | RSS: Main: 163065856 07:45:46 INFO - PROCESS | 1398 | 07:45:48 INFO - PROCESS | 1398 | Cycle 1(1): loaded http://localhost:39004/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39004/tests/kraken/driver.html?testName=ai-astar) 07:45:48 INFO - PROCESS | 1398 | RSS: Main: 165056512 07:45:48 INFO - PROCESS | 1398 | 07:45:48 INFO - PROCESS | 1398 | __start_tp_report 07:45:48 INFO - PROCESS | 1398 | _x_x_mozilla_page_load 07:45:48 INFO - PROCESS | 1398 | _x_x_mozilla_page_load_details 07:45:48 INFO - PROCESS | 1398 | |i|pagename|runs| 07:45:48 INFO - PROCESS | 1398 | |0;ai-astar;106;117;118;116;118;116;118;118;116;117 07:45:48 INFO - PROCESS | 1398 | |1;audio-beat-detection;153;128;128;184;134;130;130;133;160;130 07:45:48 INFO - PROCESS | 1398 | |2;audio-dft;163;172;176;163;163;166;164;164;163;163 07:45:48 INFO - PROCESS | 1398 | |3;audio-fft;76;77;77;115;77;77;76;79;101;77 07:45:48 INFO - PROCESS | 1398 | |4;audio-oscillator;84;85;102;87;86;84;108;86;85;107 07:45:48 INFO - PROCESS | 1398 | |5;imaging-gaussian-blur;119;119;117;124;122;124;119;123;119;118 07:45:48 INFO - PROCESS | 1398 | |6;imaging-darkroom;150;150;152;151;151;154;151;150;150;150 07:45:48 INFO - PROCESS | 1398 | |7;imaging-desaturate;96;97;96;96;97;97;97;96;97;97 07:45:48 INFO - PROCESS | 1398 | |8;json-parse-financial;63;65;65;65;65;67;66;65;64;65 07:45:48 INFO - PROCESS | 1398 | |9;json-stringify-tinderbox;68;68;66;69;68;67;67;67;66;70 07:45:48 INFO - PROCESS | 1398 | |10;stanford-crypto-aes;85;85;89;85;86;85;85;90;91;86 07:45:48 INFO - PROCESS | 1398 | |11;stanford-crypto-ccm;158;142;135;146;135;147;142;142;190;139 07:45:48 INFO - PROCESS | 1398 | |12;stanford-crypto-pbkdf2;183;185;183;181;182;187;178;180;181;180 07:45:48 INFO - PROCESS | 1398 | |13;stanford-crypto-sha256-iterative;71;74;73;71;72;71;71;70;70;69 07:45:48 INFO - PROCESS | 1398 | __end_tp_report 07:45:48 INFO - PROCESS | 1398 | __start_cc_report 07:45:48 INFO - PROCESS | 1398 | _x_x_mozilla_cycle_collect,851 07:45:48 INFO - PROCESS | 1398 | __end_cc_report 07:45:48 INFO - PROCESS | 1398 | __startTimestamp1483458348923__endTimestamp 07:45:48 INFO - PROCESS | 1398 | 07:45:48 INFO - PROCESS | 1398 | ------- Summary: start ------- 07:45:48 INFO - PROCESS | 1398 | Number of tests: 14 07:45:48 INFO - PROCESS | 1398 | 07:45:48 INFO - PROCESS | 1398 | [#0] ai-astar Cycles:10 Average:116.00 Median:117.50 stddev:3.62 (3.1%) stddev-sans-first:0.93 07:45:48 INFO - PROCESS | 1398 | Values: 106.0 117.0 118.0 116.0 118.0 116.0 118.0 118.0 116.0 117.0 07:45:48 INFO - PROCESS | 1398 | 07:45:48 INFO - PROCESS | 1398 | [#1] audio-beat-detection Cycles:10 Average:141.00 Median:133.50 stddev:18.76 (14.1%) stddev-sans-first:19.39 07:45:48 INFO - PROCESS | 1398 | Values: 153.0 128.0 128.0 184.0 134.0 130.0 130.0 133.0 160.0 130.0 07:45:48 INFO - PROCESS | 1398 | 07:45:48 INFO - PROCESS | 1398 | [#2] audio-dft Cycles:10 Average:165.70 Median:164.00 stddev:4.57 (2.8%) stddev-sans-first:4.74 07:45:48 INFO - PROCESS | 1398 | Values: 163.0 172.0 176.0 163.0 163.0 166.0 164.0 164.0 163.0 163.0 07:45:48 INFO - PROCESS | 1398 | 07:45:48 INFO - PROCESS | 1398 | [#3] audio-fft Cycles:10 Average:83.20 Median:77.00 stddev:13.51 (17.5%) stddev-sans-first:14.07 07:45:48 INFO - PROCESS | 1398 | Values: 76.0 77.0 77.0 115.0 77.0 77.0 76.0 79.0 101.0 77.0 07:45:48 INFO - PROCESS | 1398 | 07:45:48 INFO - PROCESS | 1398 | [#4] audio-oscillator Cycles:10 Average:91.40 Median:85.00 stddev:10.00 (11.8%) stddev-sans-first:10.24 07:45:48 INFO - PROCESS | 1398 | Values: 84.0 85.0 102.0 87.0 86.0 84.0 108.0 86.0 85.0 107.0 07:45:48 INFO - PROCESS | 1398 | 07:45:48 INFO - PROCESS | 1398 | [#5] imaging-gaussian-blur Cycles:10 Average:120.40 Median:120.50 stddev:2.59 (2.1%) stddev-sans-first:2.70 07:45:48 INFO - PROCESS | 1398 | Values: 119.0 119.0 117.0 124.0 122.0 124.0 119.0 123.0 119.0 118.0 07:45:48 INFO - PROCESS | 1398 | 07:45:48 INFO - PROCESS | 1398 | [#6] imaging-darkroom Cycles:10 Average:150.90 Median:151.00 stddev:1.29 (0.9%) stddev-sans-first:1.32 07:45:48 INFO - PROCESS | 1398 | Values: 150.0 150.0 152.0 151.0 151.0 154.0 151.0 150.0 150.0 150.0 07:45:48 INFO - PROCESS | 1398 | 07:45:48 INFO - PROCESS | 1398 | [#7] imaging-desaturate Cycles:10 Average:96.60 Median:97.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 07:45:48 INFO - PROCESS | 1398 | Values: 96.0 97.0 96.0 96.0 97.0 97.0 97.0 96.0 97.0 97.0 07:45:48 INFO - PROCESS | 1398 | 07:45:48 INFO - PROCESS | 1398 | [#8] json-parse-financial Cycles:10 Average:65.00 Median:65.00 stddev:1.05 (1.6%) stddev-sans-first:0.83 07:45:48 INFO - PROCESS | 1398 | Values: 63.0 65.0 65.0 65.0 65.0 67.0 66.0 65.0 64.0 65.0 07:45:48 INFO - PROCESS | 1398 | 07:45:48 INFO - PROCESS | 1398 | [#9] json-stringify-tinderbox Cycles:10 Average:67.60 Median:68.00 stddev:1.26 (1.9%) stddev-sans-first:1.33 07:45:48 INFO - PROCESS | 1398 | Values: 68.0 68.0 66.0 69.0 68.0 67.0 67.0 67.0 66.0 70.0 07:45:48 INFO - PROCESS | 1398 | 07:45:48 INFO - PROCESS | 1398 | [#10] stanford-crypto-aes Cycles:10 Average:86.70 Median:86.00 stddev:2.36 (2.7%) stddev-sans-first:2.42 07:45:48 INFO - PROCESS | 1398 | Values: 85.0 85.0 89.0 85.0 86.0 85.0 85.0 90.0 91.0 86.0 07:45:48 INFO - PROCESS | 1398 | 07:45:48 INFO - PROCESS | 1398 | [#11] stanford-crypto-ccm Cycles:10 Average:147.60 Median:144.00 stddev:16.31 (11.3%) stddev-sans-first:16.86 07:45:48 INFO - PROCESS | 1398 | Values: 158.0 142.0 135.0 146.0 135.0 147.0 142.0 142.0 190.0 139.0 07:45:48 INFO - PROCESS | 1398 | 07:45:48 INFO - PROCESS | 1398 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.00 Median:182.50 stddev:2.62 (1.4%) stddev-sans-first:2.76 07:45:48 INFO - PROCESS | 1398 | Values: 183.0 185.0 183.0 181.0 182.0 187.0 178.0 180.0 181.0 180.0 07:45:48 INFO - PROCESS | 1398 | 07:45:48 INFO - PROCESS | 1398 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.20 Median:71.00 stddev:1.48 (2.1%) stddev-sans-first:1.56 07:45:48 INFO - PROCESS | 1398 | Values: 71.0 74.0 73.0 71.0 72.0 71.0 71.0 70.0 70.0 69.0 07:45:48 INFO - PROCESS | 1398 | -------- Summary: end -------- 07:45:48 INFO - PROCESS | 1398 | 07:45:49 INFO - TEST-INFO | 1398: exit 0 07:45:50 INFO - TEST-OK | kraken | took 63857ms 07:45:50 INFO - SUITE-END | took 1182s 07:45:50 INFO - Completed test suite (00:19:43) 07:45:50 INFO - javascript benchmark 07:45:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6241.223359555952, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2598.7141414444413, 2602.609608558716, 2610.4909542639193, 2637.1297471834296, 2642.2205449392427, 4717.57541821236, 4864.246041863508, 4882.438519570251, 4893.7797799099035, 4906.950930490694, 4796.568308852203, 4819.277108433736, 4855.975720121403, 4869.707817530951, 4926.45808961014, 4460.464744230697, 4506.346579745935, 4538.818447262105, 4541.318802179667, 4650.2559590465535, 4168.7081904266715, 4586.899144205383, 4634.86095417138, 4646.163690535702, 4650.604698600623, 4405.295152775572, 4498.842540511083, 4529.456465224162, 4542.091581683677, 4630.953690463086, 4410.779461026936, 4429.025614364835, 4431.158079964796, 4436.511983681825, 4535.614472769818, 4442.800073996678, 4453.933191002137, 4468.664850136221, 4473.306637471197, 4479.574440428154, 4784.282357646381, 4830.0, 4841.685290456109, 4874.4150701916, 4883.804647814083, 5117.181250999822, 5186.247994040843, 5187.662801917863, 5207.218917162418, 5222.503862133091, 5258.947410525884, 5265.842024739226, 5265.86835329116, 5281.471852814726, 5309.946900530984, 4899.044686286175, 4909.5090490950615, 4909.705417674951, 4927.334809800703, 4959.479254678279, 5181.145111056633, 5198.610104242197, 5219.791208351623, 5293.973530132402, 5379.246905433242, 5035.169197082514, 5055.191169412877, 5073.518015788494, 5092.694438333712, 5137.255098010767, 5093.2105523643895, 5225.085610018232, 5236.92144617831, 5241.42344342122, 5288.312519372457, 5063.0380227756605, 5143.459936706667, 5186.611004174702, 5225.111731005738, 5295.602829787781, 5210.270562121306, 5232.084385232569, 5233.110371236899, 5235.319408476874, 5240.6069544784295, 4343.04453020335, 4399.0, 4399.252127138394, 4400.361947517592, 4501.774911254424, 3809.7523660961947, 3828.2534905693124, 3842.077901303667, 3864.1305706215876, 3869.845206191721, 4379.0, 4421.182081314967, 4423.535528769497, 4430.091831174602, 4456.799444025027, 5199.818006369759, 5219.947800522022, 5251.632385732962, 5270.025045366543, 5280.630355875129, 4380.123975204908, 4428.889277768081, 4435.401220835146, 4457.531959144308, 4469.08383781324, 4674.813007479663, 4700.529947005272, 4715.3869996900185, 4718.9292160617615, 4771.284307353924, 4768.260919557474, 4817.108834865561, 4904.166291730415, 4904.607631389552, 4914.2628605708, 5237.528622424, 5269.841904742864, 5285.101532739367, 5287.841364759063, 5355.410904800391, 4899.706017638953, 4900.068986892479, 4904.043711476228, 4914.778834952364, 4955.82654607087, 5102.642815003062, 5171.715555644476, 5197.974010129925, 5226.216067589892, 5226.686398816083, 5205.505476979681, 5213.400458947118, 5215.55667768244, 5264.710440925785, 5341.946580534145, 5057.949420505748, 5083.796648134034, 5096.719680417465, 5097.158968770112, 5106.10643137442, 4958.776855041459, 4965.925511117264, 5057.342545469065, 5122.974385128051, 5153.845384638467, 4908.312836202863, 4994.850154495371, 5005.174146265826, 5038.84883453497, 5047.1419858623385, 5059.418166910852, 5063.113955057924, 5075.3402057732255, 5080.060188865072, 5123.615728820428, 4906.582940450102, 4951.158303088556, 4970.080535101018, 4976.2286845539, 4989.276554899592], "value": 4776.0275359247635, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [515.5488947171225, 517.8524120625622, 522.287078138341, 525.910595198816, 529.4467281690632, 37617.435738463944, 39929.401058984105, 40043.19913601726, 40075.39886901691, 43159.78420107895, 40093.39859902096, 40405.797971010106, 40630.79684601573, 40756.388654170136, 40798.796006019926, 7752.186020467854, 7922.405819563527, 7944.880826787603, 9545.90454095457, 9892.703218903445, 9678.0, 9683.0, 9688.806223875517, 9718.854217186712, 9804.754881127958, 9726.756831079245, 9732.464714440703, 9743.0, 9777.706668799947, 9813.509324533781, 9721.854172187423, 9741.805163896717, 9747.707568772948, 9779.46212958287, 9786.90213097867, 9691.854622180674, 9732.464714440703, 9757.707268781947, 9760.072793084646, 9772.0, 34411.4838277426, 34522.654773452196, 34748.47877281843, 34812.477812832825, 34815.0, 3592.8203589820405, 3686.668199862025, 3690.280395322913, 3722.7952462614544, 3741.9625803741887, 26046.08838690656, 26193.214203573923, 26395.73604263952, 26604.201873943814, 27410.451790964267, 3367.966320336814, 3453.930921381558, 3537.2571759930447, 3573.6605022522817, 3580.6240344763687, 234847.8257608718, 235031.0, 235461.0, 235926.0, 236320.0, 47160.7641961788, 47317.76341118272, 47753.761231193625, 47875.28187077196, 48070.0, 49814.0, 49916.25125623118, 49947.50052499501, 50377.74811125921, 50486.9610431172, 13186.0, 13410.061295709207, 13469.932650336686, 13473.124246923919, 13494.460221591222, 8153.55155466455, 8394.118617545191, 9955.203583713286, 10095.7476063099, 10191.490425478696, 15936.36254549805, 15989.600259993593, 16027.759583606256, 16041.0, 16229.675406491804, 6511.0, 6606.306337834554, 6628.668566571652, 6656.900146497806, 6670.699818508178, 780.9414293927978, 803.0644299391143, 818.8239528501401, 823.333100188837, 835.0397043400138, 27112.32219194536, 27822.86088569544, 27964.440711185664, 28091.297717556816, 28404.147875563765, 952.6808519146025, 959.947202903833, 971.1114330387758, 985.4678473624163, 988.9752756181009, 13858.584242472742, 14799.408023679147, 14925.626859328386, 15046.398144074334, 15142.242887855784, 350829.0, 351093.1133608299, 353660.0, 354353.0, 355631.0, 50348.0, 51041.234381484304, 51230.74384628053, 51385.48614513807, 51548.22677659763, 1205.785778703437, 1220.6155061155707, 1225.8651548329676, 1227.6685294970487, 1240.2248594628538, 26110.86944565265, 26501.0, 26940.191794246202, 27318.453630927666, 27372.726272737815, 33099.0, 33101.17247068746, 33150.0, 33322.33355332831, 33326.16684582905, 294403.58394624526, 295398.0, 297771.0, 297816.0, 299607.0, 24324.87837560801, 25295.241142765746, 25439.74560254374, 25476.0, 25600.487990240465, 36454.0, 36707.81646091752, 37189.62810371862, 37232.44151337786, 37750.811245943594, 31992.0, 32084.19789505281, 32302.19244518906, 32487.512687310184, 33271.83364083164, 31891.0, 32074.358512829145, 32214.19464513406, 32531.674683253812, 32881.34237315288, 32147.839260803546, 32527.0, 32856.342873141926, 35298.823505882305, 35564.0, 26515.29133599063, 29190.70809291965, 30657.846710766302, 30851.537226942062, 31078.533821992234, 23170.536589268457, 23390.883045584662, 23773.524529508966, 23880.88059559691, 23976.160834370712], "value": 17127.717337141006, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [373.7888093227327, 374.6209193078431, 382.6728147433943, 387.903024243939, 403.6770583533175, 15298.235088245585, 15917.68164636708, 16558.503244902673, 16611.252493637785, 16658.916705416486, 13102.541411050615, 16099.0, 16425.0, 16426.17869106543, 16507.0, 4493.662975276851, 4740.668153229275, 4748.3827102476625, 4754.477007529169, 4754.477007529186, 4663.580277775, 5150.768215430315, 5406.216098665691, 5445.809396671118, 5482.862928426782, 5478.671279723229, 5484.643498172606, 5486.423925487826, 5488.231647569343, 5497.752601132938, 5237.842864714045, 5380.273663055476, 5427.131658934591, 5428.864278393033, 5436.864078398052, 5262.447443018466, 5270.1040823060175, 5272.578193744491, 5282.234076058989, 5282.65662731925, 11601.651950441501, 11683.065354771597, 11828.053755699524, 11836.644900652995, 12105.515779368814, 2051.0770153430867, 2123.458518077896, 2142.1645558232303, 2158.4711745622267, 2170.9891450542805, 8937.374383793072, 8973.641054357819, 8978.595963181673, 9325.300602454843, 9369.906300936971, 1644.0957473389587, 1703.5996540812898, 1726.507945235602, 1729.0749449044702, 1739.91300434979, 62011.37988620101, 62291.37708622901, 62840.37159628391, 63224.36775632231, 64486.03270950892, 9684.661036863676, 9828.459434731158, 10014.599416023424, 10017.649382271586, 10136.0, 13522.391492382867, 13533.255670937997, 13537.0, 13541.1198272112, 13565.525206617918, 6877.552959057645, 7060.858782824314, 7174.964125179341, 7310.52481588695, 7331.596762178131, 6794.966025169842, 6811.318868113149, 6950.513464057569, 6975.546589471668, 6998.68505917235, 4206.684498662613, 4276.273033584298, 4340.587644173798, 4395.846145384896, 4443.111377724404, 1543.5986643472777, 1613.580469078048, 1621.2056092514583, 1888.9127514097, 1903.7049257364854, 813.4021494201756, 822.3256929317902, 832.6003518311123, 847.9448835825651, 854.8033952191031, 15971.201439928189, 16156.67686646284, 16337.101459419608, 16385.754213686803, 16583.092944311316, 809.3080416244144, 813.5525460996429, 817.4073796497491, 819.1767273889702, 839.5340585974842, 8855.0, 9089.136532029446, 9206.815863682688, 9457.38526995743, 9459.810803784023, 311642.0, 342807.0, 347396.0, 347661.0, 348596.0, 57404.13893791597, 70680.0, 70738.64630676917, 73568.26431735721, 73887.63056184685, 425.72115264501804, 447.55021203690734, 451.3004842494187, 451.6522277846106, 451.7334772484184, 9387.342885997914, 10121.949390253001, 10129.848052279074, 10153.543090560795, 10283.897161028593, 27919.720802792526, 29175.0, 33444.0, 34312.485312720826, 37176.44235336418, 41247.01918221781, 43390.56609433991, 43827.56172438235, 43916.34125488184, 46399.76800115978, 5469.617126801086, 7592.8861067082935, 7900.920990790019, 7942.44402891792, 8012.198780121941, 10776.946115269373, 12077.51689932393, 12090.697732556757, 12141.0, 12223.63468680668, 5188.662736922088, 9373.671921482715, 9627.470489123165, 10317.329373590692, 10614.877024595266, 4893.828715994923, 7597.924020759942, 9362.157405833508, 9735.561899714672, 10362.533685983997, 9360.625574976924, 9376.906230937604, 9502.144806967406, 9742.75643108928, 10213.948930255301, 7458.701651933862, 7767.961160194162, 7782.649780759766, 7861.2531809478005, 7934.2859142677435, 9506.857397139187, 9676.516174191403, 9787.755306117404, 9845.655402060893, 10010.0], "value": 7514.096253902629, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1316.5984374765696, 1339.7052648417346, 1345.650130965949, 1345.6703107738606, 1346.1519242876989, 6711.328867113286, 6896.310368963113, 7049.54177978431, 7500.737474188404, 7514.211007844179, 7035.226125126232, 7237.819054523639, 7285.672144753486, 7502.21226771188, 7504.774856754292, 2123.2568600989684, 2174.8586341887726, 2178.934631961036, 2183.0612836480386, 2190.408589680785, 2130.8401869859745, 2154.644483660194, 2200.7689192634784, 2205.94485137872, 2224.043661225672, 2169.9891500542476, 2197.121151539381, 2204.7464541577765, 2206.305013920618, 2212.214663794354, 2075.1595603780415, 2098.412444515538, 2099.3387083068937, 2101.989490052555, 2124.1715730864976, 2141.4004078857943, 2143.2820005298245, 2162.2107930605216, 2167.0898222746328, 2172.0985790896757, 7409.333160015624, 7571.205023472567, 7577.0, 7593.126790419062, 7605.6577454014705, 4545.454545454533, 4691.343211950296, 4701.271302948048, 4701.929471057937, 4716.410448693913, 2753.559430491112, 2933.662628797694, 2992.326726486545, 3001.0846691759007, 3026.8335241561704, 1116.5366372955214, 1177.3171560494893, 1206.6983254186453, 1206.8853458921387, 1229.9385030748517, 9811.705648830475, 9885.703428897144, 9895.406275623485, 9927.354721943051, 9931.950340248324, 3834.1373191032353, 3922.6077392260545, 3961.8217180226957, 3994.560598334181, 4075.775832329191, 7931.643076061591, 7945.880811787828, 7959.761207163794, 7960.243776841191, 7963.641636126388, 4452.332150177434, 4515.322701594787, 4520.88697782558, 4560.179167749837, 4563.931541026887, 4181.874543763692, 4239.300515414983, 4256.425382573375, 4261.126469073833, 4267.615914567704, 3108.6425061117807, 3177.158053115926, 3190.920226994344, 3209.9197520062185, 3252.3820474109843, 907.8456662367413, 929.3921515777743, 974.7319487141093, 976.6728146071003, 986.6102889358663, 692.2592825676578, 701.1446035836271, 708.2775568919673, 720.3660778514874, 734.5262305812721, 4865.12427762999, 4900.8774780630765, 5094.337736094284, 5145.331106956071, 5145.691258524501, 825.0923983618092, 826.8883700700449, 831.2934006094771, 836.5566249887569, 837.9203975622306, 3422.4524076147695, 3480.9477857832153, 3503.824808759603, 3549.112721819545, 3606.0, 8301.626426810688, 8652.653893844301, 8685.0, 8711.303095752324, 8715.52064636451, 8495.1080136586, 8535.914640853636, 8566.3146948244, 8575.313974881994, 8646.481211127353, 6654.467642588581, 6796.76211332601, 6836.042953986446, 6858.0, 6867.862642747117, 4849.102915960559, 4903.362562866804, 4927.433345165352, 4951.306817045544, 5109.233614957638, 7859.52842829432, 7886.72396466121, 7926.0, 7983.760487185394, 8013.759587212393, 7933.523988560705, 7996.920030799618, 8024.679012839421, 8111.310538604049, 8124.431289809657, 5976.372480889444, 6055.486128467883, 6056.091586262096, 6060.969695151496, 6072.14989901423, 6808.659567021728, 6866.141732283465, 6904.0, 6953.6523173842115, 6968.651567421507, 6176.104464852481, 6196.907046394398, 6231.189945307262, 6241.095041219089, 6272.09054687077, 6093.0, 6172.135900973957, 6219.129321894848, 6222.471089957223, 6284.748610055546, 5618.494335509824, 5694.259746232963, 5726.770929162787, 5743.483086522233, 5759.8560035999435, 4257.254980378483, 4284.143171365677, 4354.281543545406, 4404.031113155229, 4476.507584165674, 4078.4697989262395, 4177.665786737114, 4302.204092242945, 4391.934120988251, 4416.646668266595], "value": 3910.6598288920513, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.4813431718106, 349.8950314905529, 353.0221287034913, 355.3000588839986, 355.6550146358032, 4887.340209071775, 4908.803647854091, 4927.433345165307, 4971.627127965399, 4975.2039673652225, 4905.288733133702, 4917.4836642152595, 4920.458749537548, 4920.483349248322, 4924.261360795874, 3700.9259814803686, 3825.3114439400897, 3865.845366185363, 3950.308695978214, 3957.168994511156, 3953.1339778660526, 3957.1508513870112, 3964.6828253739777, 3968.424578436125, 3969.9951524480243, 3936.7047471439614, 3938.940915886264, 3946.2896678597986, 3948.3090459169675, 3951.70362222833, 3901.7463864848696, 3943.3493473576827, 3975.70182236332, 3993.7803420811842, 3994.5406278277787, 3556.28874225156, 3560.893173204782, 3568.7858728476376, 3581.2837432513343, 3593.9101522461888, 4759.785809638574, 4785.387032790256, 4803.759812009421, 4822.1561226785525, 4825.276208568707, 4569.954300456986, 4575.588197062247, 4581.702189357681, 4583.518730533313, 4594.1271158479785, 4987.975060124712, 5138.897222055575, 5148.510891465305, 5152.871178220575, 5193.532582067632, 3803.885883423474, 3808.447775072599, 3809.580946095927, 3813.0, 3819.7135214858995, 5259.764600044966, 5478.342598888159, 5514.338279406456, 5516.282883225195, 5518.034343989786, 3868.6324799144036, 3870.477485539416, 3888.6111388861455, 3890.299746045739, 3900.8244628991197, 3919.3141200289833, 3925.4111883217747, 3927.9214415711526, 3935.763854168759, 3940.310445671996, 4429.844955426544, 4429.867103986821, 4438.667099967515, 4441.844535441244, 4444.2222611042935, 5038.64729468941, 5143.228515722672, 5183.637145399785, 5197.948020519822, 5259.447757985433, 1374.8863420629323, 1385.4275397423996, 1389.2220356600337, 1391.4295138993166, 1398.3637444962517, 954.355809828377, 995.6664517386612, 999.7200783780553, 1018.9861088217272, 1020.806046851096, 4366.868993930188, 4368.737875727466, 4395.648348132142, 4416.823327066945, 4424.292113261927, 5241.353116676054, 5263.210518422267, 5272.55183309423, 5281.630285879952, 5308.681479111188, 4252.213340532012, 4386.7367957922625, 4397.846075387346, 4408.448943882015, 4421.214634780068, 2784.5823126530777, 2798.860056997142, 2811.6344875166096, 2823.3506293552596, 2841.4743272494657, 4882.0, 4919.0, 4920.778564964585, 4931.580815630711, 4968.403791544965, 5224.451432599599, 5362.70505122222, 5371.221172929982, 5397.433269506645, 5516.282883225235, 5004.097623378432, 5020.347354843847, 5034.798608055637, 5038.6976781392505, 5045.268436076748, 5388.515033646991, 5414.756335964812, 5429.348478182485, 5449.700266485382, 5462.972685136708, 5209.609279303992, 5297.358313396221, 5336.146216605324, 5352.924430771025, 5380.757865895966, 4841.313071245492, 4944.406671199479, 4977.552020318189, 5034.748262586929, 5038.370203724535, 3629.764065335745, 3712.9443058353604, 3761.2101458693983, 3770.981145094257, 3775.981120094382, 5305.540976231413, 5309.309789727311, 5314.548263397654, 5326.25432439451, 5358.839234822962, 4998.475160108136, 5152.6650767699975, 5154.407243167084, 5175.792968281377, 5176.870578235424, 5108.846734597968, 5164.767585458589, 5174.922376164285, 5175.327207463006, 5175.81884634051, 5108.540231379045, 5109.97800439906, 5129.820456284012, 5143.794248230029, 5147.845564633067, 5031.899362012812, 5177.223416487557, 5189.299444575085, 5204.713740744295, 5214.217867319932, 5072.771725272298, 5076.238564215398, 5080.796768129381, 5101.51535604117, 5104.183330667075], "value": 3956.664554200084, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [653.6633633678659, 662.0764034172332, 688.4526801193051, 691.6714560583722, 699.8775214337493, 12048.7590248195, 12635.49458021678, 12645.0, 12669.49322027119, 12810.359482025897, 12753.426095825687, 12903.225806451619, 12934.223946563212, 12986.28575428351, 13068.607941761762, 812.236497692169, 827.5159031966307, 828.9999999999969, 829.713748756678, 830.149097175394, 806.9193080691942, 815.5799763121968, 815.7104227999064, 825.7522743177022, 845.3490812074699, 827.5779352530193, 828.2462958707578, 831.2767891934026, 859.6561375449838, 863.9784005399853, 856.5931182688236, 858.961346739392, 859.5014891362995, 860.7245681381897, 861.0915484164235, 624.6938999890067, 627.0875875601035, 627.0969803482969, 627.9246490421178, 629.078400143787, 12641.367931603383, 12866.163699359511, 12873.227606343557, 12927.09510334277, 12959.222446653232, 11795.528178872835, 12361.69095772604, 12443.315617641027, 12553.246805191626, 13100.0, 9561.713148605553, 10610.787784244272, 11582.826257606142, 11922.403879805976, 11964.521419143224, 4008.2183974125055, 4071.5114186297537, 4085.121698834735, 4088.5911408858874, 4267.4025636410925, 67055.66472167657, 67905.3209467899, 68146.31853681449, 68636.31363686349, 70477.64761176212, 10597.576096956036, 10809.459527023617, 10821.729456763644, 10837.133029357632, 10877.347359158475, 19476.318328858706, 19518.609627807364, 19538.609227815363, 19540.511487212934, 19623.509412264808, 6522.249941256721, 6601.306862779339, 6623.105880706139, 6698.83252918681, 6789.898151527731, 3550.4141816600486, 3646.2889736501656, 3666.1201311685004, 3676.7058635309113, 3677.9632203678157, 2507.661465702107, 2562.8590427526665, 2584.2505673354894, 2588.314096764359, 2627.2118364490957, 485.69158584299225, 488.4382959596421, 490.1324655360064, 496.0500641271924, 500.294584635662, 589.2928485817037, 593.6912805341199, 595.4373117404098, 604.8185544336769, 631.7315141065029, 7714.344280736088, 8400.65586515887, 8601.483910965362, 8863.512506812187, 9057.954710226406, 492.69699135032414, 506.45050120618805, 507.58124547248667, 584.5119325363369, 643.3694978920684, 3873.1091848874917, 4182.100848317566, 4201.2017716633745, 4213.810378532973, 4332.675049371247, 63830.36169638337, 64078.35921640724, 65034.34965650378, 65187.0, 66911.9632055186, 57333.42666573281, 57651.71174144186, 58041.12938305929, 58087.0, 58199.4180058194, 50064.49935500598, 51433.48566514362, 51549.48450515447, 51785.48214517882, 52383.0, 7774.572398517909, 8040.316573091119, 8106.351491880518, 8128.431009829255, 8208.600617723896, 34993.475097873044, 35126.0, 36290.0, 36314.63685363113, 36974.63025369712, 43114.353284700126, 45568.54431455643, 46405.30392044054, 47188.0, 47785.28322075102, 9494.905050949403, 9626.278029147701, 10115.898841011496, 10121.0, 10473.057424831803, 10722.0, 10751.19366047534, 10827.296225745302, 11268.211225214156, 11318.4906679198, 10816.621418250323, 10930.890691093306, 11231.831522527005, 11416.143789216008, 11455.942720286344, 10890.346579205274, 11454.885451145381, 11483.540658373571, 11676.824847627462, 11731.296122232694, 10286.331388459726, 10379.169666426818, 10414.114800242065, 10613.9469302653, 10676.893231067901, 8823.161799629024, 8912.108789121035, 9005.279577633904, 9346.579403926704, 9415.670451534163, 7962.880556791769, 8051.959740201261, 8058.798530036796, 8206.466579672302, 8423.620937057969], "value": 6213.6779970351645, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1585.2999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 117.0, 118.0, 116.0, 118.0, 116.0, 118.0, 118.0, 116.0, 117.0], "value": 116.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 128.0, 128.0, 184.0, 134.0, 130.0, 130.0, 133.0, 160.0, 130.0], "value": 141.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 172.0, 176.0, 163.0, 163.0, 166.0, 164.0, 164.0, 163.0, 163.0], "value": 165.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 77.0, 115.0, 77.0, 77.0, 76.0, 79.0, 101.0, 77.0], "value": 83.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 102.0, 87.0, 86.0, 84.0, 108.0, 86.0, 85.0, 107.0], "value": 91.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 119.0, 117.0, 124.0, 122.0, 124.0, 119.0, 123.0, 119.0, 118.0], "value": 120.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 152.0, 151.0, 151.0, 154.0, 151.0, 150.0, 150.0, 150.0], "value": 150.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 96.0, 96.0, 97.0, 97.0, 97.0, 96.0, 97.0, 97.0], "value": 96.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 65.0, 65.0, 65.0, 67.0, 66.0, 65.0, 64.0, 65.0], "value": 65.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 66.0, 69.0, 68.0, 67.0, 67.0, 67.0, 66.0, 70.0], "value": 67.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 89.0, 85.0, 86.0, 85.0, 85.0, 90.0, 91.0, 86.0], "value": 86.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 142.0, 135.0, 146.0, 135.0, 147.0, 142.0, 142.0, 190.0, 139.0], "value": 147.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 185.0, 183.0, 181.0, 182.0, 187.0, 178.0, 180.0, 181.0, 180.0], "value": 182.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 74.0, 73.0, 71.0, 72.0, 71.0, 71.0, 70.0, 70.0, 69.0], "value": 71.2, "unit": "score"}]}]} 07:45:50 INFO - Return code: 0 07:45:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:45:50 ERROR - # TBPL SUCCESS # 07:45:50 INFO - Running post-action listener: _resource_record_post_action 07:45:50 INFO - [mozharness: 2017-01-03 15:45:50.224791Z] Finished run-tests step (success) 07:45:50 INFO - Running post-run listener: _resource_record_post_run 07:45:50 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 8192; Write bytes: 394915840; Read time: 28; Write time: 194016 07:45:50 INFO - TinderboxPrint: CPU usage
13.5% 07:45:50 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 28 07:45:50 INFO - TinderboxPrint: I/O write bytes / time
394,915,840 / 194,016 07:45:50 INFO - TinderboxPrint: CPU idle
8,276.0 (86.5%) 07:45:50 INFO - TinderboxPrint: CPU user
1,234.9 (12.9%) 07:45:50 INFO - TinderboxPrint: Swap in / out
0 / 0 07:45:50 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 100040704; Read time: 0; Write time: 44124 07:45:50 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 8192; Write bytes: 283664384; Read time: 28; Write time: 142648 07:45:50 INFO - Running post-run listener: _upload_blobber_files 07:45:50 INFO - Blob upload gear active. 07:45:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:45:50 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 07:45:50 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:45:50 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:45:51 INFO - (blobuploader) - INFO - Open directory for files ... 07:45:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:45:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:45:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:45:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:45:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:45:52 INFO - (blobuploader) - INFO - Done attempting. 07:45:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:45:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:45:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:45:55 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:45:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:45:55 INFO - (blobuploader) - INFO - Done attempting. 07:45:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:45:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:45:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:45:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:45:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:45:55 INFO - (blobuploader) - INFO - Done attempting. 07:45:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:45:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:45:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:45:56 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:45:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:45:56 INFO - (blobuploader) - INFO - Done attempting. 07:45:56 INFO - (blobuploader) - INFO - Iteration through files over. 07:45:56 INFO - Return code: 0 07:45:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:45:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:45:56 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f606099e289cab7cdfd3afdea7238b14d9afaac6877d0af0cdb8272a788b9a3bcfad4ef00c82222ccd64bfb69e6e8a3cac350519f0f73d27e5b38a9550090743", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1e0e8e89b05f140d6873cb26e19d2804b7cd9aec5de6364f399e8ca789ce0180988c8a96685a1420c66c0e0c0330286033607255a7275624246117a267fd62d6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f109abb025a81d5b4c8a826d27b58b5e0a69d4de42269f5d2b39ea0de653b54a74e505e3f435f5dc221be14160d146f031c623601da9c2b55657742321490e7a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4e6950300c398e20bc3da31afa471c9abf10b35ac1fea8f03efd2e14b7ee542a6b3c70026468aaf2edd4085e9b388fc64b8995bb658a097eb22ec987e46ad2ce"} 07:45:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:45:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:45:56 INFO - Contents: 07:45:56 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f606099e289cab7cdfd3afdea7238b14d9afaac6877d0af0cdb8272a788b9a3bcfad4ef00c82222ccd64bfb69e6e8a3cac350519f0f73d27e5b38a9550090743", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1e0e8e89b05f140d6873cb26e19d2804b7cd9aec5de6364f399e8ca789ce0180988c8a96685a1420c66c0e0c0330286033607255a7275624246117a267fd62d6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f109abb025a81d5b4c8a826d27b58b5e0a69d4de42269f5d2b39ea0de653b54a74e505e3f435f5dc221be14160d146f031c623601da9c2b55657742321490e7a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4e6950300c398e20bc3da31afa471c9abf10b35ac1fea8f03efd2e14b7ee542a6b3c70026468aaf2edd4085e9b388fc64b8995bb658a097eb22ec987e46ad2ce"} 07:45:56 INFO - Running post-run listener: copy_logs_to_upload_dir 07:45:56 INFO - Copying logs to upload dir... 07:45:56 INFO - mkdir: /builds/slave/test/build/upload/logs 07:45:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.711850 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2017-01-03 07:45:55.446050) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-03 07:45:55.449764) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1483456911.235964-1506752328 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f606099e289cab7cdfd3afdea7238b14d9afaac6877d0af0cdb8272a788b9a3bcfad4ef00c82222ccd64bfb69e6e8a3cac350519f0f73d27e5b38a9550090743", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1e0e8e89b05f140d6873cb26e19d2804b7cd9aec5de6364f399e8ca789ce0180988c8a96685a1420c66c0e0c0330286033607255a7275624246117a267fd62d6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f109abb025a81d5b4c8a826d27b58b5e0a69d4de42269f5d2b39ea0de653b54a74e505e3f435f5dc221be14160d146f031c623601da9c2b55657742321490e7a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4e6950300c398e20bc3da31afa471c9abf10b35ac1fea8f03efd2e14b7ee542a6b3c70026468aaf2edd4085e9b388fc64b8995bb658a097eb22ec987e46ad2ce"} build_url:https://queue.taskcluster.net/v1/task/bMcVyxPBS166SDW_dKXzkQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011216 build_url: 'https://queue.taskcluster.net/v1/task/bMcVyxPBS166SDW_dKXzkQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f606099e289cab7cdfd3afdea7238b14d9afaac6877d0af0cdb8272a788b9a3bcfad4ef00c82222ccd64bfb69e6e8a3cac350519f0f73d27e5b38a9550090743", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1e0e8e89b05f140d6873cb26e19d2804b7cd9aec5de6364f399e8ca789ce0180988c8a96685a1420c66c0e0c0330286033607255a7275624246117a267fd62d6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f109abb025a81d5b4c8a826d27b58b5e0a69d4de42269f5d2b39ea0de653b54a74e505e3f435f5dc221be14160d146f031c623601da9c2b55657742321490e7a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4e6950300c398e20bc3da31afa471c9abf10b35ac1fea8f03efd2e14b7ee542a6b3c70026468aaf2edd4085e9b388fc64b8995bb658a097eb22ec987e46ad2ce"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-03 07:45:55.479894) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-03 07:45:55.480235) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1483456911.235964-1506752328 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004547 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-03 07:45:55.564979) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-03 07:45:55.565313) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-03 07:45:55.565639) ========= ========= Total master_lag: 0.18 =========