builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-045 starttime: 1490094150.7 results: success (0) revision: 1a53aec4fb0dd7685c1ba03489d454a6510b2648 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-21 04:02:30.701867) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-21 04:02:30.702302) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-21 04:02:30.702590) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-21 04:02:30.719949) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 04:02:30.720212) ========= 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=4300f881736b422476174874000001bc-1490094150.521909-1130967365 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-21 04:02:31-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.6M=0s 2017-03-21 04:02:31 (46.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.286648 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 04:02:31.023109) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 04:02:31.023426) ========= 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=4300f881736b422476174874000001bc-1490094150.521909-1130967365 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016671 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 04:02:31.074283) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-21 04:02:31.075023) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 1a53aec4fb0dd7685c1ba03489d454a6510b2648 --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 1a53aec4fb0dd7685c1ba03489d454a6510b2648 --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=4300f881736b422476174874000001bc-1490094150.521909-1130967365 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-21 04:02:31,506 truncating revision to first 12 chars 2017-03-21 04:02:31,507 Setting DEBUG logging. 2017-03-21 04:02:31,507 attempt 1/10 2017-03-21 04:02:31,507 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/1a53aec4fb0d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-21 04:02:32,754 unpacking tar archive at: mozilla-aurora-1a53aec4fb0d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.583197 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-21 04:02:32.671968) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-21 04:02:32.672418) ========= script_repo_revision: 1a53aec4fb0dd7685c1ba03489d454a6510b2648 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-21 04:02:32.672862) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-21 04:02:32.673192) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-21 04:02:32.682384) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-03-21 04:02:32.682690) ========= /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=4300f881736b422476174874000001bc-1490094150.521909-1130967365 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:02:33 INFO - MultiFileLogger online at 20170321 04:02:33 in /builds/slave/test 04:02:33 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 04:02:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:02:33 INFO - {'append_to_log': False, 04:02:33 INFO - 'base_work_dir': '/builds/slave/test', 04:02:33 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 04:02:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:02:33 INFO - 'branch': 'Mozilla-Aurora', 04:02:33 INFO - 'buildbot_json_path': 'buildprops.json', 04:02:33 INFO - 'config_files': ('talos/linux_config.py',), 04:02:33 INFO - 'default_actions': ('clobber', 04:02:33 INFO - 'read-buildbot-config', 04:02:33 INFO - 'download-and-extract', 04:02:33 INFO - 'populate-webroot', 04:02:33 INFO - 'create-virtualenv', 04:02:33 INFO - 'install', 04:02:33 INFO - 'run-tests'), 04:02:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:02:33 INFO - 'download_minidump_stackwalk': True, 04:02:33 INFO - 'download_symbols': 'ondemand', 04:02:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:02:33 INFO - 'tooltool.py': '/tools/tooltool.py', 04:02:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:02:33 INFO - '/tools/misc-python/virtualenv.py')}, 04:02:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:02:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:02:33 INFO - 'gecko_profile': False, 04:02:33 INFO - 'gecko_profile_interval': 0, 04:02:33 INFO - 'installer_path': 'installer.exe', 04:02:33 INFO - 'log_level': 'info', 04:02:33 INFO - 'log_name': 'talos', 04:02:33 INFO - 'log_to_console': True, 04:02:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:02:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:02:33 INFO - 'opt_config_files': (), 04:02:33 INFO - 'pip_index': False, 04:02:33 INFO - 'suite': 'dromaeojs', 04:02:33 INFO - 'system_bits': '32', 04:02:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:02:33 INFO - 'title': 'talos-linux64-ix-045', 04:02:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:02:33 INFO - 'use_talos_json': True, 04:02:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:02:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:02:33 INFO - 'work_dir': 'build'} 04:02:33 INFO - [mozharness: 2017-03-21 11:02:33.205804Z] Running clobber step. 04:02:33 INFO - Running pre-action listener: _resource_record_pre_action 04:02:33 INFO - Running main action method: clobber 04:02:33 INFO - rmtree: /builds/slave/test/build 04:02:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:02:34 INFO - Running post-action listener: _resource_record_post_action 04:02:34 INFO - [mozharness: 2017-03-21 11:02:34.161430Z] Finished clobber step (success) 04:02:34 INFO - [mozharness: 2017-03-21 11:02:34.161530Z] Running read-buildbot-config step. 04:02:34 INFO - Running pre-action listener: _resource_record_pre_action 04:02:34 INFO - Running main action method: read_buildbot_config 04:02:34 INFO - Using buildbot properties: 04:02:34 INFO - { 04:02:34 INFO - "project": "", 04:02:34 INFO - "product": "firefox", 04:02:34 INFO - "who": "cbook@mozilla.com", 04:02:34 INFO - "installer_path": "public/build/target.tar.bz2", 04:02:34 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 04:02:34 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-aurora/", 04:02:34 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 04:02:34 INFO - "stage_platform": "linux64-pgo", 04:02:34 INFO - "basedir": "/builds/slave/test", 04:02:34 INFO - "buildnumber": 1107, 04:02:34 INFO - "platform": "ubuntu64_hw", 04:02:34 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:02:34 INFO - "slavebuilddir": "test", 04:02:34 INFO - "taskId": "AoNYZA_1QmCPvj4fuYCD_Q", 04:02:34 INFO - "branch": "mozilla-aurora", 04:02:34 INFO - "script_repo_revision": "production", 04:02:34 INFO - "revision": "1a53aec4fb0dd7685c1ba03489d454a6510b2648", 04:02:34 INFO - "slavename": "talos-linux64-ix-045", 04:02:34 INFO - "repo_path": "releases/mozilla-aurora" 04:02:34 INFO - } 04:02:34 INFO - Finding installer, test and symbols from parent task. 04:02:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AoNYZA_1QmCPvj4fuYCD_Q'}, attempt #1 04:02:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AoNYZA_1QmCPvj4fuYCD_Q'}, attempt #1 04:02:35 INFO - Task dependencies: fTwnJ8sOQ7KJyY1DWRdvBA 04:02:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fTwnJ8sOQ7KJyY1DWRdvBA'}, attempt #1 04:02:35 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/fTwnJ8sOQ7KJyY1DWRdvBA/artifacts/public/build/target.tar.bz2 04:02:35 INFO - Set test_url: https://queue.taskcluster.net/v1/task/fTwnJ8sOQ7KJyY1DWRdvBA/artifacts/public/build/test_packages.json 04:02:35 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/fTwnJ8sOQ7KJyY1DWRdvBA/artifacts/public/build/target.crashreporter-symbols.zip 04:02:35 INFO - Running post-action listener: _resource_record_post_action 04:02:35 INFO - [mozharness: 2017-03-21 11:02:35.508609Z] Finished read-buildbot-config step (success) 04:02:35 INFO - [mozharness: 2017-03-21 11:02:35.508826Z] Running download-and-extract step. 04:02:35 INFO - Running pre-action listener: _resource_record_pre_action 04:02:35 INFO - Running main action method: download_and_extract 04:02:35 INFO - mkdir: /builds/slave/test/build/tests 04:02:35 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')]} 04:02:35 INFO - trying https://queue.taskcluster.net/v1/task/fTwnJ8sOQ7KJyY1DWRdvBA/artifacts/public/build/target.test_packages.json 04:02:35 INFO - Downloading https://queue.taskcluster.net/v1/task/fTwnJ8sOQ7KJyY1DWRdvBA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 04:02:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fTwnJ8sOQ7KJyY1DWRdvBA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 04:02:36 INFO - Downloaded 896 bytes. 04:02:36 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 04:02:36 INFO - Using the following test package requirements: 04:02:36 INFO - {u'common': [u'target.common.tests.zip'], 04:02:36 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 04:02:36 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 04:02:36 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 04:02:36 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 04:02:36 INFO - u'mozbase': [u'target.common.tests.zip'], 04:02:36 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 04:02:36 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 04:02:36 INFO - u'web-platform': [u'target.common.tests.zip', 04:02:36 INFO - u'target.web-platform.tests.zip'], 04:02:36 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 04:02:36 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 04:02:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fTwnJ8sOQ7KJyY1DWRdvBA/artifacts/public/build/target.common.tests.zip 04:02:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fTwnJ8sOQ7KJyY1DWRdvBA/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:02:36 INFO - Fetch https://queue.taskcluster.net/v1/task/fTwnJ8sOQ7KJyY1DWRdvBA/artifacts/public/build/target.common.tests.zip into memory 04:02:37 INFO - Expected file size: 59533728 04:02:37 INFO - Obtained file size: 59533728 04:02:47 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 04:02:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fTwnJ8sOQ7KJyY1DWRdvBA/artifacts/public/build/target.common.tests.zip 04:02:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fTwnJ8sOQ7KJyY1DWRdvBA/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:02:47 INFO - Fetch https://queue.taskcluster.net/v1/task/fTwnJ8sOQ7KJyY1DWRdvBA/artifacts/public/build/target.common.tests.zip into memory 04:02:48 INFO - Expected file size: 59533728 04:02:48 INFO - Obtained file size: 59533728 04:02:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fTwnJ8sOQ7KJyY1DWRdvBA/artifacts/public/build/target.talos.tests.zip 04:02:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fTwnJ8sOQ7KJyY1DWRdvBA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 04:02:58 INFO - Fetch https://queue.taskcluster.net/v1/task/fTwnJ8sOQ7KJyY1DWRdvBA/artifacts/public/build/target.talos.tests.zip into memory 04:03:00 INFO - Expected file size: 14404438 04:03:00 INFO - Obtained file size: 14404438 04:03:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:03:00 INFO - trying https://queue.taskcluster.net/v1/task/fTwnJ8sOQ7KJyY1DWRdvBA/artifacts/public/build/target.tar.bz2 04:03:00 INFO - Downloading https://queue.taskcluster.net/v1/task/fTwnJ8sOQ7KJyY1DWRdvBA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 04:03:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fTwnJ8sOQ7KJyY1DWRdvBA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 04:03:03 INFO - Downloaded 66667222 bytes. 04:03:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fTwnJ8sOQ7KJyY1DWRdvBA/artifacts/public/build/target.tar.bz2 04:03:03 INFO - mkdir: /builds/slave/test/properties 04:03:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:03:03 INFO - Writing to file /builds/slave/test/properties/build_url 04:03:03 INFO - Contents: 04:03:03 INFO - build_url:https://queue.taskcluster.net/v1/task/fTwnJ8sOQ7KJyY1DWRdvBA/artifacts/public/build/target.tar.bz2 04:03:03 INFO - Running post-action listener: _resource_record_post_action 04:03:03 INFO - Running post-action listener: set_extra_try_arguments 04:03:03 INFO - [mozharness: 2017-03-21 11:03:03.824282Z] Finished download-and-extract step (success) 04:03:03 INFO - [mozharness: 2017-03-21 11:03:03.824378Z] Running populate-webroot step. 04:03:03 INFO - Running pre-action listener: _resource_record_pre_action 04:03:03 INFO - Running main action method: populate_webroot 04:03:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:03:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:03:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:03:03 INFO - '--tppagecycles', 04:03:03 INFO - '7'], 04:03:03 INFO - 'tests': ['tsvgm']}}, 04:03:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:03:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:03:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:03:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:03:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:03:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:03:03 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:03:03 INFO - 'talos_options': ['--disable-e10s'], 04:03:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:03:03 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:03:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:03:03 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:03:03 INFO - 'talos_options': ['--disable-e10s'], 04:03:03 INFO - 'tests': ['damp', 'tps']}, 04:03:03 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:03:03 INFO - 'tests': ['damp', 'tps']}, 04:03:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:03:03 INFO - 'tests': ['dromaeo_dom']}, 04:03:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:03:03 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:03:03 INFO - 'tests': ['basic_compositor_video']}, 04:03:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:03:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:03:03 INFO - 'tests': ['a11yr', 04:03:03 INFO - 'ts_paint', 04:03:03 INFO - 'tpaint', 04:03:03 INFO - 'sessionrestore', 04:03:03 INFO - 'sessionrestore_no_auto_restore', 04:03:03 INFO - 'tabpaint']}, 04:03:03 INFO - 'other-e10s': {'tests': ['a11yr', 04:03:03 INFO - 'ts_paint', 04:03:03 INFO - 'tpaint', 04:03:03 INFO - 'sessionrestore', 04:03:03 INFO - 'sessionrestore_no_auto_restore', 04:03:03 INFO - 'tabpaint']}, 04:03:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:03:03 INFO - 'ts_paint', 04:03:03 INFO - 'tpaint', 04:03:03 INFO - 'sessionrestore', 04:03:03 INFO - 'sessionrestore_no_auto_restore', 04:03:03 INFO - 'tabpaint']}, 04:03:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:03:03 INFO - 'ts_paint', 04:03:03 INFO - 'tpaint', 04:03:03 INFO - 'sessionrestore', 04:03:03 INFO - 'sessionrestore_no_auto_restore', 04:03:03 INFO - 'tabpaint']}, 04:03:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:03:03 INFO - 'tests': ['a11yr', 04:03:03 INFO - 'ts_paint', 04:03:03 INFO - 'tpaint', 04:03:03 INFO - 'sessionrestore', 04:03:03 INFO - 'sessionrestore_no_auto_restore', 04:03:03 INFO - 'tabpaint']}, 04:03:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:03:03 INFO - 'tests': ['a11yr', 04:03:03 INFO - 'ts_paint', 04:03:03 INFO - 'tpaint', 04:03:03 INFO - 'sessionrestore', 04:03:03 INFO - 'sessionrestore_no_auto_restore', 04:03:03 INFO - 'tabpaint']}, 04:03:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:03:03 INFO - 'tests': ['tsvgx', 04:03:03 INFO - 'tsvgr_opacity', 04:03:03 INFO - 'tart', 04:03:03 INFO - 'tscrollx', 04:03:03 INFO - 'cart', 04:03:03 INFO - 'tsvg_static']}, 04:03:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:03:03 INFO - 'tsvgr_opacity', 04:03:03 INFO - 'tart', 04:03:03 INFO - 'tscrollx', 04:03:03 INFO - 'cart', 04:03:03 INFO - 'tsvg_static']}, 04:03:03 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:03:03 INFO - 'talos_options': ['--disable-e10s'], 04:03:03 INFO - 'tests': ['tp5o']}, 04:03:03 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:03:03 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:03:03 INFO - 'talos_options': ['--disable-e10s', 04:03:03 INFO - '--xperf_path', 04:03:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:03:03 INFO - 'tests': ['tp5n']}, 04:03:03 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:03:03 INFO - 'talos_options': ['--xperf_path', 04:03:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:03:03 INFO - 'tests': ['tp5n']}}, 04:03:03 INFO - 'talos.zip': {'path': '', 04:03:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:03:03 INFO - Running post-action listener: _resource_record_post_action 04:03:03 INFO - [mozharness: 2017-03-21 11:03:03.844518Z] Finished populate-webroot step (success) 04:03:03 INFO - [mozharness: 2017-03-21 11:03:03.844608Z] Running create-virtualenv step. 04:03:03 INFO - Running pre-action listener: _resource_record_pre_action 04:03:03 INFO - Running main action method: create_virtualenv 04:03:03 INFO - Creating virtualenv /builds/slave/test/build/venv 04:03:03 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 04:03:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:03:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:03:03 INFO - Using real prefix '/usr' 04:03:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:03:04 INFO - Installing distribute.............................................................................................................................................................................................done. 04:03:06 INFO - Installing pip.................done. 04:03:06 INFO - Return code: 0 04:03:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:03:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:03:06 INFO - Reading from file tmpfile_stdout 04:03:06 INFO - Output received: 04:03:06 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) 04:03:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:03: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')]} 04:03:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:03:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:03: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')]} 04:03:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:03:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:03:06 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 0xf0b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1003a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11a8b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a6290>, '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 0x11a6b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11a7040>, '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': '4300f881736b422476174874000001bc-1490094150.521909-1130967365', '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 04:03:06 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 04:03:06 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 04:03:06 INFO - Using env: {'DISPLAY': ':0', 04:03:06 INFO - 'HOME': '/home/cltbld', 04:03:06 INFO - 'LANG': 'en_US.UTF-8', 04:03:06 INFO - 'LANGUAGE': 'en_US:en', 04:03:06 INFO - 'LOGNAME': 'cltbld', 04:03:06 INFO - 'MAIL': '/var/mail/cltbld', 04:03:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:03:06 INFO - 'MOZ_NO_REMOTE': '1', 04:03:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:03:06 INFO - 'NO_EM_RESTART': '1', 04:03:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:03:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:03:06 INFO - 'PWD': '/builds/slave/test', 04:03:06 INFO - 'SHELL': '/bin/bash', 04:03:06 INFO - 'SHLVL': '1', 04:03:06 INFO - 'TERM': 'linux', 04:03:06 INFO - 'TMOUT': '86400', 04:03:06 INFO - 'USER': 'cltbld', 04:03:06 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1490094150.521909-1130967365', 04:03:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:03:06 INFO - '_': '/tools/buildbot/bin/python'} 04:03:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:03:06 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 04:03:06 INFO - Cleaning up... 04:03:06 INFO - Return code: 0 04:03:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:03: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')]} 04:03:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:03:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:03: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')]} 04:03:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:03:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:03:06 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 0xf0b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1003a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11a8b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a6290>, '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 0x11a6b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11a7040>, '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': '4300f881736b422476174874000001bc-1490094150.521909-1130967365', '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 04:03:06 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 04:03:06 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 04:03:06 INFO - Using env: {'DISPLAY': ':0', 04:03:06 INFO - 'HOME': '/home/cltbld', 04:03:06 INFO - 'LANG': 'en_US.UTF-8', 04:03:06 INFO - 'LANGUAGE': 'en_US:en', 04:03:06 INFO - 'LOGNAME': 'cltbld', 04:03:06 INFO - 'MAIL': '/var/mail/cltbld', 04:03:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:03:06 INFO - 'MOZ_NO_REMOTE': '1', 04:03:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:03:06 INFO - 'NO_EM_RESTART': '1', 04:03:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:03:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:03:06 INFO - 'PWD': '/builds/slave/test', 04:03:06 INFO - 'SHELL': '/bin/bash', 04:03:06 INFO - 'SHLVL': '1', 04:03:06 INFO - 'TERM': 'linux', 04:03:06 INFO - 'TMOUT': '86400', 04:03:06 INFO - 'USER': 'cltbld', 04:03:06 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1490094150.521909-1130967365', 04:03:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:03:06 INFO - '_': '/tools/buildbot/bin/python'} 04:03:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:03:07 INFO - Downloading/unpacking psutil>=3.1.1 04:03:07 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 04:03:07 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 04:03:07 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 04:03:07 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 04:03:07 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 04:03:07 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 04:03:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:03:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:03:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:03:09 INFO - Installing collected packages: psutil 04:03:09 INFO - Running setup.py install for psutil 04:03:09 INFO - building 'psutil._psutil_linux' extension 04:03:09 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 04:03:09 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 04:03:09 INFO - building 'psutil._psutil_posix' extension 04:03:09 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 04:03:09 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 04:03:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:03:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:03:09 INFO - Successfully installed psutil 04:03:09 INFO - Cleaning up... 04:03:09 INFO - Return code: 0 04:03:09 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:03:09 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')]} 04:03:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:03:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:03:09 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')]} 04:03:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:03:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:03:09 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 0xf0b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1003a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11a8b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a6290>, '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 0x11a6b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11a7040>, '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': '4300f881736b422476174874000001bc-1490094150.521909-1130967365', '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 04:03:09 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 04:03:09 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 04:03:09 INFO - Using env: {'DISPLAY': ':0', 04:03:09 INFO - 'HOME': '/home/cltbld', 04:03:09 INFO - 'LANG': 'en_US.UTF-8', 04:03:09 INFO - 'LANGUAGE': 'en_US:en', 04:03:09 INFO - 'LOGNAME': 'cltbld', 04:03:09 INFO - 'MAIL': '/var/mail/cltbld', 04:03:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:03:09 INFO - 'MOZ_NO_REMOTE': '1', 04:03:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:03:09 INFO - 'NO_EM_RESTART': '1', 04:03:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:03:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:03:09 INFO - 'PWD': '/builds/slave/test', 04:03:09 INFO - 'SHELL': '/bin/bash', 04:03:09 INFO - 'SHLVL': '1', 04:03:09 INFO - 'TERM': 'linux', 04:03:09 INFO - 'TMOUT': '86400', 04:03:09 INFO - 'USER': 'cltbld', 04:03:09 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1490094150.521909-1130967365', 04:03:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:03:09 INFO - '_': '/tools/buildbot/bin/python'} 04:03:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:03:10 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:03:10 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 04:03:10 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 04:03:10 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 04:03:10 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 04:03:10 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 04:03:10 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 04:03:12 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:03:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:03:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:03:12 INFO - Installing collected packages: mozsystemmonitor 04:03:12 INFO - Running setup.py install for mozsystemmonitor 04:03:12 INFO - Successfully installed mozsystemmonitor 04:03:12 INFO - Cleaning up... 04:03:12 INFO - Return code: 0 04:03:12 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:03:12 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')]} 04:03:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:03:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:03:12 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')]} 04:03:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:03:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:03:12 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 0xf0b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1003a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11a8b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a6290>, '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 0x11a6b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11a7040>, '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': '4300f881736b422476174874000001bc-1490094150.521909-1130967365', '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 04:03:12 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 04:03:12 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 04:03:12 INFO - Using env: {'DISPLAY': ':0', 04:03:12 INFO - 'HOME': '/home/cltbld', 04:03:12 INFO - 'LANG': 'en_US.UTF-8', 04:03:12 INFO - 'LANGUAGE': 'en_US:en', 04:03:12 INFO - 'LOGNAME': 'cltbld', 04:03:12 INFO - 'MAIL': '/var/mail/cltbld', 04:03:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:03:12 INFO - 'MOZ_NO_REMOTE': '1', 04:03:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:03:12 INFO - 'NO_EM_RESTART': '1', 04:03:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:03:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:03:12 INFO - 'PWD': '/builds/slave/test', 04:03:12 INFO - 'SHELL': '/bin/bash', 04:03:12 INFO - 'SHLVL': '1', 04:03:12 INFO - 'TERM': 'linux', 04:03:12 INFO - 'TMOUT': '86400', 04:03:12 INFO - 'USER': 'cltbld', 04:03:12 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1490094150.521909-1130967365', 04:03:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:03:12 INFO - '_': '/tools/buildbot/bin/python'} 04:03:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:03:12 INFO - Downloading/unpacking jsonschema==2.5.1 04:03:12 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 04:03:12 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 04:03:12 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 04:03:12 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 04:03:12 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 04:03:12 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 04:03:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:03:14 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:03:14 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 04:03:14 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 04:03:14 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 04:03:14 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 04:03:14 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 04:03:14 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 04:03:14 INFO - Downloading functools32-3.2.3-2.tar.gz 04:03:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:03:14 INFO - warning: no files found matching '*.txt' 04:03:14 INFO - no previously-included directories found matching 'build' 04:03:14 INFO - no previously-included directories found matching 'dist' 04:03:14 INFO - no previously-included directories found matching '.git*' 04:03:14 INFO - Installing collected packages: jsonschema, functools32 04:03:15 INFO - Running setup.py install for functools32 04:03:15 INFO - warning: no files found matching '*.txt' 04:03:15 INFO - no previously-included directories found matching 'build' 04:03:15 INFO - no previously-included directories found matching 'dist' 04:03:15 INFO - no previously-included directories found matching '.git*' 04:03:15 INFO - Successfully installed jsonschema functools32 04:03:15 INFO - Cleaning up... 04:03:15 INFO - Return code: 0 04:03:15 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:03:15 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')]} 04:03:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:03:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:03:15 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')]} 04:03:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:03:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:03:15 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 0xf0b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1003a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11a8b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a6290>, '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 0x11a6b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11a7040>, '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': '4300f881736b422476174874000001bc-1490094150.521909-1130967365', '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 04:03:15 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 04:03:15 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 04:03:15 INFO - Using env: {'DISPLAY': ':0', 04:03:15 INFO - 'HOME': '/home/cltbld', 04:03:15 INFO - 'LANG': 'en_US.UTF-8', 04:03:15 INFO - 'LANGUAGE': 'en_US:en', 04:03:15 INFO - 'LOGNAME': 'cltbld', 04:03:15 INFO - 'MAIL': '/var/mail/cltbld', 04:03:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:03:15 INFO - 'MOZ_NO_REMOTE': '1', 04:03:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:03:15 INFO - 'NO_EM_RESTART': '1', 04:03:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:03:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:03:15 INFO - 'PWD': '/builds/slave/test', 04:03:15 INFO - 'SHELL': '/bin/bash', 04:03:15 INFO - 'SHLVL': '1', 04:03:15 INFO - 'TERM': 'linux', 04:03:15 INFO - 'TMOUT': '86400', 04:03:15 INFO - 'USER': 'cltbld', 04:03:15 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1490094150.521909-1130967365', 04:03:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:03:15 INFO - '_': '/tools/buildbot/bin/python'} 04:03:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:03:15 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:03:15 INFO - Cleaning up... 04:03:15 INFO - Return code: 0 04:03:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:03:15 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')]} 04:03:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:03:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:03:15 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')]} 04:03:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:03:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:03:15 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 0xf0b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1003a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11a8b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a6290>, '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 0x11a6b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11a7040>, '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': '4300f881736b422476174874000001bc-1490094150.521909-1130967365', '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 04:03:15 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 04:03:15 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 04:03:15 INFO - Using env: {'DISPLAY': ':0', 04:03:15 INFO - 'HOME': '/home/cltbld', 04:03:15 INFO - 'LANG': 'en_US.UTF-8', 04:03:15 INFO - 'LANGUAGE': 'en_US:en', 04:03:15 INFO - 'LOGNAME': 'cltbld', 04:03:15 INFO - 'MAIL': '/var/mail/cltbld', 04:03:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:03:15 INFO - 'MOZ_NO_REMOTE': '1', 04:03:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:03:15 INFO - 'NO_EM_RESTART': '1', 04:03:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:03:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:03:15 INFO - 'PWD': '/builds/slave/test', 04:03:15 INFO - 'SHELL': '/bin/bash', 04:03:15 INFO - 'SHLVL': '1', 04:03:15 INFO - 'TERM': 'linux', 04:03:15 INFO - 'TMOUT': '86400', 04:03:15 INFO - 'USER': 'cltbld', 04:03:15 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1490094150.521909-1130967365', 04:03:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:03:15 INFO - '_': '/tools/buildbot/bin/python'} 04:03:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:03:15 INFO - Downloading/unpacking blobuploader==1.2.4 04:03:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:03:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:03:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:03:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:03:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:03:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:03:17 INFO - Downloading blobuploader-1.2.4.tar.gz 04:03:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:03:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:03:17 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 04:03:17 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 04:03:17 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 04:03:17 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 04:03:17 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 04:03:17 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 04:03:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:03:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:03:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:03:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:03:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:03:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:03:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:03:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:03:18 INFO - Downloading docopt-0.6.1.tar.gz 04:03:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:03:18 INFO - Installing collected packages: blobuploader, requests, docopt 04:03:18 INFO - Running setup.py install for blobuploader 04:03:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:03:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:03:18 INFO - Running setup.py install for requests 04:03:18 INFO - Running setup.py install for docopt 04:03:18 INFO - Successfully installed blobuploader requests docopt 04:03:18 INFO - Cleaning up... 04:03:19 INFO - Return code: 0 04:03:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:03:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:03:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:03:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:03:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:03:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:03:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:03:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf0b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1003a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11a8b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a6290>, '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 0x11a6b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11a7040>, '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': '4300f881736b422476174874000001bc-1490094150.521909-1130967365', '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 04:03:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:03:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:03:19 INFO - Using env: {'DISPLAY': ':0', 04:03:19 INFO - 'HOME': '/home/cltbld', 04:03:19 INFO - 'LANG': 'en_US.UTF-8', 04:03:19 INFO - 'LANGUAGE': 'en_US:en', 04:03:19 INFO - 'LOGNAME': 'cltbld', 04:03:19 INFO - 'MAIL': '/var/mail/cltbld', 04:03:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:03:19 INFO - 'MOZ_NO_REMOTE': '1', 04:03:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:03:19 INFO - 'NO_EM_RESTART': '1', 04:03:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:03:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:03:19 INFO - 'PWD': '/builds/slave/test', 04:03:19 INFO - 'SHELL': '/bin/bash', 04:03:19 INFO - 'SHLVL': '1', 04:03:19 INFO - 'TERM': 'linux', 04:03:19 INFO - 'TMOUT': '86400', 04:03:19 INFO - 'USER': 'cltbld', 04:03:19 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1490094150.521909-1130967365', 04:03:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:03:19 INFO - '_': '/tools/buildbot/bin/python'} 04:03:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:03:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:03:19 INFO - Running setup.py (path:/tmp/pip-5RKSVp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:03:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:03:19 INFO - Running setup.py (path:/tmp/pip-fON0xB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:03:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:03:19 INFO - Running setup.py (path:/tmp/pip-_ufiO0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:03:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:03:19 INFO - Running setup.py (path:/tmp/pip-O3Y8xV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:03:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:03:19 INFO - Running setup.py (path:/tmp/pip-WVko_X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:03:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:03:19 INFO - Running setup.py (path:/tmp/pip-PKiCYZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:03:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:03:19 INFO - Running setup.py (path:/tmp/pip-eqGCuW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:03:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:03:19 INFO - Running setup.py (path:/tmp/pip-fJ5FFt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:03:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:03:19 INFO - Running setup.py (path:/tmp/pip-kHqlcS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:03:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:03:19 INFO - Running setup.py (path:/tmp/pip-cS4yKC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:03:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:03:19 INFO - Running setup.py (path:/tmp/pip-o5qOIf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:03:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:03:20 INFO - Running setup.py (path:/tmp/pip-QYB3Gz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:03:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:03:20 INFO - Running setup.py (path:/tmp/pip-nmxTQM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:03:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:03:20 INFO - Running setup.py (path:/tmp/pip-ceOCWM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:03:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:03:20 INFO - Running setup.py (path:/tmp/pip-VYuN7F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:03:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:03:20 INFO - Running setup.py (path:/tmp/pip-UQT4Y3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:03:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:03:20 INFO - Running setup.py (path:/tmp/pip-ye0A_V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:03:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:03:20 INFO - Running setup.py install for manifestparser 04:03:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:03:20 INFO - Running setup.py install for mozcrash 04:03:20 INFO - Running setup.py install for mozdebug 04:03:20 INFO - Running setup.py install for mozdevice 04:03:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:03:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:03:20 INFO - Running setup.py install for mozfile 04:03:21 INFO - Running setup.py install for mozhttpd 04:03:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:03:21 INFO - Running setup.py install for mozinfo 04:03:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:03:21 INFO - Running setup.py install for mozInstall 04:03:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:03:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:03:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:03:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:03:21 INFO - Running setup.py install for mozleak 04:03:21 INFO - Running setup.py install for mozlog 04:03:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:03:21 INFO - Running setup.py install for moznetwork 04:03:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:03:21 INFO - Running setup.py install for mozprocess 04:03:21 INFO - Running setup.py install for mozprofile 04:03:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:03:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:03:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:03:21 INFO - Running setup.py install for mozrunner 04:03:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:03:21 INFO - Running setup.py install for mozscreenshot 04:03:22 INFO - Running setup.py install for moztest 04:03:22 INFO - Running setup.py install for mozversion 04:03:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:03:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:03:22 INFO - Cleaning up... 04:03:22 INFO - Return code: 0 04:03:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:03: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')]} 04:03:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:03:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:03: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')]} 04:03:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:03:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:03:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf0b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1003a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11a8b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a6290>, '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 0x11a6b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11a7040>, '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': '4300f881736b422476174874000001bc-1490094150.521909-1130967365', '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 04:03:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:03:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:03:22 INFO - Using env: {'DISPLAY': ':0', 04:03:22 INFO - 'HOME': '/home/cltbld', 04:03:22 INFO - 'LANG': 'en_US.UTF-8', 04:03:22 INFO - 'LANGUAGE': 'en_US:en', 04:03:22 INFO - 'LOGNAME': 'cltbld', 04:03:22 INFO - 'MAIL': '/var/mail/cltbld', 04:03:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:03:22 INFO - 'MOZ_NO_REMOTE': '1', 04:03:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:03:22 INFO - 'NO_EM_RESTART': '1', 04:03:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:03:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:03:22 INFO - 'PWD': '/builds/slave/test', 04:03:22 INFO - 'SHELL': '/bin/bash', 04:03:22 INFO - 'SHLVL': '1', 04:03:22 INFO - 'TERM': 'linux', 04:03:22 INFO - 'TMOUT': '86400', 04:03:22 INFO - 'USER': 'cltbld', 04:03:22 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1490094150.521909-1130967365', 04:03:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:03:22 INFO - '_': '/tools/buildbot/bin/python'} 04:03:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:03:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:03:22 INFO - Running setup.py (path:/tmp/pip-Avod3A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:03:22 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)) 04:03:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:03:22 INFO - Running setup.py (path:/tmp/pip-KILzKr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:03:22 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)) 04:03:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:03:22 INFO - Running setup.py (path:/tmp/pip-UZvlZ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:03:22 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)) 04:03:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:03:22 INFO - Running setup.py (path:/tmp/pip-7uf6M1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:03:22 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)) 04:03:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:03:22 INFO - Running setup.py (path:/tmp/pip-2SYqS4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:03:22 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)) 04:03:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:03:22 INFO - Running setup.py (path:/tmp/pip-wBbaMz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:03:22 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)) 04:03:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:03:22 INFO - Running setup.py (path:/tmp/pip-w1qZAz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:03:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:03:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:03:23 INFO - Running setup.py (path:/tmp/pip-OSUPTe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:03:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:03:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:03:23 INFO - Running setup.py (path:/tmp/pip-ZObiRP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:03:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:03:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:03:23 INFO - Running setup.py (path:/tmp/pip-_muK02-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:03:23 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)) 04:03:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:03:23 INFO - Running setup.py (path:/tmp/pip-Zx20A1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:03:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:03:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:03:23 INFO - Running setup.py (path:/tmp/pip-Nub7EY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:03:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:03:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:03:23 INFO - Running setup.py (path:/tmp/pip-uttJ1z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:03:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:03:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:03:23 INFO - Running setup.py (path:/tmp/pip-MGYTS_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:03:23 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)) 04:03:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:03:23 INFO - Running setup.py (path:/tmp/pip-IdbDWh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:03:23 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)) 04:03:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:03:23 INFO - Running setup.py (path:/tmp/pip-6r1Adn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:03:23 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)) 04:03:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:03:23 INFO - Running setup.py (path:/tmp/pip-dtZvWD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:03:23 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)) 04:03:23 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)) 04:03:23 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)) 04:03:23 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)) 04:03:23 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)) 04:03:23 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)) 04:03:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:03:23 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 04:03:23 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 04:03:23 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 04:03:23 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 04:03:23 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 04:03:23 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 04:03:25 INFO - Downloading blessings-1.6.tar.gz 04:03:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:03:25 INFO - Installing collected packages: blessings 04:03:25 INFO - Running setup.py install for blessings 04:03:25 INFO - Successfully installed blessings 04:03:25 INFO - Cleaning up... 04:03:26 INFO - Return code: 0 04:03:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:03:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:03:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:03:26 INFO - Reading from file tmpfile_stdout 04:03:26 INFO - Current package versions: 04:03:26 INFO - argparse == 1.2.1 04:03:26 INFO - blessings == 1.6 04:03:26 INFO - blobuploader == 1.2.4 04:03:26 INFO - docopt == 0.6.1 04:03:26 INFO - functools32 == 3.2.3-2 04:03:26 INFO - jsonschema == 2.5.1 04:03:26 INFO - manifestparser == 1.1 04:03:26 INFO - mozInstall == 1.12 04:03:26 INFO - mozcrash == 1.0 04:03:26 INFO - mozdebug == 0.1 04:03:26 INFO - mozdevice == 0.49 04:03:26 INFO - mozfile == 1.2 04:03:26 INFO - mozhttpd == 0.7 04:03:26 INFO - mozinfo == 0.9 04:03:26 INFO - mozleak == 0.1 04:03:26 INFO - mozlog == 3.4 04:03:26 INFO - moznetwork == 0.27 04:03:26 INFO - mozprocess == 0.25 04:03:26 INFO - mozprofile == 0.28 04:03:26 INFO - mozrunner == 6.13 04:03:26 INFO - mozscreenshot == 0.1 04:03:26 INFO - mozsystemmonitor == 0.3 04:03:26 INFO - moztest == 0.8 04:03:26 INFO - mozversion == 1.4 04:03:26 INFO - psutil == 3.1.1 04:03:26 INFO - requests == 1.2.3 04:03:26 INFO - wsgiref == 0.1.2 04:03:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:03:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:03:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:03:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:03:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:03:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:03:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:03:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf0b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1003a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11a8b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a6290>, '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 0x11a6b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11a7040>, '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': '4300f881736b422476174874000001bc-1490094150.521909-1130967365', '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 04:03:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:03:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:03:26 INFO - Using env: {'DISPLAY': ':0', 04:03:26 INFO - 'HOME': '/home/cltbld', 04:03:26 INFO - 'LANG': 'en_US.UTF-8', 04:03:26 INFO - 'LANGUAGE': 'en_US:en', 04:03:26 INFO - 'LOGNAME': 'cltbld', 04:03:26 INFO - 'MAIL': '/var/mail/cltbld', 04:03:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:03:26 INFO - 'MOZ_NO_REMOTE': '1', 04:03:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:03:26 INFO - 'NO_EM_RESTART': '1', 04:03:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:03:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:03:26 INFO - 'PWD': '/builds/slave/test', 04:03:26 INFO - 'SHELL': '/bin/bash', 04:03:26 INFO - 'SHLVL': '1', 04:03:26 INFO - 'TERM': 'linux', 04:03:26 INFO - 'TMOUT': '86400', 04:03:26 INFO - 'USER': 'cltbld', 04:03:26 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1490094150.521909-1130967365', 04:03:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:03:26 INFO - '_': '/tools/buildbot/bin/python'} 04:03:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:03:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:03:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:03:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:03:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:03:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:03:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:03:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:03:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:03:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:03:26 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:03:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:03:26 INFO - Cleaning up... 04:03:26 INFO - Return code: 0 04:03:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:03:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:03:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:03:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:03:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:03:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:03:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:03:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf0b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1003a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11a8b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a6290>, '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 0x11a6b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11a7040>, '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': '4300f881736b422476174874000001bc-1490094150.521909-1130967365', '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 04:03:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:03:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:03:26 INFO - Using env: {'DISPLAY': ':0', 04:03:26 INFO - 'HOME': '/home/cltbld', 04:03:26 INFO - 'LANG': 'en_US.UTF-8', 04:03:26 INFO - 'LANGUAGE': 'en_US:en', 04:03:26 INFO - 'LOGNAME': 'cltbld', 04:03:26 INFO - 'MAIL': '/var/mail/cltbld', 04:03:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:03:26 INFO - 'MOZ_NO_REMOTE': '1', 04:03:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:03:26 INFO - 'NO_EM_RESTART': '1', 04:03:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:03:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:03:26 INFO - 'PWD': '/builds/slave/test', 04:03:26 INFO - 'SHELL': '/bin/bash', 04:03:26 INFO - 'SHLVL': '1', 04:03:26 INFO - 'TERM': 'linux', 04:03:26 INFO - 'TMOUT': '86400', 04:03:26 INFO - 'USER': 'cltbld', 04:03:26 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1490094150.521909-1130967365', 04:03:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:03:26 INFO - '_': '/tools/buildbot/bin/python'} 04:03:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:03:26 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:03:26 INFO - Cleaning up... 04:03:26 INFO - Return code: 0 04:03:26 INFO - Running post-action listener: _resource_record_post_action 04:03:26 INFO - Running post-action listener: _start_resource_monitoring 04:03:26 INFO - Starting resource monitoring. 04:03:26 INFO - [mozharness: 2017-03-21 11:03:26.738808Z] Finished create-virtualenv step (success) 04:03:26 INFO - [mozharness: 2017-03-21 11:03:26.739276Z] Running install step. 04:03:26 INFO - Running pre-action listener: _resource_record_pre_action 04:03:26 INFO - Running main action method: install 04:03:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:03:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:03:26 INFO - Reading from file tmpfile_stdout 04:03:26 INFO - Detecting whether we're running mozinstall >=1.0... 04:03:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:03:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:03:27 INFO - Reading from file tmpfile_stdout 04:03:27 INFO - Output received: 04:03:27 INFO - Usage: mozinstall [options] installer 04:03:27 INFO - Options: 04:03:27 INFO - -h, --help show this help message and exit 04:03:27 INFO - -d DEST, --destination=DEST 04:03:27 INFO - Directory to install application into. [default: 04:03:27 INFO - "/builds/slave/test"] 04:03:27 INFO - --app=APP Application being installed. [default: firefox] 04:03:27 INFO - mkdir: /builds/slave/test/build/application 04:03:27 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'] 04:03:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 04:03:43 INFO - Reading from file tmpfile_stdout 04:03:43 INFO - Output received: 04:03:43 INFO - /builds/slave/test/build/application/firefox/firefox 04:03:43 INFO - Running post-action listener: _resource_record_post_action 04:03:43 INFO - [mozharness: 2017-03-21 11:03:43.618110Z] Finished install step (success) 04:03:43 INFO - [mozharness: 2017-03-21 11:03:43.618388Z] Running run-tests step. 04:03:43 INFO - Running pre-action listener: _resource_record_pre_action 04:03:43 INFO - Running main action method: run_tests 04:03:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:03:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:03:43 INFO - Python 2.7.3 04:03:43 INFO - Return code: 0 04:03:43 INFO - grabbing minidump binary from tooltool 04:03:43 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')]} 04:03:43 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 0x11a6290>, '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 0x11a6b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11a7040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:03:43 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 04:03:43 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 04:03:43 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 04:03:43 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:03:43 INFO - Return code: 0 04:03:43 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:03:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:03:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:03:43 INFO - ENV: RUST_BACKTRACE is now 1 04:03:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:03:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:03:43 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/fTwnJ8sOQ7KJyY1DWRdvBA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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 04:03:43 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/fTwnJ8sOQ7KJyY1DWRdvBA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-045 --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 04:03:43 INFO - Using env: {'DISPLAY': ':0', 04:03:43 INFO - 'HOME': '/home/cltbld', 04:03:43 INFO - 'LANG': 'en_US.UTF-8', 04:03:43 INFO - 'LANGUAGE': 'en_US:en', 04:03:43 INFO - 'LOGNAME': 'cltbld', 04:03:43 INFO - 'MAIL': '/var/mail/cltbld', 04:03:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:03:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:03:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:03:43 INFO - 'MOZ_NO_REMOTE': '1', 04:03:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:03:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:03:43 INFO - 'NO_EM_RESTART': '1', 04:03:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:03:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:03:43 INFO - 'PWD': '/builds/slave/test', 04:03:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:03:43 INFO - 'RUST_BACKTRACE': '1', 04:03:43 INFO - 'SHELL': '/bin/bash', 04:03:43 INFO - 'SHLVL': '1', 04:03:43 INFO - 'TERM': 'linux', 04:03:43 INFO - 'TMOUT': '86400', 04:03:43 INFO - 'USER': 'cltbld', 04:03:43 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1490094150.521909-1130967365', 04:03:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:03:43 INFO - '_': '/tools/buildbot/bin/python'} 04:03:43 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/fTwnJ8sOQ7KJyY1DWRdvBA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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 04:03:43 INFO - mozversion application_buildid: 20170321101027 04:03:43 INFO - mozversion application_changeset: 1a53aec4fb0dd7685c1ba03489d454a6510b2648 04:03:43 INFO - mozversion application_display_name: FirefoxDeveloperEdition 04:03:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:03:43 INFO - mozversion application_name: Firefox 04:03:43 INFO - mozversion application_remotingname: firefox-dev 04:03:43 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:03:43 INFO - mozversion application_vendor: Mozilla 04:03:43 INFO - mozversion application_version: 54.0a2 04:03:43 INFO - mozversion platform_buildid: 20170321101027 04:03:43 INFO - mozversion platform_changeset: 1a53aec4fb0dd7685c1ba03489d454a6510b2648 04:03:43 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:03:43 INFO - mozversion platform_version: 54.0a2 04:03:43 INFO - using testdate: 1490094223 04:03:43 INFO - actual date: 1490094223 04:03:43 INFO - starting webserver on 'localhost:40552' 04:03:43 INFO - SUITE-START | Running 2 tests 04:03:43 INFO - TEST-START | dromaeo_css 04:03:43 INFO - operating with platform_type : linux_ 04:03:43 INFO - Initialising browser for dromaeo_css test... 04:03:43 INFO - TEST-INFO | started process 26580 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9RwZYa/profile http://localhost:40552/getInfo.html) 04:03:48 INFO - PROCESS | 26580 | __metrics Screen width/height:1600/1200 04:03:48 INFO - PROCESS | 26580 | colorDepth:24 04:03:48 INFO - PROCESS | 26580 | Browser inner width/height: 1024/697 04:03:48 INFO - PROCESS | 26580 | __metrics 04:03:49 INFO - PROCESS | 26580 | 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" 04:03:49 INFO - PROCESS | 26580 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:03:49 INFO - PROCESS | 26580 | console.error: PushService: 04:03:49 INFO - PROCESS | 26580 | stateChangeProcessEnqueue: Error transitioning state 04:03:49 INFO - PROCESS | 26580 | UnknownError 04:03:50 INFO - TEST-INFO | 26580: exit 0 04:03:50 INFO - Browser initialized. 04:03:50 INFO - Running cycle 1/1 for dromaeo_css test... 04:03:50 INFO - TEST-INFO | started process 26673 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9RwZYa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:04:02 INFO - PROCESS | 26673 | RSS: Main: 139710464 04:04:02 INFO - PROCESS | 26673 | 04:07:03 INFO - PROCESS | 26673 | Cycle 1(1): loaded http://localhost:40552/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40552/tests/dromaeo/cssquery-ext.html) 04:07:05 INFO - PROCESS | 26673 | RSS: Main: 283570176 04:07:05 INFO - PROCESS | 26673 | 04:08:51 INFO - PROCESS | 26673 | ************************* 04:08:51 INFO - PROCESS | 26673 | A coding exception was thrown and uncaught in a Task. 04:08:51 INFO - PROCESS | 26673 | 04:08:51 ERROR - PROCESS | 26673 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:08:51 INFO - PROCESS | 26673 | Full stack: 04:08:51 INFO - PROCESS | 26673 | ************************* 04:10:07 INFO - PROCESS | 26673 | Cycle 1(1): loaded http://localhost:40552/tests/dromaeo/cssquery-ext.html (next: http://localhost:40552/tests/dromaeo/cssquery-jquery.html) 04:10:08 INFO - PROCESS | 26673 | RSS: Main: 216244224 04:10:08 INFO - PROCESS | 26673 | 04:13:09 INFO - PROCESS | 26673 | Cycle 1(1): loaded http://localhost:40552/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40552/tests/dromaeo/cssquery-mootools.html) 04:13:10 INFO - PROCESS | 26673 | RSS: Main: 220196864 04:13:10 INFO - PROCESS | 26673 | 04:16:12 INFO - PROCESS | 26673 | Cycle 1(1): loaded http://localhost:40552/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40552/tests/dromaeo/cssquery-prototype.html) 04:16:12 INFO - PROCESS | 26673 | RSS: Main: 196599808 04:16:12 INFO - PROCESS | 26673 | 04:19:15 INFO - PROCESS | 26673 | Cycle 1(1): loaded http://localhost:40552/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40552/tests/dromaeo/cssquery-yui.html) 04:19:16 INFO - PROCESS | 26673 | RSS: Main: 175443968 04:19:16 INFO - PROCESS | 26673 | 04:22:19 INFO - PROCESS | 26673 | Cycle 1(1): loaded http://localhost:40552/tests/dromaeo/cssquery-yui.html (next: http://localhost:40552/tests/dromaeo/cssquery-dojo.html) 04:22:19 INFO - PROCESS | 26673 | RSS: Main: 260272128 04:22:19 INFO - PROCESS | 26673 | 04:22:19 INFO - PROCESS | 26673 | __start_tp_report 04:22:19 INFO - PROCESS | 26673 | _x_x_mozilla_page_load 04:22:19 INFO - PROCESS | 26673 | _x_x_mozilla_page_load_details 04:22:19 INFO - PROCESS | 26673 | |i|pagename|runs| 04:22:19 INFO - PROCESS | 26673 | |0;dojo.html;3406.267652454722;3434.3989801784683;3435.6220815710267;3455.7408194385425;3485.041613556272;5754.079347304427;5854.531637469003;5868.76524939003;5876.618019828708;5878.441548052928;5821.3887541808135;5832.737526811293;5860.384659610732;5866;5869.794557190499;5270.525652691257;5292.497212764782;5322.494363035506;5342;5400.91898621521;5181.041507321139;5199.480051994789;5389.73051347433;5395.487428694288;5399.19012148177;5303.522682958533;5320.840374788762;5421.756020979045;5428.022955867942;5439.456054394549;5408.540274076709;5420.810271640494;5424.810131645373;5431.348238211401;5433.6196466247375;5115.974420127875;5280.260763493114;5324.467553244684;5366.463353664602;5423.915216956624;5727.455891690282;5728.68492232927;5791.18923350727;5808.651480911117;5818.44724751148;6246.187995560594;6255.40573645503;6278.560500764948;6289.779857704958;6295.18162638854;6338;6338.366163383671;6339.2709838368255;6343.111964324999;6351.333110023474;5691.4877661010705;5730.398308177623;5811.418858114197;5849.502792262705;5917.497012753878;6366.936330636727;6367.586106903036;6375.234971803413;6384.07430922523;6439.323870993572;6022.608530445507;6124.418180272867;6128.264608247039;6155.292141403706;6194.721237544321;6025.186599809057;6057.4851137653795;6108.267007959073;6291.6854157291955;6304.306526282106;6224.906626400608;6236.875262494816;6276.905846412307;6285.277193122758;6298.244210694655;5938.138969849348;5984.431479009487;5989.431004054608;6110.536573724111;6166.445019948226;4693.9765301173275;4706.458757242893;4742.952570474251;4766.213574760195;4773.522647735199;4124.835006599702;4134.276501612206;4156.8337266509;4216.915661686749;4233.428487154257;6077.027675571887;6079.179310792986;6086.726097325631;6095.603785753912;6102.908456373158;6258.907481786409;6302.684865756693;6303.464205542488;6305.054241863757;6307.653079080695;5748.051571490741;6046.5767396281835;6056.606320589148;6062;6069.393060693896;5147.794088236428;5281.841544753664;5337.412884582693;5339.41266460689;5342.91985620216;6624.668766561653;6662.300458451889;6663.400293973566;6668.799616069155;6672.933270667231;6319.8104056878365;6320.5891617044745;6349.68251587428;6380.266269379081;6405.647689377129;6379.043143528508;6428.774992875227;6511.316311787384;6529.118568993125;6626.0392243123515;6209.503239740719;6210.223722034746;6218.5647004711045;6219.564630475823;6221.5333849962335;6330.461910737639;6332.176817013758;6332.810015699536;6334.1765570475545;6336.556441049082;5956.225690660186;6002.729877155626;6114.877702445837;6126.846828829315;6139.72371243304;6128.66292353907;6130.295016073209;6139.032198454696;6200.534959878118;6203;6112.633242005494;6114.784027539347;6115.0324970298125;6119.112728654231;6143.924813157769;5927.733252003584;5928.851778705394;5993.370696077023;6132.601380910227;6156.938430615636;6098.0852872069545;6104.725287361991;6111.591738512148;6112.50348092447;6120.8775824484155 04:22:19 INFO - PROCESS | 26673 | |1;ext.html;745.7799949015043;799.9400044996626;822.7202751064639;901.5447199164421;916.6608354908685;24689.25932222034;43145.35281970769;43995;47924.56226313216;48199;45281;45425;45585;45596.316055259114;45614.31578526325;7513.737019204329;7655.387568994467;9159.77100572486;9299.209567186797;9309;10229.079382855542;10449.895501045006;10749.516271767789;10752.408617526073;10761.461926903663;10537.525811338508;10581.576736930514;10586.78826423471;10593.099586535154;10594.52324645389;10484.266101372907;10502.632407865687;10513.158947284199;10516.947415262952;10531.947340263327;10517.316374435713;10535.631252906189;10572.15422766177;10577.206709496742;10578.57685692579;41808;42211.155776884596;42226.78886605578;42270;42278.78860605708;4253.404523366731;4292.687761726578;4315.13697260546;4396.648268138541;4449.666275029385;29163.125106246633;29245.853770731224;30095.247618809484;30141.0957671268;30656.08031759051;4364.323529852878;4414.426124603781;4445.755483448409;4475.351074094238;4522.982328975987;216192;217109;218178;218451.90774046187;218891;53592.464075358745;53716.73141634267;53723.46276537263;53945;54181.72909135429;53576.19635705467;53654.73172634112;53734.73132634312;53765.73117134389;53792;14599.78100328496;14787.11277323364;14807.407703691948;14823.481178158712;14830.258487075604;11557.07543396543;11705.824412633818;12389.442475088643;12760.10679252462;12820.166689165175;13651;13712.862871371359;13723.588292351245;13734;13806.378712957941;5430.429804870431;5498.560115190775;5529.198266251371;5559.082751346064;5575.4424557543925;997.3866072365443;1006.7936073104996;1008.4907121903539;1012.8480727890875;1021.6424251511911;26982.5952610711;28372;28730.425391492052;28791.56812647812;30195.69804301929;1121.3608243301403;1250.493550112206;1261.1046157228286;1271.841019872516;1291.9160254583421;13238.271895045866;14613.85386146125;14644.341004654603;15179.316930738143;15651.843481565267;327879;328897;330014;330532;331762;48574.75712621414;48802.51197488051;48807.755961220675;48821.75589122103;48860.75569622129;1441.3657990484153;1466.9193194374411;1502.0612117426608;1515.8256800467866;1516.5071351810705;26811;28247.29381765472;28622;28676.569851451826;28712.569311459927;40025.1994960105;40565.39151912665;40627;40745.79627101846;40774;285819;287279;288178;288351;289252;24775.752242477345;27688.58467123035;29144.231298026654;29164;29667.258318542208;37486.43770343393;37749;38176.42735358916;38536.80731596324;38712.80643596764;32322.515162272113;32408.351832962737;32463.513047303837;32626.347473049933;32738;32345.191370215933;33126.33747325088;34151.658483414845;34229.48655770116;36367.090822729646;35264.29471410506;35499.290014199054;35697;35714.28571428609;36190.45714314235;29370.11889643314;30577.847110764305;30915.84542077365;31182.532262016543;31214;25035;25298.620520691835;25356.49287014286;25738.742612573635;25743.871280644227 04:22:19 INFO - PROCESS | 26673 | |2;jquery.html;409.94465747124127;423.82411299310786;458.44757067733383;458.85316698656425;481.0331234219219;19679.5080122997;20382.89808550957;20936.476588085305;21149.68275475869;21154.89422552885;19420.902895485502;19604.411867643994;19638.607227855435;19677.114529846156;19909.800901990977;6589.571677840949;6928.411085057776;6937;6937.6878040488045;6943.548669336477;6641.800745977628;6715.798526044202;6845.281245469228;6869.931300686979;6888.724451021953;6671.532992690513;6713.563618364815;6900.171979362483;6901.6204108774;6905.102336696223;6718.731250749964;6759.0875231843565;6792.830179245509;6809.557378770364;6811.62536060514;6442.323556026597;6448.000559913174;6609.107770450975;6638.4689224861895;6648.434883034948;24097.15659951911;24208.757912420828;24242.757572424227;24258.39354016146;24330.14844480435;2912.8689208985647;2996.3258266889993;3000.9249768755735;3022.4710675631677;3077.261457250266;15819.446319378767;15965.12191829449;16095.839041609668;16104.677906441922;16143.757843632355;2228.754836967932;2239.7760223977634;2260.5139894922504;2296.4258935266184;2331.6502524621274;92728;93458;94636.52681736616;96978.51510742471;97813;17894.91052544729;18118.184681689356;18168.54651627893;18383.26466941334;18742.344017959305;32531.837340813618;32724.509132363033;32780;32796.3440731184;33130.84042058516;9507.477088760184;9597.808043839084;9600.807983840285;9689.854652180224;9843.901560984441;7740.26467485588;7771.455998080193;7797.454178207585;7913;7958.045034595885;9797.265205109503;9964.900350996542;10006.899931000597;10112.949435252776;10226.437545935045;3843.5024128043347;3853.133045064894;3906.5898080701686;4116.073883376276;4118.649914757219;969.6945462179391;971.7327734872966;972.6936015155203;986.5461887531816;986.6102889358663;20417.285395011102;20497.38507844767;20544.17823287052;20571.58856822855;20751.377458676263;961.1301771896445;967.970960871175;969.5297780576415;974.4640447753707;984.468387070988;11527.884721152848;11886.881131188751;11981.400929953641;12003.819942700866;12024.519019239133;671336;711999;730890.255746194;745373;755059;87980;89380.10619893718;89868.5506572476;90037.54981225183;90087;1241.9689507762198;1245.4333278358324;1289.0589869395394;1289.471316760124;1297.4874924404996;17427.564310891823;17681.734773978143;18102.818971810113;18146.45560633183;18146.637067258845;42206;42784.5721542793;43014.78492607517;43034.78482607567;43545.56454435415;54779;62462;63750.362496374444;64821.35178648153;65912.34087659062;11424.771504569695;11901.523939042341;12067.396630168632;12491.375431228584;12678.87321126777;13962.4415023402;14064.929675351557;14095;14108.576742697736;14163.929180354033;12235.571754988532;12255.325957072446;12379.442925068213;12380.319082450551;12407.75184496287;12262.386880655753;12342.938285308515;12343.197692150341;12396.318202498589;12636.810447843474;12622.621321360373;12637.557685480964;12655.620331390073;12822.23066616006;12917.418716157608;12199.268043917393;12218.816717749418;12354.382280886099;12710.428030738454;12716.872831271568;12365.443555040225;12522.874771252535;12564.87435125637;12657.11400201977;12980.805287920877 04:22:19 INFO - PROCESS | 26673 | |3;mootools.html;1387.445021991204;1572.2296074923283;1583.6674298397336;1586.6192113892666;1587.6904003719264;9114;10904.727381815459;11356.48895799689;11632.941835290832;11645.068394528438;11307.265027773188;11401;11405.885941140587;11409.771804563925;11429.485673144707;1855.8793678410927;1916.0036780873936;2372.181597348912;2432.2338463384067;2434.075051480444;2347.6830627865193;2426.296374051523;2428.1258746851117;2429.2712186344115;2429.927102186937;2347.4600841806396;2357.0453966143655;2364.137089962169;2367.502824406868;2395.8802059896934;2369.715634123899;2380.940476488084;2386.1886958434216;2386.7971222446026;2398.4123889646976;2223.132978138511;2238.9776102238934;2242.6636004599277;2248.033345661365;2251.0995601759264;11085.889141108566;11171.44142792857;11221.719457013558;11255.380954047525;11255.606053788078;5536.861578460531;5670.3479099903625;5671.886562268773;5675.9432405675825;5684.459976302244;3279.5080737889507;3306.50402439636;3479.3041391721504;3544.0608238816735;3567.340042092221;1344.435337158396;1350.777121774906;1388.3891087921281;1402.4039783092146;1416.0937000319805;16638;16662.416815411525;16702.331906723837;16703.16484175786;16710.248038838283;4672.92023009691;4795.592374648124;4817.205161148441;4898.044881248194;4904.8038078477175;14212.218327991854;14219.573412797632;14220.431182752574;14222.715545689029;14228.14631122136;5876.08920617305;5881.2942446906645;5884.47039766423;5885.470307672244;5891.823245302562;5117.718525481134;5180.067587834151;5232.372115346183;5276.472352764693;5281.683099014072;4187.476565429321;4226.1758957003085;4233.830646774095;4282.336237883133;4294.549072347359;1137.6132115080911;1140.885911408869;1158.7276989907366;1159.3855256713787;1165.3182888010608;1055.5302890213782;1090.4111779639065;1091.6343025086526;1094.9781004379868;1098.5166526728374;7170;7228.421726261887;7238.348548630648;7260.745873894494;7322.400547805559;1034.384541197986;1037.6938803053117;1042.5725452564411;1045.7281106912258;1058.1904842795268;4346.958724838937;4422.248217802981;4564.018735971782;4673.813047478131;4712.6229901607785;14312;14638.121712697272;14644.341004654816;14647.92676036613;14667;13359.1316564423;13853.653658658613;13873.890088792872;13879.930600346934;14472.638184045272;10312.742181445525;10492.737681558023;10506.579736810441;10506.579736810594;10561.841572376421;7115.324044215791;7335.972963784968;7385.519941203805;7399.852002959803;7469.327760501364;12691.873081269068;12743.299118548568;12836.55072072473;13000.959923205932;13062.34688265602;12881.162724422882;12895.806562901376;13078.476860925457;13176.209427434385;13459.327033648475;9430.29272804556;9675.177609902956;9679.758006049906;9684.515774211402;9685.9031409685;10240.897591024292;10331.896681033395;10338.793224135325;10358.067773900386;10429.269951103654;8824.602892869709;8908.688195913111;8927.821443570961;9024.097590240923;9039;8732.956335218283;8828.249598784176;8873.91126088731;8978;9173.862392063991;8011.479253848481;8047.195280471906;8059.637316320897;8087.433879628605;8089.635966381645;6216.285127210429;6313.96843015782;6356.237251529846;6381.649009304533;6473.64394958263;6199.876002480015;6200.7519699211525;6203.689815509116;6359.650219237987;6407.807765767035 04:22:19 INFO - PROCESS | 26673 | |4;prototype.html;383.0385731813148;412.1412429940966;412.6595558664103;429.9548547402521;430.1032347555347;4939;5114.641975061747;5185.703574106474;5196.974015129919;5228.248536740197;4946.233333833253;5108.616853735966;5125.615578831594;5148.716820574867;5182.300389447423;4487.259602165639;4507.932381014288;4528.54714528547;4535.319702044703;4542.636589072867;4328.632066274355;4432.20220360335;4482.753448560328;4534.773261336936;4563.429571303587;4522.773861306938;4536.500984891659;4539.568740969603;4542.8864278392975;4556.931646025312;4475.373447717322;4495.43807024122;4505.932411013838;4523.36672865799;4622.214223581999;4326.935095973563;4369.366441865912;4373.278409062501;4416.6025057744955;4435.844745433894;4989.975050124726;5033.370828646419;5053.46938571452;5074.720890351029;5087.949120508784;5126.384833819928;5182.948170518284;5188.948110518884;5212.4266330703595;5212.765425555859;5201.271821944931;5383.623146379755;5421.891562168774;5472.890542189134;5487.945120548783;4743.600637811854;4759.5002524734755;4761;4763.618910487153;4775.952240477585;5625.665348880209;5670.306604362936;5702.519404059248;5713.171785028792;5723;4801.447833499123;4964.627652926045;4978.576820970258;4991.5258050485145;5024.949750502521;4808.543188397097;5053.1050855929025;5061;5067.366579177603;5084.8813261082505;5097.362829646294;5137.229415587692;5145.614078944094;5199.584033277404;5210.166373380241;5380;5431.782728690808;5440.9934162180125;5444.346678398618;5461.590380721462;1686.8060173080007;1704.7101992661278;1707.1299793326918;1728.135932033983;1729.1757196158173;1402.193738600309;1419.425132821209;1421.5713208225668;1427.928603569838;1443.758367803688;5323.334583177103;5361;5430.104032834538;5432.375276843213;5485.50630443262;5530.7511161997;5575.972120139454;5579.6652200868075;5591.720413979285;5644.717764111778;5207.110053920035;5308.522232999048;5344.893102137936;5381.67709937405;5390.975714614211;2915.4606397816474;2919.1826288639213;2919.9854000730284;2928.9267768305535;2934.6038284831275;5505.284313039359;5791.160281759121;5807.796727114531;5811.709414529257;5821.301443826683;5630;5645.350784659817;5647.971760141173;5651.350094739076;5664.971675141598;5774.335951365647;5788.884222315614;5799.913001305068;5844.6785426801935;5864.560157988082;5313.707746074003;5549.916751248816;5550.306211723535;5607.915881261702;5625.69058701759;5449.836504904859;5549.5837812165055;5549.833504994856;5576.832695019156;5591.804286849941;5704.828855134353;5807.622504537191;5811.4479124483105;5823.253024092671;5872.55955803325;4656.696125084982;4662.090892275974;4667;4687.1328804171335;4711.740854253049;5355.839324820262;5471.604740791073;5474.835754927359;5588.217649529151;5594.440555944373;5442.537384322377;5444.638840289927;5448.673079615236;5453.118674057444;5455.9454405455435;5146.382434107782;5382.596305277199;5420.620556561161;5441.8437306363;5507.614466987273;5376.596755243294;5379.892402152013;5407.810726624549;5411.540019098264;5418.160185171305;5414.35027796667;5463.524848291018;5482.53286021284;5528.806491772769;5539.335279766454;5079.568236699774;5304.310439642822;5305.681659100466;5312.229726689686;5329.1896294149865 04:22:19 INFO - PROCESS | 26673 | |5;yui.html;813.438727278178;836.4646626159259;846.4751853850613;857.425524898318;870.2081106193365;16791.244394002268;18314.45056648303;18395.72406413905;18414.631707365843;18585.88484690918;16284.592885177877;16463.753043704353;16568.83431165688;16572.502824915242;16582.66834663306;885.305035547094;900.8063266397724;910.194477887068;910.399136569864;912.338554547954;907.1699395053519;907.3149771922223;907.4509921497498;907.686848037426;908.7228395339419;947.7251597036851;948.0282710222043;948.3740731117464;948.6916752055575;948.905109489049;948.1940350701917;950.6957773512479;950.9572069256866;952.1478276942132;952.3333666433455;692.6709812838911;694.1115372323434;694.1531331775226;694.6110178300169;696.3593493985545;17398.7390189146;17590;17594.91202543979;18365;18580.44258672242;15615.687686246212;15916.840831591651;16072;16165.515034548982;16312.592185195346;13451.32743362828;13519.932400338033;13574.253416062113;13662.795058074136;13776.724465510733;4017.6183262590007;4103.158852435244;4114.485689288839;4140.37894315852;4152.60550247729;40305.79847100775;51341.486585134415;69622;75520.24479755187;82162.58918705369;12754.36228188587;12848.935755321163;12886.420111094836;12920.095593308379;12982.350882456029;22803;22809;23083.769162308497;23168.65247021296;23227.7677223229;9273.629054837731;9276.257899368034;9278;9294.117058879396;9347.392419492711;4749.501302363202;4827;4837.516248375135;4871.098846713369;4957.03337849116;3863.362545180014;3932.508436445444;3934.193490334532;3935.0359162005493;3945.6646185074014;655.7475371981822;701.6176183979743;729.2634439216324;731.4660297982502;742.7957311739207;693.5457275484565;699.6956323998975;700.5656492974389;713.183405001281;718.4647437658978;11459.541618335174;11535.19253652253;11680.415979201007;11844.940775296069;12000.879991199976;856.9314454843598;857.652650676477;858.6093327535956;870.3907264914585;880.41892351048;5204.8959020819375;5220.347456567929;5239.816606418757;5242.030224408497;5280.788768449296;63481;78985.60507197543;80217.59891200507;81637.18362816414;82051.5897420521;44676.55323446724;62397.37602624006;65531.344686552526;65753.34246657568;67552.3244767546;53289;58298.12552811711;58748.706256468446;58905.11642325368;59312.11031834526;11426.25729327591;11878.762424751629;11919;12230.816537752118;12235.877641223475;40938.976525587095;41017.1796564073;41518.79240603778;41922.58077419309;42487.78756106323;49304;50009.499905000484;50241.49758502368;50506;50510.49489505205;14097.788533171806;14156.150630962175;14251.643708906946;14350.354234059283;14437.494687686301;15624.453144139901;15934.60163495922;15996.040237585783;16011;16203.351865925231;14987.40050397972;15233.542993710207;15319.617009574404;15344.846551534789;15883.444079457626;15629.76555351648;15702.685946280782;15729.292181851615;16123.516294510715;16623.418180363627;14723.411063557338;14741.484048058266;14754.262286885398;15076.773848392064;15315.923420383273;12471.376431178223;13001.284929328978;13057.542985995444;13110.410031548412;13537.323133843465;12349;13343.66640833948;13397.009800986056;13621.863781362455;13626.93186534061 04:22:19 INFO - PROCESS | 26673 | __end_tp_report 04:22:19 INFO - PROCESS | 26673 | __start_cc_report 04:22:19 INFO - PROCESS | 26673 | _x_x_mozilla_cycle_collect,1439 04:22:19 INFO - PROCESS | 26673 | __end_cc_report 04:22:19 INFO - PROCESS | 26673 | __startTimestamp1490095339324__endTimestamp 04:22:19 INFO - PROCESS | 26673 | 04:22:19 INFO - PROCESS | 26673 | ------- Summary: start ------- 04:22:19 INFO - PROCESS | 26673 | Number of tests: 6 04:22:19 INFO - PROCESS | 26673 | 04:22:19 INFO - PROCESS | 26673 | [#0] dojo.html Cycles:165 Average:5823.44 Median:6079.18 stddev:673.77 (11.1%) stddev-sans-first:648.60 04:22:19 INFO - PROCESS | 26673 | Values: 3406.3 3434.4 3435.6 3455.7 3485.0 5754.1 5854.5 5868.8 5876.6 5878.4 5821.4 5832.7 5860.4 5866.0 5869.8 5270.5 5292.5 5322.5 5342.0 5400.9 5181.0 5199.5 5389.7 5395.5 5399.2 5303.5 5320.8 5421.8 5428.0 5439.5 5408.5 5420.8 5424.8 5431.3 5433.6 5116.0 5280.3 5324.5 5366.5 5423.9 5727.5 5728.7 5791.2 5808.7 5818.4 6246.2 6255.4 6278.6 6289.8 6295.2 6338.0 6338.4 6339.3 6343.1 6351.3 5691.5 5730.4 5811.4 5849.5 5917.5 6366.9 6367.6 6375.2 6384.1 6439.3 6022.6 6124.4 6128.3 6155.3 6194.7 6025.2 6057.5 6108.3 6291.7 6304.3 6224.9 6236.9 6276.9 6285.3 6298.2 5938.1 5984.4 5989.4 6110.5 6166.4 4694.0 4706.5 4743.0 4766.2 4773.5 4124.8 4134.3 4156.8 4216.9 4233.4 6077.0 6079.2 6086.7 6095.6 6102.9 6258.9 6302.7 6303.5 6305.1 6307.7 5748.1 6046.6 6056.6 6062.0 6069.4 5147.8 5281.8 5337.4 5339.4 5342.9 6624.7 6662.3 6663.4 6668.8 6672.9 6319.8 6320.6 6349.7 6380.3 6405.6 6379.0 6428.8 6511.3 6529.1 6626.0 6209.5 6210.2 6218.6 6219.6 6221.5 6330.5 6332.2 6332.8 6334.2 6336.6 5956.2 6002.7 6114.9 6126.8 6139.7 6128.7 6130.3 6139.0 6200.5 6203.0 6112.6 6114.8 6115.0 6119.1 6143.9 5927.7 5928.9 5993.4 6132.6 6156.9 6098.1 6104.7 6111.6 6112.5 6120.9 04:22:19 INFO - PROCESS | 26673 | 04:22:19 INFO - PROCESS | 26673 | [#1] ext.html Cycles:180 Average:44383.21 Median:30616.96 stddev:73758.26 (240.9%) stddev-sans-first:73892.40 04:22:19 INFO - PROCESS | 26673 | Values: 745.8 799.9 822.7 901.5 916.7 24689.3 43145.4 43995.0 47924.6 48199.0 45281.0 45425.0 45585.0 45596.3 45614.3 7513.7 7655.4 9159.8 9299.2 9309.0 10229.1 10449.9 10749.5 10752.4 10761.5 10537.5 10581.6 10586.8 10593.1 10594.5 10484.3 10502.6 10513.2 10516.9 10531.9 10517.3 10535.6 10572.2 10577.2 10578.6 41808.0 42211.2 42226.8 42270.0 42278.8 4253.4 4292.7 4315.1 4396.6 4449.7 29163.1 29245.9 30095.2 30141.1 30656.1 4364.3 4414.4 4445.8 4475.4 4523.0 216192.0 217109.0 218178.0 218451.9 218891.0 53592.5 53716.7 53723.5 53945.0 54181.7 53576.2 53654.7 53734.7 53765.7 53792.0 14599.8 14787.1 14807.4 14823.5 14830.3 11557.1 11705.8 12389.4 12760.1 12820.2 13651.0 13712.9 13723.6 13734.0 13806.4 5430.4 5498.6 5529.2 5559.1 5575.4 997.4 1006.8 1008.5 1012.8 1021.6 26982.6 28372.0 28730.4 28791.6 30195.7 1121.4 1250.5 1261.1 1271.8 1291.9 13238.3 14613.9 14644.3 15179.3 15651.8 327879.0 328897.0 330014.0 330532.0 331762.0 48574.8 48802.5 48807.8 48821.8 48860.8 1441.4 1466.9 1502.1 1515.8 1516.5 26811.0 28247.3 28622.0 28676.6 28712.6 40025.2 40565.4 40627.0 40745.8 40774.0 285819.0 287279.0 288178.0 288351.0 289252.0 24775.8 27688.6 29144.2 29164.0 29667.3 37486.4 37749.0 38176.4 38536.8 38712.8 32322.5 32408.4 32463.5 32626.3 32738.0 32345.2 33126.3 34151.7 34229.5 36367.1 35264.3 35499.3 35697.0 35714.3 36190.5 29370.1 30577.8 30915.8 31182.5 31214.0 25035.0 25298.6 25356.5 25738.7 25743.9 04:22:19 INFO - PROCESS | 26673 | 04:22:19 INFO - PROCESS | 26673 | [#2] jquery.html Cycles:180 Average:37713.47 Median:3011.70 stddev:118262.61 (3926.8%) stddev-sans-first:118561.20 04:22:19 INFO - PROCESS | 26673 | Values: 409.9 423.8 458.4 458.9 481.0 19679.5 20382.9 20936.5 21149.7 21154.9 19420.9 19604.4 19638.6 19677.1 19909.8 6589.6 6928.4 6937.0 6937.7 6943.5 6641.8 6715.8 6845.3 6869.9 6888.7 6671.5 6713.6 6900.2 6901.6 6905.1 6718.7 6759.1 6792.8 6809.6 6811.6 6442.3 6448.0 6609.1 6638.5 6648.4 24097.2 24208.8 24242.8 24258.4 24330.1 2912.9 2996.3 3000.9 3022.5 3077.3 15819.4 15965.1 16095.8 16104.7 16143.8 2228.8 2239.8 2260.5 2296.4 2331.7 92728.0 93458.0 94636.5 96978.5 97813.0 17894.9 18118.2 18168.5 18383.3 18742.3 32531.8 32724.5 32780.0 32796.3 33130.8 9507.5 9597.8 9600.8 9689.9 9843.9 7740.3 7771.5 7797.5 7913.0 7958.0 9797.3 9964.9 10006.9 10112.9 10226.4 3843.5 3853.1 3906.6 4116.1 4118.6 969.7 971.7 972.7 986.5 986.6 20417.3 20497.4 20544.2 20571.6 20751.4 961.1 968.0 969.5 974.5 984.5 11527.9 11886.9 11981.4 12003.8 12024.5 671336.0 711999.0 730890.3 745373.0 755059.0 87980.0 89380.1 89868.6 90037.5 90087.0 1242.0 1245.4 1289.1 1289.5 1297.5 17427.6 17681.7 18102.8 18146.5 18146.6 42206.0 42784.6 43014.8 43034.8 43545.6 54779.0 62462.0 63750.4 64821.4 65912.3 11424.8 11901.5 12067.4 12491.4 12678.9 13962.4 14064.9 14095.0 14108.6 14163.9 12235.6 12255.3 12379.4 12380.3 12407.8 12262.4 12342.9 12343.2 12396.3 12636.8 12622.6 12637.6 12655.6 12822.2 12917.4 12199.3 12218.8 12354.4 12710.4 12716.9 12365.4 12522.9 12564.9 12657.1 12980.8 04:22:19 INFO - PROCESS | 26673 | 04:22:19 INFO - PROCESS | 26673 | [#3] mootools.html Cycles:180 Average:7056.61 Median:2368.61 stddev:4511.61 (190.5%) stddev-sans-first:4504.16 04:22:19 INFO - PROCESS | 26673 | Values: 1387.4 1572.2 1583.7 1586.6 1587.7 9114.0 10904.7 11356.5 11632.9 11645.1 11307.3 11401.0 11405.9 11409.8 11429.5 1855.9 1916.0 2372.2 2432.2 2434.1 2347.7 2426.3 2428.1 2429.3 2429.9 2347.5 2357.0 2364.1 2367.5 2395.9 2369.7 2380.9 2386.2 2386.8 2398.4 2223.1 2239.0 2242.7 2248.0 2251.1 11085.9 11171.4 11221.7 11255.4 11255.6 5536.9 5670.3 5671.9 5675.9 5684.5 3279.5 3306.5 3479.3 3544.1 3567.3 1344.4 1350.8 1388.4 1402.4 1416.1 16638.0 16662.4 16702.3 16703.2 16710.2 4672.9 4795.6 4817.2 4898.0 4904.8 14212.2 14219.6 14220.4 14222.7 14228.1 5876.1 5881.3 5884.5 5885.5 5891.8 5117.7 5180.1 5232.4 5276.5 5281.7 4187.5 4226.2 4233.8 4282.3 4294.5 1137.6 1140.9 1158.7 1159.4 1165.3 1055.5 1090.4 1091.6 1095.0 1098.5 7170.0 7228.4 7238.3 7260.7 7322.4 1034.4 1037.7 1042.6 1045.7 1058.2 4347.0 4422.2 4564.0 4673.8 4712.6 14312.0 14638.1 14644.3 14647.9 14667.0 13359.1 13853.7 13873.9 13879.9 14472.6 10312.7 10492.7 10506.6 10506.6 10561.8 7115.3 7336.0 7385.5 7399.9 7469.3 12691.9 12743.3 12836.6 13001.0 13062.3 12881.2 12895.8 13078.5 13176.2 13459.3 9430.3 9675.2 9679.8 9684.5 9685.9 10240.9 10331.9 10338.8 10358.1 10429.3 8824.6 8908.7 8927.8 9024.1 9039.0 8733.0 8828.2 8873.9 8978.0 9173.9 8011.5 8047.2 8059.6 8087.4 8089.6 6216.3 6314.0 6356.2 6381.6 6473.6 6199.9 6200.8 6203.7 6359.7 6407.8 04:22:19 INFO - PROCESS | 26673 | 04:22:19 INFO - PROCESS | 26673 | [#4] prototype.html Cycles:180 Average:4814.79 Median:5211.30 stddev:1237.19 (23.7%) stddev-sans-first:1195.11 04:22:19 INFO - PROCESS | 26673 | Values: 383.0 412.1 412.7 430.0 430.1 4939.0 5114.6 5185.7 5197.0 5228.2 4946.2 5108.6 5125.6 5148.7 5182.3 4487.3 4507.9 4528.5 4535.3 4542.6 4328.6 4432.2 4482.8 4534.8 4563.4 4522.8 4536.5 4539.6 4542.9 4556.9 4475.4 4495.4 4505.9 4523.4 4622.2 4326.9 4369.4 4373.3 4416.6 4435.8 4990.0 5033.4 5053.5 5074.7 5087.9 5126.4 5182.9 5188.9 5212.4 5212.8 5201.3 5383.6 5421.9 5472.9 5487.9 4743.6 4759.5 4761.0 4763.6 4776.0 5625.7 5670.3 5702.5 5713.2 5723.0 4801.4 4964.6 4978.6 4991.5 5024.9 4808.5 5053.1 5061.0 5067.4 5084.9 5097.4 5137.2 5145.6 5199.6 5210.2 5380.0 5431.8 5441.0 5444.3 5461.6 1686.8 1704.7 1707.1 1728.1 1729.2 1402.2 1419.4 1421.6 1427.9 1443.8 5323.3 5361.0 5430.1 5432.4 5485.5 5530.8 5576.0 5579.7 5591.7 5644.7 5207.1 5308.5 5344.9 5381.7 5391.0 2915.5 2919.2 2920.0 2928.9 2934.6 5505.3 5791.2 5807.8 5811.7 5821.3 5630.0 5645.4 5648.0 5651.4 5665.0 5774.3 5788.9 5799.9 5844.7 5864.6 5313.7 5549.9 5550.3 5607.9 5625.7 5449.8 5549.6 5549.8 5576.8 5591.8 5704.8 5807.6 5811.4 5823.3 5872.6 4656.7 4662.1 4667.0 4687.1 4711.7 5355.8 5471.6 5474.8 5588.2 5594.4 5442.5 5444.6 5448.7 5453.1 5455.9 5146.4 5382.6 5420.6 5441.8 5507.6 5376.6 5379.9 5407.8 5411.5 5418.2 5414.4 5463.5 5482.5 5528.8 5539.3 5079.6 5304.3 5305.7 5312.2 5329.2 04:22:19 INFO - PROCESS | 26673 | 04:22:19 INFO - PROCESS | 26673 | [#5] yui.html Cycles:180 Average:17527.67 Median:4127.43 stddev:20259.68 (490.9%) stddev-sans-first:20277.63 04:22:19 INFO - PROCESS | 26673 | Values: 813.4 836.5 846.5 857.4 870.2 16791.2 18314.5 18395.7 18414.6 18585.9 16284.6 16463.8 16568.8 16572.5 16582.7 885.3 900.8 910.2 910.4 912.3 907.2 907.3 907.5 907.7 908.7 947.7 948.0 948.4 948.7 948.9 948.2 950.7 951.0 952.1 952.3 692.7 694.1 694.2 694.6 696.4 17398.7 17590.0 17594.9 18365.0 18580.4 15615.7 15916.8 16072.0 16165.5 16312.6 13451.3 13519.9 13574.3 13662.8 13776.7 4017.6 4103.2 4114.5 4140.4 4152.6 40305.8 51341.5 69622.0 75520.2 82162.6 12754.4 12848.9 12886.4 12920.1 12982.4 22803.0 22809.0 23083.8 23168.7 23227.8 9273.6 9276.3 9278.0 9294.1 9347.4 4749.5 4827.0 4837.5 4871.1 4957.0 3863.4 3932.5 3934.2 3935.0 3945.7 655.7 701.6 729.3 731.5 742.8 693.5 699.7 700.6 713.2 718.5 11459.5 11535.2 11680.4 11844.9 12000.9 856.9 857.7 858.6 870.4 880.4 5204.9 5220.3 5239.8 5242.0 5280.8 63481.0 78985.6 80217.6 81637.2 82051.6 44676.6 62397.4 65531.3 65753.3 67552.3 53289.0 58298.1 58748.7 58905.1 59312.1 11426.3 11878.8 11919.0 12230.8 12235.9 40939.0 41017.2 41518.8 41922.6 42487.8 49304.0 50009.5 50241.5 50506.0 50510.5 14097.8 14156.2 14251.6 14350.4 14437.5 15624.5 15934.6 15996.0 16011.0 16203.4 14987.4 15233.5 15319.6 15344.8 15883.4 15629.8 15702.7 15729.3 16123.5 16623.4 14723.4 14741.5 14754.3 15076.8 15315.9 12471.4 13001.3 13057.5 13110.4 13537.3 12349.0 13343.7 13397.0 13621.9 13626.9 04:22:19 INFO - PROCESS | 26673 | -------- Summary: end -------- 04:22:19 INFO - PROCESS | 26673 | 04:22:20 INFO - TEST-INFO | 26673: exit 0 04:22:20 INFO - TEST-OK | dromaeo_css | took 1116195ms 04:22:20 INFO - TEST-START | kraken 04:22:20 INFO - operating with platform_type : linux_ 04:22:20 INFO - Initialising browser for kraken test... 04:22:20 INFO - TEST-INFO | started process 27001 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptvYZNU/profile http://localhost:40552/getInfo.html) 04:22:24 INFO - PROCESS | 27001 | __metrics Screen width/height:1600/1200 04:22:24 INFO - PROCESS | 27001 | colorDepth:24 04:22:24 INFO - PROCESS | 27001 | Browser inner width/height: 1024/697 04:22:24 INFO - PROCESS | 27001 | __metrics 04:22:24 INFO - PROCESS | 27001 | 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" 04:22:24 INFO - PROCESS | 27001 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:22:25 INFO - PROCESS | 27001 | console.error: PushService: 04:22:25 INFO - PROCESS | 27001 | stateChangeProcessEnqueue: Error transitioning state 04:22:25 INFO - PROCESS | 27001 | UnknownError 04:22:26 INFO - TEST-INFO | 27001: exit 0 04:22:26 INFO - Browser initialized. 04:22:26 INFO - Running cycle 1/1 for kraken test... 04:22:26 INFO - TEST-INFO | started process 27097 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptvYZNU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:22:37 INFO - PROCESS | 27097 | RSS: Main: 139489280 04:22:37 INFO - PROCESS | 27097 | 04:22:40 INFO - PROCESS | 27097 | Cycle 1(1): loaded http://localhost:40552/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40552/tests/kraken/driver.html?testName=audio-beat-detection) 04:22:41 INFO - PROCESS | 27097 | RSS: Main: 182591488 04:22:41 INFO - PROCESS | 27097 | 04:22:43 INFO - PROCESS | 27097 | Cycle 1(1): loaded http://localhost:40552/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40552/tests/kraken/driver.html?testName=audio-dft) 04:22:44 INFO - PROCESS | 27097 | RSS: Main: 173785088 04:22:44 INFO - PROCESS | 27097 | 04:22:47 INFO - PROCESS | 27097 | Cycle 1(1): loaded http://localhost:40552/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40552/tests/kraken/driver.html?testName=audio-fft) 04:22:47 INFO - PROCESS | 27097 | RSS: Main: 265269248 04:22:47 INFO - PROCESS | 27097 | 04:22:49 INFO - PROCESS | 27097 | Cycle 1(1): loaded http://localhost:40552/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40552/tests/kraken/driver.html?testName=audio-oscillator) 04:22:50 INFO - PROCESS | 27097 | RSS: Main: 171155456 04:22:50 INFO - PROCESS | 27097 | 04:22:52 INFO - PROCESS | 27097 | Cycle 1(1): loaded http://localhost:40552/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40552/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:22:53 INFO - PROCESS | 27097 | RSS: Main: 174317568 04:22:53 INFO - PROCESS | 27097 | 04:22:56 INFO - PROCESS | 27097 | Cycle 1(1): loaded http://localhost:40552/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40552/tests/kraken/driver.html?testName=imaging-darkroom) 04:22:56 INFO - PROCESS | 27097 | RSS: Main: 213450752 04:22:56 INFO - PROCESS | 27097 | 04:23:00 INFO - PROCESS | 27097 | Cycle 1(1): loaded http://localhost:40552/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40552/tests/kraken/driver.html?testName=imaging-desaturate) 04:23:00 INFO - PROCESS | 27097 | RSS: Main: 212123648 04:23:00 INFO - PROCESS | 27097 | 04:23:03 INFO - PROCESS | 27097 | Cycle 1(1): loaded http://localhost:40552/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40552/tests/kraken/driver.html?testName=json-parse-financial) 04:23:04 INFO - PROCESS | 27097 | RSS: Main: 210616320 04:23:04 INFO - PROCESS | 27097 | 04:23:05 INFO - PROCESS | 27097 | Cycle 1(1): loaded http://localhost:40552/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40552/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:23:06 INFO - PROCESS | 27097 | RSS: Main: 173154304 04:23:06 INFO - PROCESS | 27097 | 04:23:07 INFO - PROCESS | 27097 | Cycle 1(1): loaded http://localhost:40552/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40552/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:23:08 INFO - PROCESS | 27097 | RSS: Main: 179273728 04:23:08 INFO - PROCESS | 27097 | 04:23:10 INFO - PROCESS | 27097 | Cycle 1(1): loaded http://localhost:40552/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40552/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:23:11 INFO - PROCESS | 27097 | RSS: Main: 189939712 04:23:11 INFO - PROCESS | 27097 | 04:23:13 INFO - PROCESS | 27097 | Cycle 1(1): loaded http://localhost:40552/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40552/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:23:14 INFO - PROCESS | 27097 | RSS: Main: 197980160 04:23:14 INFO - PROCESS | 27097 | 04:23:17 INFO - PROCESS | 27097 | Cycle 1(1): loaded http://localhost:40552/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40552/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:23:17 INFO - PROCESS | 27097 | RSS: Main: 194867200 04:23:17 INFO - PROCESS | 27097 | 04:23:19 INFO - PROCESS | 27097 | Cycle 1(1): loaded http://localhost:40552/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40552/tests/kraken/driver.html?testName=ai-astar) 04:23:19 INFO - PROCESS | 27097 | RSS: Main: 244015104 04:23:19 INFO - PROCESS | 27097 | 04:23:19 INFO - PROCESS | 27097 | __start_tp_report 04:23:19 INFO - PROCESS | 27097 | _x_x_mozilla_page_load 04:23:19 INFO - PROCESS | 27097 | _x_x_mozilla_page_load_details 04:23:19 INFO - PROCESS | 27097 | |i|pagename|runs| 04:23:19 INFO - PROCESS | 27097 | |0;ai-astar;105;113;113;112;112;113;113;112;112;111 04:23:19 INFO - PROCESS | 27097 | |1;audio-beat-detection;140;115;116;148;122;122;121;115;141;117 04:23:19 INFO - PROCESS | 27097 | |2;audio-dft;161;164;162;162;163;163;162;163;163;163 04:23:19 INFO - PROCESS | 27097 | |3;audio-fft;84;76;75;112;76;75;75;76;90;78 04:23:19 INFO - PROCESS | 27097 | |4;audio-oscillator;83;82;108;82;82;82;106;81;80;112 04:23:19 INFO - PROCESS | 27097 | |5;imaging-gaussian-blur;113;113;113;113;114;113;113;114;114;113 04:23:19 INFO - PROCESS | 27097 | |6;imaging-darkroom;146;146;147;147;148;147;146;147;146;146 04:23:19 INFO - PROCESS | 27097 | |7;imaging-desaturate;93;93;95;93;93;94;94;94;94;94 04:23:19 INFO - PROCESS | 27097 | |8;json-parse-financial;55;54;55;53;55;55;54;53;55;53 04:23:19 INFO - PROCESS | 27097 | |9;json-stringify-tinderbox;54;55;54;56;54;54;54;53;54;54 04:23:19 INFO - PROCESS | 27097 | |10;stanford-crypto-aes;82;79;82;79;80;83;75;81;88;74 04:23:19 INFO - PROCESS | 27097 | |11;stanford-crypto-ccm;120;127;120;135;124;120;128;135;155;131 04:23:19 INFO - PROCESS | 27097 | |12;stanford-crypto-pbkdf2;161;163;159;161;156;156;160;163;163;162 04:23:19 INFO - PROCESS | 27097 | |13;stanford-crypto-sha256-iterative;61;60;59;60;65;60;59;59;58;58 04:23:19 INFO - PROCESS | 27097 | __end_tp_report 04:23:19 INFO - PROCESS | 27097 | __start_cc_report 04:23:19 INFO - PROCESS | 27097 | _x_x_mozilla_cycle_collect,1710 04:23:19 INFO - PROCESS | 27097 | __end_cc_report 04:23:19 INFO - PROCESS | 27097 | __startTimestamp1490095399433__endTimestamp 04:23:19 INFO - PROCESS | 27097 | 04:23:19 INFO - PROCESS | 27097 | ------- Summary: start ------- 04:23:19 INFO - PROCESS | 27097 | Number of tests: 14 04:23:19 INFO - PROCESS | 27097 | 04:23:19 INFO - PROCESS | 27097 | [#0] ai-astar Cycles:10 Average:111.60 Median:112.50 stddev:2.41 (2.1%) stddev-sans-first:0.71 04:23:19 INFO - PROCESS | 27097 | Values: 105.0 113.0 113.0 112.0 112.0 113.0 113.0 112.0 112.0 111.0 04:23:19 INFO - PROCESS | 27097 | 04:23:19 INFO - PROCESS | 27097 | [#1] audio-beat-detection Cycles:10 Average:125.70 Median:122.00 stddev:12.40 (10.2%) stddev-sans-first:12.03 04:23:19 INFO - PROCESS | 27097 | Values: 140.0 115.0 116.0 148.0 122.0 122.0 121.0 115.0 141.0 117.0 04:23:19 INFO - PROCESS | 27097 | 04:23:19 INFO - PROCESS | 27097 | [#2] audio-dft Cycles:10 Average:162.60 Median:163.00 stddev:0.84 (0.5%) stddev-sans-first:0.67 04:23:19 INFO - PROCESS | 27097 | Values: 161.0 164.0 162.0 162.0 163.0 163.0 162.0 163.0 163.0 163.0 04:23:19 INFO - PROCESS | 27097 | 04:23:19 INFO - PROCESS | 27097 | [#3] audio-fft Cycles:10 Average:81.70 Median:76.00 stddev:11.73 (15.4%) stddev-sans-first:12.41 04:23:19 INFO - PROCESS | 27097 | Values: 84.0 76.0 75.0 112.0 76.0 75.0 75.0 76.0 90.0 78.0 04:23:19 INFO - PROCESS | 27097 | 04:23:19 INFO - PROCESS | 27097 | [#4] audio-oscillator Cycles:10 Average:89.80 Median:82.00 stddev:13.12 (16.0%) stddev-sans-first:13.68 04:23:19 INFO - PROCESS | 27097 | Values: 83.0 82.0 108.0 82.0 82.0 82.0 106.0 81.0 80.0 112.0 04:23:19 INFO - PROCESS | 27097 | 04:23:19 INFO - PROCESS | 27097 | [#5] imaging-gaussian-blur Cycles:10 Average:113.30 Median:113.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 04:23:19 INFO - PROCESS | 27097 | Values: 113.0 113.0 113.0 113.0 114.0 113.0 113.0 114.0 114.0 113.0 04:23:19 INFO - PROCESS | 27097 | 04:23:19 INFO - PROCESS | 27097 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 04:23:19 INFO - PROCESS | 27097 | Values: 146.0 146.0 147.0 147.0 148.0 147.0 146.0 147.0 146.0 146.0 04:23:19 INFO - PROCESS | 27097 | 04:23:19 INFO - PROCESS | 27097 | [#7] imaging-desaturate Cycles:10 Average:93.70 Median:94.00 stddev:0.67 (0.7%) stddev-sans-first:0.67 04:23:19 INFO - PROCESS | 27097 | Values: 93.0 93.0 95.0 93.0 93.0 94.0 94.0 94.0 94.0 94.0 04:23:19 INFO - PROCESS | 27097 | 04:23:19 INFO - PROCESS | 27097 | [#8] json-parse-financial Cycles:10 Average:54.20 Median:55.00 stddev:0.92 (1.7%) stddev-sans-first:0.93 04:23:19 INFO - PROCESS | 27097 | Values: 55.0 54.0 55.0 53.0 55.0 55.0 54.0 53.0 55.0 53.0 04:23:19 INFO - PROCESS | 27097 | 04:23:19 INFO - PROCESS | 27097 | [#9] json-stringify-tinderbox Cycles:10 Average:54.20 Median:54.00 stddev:0.79 (1.5%) stddev-sans-first:0.83 04:23:19 INFO - PROCESS | 27097 | Values: 54.0 55.0 54.0 56.0 54.0 54.0 54.0 53.0 54.0 54.0 04:23:19 INFO - PROCESS | 27097 | 04:23:19 INFO - PROCESS | 27097 | [#10] stanford-crypto-aes Cycles:10 Average:80.30 Median:81.50 stddev:4.00 (4.9%) stddev-sans-first:4.20 04:23:19 INFO - PROCESS | 27097 | Values: 82.0 79.0 82.0 79.0 80.0 83.0 75.0 81.0 88.0 74.0 04:23:19 INFO - PROCESS | 27097 | 04:23:19 INFO - PROCESS | 27097 | [#11] stanford-crypto-ccm Cycles:10 Average:129.50 Median:129.50 stddev:10.66 (8.2%) stddev-sans-first:10.74 04:23:19 INFO - PROCESS | 27097 | Values: 120.0 127.0 120.0 135.0 124.0 120.0 128.0 135.0 155.0 131.0 04:23:19 INFO - PROCESS | 27097 | 04:23:19 INFO - PROCESS | 27097 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.40 Median:161.50 stddev:2.67 (1.7%) stddev-sans-first:2.83 04:23:19 INFO - PROCESS | 27097 | Values: 161.0 163.0 159.0 161.0 156.0 156.0 160.0 163.0 163.0 162.0 04:23:19 INFO - PROCESS | 27097 | 04:23:19 INFO - PROCESS | 27097 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:59.90 Median:60.00 stddev:2.02 (3.4%) stddev-sans-first:2.11 04:23:19 INFO - PROCESS | 27097 | Values: 61.0 60.0 59.0 60.0 65.0 60.0 59.0 59.0 58.0 58.0 04:23:19 INFO - PROCESS | 27097 | -------- Summary: end -------- 04:23:19 INFO - PROCESS | 27097 | 04:23:20 INFO - TEST-INFO | 27097: exit 0 04:23:20 INFO - TEST-OK | kraken | took 60478ms 04:23:20 INFO - SUITE-END | took 1176s 04:23:20 INFO - Completed test suite (00:19:36) 04:23:20 INFO - javascript benchmark 04:23:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7801.563503930919, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3406.267652454722, 3434.3989801784683, 3435.6220815710267, 3455.7408194385425, 3485.041613556272, 5754.079347304427, 5854.531637469003, 5868.76524939003, 5876.618019828708, 5878.441548052928, 5821.3887541808135, 5832.737526811293, 5860.384659610732, 5866.0, 5869.794557190499, 5270.525652691257, 5292.497212764782, 5322.494363035506, 5342.0, 5400.91898621521, 5181.041507321139, 5199.480051994789, 5389.73051347433, 5395.487428694288, 5399.19012148177, 5303.522682958533, 5320.840374788762, 5421.756020979045, 5428.022955867942, 5439.456054394549, 5408.540274076709, 5420.810271640494, 5424.810131645373, 5431.348238211401, 5433.6196466247375, 5115.974420127875, 5280.260763493114, 5324.467553244684, 5366.463353664602, 5423.915216956624, 5727.455891690282, 5728.68492232927, 5791.18923350727, 5808.651480911117, 5818.44724751148, 6246.187995560594, 6255.40573645503, 6278.560500764948, 6289.779857704958, 6295.18162638854, 6338.0, 6338.366163383671, 6339.2709838368255, 6343.111964324999, 6351.333110023474, 5691.4877661010705, 5730.398308177623, 5811.418858114197, 5849.502792262705, 5917.497012753878, 6366.936330636727, 6367.586106903036, 6375.234971803413, 6384.07430922523, 6439.323870993572, 6022.608530445507, 6124.418180272867, 6128.264608247039, 6155.292141403706, 6194.721237544321, 6025.186599809057, 6057.4851137653795, 6108.267007959073, 6291.6854157291955, 6304.306526282106, 6224.906626400608, 6236.875262494816, 6276.905846412307, 6285.277193122758, 6298.244210694655, 5938.138969849348, 5984.431479009487, 5989.431004054608, 6110.536573724111, 6166.445019948226, 4693.9765301173275, 4706.458757242893, 4742.952570474251, 4766.213574760195, 4773.522647735199, 4124.835006599702, 4134.276501612206, 4156.8337266509, 4216.915661686749, 4233.428487154257, 6077.027675571887, 6079.179310792986, 6086.726097325631, 6095.603785753912, 6102.908456373158, 6258.907481786409, 6302.684865756693, 6303.464205542488, 6305.054241863757, 6307.653079080695, 5748.051571490741, 6046.5767396281835, 6056.606320589148, 6062.0, 6069.393060693896, 5147.794088236428, 5281.841544753664, 5337.412884582693, 5339.41266460689, 5342.91985620216, 6624.668766561653, 6662.300458451889, 6663.400293973566, 6668.799616069155, 6672.933270667231, 6319.8104056878365, 6320.5891617044745, 6349.68251587428, 6380.266269379081, 6405.647689377129, 6379.043143528508, 6428.774992875227, 6511.316311787384, 6529.118568993125, 6626.0392243123515, 6209.503239740719, 6210.223722034746, 6218.5647004711045, 6219.564630475823, 6221.5333849962335, 6330.461910737639, 6332.176817013758, 6332.810015699536, 6334.1765570475545, 6336.556441049082, 5956.225690660186, 6002.729877155626, 6114.877702445837, 6126.846828829315, 6139.72371243304, 6128.66292353907, 6130.295016073209, 6139.032198454696, 6200.534959878118, 6203.0, 6112.633242005494, 6114.784027539347, 6115.0324970298125, 6119.112728654231, 6143.924813157769, 5927.733252003584, 5928.851778705394, 5993.370696077023, 6132.601380910227, 6156.938430615636, 6098.0852872069545, 6104.725287361991, 6111.591738512148, 6112.50348092447, 6120.8775824484155], "value": 5777.5098935334545, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [745.7799949015043, 799.9400044996626, 822.7202751064639, 901.5447199164421, 916.6608354908685, 24689.25932222034, 43145.35281970769, 43995.0, 47924.56226313216, 48199.0, 45281.0, 45425.0, 45585.0, 45596.316055259114, 45614.31578526325, 7513.737019204329, 7655.387568994467, 9159.77100572486, 9299.209567186797, 9309.0, 10229.079382855542, 10449.895501045006, 10749.516271767789, 10752.408617526073, 10761.461926903663, 10537.525811338508, 10581.576736930514, 10586.78826423471, 10593.099586535154, 10594.52324645389, 10484.266101372907, 10502.632407865687, 10513.158947284199, 10516.947415262952, 10531.947340263327, 10517.316374435713, 10535.631252906189, 10572.15422766177, 10577.206709496742, 10578.57685692579, 41808.0, 42211.155776884596, 42226.78886605578, 42270.0, 42278.78860605708, 4253.404523366731, 4292.687761726578, 4315.13697260546, 4396.648268138541, 4449.666275029385, 29163.125106246633, 29245.853770731224, 30095.247618809484, 30141.0957671268, 30656.08031759051, 4364.323529852878, 4414.426124603781, 4445.755483448409, 4475.351074094238, 4522.982328975987, 216192.0, 217109.0, 218178.0, 218451.90774046187, 218891.0, 53592.464075358745, 53716.73141634267, 53723.46276537263, 53945.0, 54181.72909135429, 53576.19635705467, 53654.73172634112, 53734.73132634312, 53765.73117134389, 53792.0, 14599.78100328496, 14787.11277323364, 14807.407703691948, 14823.481178158712, 14830.258487075604, 11557.07543396543, 11705.824412633818, 12389.442475088643, 12760.10679252462, 12820.166689165175, 13651.0, 13712.862871371359, 13723.588292351245, 13734.0, 13806.378712957941, 5430.429804870431, 5498.560115190775, 5529.198266251371, 5559.082751346064, 5575.4424557543925, 997.3866072365443, 1006.7936073104996, 1008.4907121903539, 1012.8480727890875, 1021.6424251511911, 26982.5952610711, 28372.0, 28730.425391492052, 28791.56812647812, 30195.69804301929, 1121.3608243301403, 1250.493550112206, 1261.1046157228286, 1271.841019872516, 1291.9160254583421, 13238.271895045866, 14613.85386146125, 14644.341004654603, 15179.316930738143, 15651.843481565267, 327879.0, 328897.0, 330014.0, 330532.0, 331762.0, 48574.75712621414, 48802.51197488051, 48807.755961220675, 48821.75589122103, 48860.75569622129, 1441.3657990484153, 1466.9193194374411, 1502.0612117426608, 1515.8256800467866, 1516.5071351810705, 26811.0, 28247.29381765472, 28622.0, 28676.569851451826, 28712.569311459927, 40025.1994960105, 40565.39151912665, 40627.0, 40745.79627101846, 40774.0, 285819.0, 287279.0, 288178.0, 288351.0, 289252.0, 24775.752242477345, 27688.58467123035, 29144.231298026654, 29164.0, 29667.258318542208, 37486.43770343393, 37749.0, 38176.42735358916, 38536.80731596324, 38712.80643596764, 32322.515162272113, 32408.351832962737, 32463.513047303837, 32626.347473049933, 32738.0, 32345.191370215933, 33126.33747325088, 34151.658483414845, 34229.48655770116, 36367.090822729646, 35264.29471410506, 35499.290014199054, 35697.0, 35714.28571428609, 36190.45714314235, 29370.11889643314, 30577.847110764305, 30915.84542077365, 31182.532262016543, 31214.0, 25035.0, 25298.620520691835, 25356.49287014286, 25738.742612573635, 25743.871280644227], "value": 18580.314109107643, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [409.94465747124127, 423.82411299310786, 458.44757067733383, 458.85316698656425, 481.0331234219219, 19679.5080122997, 20382.89808550957, 20936.476588085305, 21149.68275475869, 21154.89422552885, 19420.902895485502, 19604.411867643994, 19638.607227855435, 19677.114529846156, 19909.800901990977, 6589.571677840949, 6928.411085057776, 6937.0, 6937.6878040488045, 6943.548669336477, 6641.800745977628, 6715.798526044202, 6845.281245469228, 6869.931300686979, 6888.724451021953, 6671.532992690513, 6713.563618364815, 6900.171979362483, 6901.6204108774, 6905.102336696223, 6718.731250749964, 6759.0875231843565, 6792.830179245509, 6809.557378770364, 6811.62536060514, 6442.323556026597, 6448.000559913174, 6609.107770450975, 6638.4689224861895, 6648.434883034948, 24097.15659951911, 24208.757912420828, 24242.757572424227, 24258.39354016146, 24330.14844480435, 2912.8689208985647, 2996.3258266889993, 3000.9249768755735, 3022.4710675631677, 3077.261457250266, 15819.446319378767, 15965.12191829449, 16095.839041609668, 16104.677906441922, 16143.757843632355, 2228.754836967932, 2239.7760223977634, 2260.5139894922504, 2296.4258935266184, 2331.6502524621274, 92728.0, 93458.0, 94636.52681736616, 96978.51510742471, 97813.0, 17894.91052544729, 18118.184681689356, 18168.54651627893, 18383.26466941334, 18742.344017959305, 32531.837340813618, 32724.509132363033, 32780.0, 32796.3440731184, 33130.84042058516, 9507.477088760184, 9597.808043839084, 9600.807983840285, 9689.854652180224, 9843.901560984441, 7740.26467485588, 7771.455998080193, 7797.454178207585, 7913.0, 7958.045034595885, 9797.265205109503, 9964.900350996542, 10006.899931000597, 10112.949435252776, 10226.437545935045, 3843.5024128043347, 3853.133045064894, 3906.5898080701686, 4116.073883376276, 4118.649914757219, 969.6945462179391, 971.7327734872966, 972.6936015155203, 986.5461887531816, 986.6102889358663, 20417.285395011102, 20497.38507844767, 20544.17823287052, 20571.58856822855, 20751.377458676263, 961.1301771896445, 967.970960871175, 969.5297780576415, 974.4640447753707, 984.468387070988, 11527.884721152848, 11886.881131188751, 11981.400929953641, 12003.819942700866, 12024.519019239133, 671336.0, 711999.0, 730890.255746194, 745373.0, 755059.0, 87980.0, 89380.10619893718, 89868.5506572476, 90037.54981225183, 90087.0, 1241.9689507762198, 1245.4333278358324, 1289.0589869395394, 1289.471316760124, 1297.4874924404996, 17427.564310891823, 17681.734773978143, 18102.818971810113, 18146.45560633183, 18146.637067258845, 42206.0, 42784.5721542793, 43014.78492607517, 43034.78482607567, 43545.56454435415, 54779.0, 62462.0, 63750.362496374444, 64821.35178648153, 65912.34087659062, 11424.771504569695, 11901.523939042341, 12067.396630168632, 12491.375431228584, 12678.87321126777, 13962.4415023402, 14064.929675351557, 14095.0, 14108.576742697736, 14163.929180354033, 12235.571754988532, 12255.325957072446, 12379.442925068213, 12380.319082450551, 12407.75184496287, 12262.386880655753, 12342.938285308515, 12343.197692150341, 12396.318202498589, 12636.810447843474, 12622.621321360373, 12637.557685480964, 12655.620331390073, 12822.23066616006, 12917.418716157608, 12199.268043917393, 12218.816717749418, 12354.382280886099, 12710.428030738454, 12716.872831271568, 12365.443555040225, 12522.874771252535, 12564.87435125637, 12657.11400201977, 12980.805287920877], "value": 11181.007614818815, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1387.445021991204, 1572.2296074923283, 1583.6674298397336, 1586.6192113892666, 1587.6904003719264, 9114.0, 10904.727381815459, 11356.48895799689, 11632.941835290832, 11645.068394528438, 11307.265027773188, 11401.0, 11405.885941140587, 11409.771804563925, 11429.485673144707, 1855.8793678410927, 1916.0036780873936, 2372.181597348912, 2432.2338463384067, 2434.075051480444, 2347.6830627865193, 2426.296374051523, 2428.1258746851117, 2429.2712186344115, 2429.927102186937, 2347.4600841806396, 2357.0453966143655, 2364.137089962169, 2367.502824406868, 2395.8802059896934, 2369.715634123899, 2380.940476488084, 2386.1886958434216, 2386.7971222446026, 2398.4123889646976, 2223.132978138511, 2238.9776102238934, 2242.6636004599277, 2248.033345661365, 2251.0995601759264, 11085.889141108566, 11171.44142792857, 11221.719457013558, 11255.380954047525, 11255.606053788078, 5536.861578460531, 5670.3479099903625, 5671.886562268773, 5675.9432405675825, 5684.459976302244, 3279.5080737889507, 3306.50402439636, 3479.3041391721504, 3544.0608238816735, 3567.340042092221, 1344.435337158396, 1350.777121774906, 1388.3891087921281, 1402.4039783092146, 1416.0937000319805, 16638.0, 16662.416815411525, 16702.331906723837, 16703.16484175786, 16710.248038838283, 4672.92023009691, 4795.592374648124, 4817.205161148441, 4898.044881248194, 4904.8038078477175, 14212.218327991854, 14219.573412797632, 14220.431182752574, 14222.715545689029, 14228.14631122136, 5876.08920617305, 5881.2942446906645, 5884.47039766423, 5885.470307672244, 5891.823245302562, 5117.718525481134, 5180.067587834151, 5232.372115346183, 5276.472352764693, 5281.683099014072, 4187.476565429321, 4226.1758957003085, 4233.830646774095, 4282.336237883133, 4294.549072347359, 1137.6132115080911, 1140.885911408869, 1158.7276989907366, 1159.3855256713787, 1165.3182888010608, 1055.5302890213782, 1090.4111779639065, 1091.6343025086526, 1094.9781004379868, 1098.5166526728374, 7170.0, 7228.421726261887, 7238.348548630648, 7260.745873894494, 7322.400547805559, 1034.384541197986, 1037.6938803053117, 1042.5725452564411, 1045.7281106912258, 1058.1904842795268, 4346.958724838937, 4422.248217802981, 4564.018735971782, 4673.813047478131, 4712.6229901607785, 14312.0, 14638.121712697272, 14644.341004654816, 14647.92676036613, 14667.0, 13359.1316564423, 13853.653658658613, 13873.890088792872, 13879.930600346934, 14472.638184045272, 10312.742181445525, 10492.737681558023, 10506.579736810441, 10506.579736810594, 10561.841572376421, 7115.324044215791, 7335.972963784968, 7385.519941203805, 7399.852002959803, 7469.327760501364, 12691.873081269068, 12743.299118548568, 12836.55072072473, 13000.959923205932, 13062.34688265602, 12881.162724422882, 12895.806562901376, 13078.476860925457, 13176.209427434385, 13459.327033648475, 9430.29272804556, 9675.177609902956, 9679.758006049906, 9684.515774211402, 9685.9031409685, 10240.897591024292, 10331.896681033395, 10338.793224135325, 10358.067773900386, 10429.269951103654, 8824.602892869709, 8908.688195913111, 8927.821443570961, 9024.097590240923, 9039.0, 8732.956335218283, 8828.249598784176, 8873.91126088731, 8978.0, 9173.862392063991, 8011.479253848481, 8047.195280471906, 8059.637316320897, 8087.433879628605, 8089.635966381645, 6216.285127210429, 6313.96843015782, 6356.237251529846, 6381.649009304533, 6473.64394958263, 6199.876002480015, 6200.7519699211525, 6203.689815509116, 6359.650219237987, 6407.807765767035], "value": 5350.19225140877, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.0385731813148, 412.1412429940966, 412.6595558664103, 429.9548547402521, 430.1032347555347, 4939.0, 5114.641975061747, 5185.703574106474, 5196.974015129919, 5228.248536740197, 4946.233333833253, 5108.616853735966, 5125.615578831594, 5148.716820574867, 5182.300389447423, 4487.259602165639, 4507.932381014288, 4528.54714528547, 4535.319702044703, 4542.636589072867, 4328.632066274355, 4432.20220360335, 4482.753448560328, 4534.773261336936, 4563.429571303587, 4522.773861306938, 4536.500984891659, 4539.568740969603, 4542.8864278392975, 4556.931646025312, 4475.373447717322, 4495.43807024122, 4505.932411013838, 4523.36672865799, 4622.214223581999, 4326.935095973563, 4369.366441865912, 4373.278409062501, 4416.6025057744955, 4435.844745433894, 4989.975050124726, 5033.370828646419, 5053.46938571452, 5074.720890351029, 5087.949120508784, 5126.384833819928, 5182.948170518284, 5188.948110518884, 5212.4266330703595, 5212.765425555859, 5201.271821944931, 5383.623146379755, 5421.891562168774, 5472.890542189134, 5487.945120548783, 4743.600637811854, 4759.5002524734755, 4761.0, 4763.618910487153, 4775.952240477585, 5625.665348880209, 5670.306604362936, 5702.519404059248, 5713.171785028792, 5723.0, 4801.447833499123, 4964.627652926045, 4978.576820970258, 4991.5258050485145, 5024.949750502521, 4808.543188397097, 5053.1050855929025, 5061.0, 5067.366579177603, 5084.8813261082505, 5097.362829646294, 5137.229415587692, 5145.614078944094, 5199.584033277404, 5210.166373380241, 5380.0, 5431.782728690808, 5440.9934162180125, 5444.346678398618, 5461.590380721462, 1686.8060173080007, 1704.7101992661278, 1707.1299793326918, 1728.135932033983, 1729.1757196158173, 1402.193738600309, 1419.425132821209, 1421.5713208225668, 1427.928603569838, 1443.758367803688, 5323.334583177103, 5361.0, 5430.104032834538, 5432.375276843213, 5485.50630443262, 5530.7511161997, 5575.972120139454, 5579.6652200868075, 5591.720413979285, 5644.717764111778, 5207.110053920035, 5308.522232999048, 5344.893102137936, 5381.67709937405, 5390.975714614211, 2915.4606397816474, 2919.1826288639213, 2919.9854000730284, 2928.9267768305535, 2934.6038284831275, 5505.284313039359, 5791.160281759121, 5807.796727114531, 5811.709414529257, 5821.301443826683, 5630.0, 5645.350784659817, 5647.971760141173, 5651.350094739076, 5664.971675141598, 5774.335951365647, 5788.884222315614, 5799.913001305068, 5844.6785426801935, 5864.560157988082, 5313.707746074003, 5549.916751248816, 5550.306211723535, 5607.915881261702, 5625.69058701759, 5449.836504904859, 5549.5837812165055, 5549.833504994856, 5576.832695019156, 5591.804286849941, 5704.828855134353, 5807.622504537191, 5811.4479124483105, 5823.253024092671, 5872.55955803325, 4656.696125084982, 4662.090892275974, 4667.0, 4687.1328804171335, 4711.740854253049, 5355.839324820262, 5471.604740791073, 5474.835754927359, 5588.217649529151, 5594.440555944373, 5442.537384322377, 5444.638840289927, 5448.673079615236, 5453.118674057444, 5455.9454405455435, 5146.382434107782, 5382.596305277199, 5420.620556561161, 5441.8437306363, 5507.614466987273, 5376.596755243294, 5379.892402152013, 5407.810726624549, 5411.540019098264, 5418.160185171305, 5414.35027796667, 5463.524848291018, 5482.53286021284, 5528.806491772769, 5539.335279766454, 5079.568236699774, 5304.310439642822, 5305.681659100466, 5312.229726689686, 5329.1896294149865], "value": 4459.767965707533, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [813.438727278178, 836.4646626159259, 846.4751853850613, 857.425524898318, 870.2081106193365, 16791.244394002268, 18314.45056648303, 18395.72406413905, 18414.631707365843, 18585.88484690918, 16284.592885177877, 16463.753043704353, 16568.83431165688, 16572.502824915242, 16582.66834663306, 885.305035547094, 900.8063266397724, 910.194477887068, 910.399136569864, 912.338554547954, 907.1699395053519, 907.3149771922223, 907.4509921497498, 907.686848037426, 908.7228395339419, 947.7251597036851, 948.0282710222043, 948.3740731117464, 948.6916752055575, 948.905109489049, 948.1940350701917, 950.6957773512479, 950.9572069256866, 952.1478276942132, 952.3333666433455, 692.6709812838911, 694.1115372323434, 694.1531331775226, 694.6110178300169, 696.3593493985545, 17398.7390189146, 17590.0, 17594.91202543979, 18365.0, 18580.44258672242, 15615.687686246212, 15916.840831591651, 16072.0, 16165.515034548982, 16312.592185195346, 13451.32743362828, 13519.932400338033, 13574.253416062113, 13662.795058074136, 13776.724465510733, 4017.6183262590007, 4103.158852435244, 4114.485689288839, 4140.37894315852, 4152.60550247729, 40305.79847100775, 51341.486585134415, 69622.0, 75520.24479755187, 82162.58918705369, 12754.36228188587, 12848.935755321163, 12886.420111094836, 12920.095593308379, 12982.350882456029, 22803.0, 22809.0, 23083.769162308497, 23168.65247021296, 23227.7677223229, 9273.629054837731, 9276.257899368034, 9278.0, 9294.117058879396, 9347.392419492711, 4749.501302363202, 4827.0, 4837.516248375135, 4871.098846713369, 4957.03337849116, 3863.362545180014, 3932.508436445444, 3934.193490334532, 3935.0359162005493, 3945.6646185074014, 655.7475371981822, 701.6176183979743, 729.2634439216324, 731.4660297982502, 742.7957311739207, 693.5457275484565, 699.6956323998975, 700.5656492974389, 713.183405001281, 718.4647437658978, 11459.541618335174, 11535.19253652253, 11680.415979201007, 11844.940775296069, 12000.879991199976, 856.9314454843598, 857.652650676477, 858.6093327535956, 870.3907264914585, 880.41892351048, 5204.8959020819375, 5220.347456567929, 5239.816606418757, 5242.030224408497, 5280.788768449296, 63481.0, 78985.60507197543, 80217.59891200507, 81637.18362816414, 82051.5897420521, 44676.55323446724, 62397.37602624006, 65531.344686552526, 65753.34246657568, 67552.3244767546, 53289.0, 58298.12552811711, 58748.706256468446, 58905.11642325368, 59312.11031834526, 11426.25729327591, 11878.762424751629, 11919.0, 12230.816537752118, 12235.877641223475, 40938.976525587095, 41017.1796564073, 41518.79240603778, 41922.58077419309, 42487.78756106323, 49304.0, 50009.499905000484, 50241.49758502368, 50506.0, 50510.49489505205, 14097.788533171806, 14156.150630962175, 14251.643708906946, 14350.354234059283, 14437.494687686301, 15624.453144139901, 15934.60163495922, 15996.040237585783, 16011.0, 16203.351865925231, 14987.40050397972, 15233.542993710207, 15319.617009574404, 15344.846551534789, 15883.444079457626, 15629.76555351648, 15702.685946280782, 15729.292181851615, 16123.516294510715, 16623.418180363627, 14723.411063557338, 14741.484048058266, 14754.262286885398, 15076.773848392064, 15315.923420383273, 12471.376431178223, 13001.284929328978, 13057.542985995444, 13110.410031548412, 13537.323133843465, 12349.0, 13343.66640833948, 13397.009800986056, 13621.863781362455, 13626.93186534061], "value": 7872.206002456698, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1463.5000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 113.0, 113.0, 112.0, 112.0, 113.0, 113.0, 112.0, 112.0, 111.0], "value": 111.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 115.0, 116.0, 148.0, 122.0, 122.0, 121.0, 115.0, 141.0, 117.0], "value": 125.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 164.0, 162.0, 162.0, 163.0, 163.0, 162.0, 163.0, 163.0, 163.0], "value": 162.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 76.0, 75.0, 112.0, 76.0, 75.0, 75.0, 76.0, 90.0, 78.0], "value": 81.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 108.0, 82.0, 82.0, 82.0, 106.0, 81.0, 80.0, 112.0], "value": 89.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 113.0, 113.0, 114.0, 113.0, 113.0, 114.0, 114.0, 113.0], "value": 113.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 147.0, 148.0, 147.0, 146.0, 147.0, 146.0, 146.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 95.0, 93.0, 93.0, 94.0, 94.0, 94.0, 94.0, 94.0], "value": 93.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 55.0, 53.0, 55.0, 55.0, 54.0, 53.0, 55.0, 53.0], "value": 54.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 54.0, 56.0, 54.0, 54.0, 54.0, 53.0, 54.0, 54.0], "value": 54.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 79.0, 82.0, 79.0, 80.0, 83.0, 75.0, 81.0, 88.0, 74.0], "value": 80.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 127.0, 120.0, 135.0, 124.0, 120.0, 128.0, 135.0, 155.0, 131.0], "value": 129.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 159.0, 161.0, 156.0, 156.0, 160.0, 163.0, 163.0, 162.0], "value": 160.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 59.0, 60.0, 65.0, 60.0, 59.0, 59.0, 58.0, 58.0], "value": 59.9, "unit": "score"}]}]} 04:23:20 INFO - Return code: 0 04:23:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:23:20 ERROR - # TBPL SUCCESS # 04:23:20 INFO - Running post-action listener: _resource_record_post_action 04:23:20 INFO - [mozharness: 2017-03-21 11:23:20.782071Z] Finished run-tests step (success) 04:23:20 INFO - Running post-run listener: _resource_record_post_run 04:23:20 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 372715520; Read time: 16; Write time: 251808 04:23:20 INFO - TinderboxPrint: CPU usage
13.1% 04:23:20 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 04:23:20 INFO - TinderboxPrint: I/O write bytes / time
372,715,520 / 251,808 04:23:20 INFO - TinderboxPrint: CPU idle
8,271.2 (86.9%) 04:23:20 INFO - TinderboxPrint: CPU user
1,200.9 (12.6%) 04:23:20 INFO - TinderboxPrint: Swap in / out
0 / 0 04:23:20 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 117456896; Read time: 0; Write time: 86780 04:23:20 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 4096; Write bytes: 254283776; Read time: 16; Write time: 164996 04:23:21 INFO - Running post-run listener: _upload_blobber_files 04:23:21 INFO - Blob upload gear active. 04:23:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:23:21 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 04:23:21 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'] 04:23:21 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 04:23:21 INFO - (blobuploader) - INFO - Open directory for files ... 04:23:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:23:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:23:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:23:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:23:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:23:22 INFO - (blobuploader) - INFO - Done attempting. 04:23:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:23:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:23:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:23:26 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:23:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:23:26 INFO - (blobuploader) - INFO - Done attempting. 04:23:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:23:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:23:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:23:27 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:23:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:23:27 INFO - (blobuploader) - INFO - Done attempting. 04:23:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:23:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:23:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:23:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:23:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:23:28 INFO - (blobuploader) - INFO - Done attempting. 04:23:28 INFO - (blobuploader) - INFO - Iteration through files over. 04:23:28 INFO - Return code: 0 04:23:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:23:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:23:28 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d44246ca56dceb5eba4c7ce5752f59f795efba9ca7fd12301c4cbb06ce98b7f984028bdc8ee38892b5826bf239080a577fb94296ca639a790602843b53b40b8a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/07a7ab4eecc639b99fe6462cc15916229e833f3a92cb91d8c3b5dcafc904af2f22757f9594df6ad06881561471e157cb0f6c378da382fe52c7cd3b1733a614ea", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/946f47885409decff1da57a77e6bb79905c0bc1ffd2373fe82ca608c1d55cf453fe642e823e1af1d3d83f1365eb62a4e5bbd08161f902d77a99c1eac1d402159", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9335eb4906ed90fa45b1828128170d07f684f8b4e4511c6e5f96a4e72763878bcebb87a8e009870839518dc93f1b5b905b5b17ba6b2c2b723fc4c14382ad2a77"} 04:23:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:23:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:23:28 INFO - Contents: 04:23:28 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d44246ca56dceb5eba4c7ce5752f59f795efba9ca7fd12301c4cbb06ce98b7f984028bdc8ee38892b5826bf239080a577fb94296ca639a790602843b53b40b8a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/07a7ab4eecc639b99fe6462cc15916229e833f3a92cb91d8c3b5dcafc904af2f22757f9594df6ad06881561471e157cb0f6c378da382fe52c7cd3b1733a614ea", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/946f47885409decff1da57a77e6bb79905c0bc1ffd2373fe82ca608c1d55cf453fe642e823e1af1d3d83f1365eb62a4e5bbd08161f902d77a99c1eac1d402159", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9335eb4906ed90fa45b1828128170d07f684f8b4e4511c6e5f96a4e72763878bcebb87a8e009870839518dc93f1b5b905b5b17ba6b2c2b723fc4c14382ad2a77"} 04:23:28 INFO - Running post-run listener: copy_logs_to_upload_dir 04:23:28 INFO - Copying logs to upload dir... 04:23:28 INFO - mkdir: /builds/slave/test/build/upload/logs 04:23:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.646272 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-03-21 04:23:28.342477) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-21 04:23:28.346272) ========= 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=4300f881736b422476174874000001bc-1490094150.521909-1130967365 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/d44246ca56dceb5eba4c7ce5752f59f795efba9ca7fd12301c4cbb06ce98b7f984028bdc8ee38892b5826bf239080a577fb94296ca639a790602843b53b40b8a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/07a7ab4eecc639b99fe6462cc15916229e833f3a92cb91d8c3b5dcafc904af2f22757f9594df6ad06881561471e157cb0f6c378da382fe52c7cd3b1733a614ea", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/946f47885409decff1da57a77e6bb79905c0bc1ffd2373fe82ca608c1d55cf453fe642e823e1af1d3d83f1365eb62a4e5bbd08161f902d77a99c1eac1d402159", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9335eb4906ed90fa45b1828128170d07f684f8b4e4511c6e5f96a4e72763878bcebb87a8e009870839518dc93f1b5b905b5b17ba6b2c2b723fc4c14382ad2a77"} build_url:https://queue.taskcluster.net/v1/task/fTwnJ8sOQ7KJyY1DWRdvBA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011390 build_url: 'https://queue.taskcluster.net/v1/task/fTwnJ8sOQ7KJyY1DWRdvBA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d44246ca56dceb5eba4c7ce5752f59f795efba9ca7fd12301c4cbb06ce98b7f984028bdc8ee38892b5826bf239080a577fb94296ca639a790602843b53b40b8a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/07a7ab4eecc639b99fe6462cc15916229e833f3a92cb91d8c3b5dcafc904af2f22757f9594df6ad06881561471e157cb0f6c378da382fe52c7cd3b1733a614ea", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/946f47885409decff1da57a77e6bb79905c0bc1ffd2373fe82ca608c1d55cf453fe642e823e1af1d3d83f1365eb62a4e5bbd08161f902d77a99c1eac1d402159", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9335eb4906ed90fa45b1828128170d07f684f8b4e4511c6e5f96a4e72763878bcebb87a8e009870839518dc93f1b5b905b5b17ba6b2c2b723fc4c14382ad2a77"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-21 04:23:28.370823) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 04:23:28.371119) ========= 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=4300f881736b422476174874000001bc-1490094150.521909-1130967365 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004427 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 04:23:28.455729) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-21 04:23:28.456045) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-21 04:23:28.456331) ========= ========= Total master_lag: 0.17 =========