builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-007 starttime: 1485375482.9 results: success (0) revision: f3a3afaf7e41b6ea973e97b00528f6d58bdb08cb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-25 12:18:02.898468) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-25 12:18:02.898866) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-25 12:18:02.899142) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-25 12:18:02.913532) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-25 12:18:02.913794) ========= 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=923d835db2ba3686ebe126b700000192-1485375482.663370-859002171 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-25 12:18:03-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 214M=0s 2017-01-25 12:18:03 (214 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.083825 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-25 12:18:03.011065) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-25 12:18:03.014443) ========= 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=923d835db2ba3686ebe126b700000192-1485375482.663370-859002171 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013894 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-25 12:18:03.064232) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-25 12:18:03.067638) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev f3a3afaf7e41b6ea973e97b00528f6d58bdb08cb --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev f3a3afaf7e41b6ea973e97b00528f6d58bdb08cb --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=923d835db2ba3686ebe126b700000192-1485375482.663370-859002171 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-25 12:18:03,482 truncating revision to first 12 chars 2017-01-25 12:18:03,482 Setting DEBUG logging. 2017-01-25 12:18:03,482 attempt 1/10 2017-01-25 12:18:03,482 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/f3a3afaf7e41?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-25 12:18:03,821 unpacking tar archive at: mozilla-aurora-f3a3afaf7e41/testing/mozharness/ program finished with exit code 0 elapsedTime=0.652008 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-25 12:18:03.732815) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-25 12:18:03.733202) ========= script_repo_revision: f3a3afaf7e41b6ea973e97b00528f6d58bdb08cb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-25 12:18:03.733610) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-25 12:18:03.733883) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-25 12:18:03.742831) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2017-01-25 12:18:03.743103) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=923d835db2ba3686ebe126b700000192-1485375482.663370-859002171 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:18:04 INFO - MultiFileLogger online at 20170125 12:18:04 in /builds/slave/test 12:18:04 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 12:18:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:18:04 INFO - {'append_to_log': False, 12:18:04 INFO - 'base_work_dir': '/builds/slave/test', 12:18:04 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 12:18:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:18:04 INFO - 'branch': 'Mozilla-Aurora', 12:18:04 INFO - 'buildbot_json_path': 'buildprops.json', 12:18:04 INFO - 'config_files': ('talos/linux_config.py',), 12:18:04 INFO - 'default_actions': ('clobber', 12:18:04 INFO - 'read-buildbot-config', 12:18:04 INFO - 'download-and-extract', 12:18:04 INFO - 'populate-webroot', 12:18:04 INFO - 'create-virtualenv', 12:18:04 INFO - 'install', 12:18:04 INFO - 'run-tests'), 12:18:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:18:04 INFO - 'download_minidump_stackwalk': True, 12:18:04 INFO - 'download_symbols': 'ondemand', 12:18:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:18:04 INFO - 'tooltool.py': '/tools/tooltool.py', 12:18:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:18:04 INFO - '/tools/misc-python/virtualenv.py')}, 12:18:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:18:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:18:04 INFO - 'installer_path': 'installer.exe', 12:18:04 INFO - 'log_level': 'info', 12:18:04 INFO - 'log_name': 'talos', 12:18:04 INFO - 'log_to_console': True, 12:18:04 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:18:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:18:04 INFO - 'opt_config_files': (), 12:18:04 INFO - 'pip_index': False, 12:18:04 INFO - 'sps_profile': False, 12:18:04 INFO - 'sps_profile_interval': 0, 12:18:04 INFO - 'suite': 'dromaeojs', 12:18:04 INFO - 'system_bits': '32', 12:18:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:18:04 INFO - 'title': 'talos-linux64-ix-007', 12:18:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:18:04 INFO - 'use_talos_json': True, 12:18:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:18:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:18:04 INFO - 'work_dir': 'build'} 12:18:04 INFO - [mozharness: 2017-01-25 20:18:04.255095Z] Running clobber step. 12:18:04 INFO - Running pre-action listener: _resource_record_pre_action 12:18:04 INFO - Running main action method: clobber 12:18:04 INFO - rmtree: /builds/slave/test/build 12:18:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:18:04 INFO - Running post-action listener: _resource_record_post_action 12:18:04 INFO - [mozharness: 2017-01-25 20:18:04.720808Z] Finished clobber step (success) 12:18:04 INFO - [mozharness: 2017-01-25 20:18:04.720909Z] Running read-buildbot-config step. 12:18:04 INFO - Running pre-action listener: _resource_record_pre_action 12:18:04 INFO - Running main action method: read_buildbot_config 12:18:04 INFO - Using buildbot properties: 12:18:04 INFO - { 12:18:04 INFO - "project": "", 12:18:04 INFO - "product": "firefox", 12:18:04 INFO - "who": "kwierso@gmail.com", 12:18:04 INFO - "installer_path": "public/build/target.tar.bz2", 12:18:04 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 12:18:04 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-aurora/", 12:18:04 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 12:18:04 INFO - "stage_platform": "linux64-pgo", 12:18:04 INFO - "basedir": "/builds/slave/test", 12:18:04 INFO - "buildnumber": 721, 12:18:04 INFO - "platform": "ubuntu64_hw", 12:18:04 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 12:18:04 INFO - "slavebuilddir": "test", 12:18:04 INFO - "taskId": "GHf2NZJ9Tfme5A1AU1KQjA", 12:18:04 INFO - "branch": "mozilla-aurora", 12:18:04 INFO - "script_repo_revision": "production", 12:18:04 INFO - "revision": "f3a3afaf7e41b6ea973e97b00528f6d58bdb08cb", 12:18:04 INFO - "slavename": "talos-linux64-ix-007", 12:18:04 INFO - "repo_path": "releases/mozilla-aurora" 12:18:04 INFO - } 12:18:04 INFO - Finding installer, test and symbols from parent task. 12:18:04 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GHf2NZJ9Tfme5A1AU1KQjA'}, attempt #1 12:18:05 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GHf2NZJ9Tfme5A1AU1KQjA'}, attempt #1 12:18:05 INFO - Task dependencies: BeRKb3tYQXK2MPmttxsCnQ 12:18:05 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BeRKb3tYQXK2MPmttxsCnQ'}, attempt #1 12:18:06 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/BeRKb3tYQXK2MPmttxsCnQ/artifacts/public/build/target.tar.bz2 12:18:06 INFO - Set test_url: https://queue.taskcluster.net/v1/task/BeRKb3tYQXK2MPmttxsCnQ/artifacts/public/build/test_packages.json 12:18:06 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/BeRKb3tYQXK2MPmttxsCnQ/artifacts/public/build/target.crashreporter-symbols.zip 12:18:06 INFO - Running post-action listener: _resource_record_post_action 12:18:06 INFO - [mozharness: 2017-01-25 20:18:06.117719Z] Finished read-buildbot-config step (success) 12:18:06 INFO - [mozharness: 2017-01-25 20:18:06.117937Z] Running download-and-extract step. 12:18:06 INFO - Running pre-action listener: _resource_record_pre_action 12:18:06 INFO - Running main action method: download_and_extract 12:18:06 INFO - mkdir: /builds/slave/test/build/tests 12:18:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:18:06 INFO - trying https://queue.taskcluster.net/v1/task/BeRKb3tYQXK2MPmttxsCnQ/artifacts/public/build/target.test_packages.json 12:18:06 INFO - Downloading https://queue.taskcluster.net/v1/task/BeRKb3tYQXK2MPmttxsCnQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 12:18:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BeRKb3tYQXK2MPmttxsCnQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 12:18:06 INFO - Downloaded 896 bytes. 12:18:06 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 12:18:06 INFO - Using the following test package requirements: 12:18:06 INFO - {u'common': [u'target.common.tests.zip'], 12:18:06 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 12:18:06 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 12:18:06 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 12:18:06 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 12:18:06 INFO - u'mozbase': [u'target.common.tests.zip'], 12:18:06 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 12:18:06 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 12:18:06 INFO - u'web-platform': [u'target.common.tests.zip', 12:18:06 INFO - u'target.web-platform.tests.zip'], 12:18:06 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 12:18:06 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 12:18:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BeRKb3tYQXK2MPmttxsCnQ/artifacts/public/build/target.common.tests.zip 12:18:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BeRKb3tYQXK2MPmttxsCnQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 12:18:06 INFO - Fetch https://queue.taskcluster.net/v1/task/BeRKb3tYQXK2MPmttxsCnQ/artifacts/public/build/target.common.tests.zip into memory 12:18:07 INFO - Expected file size: 21847345 12:18:07 INFO - Obtained file size: 21847345 12:18:11 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 12:18:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BeRKb3tYQXK2MPmttxsCnQ/artifacts/public/build/target.common.tests.zip 12:18:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BeRKb3tYQXK2MPmttxsCnQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 12:18:11 INFO - Fetch https://queue.taskcluster.net/v1/task/BeRKb3tYQXK2MPmttxsCnQ/artifacts/public/build/target.common.tests.zip into memory 12:18:12 INFO - Expected file size: 21847345 12:18:12 INFO - Obtained file size: 21847345 12:18:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BeRKb3tYQXK2MPmttxsCnQ/artifacts/public/build/target.talos.tests.zip 12:18:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BeRKb3tYQXK2MPmttxsCnQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 12:18:16 INFO - Fetch https://queue.taskcluster.net/v1/task/BeRKb3tYQXK2MPmttxsCnQ/artifacts/public/build/target.talos.tests.zip into memory 12:18:17 INFO - Expected file size: 14403485 12:18:17 INFO - Obtained file size: 14403485 12:18:17 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')]} 12:18:17 INFO - trying https://queue.taskcluster.net/v1/task/BeRKb3tYQXK2MPmttxsCnQ/artifacts/public/build/target.tar.bz2 12:18:17 INFO - Downloading https://queue.taskcluster.net/v1/task/BeRKb3tYQXK2MPmttxsCnQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 12:18:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BeRKb3tYQXK2MPmttxsCnQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 12:18:19 INFO - Downloaded 66098525 bytes. 12:18:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BeRKb3tYQXK2MPmttxsCnQ/artifacts/public/build/target.tar.bz2 12:18:19 INFO - mkdir: /builds/slave/test/properties 12:18:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:18:19 INFO - Writing to file /builds/slave/test/properties/build_url 12:18:19 INFO - Contents: 12:18:19 INFO - build_url:https://queue.taskcluster.net/v1/task/BeRKb3tYQXK2MPmttxsCnQ/artifacts/public/build/target.tar.bz2 12:18:19 INFO - Running post-action listener: _resource_record_post_action 12:18:19 INFO - Running post-action listener: set_extra_try_arguments 12:18:19 INFO - [mozharness: 2017-01-25 20:18:19.142562Z] Finished download-and-extract step (success) 12:18:19 INFO - [mozharness: 2017-01-25 20:18:19.142660Z] Running populate-webroot step. 12:18:19 INFO - Running pre-action listener: _resource_record_pre_action 12:18:19 INFO - Running main action method: populate_webroot 12:18:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:18:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:18:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:18:19 INFO - '--tppagecycles', 12:18:19 INFO - '7'], 12:18:19 INFO - 'tests': ['tsvgm']}}, 12:18:19 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:18:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:18:19 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:18:19 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:18:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:18:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:18:19 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 12:18:19 INFO - 'talos_options': ['--disable-e10s'], 12:18:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:18:19 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 12:18:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:18:19 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 12:18:19 INFO - 'talos_options': ['--disable-e10s'], 12:18:19 INFO - 'tests': ['damp', 'tps']}, 12:18:19 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 12:18:19 INFO - 'tests': ['damp', 'tps']}, 12:18:19 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:18:19 INFO - 'tests': ['dromaeo_dom']}, 12:18:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:18:19 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:18:19 INFO - 'tests': ['basic_compositor_video']}, 12:18:19 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:18:19 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:18:19 INFO - 'tests': ['a11yr', 12:18:19 INFO - 'ts_paint', 12:18:19 INFO - 'tpaint', 12:18:19 INFO - 'sessionrestore', 12:18:19 INFO - 'sessionrestore_no_auto_restore', 12:18:19 INFO - 'tabpaint']}, 12:18:19 INFO - 'other-e10s': {'tests': ['a11yr', 12:18:19 INFO - 'ts_paint', 12:18:19 INFO - 'tpaint', 12:18:19 INFO - 'sessionrestore', 12:18:19 INFO - 'sessionrestore_no_auto_restore', 12:18:19 INFO - 'tabpaint']}, 12:18:19 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:18:19 INFO - 'ts_paint', 12:18:19 INFO - 'tpaint', 12:18:19 INFO - 'sessionrestore', 12:18:19 INFO - 'sessionrestore_no_auto_restore', 12:18:19 INFO - 'tabpaint']}, 12:18:19 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:18:19 INFO - 'ts_paint', 12:18:19 INFO - 'tpaint', 12:18:19 INFO - 'sessionrestore', 12:18:19 INFO - 'sessionrestore_no_auto_restore', 12:18:19 INFO - 'tabpaint']}, 12:18:19 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:18:19 INFO - 'tests': ['a11yr', 12:18:19 INFO - 'ts_paint', 12:18:19 INFO - 'tpaint', 12:18:19 INFO - 'sessionrestore', 12:18:19 INFO - 'sessionrestore_no_auto_restore', 12:18:19 INFO - 'tabpaint']}, 12:18:19 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:18:19 INFO - 'tests': ['a11yr', 12:18:19 INFO - 'ts_paint', 12:18:19 INFO - 'tpaint', 12:18:19 INFO - 'sessionrestore', 12:18:19 INFO - 'sessionrestore_no_auto_restore', 12:18:19 INFO - 'tabpaint']}, 12:18:19 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:18:19 INFO - 'tests': ['tsvgx', 12:18:19 INFO - 'tsvgr_opacity', 12:18:19 INFO - 'tart', 12:18:19 INFO - 'tscrollx', 12:18:19 INFO - 'cart', 12:18:19 INFO - 'tsvg_static']}, 12:18:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:18:19 INFO - 'tsvgr_opacity', 12:18:19 INFO - 'tart', 12:18:19 INFO - 'tscrollx', 12:18:19 INFO - 'cart', 12:18:19 INFO - 'tsvg_static']}, 12:18:19 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 12:18:19 INFO - 'talos_options': ['--disable-e10s'], 12:18:19 INFO - 'tests': ['tp5o']}, 12:18:19 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 12:18:19 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 12:18:19 INFO - 'talos_options': ['--disable-e10s', 12:18:19 INFO - '--xperf_path', 12:18:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:18:19 INFO - 'tests': ['tp5n']}, 12:18:19 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 12:18:19 INFO - 'talos_options': ['--xperf_path', 12:18:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:18:19 INFO - 'tests': ['tp5n']}}, 12:18:19 INFO - 'talos.zip': {'path': '', 12:18:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:18:19 INFO - Running post-action listener: _resource_record_post_action 12:18:19 INFO - [mozharness: 2017-01-25 20:18:19.155865Z] Finished populate-webroot step (success) 12:18:19 INFO - [mozharness: 2017-01-25 20:18:19.155955Z] Running create-virtualenv step. 12:18:19 INFO - Running pre-action listener: _resource_record_pre_action 12:18:19 INFO - Running main action method: create_virtualenv 12:18:19 INFO - Creating virtualenv /builds/slave/test/build/venv 12:18:19 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 12:18:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:18:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:18:19 INFO - Using real prefix '/usr' 12:18:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:18:19 INFO - Installing distribute.............................................................................................................................................................................................done. 12:18:21 INFO - Installing pip.................done. 12:18:21 INFO - Return code: 0 12:18:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:18:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:18:21 INFO - Reading from file tmpfile_stdout 12:18:21 INFO - Output received: 12:18:21 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) 12:18:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:18:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:18:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:18:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:18:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:18:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:21 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 0xc2b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd3ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf9d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1026850>, '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 0xf9b6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf9bb60>, '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': '923d835db2ba3686ebe126b700000192-1485375482.663370-859002171', '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 12:18:21 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 12:18:21 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 12:18:21 INFO - Using env: {'DISPLAY': ':0', 12:18:21 INFO - 'HOME': '/home/cltbld', 12:18:21 INFO - 'LANG': 'en_US.UTF-8', 12:18:21 INFO - 'LANGUAGE': 'en_US:en', 12:18:21 INFO - 'LOGNAME': 'cltbld', 12:18:21 INFO - 'MAIL': '/var/mail/cltbld', 12:18:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:18:21 INFO - 'MOZ_NO_REMOTE': '1', 12:18:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:18:21 INFO - 'NO_EM_RESTART': '1', 12:18:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:18:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:18:21 INFO - 'PWD': '/builds/slave/test', 12:18:21 INFO - 'SHELL': '/bin/bash', 12:18:21 INFO - 'SHLVL': '1', 12:18:21 INFO - 'TERM': 'linux', 12:18:21 INFO - 'TMOUT': '86400', 12:18:21 INFO - 'USER': 'cltbld', 12:18:21 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1485375482.663370-859002171', 12:18:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:18:21 INFO - '_': '/tools/buildbot/bin/python'} 12:18:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:18:22 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 12:18:22 INFO - Cleaning up... 12:18:22 INFO - Return code: 0 12:18:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:18:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:18:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:18:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:18:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:18:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:22 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 0xc2b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd3ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf9d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1026850>, '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 0xf9b6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf9bb60>, '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': '923d835db2ba3686ebe126b700000192-1485375482.663370-859002171', '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 12:18:22 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 12:18:22 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 12:18:22 INFO - Using env: {'DISPLAY': ':0', 12:18:22 INFO - 'HOME': '/home/cltbld', 12:18:22 INFO - 'LANG': 'en_US.UTF-8', 12:18:22 INFO - 'LANGUAGE': 'en_US:en', 12:18:22 INFO - 'LOGNAME': 'cltbld', 12:18:22 INFO - 'MAIL': '/var/mail/cltbld', 12:18:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:18:22 INFO - 'MOZ_NO_REMOTE': '1', 12:18:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:18:22 INFO - 'NO_EM_RESTART': '1', 12:18:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:18:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:18:22 INFO - 'PWD': '/builds/slave/test', 12:18:22 INFO - 'SHELL': '/bin/bash', 12:18:22 INFO - 'SHLVL': '1', 12:18:22 INFO - 'TERM': 'linux', 12:18:22 INFO - 'TMOUT': '86400', 12:18:22 INFO - 'USER': 'cltbld', 12:18:22 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1485375482.663370-859002171', 12:18:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:18:22 INFO - '_': '/tools/buildbot/bin/python'} 12:18:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:18:22 INFO - Downloading/unpacking psutil>=3.1.1 12:18:22 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 12:18:22 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 12:18:22 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 12:18:22 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 12:18:22 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 12:18:22 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 12:18:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:18:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:18:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:18:24 INFO - Installing collected packages: psutil 12:18:24 INFO - Running setup.py install for psutil 12:18:24 INFO - building 'psutil._psutil_linux' extension 12:18:24 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 12:18:24 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 12:18:24 INFO - building 'psutil._psutil_posix' extension 12:18:24 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 12:18:24 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 12:18:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:18:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:18:25 INFO - Successfully installed psutil 12:18:25 INFO - Cleaning up... 12:18:25 INFO - Return code: 0 12:18:25 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:18:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:18:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:18:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:18:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:18:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xc2b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd3ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf9d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1026850>, '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 0xf9b6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf9bb60>, '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': '923d835db2ba3686ebe126b700000192-1485375482.663370-859002171', '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 12:18:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 12:18:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 12:18:25 INFO - Using env: {'DISPLAY': ':0', 12:18:25 INFO - 'HOME': '/home/cltbld', 12:18:25 INFO - 'LANG': 'en_US.UTF-8', 12:18:25 INFO - 'LANGUAGE': 'en_US:en', 12:18:25 INFO - 'LOGNAME': 'cltbld', 12:18:25 INFO - 'MAIL': '/var/mail/cltbld', 12:18:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:18:25 INFO - 'MOZ_NO_REMOTE': '1', 12:18:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:18:25 INFO - 'NO_EM_RESTART': '1', 12:18:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:18:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:18:25 INFO - 'PWD': '/builds/slave/test', 12:18:25 INFO - 'SHELL': '/bin/bash', 12:18:25 INFO - 'SHLVL': '1', 12:18:25 INFO - 'TERM': 'linux', 12:18:25 INFO - 'TMOUT': '86400', 12:18:25 INFO - 'USER': 'cltbld', 12:18:25 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1485375482.663370-859002171', 12:18:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:18:25 INFO - '_': '/tools/buildbot/bin/python'} 12:18:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:18:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:18:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:18:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:18:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:18:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:18:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:18:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:18:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:18:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:18:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:18:27 INFO - Installing collected packages: mozsystemmonitor 12:18:27 INFO - Running setup.py install for mozsystemmonitor 12:18:27 INFO - Successfully installed mozsystemmonitor 12:18:27 INFO - Cleaning up... 12:18:27 INFO - Return code: 0 12:18:27 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:18:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:18:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:18:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:18:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:18:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xc2b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd3ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf9d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1026850>, '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 0xf9b6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf9bb60>, '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': '923d835db2ba3686ebe126b700000192-1485375482.663370-859002171', '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 12:18:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 12:18:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 12:18:27 INFO - Using env: {'DISPLAY': ':0', 12:18:27 INFO - 'HOME': '/home/cltbld', 12:18:27 INFO - 'LANG': 'en_US.UTF-8', 12:18:27 INFO - 'LANGUAGE': 'en_US:en', 12:18:27 INFO - 'LOGNAME': 'cltbld', 12:18:27 INFO - 'MAIL': '/var/mail/cltbld', 12:18:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:18:27 INFO - 'MOZ_NO_REMOTE': '1', 12:18:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:18:27 INFO - 'NO_EM_RESTART': '1', 12:18:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:18:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:18:27 INFO - 'PWD': '/builds/slave/test', 12:18:27 INFO - 'SHELL': '/bin/bash', 12:18:27 INFO - 'SHLVL': '1', 12:18:27 INFO - 'TERM': 'linux', 12:18:27 INFO - 'TMOUT': '86400', 12:18:27 INFO - 'USER': 'cltbld', 12:18:27 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1485375482.663370-859002171', 12:18:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:18:27 INFO - '_': '/tools/buildbot/bin/python'} 12:18:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:18:27 INFO - Downloading/unpacking jsonschema==2.5.1 12:18:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:18:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:18:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:18:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:18:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:18:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:18:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:18:29 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:18:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:18:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:18:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:18:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:18:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:18:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:18:29 INFO - Downloading functools32-3.2.3-2.tar.gz 12:18:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:18:29 INFO - warning: no files found matching '*.txt' 12:18:29 INFO - no previously-included directories found matching 'build' 12:18:29 INFO - no previously-included directories found matching 'dist' 12:18:29 INFO - no previously-included directories found matching '.git*' 12:18:29 INFO - Installing collected packages: jsonschema, functools32 12:18:30 INFO - Running setup.py install for functools32 12:18:30 INFO - warning: no files found matching '*.txt' 12:18:30 INFO - no previously-included directories found matching 'build' 12:18:30 INFO - no previously-included directories found matching 'dist' 12:18:30 INFO - no previously-included directories found matching '.git*' 12:18:30 INFO - Successfully installed jsonschema functools32 12:18:30 INFO - Cleaning up... 12:18:30 INFO - Return code: 0 12:18:30 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:18:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:18:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:18:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:18:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:18:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xc2b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd3ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf9d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1026850>, '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 0xf9b6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf9bb60>, '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': '923d835db2ba3686ebe126b700000192-1485375482.663370-859002171', '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 12:18:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 12:18:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 12:18:30 INFO - Using env: {'DISPLAY': ':0', 12:18:30 INFO - 'HOME': '/home/cltbld', 12:18:30 INFO - 'LANG': 'en_US.UTF-8', 12:18:30 INFO - 'LANGUAGE': 'en_US:en', 12:18:30 INFO - 'LOGNAME': 'cltbld', 12:18:30 INFO - 'MAIL': '/var/mail/cltbld', 12:18:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:18:30 INFO - 'MOZ_NO_REMOTE': '1', 12:18:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:18:30 INFO - 'NO_EM_RESTART': '1', 12:18:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:18:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:18:30 INFO - 'PWD': '/builds/slave/test', 12:18:30 INFO - 'SHELL': '/bin/bash', 12:18:30 INFO - 'SHLVL': '1', 12:18:30 INFO - 'TERM': 'linux', 12:18:30 INFO - 'TMOUT': '86400', 12:18:30 INFO - 'USER': 'cltbld', 12:18:30 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1485375482.663370-859002171', 12:18:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:18:30 INFO - '_': '/tools/buildbot/bin/python'} 12:18:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:18:30 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:18:30 INFO - Cleaning up... 12:18:30 INFO - Return code: 0 12:18:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:18:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:18:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:18:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:18:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:18:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xc2b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd3ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf9d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1026850>, '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 0xf9b6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf9bb60>, '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': '923d835db2ba3686ebe126b700000192-1485375482.663370-859002171', '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 12:18:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:18:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:18:30 INFO - Using env: {'DISPLAY': ':0', 12:18:30 INFO - 'HOME': '/home/cltbld', 12:18:30 INFO - 'LANG': 'en_US.UTF-8', 12:18:30 INFO - 'LANGUAGE': 'en_US:en', 12:18:30 INFO - 'LOGNAME': 'cltbld', 12:18:30 INFO - 'MAIL': '/var/mail/cltbld', 12:18:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:18:30 INFO - 'MOZ_NO_REMOTE': '1', 12:18:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:18:30 INFO - 'NO_EM_RESTART': '1', 12:18:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:18:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:18:30 INFO - 'PWD': '/builds/slave/test', 12:18:30 INFO - 'SHELL': '/bin/bash', 12:18:30 INFO - 'SHLVL': '1', 12:18:30 INFO - 'TERM': 'linux', 12:18:30 INFO - 'TMOUT': '86400', 12:18:30 INFO - 'USER': 'cltbld', 12:18:30 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1485375482.663370-859002171', 12:18:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:18:30 INFO - '_': '/tools/buildbot/bin/python'} 12:18:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:18:30 INFO - Downloading/unpacking blobuploader==1.2.4 12:18:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:18:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:18:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:18:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:18:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:18:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:18:32 INFO - Downloading blobuploader-1.2.4.tar.gz 12:18:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:18:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:18:32 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 12:18:32 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 12:18:32 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 12:18:32 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 12:18:32 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 12:18:32 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 12:18:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:18:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:18:33 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 12:18:33 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 12:18:33 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 12:18:33 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 12:18:33 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 12:18:33 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 12:18:33 INFO - Downloading docopt-0.6.1.tar.gz 12:18:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:18:33 INFO - Installing collected packages: blobuploader, requests, docopt 12:18:33 INFO - Running setup.py install for blobuploader 12:18:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:18:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:18:33 INFO - Running setup.py install for requests 12:18:33 INFO - Running setup.py install for docopt 12:18:33 INFO - Successfully installed blobuploader requests docopt 12:18:33 INFO - Cleaning up... 12:18:34 INFO - Return code: 0 12:18:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:18:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:18:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:18:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:18:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:18:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:34 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 0xc2b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd3ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf9d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1026850>, '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 0xf9b6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf9bb60>, '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': '923d835db2ba3686ebe126b700000192-1485375482.663370-859002171', '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 12:18:34 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 12:18:34 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 12:18:34 INFO - Using env: {'DISPLAY': ':0', 12:18:34 INFO - 'HOME': '/home/cltbld', 12:18:34 INFO - 'LANG': 'en_US.UTF-8', 12:18:34 INFO - 'LANGUAGE': 'en_US:en', 12:18:34 INFO - 'LOGNAME': 'cltbld', 12:18:34 INFO - 'MAIL': '/var/mail/cltbld', 12:18:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:18:34 INFO - 'MOZ_NO_REMOTE': '1', 12:18:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:18:34 INFO - 'NO_EM_RESTART': '1', 12:18:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:18:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:18:34 INFO - 'PWD': '/builds/slave/test', 12:18:34 INFO - 'SHELL': '/bin/bash', 12:18:34 INFO - 'SHLVL': '1', 12:18:34 INFO - 'TERM': 'linux', 12:18:34 INFO - 'TMOUT': '86400', 12:18:34 INFO - 'USER': 'cltbld', 12:18:34 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1485375482.663370-859002171', 12:18:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:18:34 INFO - '_': '/tools/buildbot/bin/python'} 12:18:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:18:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:18:34 INFO - Running setup.py (path:/tmp/pip-X0f7wX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:18:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:18:34 INFO - Running setup.py (path:/tmp/pip-hn4HZx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:18:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:18:34 INFO - Running setup.py (path:/tmp/pip-OW6XWg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:18:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:18:34 INFO - Running setup.py (path:/tmp/pip-JXTMQx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:18:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:18:34 INFO - Running setup.py (path:/tmp/pip-Zlkynb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:18:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:18:34 INFO - Running setup.py (path:/tmp/pip-eXiRaj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:18:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:18:34 INFO - Running setup.py (path:/tmp/pip-vh0XjO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:18:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:18:34 INFO - Running setup.py (path:/tmp/pip-Ud8eEv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:18:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:18:34 INFO - Running setup.py (path:/tmp/pip-yvNE1n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:18:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:18:34 INFO - Running setup.py (path:/tmp/pip-cG1FKd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:18:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:18:34 INFO - Running setup.py (path:/tmp/pip-PUFRUB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:18:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:18:35 INFO - Running setup.py (path:/tmp/pip-BEj3th-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:18:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:18:35 INFO - Running setup.py (path:/tmp/pip-M2LQdg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:18:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:18:35 INFO - Running setup.py (path:/tmp/pip-sZ5DbL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:18:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:18:35 INFO - Running setup.py (path:/tmp/pip-3t0C86-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:18:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:18:35 INFO - Running setup.py (path:/tmp/pip-LFgTGq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:18:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:18:35 INFO - Running setup.py (path:/tmp/pip-0jlNbu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:18:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:18:35 INFO - Running setup.py install for manifestparser 12:18:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:18:35 INFO - Running setup.py install for mozcrash 12:18:35 INFO - Running setup.py install for mozdebug 12:18:35 INFO - Running setup.py install for mozdevice 12:18:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:18:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:18:35 INFO - Running setup.py install for mozfile 12:18:35 INFO - Running setup.py install for mozhttpd 12:18:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:18:36 INFO - Running setup.py install for mozinfo 12:18:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:18:36 INFO - Running setup.py install for mozInstall 12:18:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:18:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:18:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:18:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:18:36 INFO - Running setup.py install for mozleak 12:18:36 INFO - Running setup.py install for mozlog 12:18:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:18:36 INFO - Running setup.py install for moznetwork 12:18:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:18:36 INFO - Running setup.py install for mozprocess 12:18:36 INFO - Running setup.py install for mozprofile 12:18:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:18:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:18:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:18:36 INFO - Running setup.py install for mozrunner 12:18:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:18:36 INFO - Running setup.py install for mozscreenshot 12:18:37 INFO - Running setup.py install for moztest 12:18:37 INFO - Running setup.py install for mozversion 12:18:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:18:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:18:37 INFO - Cleaning up... 12:18:37 INFO - Return code: 0 12:18:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:18:37 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')]} 12:18:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:18:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:37 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')]} 12:18:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:18:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:37 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 0xc2b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd3ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf9d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1026850>, '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 0xf9b6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf9bb60>, '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': '923d835db2ba3686ebe126b700000192-1485375482.663370-859002171', '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 12:18:37 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 12:18:37 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 12:18:37 INFO - Using env: {'DISPLAY': ':0', 12:18:37 INFO - 'HOME': '/home/cltbld', 12:18:37 INFO - 'LANG': 'en_US.UTF-8', 12:18:37 INFO - 'LANGUAGE': 'en_US:en', 12:18:37 INFO - 'LOGNAME': 'cltbld', 12:18:37 INFO - 'MAIL': '/var/mail/cltbld', 12:18:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:18:37 INFO - 'MOZ_NO_REMOTE': '1', 12:18:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:18:37 INFO - 'NO_EM_RESTART': '1', 12:18:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:18:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:18:37 INFO - 'PWD': '/builds/slave/test', 12:18:37 INFO - 'SHELL': '/bin/bash', 12:18:37 INFO - 'SHLVL': '1', 12:18:37 INFO - 'TERM': 'linux', 12:18:37 INFO - 'TMOUT': '86400', 12:18:37 INFO - 'USER': 'cltbld', 12:18:37 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1485375482.663370-859002171', 12:18:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:18:37 INFO - '_': '/tools/buildbot/bin/python'} 12:18:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:18:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:18:37 INFO - Running setup.py (path:/tmp/pip-eBanIN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:18:37 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)) 12:18:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:18:37 INFO - Running setup.py (path:/tmp/pip-3yrR_W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:18:37 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)) 12:18:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:18:37 INFO - Running setup.py (path:/tmp/pip-xDVFym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:18:37 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)) 12:18:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:18:37 INFO - Running setup.py (path:/tmp/pip-WgYApe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:18:37 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)) 12:18:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:18:37 INFO - Running setup.py (path:/tmp/pip-834d3v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:18:37 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)) 12:18:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:18:37 INFO - Running setup.py (path:/tmp/pip-mhdWoA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:18:37 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)) 12:18:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:18:37 INFO - Running setup.py (path:/tmp/pip-Y8idqP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:18:38 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)) 12:18:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:18:38 INFO - Running setup.py (path:/tmp/pip-kquDI9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:18:38 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)) 12:18:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:18:38 INFO - Running setup.py (path:/tmp/pip-2jp3mR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:18:38 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)) 12:18:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:18:38 INFO - Running setup.py (path:/tmp/pip-lQEIBA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:18:38 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)) 12:18:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:18:38 INFO - Running setup.py (path:/tmp/pip-EJ1Eb8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:18:38 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)) 12:18:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:18:38 INFO - Running setup.py (path:/tmp/pip-9uHtK7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:18:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 12:18:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:18:38 INFO - Running setup.py (path:/tmp/pip-D4sY_H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:18:38 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)) 12:18:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:18:38 INFO - Running setup.py (path:/tmp/pip-LrtMj8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:18:38 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)) 12:18:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:18:38 INFO - Running setup.py (path:/tmp/pip-bGL3AX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:18:38 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)) 12:18:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:18:38 INFO - Running setup.py (path:/tmp/pip-5lylLL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:18:38 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)) 12:18:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:18:38 INFO - Running setup.py (path:/tmp/pip-1HRWIl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:18:38 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)) 12:18:38 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)) 12:18:38 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)) 12:18:38 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)) 12:18:38 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)) 12:18:38 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)) 12:18:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:18:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:18:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:18:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:18:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:18:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:18:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:18:40 INFO - Downloading blessings-1.6.tar.gz 12:18:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:18:40 INFO - Installing collected packages: blessings 12:18:40 INFO - Running setup.py install for blessings 12:18:40 INFO - Successfully installed blessings 12:18:40 INFO - Cleaning up... 12:18:41 INFO - Return code: 0 12:18:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:18:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:18:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:18:41 INFO - Reading from file tmpfile_stdout 12:18:41 INFO - Current package versions: 12:18:41 INFO - argparse == 1.2.1 12:18:41 INFO - blessings == 1.6 12:18:41 INFO - blobuploader == 1.2.4 12:18:41 INFO - docopt == 0.6.1 12:18:41 INFO - functools32 == 3.2.3-2 12:18:41 INFO - jsonschema == 2.5.1 12:18:41 INFO - manifestparser == 1.1 12:18:41 INFO - mozInstall == 1.12 12:18:41 INFO - mozcrash == 1.0 12:18:41 INFO - mozdebug == 0.1 12:18:41 INFO - mozdevice == 0.49 12:18:41 INFO - mozfile == 1.2 12:18:41 INFO - mozhttpd == 0.7 12:18:41 INFO - mozinfo == 0.9 12:18:41 INFO - mozleak == 0.1 12:18:41 INFO - mozlog == 3.4 12:18:41 INFO - moznetwork == 0.27 12:18:41 INFO - mozprocess == 0.24 12:18:41 INFO - mozprofile == 0.28 12:18:41 INFO - mozrunner == 6.13 12:18:41 INFO - mozscreenshot == 0.1 12:18:41 INFO - mozsystemmonitor == 0.3 12:18:41 INFO - moztest == 0.8 12:18:41 INFO - mozversion == 1.4 12:18:41 INFO - psutil == 3.1.1 12:18:41 INFO - requests == 1.2.3 12:18:41 INFO - wsgiref == 0.1.2 12:18:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:18: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')]} 12:18:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:18:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18: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')]} 12:18:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:18:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:41 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 0xc2b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd3ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf9d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1026850>, '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 0xf9b6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf9bb60>, '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': '923d835db2ba3686ebe126b700000192-1485375482.663370-859002171', '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 12:18:41 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 12:18:41 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 12:18:41 INFO - Using env: {'DISPLAY': ':0', 12:18:41 INFO - 'HOME': '/home/cltbld', 12:18:41 INFO - 'LANG': 'en_US.UTF-8', 12:18:41 INFO - 'LANGUAGE': 'en_US:en', 12:18:41 INFO - 'LOGNAME': 'cltbld', 12:18:41 INFO - 'MAIL': '/var/mail/cltbld', 12:18:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:18:41 INFO - 'MOZ_NO_REMOTE': '1', 12:18:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:18:41 INFO - 'NO_EM_RESTART': '1', 12:18:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:18:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:18:41 INFO - 'PWD': '/builds/slave/test', 12:18:41 INFO - 'SHELL': '/bin/bash', 12:18:41 INFO - 'SHLVL': '1', 12:18:41 INFO - 'TERM': 'linux', 12:18:41 INFO - 'TMOUT': '86400', 12:18:41 INFO - 'USER': 'cltbld', 12:18:41 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1485375482.663370-859002171', 12:18:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:18:41 INFO - '_': '/tools/buildbot/bin/python'} 12:18:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:18:41 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)) 12:18:41 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)) 12:18:41 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)) 12:18:41 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)) 12:18:41 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)) 12:18:41 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)) 12:18:41 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)) 12:18:41 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)) 12:18:41 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)) 12:18:41 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)) 12:18:41 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)) 12:18:41 INFO - Cleaning up... 12:18:41 INFO - Return code: 0 12:18:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:18: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')]} 12:18:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:18:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18: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')]} 12:18:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:18:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18: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']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xc2b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd3ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf9d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1026850>, '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 0xf9b6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf9bb60>, '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': '923d835db2ba3686ebe126b700000192-1485375482.663370-859002171', '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 12:18: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'] in /builds/slave/test/build 12:18: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 12:18:41 INFO - Using env: {'DISPLAY': ':0', 12:18:41 INFO - 'HOME': '/home/cltbld', 12:18:41 INFO - 'LANG': 'en_US.UTF-8', 12:18:41 INFO - 'LANGUAGE': 'en_US:en', 12:18:41 INFO - 'LOGNAME': 'cltbld', 12:18:41 INFO - 'MAIL': '/var/mail/cltbld', 12:18:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:18:41 INFO - 'MOZ_NO_REMOTE': '1', 12:18:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:18:41 INFO - 'NO_EM_RESTART': '1', 12:18:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:18:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:18:41 INFO - 'PWD': '/builds/slave/test', 12:18:41 INFO - 'SHELL': '/bin/bash', 12:18:41 INFO - 'SHLVL': '1', 12:18:41 INFO - 'TERM': 'linux', 12:18:41 INFO - 'TMOUT': '86400', 12:18:41 INFO - 'USER': 'cltbld', 12:18:41 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1485375482.663370-859002171', 12:18:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:18:41 INFO - '_': '/tools/buildbot/bin/python'} 12:18:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:18:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:18:41 INFO - Cleaning up... 12:18:41 INFO - Return code: 0 12:18:41 INFO - Running post-action listener: _resource_record_post_action 12:18:41 INFO - Running post-action listener: _start_resource_monitoring 12:18:41 INFO - Starting resource monitoring. 12:18:41 INFO - [mozharness: 2017-01-25 20:18:41.726936Z] Finished create-virtualenv step (success) 12:18:41 INFO - [mozharness: 2017-01-25 20:18:41.727399Z] Running install step. 12:18:41 INFO - Running pre-action listener: _resource_record_pre_action 12:18:41 INFO - Running main action method: install 12:18:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:18:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:18:41 INFO - Reading from file tmpfile_stdout 12:18:41 INFO - Detecting whether we're running mozinstall >=1.0... 12:18:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:18:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:18:42 INFO - Reading from file tmpfile_stdout 12:18:42 INFO - Output received: 12:18:42 INFO - Usage: mozinstall [options] installer 12:18:42 INFO - Options: 12:18:42 INFO - -h, --help show this help message and exit 12:18:42 INFO - -d DEST, --destination=DEST 12:18:42 INFO - Directory to install application into. [default: 12:18:42 INFO - "/builds/slave/test"] 12:18:42 INFO - --app=APP Application being installed. [default: firefox] 12:18:42 INFO - mkdir: /builds/slave/test/build/application 12:18:42 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'] 12:18:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 12:18:58 INFO - Reading from file tmpfile_stdout 12:18:58 INFO - Output received: 12:18:58 INFO - /builds/slave/test/build/application/firefox/firefox 12:18:58 INFO - Running post-action listener: _resource_record_post_action 12:18:58 INFO - [mozharness: 2017-01-25 20:18:58.481011Z] Finished install step (success) 12:18:58 INFO - [mozharness: 2017-01-25 20:18:58.481286Z] Running run-tests step. 12:18:58 INFO - Running pre-action listener: _resource_record_pre_action 12:18:58 INFO - Running main action method: run_tests 12:18:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:18:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:18:58 INFO - Python 2.7.3 12:18:58 INFO - Return code: 0 12:18:58 INFO - grabbing minidump binary from tooltool 12:18:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:18:58 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 0x1026850>, '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 0xf9b6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf9bb60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:18:58 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 12:18:58 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 12:18:58 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 12:18:58 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:18:58 INFO - Return code: 0 12:18:58 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:18:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:18:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:18:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:18:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:18:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BeRKb3tYQXK2MPmttxsCnQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--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 12:18:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BeRKb3tYQXK2MPmttxsCnQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-007 --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 12:18:58 INFO - Using env: {'DISPLAY': ':0', 12:18:58 INFO - 'HOME': '/home/cltbld', 12:18:58 INFO - 'LANG': 'en_US.UTF-8', 12:18:58 INFO - 'LANGUAGE': 'en_US:en', 12:18:58 INFO - 'LOGNAME': 'cltbld', 12:18:58 INFO - 'MAIL': '/var/mail/cltbld', 12:18:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:18:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:18:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:18:58 INFO - 'MOZ_NO_REMOTE': '1', 12:18:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:18:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:18:58 INFO - 'NO_EM_RESTART': '1', 12:18:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:18:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:18:58 INFO - 'PWD': '/builds/slave/test', 12:18:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:18:58 INFO - 'SHELL': '/bin/bash', 12:18:58 INFO - 'SHLVL': '1', 12:18:58 INFO - 'TERM': 'linux', 12:18:58 INFO - 'TMOUT': '86400', 12:18:58 INFO - 'USER': 'cltbld', 12:18:58 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1485375482.663370-859002171', 12:18:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:18:58 INFO - '_': '/tools/buildbot/bin/python'} 12:18:58 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BeRKb3tYQXK2MPmttxsCnQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--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 12:18:58 INFO - mozversion application_buildid: 20170125192422 12:18:58 INFO - mozversion application_changeset: f3a3afaf7e41b6ea973e97b00528f6d58bdb08cb 12:18:58 INFO - mozversion application_display_name: FirefoxDeveloperEdition 12:18:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:18:58 INFO - mozversion application_name: Firefox 12:18:58 INFO - mozversion application_remotingname: firefox-dev 12:18:58 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 12:18:58 INFO - mozversion application_vendor: Mozilla 12:18:58 INFO - mozversion application_version: 53.0a2 12:18:58 INFO - mozversion platform_buildid: 20170125192422 12:18:58 INFO - mozversion platform_changeset: f3a3afaf7e41b6ea973e97b00528f6d58bdb08cb 12:18:58 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 12:18:58 INFO - mozversion platform_version: 53.0a2 12:18:58 INFO - using testdate: 1485375538 12:18:58 INFO - actual date: 1485375538 12:18:58 INFO - starting webserver on 'localhost:57339' 12:18:58 INFO - SUITE-START | Running 2 tests 12:18:58 INFO - TEST-START | dromaeo_css 12:18:58 INFO - operating with platform_type : linux_ 12:18:58 INFO - Initialising browser for dromaeo_css test... 12:18:58 INFO - TEST-INFO | started process 11903 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvT7oO5/profile http://localhost:57339/getInfo.html) 12:19:02 INFO - PROCESS | 11903 | __metrics Screen width/height:1600/1200 12:19:02 INFO - PROCESS | 11903 | colorDepth:24 12:19:02 INFO - PROCESS | 11903 | Browser inner width/height: 1024/697 12:19:02 INFO - PROCESS | 11903 | __metrics 12:19:02 INFO - PROCESS | 11903 | JavaScript error: resource://app/modules/webrtcUI.jsm, line 66: NS_ERROR_XPC_NOT_ENOUGH_ARGS: Not enough arguments [nsIMessageListenerManager.removeMessageListener] 12:19:03 INFO - PROCESS | 11903 | 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" 12:19:03 INFO - PROCESS | 11903 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:19:03 INFO - PROCESS | 11903 | console.error: PushService: 12:19:03 INFO - PROCESS | 11903 | stateChangeProcessEnqueue: Error transitioning state 12:19:03 INFO - PROCESS | 11903 | UnknownError 12:19:04 INFO - TEST-INFO | 11903: exit 0 12:19:04 INFO - Browser initialized. 12:19:04 INFO - Running cycle 1/1 for dromaeo_css test... 12:19:04 INFO - TEST-INFO | started process 11992 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvT7oO5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:19:15 INFO - PROCESS | 11992 | RSS: Main: 138919936 12:19:15 INFO - PROCESS | 11992 | 12:22:16 INFO - PROCESS | 11992 | Cycle 1(1): loaded http://localhost:57339/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57339/tests/dromaeo/cssquery-ext.html) 12:22:17 INFO - PROCESS | 11992 | RSS: Main: 238817280 12:22:17 INFO - PROCESS | 11992 | 12:24:05 INFO - PROCESS | 11992 | ************************* 12:24:05 INFO - PROCESS | 11992 | A coding exception was thrown and uncaught in a Task. 12:24:05 INFO - PROCESS | 11992 | 12:24:05 ERROR - PROCESS | 11992 | Full message: TypeError: NetworkError when attempting to fetch resource. 12:24:05 INFO - PROCESS | 11992 | Full stack: 12:24:05 INFO - PROCESS | 11992 | ************************* 12:25:19 INFO - PROCESS | 11992 | Cycle 1(1): loaded http://localhost:57339/tests/dromaeo/cssquery-ext.html (next: http://localhost:57339/tests/dromaeo/cssquery-jquery.html) 12:25:20 INFO - PROCESS | 11992 | RSS: Main: 228032512 12:25:20 INFO - PROCESS | 11992 | 12:28:21 INFO - PROCESS | 11992 | Cycle 1(1): loaded http://localhost:57339/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57339/tests/dromaeo/cssquery-mootools.html) 12:28:22 INFO - PROCESS | 11992 | RSS: Main: 171139072 12:28:22 INFO - PROCESS | 11992 | 12:31:24 INFO - PROCESS | 11992 | Cycle 1(1): loaded http://localhost:57339/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57339/tests/dromaeo/cssquery-prototype.html) 12:31:25 INFO - PROCESS | 11992 | RSS: Main: 212807680 12:31:25 INFO - PROCESS | 11992 | 12:34:27 INFO - PROCESS | 11992 | Cycle 1(1): loaded http://localhost:57339/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57339/tests/dromaeo/cssquery-yui.html) 12:34:28 INFO - PROCESS | 11992 | RSS: Main: 172240896 12:34:28 INFO - PROCESS | 11992 | 12:37:30 INFO - PROCESS | 11992 | Cycle 1(1): loaded http://localhost:57339/tests/dromaeo/cssquery-yui.html (next: http://localhost:57339/tests/dromaeo/cssquery-dojo.html) 12:37:31 INFO - PROCESS | 11992 | RSS: Main: 263655424 12:37:31 INFO - PROCESS | 11992 | 12:37:31 INFO - PROCESS | 11992 | __start_tp_report 12:37:31 INFO - PROCESS | 11992 | _x_x_mozilla_page_load 12:37:31 INFO - PROCESS | 11992 | _x_x_mozilla_page_load_details 12:37:31 INFO - PROCESS | 11992 | |i|pagename|runs| 12:37:31 INFO - PROCESS | 11992 | |0;dojo.html;3318.867245310187;3342.398368293708;3361.4621660534312;3376.3753705564486;3402.200482886521;5469.288992430983;5541.833744987652;5546.500814926656;5548.4174161713045;5570.972145139279;5518.255035570197;5584.46947539983;5590.888182236363;5615.466530679589;5628.887422251562;4985.451600323961;4995.200767877141;5030.622703297249;5065;5078.923816142761;4840.806367745286;5038.773255203506;5071.1886098224295;5091.541761241488;5097.158968770148;4826.251930950691;4851.927221091686;4883.19427294496;4912.926306105412;4968.378952630921;4934.432540257881;4960.032793605248;4966.925496117579;4967.726775027372;5004.024215278022;4866.902661946777;4897.730624815634;4932.136876046713;4955.776990035457;4957.157283261854;5306.442823503554;5359.571234301286;5395.29861118056;5469.097598896177;5470.070088085035;5924.052151655757;5926.555508336849;5930.525557955396;5941.405859414024;5965.433283838029;5891.587588868781;5941.643501389931;5952.047672372443;5960.433758792908;5966.284045914518;5395.676259424408;5437.728113594305;5528.44715528444;5581.413951535112;5585.636933599303;6058.0610005449225;6110.437255174928;6113.697866921391;6116.7102152544485;6121.523955630119;5840.649561026352;5894.911576326359;5895.970520147372;5896.734646940898;5924.911126333109;5731.512821410143;5769.884602308014;5980.940190598125;5985.281766187998;5991.760329586855;5732.971335143381;5761.683107429048;5769.163471296639;5804.419558044162;5843.444872737083;5799.4780469757925;5807;5824.446677565625;5827.79602713903;5828.854278643068;4515.367848501212;4519.796609152596;4525.04973955473;4527.637788976874;4544.182047231464;3949.6840252779707;3986.2226865761477;4038.2932986727205;4093.529244136903;4101.938470922939;5748.051571490741;5763.9135412968835;5765.682887441231;5768.567357448208;5795.768169273266;5648.124540696199;5736.885262294731;5958.165856780054;5963.314218864799;5979.970100149559;5569.164625306236;5576.609637325349;5584.6090773646265;5639.605227634108;5687.488126068673;4964.826231081895;4965.82619608312;4972.353594032753;4980.12847751642;4995.825146119941;5867.765289388377;5975.551833612496;6009.429104235091;6025.78909738157;6031.668258245839;5678.68767217807;5848.6783226921225;5884.882302353843;5936.198613187337;6023.728932197974;6204.782832601018;6230;6232.937670623417;6238.407351301619;6241.750329986749;5912.526997840248;5913.940860591339;5914.378990206139;5917.733701983335;5948.762049518144;5621.381648018796;5722.599418040697;5817.825465236049;5834.795782147605;5871.500922421471;5760.942390576208;5805.245318108618;5812.622179558315;5816.47651711348;5828.475437210672;5779.624324418899;5788.594798364074;5791.8552036199435;5793.710314484343;5794.913076303775;5573.16402539606;5580.135079062752;5719.914201287067;5733.197352370755;5758.2514273144225;5869.236999190249;5869.647821130575;5870.0607902735355;5881.911771323519;5909.763609455574;5756.136579513107;5769.68266745333;5770.047942089508;5774.653520788766;5775.27809023872 12:37:31 INFO - PROCESS | 11992 | |1;ext.html;592.9140274660174;603.9607425517341;645.9773907913221;649.9405968271716;652.0577765129387;36439.4534081989;47861;49031.50968490314;49143.26285105726;49218.75390623051;49176;49708.751456242666;49758;49766.50233497664;49820.75089624547;8773.341999350074;8951.910480895205;9327.440353578773;9497.81004379912;9516.381435206724;11116.277441966287;11353.20527563071;11359.602413915514;11691.240069395504;11764;11412.429378531082;11487.655370338862;11490.942545287262;11493.655190344261;11510;11349.943250283737;11357.375344356056;11417.54329826806;11435.714107147387;11443.713907152305;11273.32360058391;11338.659840204808;11347.375894325809;11348.43257837113;11352.262102963281;47838.52161478376;48109.75945120252;48162.03675926497;48167.51832481665;48271;4351.847685331029;4389.758563279019;4431.7784110794655;4599.218132917412;4660.673752837302;29840;31555.36889262202;31837.363252735046;31956.360872782414;33258.669653213845;4645.117427688762;4686.367340409035;4717.150912835688;4736;4767.237242041291;337872;337980;338166;338213;341205;61191;61221.38778612246;61306.693466533274;61570.53717851325;61642.76714465686;57688;57688.71155644279;57822;57825;57852.71073644689;18872;19417.611647766964;19437.51406214856;19455.610887782164;19466.221351145796;13450.058495905192;14027;14036.789448158286;14259;14916.62708432298;19502.50638418618;19528.12123454448;19664.016799159985;19677;19787.703184452246;7330.523515971445;7419.2209817969415;7555.811104722426;7607.581583012988;7650.693972241159;1024.0374048394485;1027.547878933282;1039.3815679670583;1048.1457612046158;1049.2864851900629;33837.661623383945;33930;34667.4799878002;34728.65271347305;34863;1087.9292845964987;1181.4919584578713;1186.655869797749;1215.1008253892055;1234.6172686467223;18281.45155645333;18516.16677249527;18602;18670.43988680342;18703.438896833115;520744;523033;523479;523582;524238;68066;68551;68578.65710671514;68747.65626171837;68865;1515.552911890995;1541.8458154184268;1579.0920220872815;1579.9842001580066;1582.4619629326085;32282.83858580692;33706.494402584474;33762.32475350529;33849.15377115592;34152.13946117255;56930;57695.71152144212;57712.71143644255;57795.42204577901;57810.421895780506;400347;400410;403137;403219;403287;28383.574246385906;29067.7093229065;29902.25244368908;30300.090997270116;30981;51207;51319.230211547605;51843.22235166551;51958.740206298724;52086;42783.14433711371;43709;43871.56128438675;44189.558104418546;44953.55046449494;43033.354499681904;43270.783646082826;43430.78284608557;44546;44632.77683611561;42919.57080429281;43017;43026.35460468033;43216.56783432126;43300;35390;37559.248815023;38050.2389952205;38685.80657096697;38743.418848717854;28515.42969140647;28606.856965715036;28874.855625721735;28900.710992889803;28915.277118071375 12:37:31 INFO - PROCESS | 11992 | |2;jquery.html;386.1003861003861;433.4884835893648;442.10253186032367;447.8007286757393;448.5357654827254;18494;20806.47983800406;22097.33707988761;23264.18575349863;23935.401614959635;22858.88570557149;23104.76895231047;23263.418414539647;23388.64917026242;23534.29397118089;5897.380775018625;6069.302030266521;6106.938930610704;6247.094171345152;6291.339409361997;6156.3843615638525;6196.938030619704;6213.502919766431;6252.968735156318;6255.87488250237;5901.911471327933;6079.665618390986;6113.144159817629;6114.388561143895;6119.571629985903;5924.289085309747;6004.249468816398;6107.847303817396;6127.203463549732;6153.476954458876;5441.047816632113;5470.7264636768405;5474.206240095164;5484.287042684426;5492.670439773627;25939;26119.73880261211;26135.60796588053;26367;26410.6038409424;3392.8982130536124;3431.0564594736647;3438.6905178534053;3455.706264967481;3529.6117427083;15930.761038584431;16086.436974705946;16087.839121608751;16112.75830862538;16121.355145794154;2070.989645051765;2109.820665243456;2124.9575008499896;2125.2986514450195;2226.8441209115367;90478.5476072622;92002.53998729963;92883.07116928812;94159;94285.52857235739;10352.741181470523;10862;11935;12127.818082728767;12154.696132596755;16039.518814435585;16790.74813877793;16886.240119194666;17527;17571.824281757017;9342.90657093434;9463.668771592962;9608;9635.518224088908;9672.95163524178;9307.860382094274;9327.486988215578;9348.813023739487;9439.339246252697;9539.046095390406;7711.575863327459;8000.679972801139;8020.919790802017;8100.959495202486;8152.307053900485;2142.1966762464076;2145.581611585757;2150.47313408216;2212.9004194811273;2233.798958093779;958.5925981457992;966.0972352541055;973.1873885305849;983.1593987141034;985.9852102218473;20221.696674549894;21553;21689.457763556038;21721.13115475363;21732.89133554322;971.7424882406168;975.0590679993699;991.0436428846198;995.7361299255703;1002.3785253143097;11189;11645.41772911368;11909.10681698876;12056.095792815573;12149.574764883188;614315;626991;635281;644202;651809;94696.52651736834;98394.50802746083;98971.50514247526;106428;112542;1167.8423412839159;1171.9648410547697;1213.7815193265121;1226.656536169856;1227.6623928419756;19576.706349405056;19755;19892.104855281257;20000.099995499946;20073.498162546053;47162.87767050559;47224.2916356248;48305.75847120742;48634;49337.50662493329;67980.3201967974;69498;69508.65245673739;69799.6510017467;71181.64409178129;9966.352187107816;10069.395836249849;10082.495875206358;10099.94950025245;10304.536295866554;14520.419183232974;14593.051451655609;14642.85357146415;14913.92543037278;15259;12771.680707982376;13182.934085329513;13185.340732963505;13203.603891883258;13524.188548686716;12631.368431578569;12992.155509891827;13138.605841824761;13191.076624636567;13360.465581376637;13136.474541018251;13266.933665331611;13349.132306400053;13418.463261469431;13508.459661613426;9683.66107186245;9721.319507634398;9755.073268039525;9798.951005244928;10039.849402258826;12373.319467429377;13051;13069.934650326688;13106.60680179596;13426.127301725357 12:37:31 INFO - PROCESS | 11992 | |3;mootools.html;1519.7188520123777;1525.6567272363714;1532.8926975111742;1534.823495298041;1544.7219500489914;8351.91648083519;8859.069797671249;8868.822623547534;8870.689525866595;8872.556372181389;7392.8891066633905;7672.808179795508;8333.666653333874;8667.523286219255;8699.608517616707;2405.170216275387;2441.6703744994375;2447.2413551799;2451.669024681672;2454.1410506322823;2345.0854166874933;2367.95264094718;2376.1683410806168;2443.5601591713485;2487.6019836826113;2336.1122773346106;2364.030747393569;2385.022140922222;2387.0809738250723;2390.1873363056557;2323.76762323768;2351.776581224781;2356.6582845487396;2362.0197617988515;2368.692070030894;2378.952420951571;2425.4300239443714;2451.767082127195;2459.5695753243112;2460.9261722148362;8831.823363532758;8917.643294268222;8922.10778922109;8924.776880577972;8926.062763409878;5246.422893481714;5464.453554644543;5468.808591699311;5474.452554744534;5475.890482190373;3312.0560640217423;3335.7164641005543;3354.6788679207652;3361.512580675813;3457.4640930655537;1427.3148888533563;1470.8235011798652;1478.0540454109378;1480.0897448069359;1541.9229038548028;11226.550937962471;11589.884101158965;11928.284302941851;12084.395780210954;12165.574204902874;4363.869083927487;4527.886802829889;4560.8175672973375;4621.445426548836;4640.883977900512;9776.120149186607;9828.508574571242;9832.606695732233;9863.260255480867;9867;5346.984073026113;5351.117065684196;5351.9464805351445;5352.57179425645;5354.812581559627;4315.784210789448;4453.198424283595;4986.850394488171;5011.824586139468;5056.797728090909;3849.4610754494392;3922.195949830335;3938;4012.839486420569;4035.53591337;1134.075728281448;1146.358039497884;1148.4200478758341;1150.6375491720082;1161.175565348612;1082.9928166804948;1112;1117.1286396610656;1119.3619636807105;1127.5433449452985;6100.0849872519475;6250.343713909974;6283;6341.239051313872;6378.521610879203;640.0623087177307;640.782134074417;641.3458272561961;648.6886294578534;666.0342503370133;4174.582541745801;4197.559256278108;4235;4267.16790225903;4267.743935363888;10403.5838566458;10755.623553175757;10790.622328218475;10826.566937322576;10833.349998999927;10596.205284603686;10680.78638427227;10728.463576821128;10753.89246107529;10761.139108871428;7841.607919603997;8364.539950302791;8374.539400332918;8380.580970951429;8381;6101.267847858286;6172.783952561639;6239.1577137087725;6293.905591416041;6392.872142557216;9630.47032413224;9653.324267301221;9740.737792988148;9851.556679949563;9858.950705246429;9758.121769040821;9851.556679949275;9916.454594997344;9924.1068303853;9931.553080111556;6783.423409010092;6915.066466027022;7294.744683936036;7729.188435214446;7883.408744344082;8118.512889226429;8445.324374049938;8446;8449.619767110371;8457.957710211656;7466.962665186639;7474.439417043852;7535.133459651991;7612.619369031637;7796.220377962159;6666.300038496082;6669.933300667125;6683.030960510796;6724.899126513008;6740.12378390806;6648.90026649591;6734.8653026940165;6760.425363844129;6761.188657361148;6761.729530818712;5265.631405801711;5344.118220493575;5353.705546194997;5362.517373436253;5523.447655234444;5127.307813445286;5220.738963051908;5346.759395827119;5374.193870919394;5529.198266251291 12:37:31 INFO - PROCESS | 11992 | |4;prototype.html;380.7106598984773;400.9278329900617;401.6385253272053;407.6066595735115;407.986708481208;5403.729813509323;5434.239206511087;5486.835394938148;5490.69801160937;5493.890122197554;5162.561182299509;5232.973835130829;5298.7350632468415;5331.706756128411;5429.511343979041;4287.892802679942;4295.720778149418;4304.268274393361;4327.891802704942;4341.1317736452675;4334.913301733964;4350.390945267665;4352.97823510882;4382.605565499104;4393.2970724684055;4004.379321205218;4104.774237416941;4245.532991370947;4275.674540892318;4298.377989426447;4244.34212697034;4248.362745588156;4251.511076226243;4261.786910654455;4275.46556680415;3852.8844134676006;3854.9421758673643;3862.517185351831;3866.2654095721723;3873.86441474547;5208.401033881114;5223.660462069954;5262;5270.894582108374;5302.708351040691;4885.680866166151;4932.4081110267;4939.753012349368;4961.851144465636;4963.081829861487;5596.300462442195;5623.662580245198;5639.520640745542;5658.801941932013;5676.403977582377;4251.1285186537;4287.678424118204;4289.356596510517;4324.610785029363;4356.324769660708;5816.447437493432;5830.38780928005;5838.27021622293;5838.824835254949;5853.385394533598;4339.370791235317;4415.359772832985;4429.025614364835;4463.4420697412825;4466.151431228056;4114;4286.185624731291;4292.635126014261;4510.368548403226;4519.84180553679;4837.153498137812;4841.588464980446;4844.418669759581;4844.491328410537;4868.249439066986;5692.260006199251;5703.488575527488;5705.315362156485;5747.224124743107;5756.395578464285;1415.9079659822078;1428.178797191619;1430.985690143106;1431.9546730886511;1439.7186504011438;953.3660116022905;960.6013504395737;985.2512090810892;1015.720676813882;1018.4347687033619;5392.299001129828;5410.864728381744;5436.157395603688;5440.591955603346;5469.854833470691;5636.857993962268;5649.4633009864;5651.66090034591;5657.377688454267;5662.073995623834;5290.576753859682;5351.170568561879;5374.623776335698;5386.380566234855;5420.268263784417;2919.2847752300822;2935.706429357047;2945.4109178164026;2946.911592652224;2950.141410911155;5523.370605671336;5730.739237367772;5736.397678243808;5756.971215143897;5794.333651630032;5635.802746903839;5653.180288858092;5681.886362272814;5692.459216374438;5700.857478563069;5767.106098554731;5785.971070144622;5795;5820.417958204146;5849.268841394825;5437.619366644455;5514.455952333193;5720.799772007959;5756.798512052058;5782.566307527037;5721.971390143022;5729.3984131665575;5749.54003679713;5750.30996280449;5767.365589785204;5829.271341082364;5947.6431414115295;6040;6078.72645730952;6093.60391574564;4160.50073991123;4194.573844892751;4203.180379825904;4243.172581346607;4251.95748042528;5736.340320862987;5772.960867043972;5834;5837.211976383303;5872.500837428866;5470;5594.328680558359;5630.904031851182;5725.799597014251;5753.424657534213;5585.525230355465;5621.065254322073;5627.718614069198;5628.380878103323;5630.268065151504;5374;5557.166425036277;5621.976088608179;5639.323281206118;5641.689707066151;5480.150576660624;5634;5637.379888212376;5638.661680299195;5650.378458369658;5513.558915286848;5521.475459831309;5524.364698059614;5577.298923828272;5589.496945274945 12:37:31 INFO - PROCESS | 11992 | |5;yui.html;757.8749506331459;765.5827573972184;789.7433334166398;854.9401541892066;863.9136086391362;14887.851121488782;15522.534323970285;16289.104099274535;16516.504504864843;16576.834231657678;15673.059616423023;15802.683946321067;16308.83691163088;16803.24385402657;16992.895461794975;702.3012102957564;725.9709611615529;817.3257062923083;826.9049059358191;828.4821986258588;790.3282210121408;815.502543448496;821.2813787935556;827.755812035451;829.0134739659785;878.7407714724171;879.5997820991433;880.4277219807112;882.6381183714678;882.9337799665019;723.7141329174999;744.8659241336558;867.5402036920442;873.275181599271;873.6243415331405;614.9846253843644;636.3191385217818;639.4979940746538;640.6380395076767;641.0608458608161;15460.768088478682;15959;15971.281292341757;15983.280752366172;16030.438934637232;13678.93160534201;13883;14081.08472949255;14235.572932812032;14733.410663573444;14052.227127507984;14102.294885255696;14118.223497707622;14317.212553309564;14469.49356772508;4588.931166032512;4613.976930115362;4701.717896926195;4869.659123861331;4885.096257192396;87210.56394718049;87786.56106719426;88760;89453.10546894578;90678.1864362709;12245.142840001114;12300.323482208565;12377.133600647869;12385.62843114708;12410.007199424204;23510;23547.41131471727;23565.646515302284;23589;23870.283891483283;8598.312135029182;8652.307815374756;8672.392932494664;8676.783080422914;8880.1563851434;4505.166544189336;4743.169945259566;4753.429588449409;4818.132736107535;4826.01066781309;3802.5627052888717;3833.3291673956946;3836.3286424875537;3843.5387753469763;3899.649031587114;643.9356064393617;648.160631981585;650.869826034795;658.0228360884083;666.5001249063203;779.1468342165319;786.3591173193829;797.4736673795268;799.8887111358424;811.6550466051905;10712.645514266938;11018.50416731249;11098.833517497244;11125.332480051224;11213.66359009231;678.9117414736053;724.272106532931;807.4711064252924;842.0568962761746;855.619249433996;4608.078384323148;4953.306537084739;5077.289179514871;5241.13521268994;5267.367915850123;73184;73866.26133738593;74375.62812185904;74884.25115748882;75335.62332188305;62922.685386572775;63560.68219658872;63871;64281;64429.35570644234;58344;58964;59187;59320;60014.399856000884;9835.803283934425;10065.396076235449;10312.948435257777;10375.014373634493;10392.584296628353;39875.80062099787;40016.3997540043;40657.39013914735;41345.79327103345;42284.36573451462;53404;54101.18848217359;54341.72829135829;54563.45436545584;56293.43706562882;13225;13618.659533511742;13664.863351366359;13873.930630347188;13984.39872362246;14059;14219.289035548389;14415.765556338365;14876.62808429798;15253.923730381277;14322.28388580546;14360.138391696531;14367.13797172173;14960;15214.923925380303;12166.939165304471;12224.572139975058;12359.25844449336;12572.434240459019;12677.556285529961;12981.935090324489;13231.352227686968;13519;13594.388252528857;13978.860211398163;10114;10322.329048611817;10334.586616535255;10410.219233557666;10603.787924241626;10066.215940579938;10320.374637627236;10413.895861041292;10490.265681402534;10491.79016419652 12:37:31 INFO - PROCESS | 11992 | __end_tp_report 12:37:31 INFO - PROCESS | 11992 | __start_cc_report 12:37:31 INFO - PROCESS | 11992 | _x_x_mozilla_cycle_collect,947 12:37:31 INFO - PROCESS | 11992 | __end_cc_report 12:37:31 INFO - PROCESS | 11992 | __startTimestamp1485376651142__endTimestamp 12:37:31 INFO - PROCESS | 11992 | 12:37:31 INFO - PROCESS | 11992 | ------- Summary: start ------- 12:37:31 INFO - PROCESS | 11992 | Number of tests: 6 12:37:31 INFO - PROCESS | 11992 | 12:37:31 INFO - PROCESS | 11992 | [#0] dojo.html Cycles:165 Average:5486.75 Median:5756.14 stddev:618.16 (10.7%) stddev-sans-first:596.21 12:37:31 INFO - PROCESS | 11992 | Values: 3318.9 3342.4 3361.5 3376.4 3402.2 5469.3 5541.8 5546.5 5548.4 5571.0 5518.3 5584.5 5590.9 5615.5 5628.9 4985.5 4995.2 5030.6 5065.0 5078.9 4840.8 5038.8 5071.2 5091.5 5097.2 4826.3 4851.9 4883.2 4912.9 4968.4 4934.4 4960.0 4966.9 4967.7 5004.0 4866.9 4897.7 4932.1 4955.8 4957.2 5306.4 5359.6 5395.3 5469.1 5470.1 5924.1 5926.6 5930.5 5941.4 5965.4 5891.6 5941.6 5952.0 5960.4 5966.3 5395.7 5437.7 5528.4 5581.4 5585.6 6058.1 6110.4 6113.7 6116.7 6121.5 5840.6 5894.9 5896.0 5896.7 5924.9 5731.5 5769.9 5980.9 5985.3 5991.8 5733.0 5761.7 5769.2 5804.4 5843.4 5799.5 5807.0 5824.4 5827.8 5828.9 4515.4 4519.8 4525.0 4527.6 4544.2 3949.7 3986.2 4038.3 4093.5 4101.9 5748.1 5763.9 5765.7 5768.6 5795.8 5648.1 5736.9 5958.2 5963.3 5980.0 5569.2 5576.6 5584.6 5639.6 5687.5 4964.8 4965.8 4972.4 4980.1 4995.8 5867.8 5975.6 6009.4 6025.8 6031.7 5678.7 5848.7 5884.9 5936.2 6023.7 6204.8 6230.0 6232.9 6238.4 6241.8 5912.5 5913.9 5914.4 5917.7 5948.8 5621.4 5722.6 5817.8 5834.8 5871.5 5760.9 5805.2 5812.6 5816.5 5828.5 5779.6 5788.6 5791.9 5793.7 5794.9 5573.2 5580.1 5719.9 5733.2 5758.3 5869.2 5869.6 5870.1 5881.9 5909.8 5756.1 5769.7 5770.0 5774.7 5775.3 12:37:31 INFO - PROCESS | 11992 | 12:37:31 INFO - PROCESS | 11992 | [#1] ext.html Cycles:180 Average:60531.29 Median:219545.21 stddev:112975.71 (51.5%) stddev-sans-first:113203.00 12:37:31 INFO - PROCESS | 11992 | Values: 592.9 604.0 646.0 649.9 652.1 36439.5 47861.0 49031.5 49143.3 49218.8 49176.0 49708.8 49758.0 49766.5 49820.8 8773.3 8951.9 9327.4 9497.8 9516.4 11116.3 11353.2 11359.6 11691.2 11764.0 11412.4 11487.7 11490.9 11493.7 11510.0 11349.9 11357.4 11417.5 11435.7 11443.7 11273.3 11338.7 11347.4 11348.4 11352.3 47838.5 48109.8 48162.0 48167.5 48271.0 4351.8 4389.8 4431.8 4599.2 4660.7 29840.0 31555.4 31837.4 31956.4 33258.7 4645.1 4686.4 4717.2 4736.0 4767.2 337872.0 337980.0 338166.0 338213.0 341205.0 61191.0 61221.4 61306.7 61570.5 61642.8 57688.0 57688.7 57822.0 57825.0 57852.7 18872.0 19417.6 19437.5 19455.6 19466.2 13450.1 14027.0 14036.8 14259.0 14916.6 19502.5 19528.1 19664.0 19677.0 19787.7 7330.5 7419.2 7555.8 7607.6 7650.7 1024.0 1027.5 1039.4 1048.1 1049.3 33837.7 33930.0 34667.5 34728.7 34863.0 1087.9 1181.5 1186.7 1215.1 1234.6 18281.5 18516.2 18602.0 18670.4 18703.4 520744.0 523033.0 523479.0 523582.0 524238.0 68066.0 68551.0 68578.7 68747.7 68865.0 1515.6 1541.8 1579.1 1580.0 1582.5 32282.8 33706.5 33762.3 33849.2 34152.1 56930.0 57695.7 57712.7 57795.4 57810.4 400347.0 400410.0 403137.0 403219.0 403287.0 28383.6 29067.7 29902.3 30300.1 30981.0 51207.0 51319.2 51843.2 51958.7 52086.0 42783.1 43709.0 43871.6 44189.6 44953.6 43033.4 43270.8 43430.8 44546.0 44632.8 42919.6 43017.0 43026.4 43216.6 43300.0 35390.0 37559.2 38050.2 38685.8 38743.4 28515.4 28606.9 28874.9 28900.7 28915.3 12:37:31 INFO - PROCESS | 11992 | 12:37:31 INFO - PROCESS | 11992 | [#2] jquery.html Cycles:180 Average:35316.72 Median:26251.30 stddev:104248.86 (397.1%) stddev-sans-first:104508.31 12:37:31 INFO - PROCESS | 11992 | Values: 386.1 433.5 442.1 447.8 448.5 18494.0 20806.5 22097.3 23264.2 23935.4 22858.9 23104.8 23263.4 23388.6 23534.3 5897.4 6069.3 6106.9 6247.1 6291.3 6156.4 6196.9 6213.5 6253.0 6255.9 5901.9 6079.7 6113.1 6114.4 6119.6 5924.3 6004.2 6107.8 6127.2 6153.5 5441.0 5470.7 5474.2 5484.3 5492.7 25939.0 26119.7 26135.6 26367.0 26410.6 3392.9 3431.1 3438.7 3455.7 3529.6 15930.8 16086.4 16087.8 16112.8 16121.4 2071.0 2109.8 2125.0 2125.3 2226.8 90478.5 92002.5 92883.1 94159.0 94285.5 10352.7 10862.0 11935.0 12127.8 12154.7 16039.5 16790.7 16886.2 17527.0 17571.8 9342.9 9463.7 9608.0 9635.5 9673.0 9307.9 9327.5 9348.8 9439.3 9539.0 7711.6 8000.7 8020.9 8101.0 8152.3 2142.2 2145.6 2150.5 2212.9 2233.8 958.6 966.1 973.2 983.2 986.0 20221.7 21553.0 21689.5 21721.1 21732.9 971.7 975.1 991.0 995.7 1002.4 11189.0 11645.4 11909.1 12056.1 12149.6 614315.0 626991.0 635281.0 644202.0 651809.0 94696.5 98394.5 98971.5 106428.0 112542.0 1167.8 1172.0 1213.8 1226.7 1227.7 19576.7 19755.0 19892.1 20000.1 20073.5 47162.9 47224.3 48305.8 48634.0 49337.5 67980.3 69498.0 69508.7 69799.7 71181.6 9966.4 10069.4 10082.5 10099.9 10304.5 14520.4 14593.1 14642.9 14913.9 15259.0 12771.7 13182.9 13185.3 13203.6 13524.2 12631.4 12992.2 13138.6 13191.1 13360.5 13136.5 13266.9 13349.1 13418.5 13508.5 9683.7 9721.3 9755.1 9799.0 10039.8 12373.3 13051.0 13069.9 13106.6 13426.1 12:37:31 INFO - PROCESS | 11992 | 12:37:31 INFO - PROCESS | 11992 | [#3] mootools.html Cycles:180 Average:5728.82 Median:5346.87 stddev:3161.54 (59.1%) stddev-sans-first:3154.58 12:37:31 INFO - PROCESS | 11992 | Values: 1519.7 1525.7 1532.9 1534.8 1544.7 8351.9 8859.1 8868.8 8870.7 8872.6 7392.9 7672.8 8333.7 8667.5 8699.6 2405.2 2441.7 2447.2 2451.7 2454.1 2345.1 2368.0 2376.2 2443.6 2487.6 2336.1 2364.0 2385.0 2387.1 2390.2 2323.8 2351.8 2356.7 2362.0 2368.7 2379.0 2425.4 2451.8 2459.6 2460.9 8831.8 8917.6 8922.1 8924.8 8926.1 5246.4 5464.5 5468.8 5474.5 5475.9 3312.1 3335.7 3354.7 3361.5 3457.5 1427.3 1470.8 1478.1 1480.1 1541.9 11226.6 11589.9 11928.3 12084.4 12165.6 4363.9 4527.9 4560.8 4621.4 4640.9 9776.1 9828.5 9832.6 9863.3 9867.0 5347.0 5351.1 5351.9 5352.6 5354.8 4315.8 4453.2 4986.9 5011.8 5056.8 3849.5 3922.2 3938.0 4012.8 4035.5 1134.1 1146.4 1148.4 1150.6 1161.2 1083.0 1112.0 1117.1 1119.4 1127.5 6100.1 6250.3 6283.0 6341.2 6378.5 640.1 640.8 641.3 648.7 666.0 4174.6 4197.6 4235.0 4267.2 4267.7 10403.6 10755.6 10790.6 10826.6 10833.3 10596.2 10680.8 10728.5 10753.9 10761.1 7841.6 8364.5 8374.5 8380.6 8381.0 6101.3 6172.8 6239.2 6293.9 6392.9 9630.5 9653.3 9740.7 9851.6 9859.0 9758.1 9851.6 9916.5 9924.1 9931.6 6783.4 6915.1 7294.7 7729.2 7883.4 8118.5 8445.3 8446.0 8449.6 8458.0 7467.0 7474.4 7535.1 7612.6 7796.2 6666.3 6669.9 6683.0 6724.9 6740.1 6648.9 6734.9 6760.4 6761.2 6761.7 5265.6 5344.1 5353.7 5362.5 5523.4 5127.3 5220.7 5346.8 5374.2 5529.2 12:37:31 INFO - PROCESS | 11992 | 12:37:31 INFO - PROCESS | 11992 | [#4] prototype.html Cycles:180 Average:4772.17 Median:5431.88 stddev:1363.30 (25.1%) stddev-sans-first:1326.68 12:37:31 INFO - PROCESS | 11992 | Values: 380.7 400.9 401.6 407.6 408.0 5403.7 5434.2 5486.8 5490.7 5493.9 5162.6 5233.0 5298.7 5331.7 5429.5 4287.9 4295.7 4304.3 4327.9 4341.1 4334.9 4350.4 4353.0 4382.6 4393.3 4004.4 4104.8 4245.5 4275.7 4298.4 4244.3 4248.4 4251.5 4261.8 4275.5 3852.9 3854.9 3862.5 3866.3 3873.9 5208.4 5223.7 5262.0 5270.9 5302.7 4885.7 4932.4 4939.8 4961.9 4963.1 5596.3 5623.7 5639.5 5658.8 5676.4 4251.1 4287.7 4289.4 4324.6 4356.3 5816.4 5830.4 5838.3 5838.8 5853.4 4339.4 4415.4 4429.0 4463.4 4466.2 4114.0 4286.2 4292.6 4510.4 4519.8 4837.2 4841.6 4844.4 4844.5 4868.2 5692.3 5703.5 5705.3 5747.2 5756.4 1415.9 1428.2 1431.0 1432.0 1439.7 953.4 960.6 985.3 1015.7 1018.4 5392.3 5410.9 5436.2 5440.6 5469.9 5636.9 5649.5 5651.7 5657.4 5662.1 5290.6 5351.2 5374.6 5386.4 5420.3 2919.3 2935.7 2945.4 2946.9 2950.1 5523.4 5730.7 5736.4 5757.0 5794.3 5635.8 5653.2 5681.9 5692.5 5700.9 5767.1 5786.0 5795.0 5820.4 5849.3 5437.6 5514.5 5720.8 5756.8 5782.6 5722.0 5729.4 5749.5 5750.3 5767.4 5829.3 5947.6 6040.0 6078.7 6093.6 4160.5 4194.6 4203.2 4243.2 4252.0 5736.3 5773.0 5834.0 5837.2 5872.5 5470.0 5594.3 5630.9 5725.8 5753.4 5585.5 5621.1 5627.7 5628.4 5630.3 5374.0 5557.2 5622.0 5639.3 5641.7 5480.2 5634.0 5637.4 5638.7 5650.4 5513.6 5521.5 5524.4 5577.3 5589.5 12:37:31 INFO - PROCESS | 11992 | 12:37:31 INFO - PROCESS | 11992 | [#5] yui.html Cycles:180 Average:17738.76 Median:4598.50 stddev:22259.72 (484.1%) stddev-sans-first:22285.64 12:37:31 INFO - PROCESS | 11992 | Values: 757.9 765.6 789.7 854.9 863.9 14887.9 15522.5 16289.1 16516.5 16576.8 15673.1 15802.7 16308.8 16803.2 16992.9 702.3 726.0 817.3 826.9 828.5 790.3 815.5 821.3 827.8 829.0 878.7 879.6 880.4 882.6 882.9 723.7 744.9 867.5 873.3 873.6 615.0 636.3 639.5 640.6 641.1 15460.8 15959.0 15971.3 15983.3 16030.4 13678.9 13883.0 14081.1 14235.6 14733.4 14052.2 14102.3 14118.2 14317.2 14469.5 4588.9 4614.0 4701.7 4869.7 4885.1 87210.6 87786.6 88760.0 89453.1 90678.2 12245.1 12300.3 12377.1 12385.6 12410.0 23510.0 23547.4 23565.6 23589.0 23870.3 8598.3 8652.3 8672.4 8676.8 8880.2 4505.2 4743.2 4753.4 4818.1 4826.0 3802.6 3833.3 3836.3 3843.5 3899.6 643.9 648.2 650.9 658.0 666.5 779.1 786.4 797.5 799.9 811.7 10712.6 11018.5 11098.8 11125.3 11213.7 678.9 724.3 807.5 842.1 855.6 4608.1 4953.3 5077.3 5241.1 5267.4 73184.0 73866.3 74375.6 74884.3 75335.6 62922.7 63560.7 63871.0 64281.0 64429.4 58344.0 58964.0 59187.0 59320.0 60014.4 9835.8 10065.4 10312.9 10375.0 10392.6 39875.8 40016.4 40657.4 41345.8 42284.4 53404.0 54101.2 54341.7 54563.5 56293.4 13225.0 13618.7 13664.9 13873.9 13984.4 14059.0 14219.3 14415.8 14876.6 15253.9 14322.3 14360.1 14367.1 14960.0 15214.9 12166.9 12224.6 12359.3 12572.4 12677.6 12981.9 13231.4 13519.0 13594.4 13978.9 10114.0 10322.3 10334.6 10410.2 10603.8 10066.2 10320.4 10413.9 10490.3 10491.8 12:37:31 INFO - PROCESS | 11992 | -------- Summary: end -------- 12:37:31 INFO - PROCESS | 11992 | 12:37:31 INFO - TEST-INFO | 11992: exit 0 12:37:31 INFO - TEST-OK | dromaeo_css | took 1113112ms 12:37:31 INFO - TEST-START | kraken 12:37:31 INFO - operating with platform_type : linux_ 12:37:31 INFO - Initialising browser for kraken test... 12:37:31 INFO - TEST-INFO | started process 12306 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_WKQDY/profile http://localhost:57339/getInfo.html) 12:37:35 INFO - PROCESS | 12306 | __metrics Screen width/height:1600/1200 12:37:35 INFO - PROCESS | 12306 | colorDepth:24 12:37:35 INFO - PROCESS | 12306 | Browser inner width/height: 1024/697 12:37:35 INFO - PROCESS | 12306 | __metrics 12:37:35 INFO - PROCESS | 12306 | JavaScript error: resource://app/modules/webrtcUI.jsm, line 66: NS_ERROR_XPC_NOT_ENOUGH_ARGS: Not enough arguments [nsIMessageListenerManager.removeMessageListener] 12:37:35 INFO - PROCESS | 12306 | 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" 12:37:35 INFO - PROCESS | 12306 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:37:36 INFO - PROCESS | 12306 | console.error: PushService: 12:37:36 INFO - PROCESS | 12306 | stateChangeProcessEnqueue: Error transitioning state 12:37:36 INFO - PROCESS | 12306 | UnknownError 12:37:37 INFO - TEST-INFO | 12306: exit 0 12:37:37 INFO - Browser initialized. 12:37:37 INFO - Running cycle 1/1 for kraken test... 12:37:37 INFO - TEST-INFO | started process 12399 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_WKQDY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:37:48 INFO - PROCESS | 12399 | RSS: Main: 138252288 12:37:48 INFO - PROCESS | 12399 | 12:37:51 INFO - PROCESS | 12399 | Cycle 1(1): loaded http://localhost:57339/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57339/tests/kraken/driver.html?testName=audio-beat-detection) 12:37:52 INFO - PROCESS | 12399 | RSS: Main: 183230464 12:37:52 INFO - PROCESS | 12399 | 12:37:54 INFO - PROCESS | 12399 | Cycle 1(1): loaded http://localhost:57339/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57339/tests/kraken/driver.html?testName=audio-dft) 12:37:55 INFO - PROCESS | 12399 | RSS: Main: 173559808 12:37:55 INFO - PROCESS | 12399 | 12:37:58 INFO - PROCESS | 12399 | Cycle 1(1): loaded http://localhost:57339/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57339/tests/kraken/driver.html?testName=audio-fft) 12:37:58 INFO - PROCESS | 12399 | RSS: Main: 264347648 12:37:58 INFO - PROCESS | 12399 | 12:38:00 INFO - PROCESS | 12399 | Cycle 1(1): loaded http://localhost:57339/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57339/tests/kraken/driver.html?testName=audio-oscillator) 12:38:01 INFO - PROCESS | 12399 | RSS: Main: 170819584 12:38:01 INFO - PROCESS | 12399 | 12:38:03 INFO - PROCESS | 12399 | Cycle 1(1): loaded http://localhost:57339/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57339/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:38:04 INFO - PROCESS | 12399 | RSS: Main: 172818432 12:38:04 INFO - PROCESS | 12399 | 12:38:07 INFO - PROCESS | 12399 | Cycle 1(1): loaded http://localhost:57339/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57339/tests/kraken/driver.html?testName=imaging-darkroom) 12:38:07 INFO - PROCESS | 12399 | RSS: Main: 211550208 12:38:07 INFO - PROCESS | 12399 | 12:38:11 INFO - PROCESS | 12399 | Cycle 1(1): loaded http://localhost:57339/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57339/tests/kraken/driver.html?testName=imaging-desaturate) 12:38:11 INFO - PROCESS | 12399 | RSS: Main: 210112512 12:38:11 INFO - PROCESS | 12399 | 12:38:14 INFO - PROCESS | 12399 | Cycle 1(1): loaded http://localhost:57339/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57339/tests/kraken/driver.html?testName=json-parse-financial) 12:38:15 INFO - PROCESS | 12399 | RSS: Main: 208572416 12:38:15 INFO - PROCESS | 12399 | 12:38:16 INFO - PROCESS | 12399 | Cycle 1(1): loaded http://localhost:57339/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57339/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:38:17 INFO - PROCESS | 12399 | RSS: Main: 170950656 12:38:17 INFO - PROCESS | 12399 | 12:38:18 INFO - PROCESS | 12399 | Cycle 1(1): loaded http://localhost:57339/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57339/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:38:19 INFO - PROCESS | 12399 | RSS: Main: 177565696 12:38:19 INFO - PROCESS | 12399 | 12:38:21 INFO - PROCESS | 12399 | Cycle 1(1): loaded http://localhost:57339/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57339/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:38:22 INFO - PROCESS | 12399 | RSS: Main: 187084800 12:38:22 INFO - PROCESS | 12399 | 12:38:24 INFO - PROCESS | 12399 | Cycle 1(1): loaded http://localhost:57339/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57339/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:38:25 INFO - PROCESS | 12399 | RSS: Main: 196894720 12:38:25 INFO - PROCESS | 12399 | 12:38:27 INFO - PROCESS | 12399 | Cycle 1(1): loaded http://localhost:57339/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57339/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:38:28 INFO - PROCESS | 12399 | RSS: Main: 192983040 12:38:28 INFO - PROCESS | 12399 | 12:38:30 INFO - PROCESS | 12399 | Cycle 1(1): loaded http://localhost:57339/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57339/tests/kraken/driver.html?testName=ai-astar) 12:38:30 INFO - PROCESS | 12399 | RSS: Main: 245043200 12:38:30 INFO - PROCESS | 12399 | 12:38:30 INFO - PROCESS | 12399 | __start_tp_report 12:38:30 INFO - PROCESS | 12399 | _x_x_mozilla_page_load 12:38:30 INFO - PROCESS | 12399 | _x_x_mozilla_page_load_details 12:38:30 INFO - PROCESS | 12399 | |i|pagename|runs| 12:38:30 INFO - PROCESS | 12399 | |0;ai-astar;111;112;112;111;112;112;112;112;111;112 12:38:30 INFO - PROCESS | 12399 | |1;audio-beat-detection;141;116;117;150;119;117;116;116;134;118 12:38:30 INFO - PROCESS | 12399 | |2;audio-dft;160;160;160;161;159;160;160;160;161;162 12:38:30 INFO - PROCESS | 12399 | |3;audio-fft;75;76;75;110;76;76;76;76;89;76 12:38:30 INFO - PROCESS | 12399 | |4;audio-oscillator;83;82;113;83;82;82;101;82;82;107 12:38:30 INFO - PROCESS | 12399 | |5;imaging-gaussian-blur;116;117;117;117;117;117;117;116;118;118 12:38:30 INFO - PROCESS | 12399 | |6;imaging-darkroom;146;147;147;147;147;147;146;147;146;147 12:38:30 INFO - PROCESS | 12399 | |7;imaging-desaturate;95;96;96;96;96;95;96;95;95;95 12:38:30 INFO - PROCESS | 12399 | |8;json-parse-financial;47;50;48;49;48;50;49;48;51;50 12:38:30 INFO - PROCESS | 12399 | |9;json-stringify-tinderbox;63;64;63;63;64;63;62;64;63;63 12:38:30 INFO - PROCESS | 12399 | |10;stanford-crypto-aes;78;76;76;75;77;76;77;76;76;75 12:38:30 INFO - PROCESS | 12399 | |11;stanford-crypto-ccm;120;130;129;124;120;120;119;119;161;119 12:38:30 INFO - PROCESS | 12399 | |12;stanford-crypto-pbkdf2;163;157;158;160;161;157;163;162;159;157 12:38:30 INFO - PROCESS | 12399 | |13;stanford-crypto-sha256-iterative;61;65;60;61;61;62;62;61;59;61 12:38:30 INFO - PROCESS | 12399 | __end_tp_report 12:38:30 INFO - PROCESS | 12399 | __start_cc_report 12:38:30 INFO - PROCESS | 12399 | _x_x_mozilla_cycle_collect,1520 12:38:30 INFO - PROCESS | 12399 | __end_cc_report 12:38:30 INFO - PROCESS | 12399 | __startTimestamp1485376710368__endTimestamp 12:38:30 INFO - PROCESS | 12399 | 12:38:30 INFO - PROCESS | 12399 | ------- Summary: start ------- 12:38:30 INFO - PROCESS | 12399 | Number of tests: 14 12:38:30 INFO - PROCESS | 12399 | 12:38:30 INFO - PROCESS | 12399 | [#0] ai-astar Cycles:10 Average:111.70 Median:112.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 12:38:30 INFO - PROCESS | 12399 | Values: 111.0 112.0 112.0 111.0 112.0 112.0 112.0 112.0 111.0 112.0 12:38:30 INFO - PROCESS | 12399 | 12:38:30 INFO - PROCESS | 12399 | [#1] audio-beat-detection Cycles:10 Average:124.40 Median:118.50 stddev:12.54 (10.6%) stddev-sans-first:11.77 12:38:30 INFO - PROCESS | 12399 | Values: 141.0 116.0 117.0 150.0 119.0 117.0 116.0 116.0 134.0 118.0 12:38:30 INFO - PROCESS | 12399 | 12:38:30 INFO - PROCESS | 12399 | [#2] audio-dft Cycles:10 Average:160.30 Median:160.00 stddev:0.82 (0.5%) stddev-sans-first:0.87 12:38:30 INFO - PROCESS | 12399 | Values: 160.0 160.0 160.0 161.0 159.0 160.0 160.0 160.0 161.0 162.0 12:38:30 INFO - PROCESS | 12399 | 12:38:30 INFO - PROCESS | 12399 | [#3] audio-fft Cycles:10 Average:80.50 Median:76.00 stddev:11.18 (14.7%) stddev-sans-first:11.68 12:38:30 INFO - PROCESS | 12399 | Values: 75.0 76.0 75.0 110.0 76.0 76.0 76.0 76.0 89.0 76.0 12:38:30 INFO - PROCESS | 12399 | 12:38:30 INFO - PROCESS | 12399 | [#4] audio-oscillator Cycles:10 Average:89.70 Median:82.00 stddev:12.28 (15.0%) stddev-sans-first:12.78 12:38:30 INFO - PROCESS | 12399 | Values: 83.0 82.0 113.0 83.0 82.0 82.0 101.0 82.0 82.0 107.0 12:38:30 INFO - PROCESS | 12399 | 12:38:30 INFO - PROCESS | 12399 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.60 12:38:30 INFO - PROCESS | 12399 | Values: 116.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 118.0 118.0 12:38:30 INFO - PROCESS | 12399 | 12:38:30 INFO - PROCESS | 12399 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 12:38:30 INFO - PROCESS | 12399 | Values: 146.0 147.0 147.0 147.0 147.0 147.0 146.0 147.0 146.0 147.0 12:38:30 INFO - PROCESS | 12399 | 12:38:30 INFO - PROCESS | 12399 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 12:38:30 INFO - PROCESS | 12399 | Values: 95.0 96.0 96.0 96.0 96.0 95.0 96.0 95.0 95.0 95.0 12:38:30 INFO - PROCESS | 12399 | 12:38:30 INFO - PROCESS | 12399 | [#8] json-parse-financial Cycles:10 Average:49.00 Median:49.50 stddev:1.25 (2.5%) stddev-sans-first:1.09 12:38:30 INFO - PROCESS | 12399 | Values: 47.0 50.0 48.0 49.0 48.0 50.0 49.0 48.0 51.0 50.0 12:38:30 INFO - PROCESS | 12399 | 12:38:30 INFO - PROCESS | 12399 | [#9] json-stringify-tinderbox Cycles:10 Average:63.20 Median:63.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 12:38:30 INFO - PROCESS | 12399 | Values: 63.0 64.0 63.0 63.0 64.0 63.0 62.0 64.0 63.0 63.0 12:38:30 INFO - PROCESS | 12399 | 12:38:30 INFO - PROCESS | 12399 | [#10] stanford-crypto-aes Cycles:10 Average:76.20 Median:76.00 stddev:0.92 (1.2%) stddev-sans-first:0.71 12:38:30 INFO - PROCESS | 12399 | Values: 78.0 76.0 76.0 75.0 77.0 76.0 77.0 76.0 76.0 75.0 12:38:30 INFO - PROCESS | 12399 | 12:38:30 INFO - PROCESS | 12399 | [#11] stanford-crypto-ccm Cycles:10 Average:126.10 Median:122.00 stddev:12.95 (10.6%) stddev-sans-first:13.54 12:38:30 INFO - PROCESS | 12399 | Values: 120.0 130.0 129.0 124.0 120.0 120.0 119.0 119.0 161.0 119.0 12:38:30 INFO - PROCESS | 12399 | 12:38:30 INFO - PROCESS | 12399 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.70 Median:160.50 stddev:2.45 (1.5%) stddev-sans-first:2.29 12:38:30 INFO - PROCESS | 12399 | Values: 163.0 157.0 158.0 160.0 161.0 157.0 163.0 162.0 159.0 157.0 12:38:30 INFO - PROCESS | 12399 | 12:38:30 INFO - PROCESS | 12399 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.30 Median:61.00 stddev:1.57 (2.6%) stddev-sans-first:1.66 12:38:30 INFO - PROCESS | 12399 | Values: 61.0 65.0 60.0 61.0 61.0 62.0 62.0 61.0 59.0 61.0 12:38:30 INFO - PROCESS | 12399 | -------- Summary: end -------- 12:38:30 INFO - PROCESS | 12399 | 12:38:31 INFO - TEST-INFO | 12399: exit 0 12:38:31 INFO - TEST-OK | kraken | took 59555ms 12:38:31 INFO - SUITE-END | took 1172s 12:38:31 INFO - Completed test suite (00:19:32) 12:38:31 INFO - javascript benchmark 12:38:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3318.867245310187, 3342.398368293708, 3361.4621660534312, 3376.3753705564486, 3402.200482886521, 5469.288992430983, 5541.833744987652, 5546.500814926656, 5548.4174161713045, 5570.972145139279, 5518.255035570197, 5584.46947539983, 5590.888182236363, 5615.466530679589, 5628.887422251562, 4985.451600323961, 4995.200767877141, 5030.622703297249, 5065.0, 5078.923816142761, 4840.806367745286, 5038.773255203506, 5071.1886098224295, 5091.541761241488, 5097.158968770148, 4826.251930950691, 4851.927221091686, 4883.19427294496, 4912.926306105412, 4968.378952630921, 4934.432540257881, 4960.032793605248, 4966.925496117579, 4967.726775027372, 5004.024215278022, 4866.902661946777, 4897.730624815634, 4932.136876046713, 4955.776990035457, 4957.157283261854, 5306.442823503554, 5359.571234301286, 5395.29861118056, 5469.097598896177, 5470.070088085035, 5924.052151655757, 5926.555508336849, 5930.525557955396, 5941.405859414024, 5965.433283838029, 5891.587588868781, 5941.643501389931, 5952.047672372443, 5960.433758792908, 5966.284045914518, 5395.676259424408, 5437.728113594305, 5528.44715528444, 5581.413951535112, 5585.636933599303, 6058.0610005449225, 6110.437255174928, 6113.697866921391, 6116.7102152544485, 6121.523955630119, 5840.649561026352, 5894.911576326359, 5895.970520147372, 5896.734646940898, 5924.911126333109, 5731.512821410143, 5769.884602308014, 5980.940190598125, 5985.281766187998, 5991.760329586855, 5732.971335143381, 5761.683107429048, 5769.163471296639, 5804.419558044162, 5843.444872737083, 5799.4780469757925, 5807.0, 5824.446677565625, 5827.79602713903, 5828.854278643068, 4515.367848501212, 4519.796609152596, 4525.04973955473, 4527.637788976874, 4544.182047231464, 3949.6840252779707, 3986.2226865761477, 4038.2932986727205, 4093.529244136903, 4101.938470922939, 5748.051571490741, 5763.9135412968835, 5765.682887441231, 5768.567357448208, 5795.768169273266, 5648.124540696199, 5736.885262294731, 5958.165856780054, 5963.314218864799, 5979.970100149559, 5569.164625306236, 5576.609637325349, 5584.6090773646265, 5639.605227634108, 5687.488126068673, 4964.826231081895, 4965.82619608312, 4972.353594032753, 4980.12847751642, 4995.825146119941, 5867.765289388377, 5975.551833612496, 6009.429104235091, 6025.78909738157, 6031.668258245839, 5678.68767217807, 5848.6783226921225, 5884.882302353843, 5936.198613187337, 6023.728932197974, 6204.782832601018, 6230.0, 6232.937670623417, 6238.407351301619, 6241.750329986749, 5912.526997840248, 5913.940860591339, 5914.378990206139, 5917.733701983335, 5948.762049518144, 5621.381648018796, 5722.599418040697, 5817.825465236049, 5834.795782147605, 5871.500922421471, 5760.942390576208, 5805.245318108618, 5812.622179558315, 5816.47651711348, 5828.475437210672, 5779.624324418899, 5788.594798364074, 5791.8552036199435, 5793.710314484343, 5794.913076303775, 5573.16402539606, 5580.135079062752, 5719.914201287067, 5733.197352370755, 5758.2514273144225, 5869.236999190249, 5869.647821130575, 5870.0607902735355, 5881.911771323519, 5909.763609455574, 5756.136579513107, 5769.68266745333, 5770.047942089508, 5774.653520788766, 5775.27809023872], "value": 5446.522525880274, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [592.9140274660174, 603.9607425517341, 645.9773907913221, 649.9405968271716, 652.0577765129387, 36439.4534081989, 47861.0, 49031.50968490314, 49143.26285105726, 49218.75390623051, 49176.0, 49708.751456242666, 49758.0, 49766.50233497664, 49820.75089624547, 8773.341999350074, 8951.910480895205, 9327.440353578773, 9497.81004379912, 9516.381435206724, 11116.277441966287, 11353.20527563071, 11359.602413915514, 11691.240069395504, 11764.0, 11412.429378531082, 11487.655370338862, 11490.942545287262, 11493.655190344261, 11510.0, 11349.943250283737, 11357.375344356056, 11417.54329826806, 11435.714107147387, 11443.713907152305, 11273.32360058391, 11338.659840204808, 11347.375894325809, 11348.43257837113, 11352.262102963281, 47838.52161478376, 48109.75945120252, 48162.03675926497, 48167.51832481665, 48271.0, 4351.847685331029, 4389.758563279019, 4431.7784110794655, 4599.218132917412, 4660.673752837302, 29840.0, 31555.36889262202, 31837.363252735046, 31956.360872782414, 33258.669653213845, 4645.117427688762, 4686.367340409035, 4717.150912835688, 4736.0, 4767.237242041291, 337872.0, 337980.0, 338166.0, 338213.0, 341205.0, 61191.0, 61221.38778612246, 61306.693466533274, 61570.53717851325, 61642.76714465686, 57688.0, 57688.71155644279, 57822.0, 57825.0, 57852.71073644689, 18872.0, 19417.611647766964, 19437.51406214856, 19455.610887782164, 19466.221351145796, 13450.058495905192, 14027.0, 14036.789448158286, 14259.0, 14916.62708432298, 19502.50638418618, 19528.12123454448, 19664.016799159985, 19677.0, 19787.703184452246, 7330.523515971445, 7419.2209817969415, 7555.811104722426, 7607.581583012988, 7650.693972241159, 1024.0374048394485, 1027.547878933282, 1039.3815679670583, 1048.1457612046158, 1049.2864851900629, 33837.661623383945, 33930.0, 34667.4799878002, 34728.65271347305, 34863.0, 1087.9292845964987, 1181.4919584578713, 1186.655869797749, 1215.1008253892055, 1234.6172686467223, 18281.45155645333, 18516.16677249527, 18602.0, 18670.43988680342, 18703.438896833115, 520744.0, 523033.0, 523479.0, 523582.0, 524238.0, 68066.0, 68551.0, 68578.65710671514, 68747.65626171837, 68865.0, 1515.552911890995, 1541.8458154184268, 1579.0920220872815, 1579.9842001580066, 1582.4619629326085, 32282.83858580692, 33706.494402584474, 33762.32475350529, 33849.15377115592, 34152.13946117255, 56930.0, 57695.71152144212, 57712.71143644255, 57795.42204577901, 57810.421895780506, 400347.0, 400410.0, 403137.0, 403219.0, 403287.0, 28383.574246385906, 29067.7093229065, 29902.25244368908, 30300.090997270116, 30981.0, 51207.0, 51319.230211547605, 51843.22235166551, 51958.740206298724, 52086.0, 42783.14433711371, 43709.0, 43871.56128438675, 44189.558104418546, 44953.55046449494, 43033.354499681904, 43270.783646082826, 43430.78284608557, 44546.0, 44632.77683611561, 42919.57080429281, 43017.0, 43026.35460468033, 43216.56783432126, 43300.0, 35390.0, 37559.248815023, 38050.2389952205, 38685.80657096697, 38743.418848717854, 28515.42969140647, 28606.856965715036, 28874.855625721735, 28900.710992889803, 28915.277118071375], "value": 21851.252581168395, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [386.1003861003861, 433.4884835893648, 442.10253186032367, 447.8007286757393, 448.5357654827254, 18494.0, 20806.47983800406, 22097.33707988761, 23264.18575349863, 23935.401614959635, 22858.88570557149, 23104.76895231047, 23263.418414539647, 23388.64917026242, 23534.29397118089, 5897.380775018625, 6069.302030266521, 6106.938930610704, 6247.094171345152, 6291.339409361997, 6156.3843615638525, 6196.938030619704, 6213.502919766431, 6252.968735156318, 6255.87488250237, 5901.911471327933, 6079.665618390986, 6113.144159817629, 6114.388561143895, 6119.571629985903, 5924.289085309747, 6004.249468816398, 6107.847303817396, 6127.203463549732, 6153.476954458876, 5441.047816632113, 5470.7264636768405, 5474.206240095164, 5484.287042684426, 5492.670439773627, 25939.0, 26119.73880261211, 26135.60796588053, 26367.0, 26410.6038409424, 3392.8982130536124, 3431.0564594736647, 3438.6905178534053, 3455.706264967481, 3529.6117427083, 15930.761038584431, 16086.436974705946, 16087.839121608751, 16112.75830862538, 16121.355145794154, 2070.989645051765, 2109.820665243456, 2124.9575008499896, 2125.2986514450195, 2226.8441209115367, 90478.5476072622, 92002.53998729963, 92883.07116928812, 94159.0, 94285.52857235739, 10352.741181470523, 10862.0, 11935.0, 12127.818082728767, 12154.696132596755, 16039.518814435585, 16790.74813877793, 16886.240119194666, 17527.0, 17571.824281757017, 9342.90657093434, 9463.668771592962, 9608.0, 9635.518224088908, 9672.95163524178, 9307.860382094274, 9327.486988215578, 9348.813023739487, 9439.339246252697, 9539.046095390406, 7711.575863327459, 8000.679972801139, 8020.919790802017, 8100.959495202486, 8152.307053900485, 2142.1966762464076, 2145.581611585757, 2150.47313408216, 2212.9004194811273, 2233.798958093779, 958.5925981457992, 966.0972352541055, 973.1873885305849, 983.1593987141034, 985.9852102218473, 20221.696674549894, 21553.0, 21689.457763556038, 21721.13115475363, 21732.89133554322, 971.7424882406168, 975.0590679993699, 991.0436428846198, 995.7361299255703, 1002.3785253143097, 11189.0, 11645.41772911368, 11909.10681698876, 12056.095792815573, 12149.574764883188, 614315.0, 626991.0, 635281.0, 644202.0, 651809.0, 94696.52651736834, 98394.50802746083, 98971.50514247526, 106428.0, 112542.0, 1167.8423412839159, 1171.9648410547697, 1213.7815193265121, 1226.656536169856, 1227.6623928419756, 19576.706349405056, 19755.0, 19892.104855281257, 20000.099995499946, 20073.498162546053, 47162.87767050559, 47224.2916356248, 48305.75847120742, 48634.0, 49337.50662493329, 67980.3201967974, 69498.0, 69508.65245673739, 69799.6510017467, 71181.64409178129, 9966.352187107816, 10069.395836249849, 10082.495875206358, 10099.94950025245, 10304.536295866554, 14520.419183232974, 14593.051451655609, 14642.85357146415, 14913.92543037278, 15259.0, 12771.680707982376, 13182.934085329513, 13185.340732963505, 13203.603891883258, 13524.188548686716, 12631.368431578569, 12992.155509891827, 13138.605841824761, 13191.076624636567, 13360.465581376637, 13136.474541018251, 13266.933665331611, 13349.132306400053, 13418.463261469431, 13508.459661613426, 9683.66107186245, 9721.319507634398, 9755.073268039525, 9798.951005244928, 10039.849402258826, 12373.319467429377, 13051.0, 13069.934650326688, 13106.60680179596, 13426.127301725357], "value": 10595.858420630142, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1519.7188520123777, 1525.6567272363714, 1532.8926975111742, 1534.823495298041, 1544.7219500489914, 8351.91648083519, 8859.069797671249, 8868.822623547534, 8870.689525866595, 8872.556372181389, 7392.8891066633905, 7672.808179795508, 8333.666653333874, 8667.523286219255, 8699.608517616707, 2405.170216275387, 2441.6703744994375, 2447.2413551799, 2451.669024681672, 2454.1410506322823, 2345.0854166874933, 2367.95264094718, 2376.1683410806168, 2443.5601591713485, 2487.6019836826113, 2336.1122773346106, 2364.030747393569, 2385.022140922222, 2387.0809738250723, 2390.1873363056557, 2323.76762323768, 2351.776581224781, 2356.6582845487396, 2362.0197617988515, 2368.692070030894, 2378.952420951571, 2425.4300239443714, 2451.767082127195, 2459.5695753243112, 2460.9261722148362, 8831.823363532758, 8917.643294268222, 8922.10778922109, 8924.776880577972, 8926.062763409878, 5246.422893481714, 5464.453554644543, 5468.808591699311, 5474.452554744534, 5475.890482190373, 3312.0560640217423, 3335.7164641005543, 3354.6788679207652, 3361.512580675813, 3457.4640930655537, 1427.3148888533563, 1470.8235011798652, 1478.0540454109378, 1480.0897448069359, 1541.9229038548028, 11226.550937962471, 11589.884101158965, 11928.284302941851, 12084.395780210954, 12165.574204902874, 4363.869083927487, 4527.886802829889, 4560.8175672973375, 4621.445426548836, 4640.883977900512, 9776.120149186607, 9828.508574571242, 9832.606695732233, 9863.260255480867, 9867.0, 5346.984073026113, 5351.117065684196, 5351.9464805351445, 5352.57179425645, 5354.812581559627, 4315.784210789448, 4453.198424283595, 4986.850394488171, 5011.824586139468, 5056.797728090909, 3849.4610754494392, 3922.195949830335, 3938.0, 4012.839486420569, 4035.53591337, 1134.075728281448, 1146.358039497884, 1148.4200478758341, 1150.6375491720082, 1161.175565348612, 1082.9928166804948, 1112.0, 1117.1286396610656, 1119.3619636807105, 1127.5433449452985, 6100.0849872519475, 6250.343713909974, 6283.0, 6341.239051313872, 6378.521610879203, 640.0623087177307, 640.782134074417, 641.3458272561961, 648.6886294578534, 666.0342503370133, 4174.582541745801, 4197.559256278108, 4235.0, 4267.16790225903, 4267.743935363888, 10403.5838566458, 10755.623553175757, 10790.622328218475, 10826.566937322576, 10833.349998999927, 10596.205284603686, 10680.78638427227, 10728.463576821128, 10753.89246107529, 10761.139108871428, 7841.607919603997, 8364.539950302791, 8374.539400332918, 8380.580970951429, 8381.0, 6101.267847858286, 6172.783952561639, 6239.1577137087725, 6293.905591416041, 6392.872142557216, 9630.47032413224, 9653.324267301221, 9740.737792988148, 9851.556679949563, 9858.950705246429, 9758.121769040821, 9851.556679949275, 9916.454594997344, 9924.1068303853, 9931.553080111556, 6783.423409010092, 6915.066466027022, 7294.744683936036, 7729.188435214446, 7883.408744344082, 8118.512889226429, 8445.324374049938, 8446.0, 8449.619767110371, 8457.957710211656, 7466.962665186639, 7474.439417043852, 7535.133459651991, 7612.619369031637, 7796.220377962159, 6666.300038496082, 6669.933300667125, 6683.030960510796, 6724.899126513008, 6740.12378390806, 6648.90026649591, 6734.8653026940165, 6760.425363844129, 6761.188657361148, 6761.729530818712, 5265.631405801711, 5344.118220493575, 5353.705546194997, 5362.517373436253, 5523.447655234444, 5127.307813445286, 5220.738963051908, 5346.759395827119, 5374.193870919394, 5529.198266251291], "value": 4618.632578103803, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [380.7106598984773, 400.9278329900617, 401.6385253272053, 407.6066595735115, 407.986708481208, 5403.729813509323, 5434.239206511087, 5486.835394938148, 5490.69801160937, 5493.890122197554, 5162.561182299509, 5232.973835130829, 5298.7350632468415, 5331.706756128411, 5429.511343979041, 4287.892802679942, 4295.720778149418, 4304.268274393361, 4327.891802704942, 4341.1317736452675, 4334.913301733964, 4350.390945267665, 4352.97823510882, 4382.605565499104, 4393.2970724684055, 4004.379321205218, 4104.774237416941, 4245.532991370947, 4275.674540892318, 4298.377989426447, 4244.34212697034, 4248.362745588156, 4251.511076226243, 4261.786910654455, 4275.46556680415, 3852.8844134676006, 3854.9421758673643, 3862.517185351831, 3866.2654095721723, 3873.86441474547, 5208.401033881114, 5223.660462069954, 5262.0, 5270.894582108374, 5302.708351040691, 4885.680866166151, 4932.4081110267, 4939.753012349368, 4961.851144465636, 4963.081829861487, 5596.300462442195, 5623.662580245198, 5639.520640745542, 5658.801941932013, 5676.403977582377, 4251.1285186537, 4287.678424118204, 4289.356596510517, 4324.610785029363, 4356.324769660708, 5816.447437493432, 5830.38780928005, 5838.27021622293, 5838.824835254949, 5853.385394533598, 4339.370791235317, 4415.359772832985, 4429.025614364835, 4463.4420697412825, 4466.151431228056, 4114.0, 4286.185624731291, 4292.635126014261, 4510.368548403226, 4519.84180553679, 4837.153498137812, 4841.588464980446, 4844.418669759581, 4844.491328410537, 4868.249439066986, 5692.260006199251, 5703.488575527488, 5705.315362156485, 5747.224124743107, 5756.395578464285, 1415.9079659822078, 1428.178797191619, 1430.985690143106, 1431.9546730886511, 1439.7186504011438, 953.3660116022905, 960.6013504395737, 985.2512090810892, 1015.720676813882, 1018.4347687033619, 5392.299001129828, 5410.864728381744, 5436.157395603688, 5440.591955603346, 5469.854833470691, 5636.857993962268, 5649.4633009864, 5651.66090034591, 5657.377688454267, 5662.073995623834, 5290.576753859682, 5351.170568561879, 5374.623776335698, 5386.380566234855, 5420.268263784417, 2919.2847752300822, 2935.706429357047, 2945.4109178164026, 2946.911592652224, 2950.141410911155, 5523.370605671336, 5730.739237367772, 5736.397678243808, 5756.971215143897, 5794.333651630032, 5635.802746903839, 5653.180288858092, 5681.886362272814, 5692.459216374438, 5700.857478563069, 5767.106098554731, 5785.971070144622, 5795.0, 5820.417958204146, 5849.268841394825, 5437.619366644455, 5514.455952333193, 5720.799772007959, 5756.798512052058, 5782.566307527037, 5721.971390143022, 5729.3984131665575, 5749.54003679713, 5750.30996280449, 5767.365589785204, 5829.271341082364, 5947.6431414115295, 6040.0, 6078.72645730952, 6093.60391574564, 4160.50073991123, 4194.573844892751, 4203.180379825904, 4243.172581346607, 4251.95748042528, 5736.340320862987, 5772.960867043972, 5834.0, 5837.211976383303, 5872.500837428866, 5470.0, 5594.328680558359, 5630.904031851182, 5725.799597014251, 5753.424657534213, 5585.525230355465, 5621.065254322073, 5627.718614069198, 5628.380878103323, 5630.268065151504, 5374.0, 5557.166425036277, 5621.976088608179, 5639.323281206118, 5641.689707066151, 5480.150576660624, 5634.0, 5637.379888212376, 5638.661680299195, 5650.378458369658, 5513.558915286848, 5521.475459831309, 5524.364698059614, 5577.298923828272, 5589.496945274945], "value": 4351.606993707029, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [757.8749506331459, 765.5827573972184, 789.7433334166398, 854.9401541892066, 863.9136086391362, 14887.851121488782, 15522.534323970285, 16289.104099274535, 16516.504504864843, 16576.834231657678, 15673.059616423023, 15802.683946321067, 16308.83691163088, 16803.24385402657, 16992.895461794975, 702.3012102957564, 725.9709611615529, 817.3257062923083, 826.9049059358191, 828.4821986258588, 790.3282210121408, 815.502543448496, 821.2813787935556, 827.755812035451, 829.0134739659785, 878.7407714724171, 879.5997820991433, 880.4277219807112, 882.6381183714678, 882.9337799665019, 723.7141329174999, 744.8659241336558, 867.5402036920442, 873.275181599271, 873.6243415331405, 614.9846253843644, 636.3191385217818, 639.4979940746538, 640.6380395076767, 641.0608458608161, 15460.768088478682, 15959.0, 15971.281292341757, 15983.280752366172, 16030.438934637232, 13678.93160534201, 13883.0, 14081.08472949255, 14235.572932812032, 14733.410663573444, 14052.227127507984, 14102.294885255696, 14118.223497707622, 14317.212553309564, 14469.49356772508, 4588.931166032512, 4613.976930115362, 4701.717896926195, 4869.659123861331, 4885.096257192396, 87210.56394718049, 87786.56106719426, 88760.0, 89453.10546894578, 90678.1864362709, 12245.142840001114, 12300.323482208565, 12377.133600647869, 12385.62843114708, 12410.007199424204, 23510.0, 23547.41131471727, 23565.646515302284, 23589.0, 23870.283891483283, 8598.312135029182, 8652.307815374756, 8672.392932494664, 8676.783080422914, 8880.1563851434, 4505.166544189336, 4743.169945259566, 4753.429588449409, 4818.132736107535, 4826.01066781309, 3802.5627052888717, 3833.3291673956946, 3836.3286424875537, 3843.5387753469763, 3899.649031587114, 643.9356064393617, 648.160631981585, 650.869826034795, 658.0228360884083, 666.5001249063203, 779.1468342165319, 786.3591173193829, 797.4736673795268, 799.8887111358424, 811.6550466051905, 10712.645514266938, 11018.50416731249, 11098.833517497244, 11125.332480051224, 11213.66359009231, 678.9117414736053, 724.272106532931, 807.4711064252924, 842.0568962761746, 855.619249433996, 4608.078384323148, 4953.306537084739, 5077.289179514871, 5241.13521268994, 5267.367915850123, 73184.0, 73866.26133738593, 74375.62812185904, 74884.25115748882, 75335.62332188305, 62922.685386572775, 63560.68219658872, 63871.0, 64281.0, 64429.35570644234, 58344.0, 58964.0, 59187.0, 59320.0, 60014.399856000884, 9835.803283934425, 10065.396076235449, 10312.948435257777, 10375.014373634493, 10392.584296628353, 39875.80062099787, 40016.3997540043, 40657.39013914735, 41345.79327103345, 42284.36573451462, 53404.0, 54101.18848217359, 54341.72829135829, 54563.45436545584, 56293.43706562882, 13225.0, 13618.659533511742, 13664.863351366359, 13873.930630347188, 13984.39872362246, 14059.0, 14219.289035548389, 14415.765556338365, 14876.62808429798, 15253.923730381277, 14322.28388580546, 14360.138391696531, 14367.13797172173, 14960.0, 15214.923925380303, 12166.939165304471, 12224.572139975058, 12359.25844449336, 12572.434240459019, 12677.556285529961, 12981.935090324489, 13231.352227686968, 13519.0, 13594.388252528857, 13978.860211398163, 10114.0, 10322.329048611817, 10334.586616535255, 10410.219233557666, 10603.787924241626, 10066.215940579938, 10320.374637627236, 10413.895861041292, 10490.265681402534, 10491.79016419652], "value": 7477.41285018747, "unit": "score"}], "name": "dromaeo_css", "value": 7579.068280301622, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 112.0, 112.0, 111.0, 112.0, 112.0, 112.0, 112.0, 111.0, 112.0], "value": 111.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 116.0, 117.0, 150.0, 119.0, 117.0, 116.0, 116.0, 134.0, 118.0], "value": 124.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 160.0, 161.0, 159.0, 160.0, 160.0, 160.0, 161.0, 162.0], "value": 160.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 110.0, 76.0, 76.0, 76.0, 76.0, 89.0, 76.0], "value": 80.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 113.0, 83.0, 82.0, 82.0, 101.0, 82.0, 82.0, 107.0], "value": 89.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 118.0, 118.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 147.0, 147.0, 147.0, 146.0, 147.0, 146.0, 147.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [47.0, 50.0, 48.0, 49.0, 48.0, 50.0, 49.0, 48.0, 51.0, 50.0], "value": 49.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 63.0, 63.0, 64.0, 63.0, 62.0, 64.0, 63.0, 63.0], "value": 63.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 76.0, 76.0, 75.0, 77.0, 76.0, 77.0, 76.0, 76.0, 75.0], "value": 76.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 130.0, 129.0, 124.0, 120.0, 120.0, 119.0, 119.0, 161.0, 119.0], "value": 126.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 157.0, 158.0, 160.0, 161.0, 157.0, 163.0, 162.0, 159.0, 157.0], "value": 159.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 65.0, 60.0, 61.0, 61.0, 62.0, 62.0, 61.0, 59.0, 61.0], "value": 61.3, "unit": "score"}], "name": "kraken", "value": 1461.3, "alertThreshold": 2.0}]} 12:38:31 INFO - Return code: 0 12:38:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:38:31 ERROR - # TBPL SUCCESS # 12:38:31 INFO - Running post-action listener: _resource_record_post_action 12:38:31 INFO - [mozharness: 2017-01-25 20:38:31.674353Z] Finished run-tests step (success) 12:38:31 INFO - Running post-run listener: _resource_record_post_run 12:38:31 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 356044800; Read time: 12; Write time: 273036 12:38:31 INFO - TinderboxPrint: CPU usage
13.0% 12:38:31 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 12:38:31 INFO - TinderboxPrint: I/O write bytes / time
356,044,800 / 273,036 12:38:31 INFO - TinderboxPrint: CPU idle
8,255.0 (87.0%) 12:38:31 INFO - TinderboxPrint: CPU user
1,191.9 (12.6%) 12:38:31 INFO - TinderboxPrint: Swap in / out
0 / 0 12:38:31 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 112381952; Read time: 0; Write time: 120656 12:38:31 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 242667520; Read time: 12; Write time: 152352 12:38:32 INFO - Running post-run listener: _upload_blobber_files 12:38:32 INFO - Blob upload gear active. 12:38:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:38:32 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 12:38:32 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:38:32 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:38:32 INFO - (blobuploader) - INFO - Open directory for files ... 12:38:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:38:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:38:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:38:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:38:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:38:33 INFO - (blobuploader) - INFO - Done attempting. 12:38:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:38:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:38:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:38:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:38:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:38:36 INFO - (blobuploader) - INFO - Done attempting. 12:38:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 12:38:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:38:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:38:37 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 12:38:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:38:37 INFO - (blobuploader) - INFO - Done attempting. 12:38:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:38:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:38:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:38:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:38:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:38:38 INFO - (blobuploader) - INFO - Done attempting. 12:38:38 INFO - (blobuploader) - INFO - Iteration through files over. 12:38:38 INFO - Return code: 0 12:38:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:38:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:38:38 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/769a92d85703294a110e3af78f6cda09be66d0df3949450b96c125b4bcba7c9620803ae851ea5a3cf6554841e3c7d34943a2076ce17371bf3b0a09f26bafa29b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/160cf43559f914302986a66e27975ed2c4df7f974359cb9496248c0987192069e3aaa927b671f539357bb79c0161c255e51c88bd197407ca4daa6971e997c0bd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2a6b9b884340db1cf49781666c520a3e228a0650b3b713ef581fd529a5186668073f1cbc9a6dbe8067ed3900daaa633ce02ac431efecc53404d2d974afc8f76a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2fd57feeb24285c304d3db44808cd93ac60a22d3f1e2fcf62c126840b134a821a2011390a3f30597e3afed5da198bada50c03b4f5968acb2f062f1c37cc94502"} 12:38:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:38:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:38:38 INFO - Contents: 12:38:38 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/769a92d85703294a110e3af78f6cda09be66d0df3949450b96c125b4bcba7c9620803ae851ea5a3cf6554841e3c7d34943a2076ce17371bf3b0a09f26bafa29b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/160cf43559f914302986a66e27975ed2c4df7f974359cb9496248c0987192069e3aaa927b671f539357bb79c0161c255e51c88bd197407ca4daa6971e997c0bd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2a6b9b884340db1cf49781666c520a3e228a0650b3b713ef581fd529a5186668073f1cbc9a6dbe8067ed3900daaa633ce02ac431efecc53404d2d974afc8f76a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2fd57feeb24285c304d3db44808cd93ac60a22d3f1e2fcf62c126840b134a821a2011390a3f30597e3afed5da198bada50c03b4f5968acb2f062f1c37cc94502"} 12:38:38 INFO - Running post-run listener: copy_logs_to_upload_dir 12:38:38 INFO - Copying logs to upload dir... 12:38:38 INFO - mkdir: /builds/slave/test/build/upload/logs 12:38:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.336714 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2017-01-25 12:38:38.090375) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-25 12:38:38.093687) ========= 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=923d835db2ba3686ebe126b700000192-1485375482.663370-859002171 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/769a92d85703294a110e3af78f6cda09be66d0df3949450b96c125b4bcba7c9620803ae851ea5a3cf6554841e3c7d34943a2076ce17371bf3b0a09f26bafa29b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/160cf43559f914302986a66e27975ed2c4df7f974359cb9496248c0987192069e3aaa927b671f539357bb79c0161c255e51c88bd197407ca4daa6971e997c0bd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2a6b9b884340db1cf49781666c520a3e228a0650b3b713ef581fd529a5186668073f1cbc9a6dbe8067ed3900daaa633ce02ac431efecc53404d2d974afc8f76a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2fd57feeb24285c304d3db44808cd93ac60a22d3f1e2fcf62c126840b134a821a2011390a3f30597e3afed5da198bada50c03b4f5968acb2f062f1c37cc94502"} build_url:https://queue.taskcluster.net/v1/task/BeRKb3tYQXK2MPmttxsCnQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011407 build_url: 'https://queue.taskcluster.net/v1/task/BeRKb3tYQXK2MPmttxsCnQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/769a92d85703294a110e3af78f6cda09be66d0df3949450b96c125b4bcba7c9620803ae851ea5a3cf6554841e3c7d34943a2076ce17371bf3b0a09f26bafa29b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/160cf43559f914302986a66e27975ed2c4df7f974359cb9496248c0987192069e3aaa927b671f539357bb79c0161c255e51c88bd197407ca4daa6971e997c0bd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2a6b9b884340db1cf49781666c520a3e228a0650b3b713ef581fd529a5186668073f1cbc9a6dbe8067ed3900daaa633ce02ac431efecc53404d2d974afc8f76a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2fd57feeb24285c304d3db44808cd93ac60a22d3f1e2fcf62c126840b134a821a2011390a3f30597e3afed5da198bada50c03b4f5968acb2f062f1c37cc94502"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-25 12:38:38.118578) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-25 12:38:38.118867) ========= 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=923d835db2ba3686ebe126b700000192-1485375482.663370-859002171 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004372 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-25 12:38:38.201749) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-25 12:38:38.202031) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-25 12:38:38.202295) ========= ========= Total master_lag: 0.17 =========