builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-066 starttime: 1488593161.39 results: success (0) revision: 9a117f52a1371a223ff79a1f67a4b8cf08f9b69b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-03 18:06:01.389696) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-03 18:06:01.391154) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-03 18:06:01.391425) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-03 18:06:01.406194) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-03 18:06:01.406508) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1488592142.169400-722335293 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-03 18:06:01-- 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% 46.5M=0s 2017-03-03 18:06:02 (46.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.149643 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-03 18:06:01.573691) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-03 18:06:01.574228) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1488592142.169400-722335293 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017343 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-03 18:06:01.628867) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-03 18:06:01.630107) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 9a117f52a1371a223ff79a1f67a4b8cf08f9b69b --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 9a117f52a1371a223ff79a1f67a4b8cf08f9b69b --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=82c74bd3bc9a11c5833d2010000001e6-1488592142.169400-722335293 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-03 18:06:02,250 truncating revision to first 12 chars 2017-03-03 18:06:02,250 Setting DEBUG logging. 2017-03-03 18:06:02,250 attempt 1/10 2017-03-03 18:06:02,250 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/9a117f52a137?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-03 18:06:02,689 unpacking tar archive at: mozilla-central-9a117f52a137/testing/mozharness/ program finished with exit code 0 elapsedTime=0.748817 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-03 18:06:02.396906) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-03 18:06:02.397232) ========= script_repo_revision: 9a117f52a1371a223ff79a1f67a4b8cf08f9b69b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-03 18:06:02.397621) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-03 18:06:02.397886) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-03 18:06:02.408323) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2017-03-03 18:06:02.408650) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=82c74bd3bc9a11c5833d2010000001e6-1488592142.169400-722335293 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:06:03 INFO - MultiFileLogger online at 20170303 18:06:03 in /builds/slave/test 18:06:03 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 18:06:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:06:03 INFO - {'append_to_log': False, 18:06:03 INFO - 'base_work_dir': '/builds/slave/test', 18:06:03 INFO - 'blob_upload_branch': 'Firefox', 18:06:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:06:03 INFO - 'branch': 'Firefox', 18:06:03 INFO - 'buildbot_json_path': 'buildprops.json', 18:06:03 INFO - 'config_files': ('talos/linux_config.py',), 18:06:03 INFO - 'default_actions': ('clobber', 18:06:03 INFO - 'read-buildbot-config', 18:06:03 INFO - 'download-and-extract', 18:06:03 INFO - 'populate-webroot', 18:06:03 INFO - 'create-virtualenv', 18:06:03 INFO - 'install', 18:06:03 INFO - 'run-tests'), 18:06:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:06:03 INFO - 'download_minidump_stackwalk': True, 18:06:03 INFO - 'download_symbols': 'ondemand', 18:06:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:06:03 INFO - 'tooltool.py': '/tools/tooltool.py', 18:06:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:06:03 INFO - '/tools/misc-python/virtualenv.py')}, 18:06:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:06:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:06:03 INFO - 'gecko_profile': False, 18:06:03 INFO - 'gecko_profile_interval': 0, 18:06:03 INFO - 'installer_path': 'installer.exe', 18:06:03 INFO - 'log_level': 'info', 18:06:03 INFO - 'log_name': 'talos', 18:06:03 INFO - 'log_to_console': True, 18:06:03 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:06:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:06:03 INFO - 'opt_config_files': (), 18:06:03 INFO - 'pip_index': False, 18:06:03 INFO - 'suite': 'dromaeojs', 18:06:03 INFO - 'system_bits': '32', 18:06:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:06:03 INFO - 'title': 'talos-linux64-ix-066', 18:06:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:06:03 INFO - 'use_talos_json': True, 18:06:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:06:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:06:03 INFO - 'work_dir': 'build'} 18:06:03 INFO - [mozharness: 2017-03-04 02:06:03.120562Z] Running clobber step. 18:06:03 INFO - Running pre-action listener: _resource_record_pre_action 18:06:03 INFO - Running main action method: clobber 18:06:03 INFO - rmtree: /builds/slave/test/build 18:06:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:06:04 INFO - Running post-action listener: _resource_record_post_action 18:06:04 INFO - [mozharness: 2017-03-04 02:06:04.039303Z] Finished clobber step (success) 18:06:04 INFO - [mozharness: 2017-03-04 02:06:04.039403Z] Running read-buildbot-config step. 18:06:04 INFO - Running pre-action listener: _resource_record_pre_action 18:06:04 INFO - Running main action method: read_buildbot_config 18:06:04 INFO - Using buildbot properties: 18:06:04 INFO - { 18:06:04 INFO - "project": "", 18:06:04 INFO - "product": "firefox", 18:06:04 INFO - "who": "kwierso@gmail.com", 18:06:04 INFO - "installer_path": "public/build/target.tar.bz2", 18:06:04 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 18:06:04 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 18:06:04 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 18:06:04 INFO - "stage_platform": "linux64-pgo", 18:06:04 INFO - "basedir": "/builds/slave/test", 18:06:04 INFO - "buildnumber": 57, 18:06:04 INFO - "platform": "ubuntu64_hw", 18:06:04 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 18:06:04 INFO - "slavebuilddir": "test", 18:06:04 INFO - "taskId": "GkjyF1c1Q-uyQv_Lj5_Cqg", 18:06:04 INFO - "branch": "mozilla-central", 18:06:04 INFO - "script_repo_revision": "production", 18:06:04 INFO - "revision": "9a117f52a1371a223ff79a1f67a4b8cf08f9b69b", 18:06:04 INFO - "slavename": "talos-linux64-ix-066", 18:06:04 INFO - "repo_path": "mozilla-central" 18:06:04 INFO - } 18:06:04 INFO - Finding installer, test and symbols from parent task. 18:06:04 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GkjyF1c1Q-uyQv_Lj5_Cqg'}, attempt #1 18:06:04 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GkjyF1c1Q-uyQv_Lj5_Cqg'}, attempt #1 18:06:04 INFO - Task dependencies: EZUAmDZLThm1pkhGQXcXhw 18:06:04 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EZUAmDZLThm1pkhGQXcXhw'}, attempt #1 18:06:05 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/EZUAmDZLThm1pkhGQXcXhw/artifacts/public/build/target.tar.bz2 18:06:05 INFO - Set test_url: https://queue.taskcluster.net/v1/task/EZUAmDZLThm1pkhGQXcXhw/artifacts/public/build/test_packages.json 18:06:05 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/EZUAmDZLThm1pkhGQXcXhw/artifacts/public/build/target.crashreporter-symbols.zip 18:06:05 INFO - Running post-action listener: _resource_record_post_action 18:06:05 INFO - [mozharness: 2017-03-04 02:06:05.421461Z] Finished read-buildbot-config step (success) 18:06:05 INFO - [mozharness: 2017-03-04 02:06:05.421679Z] Running download-and-extract step. 18:06:05 INFO - Running pre-action listener: _resource_record_pre_action 18:06:05 INFO - Running main action method: download_and_extract 18:06:05 INFO - mkdir: /builds/slave/test/build/tests 18:06:05 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')]} 18:06:05 INFO - trying https://queue.taskcluster.net/v1/task/EZUAmDZLThm1pkhGQXcXhw/artifacts/public/build/target.test_packages.json 18:06:05 INFO - Downloading https://queue.taskcluster.net/v1/task/EZUAmDZLThm1pkhGQXcXhw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 18:06:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EZUAmDZLThm1pkhGQXcXhw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 18:06:05 INFO - Downloaded 896 bytes. 18:06:05 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 18:06:05 INFO - Using the following test package requirements: 18:06:05 INFO - {u'common': [u'target.common.tests.zip'], 18:06:05 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 18:06:05 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 18:06:05 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 18:06:05 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 18:06:05 INFO - u'mozbase': [u'target.common.tests.zip'], 18:06:05 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 18:06:05 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 18:06:05 INFO - u'web-platform': [u'target.common.tests.zip', 18:06:05 INFO - u'target.web-platform.tests.zip'], 18:06:05 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 18:06:05 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 18:06:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EZUAmDZLThm1pkhGQXcXhw/artifacts/public/build/target.common.tests.zip 18:06:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EZUAmDZLThm1pkhGQXcXhw/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:06:05 INFO - Fetch https://queue.taskcluster.net/v1/task/EZUAmDZLThm1pkhGQXcXhw/artifacts/public/build/target.common.tests.zip into memory 18:06:07 INFO - Expected file size: 59616914 18:06:07 INFO - Obtained file size: 59616914 18:06:17 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 18:06:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EZUAmDZLThm1pkhGQXcXhw/artifacts/public/build/target.common.tests.zip 18:06:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EZUAmDZLThm1pkhGQXcXhw/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:06:17 INFO - Fetch https://queue.taskcluster.net/v1/task/EZUAmDZLThm1pkhGQXcXhw/artifacts/public/build/target.common.tests.zip into memory 18:06:18 INFO - Expected file size: 59616914 18:06:18 INFO - Obtained file size: 59616914 18:06:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EZUAmDZLThm1pkhGQXcXhw/artifacts/public/build/target.talos.tests.zip 18:06:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EZUAmDZLThm1pkhGQXcXhw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 18:06:29 INFO - Fetch https://queue.taskcluster.net/v1/task/EZUAmDZLThm1pkhGQXcXhw/artifacts/public/build/target.talos.tests.zip into memory 18:06:30 INFO - Expected file size: 14404424 18:06:30 INFO - Obtained file size: 14404424 18:06:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:06:31 INFO - trying https://queue.taskcluster.net/v1/task/EZUAmDZLThm1pkhGQXcXhw/artifacts/public/build/target.tar.bz2 18:06:31 INFO - Downloading https://queue.taskcluster.net/v1/task/EZUAmDZLThm1pkhGQXcXhw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 18:06:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EZUAmDZLThm1pkhGQXcXhw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 18:06:33 INFO - Downloaded 67129117 bytes. 18:06:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EZUAmDZLThm1pkhGQXcXhw/artifacts/public/build/target.tar.bz2 18:06:33 INFO - mkdir: /builds/slave/test/properties 18:06:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:06:33 INFO - Writing to file /builds/slave/test/properties/build_url 18:06:33 INFO - Contents: 18:06:33 INFO - build_url:https://queue.taskcluster.net/v1/task/EZUAmDZLThm1pkhGQXcXhw/artifacts/public/build/target.tar.bz2 18:06:33 INFO - Running post-action listener: _resource_record_post_action 18:06:33 INFO - Running post-action listener: set_extra_try_arguments 18:06:33 INFO - [mozharness: 2017-03-04 02:06:33.450490Z] Finished download-and-extract step (success) 18:06:33 INFO - [mozharness: 2017-03-04 02:06:33.450618Z] Running populate-webroot step. 18:06:33 INFO - Running pre-action listener: _resource_record_pre_action 18:06:33 INFO - Running main action method: populate_webroot 18:06:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:06:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:06:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:06:33 INFO - '--tppagecycles', 18:06:33 INFO - '7'], 18:06:33 INFO - 'tests': ['tsvgm']}}, 18:06:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:06:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:06:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:06:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:06:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:06:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:06:33 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 18:06:33 INFO - 'talos_options': ['--disable-e10s'], 18:06:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:06:33 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 18:06:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:06:33 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 18:06:33 INFO - 'talos_options': ['--disable-e10s'], 18:06:33 INFO - 'tests': ['damp', 'tps']}, 18:06:33 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 18:06:33 INFO - 'tests': ['damp', 'tps']}, 18:06:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:06:33 INFO - 'tests': ['dromaeo_dom']}, 18:06:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:06:33 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:06:33 INFO - 'tests': ['basic_compositor_video']}, 18:06:33 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:06:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:06:33 INFO - 'tests': ['a11yr', 18:06:33 INFO - 'ts_paint', 18:06:33 INFO - 'tpaint', 18:06:33 INFO - 'sessionrestore', 18:06:33 INFO - 'sessionrestore_no_auto_restore', 18:06:33 INFO - 'tabpaint']}, 18:06:33 INFO - 'other-e10s': {'tests': ['a11yr', 18:06:33 INFO - 'ts_paint', 18:06:33 INFO - 'tpaint', 18:06:33 INFO - 'sessionrestore', 18:06:33 INFO - 'sessionrestore_no_auto_restore', 18:06:33 INFO - 'tabpaint']}, 18:06:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:06:33 INFO - 'ts_paint', 18:06:33 INFO - 'tpaint', 18:06:33 INFO - 'sessionrestore', 18:06:33 INFO - 'sessionrestore_no_auto_restore', 18:06:33 INFO - 'tabpaint']}, 18:06:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:06:33 INFO - 'ts_paint', 18:06:33 INFO - 'tpaint', 18:06:33 INFO - 'sessionrestore', 18:06:33 INFO - 'sessionrestore_no_auto_restore', 18:06:33 INFO - 'tabpaint']}, 18:06:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:06:33 INFO - 'tests': ['a11yr', 18:06:33 INFO - 'ts_paint', 18:06:33 INFO - 'tpaint', 18:06:33 INFO - 'sessionrestore', 18:06:33 INFO - 'sessionrestore_no_auto_restore', 18:06:33 INFO - 'tabpaint']}, 18:06:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:06:33 INFO - 'tests': ['a11yr', 18:06:33 INFO - 'ts_paint', 18:06:33 INFO - 'tpaint', 18:06:33 INFO - 'sessionrestore', 18:06:33 INFO - 'sessionrestore_no_auto_restore', 18:06:33 INFO - 'tabpaint']}, 18:06:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:06:33 INFO - 'tests': ['tsvgx', 18:06:33 INFO - 'tsvgr_opacity', 18:06:33 INFO - 'tart', 18:06:33 INFO - 'tscrollx', 18:06:33 INFO - 'cart', 18:06:33 INFO - 'tsvg_static']}, 18:06:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:06:33 INFO - 'tsvgr_opacity', 18:06:33 INFO - 'tart', 18:06:33 INFO - 'tscrollx', 18:06:33 INFO - 'cart', 18:06:33 INFO - 'tsvg_static']}, 18:06:33 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 18:06:33 INFO - 'talos_options': ['--disable-e10s'], 18:06:33 INFO - 'tests': ['tp5o']}, 18:06:33 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 18:06:33 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 18:06:33 INFO - 'talos_options': ['--disable-e10s', 18:06:33 INFO - '--xperf_path', 18:06:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:06:33 INFO - 'tests': ['tp5n']}, 18:06:33 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 18:06:33 INFO - 'talos_options': ['--xperf_path', 18:06:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:06:33 INFO - 'tests': ['tp5n']}}, 18:06:33 INFO - 'talos.zip': {'path': '', 18:06:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:06:33 INFO - Running post-action listener: _resource_record_post_action 18:06:33 INFO - [mozharness: 2017-03-04 02:06:33.464081Z] Finished populate-webroot step (success) 18:06:33 INFO - [mozharness: 2017-03-04 02:06:33.464192Z] Running create-virtualenv step. 18:06:33 INFO - Running pre-action listener: _resource_record_pre_action 18:06:33 INFO - Running main action method: create_virtualenv 18:06:33 INFO - Creating virtualenv /builds/slave/test/build/venv 18:06:33 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 18:06:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:06:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:06:33 INFO - Using real prefix '/usr' 18:06:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:06:34 INFO - Installing distribute.............................................................................................................................................................................................done. 18:06:36 INFO - Installing pip.................done. 18:06:36 INFO - Return code: 0 18:06:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:06:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:06:36 INFO - Reading from file tmpfile_stdout 18:06:36 INFO - Output received: 18:06:36 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) 18:06:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:06: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')]} 18:06:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:06:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:06: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')]} 18:06:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:06:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:06:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b7c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e1a310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e17400>, '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 0x1e183b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e18840>, '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': '82c74bd3bc9a11c5833d2010000001e6-1488592142.169400-722335293', '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 18:06:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:06:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:06:36 INFO - Using env: {'DISPLAY': ':0', 18:06:36 INFO - 'HOME': '/home/cltbld', 18:06:36 INFO - 'LANG': 'en_US.UTF-8', 18:06:36 INFO - 'LANGUAGE': 'en_US:en', 18:06:36 INFO - 'LOGNAME': 'cltbld', 18:06:36 INFO - 'MAIL': '/var/mail/cltbld', 18:06:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:06:36 INFO - 'MOZ_NO_REMOTE': '1', 18:06:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:06:36 INFO - 'NO_EM_RESTART': '1', 18:06:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:06:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:06:36 INFO - 'PWD': '/builds/slave/test', 18:06:36 INFO - 'SHELL': '/bin/bash', 18:06:36 INFO - 'SHLVL': '1', 18:06:36 INFO - 'TERM': 'linux', 18:06:36 INFO - 'TMOUT': '86400', 18:06:36 INFO - 'USER': 'cltbld', 18:06:36 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1488592142.169400-722335293', 18:06:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:06:36 INFO - '_': '/tools/buildbot/bin/python'} 18:06:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:06:36 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 18:06:36 INFO - Cleaning up... 18:06:36 INFO - Return code: 0 18:06:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:06: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')]} 18:06:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:06:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:06: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')]} 18:06:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:06:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:06: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', '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 0x1b7c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e1a310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e17400>, '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 0x1e183b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e18840>, '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': '82c74bd3bc9a11c5833d2010000001e6-1488592142.169400-722335293', '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 18:06: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', 'psutil>=3.1.1'] in /builds/slave/test/build 18:06: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 psutil>=3.1.1 18:06:36 INFO - Using env: {'DISPLAY': ':0', 18:06:36 INFO - 'HOME': '/home/cltbld', 18:06:36 INFO - 'LANG': 'en_US.UTF-8', 18:06:36 INFO - 'LANGUAGE': 'en_US:en', 18:06:36 INFO - 'LOGNAME': 'cltbld', 18:06:36 INFO - 'MAIL': '/var/mail/cltbld', 18:06:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:06:36 INFO - 'MOZ_NO_REMOTE': '1', 18:06:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:06:36 INFO - 'NO_EM_RESTART': '1', 18:06:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:06:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:06:36 INFO - 'PWD': '/builds/slave/test', 18:06:36 INFO - 'SHELL': '/bin/bash', 18:06:36 INFO - 'SHLVL': '1', 18:06:36 INFO - 'TERM': 'linux', 18:06:36 INFO - 'TMOUT': '86400', 18:06:36 INFO - 'USER': 'cltbld', 18:06:36 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1488592142.169400-722335293', 18:06:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:06:36 INFO - '_': '/tools/buildbot/bin/python'} 18:06:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:06:36 INFO - Downloading/unpacking psutil>=3.1.1 18:06: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 18:06: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 18:06: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 18:06: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 18:06: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 18:06: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 18:06:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:06:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:06:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:06:38 INFO - Installing collected packages: psutil 18:06:38 INFO - Running setup.py install for psutil 18:06:38 INFO - building 'psutil._psutil_linux' extension 18:06:38 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 18:06:39 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 18:06:39 INFO - building 'psutil._psutil_posix' extension 18:06:39 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 18:06:39 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 18:06:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:06:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:06:39 INFO - Successfully installed psutil 18:06:39 INFO - Cleaning up... 18:06:39 INFO - Return code: 0 18:06:39 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:06: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')]} 18:06:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:06:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:06: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')]} 18:06:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:06:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:06: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b7c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e1a310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e17400>, '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 0x1e183b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e18840>, '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': '82c74bd3bc9a11c5833d2010000001e6-1488592142.169400-722335293', '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 18:06: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 18:06: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 mozsystemmonitor==0.3 18:06:39 INFO - Using env: {'DISPLAY': ':0', 18:06:39 INFO - 'HOME': '/home/cltbld', 18:06:39 INFO - 'LANG': 'en_US.UTF-8', 18:06:39 INFO - 'LANGUAGE': 'en_US:en', 18:06:39 INFO - 'LOGNAME': 'cltbld', 18:06:39 INFO - 'MAIL': '/var/mail/cltbld', 18:06:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:06:39 INFO - 'MOZ_NO_REMOTE': '1', 18:06:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:06:39 INFO - 'NO_EM_RESTART': '1', 18:06:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:06:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:06:39 INFO - 'PWD': '/builds/slave/test', 18:06:39 INFO - 'SHELL': '/bin/bash', 18:06:39 INFO - 'SHLVL': '1', 18:06:39 INFO - 'TERM': 'linux', 18:06:39 INFO - 'TMOUT': '86400', 18:06:39 INFO - 'USER': 'cltbld', 18:06:39 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1488592142.169400-722335293', 18:06:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:06:39 INFO - '_': '/tools/buildbot/bin/python'} 18:06:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:06:39 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:06: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 18:06: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 18:06: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 18:06: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 18:06: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 18:06: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 18:06:41 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:06:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:06:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:06:41 INFO - Installing collected packages: mozsystemmonitor 18:06:41 INFO - Running setup.py install for mozsystemmonitor 18:06:41 INFO - Successfully installed mozsystemmonitor 18:06:41 INFO - Cleaning up... 18:06:41 INFO - Return code: 0 18:06:41 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:06:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:06:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:06:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:06:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:06:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:06:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:06:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1b7c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e1a310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e17400>, '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 0x1e183b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e18840>, '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': '82c74bd3bc9a11c5833d2010000001e6-1488592142.169400-722335293', '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 18:06:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 18:06:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 18:06:41 INFO - Using env: {'DISPLAY': ':0', 18:06:41 INFO - 'HOME': '/home/cltbld', 18:06:41 INFO - 'LANG': 'en_US.UTF-8', 18:06:41 INFO - 'LANGUAGE': 'en_US:en', 18:06:41 INFO - 'LOGNAME': 'cltbld', 18:06:41 INFO - 'MAIL': '/var/mail/cltbld', 18:06:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:06:41 INFO - 'MOZ_NO_REMOTE': '1', 18:06:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:06:41 INFO - 'NO_EM_RESTART': '1', 18:06:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:06:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:06:41 INFO - 'PWD': '/builds/slave/test', 18:06:41 INFO - 'SHELL': '/bin/bash', 18:06:41 INFO - 'SHLVL': '1', 18:06:41 INFO - 'TERM': 'linux', 18:06:41 INFO - 'TMOUT': '86400', 18:06:41 INFO - 'USER': 'cltbld', 18:06:41 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1488592142.169400-722335293', 18:06:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:06:41 INFO - '_': '/tools/buildbot/bin/python'} 18:06:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:06:42 INFO - Downloading/unpacking jsonschema==2.5.1 18:06:42 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 18:06:42 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 18:06:42 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 18:06:42 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 18:06:42 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 18:06:42 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 18:06:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:06:44 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:06:44 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 18:06:44 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 18:06:44 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 18:06:44 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 18:06:44 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 18:06:44 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 18:06:44 INFO - Downloading functools32-3.2.3-2.tar.gz 18:06:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:06:44 INFO - warning: no files found matching '*.txt' 18:06:44 INFO - no previously-included directories found matching 'build' 18:06:44 INFO - no previously-included directories found matching 'dist' 18:06:44 INFO - no previously-included directories found matching '.git*' 18:06:44 INFO - Installing collected packages: jsonschema, functools32 18:06:44 INFO - Running setup.py install for functools32 18:06:44 INFO - warning: no files found matching '*.txt' 18:06:44 INFO - no previously-included directories found matching 'build' 18:06:44 INFO - no previously-included directories found matching 'dist' 18:06:44 INFO - no previously-included directories found matching '.git*' 18:06:44 INFO - Successfully installed jsonschema functools32 18:06:44 INFO - Cleaning up... 18:06:44 INFO - Return code: 0 18:06:44 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:06:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:06:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:06:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:06:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:06:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:06:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:06:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1b7c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e1a310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e17400>, '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 0x1e183b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e18840>, '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': '82c74bd3bc9a11c5833d2010000001e6-1488592142.169400-722335293', '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 18:06:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 18:06:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 18:06:44 INFO - Using env: {'DISPLAY': ':0', 18:06:44 INFO - 'HOME': '/home/cltbld', 18:06:44 INFO - 'LANG': 'en_US.UTF-8', 18:06:44 INFO - 'LANGUAGE': 'en_US:en', 18:06:44 INFO - 'LOGNAME': 'cltbld', 18:06:44 INFO - 'MAIL': '/var/mail/cltbld', 18:06:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:06:44 INFO - 'MOZ_NO_REMOTE': '1', 18:06:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:06:44 INFO - 'NO_EM_RESTART': '1', 18:06:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:06:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:06:44 INFO - 'PWD': '/builds/slave/test', 18:06:44 INFO - 'SHELL': '/bin/bash', 18:06:44 INFO - 'SHLVL': '1', 18:06:44 INFO - 'TERM': 'linux', 18:06:44 INFO - 'TMOUT': '86400', 18:06:44 INFO - 'USER': 'cltbld', 18:06:44 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1488592142.169400-722335293', 18:06:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:06:44 INFO - '_': '/tools/buildbot/bin/python'} 18:06:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:06:44 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:06:44 INFO - Cleaning up... 18:06:44 INFO - Return code: 0 18:06:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:06:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:06:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:06:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:06:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:06:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:06:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:06:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1b7c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e1a310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e17400>, '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 0x1e183b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e18840>, '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': '82c74bd3bc9a11c5833d2010000001e6-1488592142.169400-722335293', '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 18:06:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:06:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:06:44 INFO - Using env: {'DISPLAY': ':0', 18:06:44 INFO - 'HOME': '/home/cltbld', 18:06:44 INFO - 'LANG': 'en_US.UTF-8', 18:06:44 INFO - 'LANGUAGE': 'en_US:en', 18:06:44 INFO - 'LOGNAME': 'cltbld', 18:06:44 INFO - 'MAIL': '/var/mail/cltbld', 18:06:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:06:44 INFO - 'MOZ_NO_REMOTE': '1', 18:06:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:06:44 INFO - 'NO_EM_RESTART': '1', 18:06:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:06:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:06:44 INFO - 'PWD': '/builds/slave/test', 18:06:44 INFO - 'SHELL': '/bin/bash', 18:06:44 INFO - 'SHLVL': '1', 18:06:44 INFO - 'TERM': 'linux', 18:06:44 INFO - 'TMOUT': '86400', 18:06:44 INFO - 'USER': 'cltbld', 18:06:44 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1488592142.169400-722335293', 18:06:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:06:44 INFO - '_': '/tools/buildbot/bin/python'} 18:06:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:06:45 INFO - Downloading/unpacking blobuploader==1.2.4 18:06:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:06:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:06:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:06:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:06:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:06:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:06:47 INFO - Downloading blobuploader-1.2.4.tar.gz 18:06:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:06:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:06: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 18:06: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 18:06: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 18:06: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 18:06: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 18:06: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 18:06:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:06:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:06: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 18:06: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 18:06: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 18:06: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 18:06: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 18:06: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 18:06:47 INFO - Downloading docopt-0.6.1.tar.gz 18:06:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:06:47 INFO - Installing collected packages: blobuploader, requests, docopt 18:06:47 INFO - Running setup.py install for blobuploader 18:06:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:06:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:06:47 INFO - Running setup.py install for requests 18:06:48 INFO - Running setup.py install for docopt 18:06:48 INFO - Successfully installed blobuploader requests docopt 18:06:48 INFO - Cleaning up... 18:06:48 INFO - Return code: 0 18:06:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:06:48 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')]} 18:06:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:06:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:06:48 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')]} 18:06:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:06:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:06:48 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 0x1b7c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e1a310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e17400>, '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 0x1e183b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e18840>, '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': '82c74bd3bc9a11c5833d2010000001e6-1488592142.169400-722335293', '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 18:06:48 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 18:06:48 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 18:06:48 INFO - Using env: {'DISPLAY': ':0', 18:06:48 INFO - 'HOME': '/home/cltbld', 18:06:48 INFO - 'LANG': 'en_US.UTF-8', 18:06:48 INFO - 'LANGUAGE': 'en_US:en', 18:06:48 INFO - 'LOGNAME': 'cltbld', 18:06:48 INFO - 'MAIL': '/var/mail/cltbld', 18:06:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:06:48 INFO - 'MOZ_NO_REMOTE': '1', 18:06:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:06:48 INFO - 'NO_EM_RESTART': '1', 18:06:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:06:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:06:48 INFO - 'PWD': '/builds/slave/test', 18:06:48 INFO - 'SHELL': '/bin/bash', 18:06:48 INFO - 'SHLVL': '1', 18:06:48 INFO - 'TERM': 'linux', 18:06:48 INFO - 'TMOUT': '86400', 18:06:48 INFO - 'USER': 'cltbld', 18:06:48 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1488592142.169400-722335293', 18:06:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:06:48 INFO - '_': '/tools/buildbot/bin/python'} 18:06:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:06:48 INFO - Running setup.py (path:/tmp/pip-109Prh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:06:48 INFO - Running setup.py (path:/tmp/pip-_aA366-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:06:48 INFO - Running setup.py (path:/tmp/pip-lZGUuo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:06:48 INFO - Running setup.py (path:/tmp/pip-5Qh3Vs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:06:48 INFO - Running setup.py (path:/tmp/pip-hMAiA6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:06:49 INFO - Running setup.py (path:/tmp/pip-0uNiWN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:06:49 INFO - Running setup.py (path:/tmp/pip-Ewy90n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:06:49 INFO - Running setup.py (path:/tmp/pip-8q8npa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:06:49 INFO - Running setup.py (path:/tmp/pip-wDZIzY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:06:49 INFO - Running setup.py (path:/tmp/pip-ANwUqs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:06:49 INFO - Running setup.py (path:/tmp/pip-tJvyrb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:06:49 INFO - Running setup.py (path:/tmp/pip-qUffAU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:06:49 INFO - Running setup.py (path:/tmp/pip-zdYKnQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:06:49 INFO - Running setup.py (path:/tmp/pip-Zt7v6A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:06:49 INFO - Running setup.py (path:/tmp/pip-mUbidc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:06:49 INFO - Running setup.py (path:/tmp/pip-5OCzfO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:06:49 INFO - Running setup.py (path:/tmp/pip-QgS44T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:06:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:06:49 INFO - Running setup.py install for manifestparser 18:06:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:06:50 INFO - Running setup.py install for mozcrash 18:06:50 INFO - Running setup.py install for mozdebug 18:06:50 INFO - Running setup.py install for mozdevice 18:06:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:06:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:06:50 INFO - Running setup.py install for mozfile 18:06:50 INFO - Running setup.py install for mozhttpd 18:06:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:06:50 INFO - Running setup.py install for mozinfo 18:06:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:06:50 INFO - Running setup.py install for mozInstall 18:06:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:06:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:06:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:06:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:06:50 INFO - Running setup.py install for mozleak 18:06:50 INFO - Running setup.py install for mozlog 18:06:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:06:50 INFO - Running setup.py install for moznetwork 18:06:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:06:51 INFO - Running setup.py install for mozprocess 18:06:51 INFO - Running setup.py install for mozprofile 18:06:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:06:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:06:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:06:51 INFO - Running setup.py install for mozrunner 18:06:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:06:51 INFO - Running setup.py install for mozscreenshot 18:06:51 INFO - Running setup.py install for moztest 18:06:51 INFO - Running setup.py install for mozversion 18:06:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:06:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:06:51 INFO - Cleaning up... 18:06:51 INFO - Return code: 0 18:06:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:06:51 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')]} 18:06:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:06:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:06:51 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')]} 18:06:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:06:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:06:51 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 0x1b7c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e1a310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e17400>, '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 0x1e183b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e18840>, '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': '82c74bd3bc9a11c5833d2010000001e6-1488592142.169400-722335293', '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 18:06:51 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 18:06:51 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 18:06:51 INFO - Using env: {'DISPLAY': ':0', 18:06:51 INFO - 'HOME': '/home/cltbld', 18:06:51 INFO - 'LANG': 'en_US.UTF-8', 18:06:51 INFO - 'LANGUAGE': 'en_US:en', 18:06:51 INFO - 'LOGNAME': 'cltbld', 18:06:51 INFO - 'MAIL': '/var/mail/cltbld', 18:06:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:06:51 INFO - 'MOZ_NO_REMOTE': '1', 18:06:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:06:51 INFO - 'NO_EM_RESTART': '1', 18:06:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:06:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:06:51 INFO - 'PWD': '/builds/slave/test', 18:06:51 INFO - 'SHELL': '/bin/bash', 18:06:51 INFO - 'SHLVL': '1', 18:06:51 INFO - 'TERM': 'linux', 18:06:51 INFO - 'TMOUT': '86400', 18:06:51 INFO - 'USER': 'cltbld', 18:06:51 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1488592142.169400-722335293', 18:06:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:06:51 INFO - '_': '/tools/buildbot/bin/python'} 18:06:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:06:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:06:51 INFO - Running setup.py (path:/tmp/pip-NzeKn3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:06:52 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)) 18:06:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:06:52 INFO - Running setup.py (path:/tmp/pip-s17FaS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:06:52 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)) 18:06:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:06:52 INFO - Running setup.py (path:/tmp/pip-0w2BtJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:06:52 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)) 18:06:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:06:52 INFO - Running setup.py (path:/tmp/pip-QIEKy9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:06:52 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)) 18:06:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:06:52 INFO - Running setup.py (path:/tmp/pip-0NCqeI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:06:52 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)) 18:06:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:06:52 INFO - Running setup.py (path:/tmp/pip-zGL_PI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:06:52 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)) 18:06:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:06:52 INFO - Running setup.py (path:/tmp/pip-6v3ZNy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:06:52 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)) 18:06:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:06:52 INFO - Running setup.py (path:/tmp/pip-rlZZ_f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:06:52 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)) 18:06:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:06:52 INFO - Running setup.py (path:/tmp/pip-uOGkLc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:06:52 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)) 18:06:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:06:52 INFO - Running setup.py (path:/tmp/pip-HJnMCw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:06:52 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)) 18:06:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:06:52 INFO - Running setup.py (path:/tmp/pip-49Z2S8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:06:52 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)) 18:06:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:06:52 INFO - Running setup.py (path:/tmp/pip-cdozHv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:06:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 18:06:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:06:52 INFO - Running setup.py (path:/tmp/pip-8v0Rts-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:06:52 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)) 18:06:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:06:52 INFO - Running setup.py (path:/tmp/pip-HfLy3s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:06:52 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)) 18:06:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:06:52 INFO - Running setup.py (path:/tmp/pip-oG9uk6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:06:53 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)) 18:06:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:06:53 INFO - Running setup.py (path:/tmp/pip-9nHX6C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:06:53 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)) 18:06:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:06:53 INFO - Running setup.py (path:/tmp/pip-NMYABg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:06:53 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)) 18:06:53 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)) 18:06:53 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)) 18:06:53 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)) 18:06:53 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)) 18:06:53 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)) 18:06:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:06:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:06:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:06:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:06:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:06:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:06:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:06:55 INFO - Downloading blessings-1.6.tar.gz 18:06:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:06:55 INFO - Installing collected packages: blessings 18:06:55 INFO - Running setup.py install for blessings 18:06:55 INFO - Successfully installed blessings 18:06:55 INFO - Cleaning up... 18:06:55 INFO - Return code: 0 18:06:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:06:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:06:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:06:55 INFO - Reading from file tmpfile_stdout 18:06:55 INFO - Current package versions: 18:06:55 INFO - argparse == 1.2.1 18:06:55 INFO - blessings == 1.6 18:06:55 INFO - blobuploader == 1.2.4 18:06:55 INFO - docopt == 0.6.1 18:06:55 INFO - functools32 == 3.2.3-2 18:06:55 INFO - jsonschema == 2.5.1 18:06:55 INFO - manifestparser == 1.1 18:06:55 INFO - mozInstall == 1.12 18:06:55 INFO - mozcrash == 1.0 18:06:55 INFO - mozdebug == 0.1 18:06:55 INFO - mozdevice == 0.49 18:06:55 INFO - mozfile == 1.2 18:06:55 INFO - mozhttpd == 0.7 18:06:55 INFO - mozinfo == 0.9 18:06:55 INFO - mozleak == 0.1 18:06:55 INFO - mozlog == 3.4 18:06:55 INFO - moznetwork == 0.27 18:06:55 INFO - mozprocess == 0.25 18:06:55 INFO - mozprofile == 0.28 18:06:55 INFO - mozrunner == 6.13 18:06:55 INFO - mozscreenshot == 0.1 18:06:55 INFO - mozsystemmonitor == 0.3 18:06:55 INFO - moztest == 0.8 18:06:55 INFO - mozversion == 1.4 18:06:55 INFO - psutil == 3.1.1 18:06:55 INFO - requests == 1.2.3 18:06:55 INFO - wsgiref == 0.1.2 18:06:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:06:55 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')]} 18:06:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:06:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:06:55 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')]} 18:06:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:06:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:06:55 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 0x1b7c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e1a310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e17400>, '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 0x1e183b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e18840>, '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': '82c74bd3bc9a11c5833d2010000001e6-1488592142.169400-722335293', '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 18:06:55 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 18:06:55 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 18:06:55 INFO - Using env: {'DISPLAY': ':0', 18:06:55 INFO - 'HOME': '/home/cltbld', 18:06:55 INFO - 'LANG': 'en_US.UTF-8', 18:06:55 INFO - 'LANGUAGE': 'en_US:en', 18:06:55 INFO - 'LOGNAME': 'cltbld', 18:06:55 INFO - 'MAIL': '/var/mail/cltbld', 18:06:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:06:55 INFO - 'MOZ_NO_REMOTE': '1', 18:06:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:06:55 INFO - 'NO_EM_RESTART': '1', 18:06:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:06:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:06:55 INFO - 'PWD': '/builds/slave/test', 18:06:55 INFO - 'SHELL': '/bin/bash', 18:06:55 INFO - 'SHLVL': '1', 18:06:55 INFO - 'TERM': 'linux', 18:06:55 INFO - 'TMOUT': '86400', 18:06:55 INFO - 'USER': 'cltbld', 18:06:55 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1488592142.169400-722335293', 18:06:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:06:55 INFO - '_': '/tools/buildbot/bin/python'} 18:06:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:06:55 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)) 18:06:55 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)) 18:06:55 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)) 18:06:55 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)) 18:06:55 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)) 18:06:55 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)) 18:06:55 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)) 18:06:55 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)) 18:06:55 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)) 18:06:55 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)) 18:06:55 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)) 18:06:55 INFO - Cleaning up... 18:06:55 INFO - Return code: 0 18:06:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:06:55 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')]} 18:06:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:06:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:06:55 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')]} 18:06:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:06:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:06:55 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 0x1b7c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e1a310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e17400>, '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 0x1e183b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e18840>, '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': '82c74bd3bc9a11c5833d2010000001e6-1488592142.169400-722335293', '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 18:06:55 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 18:06:55 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 18:06:55 INFO - Using env: {'DISPLAY': ':0', 18:06:55 INFO - 'HOME': '/home/cltbld', 18:06:55 INFO - 'LANG': 'en_US.UTF-8', 18:06:55 INFO - 'LANGUAGE': 'en_US:en', 18:06:55 INFO - 'LOGNAME': 'cltbld', 18:06:55 INFO - 'MAIL': '/var/mail/cltbld', 18:06:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:06:55 INFO - 'MOZ_NO_REMOTE': '1', 18:06:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:06:55 INFO - 'NO_EM_RESTART': '1', 18:06:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:06:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:06:55 INFO - 'PWD': '/builds/slave/test', 18:06:55 INFO - 'SHELL': '/bin/bash', 18:06:55 INFO - 'SHLVL': '1', 18:06:55 INFO - 'TERM': 'linux', 18:06:55 INFO - 'TMOUT': '86400', 18:06:55 INFO - 'USER': 'cltbld', 18:06:55 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1488592142.169400-722335293', 18:06:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:06:55 INFO - '_': '/tools/buildbot/bin/python'} 18:06:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:06:56 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:06:56 INFO - Cleaning up... 18:06:56 INFO - Return code: 0 18:06:56 INFO - Running post-action listener: _resource_record_post_action 18:06:56 INFO - Running post-action listener: _start_resource_monitoring 18:06:56 INFO - Starting resource monitoring. 18:06:56 INFO - [mozharness: 2017-03-04 02:06:56.171383Z] Finished create-virtualenv step (success) 18:06:56 INFO - [mozharness: 2017-03-04 02:06:56.171897Z] Running install step. 18:06:56 INFO - Running pre-action listener: _resource_record_pre_action 18:06:56 INFO - Running main action method: install 18:06:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:06:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:06:56 INFO - Reading from file tmpfile_stdout 18:06:56 INFO - Detecting whether we're running mozinstall >=1.0... 18:06:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:06:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:06:56 INFO - Reading from file tmpfile_stdout 18:06:56 INFO - Output received: 18:06:56 INFO - Usage: mozinstall [options] installer 18:06:56 INFO - Options: 18:06:56 INFO - -h, --help show this help message and exit 18:06:56 INFO - -d DEST, --destination=DEST 18:06:56 INFO - Directory to install application into. [default: 18:06:56 INFO - "/builds/slave/test"] 18:06:56 INFO - --app=APP Application being installed. [default: firefox] 18:06:56 INFO - mkdir: /builds/slave/test/build/application 18:06:56 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'] 18:06:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 18:07:14 INFO - Reading from file tmpfile_stdout 18:07:14 INFO - Output received: 18:07:14 INFO - /builds/slave/test/build/application/firefox/firefox 18:07:14 INFO - Running post-action listener: _resource_record_post_action 18:07:14 INFO - [mozharness: 2017-03-04 02:07:14.035499Z] Finished install step (success) 18:07:14 INFO - [mozharness: 2017-03-04 02:07:14.035648Z] Running run-tests step. 18:07:14 INFO - Running pre-action listener: _resource_record_pre_action 18:07:14 INFO - Running main action method: run_tests 18:07:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:07:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:07:14 INFO - Python 2.7.3 18:07:14 INFO - Return code: 0 18:07:14 INFO - grabbing minidump binary from tooltool 18:07: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')]} 18:07:14 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 0x1e17400>, '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 0x1e183b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e18840>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:07:14 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 18:07:14 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 18:07:14 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 18:07:14 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:07:14 INFO - Return code: 0 18:07:14 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:07:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:07:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:07:14 INFO - ENV: RUST_BACKTRACE is now 1 18:07:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:07:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:07:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EZUAmDZLThm1pkhGQXcXhw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 18:07:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/EZUAmDZLThm1pkhGQXcXhw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-066 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 18:07:14 INFO - Using env: {'DISPLAY': ':0', 18:07:14 INFO - 'HOME': '/home/cltbld', 18:07:14 INFO - 'LANG': 'en_US.UTF-8', 18:07:14 INFO - 'LANGUAGE': 'en_US:en', 18:07:14 INFO - 'LOGNAME': 'cltbld', 18:07:14 INFO - 'MAIL': '/var/mail/cltbld', 18:07:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:07:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:07:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:07:14 INFO - 'MOZ_NO_REMOTE': '1', 18:07:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:07:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:07:14 INFO - 'NO_EM_RESTART': '1', 18:07:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:07:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:07:14 INFO - 'PWD': '/builds/slave/test', 18:07:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:07:14 INFO - 'RUST_BACKTRACE': '1', 18:07:14 INFO - 'SHELL': '/bin/bash', 18:07:14 INFO - 'SHLVL': '1', 18:07:14 INFO - 'TERM': 'linux', 18:07:14 INFO - 'TMOUT': '86400', 18:07:14 INFO - 'USER': 'cltbld', 18:07:14 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1488592142.169400-722335293', 18:07:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:07:14 INFO - '_': '/tools/buildbot/bin/python'} 18:07:14 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EZUAmDZLThm1pkhGQXcXhw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 18:07:14 INFO - mozversion application_buildid: 20170304011621 18:07:14 INFO - mozversion application_changeset: 9a117f52a1371a223ff79a1f67a4b8cf08f9b69b 18:07:14 INFO - mozversion application_display_name: Nightly 18:07:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:07:14 INFO - mozversion application_name: Firefox 18:07:14 INFO - mozversion application_remotingname: firefox 18:07:14 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:07:14 INFO - mozversion application_vendor: Mozilla 18:07:14 INFO - mozversion application_version: 54.0a1 18:07:14 INFO - mozversion platform_buildid: 20170304011621 18:07:14 INFO - mozversion platform_changeset: 9a117f52a1371a223ff79a1f67a4b8cf08f9b69b 18:07:14 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:07:14 INFO - mozversion platform_version: 54.0a1 18:07:14 INFO - using testdate: 1488593234 18:07:14 INFO - actual date: 1488593234 18:07:14 INFO - starting webserver on 'localhost:44765' 18:07:14 INFO - SUITE-START | Running 2 tests 18:07:14 INFO - TEST-START | dromaeo_css 18:07:14 INFO - operating with platform_type : linux_ 18:07:14 INFO - Initialising browser for dromaeo_css test... 18:07:14 INFO - TEST-INFO | started process 1797 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpK517W_/profile http://localhost:44765/getInfo.html) 18:07:18 INFO - PROCESS | 1797 | __metrics Screen width/height:1600/1200 18:07:18 INFO - PROCESS | 1797 | colorDepth:24 18:07:18 INFO - PROCESS | 1797 | Browser inner width/height: 1024/697 18:07:18 INFO - PROCESS | 1797 | __metrics 18:07:19 INFO - PROCESS | 1797 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 18:07:19 INFO - PROCESS | 1797 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:07:20 INFO - TEST-INFO | 1797: exit 0 18:07:20 INFO - Browser initialized. 18:07:20 INFO - Running cycle 1/1 for dromaeo_css test... 18:07:20 INFO - TEST-INFO | started process 1889 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpK517W_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:07:32 INFO - PROCESS | 1889 | RSS: Main: 142512128 18:07:32 INFO - PROCESS | 1889 | 18:10:34 INFO - PROCESS | 1889 | Cycle 1(1): loaded http://localhost:44765/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44765/tests/dromaeo/cssquery-ext.html) 18:10:36 INFO - PROCESS | 1889 | RSS: Main: 341540864 18:10:36 INFO - PROCESS | 1889 | 18:12:22 INFO - PROCESS | 1889 | ************************* 18:12:22 INFO - PROCESS | 1889 | A coding exception was thrown and uncaught in a Task. 18:12:22 INFO - PROCESS | 1889 | 18:12:22 ERROR - PROCESS | 1889 | Full message: TypeError: NetworkError when attempting to fetch resource. 18:12:22 INFO - PROCESS | 1889 | Full stack: 18:12:22 INFO - PROCESS | 1889 | ************************* 18:13:39 INFO - PROCESS | 1889 | Cycle 1(1): loaded http://localhost:44765/tests/dromaeo/cssquery-ext.html (next: http://localhost:44765/tests/dromaeo/cssquery-jquery.html) 18:13:39 INFO - PROCESS | 1889 | RSS: Main: 235761664 18:13:39 INFO - PROCESS | 1889 | 18:16:41 INFO - PROCESS | 1889 | Cycle 1(1): loaded http://localhost:44765/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44765/tests/dromaeo/cssquery-mootools.html) 18:16:42 INFO - PROCESS | 1889 | RSS: Main: 217706496 18:16:42 INFO - PROCESS | 1889 | 18:19:44 INFO - PROCESS | 1889 | Cycle 1(1): loaded http://localhost:44765/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44765/tests/dromaeo/cssquery-prototype.html) 18:19:44 INFO - PROCESS | 1889 | RSS: Main: 173309952 18:19:44 INFO - PROCESS | 1889 | 18:22:47 INFO - PROCESS | 1889 | Cycle 1(1): loaded http://localhost:44765/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44765/tests/dromaeo/cssquery-yui.html) 18:22:48 INFO - PROCESS | 1889 | RSS: Main: 180490240 18:22:48 INFO - PROCESS | 1889 | 18:25:51 INFO - PROCESS | 1889 | Cycle 1(1): loaded http://localhost:44765/tests/dromaeo/cssquery-yui.html (next: http://localhost:44765/tests/dromaeo/cssquery-dojo.html) 18:25:51 INFO - PROCESS | 1889 | RSS: Main: 243609600 18:25:51 INFO - PROCESS | 1889 | 18:25:51 INFO - PROCESS | 1889 | __start_tp_report 18:25:51 INFO - PROCESS | 1889 | _x_x_mozilla_page_load 18:25:51 INFO - PROCESS | 1889 | _x_x_mozilla_page_load_details 18:25:51 INFO - PROCESS | 1889 | |i|pagename|runs| 18:25:51 INFO - PROCESS | 1889 | |0;dojo.html;3195.9041228763135;3211.518272259162;3247.772655914086;3247.821369824662;3256.967430325696;5261.947380526193;5361.544268737162;5400.648957817744;5469.671819690811;5480.6437581557175;5427.755750991205;5428.45715428457;5431.266778984836;5442.782288708457;5474.808381706631;4757.119932812441;4789.066132104241;4833.4924832892475;4888.804447822101;4911;4879.829205977791;4894.363732714742;4945.134601444751;4953.578945789613;4989;4788.425388953313;4817.542333478314;4825.879353016185;4829.082474329866;4829.661923665345;4771.475137734847;4833.782479788418;4835.298881662139;4841.15279826029;4844.5155484451625;4785.904281914377;4795.424549054101;4802.783874725646;4849.321095046696;4875.561199492027;5361.865953351158;5365.731713414314;5369.704666243355;5383.788647554308;5422.8373148805595;5650.519705824969;5677.37548869624;5793.13103034544;5802.88394232113;5821.068629019379;5712.6286791358425;5778.479936805707;5819.67991760453;5830.125481177814;5844.357120716718;5525.889482210374;5531.834044978697;5547.306586676666;5553.416891226444;5557.249771280865;5964.433378829004;6006.729697163638;6012.609180403259;6021.909671354933;6026.457618814327;5509.834704958857;5549.084401073858;5550.167474878801;5747.4252574742195;5764.365919748824;5692.203091567184;5697.03150464422;5698.1737648041635;5704.515116215168;5721.742521586539;5646.830595082154;5656.91514627281;5661.80183693577;5685.658860468302;5686.914696279559;5707.200991861143;5745.482906538432;5755.165501002331;5758.596898217168;5759.078547432391;4499.100179963955;4503.437070366204;4504.954950450454;4506.864794056183;4545.5908968193025;4015.8795236142964;4018.1160144768687;4022.4368588397647;4035;4053.3717273822604;5630.8029218977135;5635.0702134147405;5642.802501912413;5642.858928526737;5653.180288858175;5869.20765696634;5899.321578018583;5900.321463031721;5906.881862362815;5919.082542205965;5583.218349431083;5586.944130558642;5591.10542313228;5592.440755924375;5614.887702245932;4914.901701966012;4933.605311575066;4963.429205641325;4984.576311013532;5082.313887625123;6135.55172499934;6139.032198454696;6146.7233974471255;6150.692465376714;6150.815475535741;5869.6771677558145;5869.853253668522;5874.441928016831;5877;5923.378045305181;6009.2188015557695;6062.787802426894;6069.848253793691;6115.388461153849;6140.846478838065;5682.573806964411;5753.798617048383;5763.94236057634;5779.162021506942;5783.8554036149435;5882.970585147047;5884.882302354014;5892.086726557391;5901.557383196363;5940.138679891478;5702.543796496353;5734.5125664319;5748.281464816898;5749.453801888814;5770.480656740913;5618.550515958796;5630.577706671934;5719.28508936383;5738.770449181986;5740.885182296414;5654.15187721845;5670.291213598301;5681.034224181816;5689.1750696148;5704.3154821421695;5615.522680572034;5653.293338332708;5654.208410822406;5655.830325090254;5724.055530837365;5555.0278701227935;5560.416156303691;5595.160725891149;5600.383957764561;5605.523530499953 18:25:51 INFO - PROCESS | 1889 | |1;ext.html;753.190320405564;771.4252881603205;825.1047613339526;832.9416940814142;836.6778790165785;28598.142055738335;40064.399034014474;40380;44593.7770311148;44968.775156124255;43293.56706432935;43568;43610.781946090225;43638;43680.56319436805;7257.274272572753;8705.912940870588;8849.380543361967;8858.645654173857;8871.423357481743;7348.5958272295;10279.537420816081;10475.633352832652;10479.947600261989;10503.63237286695;10626.840597391045;10649.680509584687;10662.62680806172;10663.573457061708;10666.14670826332;10531.631392901212;10540.736481587983;10592.41741704206;10598.152147828156;10599.735006624818;10211.591536338537;10280.07479326864;10282.228832837567;10285.948570257176;10287.22845786569;39239.41140882889;39343;39426.802865985774;39445.60554394448;39446.60553394458;3749.193923306475;3753.680937120348;3776.0748616588835;3779.5653499847595;3829.617038296148;28035.85982070097;28197.43605127886;28423.85788071067;28823.42353152946;28874.566881496794;4031.2743706132883;4083.4895638045246;4128.112455821983;4140.192662430827;4238.215930052919;209343;209629;209877;210233;211928;39974.20051598952;40304;48556.271655925186;49131.263031054565;49176;54101.45898541043;55277.170842437394;55309.44690553043;55506.16740748892;55530;13604.727905442034;13620.523281685291;13717.17696938187;13741.931290343484;13742.106763060368;11603.12976526747;11614.535418583331;11635.53457861693;11639.6508104757;11646.534138634359;13065.150765200231;13098.607041788762;13120.212787232605;13196.538121165906;13223.206607603575;4811.206150985118;4889.4282900430235;5475.123980163155;5596.425644203712;5696.914546281809;1130.0846314485293;1147.4205526209212;1150.925189862673;1173.3957012138756;1200.5497938273147;25063.122790702237;25353.492930141292;25441.618375724378;25464.618030729554;25961.480770384485;1222.45600707686;1236.5733821831454;1252.423885012886;1267.991946402612;1275.3431982528818;13258.412400843716;13461.326933653278;13563.66090847717;13804.064252371376;13865.861341386659;267613;268195;268678;268746;269040;50117.49882501128;50654.49345506571;50726;50827.237591436155;50899;1414.2080434956458;1432.548747144646;1439.7336492748875;1441.2865631512468;1452.5787521618613;23836.16573419922;24065.157719480434;24529.877350613133;24679.506409871345;25188;38542.42186367151;38570.03574910649;38722.22555548817;38749;38991.805040974614;247163;247677;247775;248668;248775.3663401974;31995.680043200202;32496.83751581227;32775.50836737498;32843;32953.67046329506;32384.838075810414;39094.609053909095;39515.209695805344;39664.60335396609;41005.1798964025;35159.47260791141;35488.64511354853;35897.820510898324;36044;36212.818935905154;35932.46101308535;35993.1001724959;36281.274374511835;36429.45355819612;36561.81719091388;37230.44154337741;37397;38100.618993810815;38122.42816357702;38166.80916595511;29603.407931841673;31034;31777.8411107943;31849.68150318467;31990.52014219835;25188.496230075663;25347.366315842253;25348.366290842878;25366.365840854127;25716.61425078588 18:25:51 INFO - PROCESS | 1889 | |2;jquery.html;392.4760444806184;418.24896269504416;427.81176282435706;427.98930026749326;441.7791104447776;15083;18798.15408306626;19936.302229421974;20215.898920505377;20313.59372812543;19511.902440487815;20328.08523616437;20442.69335959958;20548.48628784281;20714.792852071514;6349.396807303298;6499.7000599879975;6605.471562275006;6605.867882642344;6615.305392933745;6305.842353941165;6366.808995730135;6476.222853257592;6477.287498375175;6486.902696459533;6451.774187903425;6468.870622587546;6495.902561461558;6813.523053386265;7028.332308430691;7136.2506936771415;7198.496105272633;7219.711211551558;7283.308085731847;7301.744438944638;7111.146662400493;7143.749968751069;7153.248908864546;7157.6063316517575;7165.925111233305;22663.660045099336;22840.657390138997;23078.192263270874;23306.086739157607;23613.645795312914;3213.469777486712;3325.235195904931;3384.8476818543227;3394.6775056369606;3423.2639982403903;14226.359813808403;14265.500707475292;14705.852941470663;14730;14747.041442306216;2082.2191678120703;2139.1550337616554;2153.633882240023;2165.621016322153;2231.364061242538;104931;106650.46674766732;107161;107565.46217268941;110633;13533.255670938193;15454.459093931659;16274.837251627569;16306.836931630532;16696.666066678597;24105.638415423782;24559;24587;25033;25253.116140935348;8213.260806527442;8416.410851240476;8546.359023073295;8640.222379985831;8674.6530138795;6864.759733409307;6896.069030680894;6950.652467376611;7075.2570980047385;7101.396381307543;8134.901788258628;8260.215279548553;8365.749027529184;8375.748727538183;8413.537255450887;3542.3800834853796;3618.9819050904575;3635.781853088823;3642.453631955175;3682.760620559655;870.5603670146536;886.7650072730731;891.2780647675404;895.2971917045088;913.9451632902047;18254.543636409195;19491.415257542296;19501.902490487457;19563.119659615353;19890.403287901387;881;883.5052370672444;888.8444522208717;898.9235914947172;905.5698543192062;10279.327374882585;10681.519331630096;10699.14406847466;10760.085392741548;10780.40707761065;567056;580173;589863;590714;592154;96896;99741;99869;102665.97334026714;103321;1124.1961997171898;1166.2361153444508;1188.5424111716877;1191.53530123252;1195.1574140231116;16068;16106.919465403067;16585.585360365603;16659.916700416907;16804.32782688728;47387.76306118447;47837.28244076411;48591.47889717513;48680;49475.257871131245;59559.40440595712;59882.10176847438;60992;61255;62497;11028.503717332578;11366.772664546828;11379.715507112389;11499.885001149882;11726.237794543327;12876.484940602271;12920.483180672667;13032.674183145118;13212.603621891358;13236.404361803934;11508.42457877086;11581.305121692725;11758.764824703629;11909.940450297692;12344.938275308925;11383.54465821358;11490.253133546294;11492.080633549464;11606;11736.413179341169;11793.174477786815;11851.703707407383;11904.404779761151;11995;12309.138360314691;11212.887871121511;11258.66224013281;11309.886901130883;11578.76842463163;11669.88330116722;11651;11704.590339338083;11710.648680539256;11741.882581174079;12035.509702186268 18:25:51 INFO - PROCESS | 1889 | |3;mootools.html;1456.4756687592458;1464.9267536623165;1486.8810495160387;1504.3230546254185;1505.9774103388447;9166.495842728647;9663.951680241598;9669.613215471372;9671.70984870454;9672;9369.531523423819;9650.324477286593;9925.255605829556;9950.25373097017;9951.203903687705;2118.7987141221597;2174.4672555223992;2174.7281589801273;2176.7279090113734;2187.475005998565;2101.642720737478;2158.2230397057047;2160.7839216078346;2165.523584811339;2165.6968024476505;1988.0954165854573;2028.0772248626913;2033.4001469566513;2040.4286799696035;2048.764392094906;2050.846186536016;2052.374025922093;2056.7120603115577;2057.722207501983;2062.9071691773906;2051.241040814908;2084.5309805293687;2161.9783802161933;2165.967510487344;2167.089822274648;9846.950765246127;9912;9915.851262231072;9923.851142232872;9926.553305101215;5162.354705661793;5286.3392075990505;5292.788288468457;5293.444188360205;5302.814401495968;2953.778466614991;3098.6281646202374;3118.8908388206305;3129.1864115330177;3131.091983324833;1141.5662048421548;1211.668285877981;1236.437420973455;1243.8072098824696;1260.1116213069763;14172.220527870963;14408.495702650356;14516.927415362856;14549.92725036368;14565.053271537423;4175.561566035583;4338.284183109815;4422.159789639958;4436.578525040116;4483.798229079699;12154.574589889487;12172.087093468026;12176.81734773979;12188.451519681636;12201.38993050344;5420.07858664028;5428.077226871442;5434.972825135849;5438;5438.293021907127;4701.882452938704;4748.976255118702;4814.614830813526;4915.901681966412;4928.211486162197;3743.1390780120723;3810.809459527068;3813.275477659236;3870.7549621219623;3886.4947556817997;1053.2942928238099;1070.9946450267698;1078.1698092468755;1098.4837126550508;1106.983395249072;990.6037584965927;1008.9243306752023;1010.2524132142308;1021.9284650074424;1040.9895901041043;6428.325025872309;6466.159399278158;6533.281339052701;6542.093191814605;6633.900491492632;1010.2978429991233;1014.802113587858;1015.7206768138673;1016.7240113657313;1069.9518521666544;4170.311898536707;4199.68502362324;4240.703150779477;4272.423222864935;4391.341298805205;11432.599859004895;11866.644000679993;11953.820692689616;11960;12023;10745.247832651796;11257.943710281395;11676.299422034705;11757.588484403175;11764.823527647091;8801.491574901122;8990.145936136056;9075.410098343718;9116.680916167903;9253.72238832836;6658.367455091952;6681.899771503334;6686;6737.73049078051;6857.108575885103;11192.272502287326;11216.102711782874;11240.943795280971;11362;11398.886011139783;11231.831522527005;11247.550097995989;11294.94352528232;11410.657680269605;11417.37204453763;8293.543855088028;8353.498790072616;8416.410851240355;8431.873521897054;8434.704785332484;8798.956005219932;8911.06433824439;8952.328575356743;8973.551322433721;8985.415947963362;8024.0772311184965;8056.355491560544;8122.918770812216;8163.877541836996;8183.71357002502;7942.64258108375;7955.2840244378285;7982.56095914707;8220.712275070344;8225.547594882339;7390.260973902567;7512.661930213044;7515.8872616911885;7518.135414427192;7526;5759.683217422914;5770.365259821332;5860.2967643883;5913.231279933581;6035.6076855004285;5934.33715155805;5943.227380440515;6010.248718910137;6184.6598437086395;6257.28041275241 18:25:51 INFO - PROCESS | 1889 | |4;prototype.html;391.48910671573606;394.14863893988985;403.07494300580163;404.58530006743086;413.59261127789125;5180.844574662761;5265.341417453499;5272.7627256773485;5277.841664750059;5315.681059136455;4784.784684689189;5084.618653600976;5094.184930411135;5216.5742929537755;5225.503577160173;4386.232409328362;4391.121775644884;4392.494863090737;4398.538153493869;4418.270985287424;4399.472063352387;4415.955840441587;4420.77896105195;4432.468103827545;4441;4300.011492013052;4409.360642706805;4417.73493590384;4422.690411671184;4452.532484089173;4365.799405163573;4374.34384842273;4400.757958312275;4405.647548196137;4425.402570652969;4257.318828987378;4261.31818908973;4271.850485233033;4283.115429211169;4291.871243862689;4838.733869637169;5092.548623642281;5122.743862806882;5147.382314122292;5149.613778966593;5256.737163141827;5272.604554658377;5275.208718692188;5280.471952804727;5296.9735151324385;5494.862628434321;5547.3343198816;5564.693941833198;5574.968630803314;5578.206819362832;4284.721493102938;4519.463382449982;4524.954750452486;4806.4712881583;4810.518948105161;5446.673199608036;5550.72246387679;5680.772769089232;5727.682632994393;5730.914036289459;4459.799309031101;4495.910081798345;4510.534076425175;4533.481283769908;4669.813207471663;4631.8378856739855;4702.27114797207;4726.19654658702;4738.076075165379;4743.146233677902;4919.7540122993705;5025.773840177201;5071.239314102914;5094.739366805247;5098.439171691111;5464.617476776667;5480.972595136999;5481.835544933659;5555.500044963512;5567.081431563827;1649.2990479046357;1649.878082903637;1656.4119737493018;1663.7670726098356;1669.290551515601;1148.6732823588768;1268.4165283969478;1277.6614197237739;1278.6945745248636;1283.3444856135482;5383.380911195184;5420.186971954238;5421.918671219935;5427.48438898304;5427.941551397518;5245.318108645852;5640.8871822563315;5700.572457065737;5715.771369145187;5745.213571417859;5341.679499229981;5342.290467050584;5358.33020872391;5385.865353366119;5396.541293990055;2983.77621678375;2987.536931775578;2989.910302690923;2996.1760515858314;2997.4454725875785;5495.1425258865165;5806.477417032487;5822.650640961556;5938.524918006549;5948.434898684618;5687.530606330135;5696.458836410535;5697.401772813878;5719.682584101211;5756.884862302731;5607.243022192115;5856.306099194333;5890.2342695449315;5897.439743224387;5913.2608423947;5543.6396634218645;5596.580256480699;5639.746211420414;5662.8301150965535;5670.489655930986;5623.746931388179;5633.718314084362;5644.2380278663495;5645.294338207724;5719.8570035749435;5543.972280138573;5681.147827825859;5795.797147099831;5833.79581714638;5928.9407105928385;4987.60099192071;5042.798288068583;5044.621653375938;5051.747412629427;5055.87360315995;5317.83007738297;5582;5679.34687510925;5692.430756924275;5698.20225168485;5434.701091440009;5439.292891924025;5465.704404150346;5481.287432633732;5485.820548582074;5454.209139674805;5460.481254280837;5501.504864562048;5525.408484485117;5529.336479622471;5235.554977826928;5426.232621363054;5460.290162278879;5465.890682186414;5514.145307477347;5478.424765399575;5511.614187006871;5515.332304017783;5542;5560.304961879765;5249.238860365302;5421.566274698093;5456.972715136399;5458.1169496523635;5465.37148227943 18:25:51 INFO - PROCESS | 1889 | |5;yui.html;736.5433431272612;772.2470591173607;772.5441989226356;831.5758962928907;859.3511898516621;15413.6146596335;16971.321147154114;17006.659866802656;17011.82988170118;17023.914880425596;14450.855491445081;15226.847731522681;15284.541463756077;15678.372865085412;16468.258928348223;818.4720855048505;844.7381311793364;845.7970087179094;846.318713435684;848.8811566380712;811.4157806379397;842.4524059361403;844.5312851367519;845.1421806866036;845.7631863078317;872.2760109109424;883.5317281840635;884.3720958119743;884.7168905950099;887.8978917424514;881.2817553693719;883.0551310098198;887.1394747095308;887.4675194883083;887.5739644970386;648.6724204276857;653.1150291355241;653.650297091054;653.8169312592481;653.8365408647838;15255.160966146857;15582.922085389613;16562.668746625;16626.750598740906;16687.249073791707;14010.29948502581;14755.040922340013;14954.177520236382;14960.251987400696;15472.149031803247;12618.55711143621;12850.164739291917;12853.87146128536;12890.355482225852;13179.14335568185;3461.809600471973;3491.528129802225;3492.0746002309406;3506.7720598161036;3622.2755448910325;83165;86522.56738716329;86543.56728216381;87572;88423.55788221082;10915;10976.341419514854;11131.276467029616;11289.0968722502;11422.543098276143;19440.222391104482;20091.39725808228;22755.31734047981;22796.316110516713;23084.4228894279;7689.615519224017;7770.184130666312;7871.921280787119;7931.801704957422;8049.879251811228;4295.720778149473;4302.311630139163;4352.467029787921;4367.410399596014;4387.42963414754;3348.11275012122;3440.9483857742152;3452.9654703452643;3454.4990976308295;3460;569.3907518954761;576.7145263094795;581.0441823200896;581.3315783700806;582.3186871360518;759.369723129812;772.4862966127462;780.1963977103593;813.345257068054;826.3884725303233;10153.847692284622;10247.72411587781;10252.43611601369;10541.31481453703;11050.336979781077;625.3496363781707;632.7658766256422;653.8071268975664;680.8536164724608;784.2471227621547;4748.430188377348;5035.471275516018;5050;5078.923816142761;5103;67039.32960670428;68655.3134468659;68695.3130468699;69040.65479672569;69276.307236928;45095.549044509135;52143.478565214624;59764.701176493836;59786.70106649439;61022;57731.71134144302;58075.41924580785;58126.709366452895;58608.70695646494;58676.70661646665;10536.631217907336;10713.14294856394;10886.455677216265;10984.615538456115;11106.777864442827;37158.44262336121;37572;37831.43252851265;38936.80531597324;38960.80519597384;43890.78054609834;44446.55553444424;45193.77403112964;46603.53396465992;46740.53259467362;12945.482180712666;13003.544875929298;13196;13229;13573.86426135726;14815;15035.173065481504;15061.322240499423;15292.235388230767;15609.609759755642;13930.021821579872;14049.157050576998;14115.294235287989;14575.781363279348;14586.34361453716;14200.715985680436;14440.783388249394;14549.85450145485;14620.707585848437;14993;13948.58154255374;13959.511417100759;13995;14401.7839732402;14688.592310136944;11148.88851111511;11249.437528123724;11271.549138034386;11353.602623908124;11693.766124677288;10985.285956412808;11074.169437292074;11134.488264172049;11382.886171138183;11434.256773309708 18:25:51 INFO - PROCESS | 1889 | __end_tp_report 18:25:51 INFO - PROCESS | 1889 | __start_cc_report 18:25:51 INFO - PROCESS | 1889 | _x_x_mozilla_cycle_collect,2159 18:25:51 INFO - PROCESS | 1889 | __end_cc_report 18:25:51 INFO - PROCESS | 1889 | __startTimestamp1488594351607__endTimestamp 18:25:51 INFO - PROCESS | 1889 | 18:25:51 INFO - PROCESS | 1889 | ------- Summary: start ------- 18:25:51 INFO - PROCESS | 1889 | Number of tests: 6 18:25:51 INFO - PROCESS | 1889 | 18:25:51 INFO - PROCESS | 1889 | [#0] dojo.html Cycles:165 Average:5402.49 Median:5635.07 stddev:617.05 (11.0%) stddev-sans-first:594.17 18:25:51 INFO - PROCESS | 1889 | Values: 3195.9 3211.5 3247.8 3247.8 3257.0 5261.9 5361.5 5400.6 5469.7 5480.6 5427.8 5428.5 5431.3 5442.8 5474.8 4757.1 4789.1 4833.5 4888.8 4911.0 4879.8 4894.4 4945.1 4953.6 4989.0 4788.4 4817.5 4825.9 4829.1 4829.7 4771.5 4833.8 4835.3 4841.2 4844.5 4785.9 4795.4 4802.8 4849.3 4875.6 5361.9 5365.7 5369.7 5383.8 5422.8 5650.5 5677.4 5793.1 5802.9 5821.1 5712.6 5778.5 5819.7 5830.1 5844.4 5525.9 5531.8 5547.3 5553.4 5557.2 5964.4 6006.7 6012.6 6021.9 6026.5 5509.8 5549.1 5550.2 5747.4 5764.4 5692.2 5697.0 5698.2 5704.5 5721.7 5646.8 5656.9 5661.8 5685.7 5686.9 5707.2 5745.5 5755.2 5758.6 5759.1 4499.1 4503.4 4505.0 4506.9 4545.6 4015.9 4018.1 4022.4 4035.0 4053.4 5630.8 5635.1 5642.8 5642.9 5653.2 5869.2 5899.3 5900.3 5906.9 5919.1 5583.2 5586.9 5591.1 5592.4 5614.9 4914.9 4933.6 4963.4 4984.6 5082.3 6135.6 6139.0 6146.7 6150.7 6150.8 5869.7 5869.9 5874.4 5877.0 5923.4 6009.2 6062.8 6069.8 6115.4 6140.8 5682.6 5753.8 5763.9 5779.2 5783.9 5883.0 5884.9 5892.1 5901.6 5940.1 5702.5 5734.5 5748.3 5749.5 5770.5 5618.6 5630.6 5719.3 5738.8 5740.9 5654.2 5670.3 5681.0 5689.2 5704.3 5615.5 5653.3 5654.2 5655.8 5724.1 5555.0 5560.4 5595.2 5600.4 5605.5 18:25:51 INFO - PROCESS | 1889 | 18:25:51 INFO - PROCESS | 1889 | [#1] ext.html Cycles:180 Average:40965.44 Median:30318.70 stddev:63220.93 (208.5%) stddev-sans-first:63326.18 18:25:51 INFO - PROCESS | 1889 | Values: 753.2 771.4 825.1 832.9 836.7 28598.1 40064.4 40380.0 44593.8 44968.8 43293.6 43568.0 43610.8 43638.0 43680.6 7257.3 8705.9 8849.4 8858.6 8871.4 7348.6 10279.5 10475.6 10479.9 10503.6 10626.8 10649.7 10662.6 10663.6 10666.1 10531.6 10540.7 10592.4 10598.2 10599.7 10211.6 10280.1 10282.2 10285.9 10287.2 39239.4 39343.0 39426.8 39445.6 39446.6 3749.2 3753.7 3776.1 3779.6 3829.6 28035.9 28197.4 28423.9 28823.4 28874.6 4031.3 4083.5 4128.1 4140.2 4238.2 209343.0 209629.0 209877.0 210233.0 211928.0 39974.2 40304.0 48556.3 49131.3 49176.0 54101.5 55277.2 55309.4 55506.2 55530.0 13604.7 13620.5 13717.2 13741.9 13742.1 11603.1 11614.5 11635.5 11639.7 11646.5 13065.2 13098.6 13120.2 13196.5 13223.2 4811.2 4889.4 5475.1 5596.4 5696.9 1130.1 1147.4 1150.9 1173.4 1200.5 25063.1 25353.5 25441.6 25464.6 25961.5 1222.5 1236.6 1252.4 1268.0 1275.3 13258.4 13461.3 13563.7 13804.1 13865.9 267613.0 268195.0 268678.0 268746.0 269040.0 50117.5 50654.5 50726.0 50827.2 50899.0 1414.2 1432.5 1439.7 1441.3 1452.6 23836.2 24065.2 24529.9 24679.5 25188.0 38542.4 38570.0 38722.2 38749.0 38991.8 247163.0 247677.0 247775.0 248668.0 248775.4 31995.7 32496.8 32775.5 32843.0 32953.7 32384.8 39094.6 39515.2 39664.6 41005.2 35159.5 35488.6 35897.8 36044.0 36212.8 35932.5 35993.1 36281.3 36429.5 36561.8 37230.4 37397.0 38100.6 38122.4 38166.8 29603.4 31034.0 31777.8 31849.7 31990.5 25188.5 25347.4 25348.4 25366.4 25716.6 18:25:51 INFO - PROCESS | 1889 | 18:25:51 INFO - PROCESS | 1889 | [#2] jquery.html Cycles:180 Average:33831.91 Median:23459.87 stddev:96327.59 (410.6%) stddev-sans-first:96565.09 18:25:51 INFO - PROCESS | 1889 | Values: 392.5 418.2 427.8 428.0 441.8 15083.0 18798.2 19936.3 20215.9 20313.6 19511.9 20328.1 20442.7 20548.5 20714.8 6349.4 6499.7 6605.5 6605.9 6615.3 6305.8 6366.8 6476.2 6477.3 6486.9 6451.8 6468.9 6495.9 6813.5 7028.3 7136.3 7198.5 7219.7 7283.3 7301.7 7111.1 7143.7 7153.2 7157.6 7165.9 22663.7 22840.7 23078.2 23306.1 23613.6 3213.5 3325.2 3384.8 3394.7 3423.3 14226.4 14265.5 14705.9 14730.0 14747.0 2082.2 2139.2 2153.6 2165.6 2231.4 104931.0 106650.5 107161.0 107565.5 110633.0 13533.3 15454.5 16274.8 16306.8 16696.7 24105.6 24559.0 24587.0 25033.0 25253.1 8213.3 8416.4 8546.4 8640.2 8674.7 6864.8 6896.1 6950.7 7075.3 7101.4 8134.9 8260.2 8365.7 8375.7 8413.5 3542.4 3619.0 3635.8 3642.5 3682.8 870.6 886.8 891.3 895.3 913.9 18254.5 19491.4 19501.9 19563.1 19890.4 881.0 883.5 888.8 898.9 905.6 10279.3 10681.5 10699.1 10760.1 10780.4 567056.0 580173.0 589863.0 590714.0 592154.0 96896.0 99741.0 99869.0 102666.0 103321.0 1124.2 1166.2 1188.5 1191.5 1195.2 16068.0 16106.9 16585.6 16659.9 16804.3 47387.8 47837.3 48591.5 48680.0 49475.3 59559.4 59882.1 60992.0 61255.0 62497.0 11028.5 11366.8 11379.7 11499.9 11726.2 12876.5 12920.5 13032.7 13212.6 13236.4 11508.4 11581.3 11758.8 11909.9 12344.9 11383.5 11490.3 11492.1 11606.0 11736.4 11793.2 11851.7 11904.4 11995.0 12309.1 11212.9 11258.7 11309.9 11578.8 11669.9 11651.0 11704.6 11710.6 11741.9 12035.5 18:25:51 INFO - PROCESS | 1889 | 18:25:51 INFO - PROCESS | 1889 | [#3] mootools.html Cycles:180 Average:6232.46 Median:4187.62 stddev:3809.44 (91.0%) stddev-sans-first:3803.22 18:25:51 INFO - PROCESS | 1889 | Values: 1456.5 1464.9 1486.9 1504.3 1506.0 9166.5 9664.0 9669.6 9671.7 9672.0 9369.5 9650.3 9925.3 9950.3 9951.2 2118.8 2174.5 2174.7 2176.7 2187.5 2101.6 2158.2 2160.8 2165.5 2165.7 1988.1 2028.1 2033.4 2040.4 2048.8 2050.8 2052.4 2056.7 2057.7 2062.9 2051.2 2084.5 2162.0 2166.0 2167.1 9847.0 9912.0 9915.9 9923.9 9926.6 5162.4 5286.3 5292.8 5293.4 5302.8 2953.8 3098.6 3118.9 3129.2 3131.1 1141.6 1211.7 1236.4 1243.8 1260.1 14172.2 14408.5 14516.9 14549.9 14565.1 4175.6 4338.3 4422.2 4436.6 4483.8 12154.6 12172.1 12176.8 12188.5 12201.4 5420.1 5428.1 5435.0 5438.0 5438.3 4701.9 4749.0 4814.6 4915.9 4928.2 3743.1 3810.8 3813.3 3870.8 3886.5 1053.3 1071.0 1078.2 1098.5 1107.0 990.6 1008.9 1010.3 1021.9 1041.0 6428.3 6466.2 6533.3 6542.1 6633.9 1010.3 1014.8 1015.7 1016.7 1070.0 4170.3 4199.7 4240.7 4272.4 4391.3 11432.6 11866.6 11953.8 11960.0 12023.0 10745.2 11257.9 11676.3 11757.6 11764.8 8801.5 8990.1 9075.4 9116.7 9253.7 6658.4 6681.9 6686.0 6737.7 6857.1 11192.3 11216.1 11240.9 11362.0 11398.9 11231.8 11247.6 11294.9 11410.7 11417.4 8293.5 8353.5 8416.4 8431.9 8434.7 8799.0 8911.1 8952.3 8973.6 8985.4 8024.1 8056.4 8122.9 8163.9 8183.7 7942.6 7955.3 7982.6 8220.7 8225.5 7390.3 7512.7 7515.9 7518.1 7526.0 5759.7 5770.4 5860.3 5913.2 6035.6 5934.3 5943.2 6010.2 6184.7 6257.3 18:25:51 INFO - PROCESS | 1889 | 18:25:51 INFO - PROCESS | 1889 | [#4] prototype.html Cycles:180 Average:4809.73 Median:5288.72 stddev:1275.37 (24.1%) stddev-sans-first:1235.08 18:25:51 INFO - PROCESS | 1889 | Values: 391.5 394.1 403.1 404.6 413.6 5180.8 5265.3 5272.8 5277.8 5315.7 4784.8 5084.6 5094.2 5216.6 5225.5 4386.2 4391.1 4392.5 4398.5 4418.3 4399.5 4416.0 4420.8 4432.5 4441.0 4300.0 4409.4 4417.7 4422.7 4452.5 4365.8 4374.3 4400.8 4405.6 4425.4 4257.3 4261.3 4271.9 4283.1 4291.9 4838.7 5092.5 5122.7 5147.4 5149.6 5256.7 5272.6 5275.2 5280.5 5297.0 5494.9 5547.3 5564.7 5575.0 5578.2 4284.7 4519.5 4525.0 4806.5 4810.5 5446.7 5550.7 5680.8 5727.7 5730.9 4459.8 4495.9 4510.5 4533.5 4669.8 4631.8 4702.3 4726.2 4738.1 4743.1 4919.8 5025.8 5071.2 5094.7 5098.4 5464.6 5481.0 5481.8 5555.5 5567.1 1649.3 1649.9 1656.4 1663.8 1669.3 1148.7 1268.4 1277.7 1278.7 1283.3 5383.4 5420.2 5421.9 5427.5 5427.9 5245.3 5640.9 5700.6 5715.8 5745.2 5341.7 5342.3 5358.3 5385.9 5396.5 2983.8 2987.5 2989.9 2996.2 2997.4 5495.1 5806.5 5822.7 5938.5 5948.4 5687.5 5696.5 5697.4 5719.7 5756.9 5607.2 5856.3 5890.2 5897.4 5913.3 5543.6 5596.6 5639.7 5662.8 5670.5 5623.7 5633.7 5644.2 5645.3 5719.9 5544.0 5681.1 5795.8 5833.8 5928.9 4987.6 5042.8 5044.6 5051.7 5055.9 5317.8 5582.0 5679.3 5692.4 5698.2 5434.7 5439.3 5465.7 5481.3 5485.8 5454.2 5460.5 5501.5 5525.4 5529.3 5235.6 5426.2 5460.3 5465.9 5514.1 5478.4 5511.6 5515.3 5542.0 5560.3 5249.2 5421.6 5457.0 5458.1 5465.4 18:25:51 INFO - PROCESS | 1889 | 18:25:51 INFO - PROCESS | 1889 | [#5] yui.html Cycles:180 Average:16869.27 Median:37365.22 stddev:20710.04 (55.4%) stddev-sans-first:20732.70 18:25:51 INFO - PROCESS | 1889 | Values: 736.5 772.2 772.5 831.6 859.4 15413.6 16971.3 17006.7 17011.8 17023.9 14450.9 15226.8 15284.5 15678.4 16468.3 818.5 844.7 845.8 846.3 848.9 811.4 842.5 844.5 845.1 845.8 872.3 883.5 884.4 884.7 887.9 881.3 883.1 887.1 887.5 887.6 648.7 653.1 653.7 653.8 653.8 15255.2 15582.9 16562.7 16626.8 16687.2 14010.3 14755.0 14954.2 14960.3 15472.1 12618.6 12850.2 12853.9 12890.4 13179.1 3461.8 3491.5 3492.1 3506.8 3622.3 83165.0 86522.6 86543.6 87572.0 88423.6 10915.0 10976.3 11131.3 11289.1 11422.5 19440.2 20091.4 22755.3 22796.3 23084.4 7689.6 7770.2 7871.9 7931.8 8049.9 4295.7 4302.3 4352.5 4367.4 4387.4 3348.1 3440.9 3453.0 3454.5 3460.0 569.4 576.7 581.0 581.3 582.3 759.4 772.5 780.2 813.3 826.4 10153.8 10247.7 10252.4 10541.3 11050.3 625.3 632.8 653.8 680.9 784.2 4748.4 5035.5 5050.0 5078.9 5103.0 67039.3 68655.3 68695.3 69040.7 69276.3 45095.5 52143.5 59764.7 59786.7 61022.0 57731.7 58075.4 58126.7 58608.7 58676.7 10536.6 10713.1 10886.5 10984.6 11106.8 37158.4 37572.0 37831.4 38936.8 38960.8 43890.8 44446.6 45193.8 46603.5 46740.5 12945.5 13003.5 13196.0 13229.0 13573.9 14815.0 15035.2 15061.3 15292.2 15609.6 13930.0 14049.2 14115.3 14575.8 14586.3 14200.7 14440.8 14549.9 14620.7 14993.0 13948.6 13959.5 13995.0 14401.8 14688.6 11148.9 11249.4 11271.5 11353.6 11693.8 10985.3 11074.2 11134.5 11382.9 11434.3 18:25:51 INFO - PROCESS | 1889 | -------- Summary: end -------- 18:25:51 INFO - PROCESS | 1889 | 18:25:52 INFO - TEST-INFO | 1889: exit 0 18:25:52 INFO - TEST-OK | dromaeo_css | took 1118149ms 18:25:52 INFO - TEST-START | kraken 18:25:52 INFO - operating with platform_type : linux_ 18:25:52 INFO - Initialising browser for kraken test... 18:25:52 INFO - TEST-INFO | started process 2218 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp77HwFd/profile http://localhost:44765/getInfo.html) 18:25:56 INFO - PROCESS | 2218 | __metrics Screen width/height:1600/1200 18:25:56 INFO - PROCESS | 2218 | colorDepth:24 18:25:56 INFO - PROCESS | 2218 | Browser inner width/height: 1024/697 18:25:56 INFO - PROCESS | 2218 | __metrics 18:25:57 INFO - PROCESS | 2218 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 18:25:57 INFO - PROCESS | 2218 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:25:58 INFO - TEST-INFO | 2218: exit 0 18:25:58 INFO - Browser initialized. 18:25:58 INFO - Running cycle 1/1 for kraken test... 18:25:58 INFO - TEST-INFO | started process 2312 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp77HwFd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:26:10 INFO - PROCESS | 2312 | RSS: Main: 142700544 18:26:10 INFO - PROCESS | 2312 | 18:26:13 INFO - PROCESS | 2312 | Cycle 1(1): loaded http://localhost:44765/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44765/tests/kraken/driver.html?testName=audio-beat-detection) 18:26:14 INFO - PROCESS | 2312 | RSS: Main: 197517312 18:26:14 INFO - PROCESS | 2312 | 18:26:16 INFO - PROCESS | 2312 | Cycle 1(1): loaded http://localhost:44765/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44765/tests/kraken/driver.html?testName=audio-dft) 18:26:17 INFO - PROCESS | 2312 | RSS: Main: 177377280 18:26:17 INFO - PROCESS | 2312 | 18:26:20 INFO - PROCESS | 2312 | Cycle 1(1): loaded http://localhost:44765/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44765/tests/kraken/driver.html?testName=audio-fft) 18:26:20 INFO - PROCESS | 2312 | RSS: Main: 259579904 18:26:20 INFO - PROCESS | 2312 | 18:26:22 INFO - PROCESS | 2312 | Cycle 1(1): loaded http://localhost:44765/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44765/tests/kraken/driver.html?testName=audio-oscillator) 18:26:23 INFO - PROCESS | 2312 | RSS: Main: 170905600 18:26:23 INFO - PROCESS | 2312 | 18:26:25 INFO - PROCESS | 2312 | Cycle 1(1): loaded http://localhost:44765/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44765/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:26:26 INFO - PROCESS | 2312 | RSS: Main: 173928448 18:26:26 INFO - PROCESS | 2312 | 18:26:29 INFO - PROCESS | 2312 | Cycle 1(1): loaded http://localhost:44765/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44765/tests/kraken/driver.html?testName=imaging-darkroom) 18:26:29 INFO - PROCESS | 2312 | RSS: Main: 213069824 18:26:29 INFO - PROCESS | 2312 | 18:26:33 INFO - PROCESS | 2312 | Cycle 1(1): loaded http://localhost:44765/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44765/tests/kraken/driver.html?testName=imaging-desaturate) 18:26:34 INFO - PROCESS | 2312 | RSS: Main: 208101376 18:26:34 INFO - PROCESS | 2312 | 18:26:36 INFO - PROCESS | 2312 | Cycle 1(1): loaded http://localhost:44765/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44765/tests/kraken/driver.html?testName=json-parse-financial) 18:26:37 INFO - PROCESS | 2312 | RSS: Main: 210391040 18:26:37 INFO - PROCESS | 2312 | 18:26:39 INFO - PROCESS | 2312 | Cycle 1(1): loaded http://localhost:44765/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44765/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:26:39 INFO - PROCESS | 2312 | RSS: Main: 173813760 18:26:39 INFO - PROCESS | 2312 | 18:26:41 INFO - PROCESS | 2312 | Cycle 1(1): loaded http://localhost:44765/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44765/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:26:42 INFO - PROCESS | 2312 | RSS: Main: 180006912 18:26:42 INFO - PROCESS | 2312 | 18:26:44 INFO - PROCESS | 2312 | Cycle 1(1): loaded http://localhost:44765/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44765/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:26:44 INFO - PROCESS | 2312 | RSS: Main: 188997632 18:26:44 INFO - PROCESS | 2312 | 18:26:47 INFO - PROCESS | 2312 | Cycle 1(1): loaded http://localhost:44765/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44765/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:26:48 INFO - PROCESS | 2312 | RSS: Main: 199294976 18:26:48 INFO - PROCESS | 2312 | 18:26:50 INFO - PROCESS | 2312 | Cycle 1(1): loaded http://localhost:44765/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44765/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:26:51 INFO - PROCESS | 2312 | RSS: Main: 194932736 18:26:51 INFO - PROCESS | 2312 | 18:26:53 INFO - PROCESS | 2312 | Cycle 1(1): loaded http://localhost:44765/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44765/tests/kraken/driver.html?testName=ai-astar) 18:26:53 INFO - PROCESS | 2312 | RSS: Main: 246992896 18:26:53 INFO - PROCESS | 2312 | 18:26:53 INFO - PROCESS | 2312 | __start_tp_report 18:26:53 INFO - PROCESS | 2312 | _x_x_mozilla_page_load 18:26:53 INFO - PROCESS | 2312 | _x_x_mozilla_page_load_details 18:26:53 INFO - PROCESS | 2312 | |i|pagename|runs| 18:26:53 INFO - PROCESS | 2312 | |0;ai-astar;112;113;113;114;112;114;113;113;113;113 18:26:53 INFO - PROCESS | 2312 | |1;audio-beat-detection;144;117;118;172;119;126;118;121;154;117 18:26:53 INFO - PROCESS | 2312 | |2;audio-dft;162;163;162;161;162;162;162;163;162;163 18:26:53 INFO - PROCESS | 2312 | |3;audio-fft;76;75;76;107;76;75;77;75;93;75 18:26:53 INFO - PROCESS | 2312 | |4;audio-oscillator;82;83;104;83;82;83;105;83;83;102 18:26:53 INFO - PROCESS | 2312 | |5;imaging-gaussian-blur;113;113;113;114;114;113;113;114;114;113 18:26:53 INFO - PROCESS | 2312 | |6;imaging-darkroom;147;147;147;146;146;147;147;147;147;146 18:26:53 INFO - PROCESS | 2312 | |7;imaging-desaturate;94;94;93;93;93;94;94;93;93;94 18:26:53 INFO - PROCESS | 2312 | |8;json-parse-financial;65;56;55;56;56;56;57;57;55;58 18:26:53 INFO - PROCESS | 2312 | |9;json-stringify-tinderbox;54;54;54;54;54;55;55;55;55;55 18:26:53 INFO - PROCESS | 2312 | |10;stanford-crypto-aes;81;84;80;88;87;82;81;87;85;85 18:26:53 INFO - PROCESS | 2312 | |11;stanford-crypto-ccm;128;130;128;131;129;137;125;127;184;148 18:26:53 INFO - PROCESS | 2312 | |12;stanford-crypto-pbkdf2;175;178;176;177;171;171;170;169;177;170 18:26:53 INFO - PROCESS | 2312 | |13;stanford-crypto-sha256-iterative;71;67;62;63;62;63;64;66;64;62 18:26:53 INFO - PROCESS | 2312 | __end_tp_report 18:26:53 INFO - PROCESS | 2312 | __start_cc_report 18:26:53 INFO - PROCESS | 2312 | _x_x_mozilla_cycle_collect,1762 18:26:53 INFO - PROCESS | 2312 | __end_cc_report 18:26:53 INFO - PROCESS | 2312 | __startTimestamp1488594413526__endTimestamp 18:26:53 INFO - PROCESS | 2312 | 18:26:53 INFO - PROCESS | 2312 | ------- Summary: start ------- 18:26:53 INFO - PROCESS | 2312 | Number of tests: 14 18:26:53 INFO - PROCESS | 2312 | 18:26:53 INFO - PROCESS | 2312 | [#0] ai-astar Cycles:10 Average:113.00 Median:113.00 stddev:0.67 (0.6%) stddev-sans-first:0.60 18:26:53 INFO - PROCESS | 2312 | Values: 112.0 113.0 113.0 114.0 112.0 114.0 113.0 113.0 113.0 113.0 18:26:53 INFO - PROCESS | 2312 | 18:26:53 INFO - PROCESS | 2312 | [#1] audio-beat-detection Cycles:10 Average:130.60 Median:123.50 stddev:19.37 (15.7%) stddev-sans-first:19.93 18:26:53 INFO - PROCESS | 2312 | Values: 144.0 117.0 118.0 172.0 119.0 126.0 118.0 121.0 154.0 117.0 18:26:53 INFO - PROCESS | 2312 | 18:26:53 INFO - PROCESS | 2312 | [#2] audio-dft Cycles:10 Average:162.20 Median:162.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 18:26:53 INFO - PROCESS | 2312 | Values: 162.0 163.0 162.0 161.0 162.0 162.0 162.0 163.0 162.0 163.0 18:26:53 INFO - PROCESS | 2312 | 18:26:53 INFO - PROCESS | 2312 | [#3] audio-fft Cycles:10 Average:80.50 Median:76.00 stddev:10.81 (14.2%) stddev-sans-first:11.35 18:26:53 INFO - PROCESS | 2312 | Values: 76.0 75.0 76.0 107.0 76.0 75.0 77.0 75.0 93.0 75.0 18:26:53 INFO - PROCESS | 2312 | 18:26:53 INFO - PROCESS | 2312 | [#4] audio-oscillator Cycles:10 Average:89.00 Median:83.00 stddev:10.15 (12.2%) stddev-sans-first:10.45 18:26:53 INFO - PROCESS | 2312 | Values: 82.0 83.0 104.0 83.0 82.0 83.0 105.0 83.0 83.0 102.0 18:26:53 INFO - PROCESS | 2312 | 18:26:53 INFO - PROCESS | 2312 | [#5] imaging-gaussian-blur Cycles:10 Average:113.40 Median:113.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 18:26:53 INFO - PROCESS | 2312 | Values: 113.0 113.0 113.0 114.0 114.0 113.0 113.0 114.0 114.0 113.0 18:26:53 INFO - PROCESS | 2312 | 18:26:53 INFO - PROCESS | 2312 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 18:26:53 INFO - PROCESS | 2312 | Values: 147.0 147.0 147.0 146.0 146.0 147.0 147.0 147.0 147.0 146.0 18:26:53 INFO - PROCESS | 2312 | 18:26:53 INFO - PROCESS | 2312 | [#7] imaging-desaturate Cycles:10 Average:93.50 Median:94.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 18:26:53 INFO - PROCESS | 2312 | Values: 94.0 94.0 93.0 93.0 93.0 94.0 94.0 93.0 93.0 94.0 18:26:53 INFO - PROCESS | 2312 | 18:26:53 INFO - PROCESS | 2312 | [#8] json-parse-financial Cycles:10 Average:57.10 Median:56.50 stddev:2.92 (5.2%) stddev-sans-first:0.97 18:26:53 INFO - PROCESS | 2312 | Values: 65.0 56.0 55.0 56.0 56.0 56.0 57.0 57.0 55.0 58.0 18:26:53 INFO - PROCESS | 2312 | 18:26:53 INFO - PROCESS | 2312 | [#9] json-stringify-tinderbox Cycles:10 Average:54.50 Median:55.00 stddev:0.53 (1.0%) stddev-sans-first:0.53 18:26:53 INFO - PROCESS | 2312 | Values: 54.0 54.0 54.0 54.0 54.0 55.0 55.0 55.0 55.0 55.0 18:26:53 INFO - PROCESS | 2312 | 18:26:53 INFO - PROCESS | 2312 | [#10] stanford-crypto-aes Cycles:10 Average:84.00 Median:85.00 stddev:2.87 (3.4%) stddev-sans-first:2.83 18:26:53 INFO - PROCESS | 2312 | Values: 81.0 84.0 80.0 88.0 87.0 82.0 81.0 87.0 85.0 85.0 18:26:53 INFO - PROCESS | 2312 | 18:26:53 INFO - PROCESS | 2312 | [#11] stanford-crypto-ccm Cycles:10 Average:136.70 Median:130.50 stddev:17.90 (13.7%) stddev-sans-first:18.71 18:26:53 INFO - PROCESS | 2312 | Values: 128.0 130.0 128.0 131.0 129.0 137.0 125.0 127.0 184.0 148.0 18:26:53 INFO - PROCESS | 2312 | 18:26:53 INFO - PROCESS | 2312 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.40 Median:175.50 stddev:3.50 (2.0%) stddev-sans-first:3.67 18:26:53 INFO - PROCESS | 2312 | Values: 175.0 178.0 176.0 177.0 171.0 171.0 170.0 169.0 177.0 170.0 18:26:53 INFO - PROCESS | 2312 | 18:26:53 INFO - PROCESS | 2312 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.40 Median:64.00 stddev:2.88 (4.5%) stddev-sans-first:1.80 18:26:53 INFO - PROCESS | 2312 | Values: 71.0 67.0 62.0 63.0 62.0 63.0 64.0 66.0 64.0 62.0 18:26:53 INFO - PROCESS | 2312 | -------- Summary: end -------- 18:26:53 INFO - PROCESS | 2312 | 18:26:54 INFO - TEST-INFO | 2312: exit 0 18:26:54 INFO - TEST-OK | kraken | took 62181ms 18:26:54 INFO - SUITE-END | took 1180s 18:26:54 INFO - Completed test suite (00:19:40) 18:26:54 INFO - javascript benchmark 18:26:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7353.7801760616, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3195.9041228763135, 3211.518272259162, 3247.772655914086, 3247.821369824662, 3256.967430325696, 5261.947380526193, 5361.544268737162, 5400.648957817744, 5469.671819690811, 5480.6437581557175, 5427.755750991205, 5428.45715428457, 5431.266778984836, 5442.782288708457, 5474.808381706631, 4757.119932812441, 4789.066132104241, 4833.4924832892475, 4888.804447822101, 4911.0, 4879.829205977791, 4894.363732714742, 4945.134601444751, 4953.578945789613, 4989.0, 4788.425388953313, 4817.542333478314, 4825.879353016185, 4829.082474329866, 4829.661923665345, 4771.475137734847, 4833.782479788418, 4835.298881662139, 4841.15279826029, 4844.5155484451625, 4785.904281914377, 4795.424549054101, 4802.783874725646, 4849.321095046696, 4875.561199492027, 5361.865953351158, 5365.731713414314, 5369.704666243355, 5383.788647554308, 5422.8373148805595, 5650.519705824969, 5677.37548869624, 5793.13103034544, 5802.88394232113, 5821.068629019379, 5712.6286791358425, 5778.479936805707, 5819.67991760453, 5830.125481177814, 5844.357120716718, 5525.889482210374, 5531.834044978697, 5547.306586676666, 5553.416891226444, 5557.249771280865, 5964.433378829004, 6006.729697163638, 6012.609180403259, 6021.909671354933, 6026.457618814327, 5509.834704958857, 5549.084401073858, 5550.167474878801, 5747.4252574742195, 5764.365919748824, 5692.203091567184, 5697.03150464422, 5698.1737648041635, 5704.515116215168, 5721.742521586539, 5646.830595082154, 5656.91514627281, 5661.80183693577, 5685.658860468302, 5686.914696279559, 5707.200991861143, 5745.482906538432, 5755.165501002331, 5758.596898217168, 5759.078547432391, 4499.100179963955, 4503.437070366204, 4504.954950450454, 4506.864794056183, 4545.5908968193025, 4015.8795236142964, 4018.1160144768687, 4022.4368588397647, 4035.0, 4053.3717273822604, 5630.8029218977135, 5635.0702134147405, 5642.802501912413, 5642.858928526737, 5653.180288858175, 5869.20765696634, 5899.321578018583, 5900.321463031721, 5906.881862362815, 5919.082542205965, 5583.218349431083, 5586.944130558642, 5591.10542313228, 5592.440755924375, 5614.887702245932, 4914.901701966012, 4933.605311575066, 4963.429205641325, 4984.576311013532, 5082.313887625123, 6135.55172499934, 6139.032198454696, 6146.7233974471255, 6150.692465376714, 6150.815475535741, 5869.6771677558145, 5869.853253668522, 5874.441928016831, 5877.0, 5923.378045305181, 6009.2188015557695, 6062.787802426894, 6069.848253793691, 6115.388461153849, 6140.846478838065, 5682.573806964411, 5753.798617048383, 5763.94236057634, 5779.162021506942, 5783.8554036149435, 5882.970585147047, 5884.882302354014, 5892.086726557391, 5901.557383196363, 5940.138679891478, 5702.543796496353, 5734.5125664319, 5748.281464816898, 5749.453801888814, 5770.480656740913, 5618.550515958796, 5630.577706671934, 5719.28508936383, 5738.770449181986, 5740.885182296414, 5654.15187721845, 5670.291213598301, 5681.034224181816, 5689.1750696148, 5704.3154821421695, 5615.522680572034, 5653.293338332708, 5654.208410822406, 5655.830325090254, 5724.055530837365, 5555.0278701227935, 5560.416156303691, 5595.160725891149, 5600.383957764561, 5605.523530499953], "value": 5361.431772111188, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [753.190320405564, 771.4252881603205, 825.1047613339526, 832.9416940814142, 836.6778790165785, 28598.142055738335, 40064.399034014474, 40380.0, 44593.7770311148, 44968.775156124255, 43293.56706432935, 43568.0, 43610.781946090225, 43638.0, 43680.56319436805, 7257.274272572753, 8705.912940870588, 8849.380543361967, 8858.645654173857, 8871.423357481743, 7348.5958272295, 10279.537420816081, 10475.633352832652, 10479.947600261989, 10503.63237286695, 10626.840597391045, 10649.680509584687, 10662.62680806172, 10663.573457061708, 10666.14670826332, 10531.631392901212, 10540.736481587983, 10592.41741704206, 10598.152147828156, 10599.735006624818, 10211.591536338537, 10280.07479326864, 10282.228832837567, 10285.948570257176, 10287.22845786569, 39239.41140882889, 39343.0, 39426.802865985774, 39445.60554394448, 39446.60553394458, 3749.193923306475, 3753.680937120348, 3776.0748616588835, 3779.5653499847595, 3829.617038296148, 28035.85982070097, 28197.43605127886, 28423.85788071067, 28823.42353152946, 28874.566881496794, 4031.2743706132883, 4083.4895638045246, 4128.112455821983, 4140.192662430827, 4238.215930052919, 209343.0, 209629.0, 209877.0, 210233.0, 211928.0, 39974.20051598952, 40304.0, 48556.271655925186, 49131.263031054565, 49176.0, 54101.45898541043, 55277.170842437394, 55309.44690553043, 55506.16740748892, 55530.0, 13604.727905442034, 13620.523281685291, 13717.17696938187, 13741.931290343484, 13742.106763060368, 11603.12976526747, 11614.535418583331, 11635.53457861693, 11639.6508104757, 11646.534138634359, 13065.150765200231, 13098.607041788762, 13120.212787232605, 13196.538121165906, 13223.206607603575, 4811.206150985118, 4889.4282900430235, 5475.123980163155, 5596.425644203712, 5696.914546281809, 1130.0846314485293, 1147.4205526209212, 1150.925189862673, 1173.3957012138756, 1200.5497938273147, 25063.122790702237, 25353.492930141292, 25441.618375724378, 25464.618030729554, 25961.480770384485, 1222.45600707686, 1236.5733821831454, 1252.423885012886, 1267.991946402612, 1275.3431982528818, 13258.412400843716, 13461.326933653278, 13563.66090847717, 13804.064252371376, 13865.861341386659, 267613.0, 268195.0, 268678.0, 268746.0, 269040.0, 50117.49882501128, 50654.49345506571, 50726.0, 50827.237591436155, 50899.0, 1414.2080434956458, 1432.548747144646, 1439.7336492748875, 1441.2865631512468, 1452.5787521618613, 23836.16573419922, 24065.157719480434, 24529.877350613133, 24679.506409871345, 25188.0, 38542.42186367151, 38570.03574910649, 38722.22555548817, 38749.0, 38991.805040974614, 247163.0, 247677.0, 247775.0, 248668.0, 248775.3663401974, 31995.680043200202, 32496.83751581227, 32775.50836737498, 32843.0, 32953.67046329506, 32384.838075810414, 39094.609053909095, 39515.209695805344, 39664.60335396609, 41005.1798964025, 35159.47260791141, 35488.64511354853, 35897.820510898324, 36044.0, 36212.818935905154, 35932.46101308535, 35993.1001724959, 36281.274374511835, 36429.45355819612, 36561.81719091388, 37230.44154337741, 37397.0, 38100.618993810815, 38122.42816357702, 38166.80916595511, 29603.407931841673, 31034.0, 31777.8411107943, 31849.68150318467, 31990.52014219835, 25188.496230075663, 25347.366315842253, 25348.366290842878, 25366.365840854127, 25716.61425078588], "value": 17996.489003768984, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [392.4760444806184, 418.24896269504416, 427.81176282435706, 427.98930026749326, 441.7791104447776, 15083.0, 18798.15408306626, 19936.302229421974, 20215.898920505377, 20313.59372812543, 19511.902440487815, 20328.08523616437, 20442.69335959958, 20548.48628784281, 20714.792852071514, 6349.396807303298, 6499.7000599879975, 6605.471562275006, 6605.867882642344, 6615.305392933745, 6305.842353941165, 6366.808995730135, 6476.222853257592, 6477.287498375175, 6486.902696459533, 6451.774187903425, 6468.870622587546, 6495.902561461558, 6813.523053386265, 7028.332308430691, 7136.2506936771415, 7198.496105272633, 7219.711211551558, 7283.308085731847, 7301.744438944638, 7111.146662400493, 7143.749968751069, 7153.248908864546, 7157.6063316517575, 7165.925111233305, 22663.660045099336, 22840.657390138997, 23078.192263270874, 23306.086739157607, 23613.645795312914, 3213.469777486712, 3325.235195904931, 3384.8476818543227, 3394.6775056369606, 3423.2639982403903, 14226.359813808403, 14265.500707475292, 14705.852941470663, 14730.0, 14747.041442306216, 2082.2191678120703, 2139.1550337616554, 2153.633882240023, 2165.621016322153, 2231.364061242538, 104931.0, 106650.46674766732, 107161.0, 107565.46217268941, 110633.0, 13533.255670938193, 15454.459093931659, 16274.837251627569, 16306.836931630532, 16696.666066678597, 24105.638415423782, 24559.0, 24587.0, 25033.0, 25253.116140935348, 8213.260806527442, 8416.410851240476, 8546.359023073295, 8640.222379985831, 8674.6530138795, 6864.759733409307, 6896.069030680894, 6950.652467376611, 7075.2570980047385, 7101.396381307543, 8134.901788258628, 8260.215279548553, 8365.749027529184, 8375.748727538183, 8413.537255450887, 3542.3800834853796, 3618.9819050904575, 3635.781853088823, 3642.453631955175, 3682.760620559655, 870.5603670146536, 886.7650072730731, 891.2780647675404, 895.2971917045088, 913.9451632902047, 18254.543636409195, 19491.415257542296, 19501.902490487457, 19563.119659615353, 19890.403287901387, 881.0, 883.5052370672444, 888.8444522208717, 898.9235914947172, 905.5698543192062, 10279.327374882585, 10681.519331630096, 10699.14406847466, 10760.085392741548, 10780.40707761065, 567056.0, 580173.0, 589863.0, 590714.0, 592154.0, 96896.0, 99741.0, 99869.0, 102665.97334026714, 103321.0, 1124.1961997171898, 1166.2361153444508, 1188.5424111716877, 1191.53530123252, 1195.1574140231116, 16068.0, 16106.919465403067, 16585.585360365603, 16659.916700416907, 16804.32782688728, 47387.76306118447, 47837.28244076411, 48591.47889717513, 48680.0, 49475.257871131245, 59559.40440595712, 59882.10176847438, 60992.0, 61255.0, 62497.0, 11028.503717332578, 11366.772664546828, 11379.715507112389, 11499.885001149882, 11726.237794543327, 12876.484940602271, 12920.483180672667, 13032.674183145118, 13212.603621891358, 13236.404361803934, 11508.42457877086, 11581.305121692725, 11758.764824703629, 11909.940450297692, 12344.938275308925, 11383.54465821358, 11490.253133546294, 11492.080633549464, 11606.0, 11736.413179341169, 11793.174477786815, 11851.703707407383, 11904.404779761151, 11995.0, 12309.138360314691, 11212.887871121511, 11258.66224013281, 11309.886901130883, 11578.76842463163, 11669.88330116722, 11651.0, 11704.590339338083, 11710.648680539256, 11741.882581174079, 12035.509702186268], "value": 10575.23436053132, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1456.4756687592458, 1464.9267536623165, 1486.8810495160387, 1504.3230546254185, 1505.9774103388447, 9166.495842728647, 9663.951680241598, 9669.613215471372, 9671.70984870454, 9672.0, 9369.531523423819, 9650.324477286593, 9925.255605829556, 9950.25373097017, 9951.203903687705, 2118.7987141221597, 2174.4672555223992, 2174.7281589801273, 2176.7279090113734, 2187.475005998565, 2101.642720737478, 2158.2230397057047, 2160.7839216078346, 2165.523584811339, 2165.6968024476505, 1988.0954165854573, 2028.0772248626913, 2033.4001469566513, 2040.4286799696035, 2048.764392094906, 2050.846186536016, 2052.374025922093, 2056.7120603115577, 2057.722207501983, 2062.9071691773906, 2051.241040814908, 2084.5309805293687, 2161.9783802161933, 2165.967510487344, 2167.089822274648, 9846.950765246127, 9912.0, 9915.851262231072, 9923.851142232872, 9926.553305101215, 5162.354705661793, 5286.3392075990505, 5292.788288468457, 5293.444188360205, 5302.814401495968, 2953.778466614991, 3098.6281646202374, 3118.8908388206305, 3129.1864115330177, 3131.091983324833, 1141.5662048421548, 1211.668285877981, 1236.437420973455, 1243.8072098824696, 1260.1116213069763, 14172.220527870963, 14408.495702650356, 14516.927415362856, 14549.92725036368, 14565.053271537423, 4175.561566035583, 4338.284183109815, 4422.159789639958, 4436.578525040116, 4483.798229079699, 12154.574589889487, 12172.087093468026, 12176.81734773979, 12188.451519681636, 12201.38993050344, 5420.07858664028, 5428.077226871442, 5434.972825135849, 5438.0, 5438.293021907127, 4701.882452938704, 4748.976255118702, 4814.614830813526, 4915.901681966412, 4928.211486162197, 3743.1390780120723, 3810.809459527068, 3813.275477659236, 3870.7549621219623, 3886.4947556817997, 1053.2942928238099, 1070.9946450267698, 1078.1698092468755, 1098.4837126550508, 1106.983395249072, 990.6037584965927, 1008.9243306752023, 1010.2524132142308, 1021.9284650074424, 1040.9895901041043, 6428.325025872309, 6466.159399278158, 6533.281339052701, 6542.093191814605, 6633.900491492632, 1010.2978429991233, 1014.802113587858, 1015.7206768138673, 1016.7240113657313, 1069.9518521666544, 4170.311898536707, 4199.68502362324, 4240.703150779477, 4272.423222864935, 4391.341298805205, 11432.599859004895, 11866.644000679993, 11953.820692689616, 11960.0, 12023.0, 10745.247832651796, 11257.943710281395, 11676.299422034705, 11757.588484403175, 11764.823527647091, 8801.491574901122, 8990.145936136056, 9075.410098343718, 9116.680916167903, 9253.72238832836, 6658.367455091952, 6681.899771503334, 6686.0, 6737.73049078051, 6857.108575885103, 11192.272502287326, 11216.102711782874, 11240.943795280971, 11362.0, 11398.886011139783, 11231.831522527005, 11247.550097995989, 11294.94352528232, 11410.657680269605, 11417.37204453763, 8293.543855088028, 8353.498790072616, 8416.410851240355, 8431.873521897054, 8434.704785332484, 8798.956005219932, 8911.06433824439, 8952.328575356743, 8973.551322433721, 8985.415947963362, 8024.0772311184965, 8056.355491560544, 8122.918770812216, 8163.877541836996, 8183.71357002502, 7942.64258108375, 7955.2840244378285, 7982.56095914707, 8220.712275070344, 8225.547594882339, 7390.260973902567, 7512.661930213044, 7515.8872616911885, 7518.135414427192, 7526.0, 5759.683217422914, 5770.365259821332, 5860.2967643883, 5913.231279933581, 6035.6076855004285, 5934.33715155805, 5943.227380440515, 6010.248718910137, 6184.6598437086395, 6257.28041275241], "value": 4814.392825520596, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [391.48910671573606, 394.14863893988985, 403.07494300580163, 404.58530006743086, 413.59261127789125, 5180.844574662761, 5265.341417453499, 5272.7627256773485, 5277.841664750059, 5315.681059136455, 4784.784684689189, 5084.618653600976, 5094.184930411135, 5216.5742929537755, 5225.503577160173, 4386.232409328362, 4391.121775644884, 4392.494863090737, 4398.538153493869, 4418.270985287424, 4399.472063352387, 4415.955840441587, 4420.77896105195, 4432.468103827545, 4441.0, 4300.011492013052, 4409.360642706805, 4417.73493590384, 4422.690411671184, 4452.532484089173, 4365.799405163573, 4374.34384842273, 4400.757958312275, 4405.647548196137, 4425.402570652969, 4257.318828987378, 4261.31818908973, 4271.850485233033, 4283.115429211169, 4291.871243862689, 4838.733869637169, 5092.548623642281, 5122.743862806882, 5147.382314122292, 5149.613778966593, 5256.737163141827, 5272.604554658377, 5275.208718692188, 5280.471952804727, 5296.9735151324385, 5494.862628434321, 5547.3343198816, 5564.693941833198, 5574.968630803314, 5578.206819362832, 4284.721493102938, 4519.463382449982, 4524.954750452486, 4806.4712881583, 4810.518948105161, 5446.673199608036, 5550.72246387679, 5680.772769089232, 5727.682632994393, 5730.914036289459, 4459.799309031101, 4495.910081798345, 4510.534076425175, 4533.481283769908, 4669.813207471663, 4631.8378856739855, 4702.27114797207, 4726.19654658702, 4738.076075165379, 4743.146233677902, 4919.7540122993705, 5025.773840177201, 5071.239314102914, 5094.739366805247, 5098.439171691111, 5464.617476776667, 5480.972595136999, 5481.835544933659, 5555.500044963512, 5567.081431563827, 1649.2990479046357, 1649.878082903637, 1656.4119737493018, 1663.7670726098356, 1669.290551515601, 1148.6732823588768, 1268.4165283969478, 1277.6614197237739, 1278.6945745248636, 1283.3444856135482, 5383.380911195184, 5420.186971954238, 5421.918671219935, 5427.48438898304, 5427.941551397518, 5245.318108645852, 5640.8871822563315, 5700.572457065737, 5715.771369145187, 5745.213571417859, 5341.679499229981, 5342.290467050584, 5358.33020872391, 5385.865353366119, 5396.541293990055, 2983.77621678375, 2987.536931775578, 2989.910302690923, 2996.1760515858314, 2997.4454725875785, 5495.1425258865165, 5806.477417032487, 5822.650640961556, 5938.524918006549, 5948.434898684618, 5687.530606330135, 5696.458836410535, 5697.401772813878, 5719.682584101211, 5756.884862302731, 5607.243022192115, 5856.306099194333, 5890.2342695449315, 5897.439743224387, 5913.2608423947, 5543.6396634218645, 5596.580256480699, 5639.746211420414, 5662.8301150965535, 5670.489655930986, 5623.746931388179, 5633.718314084362, 5644.2380278663495, 5645.294338207724, 5719.8570035749435, 5543.972280138573, 5681.147827825859, 5795.797147099831, 5833.79581714638, 5928.9407105928385, 4987.60099192071, 5042.798288068583, 5044.621653375938, 5051.747412629427, 5055.87360315995, 5317.83007738297, 5582.0, 5679.34687510925, 5692.430756924275, 5698.20225168485, 5434.701091440009, 5439.292891924025, 5465.704404150346, 5481.287432633732, 5485.820548582074, 5454.209139674805, 5460.481254280837, 5501.504864562048, 5525.408484485117, 5529.336479622471, 5235.554977826928, 5426.232621363054, 5460.290162278879, 5465.890682186414, 5514.145307477347, 5478.424765399575, 5511.614187006871, 5515.332304017783, 5542.0, 5560.304961879765, 5249.238860365302, 5421.566274698093, 5456.972715136399, 5458.1169496523635, 5465.37148227943], "value": 4433.963526699244, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [736.5433431272612, 772.2470591173607, 772.5441989226356, 831.5758962928907, 859.3511898516621, 15413.6146596335, 16971.321147154114, 17006.659866802656, 17011.82988170118, 17023.914880425596, 14450.855491445081, 15226.847731522681, 15284.541463756077, 15678.372865085412, 16468.258928348223, 818.4720855048505, 844.7381311793364, 845.7970087179094, 846.318713435684, 848.8811566380712, 811.4157806379397, 842.4524059361403, 844.5312851367519, 845.1421806866036, 845.7631863078317, 872.2760109109424, 883.5317281840635, 884.3720958119743, 884.7168905950099, 887.8978917424514, 881.2817553693719, 883.0551310098198, 887.1394747095308, 887.4675194883083, 887.5739644970386, 648.6724204276857, 653.1150291355241, 653.650297091054, 653.8169312592481, 653.8365408647838, 15255.160966146857, 15582.922085389613, 16562.668746625, 16626.750598740906, 16687.249073791707, 14010.29948502581, 14755.040922340013, 14954.177520236382, 14960.251987400696, 15472.149031803247, 12618.55711143621, 12850.164739291917, 12853.87146128536, 12890.355482225852, 13179.14335568185, 3461.809600471973, 3491.528129802225, 3492.0746002309406, 3506.7720598161036, 3622.2755448910325, 83165.0, 86522.56738716329, 86543.56728216381, 87572.0, 88423.55788221082, 10915.0, 10976.341419514854, 11131.276467029616, 11289.0968722502, 11422.543098276143, 19440.222391104482, 20091.39725808228, 22755.31734047981, 22796.316110516713, 23084.4228894279, 7689.615519224017, 7770.184130666312, 7871.921280787119, 7931.801704957422, 8049.879251811228, 4295.720778149473, 4302.311630139163, 4352.467029787921, 4367.410399596014, 4387.42963414754, 3348.11275012122, 3440.9483857742152, 3452.9654703452643, 3454.4990976308295, 3460.0, 569.3907518954761, 576.7145263094795, 581.0441823200896, 581.3315783700806, 582.3186871360518, 759.369723129812, 772.4862966127462, 780.1963977103593, 813.345257068054, 826.3884725303233, 10153.847692284622, 10247.72411587781, 10252.43611601369, 10541.31481453703, 11050.336979781077, 625.3496363781707, 632.7658766256422, 653.8071268975664, 680.8536164724608, 784.2471227621547, 4748.430188377348, 5035.471275516018, 5050.0, 5078.923816142761, 5103.0, 67039.32960670428, 68655.3134468659, 68695.3130468699, 69040.65479672569, 69276.307236928, 45095.549044509135, 52143.478565214624, 59764.701176493836, 59786.70106649439, 61022.0, 57731.71134144302, 58075.41924580785, 58126.709366452895, 58608.70695646494, 58676.70661646665, 10536.631217907336, 10713.14294856394, 10886.455677216265, 10984.615538456115, 11106.777864442827, 37158.44262336121, 37572.0, 37831.43252851265, 38936.80531597324, 38960.80519597384, 43890.78054609834, 44446.55553444424, 45193.77403112964, 46603.53396465992, 46740.53259467362, 12945.482180712666, 13003.544875929298, 13196.0, 13229.0, 13573.86426135726, 14815.0, 15035.173065481504, 15061.322240499423, 15292.235388230767, 15609.609759755642, 13930.021821579872, 14049.157050576998, 14115.294235287989, 14575.781363279348, 14586.34361453716, 14200.715985680436, 14440.783388249394, 14549.85450145485, 14620.707585848437, 14993.0, 13948.58154255374, 13959.511417100759, 13995.0, 14401.7839732402, 14688.592310136944, 11148.88851111511, 11249.437528123724, 11271.549138034386, 11353.602623908124, 11693.766124677288, 10985.285956412808, 11074.169437292074, 11134.488264172049, 11382.886171138183, 11434.256773309708], "value": 7259.919881249976, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1499.0000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 113.0, 113.0, 114.0, 112.0, 114.0, 113.0, 113.0, 113.0, 113.0], "value": 113.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 117.0, 118.0, 172.0, 119.0, 126.0, 118.0, 121.0, 154.0, 117.0], "value": 130.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 162.0, 161.0, 162.0, 162.0, 162.0, 163.0, 162.0, 163.0], "value": 162.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 107.0, 76.0, 75.0, 77.0, 75.0, 93.0, 75.0], "value": 80.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 104.0, 83.0, 82.0, 83.0, 105.0, 83.0, 83.0, 102.0], "value": 89.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 113.0, 114.0, 114.0, 113.0, 113.0, 114.0, 114.0, 113.0], "value": 113.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 146.0, 146.0, 147.0, 147.0, 147.0, 147.0, 146.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 93.0, 93.0, 93.0, 94.0, 94.0, 93.0, 93.0, 94.0], "value": 93.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 56.0, 55.0, 56.0, 56.0, 56.0, 57.0, 57.0, 55.0, 58.0], "value": 57.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 54.0, 54.0, 55.0, 55.0, 55.0, 55.0, 55.0], "value": 54.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 84.0, 80.0, 88.0, 87.0, 82.0, 81.0, 87.0, 85.0, 85.0], "value": 84.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 130.0, 128.0, 131.0, 129.0, 137.0, 125.0, 127.0, 184.0, 148.0], "value": 136.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 178.0, 176.0, 177.0, 171.0, 171.0, 170.0, 169.0, 177.0, 170.0], "value": 173.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 67.0, 62.0, 63.0, 62.0, 63.0, 64.0, 66.0, 64.0, 62.0], "value": 64.4, "unit": "score"}]}]} 18:26:54 INFO - Return code: 0 18:26:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:26:54 ERROR - # TBPL SUCCESS # 18:26:54 INFO - Running post-action listener: _resource_record_post_action 18:26:54 INFO - [mozharness: 2017-03-04 02:26:54.834223Z] Finished run-tests step (success) 18:26:54 INFO - Running post-run listener: _resource_record_post_run 18:26:54 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 365023232; Read time: 16; Write time: 315420 18:26:54 INFO - TinderboxPrint: CPU usage
13.2% 18:26:54 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 18:26:54 INFO - TinderboxPrint: I/O write bytes / time
365,023,232 / 315,420 18:26:54 INFO - TinderboxPrint: CPU idle
8,302.1 (86.8%) 18:26:54 INFO - TinderboxPrint: CPU user
1,209.2 (12.6%) 18:26:54 INFO - TinderboxPrint: Swap in / out
0 / 0 18:26:54 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 111525888; Read time: 0; Write time: 123708 18:26:54 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 4096; Write bytes: 253497344; Read time: 16; Write time: 191712 18:26:55 INFO - Running post-run listener: _upload_blobber_files 18:26:55 INFO - Blob upload gear active. 18:26:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:26:55 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 18:26:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:26:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:26:55 INFO - (blobuploader) - INFO - Open directory for files ... 18:26:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:26:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:26:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:26:56 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:26:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:26:56 INFO - (blobuploader) - INFO - Done attempting. 18:26:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:26:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:26:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:27:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:27:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:27:00 INFO - (blobuploader) - INFO - Done attempting. 18:27:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:27:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:27:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:27:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:27:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:27:00 INFO - (blobuploader) - INFO - Done attempting. 18:27:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:27:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:27:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:27:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:27:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:27:01 INFO - (blobuploader) - INFO - Done attempting. 18:27:01 INFO - (blobuploader) - INFO - Iteration through files over. 18:27:01 INFO - Return code: 0 18:27:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:27:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:27:01 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4fb43676e155320762be0ecb3d747cbf762f4642651406329e70a35550a96a7faa26477a524cc6f35b4e6aa62c0a1cdd89316d0a2fbcf0f6f8cbe483614badc0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/38a8a0af822d3ed933887ca60a579fece282e495fc2bbba1b146087dad145ca70906c36c336224def77ac84555c5f02c3450f5e1b3f53aa5512e0708b61102f8", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b29bb58e0de5bb98a5b6d17d468a9826b96a358cc0c6756f0fc652a6b735401f0b2a9ffaf91f03ee59c71835de46c55df088e8a57ed19ff4c16970309ab4d465", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/878df3cf99979ebc029e1d182be2093cf8469d2c9c1c9781f6c9558194e1b7c688523a84809648ee42d703dabbc2ae91f0b57442cad9d316fd42a6b3e664dfcd"} 18:27:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:27:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:27:01 INFO - Contents: 18:27:01 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4fb43676e155320762be0ecb3d747cbf762f4642651406329e70a35550a96a7faa26477a524cc6f35b4e6aa62c0a1cdd89316d0a2fbcf0f6f8cbe483614badc0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/38a8a0af822d3ed933887ca60a579fece282e495fc2bbba1b146087dad145ca70906c36c336224def77ac84555c5f02c3450f5e1b3f53aa5512e0708b61102f8", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b29bb58e0de5bb98a5b6d17d468a9826b96a358cc0c6756f0fc652a6b735401f0b2a9ffaf91f03ee59c71835de46c55df088e8a57ed19ff4c16970309ab4d465", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/878df3cf99979ebc029e1d182be2093cf8469d2c9c1c9781f6c9558194e1b7c688523a84809648ee42d703dabbc2ae91f0b57442cad9d316fd42a6b3e664dfcd"} 18:27:01 INFO - Running post-run listener: copy_logs_to_upload_dir 18:27:01 INFO - Copying logs to upload dir... 18:27:01 INFO - mkdir: /builds/slave/test/build/upload/logs 18:27:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.645370 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2017-03-03 18:27:01.043661) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-03 18:27:01.047122) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1488592142.169400-722335293 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4fb43676e155320762be0ecb3d747cbf762f4642651406329e70a35550a96a7faa26477a524cc6f35b4e6aa62c0a1cdd89316d0a2fbcf0f6f8cbe483614badc0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/38a8a0af822d3ed933887ca60a579fece282e495fc2bbba1b146087dad145ca70906c36c336224def77ac84555c5f02c3450f5e1b3f53aa5512e0708b61102f8", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b29bb58e0de5bb98a5b6d17d468a9826b96a358cc0c6756f0fc652a6b735401f0b2a9ffaf91f03ee59c71835de46c55df088e8a57ed19ff4c16970309ab4d465", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/878df3cf99979ebc029e1d182be2093cf8469d2c9c1c9781f6c9558194e1b7c688523a84809648ee42d703dabbc2ae91f0b57442cad9d316fd42a6b3e664dfcd"} build_url:https://queue.taskcluster.net/v1/task/EZUAmDZLThm1pkhGQXcXhw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011267 build_url: 'https://queue.taskcluster.net/v1/task/EZUAmDZLThm1pkhGQXcXhw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4fb43676e155320762be0ecb3d747cbf762f4642651406329e70a35550a96a7faa26477a524cc6f35b4e6aa62c0a1cdd89316d0a2fbcf0f6f8cbe483614badc0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/38a8a0af822d3ed933887ca60a579fece282e495fc2bbba1b146087dad145ca70906c36c336224def77ac84555c5f02c3450f5e1b3f53aa5512e0708b61102f8", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b29bb58e0de5bb98a5b6d17d468a9826b96a358cc0c6756f0fc652a6b735401f0b2a9ffaf91f03ee59c71835de46c55df088e8a57ed19ff4c16970309ab4d465", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/878df3cf99979ebc029e1d182be2093cf8469d2c9c1c9781f6c9558194e1b7c688523a84809648ee42d703dabbc2ae91f0b57442cad9d316fd42a6b3e664dfcd"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-03 18:27:01.072022) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-03 18:27:01.072324) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1488592142.169400-722335293 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004482 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-03 18:27:01.158517) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-03 18:27:01.158846) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-03 18:27:01.159146) ========= ========= Total master_lag: 0.16 =========