builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-031 starttime: 1489727259.93 results: success (0) revision: dff5f8de5eed5a31fde56f87e8a75fbcc4a2ddff ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-16 22:07:39.933790) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-16 22:07:39.934281) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-16 22:07:39.934701) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-16 22:07:39.951515) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-16 22:07:39.951930) ========= 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=db0483c52d987ecb441a263b000001ad-1489726431.561765-1911677626 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-16 22:07:39-- 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% 42.4M=0s 2017-03-16 22:07:40 (42.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.146874 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-16 22:07:40.115637) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-16 22:07:40.116073) ========= 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=db0483c52d987ecb441a263b000001ad-1489726431.561765-1911677626 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016649 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-16 22:07:40.186259) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-16 22:07:40.186639) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev dff5f8de5eed5a31fde56f87e8a75fbcc4a2ddff --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 dff5f8de5eed5a31fde56f87e8a75fbcc4a2ddff --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=db0483c52d987ecb441a263b000001ad-1489726431.561765-1911677626 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-16 22:07:40,270 truncating revision to first 12 chars 2017-03-16 22:07:40,270 Setting DEBUG logging. 2017-03-16 22:07:40,270 attempt 1/10 2017-03-16 22:07:40,270 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/dff5f8de5eed?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-16 22:07:40,569 unpacking tar archive at: mozilla-aurora-dff5f8de5eed/testing/mozharness/ program finished with exit code 0 elapsedTime=0.644260 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-16 22:07:40.847983) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-16 22:07:40.848560) ========= script_repo_revision: dff5f8de5eed5a31fde56f87e8a75fbcc4a2ddff ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-16 22:07:40.849206) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-16 22:07:40.849704) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-16 22:07:40.861412) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-03-16 22:07:40.861868) ========= /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=db0483c52d987ecb441a263b000001ad-1489726431.561765-1911677626 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:07:41 INFO - MultiFileLogger online at 20170316 22:07:41 in /builds/slave/test 22:07:41 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 22:07:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:07:41 INFO - {'append_to_log': False, 22:07:41 INFO - 'base_work_dir': '/builds/slave/test', 22:07:41 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 22:07:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:07:41 INFO - 'branch': 'Mozilla-Aurora', 22:07:41 INFO - 'buildbot_json_path': 'buildprops.json', 22:07:41 INFO - 'config_files': ('talos/linux_config.py',), 22:07:41 INFO - 'default_actions': ('clobber', 22:07:41 INFO - 'read-buildbot-config', 22:07:41 INFO - 'download-and-extract', 22:07:41 INFO - 'populate-webroot', 22:07:41 INFO - 'create-virtualenv', 22:07:41 INFO - 'install', 22:07:41 INFO - 'run-tests'), 22:07:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:07:41 INFO - 'download_minidump_stackwalk': True, 22:07:41 INFO - 'download_symbols': 'ondemand', 22:07:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:07:41 INFO - 'tooltool.py': '/tools/tooltool.py', 22:07:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:07:41 INFO - '/tools/misc-python/virtualenv.py')}, 22:07:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:07:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:07:41 INFO - 'gecko_profile': False, 22:07:41 INFO - 'gecko_profile_interval': 0, 22:07:41 INFO - 'installer_path': 'installer.exe', 22:07:41 INFO - 'log_level': 'info', 22:07:41 INFO - 'log_name': 'talos', 22:07:41 INFO - 'log_to_console': True, 22:07:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:07:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:07:41 INFO - 'opt_config_files': (), 22:07:41 INFO - 'pip_index': False, 22:07:41 INFO - 'suite': 'dromaeojs', 22:07:41 INFO - 'system_bits': '32', 22:07:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:07:41 INFO - 'title': 'talos-linux64-ix-031', 22:07:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:07:41 INFO - 'use_talos_json': True, 22:07:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:07:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:07:41 INFO - 'work_dir': 'build'} 22:07:41 INFO - [mozharness: 2017-03-17 05:07:41.049617Z] Running clobber step. 22:07:41 INFO - Running pre-action listener: _resource_record_pre_action 22:07:41 INFO - Running main action method: clobber 22:07:41 INFO - rmtree: /builds/slave/test/build 22:07:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:07:42 INFO - Running post-action listener: _resource_record_post_action 22:07:42 INFO - [mozharness: 2017-03-17 05:07:42.495426Z] Finished clobber step (success) 22:07:42 INFO - [mozharness: 2017-03-17 05:07:42.495523Z] Running read-buildbot-config step. 22:07:42 INFO - Running pre-action listener: _resource_record_pre_action 22:07:42 INFO - Running main action method: read_buildbot_config 22:07:42 INFO - Using buildbot properties: 22:07:42 INFO - { 22:07:42 INFO - "project": "", 22:07:42 INFO - "product": "firefox", 22:07:42 INFO - "who": "eakhgari@mozilla.com", 22:07:42 INFO - "installer_path": "public/build/target.tar.bz2", 22:07:42 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 22:07:42 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-aurora/", 22:07:42 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 22:07:42 INFO - "stage_platform": "linux64-pgo", 22:07:42 INFO - "basedir": "/builds/slave/test", 22:07:42 INFO - "buildnumber": 1103, 22:07:42 INFO - "platform": "ubuntu64_hw", 22:07:42 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 22:07:42 INFO - "slavebuilddir": "test", 22:07:42 INFO - "taskId": "N1n0-2QJSaaP0lYGLwEflA", 22:07:42 INFO - "branch": "mozilla-aurora", 22:07:42 INFO - "script_repo_revision": "production", 22:07:42 INFO - "revision": "dff5f8de5eed5a31fde56f87e8a75fbcc4a2ddff", 22:07:42 INFO - "slavename": "talos-linux64-ix-031", 22:07:42 INFO - "repo_path": "releases/mozilla-aurora" 22:07:42 INFO - } 22:07:42 INFO - Finding installer, test and symbols from parent task. 22:07:42 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/N1n0-2QJSaaP0lYGLwEflA'}, attempt #1 22:07:42 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/N1n0-2QJSaaP0lYGLwEflA'}, attempt #1 22:07:43 INFO - Task dependencies: To2NTRFkTI2cEeg1u-ty6w 22:07:43 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/To2NTRFkTI2cEeg1u-ty6w'}, attempt #1 22:07:43 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/To2NTRFkTI2cEeg1u-ty6w/artifacts/public/build/target.tar.bz2 22:07:43 INFO - Set test_url: https://queue.taskcluster.net/v1/task/To2NTRFkTI2cEeg1u-ty6w/artifacts/public/build/test_packages.json 22:07:43 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/To2NTRFkTI2cEeg1u-ty6w/artifacts/public/build/target.crashreporter-symbols.zip 22:07:43 INFO - Running post-action listener: _resource_record_post_action 22:07:43 INFO - [mozharness: 2017-03-17 05:07:43.873541Z] Finished read-buildbot-config step (success) 22:07:43 INFO - [mozharness: 2017-03-17 05:07:43.873757Z] Running download-and-extract step. 22:07:43 INFO - Running pre-action listener: _resource_record_pre_action 22:07:43 INFO - Running main action method: download_and_extract 22:07:43 INFO - mkdir: /builds/slave/test/build/tests 22:07: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')]} 22:07:43 INFO - trying https://queue.taskcluster.net/v1/task/To2NTRFkTI2cEeg1u-ty6w/artifacts/public/build/target.test_packages.json 22:07:43 INFO - Downloading https://queue.taskcluster.net/v1/task/To2NTRFkTI2cEeg1u-ty6w/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 22:07:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/To2NTRFkTI2cEeg1u-ty6w/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 22:07:44 INFO - Downloaded 896 bytes. 22:07:44 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 22:07:44 INFO - Using the following test package requirements: 22:07:44 INFO - {u'common': [u'target.common.tests.zip'], 22:07:44 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 22:07:44 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 22:07:44 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 22:07:44 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 22:07:44 INFO - u'mozbase': [u'target.common.tests.zip'], 22:07:44 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 22:07:44 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 22:07:44 INFO - u'web-platform': [u'target.common.tests.zip', 22:07:44 INFO - u'target.web-platform.tests.zip'], 22:07:44 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 22:07:44 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 22:07:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/To2NTRFkTI2cEeg1u-ty6w/artifacts/public/build/target.common.tests.zip 22:07:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/To2NTRFkTI2cEeg1u-ty6w/artifacts/public/build/target.common.tests.zip'}, attempt #1 22:07:44 INFO - Fetch https://queue.taskcluster.net/v1/task/To2NTRFkTI2cEeg1u-ty6w/artifacts/public/build/target.common.tests.zip into memory 22:07:45 INFO - Expected file size: 59534188 22:07:45 INFO - Obtained file size: 59534188 22:07:55 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 22:07:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/To2NTRFkTI2cEeg1u-ty6w/artifacts/public/build/target.common.tests.zip 22:07:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/To2NTRFkTI2cEeg1u-ty6w/artifacts/public/build/target.common.tests.zip'}, attempt #1 22:07:55 INFO - Fetch https://queue.taskcluster.net/v1/task/To2NTRFkTI2cEeg1u-ty6w/artifacts/public/build/target.common.tests.zip into memory 22:07:57 INFO - Expected file size: 59534188 22:07:57 INFO - Obtained file size: 59534188 22:08:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/To2NTRFkTI2cEeg1u-ty6w/artifacts/public/build/target.talos.tests.zip 22:08:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/To2NTRFkTI2cEeg1u-ty6w/artifacts/public/build/target.talos.tests.zip'}, attempt #1 22:08:07 INFO - Fetch https://queue.taskcluster.net/v1/task/To2NTRFkTI2cEeg1u-ty6w/artifacts/public/build/target.talos.tests.zip into memory 22:08:08 INFO - Expected file size: 14404424 22:08:08 INFO - Obtained file size: 14404424 22:08:08 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')]} 22:08:08 INFO - trying https://queue.taskcluster.net/v1/task/To2NTRFkTI2cEeg1u-ty6w/artifacts/public/build/target.tar.bz2 22:08:08 INFO - Downloading https://queue.taskcluster.net/v1/task/To2NTRFkTI2cEeg1u-ty6w/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 22:08:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/To2NTRFkTI2cEeg1u-ty6w/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 22:08:11 INFO - Downloaded 66646043 bytes. 22:08:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/To2NTRFkTI2cEeg1u-ty6w/artifacts/public/build/target.tar.bz2 22:08:11 INFO - mkdir: /builds/slave/test/properties 22:08:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:08:11 INFO - Writing to file /builds/slave/test/properties/build_url 22:08:11 INFO - Contents: 22:08:11 INFO - build_url:https://queue.taskcluster.net/v1/task/To2NTRFkTI2cEeg1u-ty6w/artifacts/public/build/target.tar.bz2 22:08:11 INFO - Running post-action listener: _resource_record_post_action 22:08:11 INFO - Running post-action listener: set_extra_try_arguments 22:08:11 INFO - [mozharness: 2017-03-17 05:08:11.591922Z] Finished download-and-extract step (success) 22:08:11 INFO - [mozharness: 2017-03-17 05:08:11.592148Z] Running populate-webroot step. 22:08:11 INFO - Running pre-action listener: _resource_record_pre_action 22:08:11 INFO - Running main action method: populate_webroot 22:08:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:08:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:08:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:08:11 INFO - '--tppagecycles', 22:08:11 INFO - '7'], 22:08:11 INFO - 'tests': ['tsvgm']}}, 22:08:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:08:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:08:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:08:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:08:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:08:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:08:11 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 22:08:11 INFO - 'talos_options': ['--disable-e10s'], 22:08:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:08:11 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 22:08:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:08:11 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 22:08:11 INFO - 'talos_options': ['--disable-e10s'], 22:08:11 INFO - 'tests': ['damp', 'tps']}, 22:08:11 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 22:08:11 INFO - 'tests': ['damp', 'tps']}, 22:08:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:08:11 INFO - 'tests': ['dromaeo_dom']}, 22:08:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:08:11 INFO - 'g4': {'talos_options': ['--disable-e10s'], 22:08:11 INFO - 'tests': ['basic_compositor_video']}, 22:08:11 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 22:08:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:08:11 INFO - 'tests': ['a11yr', 22:08:11 INFO - 'ts_paint', 22:08:11 INFO - 'tpaint', 22:08:11 INFO - 'sessionrestore', 22:08:11 INFO - 'sessionrestore_no_auto_restore', 22:08:11 INFO - 'tabpaint']}, 22:08:11 INFO - 'other-e10s': {'tests': ['a11yr', 22:08:11 INFO - 'ts_paint', 22:08:11 INFO - 'tpaint', 22:08:11 INFO - 'sessionrestore', 22:08:11 INFO - 'sessionrestore_no_auto_restore', 22:08:11 INFO - 'tabpaint']}, 22:08:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:08:11 INFO - 'ts_paint', 22:08:11 INFO - 'tpaint', 22:08:11 INFO - 'sessionrestore', 22:08:11 INFO - 'sessionrestore_no_auto_restore', 22:08:11 INFO - 'tabpaint']}, 22:08:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:08:11 INFO - 'ts_paint', 22:08:11 INFO - 'tpaint', 22:08:11 INFO - 'sessionrestore', 22:08:11 INFO - 'sessionrestore_no_auto_restore', 22:08:11 INFO - 'tabpaint']}, 22:08:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:08:11 INFO - 'tests': ['a11yr', 22:08:11 INFO - 'ts_paint', 22:08:11 INFO - 'tpaint', 22:08:11 INFO - 'sessionrestore', 22:08:11 INFO - 'sessionrestore_no_auto_restore', 22:08:11 INFO - 'tabpaint']}, 22:08:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:08:11 INFO - 'tests': ['a11yr', 22:08:11 INFO - 'ts_paint', 22:08:11 INFO - 'tpaint', 22:08:11 INFO - 'sessionrestore', 22:08:11 INFO - 'sessionrestore_no_auto_restore', 22:08:11 INFO - 'tabpaint']}, 22:08:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:08:11 INFO - 'tests': ['tsvgx', 22:08:11 INFO - 'tsvgr_opacity', 22:08:11 INFO - 'tart', 22:08:11 INFO - 'tscrollx', 22:08:11 INFO - 'cart', 22:08:11 INFO - 'tsvg_static']}, 22:08:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:08:11 INFO - 'tsvgr_opacity', 22:08:11 INFO - 'tart', 22:08:11 INFO - 'tscrollx', 22:08:11 INFO - 'cart', 22:08:11 INFO - 'tsvg_static']}, 22:08:11 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 22:08:11 INFO - 'talos_options': ['--disable-e10s'], 22:08:11 INFO - 'tests': ['tp5o']}, 22:08:11 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 22:08:11 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 22:08:11 INFO - 'talos_options': ['--disable-e10s', 22:08:11 INFO - '--xperf_path', 22:08:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:08:11 INFO - 'tests': ['tp5n']}, 22:08:11 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 22:08:11 INFO - 'talos_options': ['--xperf_path', 22:08:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:08:11 INFO - 'tests': ['tp5n']}}, 22:08:11 INFO - 'talos.zip': {'path': '', 22:08:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:08:11 INFO - Running post-action listener: _resource_record_post_action 22:08:11 INFO - [mozharness: 2017-03-17 05:08:11.610866Z] Finished populate-webroot step (success) 22:08:11 INFO - [mozharness: 2017-03-17 05:08:11.610955Z] Running create-virtualenv step. 22:08:11 INFO - Running pre-action listener: _resource_record_pre_action 22:08:11 INFO - Running main action method: create_virtualenv 22:08:11 INFO - Creating virtualenv /builds/slave/test/build/venv 22:08:11 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 22:08:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:08:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:08:11 INFO - Using real prefix '/usr' 22:08:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:08:12 INFO - Installing distribute.............................................................................................................................................................................................done. 22:08:14 INFO - Installing pip.................done. 22:08:14 INFO - Return code: 0 22:08:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 22:08:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 22:08:14 INFO - Reading from file tmpfile_stdout 22:08:14 INFO - Output received: 22:08:14 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) 22:08:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:08:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:08:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:08:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:08:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:08:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:08:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:08:14 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 0x1f7a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2072a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2217b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2215290>, '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 0x2215b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2216040>, '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': 'db0483c52d987ecb441a263b000001ad-1489726431.561765-1911677626', '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 22:08:14 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 22:08:14 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 22:08:14 INFO - Using env: {'DISPLAY': ':0', 22:08:14 INFO - 'HOME': '/home/cltbld', 22:08:14 INFO - 'LANG': 'en_US.UTF-8', 22:08:14 INFO - 'LANGUAGE': 'en_US:en', 22:08:14 INFO - 'LOGNAME': 'cltbld', 22:08:14 INFO - 'MAIL': '/var/mail/cltbld', 22:08:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:08:14 INFO - 'MOZ_NO_REMOTE': '1', 22:08:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:08:14 INFO - 'NO_EM_RESTART': '1', 22:08:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:08:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:08:14 INFO - 'PWD': '/builds/slave/test', 22:08:14 INFO - 'SHELL': '/bin/bash', 22:08:14 INFO - 'SHLVL': '1', 22:08:14 INFO - 'TERM': 'linux', 22:08:14 INFO - 'TMOUT': '86400', 22:08:14 INFO - 'USER': 'cltbld', 22:08:14 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1489726431.561765-1911677626', 22:08:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:08:14 INFO - '_': '/tools/buildbot/bin/python'} 22:08:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:08:14 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 22:08:14 INFO - Cleaning up... 22:08:14 INFO - Return code: 0 22:08:14 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:08:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:08:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:08:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:08:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:08:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:08:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:08:14 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 0x1f7a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2072a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2217b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2215290>, '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 0x2215b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2216040>, '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': 'db0483c52d987ecb441a263b000001ad-1489726431.561765-1911677626', '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 22:08:14 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 22:08:14 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 22:08:14 INFO - Using env: {'DISPLAY': ':0', 22:08:14 INFO - 'HOME': '/home/cltbld', 22:08:14 INFO - 'LANG': 'en_US.UTF-8', 22:08:14 INFO - 'LANGUAGE': 'en_US:en', 22:08:14 INFO - 'LOGNAME': 'cltbld', 22:08:14 INFO - 'MAIL': '/var/mail/cltbld', 22:08:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:08:14 INFO - 'MOZ_NO_REMOTE': '1', 22:08:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:08:14 INFO - 'NO_EM_RESTART': '1', 22:08:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:08:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:08:14 INFO - 'PWD': '/builds/slave/test', 22:08:14 INFO - 'SHELL': '/bin/bash', 22:08:14 INFO - 'SHLVL': '1', 22:08:14 INFO - 'TERM': 'linux', 22:08:14 INFO - 'TMOUT': '86400', 22:08:14 INFO - 'USER': 'cltbld', 22:08:14 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1489726431.561765-1911677626', 22:08:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:08:14 INFO - '_': '/tools/buildbot/bin/python'} 22:08:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:08:14 INFO - Downloading/unpacking psutil>=3.1.1 22:08: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 22:08: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 22:08: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 22:08: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 22:08: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 22:08: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 22:08:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:08:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:08:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:08:16 INFO - Installing collected packages: psutil 22:08:16 INFO - Running setup.py install for psutil 22:08:17 INFO - building 'psutil._psutil_linux' extension 22:08:17 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 22:08:17 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 22:08:17 INFO - building 'psutil._psutil_posix' extension 22:08:17 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 22:08:17 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 22:08:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:08:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:08:17 INFO - Successfully installed psutil 22:08:17 INFO - Cleaning up... 22:08:17 INFO - Return code: 0 22:08:17 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:08:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:08:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:08:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:08:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:08:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:08:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:08:17 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 0x1f7a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2072a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2217b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2215290>, '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 0x2215b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2216040>, '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': 'db0483c52d987ecb441a263b000001ad-1489726431.561765-1911677626', '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 22:08:17 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 22:08:17 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 22:08:17 INFO - Using env: {'DISPLAY': ':0', 22:08:17 INFO - 'HOME': '/home/cltbld', 22:08:17 INFO - 'LANG': 'en_US.UTF-8', 22:08:17 INFO - 'LANGUAGE': 'en_US:en', 22:08:17 INFO - 'LOGNAME': 'cltbld', 22:08:17 INFO - 'MAIL': '/var/mail/cltbld', 22:08:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:08:17 INFO - 'MOZ_NO_REMOTE': '1', 22:08:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:08:17 INFO - 'NO_EM_RESTART': '1', 22:08:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:08:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:08:17 INFO - 'PWD': '/builds/slave/test', 22:08:17 INFO - 'SHELL': '/bin/bash', 22:08:17 INFO - 'SHLVL': '1', 22:08:17 INFO - 'TERM': 'linux', 22:08:17 INFO - 'TMOUT': '86400', 22:08:17 INFO - 'USER': 'cltbld', 22:08:17 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1489726431.561765-1911677626', 22:08:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:08:17 INFO - '_': '/tools/buildbot/bin/python'} 22:08:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:08:17 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:08: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 22:08: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 22:08: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 22:08: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 22:08: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 22:08: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 22:08:19 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:08:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:08:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:08:19 INFO - Installing collected packages: mozsystemmonitor 22:08:19 INFO - Running setup.py install for mozsystemmonitor 22:08:19 INFO - Successfully installed mozsystemmonitor 22:08:19 INFO - Cleaning up... 22:08:20 INFO - Return code: 0 22:08:20 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:08:20 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')]} 22:08:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:08:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:08:20 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')]} 22:08:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:08:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:08:20 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 0x1f7a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2072a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2217b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2215290>, '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 0x2215b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2216040>, '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': 'db0483c52d987ecb441a263b000001ad-1489726431.561765-1911677626', '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 22:08:20 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 22:08:20 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 22:08:20 INFO - Using env: {'DISPLAY': ':0', 22:08:20 INFO - 'HOME': '/home/cltbld', 22:08:20 INFO - 'LANG': 'en_US.UTF-8', 22:08:20 INFO - 'LANGUAGE': 'en_US:en', 22:08:20 INFO - 'LOGNAME': 'cltbld', 22:08:20 INFO - 'MAIL': '/var/mail/cltbld', 22:08:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:08:20 INFO - 'MOZ_NO_REMOTE': '1', 22:08:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:08:20 INFO - 'NO_EM_RESTART': '1', 22:08:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:08:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:08:20 INFO - 'PWD': '/builds/slave/test', 22:08:20 INFO - 'SHELL': '/bin/bash', 22:08:20 INFO - 'SHLVL': '1', 22:08:20 INFO - 'TERM': 'linux', 22:08:20 INFO - 'TMOUT': '86400', 22:08:20 INFO - 'USER': 'cltbld', 22:08:20 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1489726431.561765-1911677626', 22:08:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:08:20 INFO - '_': '/tools/buildbot/bin/python'} 22:08:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:08:20 INFO - Downloading/unpacking jsonschema==2.5.1 22:08:20 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 22:08:20 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 22:08:20 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 22:08:20 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 22:08:20 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 22:08:20 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 22:08:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:08:22 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:08:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:08:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:08:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:08:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:08:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:08:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:08:22 INFO - Downloading functools32-3.2.3-2.tar.gz 22:08:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:08:22 INFO - warning: no files found matching '*.txt' 22:08:22 INFO - no previously-included directories found matching 'build' 22:08:22 INFO - no previously-included directories found matching 'dist' 22:08:22 INFO - no previously-included directories found matching '.git*' 22:08:22 INFO - Installing collected packages: jsonschema, functools32 22:08:22 INFO - Running setup.py install for functools32 22:08:22 INFO - warning: no files found matching '*.txt' 22:08:22 INFO - no previously-included directories found matching 'build' 22:08:22 INFO - no previously-included directories found matching 'dist' 22:08:22 INFO - no previously-included directories found matching '.git*' 22:08:22 INFO - Successfully installed jsonschema functools32 22:08:22 INFO - Cleaning up... 22:08:22 INFO - Return code: 0 22:08:22 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 22:08: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')]} 22:08:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:08:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:08: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')]} 22:08:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:08:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:08:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1f7a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2072a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2217b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2215290>, '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 0x2215b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2216040>, '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': 'db0483c52d987ecb441a263b000001ad-1489726431.561765-1911677626', '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 22:08:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 22:08:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 22:08:22 INFO - Using env: {'DISPLAY': ':0', 22:08:22 INFO - 'HOME': '/home/cltbld', 22:08:22 INFO - 'LANG': 'en_US.UTF-8', 22:08:22 INFO - 'LANGUAGE': 'en_US:en', 22:08:22 INFO - 'LOGNAME': 'cltbld', 22:08:22 INFO - 'MAIL': '/var/mail/cltbld', 22:08:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:08:22 INFO - 'MOZ_NO_REMOTE': '1', 22:08:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:08:22 INFO - 'NO_EM_RESTART': '1', 22:08:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:08:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:08:22 INFO - 'PWD': '/builds/slave/test', 22:08:22 INFO - 'SHELL': '/bin/bash', 22:08:22 INFO - 'SHLVL': '1', 22:08:22 INFO - 'TERM': 'linux', 22:08:22 INFO - 'TMOUT': '86400', 22:08:22 INFO - 'USER': 'cltbld', 22:08:22 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1489726431.561765-1911677626', 22:08:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:08:22 INFO - '_': '/tools/buildbot/bin/python'} 22:08:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:08:22 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 22:08:22 INFO - Cleaning up... 22:08:22 INFO - Return code: 0 22:08:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:08: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')]} 22:08:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:08:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:08: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')]} 22:08:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:08:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:08:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1f7a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2072a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2217b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2215290>, '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 0x2215b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2216040>, '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': 'db0483c52d987ecb441a263b000001ad-1489726431.561765-1911677626', '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 22:08:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 22:08:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 22:08:22 INFO - Using env: {'DISPLAY': ':0', 22:08:22 INFO - 'HOME': '/home/cltbld', 22:08:22 INFO - 'LANG': 'en_US.UTF-8', 22:08:22 INFO - 'LANGUAGE': 'en_US:en', 22:08:22 INFO - 'LOGNAME': 'cltbld', 22:08:22 INFO - 'MAIL': '/var/mail/cltbld', 22:08:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:08:22 INFO - 'MOZ_NO_REMOTE': '1', 22:08:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:08:22 INFO - 'NO_EM_RESTART': '1', 22:08:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:08:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:08:22 INFO - 'PWD': '/builds/slave/test', 22:08:22 INFO - 'SHELL': '/bin/bash', 22:08:22 INFO - 'SHLVL': '1', 22:08:22 INFO - 'TERM': 'linux', 22:08:22 INFO - 'TMOUT': '86400', 22:08:22 INFO - 'USER': 'cltbld', 22:08:22 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1489726431.561765-1911677626', 22:08:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:08:22 INFO - '_': '/tools/buildbot/bin/python'} 22:08:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:08:23 INFO - Downloading/unpacking blobuploader==1.2.4 22:08: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 22:08: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 22:08: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 22:08: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 22:08: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 22:08: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 22:08:25 INFO - Downloading blobuploader-1.2.4.tar.gz 22:08:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:08:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:08:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:08:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:08:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:08:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:08:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:08:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:08:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:08:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:08:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:08:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:08:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:08:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:08:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:08:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:08:25 INFO - Downloading docopt-0.6.1.tar.gz 22:08:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:08:25 INFO - Installing collected packages: blobuploader, requests, docopt 22:08:25 INFO - Running setup.py install for blobuploader 22:08:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:08:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:08:26 INFO - Running setup.py install for requests 22:08:26 INFO - Running setup.py install for docopt 22:08:26 INFO - Successfully installed blobuploader requests docopt 22:08:26 INFO - Cleaning up... 22:08:26 INFO - Return code: 0 22:08:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:08: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')]} 22:08:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:08:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:08: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')]} 22:08:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:08:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:08:26 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 0x1f7a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2072a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2217b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2215290>, '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 0x2215b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2216040>, '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': 'db0483c52d987ecb441a263b000001ad-1489726431.561765-1911677626', '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 22:08:26 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 22:08:26 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 22:08:26 INFO - Using env: {'DISPLAY': ':0', 22:08:26 INFO - 'HOME': '/home/cltbld', 22:08:26 INFO - 'LANG': 'en_US.UTF-8', 22:08:26 INFO - 'LANGUAGE': 'en_US:en', 22:08:26 INFO - 'LOGNAME': 'cltbld', 22:08:26 INFO - 'MAIL': '/var/mail/cltbld', 22:08:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:08:26 INFO - 'MOZ_NO_REMOTE': '1', 22:08:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:08:26 INFO - 'NO_EM_RESTART': '1', 22:08:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:08:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:08:26 INFO - 'PWD': '/builds/slave/test', 22:08:26 INFO - 'SHELL': '/bin/bash', 22:08:26 INFO - 'SHLVL': '1', 22:08:26 INFO - 'TERM': 'linux', 22:08:26 INFO - 'TMOUT': '86400', 22:08:26 INFO - 'USER': 'cltbld', 22:08:26 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1489726431.561765-1911677626', 22:08:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:08:26 INFO - '_': '/tools/buildbot/bin/python'} 22:08:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:08:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:08:26 INFO - Running setup.py (path:/tmp/pip-HayESN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:08:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:08:26 INFO - Running setup.py (path:/tmp/pip-fbBYZG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:08:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:08:26 INFO - Running setup.py (path:/tmp/pip-GOyNOh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:08:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:08:27 INFO - Running setup.py (path:/tmp/pip-KFD923-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:08:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:08:27 INFO - Running setup.py (path:/tmp/pip-wGqQgQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:08:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:08:27 INFO - Running setup.py (path:/tmp/pip-Jhvcj0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:08:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:08:27 INFO - Running setup.py (path:/tmp/pip-497jMD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:08:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:08:27 INFO - Running setup.py (path:/tmp/pip-eJOlE_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:08:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:08:27 INFO - Running setup.py (path:/tmp/pip-DotkWF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:08:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:08:27 INFO - Running setup.py (path:/tmp/pip-bDLRqm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:08:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:08:27 INFO - Running setup.py (path:/tmp/pip-l4GoC2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:08:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:08:27 INFO - Running setup.py (path:/tmp/pip-4ZhV5K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:08:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:08:27 INFO - Running setup.py (path:/tmp/pip-pNgtmO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:08:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:08:27 INFO - Running setup.py (path:/tmp/pip-A_n783-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:08:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:08:27 INFO - Running setup.py (path:/tmp/pip-vITVvh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:08:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:08:27 INFO - Running setup.py (path:/tmp/pip-LJPaz1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:08:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:08:27 INFO - Running setup.py (path:/tmp/pip-8j6mox-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:08:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:08:28 INFO - Running setup.py install for manifestparser 22:08:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:08:28 INFO - Running setup.py install for mozcrash 22:08:28 INFO - Running setup.py install for mozdebug 22:08:28 INFO - Running setup.py install for mozdevice 22:08:28 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:08:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:08:28 INFO - Running setup.py install for mozfile 22:08:28 INFO - Running setup.py install for mozhttpd 22:08:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:08:28 INFO - Running setup.py install for mozinfo 22:08:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:08:28 INFO - Running setup.py install for mozInstall 22:08:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:08:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:08:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:08:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:08:28 INFO - Running setup.py install for mozleak 22:08:28 INFO - Running setup.py install for mozlog 22:08:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:08:29 INFO - Running setup.py install for moznetwork 22:08:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:08:29 INFO - Running setup.py install for mozprocess 22:08:29 INFO - Running setup.py install for mozprofile 22:08:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:08:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:08:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:08:29 INFO - Running setup.py install for mozrunner 22:08:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:08:29 INFO - Running setup.py install for mozscreenshot 22:08:29 INFO - Running setup.py install for moztest 22:08:29 INFO - Running setup.py install for mozversion 22:08:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:08:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:08:29 INFO - Cleaning up... 22:08:29 INFO - Return code: 0 22:08:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:08:29 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')]} 22:08:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:08:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:08:29 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')]} 22:08:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:08:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:08:29 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 0x1f7a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2072a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2217b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2215290>, '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 0x2215b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2216040>, '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': 'db0483c52d987ecb441a263b000001ad-1489726431.561765-1911677626', '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 22:08:29 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 22:08:29 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 22:08:29 INFO - Using env: {'DISPLAY': ':0', 22:08:29 INFO - 'HOME': '/home/cltbld', 22:08:29 INFO - 'LANG': 'en_US.UTF-8', 22:08:29 INFO - 'LANGUAGE': 'en_US:en', 22:08:29 INFO - 'LOGNAME': 'cltbld', 22:08:29 INFO - 'MAIL': '/var/mail/cltbld', 22:08:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:08:29 INFO - 'MOZ_NO_REMOTE': '1', 22:08:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:08:29 INFO - 'NO_EM_RESTART': '1', 22:08:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:08:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:08:29 INFO - 'PWD': '/builds/slave/test', 22:08:29 INFO - 'SHELL': '/bin/bash', 22:08:29 INFO - 'SHLVL': '1', 22:08:29 INFO - 'TERM': 'linux', 22:08:29 INFO - 'TMOUT': '86400', 22:08:29 INFO - 'USER': 'cltbld', 22:08:29 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1489726431.561765-1911677626', 22:08:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:08:29 INFO - '_': '/tools/buildbot/bin/python'} 22:08:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:08:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:08:30 INFO - Running setup.py (path:/tmp/pip-1SF2q1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:08:30 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)) 22:08:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:08:30 INFO - Running setup.py (path:/tmp/pip-9uQHa2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:08:30 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)) 22:08:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:08:30 INFO - Running setup.py (path:/tmp/pip-DyUS9x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:08:30 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)) 22:08:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:08:30 INFO - Running setup.py (path:/tmp/pip-xbh6nC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:08:30 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)) 22:08:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:08:30 INFO - Running setup.py (path:/tmp/pip-JabnNn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:08:30 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)) 22:08:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:08:30 INFO - Running setup.py (path:/tmp/pip-ZB4PsT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:08:30 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)) 22:08:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:08:30 INFO - Running setup.py (path:/tmp/pip-2JMjMh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:08:30 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)) 22:08:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:08:30 INFO - Running setup.py (path:/tmp/pip-9wsebz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:08:30 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)) 22:08:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:08:30 INFO - Running setup.py (path:/tmp/pip-MippDD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:08:30 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)) 22:08:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:08:30 INFO - Running setup.py (path:/tmp/pip-xI5N0y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:08:30 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)) 22:08:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:08:30 INFO - Running setup.py (path:/tmp/pip-dXdWwS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:08:30 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)) 22:08:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:08:30 INFO - Running setup.py (path:/tmp/pip-klZHQQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:08:30 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)) 22:08:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:08:30 INFO - Running setup.py (path:/tmp/pip-uDtWLK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:08:31 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)) 22:08:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:08:31 INFO - Running setup.py (path:/tmp/pip-dg8qgp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:08:31 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)) 22:08:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:08:31 INFO - Running setup.py (path:/tmp/pip-jDJLQx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:08:31 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)) 22:08:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:08:31 INFO - Running setup.py (path:/tmp/pip-OSmBCj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:08:31 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)) 22:08:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:08:31 INFO - Running setup.py (path:/tmp/pip-Se5fQu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:08:31 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)) 22:08:31 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)) 22:08:31 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)) 22:08:31 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)) 22:08:31 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)) 22:08:31 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)) 22:08:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:08:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:08:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:08:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:08:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:08:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:08:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:08:33 INFO - Downloading blessings-1.6.tar.gz 22:08:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:08:33 INFO - Installing collected packages: blessings 22:08:33 INFO - Running setup.py install for blessings 22:08:33 INFO - Successfully installed blessings 22:08:33 INFO - Cleaning up... 22:08:33 INFO - Return code: 0 22:08:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:08:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:08:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:08:33 INFO - Reading from file tmpfile_stdout 22:08:33 INFO - Current package versions: 22:08:33 INFO - argparse == 1.2.1 22:08:33 INFO - blessings == 1.6 22:08:33 INFO - blobuploader == 1.2.4 22:08:33 INFO - docopt == 0.6.1 22:08:33 INFO - functools32 == 3.2.3-2 22:08:33 INFO - jsonschema == 2.5.1 22:08:33 INFO - manifestparser == 1.1 22:08:33 INFO - mozInstall == 1.12 22:08:33 INFO - mozcrash == 1.0 22:08:33 INFO - mozdebug == 0.1 22:08:33 INFO - mozdevice == 0.49 22:08:33 INFO - mozfile == 1.2 22:08:33 INFO - mozhttpd == 0.7 22:08:33 INFO - mozinfo == 0.9 22:08:33 INFO - mozleak == 0.1 22:08:33 INFO - mozlog == 3.4 22:08:33 INFO - moznetwork == 0.27 22:08:33 INFO - mozprocess == 0.25 22:08:33 INFO - mozprofile == 0.28 22:08:33 INFO - mozrunner == 6.13 22:08:33 INFO - mozscreenshot == 0.1 22:08:33 INFO - mozsystemmonitor == 0.3 22:08:33 INFO - moztest == 0.8 22:08:33 INFO - mozversion == 1.4 22:08:33 INFO - psutil == 3.1.1 22:08:33 INFO - requests == 1.2.3 22:08:33 INFO - wsgiref == 0.1.2 22:08:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:08:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:08:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:08:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:08:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:08:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:08:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:08:33 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 0x1f7a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2072a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2217b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2215290>, '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 0x2215b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2216040>, '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': 'db0483c52d987ecb441a263b000001ad-1489726431.561765-1911677626', '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 22:08:33 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 22:08:33 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 22:08:33 INFO - Using env: {'DISPLAY': ':0', 22:08:33 INFO - 'HOME': '/home/cltbld', 22:08:33 INFO - 'LANG': 'en_US.UTF-8', 22:08:33 INFO - 'LANGUAGE': 'en_US:en', 22:08:33 INFO - 'LOGNAME': 'cltbld', 22:08:33 INFO - 'MAIL': '/var/mail/cltbld', 22:08:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:08:33 INFO - 'MOZ_NO_REMOTE': '1', 22:08:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:08:33 INFO - 'NO_EM_RESTART': '1', 22:08:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:08:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:08:33 INFO - 'PWD': '/builds/slave/test', 22:08:33 INFO - 'SHELL': '/bin/bash', 22:08:33 INFO - 'SHLVL': '1', 22:08:33 INFO - 'TERM': 'linux', 22:08:33 INFO - 'TMOUT': '86400', 22:08:33 INFO - 'USER': 'cltbld', 22:08:33 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1489726431.561765-1911677626', 22:08:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:08:33 INFO - '_': '/tools/buildbot/bin/python'} 22:08:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:08:34 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)) 22:08:34 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)) 22:08:34 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)) 22:08:34 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)) 22:08:34 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)) 22:08:34 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)) 22:08:34 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)) 22:08:34 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)) 22:08:34 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)) 22:08:34 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)) 22:08:34 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)) 22:08:34 INFO - Cleaning up... 22:08:34 INFO - Return code: 0 22:08:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:08:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:08:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:08:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:08:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:08:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:08:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:08:34 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 0x1f7a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2072a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2217b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2215290>, '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 0x2215b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2216040>, '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': 'db0483c52d987ecb441a263b000001ad-1489726431.561765-1911677626', '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 22:08:34 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 22:08:34 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 22:08:34 INFO - Using env: {'DISPLAY': ':0', 22:08:34 INFO - 'HOME': '/home/cltbld', 22:08:34 INFO - 'LANG': 'en_US.UTF-8', 22:08:34 INFO - 'LANGUAGE': 'en_US:en', 22:08:34 INFO - 'LOGNAME': 'cltbld', 22:08:34 INFO - 'MAIL': '/var/mail/cltbld', 22:08:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:08:34 INFO - 'MOZ_NO_REMOTE': '1', 22:08:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:08:34 INFO - 'NO_EM_RESTART': '1', 22:08:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:08:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:08:34 INFO - 'PWD': '/builds/slave/test', 22:08:34 INFO - 'SHELL': '/bin/bash', 22:08:34 INFO - 'SHLVL': '1', 22:08:34 INFO - 'TERM': 'linux', 22:08:34 INFO - 'TMOUT': '86400', 22:08:34 INFO - 'USER': 'cltbld', 22:08:34 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1489726431.561765-1911677626', 22:08:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:08:34 INFO - '_': '/tools/buildbot/bin/python'} 22:08:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:08:34 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:08:34 INFO - Cleaning up... 22:08:34 INFO - Return code: 0 22:08:34 INFO - Running post-action listener: _resource_record_post_action 22:08:34 INFO - Running post-action listener: _start_resource_monitoring 22:08:34 INFO - Starting resource monitoring. 22:08:34 INFO - [mozharness: 2017-03-17 05:08:34.308930Z] Finished create-virtualenv step (success) 22:08:34 INFO - [mozharness: 2017-03-17 05:08:34.309466Z] Running install step. 22:08:34 INFO - Running pre-action listener: _resource_record_pre_action 22:08:34 INFO - Running main action method: install 22:08:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:08:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:08:34 INFO - Reading from file tmpfile_stdout 22:08:34 INFO - Detecting whether we're running mozinstall >=1.0... 22:08:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:08:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:08:34 INFO - Reading from file tmpfile_stdout 22:08:34 INFO - Output received: 22:08:34 INFO - Usage: mozinstall [options] installer 22:08:34 INFO - Options: 22:08:34 INFO - -h, --help show this help message and exit 22:08:34 INFO - -d DEST, --destination=DEST 22:08:34 INFO - Directory to install application into. [default: 22:08:34 INFO - "/builds/slave/test"] 22:08:34 INFO - --app=APP Application being installed. [default: firefox] 22:08:34 INFO - mkdir: /builds/slave/test/build/application 22:08:34 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'] 22:08:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 22:08:51 INFO - Reading from file tmpfile_stdout 22:08:51 INFO - Output received: 22:08:51 INFO - /builds/slave/test/build/application/firefox/firefox 22:08:51 INFO - Running post-action listener: _resource_record_post_action 22:08:51 INFO - [mozharness: 2017-03-17 05:08:51.180953Z] Finished install step (success) 22:08:51 INFO - [mozharness: 2017-03-17 05:08:51.181203Z] Running run-tests step. 22:08:51 INFO - Running pre-action listener: _resource_record_pre_action 22:08:51 INFO - Running main action method: run_tests 22:08:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:08:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:08:51 INFO - Python 2.7.3 22:08:51 INFO - Return code: 0 22:08:51 INFO - grabbing minidump binary from tooltool 22:08:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:08:51 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 0x2215290>, '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 0x2215b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2216040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:08:51 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 22:08:51 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 22:08:51 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 22:08:51 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:08:51 INFO - Return code: 0 22:08:51 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:08:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:08:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:08:51 INFO - ENV: RUST_BACKTRACE is now 1 22:08:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:08:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:08:51 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/To2NTRFkTI2cEeg1u-ty6w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--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 22:08:51 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/To2NTRFkTI2cEeg1u-ty6w/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-031 --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 22:08:51 INFO - Using env: {'DISPLAY': ':0', 22:08:51 INFO - 'HOME': '/home/cltbld', 22:08:51 INFO - 'LANG': 'en_US.UTF-8', 22:08:51 INFO - 'LANGUAGE': 'en_US:en', 22:08:51 INFO - 'LOGNAME': 'cltbld', 22:08:51 INFO - 'MAIL': '/var/mail/cltbld', 22:08:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:08:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:08:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:08:51 INFO - 'MOZ_NO_REMOTE': '1', 22:08:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:08:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:08:51 INFO - 'NO_EM_RESTART': '1', 22:08:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:08:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:08:51 INFO - 'PWD': '/builds/slave/test', 22:08:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:08:51 INFO - 'RUST_BACKTRACE': '1', 22:08:51 INFO - 'SHELL': '/bin/bash', 22:08:51 INFO - 'SHLVL': '1', 22:08:51 INFO - 'TERM': 'linux', 22:08:51 INFO - 'TMOUT': '86400', 22:08:51 INFO - 'USER': 'cltbld', 22:08:51 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1489726431.561765-1911677626', 22:08:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:08:51 INFO - '_': '/tools/buildbot/bin/python'} 22:08:51 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/To2NTRFkTI2cEeg1u-ty6w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--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 22:08:51 INFO - mozversion application_buildid: 20170317041844 22:08:51 INFO - mozversion application_changeset: dff5f8de5eed5a31fde56f87e8a75fbcc4a2ddff 22:08:51 INFO - mozversion application_display_name: FirefoxDeveloperEdition 22:08:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:08:51 INFO - mozversion application_name: Firefox 22:08:51 INFO - mozversion application_remotingname: firefox-dev 22:08:51 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 22:08:51 INFO - mozversion application_vendor: Mozilla 22:08:51 INFO - mozversion application_version: 54.0a2 22:08:51 INFO - mozversion platform_buildid: 20170317041844 22:08:51 INFO - mozversion platform_changeset: dff5f8de5eed5a31fde56f87e8a75fbcc4a2ddff 22:08:51 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 22:08:51 INFO - mozversion platform_version: 54.0a2 22:08:51 INFO - using testdate: 1489727331 22:08:51 INFO - actual date: 1489727331 22:08:51 INFO - starting webserver on 'localhost:44096' 22:08:51 INFO - SUITE-START | Running 2 tests 22:08:51 INFO - TEST-START | dromaeo_css 22:08:51 INFO - operating with platform_type : linux_ 22:08:51 INFO - Initialising browser for dromaeo_css test... 22:08:51 INFO - TEST-INFO | started process 1312 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3bmsZX/profile http://localhost:44096/getInfo.html) 22:08:55 INFO - PROCESS | 1312 | __metrics Screen width/height:1600/1200 22:08:55 INFO - PROCESS | 1312 | colorDepth:24 22:08:55 INFO - PROCESS | 1312 | Browser inner width/height: 1024/697 22:08:55 INFO - PROCESS | 1312 | __metrics 22:08:56 INFO - PROCESS | 1312 | 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" 22:08:56 INFO - PROCESS | 1312 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:08:57 INFO - TEST-INFO | 1312: exit 0 22:08:57 INFO - Browser initialized. 22:08:57 INFO - Running cycle 1/1 for dromaeo_css test... 22:08:57 INFO - TEST-INFO | started process 1404 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3bmsZX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:09:09 INFO - PROCESS | 1404 | RSS: Main: 139202560 22:09:09 INFO - PROCESS | 1404 | 22:12:10 INFO - PROCESS | 1404 | Cycle 1(1): loaded http://localhost:44096/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44096/tests/dromaeo/cssquery-ext.html) 22:12:12 INFO - PROCESS | 1404 | RSS: Main: 255881216 22:12:12 INFO - PROCESS | 1404 | 22:13:59 INFO - PROCESS | 1404 | ************************* 22:13:59 INFO - PROCESS | 1404 | A coding exception was thrown and uncaught in a Task. 22:13:59 INFO - PROCESS | 1404 | 22:13:59 ERROR - PROCESS | 1404 | Full message: TypeError: NetworkError when attempting to fetch resource. 22:13:59 INFO - PROCESS | 1404 | Full stack: 22:13:59 INFO - PROCESS | 1404 | ************************* 22:15:14 INFO - PROCESS | 1404 | Cycle 1(1): loaded http://localhost:44096/tests/dromaeo/cssquery-ext.html (next: http://localhost:44096/tests/dromaeo/cssquery-jquery.html) 22:15:14 INFO - PROCESS | 1404 | RSS: Main: 221638656 22:15:14 INFO - PROCESS | 1404 | 22:18:16 INFO - PROCESS | 1404 | Cycle 1(1): loaded http://localhost:44096/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44096/tests/dromaeo/cssquery-mootools.html) 22:18:17 INFO - PROCESS | 1404 | RSS: Main: 223764480 22:18:17 INFO - PROCESS | 1404 | 22:21:19 INFO - PROCESS | 1404 | Cycle 1(1): loaded http://localhost:44096/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44096/tests/dromaeo/cssquery-prototype.html) 22:21:20 INFO - PROCESS | 1404 | RSS: Main: 170840064 22:21:20 INFO - PROCESS | 1404 | 22:24:22 INFO - PROCESS | 1404 | Cycle 1(1): loaded http://localhost:44096/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44096/tests/dromaeo/cssquery-yui.html) 22:24:23 INFO - PROCESS | 1404 | RSS: Main: 176922624 22:24:23 INFO - PROCESS | 1404 | 22:27:26 INFO - PROCESS | 1404 | Cycle 1(1): loaded http://localhost:44096/tests/dromaeo/cssquery-yui.html (next: http://localhost:44096/tests/dromaeo/cssquery-dojo.html) 22:27:26 INFO - PROCESS | 1404 | RSS: Main: 267718656 22:27:26 INFO - PROCESS | 1404 | 22:27:26 INFO - PROCESS | 1404 | __start_tp_report 22:27:26 INFO - PROCESS | 1404 | _x_x_mozilla_page_load 22:27:26 INFO - PROCESS | 1404 | _x_x_mozilla_page_load_details 22:27:26 INFO - PROCESS | 1404 | |i|pagename|runs| 22:27:26 INFO - PROCESS | 1404 | |0;dojo.html;3382.391169589474;3419.4357930941383;3430.6740859618344;3446.7242620590355;3472.4791281307803;5746.1668058131545;5831.825045248644;5850.151727999448;5856.531477481802;5859.765609375625;5793.304803423584;5887.793927212538;5892.852678683024;5901.439363260494;5911.645301281927;5216.76524556394;5245.7377131143485;5274.604404669665;5291.735413229342;5326.573874090082;5110.28456016158;5332.253484512172;5346.91979620304;5353.116735738598;5354.063038968185;5154.226865970097;5171.948280517185;5252.658577192489;5332.120200166968;5332.92000619991;5312.521873031426;5351.357837059539;5352.036633405985;5352.759125839308;5354.009508240968;5017.071841709296;5216.713080780555;5265.236540701615;5297.099493086146;5364.490373414558;5674.00704876645;5770.451807078321;5824.359320474744;5827.417258274181;5837.153612726173;6321.683915804238;6326.367363263636;6345.0482427636225;6356.0783686365685;6363.268224154189;6115.510759139258;6375;6377.872442551169;6382;6390.169277993878;5730.426957304237;5778.219940308089;5792.478676919098;5793.362730099686;5793.826185214451;6281.842953926189;6292.968535157295;6346.968265158737;6400.935990640034;6441.1626488556185;6126.754929802847;6173.074038894202;6175.413335733098;6176.197094377702;6182.629042257479;6300.30696623371;6302.054691796267;6303;6307.400796924285;6316.526260530479;6021.42796434338;6057.545684073712;6113.484984902833;6130.948521380002;6261.592996455216;6059.1820104286235;6109.053096770008;6139.8601398601395;6259.280182778948;6267.1539342189135;4750.049990002013;4756.357891684647;4757.619390448755;4780.211265141283;4790.4969978152485;4278.294081476583;4304.225239456928;4315.546867578922;4322.308430651081;4344.348347747863;5915.881682366328;5969.522438204933;6137.263528376534;6137.96931015342;6140.385961403824;6164.075388691732;6219.222597175353;6340.587861788969;6350.682465876687;6356.586821856565;6135.509159267248;6142.877142457215;6145.8156255312415;6150.938490615036;6151.200343955257;5365.302510673666;5371.6239863209985;5379.5427388671615;5382.623216374895;5384.111621582473;6298.055291706189;6335.366463353628;6490.091387205795;6525.249596296487;6646.734130634721;6293;6299.622022678471;6357.90463143044;6361.427471527585;6370.044493326038;6644.667766611747;6653.933460665331;6658.600483970978;6659.034440006075;6663.83340416474;5959.553033522417;5999.1901093351835;6111.327753947151;6239.469645080219;6244.344343844013;6267.6866156692895;6276.089966954857;6284.528660350584;6300.369963003663;6304.842378940563;6142.109394137736;6144.10910417978;6144.56988010835;6145.631262124287;6146.907796382969;5938.406159384027;5985;6068.4538391544975;6068.514518838394;6128.724207410588;6044.788432404845;6071.058985857199;6125.388069147376;6146.631202127886;6155.599886007395;6146;6149.569530133027;6151.415615516519;6153.138560601609;6153.753849845956;5763.452472015152;5822.679752613647;5889.440503152194;5923.466887980103;5947.821565353046 22:27:26 INFO - PROCESS | 1404 | |1;ext.html;769.1923480345639;823.7117009046833;841.760098371964;914.6295750221159;927.2026057590475;30895.691043089562;45392.54607453924;45409.54590454099;45457;45640;45678.08643827122;46037.76981115098;46077.539224607746;46131.76934115333;46159.07681846361;9019.909800902005;9168.220701240403;9172;9193.172614464696;9219.907800922005;7371.520851144658;7469.066366704162;10326.483675816216;10512.737181570483;10879.347239165636;10652.946735266352;10670.199735019865;10677.199210059238;10691.625793097242;10697;10528.42093684847;10578.100861426788;10598.735031624194;10608.416537090457;10636.30863993838;10087.596496140146;10090.293679442442;10109.292349535535;10136.391816491034;10411.583536658525;43417.13165736699;43635.78182109101;43685.56314436847;43708.56291437077;43740.3438948416;4098.221337945781;4119.217348703737;4143.129942712004;4202.159568086365;4216.9578304216875;30725.231869203224;30878.536821947688;30999.535006974915;31254.53118203229;31356;4359.934600980988;4379.896961203366;4394.780260986938;4403.647827513853;4500.932486012713;251256;252017;252181;252603;252685.7365713178;55739.44260557424;55962.440375595725;56151;56190;56231.15653265204;57337.713311433174;57750.7112464435;57753.42246577564;57791;57852;16818.91590542064;17116.400925967533;17177.31290748381;17178.484645460656;17194.226259818337;15197;15233.542993710207;15249.695006099815;15250.694986100216;15262.313195905988;12603.558875439316;12807.807882881763;13707.588772336845;13821.308934553232;13973.510927117502;5316.973415132899;5348.572114230852;5408.971635636636;5414.133738601883;5439.428859969726;1003.0370843989851;1024.574801457387;1032.6024480575034;1033.1579762493693;1046.6912260882905;28428.573571396446;28630;28634;28777.280567985967;29083.982060627775;1091.1979694924225;1102.3716481605409;1109.1570406491126;1114.2089116727213;1116.1461481966303;14569.635759105895;15273.923630382;15459.304331305118;15546;15657.843421565867;309902;310053;310141;310974;311329;58061;58105;58118;58369.4163058364;58385;1472.4036765110147;1492.2165862921836;1522.2540954932003;1533.1031346662328;1544.6601747615507;26248.868755656098;27883.72116278811;27996.860015699793;28257.57613635756;28337.858310708314;43353.132937340444;43548.56451435572;43550.782246088565;43551.78224108859;43628;281137;281201;281233;281381;281450;25490.49019019572;30361.24096897595;30567.694323056483;35545.28909421849;35693;32889;33006.669933300356;33299.500507491925;39570;39610.60389396069;34306;34620.134496636776;34920;35175.82412088026;35205.64794352126;33942.66057339395;34226;34235.828820855735;34341.828290858386;34440;35907.46138807972;36364.27271454609;36476.45285320775;36496.452553211195;37108.814455927546;29974.550381744728;31392.686073138975;31966;32040.5193922096;32247.51628725524;25258.36854078663;25465.872670636527;25647.615285770356;25676.358091047874;26275.21174364772 22:27:26 INFO - PROCESS | 1404 | |2;jquery.html;447.23299541286684;457.1884904294876;460.09820751327396;466.8389405655048;481.63877092180866;19761.209551617936;21183.834889081096;21244.93775311234;21329.466763330925;21364.4658883528;21015.894920525414;21621.243256486025;22484.775152248472;23577.056917723272;23825.046998120055;6596.538242323039;6628.972509261061;6772.966135169342;6813.2164801047775;6829.590224586541;6729.091572637704;6827.044213810071;6830.760923367683;6832.043513908056;7156.141263048441;7560.168381478033;7620.542767433972;7630.847383052335;7631.046119235096;7640.235976402371;7243.529170603894;7466.9626651866665;7500.549967001943;7521.548707077593;7621.085469743639;7289.271072892721;7429.777106686808;7459.888101678479;7467.514611550232;7488.475806693534;25223.36941576457;25301;25648;25674.101406450685;25976.480470390674;2964.172136980981;3085.274960384308;3106.4253113174136;3168.3821654777325;3191.7287030602192;15250.694986100327;15888.920555397264;16119.194040297938;16176.919115404347;16514.091724955124;2155.7520885098256;2239.8992045358;2240.843140980132;2286.0512887151813;2311.0062673050584;114890;115551;116258.41870790676;116743.41628291804;117732;17881.910590447224;18161.45515634533;18270.360537381126;18575.16411761447;18711.812881871007;32244.35511289761;32275.193120171713;32319.73761836696;32333.838330808667;32557.51163732546;10758.768470707288;10805.40570268627;10898;11010.174236932262;11186.32882027081;9258.814823703487;9315.627374905063;9335.90664093364;9346.532673366304;9551.856722149034;9250.907490925005;9359;9383.953080234554;9439;9465.148136667733;3511.9437050207052;3636.4363523653874;3811.5045044144085;3852.7110466715108;3907.159960608426;899.109881217603;926.3006430145332;929.3355250995571;935.4714586258742;938;19149;19979.400617981482;20270.391888243375;20482.283120091022;20511.692324615142;933.2533972821716;939.9859002114973;943.2501161576563;950.7147855643418;966.5795379010153;10178.898211017795;11269.66191014271;11281.282781357579;11283.492242849092;11363.14776391774;626710;630822;634115;650287;657693.5576610623;83159;84414;89663.55168224117;98072.01927980629;112064;1194.205853107691;1210.334316126127;1238.8575313838844;1250.8186312984567;1252.473960936409;17991.73012404789;18185;18611.255549778398;18708.158132884324;18962;49679;50742.49257507525;51081.999999998516;51251;52018.21972670337;68163;68876.65561672159;70167;70819;71252;11233.943830280796;12114.575989840665;12459.501619935101;12517.93741031289;12648.747025059263;13943.790843137564;14087;14128.293585320487;14153.646158846112;14299.07056041354;12229.633111006684;12252.264864108181;12358.196717213352;12489.875101248872;12562.309073000708;6394.7442102317245;11249.493772780408;11466.827997579876;11896.524139034342;12103.273803571814;12159.392030398622;13029.739405212033;13042.608721738363;13112.475500979854;13389.866101338863;14246.145231286157;14752.852471475147;14780;14785.556433307018;14878.181700006604;13563.932180339036;13734.45062197541;13750.449982001008;13929.791053134413;13963.162210267417 22:27:26 INFO - PROCESS | 1404 | |3;mootools.html;1549.10926217425;1562.5234303537416;1574.2600977540556;1580.1862041048855;1582.2484319948026;11033.613823516178;11901.702457438569;11902.34537100459;11904.285742855423;11904.642860714182;10943.179261555395;11195.384253866034;11651.592194273202;11662.358570278631;11667.12496562759;2465.0632759551345;2502.8373155744816;2507.53610582042;2508.4481414088873;2511.937201569957;2359.7640235976437;2421.539907417594;2422.358075110097;2423.612222044473;2425.3936515871032;2366.8343215974887;2376.4534157143867;2381.8570885746826;2390.5696974544576;2393.042782886842;2313.9884300578556;2318.3508617587104;2327.55776402483;2334.2997100869757;2337.1703045418803;2185.442712108418;2205.095910676615;2230.453538882984;2243.23729931824;2243.8653680779207;11429.542818287258;11663.24188927717;11669.883301166965;11680.824787628193;11682.766344673058;5756.107803290497;5901.203337549462;5904.763809447617;5906.616069955439;5907;3414.9487757683655;3446.6208717041104;3507.94738078929;3615.963840361589;3622.5290712207507;1317.9934100329533;1347.6226656536185;1352.2900477249425;1391.5527851034913;1423.3523746695332;14920.62698432537;16191.190440477929;17315.913420432942;17660.205290761947;17855.464336069937;4643.326717625993;4685.320628508915;4795.568398844121;4809.663323567387;4828.517148285214;11182.66452006441;11450.484728187252;13310.800337994939;13311.467541298432;13357.53248636293;5677.37548869624;5820.417958204231;5900.262467191601;5909.084091965752;5916.319623243296;5451.182322651634;5512.944870551243;5514.228008078872;5536.584756143306;5579.2746942897165;4027.8187481562813;4064.227796718614;4134.297169481196;4159.91680166395;4168.353905144708;1043.7129789308;1047.0471870597871;1050.3540322701483;1051.7738686182508;1063.0857462582173;943.8867335919733;956.818204541135;959.1511512311515;959.9904000960041;982.9508524573743;6570.408663220333;6704;6777.830554236183;6889.517733758689;6912.861742765116;1026.440589878518;1049.8057859296055;1050.632278702448;1064.3720205078885;1067.5783065689009;4563.224251877189;4599.6090332321455;4657.975245445997;4698.060387922361;4702.717836929795;13815.723685526233;14129.85870141306;14304.213268270138;14688.04527705717;14700.191489468181;14706.264686765619;14732.189729564763;14752.483663071742;14756.114633122046;14775.261236938326;10394.740131496621;10565.683029509128;10568.260221784401;10648.094911932418;10732.570697172026;7303.196648368781;7555.09338879338;7702.961485192538;7723.922760772545;7824.530528168328;12742.745145097231;13176.80234796498;13205.33973301312;13417.932910335387;13419.261940593362;13017.804732929204;13399.732005360032;13534.59396218115;13650.726985460435;13703.314834258446;10606.734831629272;10880.836787448035;10889.945550272514;10898.836517452086;10912.672619821418;10460.843087353847;11034.834477483004;11099.223054386115;11104.111671066457;11146.665600032013;9175.403598766059;9227.538623068685;9335.48654823964;9418;9770.31607787448;9573.712788616353;9728.902710973083;9784.461854597781;9869.161121304769;9981.051800078982;8729.825403491768;8732.388732788899;8814.735557933273;8818.823623527365;8929.374943753875;6354.3963323484195;6417.326180751141;6428.260750013808;6567.835804104936;6579.703913323816;6150.630962142286;6262.123302737711;6344.270408903035;6375.521835862236;6561.343865613591 22:27:26 INFO - PROCESS | 1404 | |4;prototype.html;416.38375204697064;438.86395217482584;440.9140217657556;443.8681362525559;449.781855799937;5278.683279003258;5333.626646134772;5337.1994200869885;5344.877575709106;5366.838994830161;5001.949980500194;5232.92150617741;5256.580723204733;5283.969625922947;5317.3619165700175;4329.372241025049;4335.544767799383;4340.283853164224;4341.630961368288;4360.629346505535;4348.7390756554705;4353.891152721191;4375.803088861009;4400.845970391037;4416.5583441655735;4407.735535867858;4415;4431.135928493945;4433.630440864949;4465.330200469939;4178.937315940263;4349;4355.216061108983;4364.563543645641;4402.471703395581;4136.503619565641;4140.565240649748;4145.647619952308;4149.813258403379;4167.291560434734;5226.634135610509;5228.320318358627;5232.764525596357;5261.316028916216;5298.602604804655;5072.250073724559;5156.639035267533;5157.48425157485;5159.1229490986625;5226.660267082628;5525.4528731955115;5531.944680553223;5581.916271255935;5598.033042487447;5613.326400831886;4494.37078808967;4565.360849481075;4595.816167353335;4606.723596584216;4658.9068218635775;5535.391106978229;5631.352394474647;5652.236948012048;5810.302763668345;5825.475707186331;4684.95315046852;4704.341392205094;4742.217534106834;4787.832425865078;4845.2732090186755;4835.734034628059;4836.806527738851;4863.221884498464;4872.269159626085;4897.2898929655;4753.765730106844;4846.39420072491;5078.847634570969;5126.615503837227;5130.127878260705;5564.276644036249;5567.359753628303;5604.943950560524;5635.295588051494;5638.830835074954;1646.0699954081754;1673.573238824092;1689.6536210076904;1694.110591939217;1695.465928232603;1269.2447993443886;1273.5988163728582;1275.6810797300675;1287.8068289756611;1304.3543445994103;5342.652727572696;5481.972590137104;5515.338159420895;5518.475744804237;5634.548971197542;5689.374168841424;5704.832163777738;5735.369109398046;5746.569007324384;5757.193992841006;5525.088360420566;5567.805126820542;5581.944180558143;5637.887242255214;5638.830835074954;2861.141657502741;3007.5789389485053;3038.3923215356576;3074.4773388524004;3076.8769249230227;5880.764769409176;5934.703264836741;5976.402359763989;5978.730957106854;5985.221921150222;5562.471565201299;5776.840674714199;5838.854028649318;5842.211301474246;5927.496162826122;5895.852603684856;5942.3166335871065;5948.702564871739;5953.226080609493;5962.34414214436;5704.3154821421695;5725.627834190765;5764.971175144097;5777.91333129995;5785.566082543742;5500.642458240201;5517.862053448696;5645.774169033192;5676.68778217202;5688.687122208318;5742.913856292075;5814.273215848019;5820.476157145878;5938.257717785277;5970.701464926649;4723.45680246776;4740.862193073706;4772.308015337826;4791.448983366958;4799.424069111729;5505.174223866452;5761.769529218785;5782.2194003808945;5785.218995435563;5785.3636100028125;5605.850800585951;5617.8033768817895;5625.549956003428;5629.296337957755;5638.631774654737;5622.269105016322;5623.8875222496135;5678.422593765901;5685.289338832646;5685.431456854281;5352.330958630171;5503.587230957774;5584.776608935597;5600.271964644733;5648.802291919763;5621.297337832771;5625.353084395347;5644.463775941279;5650.208970744181;5654.717264136694;5465.262189604353;5540.418256083053;5589.441055894378;5596.636218645775;5649.915251271316 22:27:26 INFO - PROCESS | 1404 | |5;yui.html;814.6415577146051;824.9175082491752;907.4782000349801;909.7134402663161;927.6706769096968;16874.409395671155;17981;17991.999999999967;18025.36911208108;18131.09344532773;14411.855881441208;16025.519234422956;16166.11086390248;16195.757063644025;16220.10789406582;874.9912500874989;890.888638920135;897.995510022449;898.8112496375769;899.6626265150569;896.8116695493921;898.0660113481971;900.0729248873671;900.1673452056854;900.1718419054486;930.3952430919888;930.5254320296664;930.5533343994887;931.2503434735036;931.4504442379028;924.8150369925975;927.5686805635345;929.8233335666201;929.930255230857;930.1396208507138;679.0493309366876;683.3132701634826;683.5249501596393;685.4619123987695;687.0107045853954;17417.129143542898;17458.825411745845;17478.475645730647;17553.122343882882;17581.120943952752;17026.829731702648;17099.23053462597;17232.310707571683;17641.38255161076;18058.548536286566;13450.461981520728;13623.659408514768;13666.316684165751;13724.107932984323;13863.168209907439;4098.7130900836955;4118.979405102985;4125.422440858282;4127.938080928789;4171.707980441371;53279.46720532784;55445.44554554483;62791.372086279465;65814;87129;13065.673358165932;13801.792973105412;13843.930780346236;13846.584602461942;13873;25379.74620253774;25398.111066112597;25433.237002889942;25462.872685636823;25750.227493175236;8680.30557555394;8951.820963580692;9050.547472626475;9114.04302548223;9329.30030247734;4808.182608956486;4847.878803029882;4899.730514821719;4928.137575924199;5051.1413059779925;3455.6026057003264;3534.8939531814085;3550.9112272192883;3566.3045706087582;3575.6245594212755;628.1739512540994;634.3624657219465;637.971291291893;650.7624716978269;653.1606885152556;851.7181641629309;880.9911900880909;888.6312180445043;891.4294851295176;903.9683611073581;11335.319880807177;11448.771024579462;11529.308241505536;11616.477258523386;11786.823197652042;840.3991146330403;852.2840813716508;855.9215338910099;866.6836604639387;868.9591767130863;5599.636023658449;5629.577781666391;5669.971650141723;5674;5723.484886360247;84875.5756221215;85150.57424712837;85901.57049214713;86414.13585864186;89541.55229223943;46597.767011164724;60391.39608603946;63594.0460893087;73097.2690273101;74969.62515187498;58159.70920145372;68118;70453.2954670457;71273.64363178151;73076;11540.422978850856;11744.29534227949;11808.409579520818;12113.636590902288;12140.817887731868;45400.31899521444;45915.311270330305;46182.921768519824;46322;47122.52877471319;45001.77499112483;46930.76534617305;50880.49119508905;51524.227136593734;51665.48334516757;13286.933565332112;13709.588712338646;15860.286287117338;16148.273327700517;16285.185740713154;15957.8404215961;16097.275622596777;16231.18844057816;17064.31742730277;17068.48794536166;15423.383064677288;15586.14276214819;15962.361505539648;16688.833111669213;16746.078965657005;16057.197140142713;16339.509814705103;16701.081440520888;16878.493645190665;17026.14869256557;16667.999920004837;16732.916335418246;16947.15264236808;17089.829101708823;17523.474295771146;12947.498801342557;13364.732705345645;13670.93164534171;13880.722385552433;14692.85749987496;12582.559610413959;13177.868221317663;13221.405036773176;13288.284936074035;13420.597382078553 22:27:26 INFO - PROCESS | 1404 | __end_tp_report 22:27:26 INFO - PROCESS | 1404 | __start_cc_report 22:27:26 INFO - PROCESS | 1404 | _x_x_mozilla_cycle_collect,1077 22:27:26 INFO - PROCESS | 1404 | __end_cc_report 22:27:26 INFO - PROCESS | 1404 | __startTimestamp1489728446348__endTimestamp 22:27:26 INFO - PROCESS | 1404 | 22:27:26 INFO - PROCESS | 1404 | ------- Summary: start ------- 22:27:26 INFO - PROCESS | 1404 | Number of tests: 6 22:27:26 INFO - PROCESS | 1404 | 22:27:26 INFO - PROCESS | 1404 | [#0] dojo.html Cycles:165 Average:5817.74 Median:6071.06 stddev:668.92 (11.0%) stddev-sans-first:643.12 22:27:26 INFO - PROCESS | 1404 | Values: 3382.4 3419.4 3430.7 3446.7 3472.5 5746.2 5831.8 5850.2 5856.5 5859.8 5793.3 5887.8 5892.9 5901.4 5911.6 5216.8 5245.7 5274.6 5291.7 5326.6 5110.3 5332.3 5346.9 5353.1 5354.1 5154.2 5171.9 5252.7 5332.1 5332.9 5312.5 5351.4 5352.0 5352.8 5354.0 5017.1 5216.7 5265.2 5297.1 5364.5 5674.0 5770.5 5824.4 5827.4 5837.2 6321.7 6326.4 6345.0 6356.1 6363.3 6115.5 6375.0 6377.9 6382.0 6390.2 5730.4 5778.2 5792.5 5793.4 5793.8 6281.8 6293.0 6347.0 6400.9 6441.2 6126.8 6173.1 6175.4 6176.2 6182.6 6300.3 6302.1 6303.0 6307.4 6316.5 6021.4 6057.5 6113.5 6130.9 6261.6 6059.2 6109.1 6139.9 6259.3 6267.2 4750.0 4756.4 4757.6 4780.2 4790.5 4278.3 4304.2 4315.5 4322.3 4344.3 5915.9 5969.5 6137.3 6138.0 6140.4 6164.1 6219.2 6340.6 6350.7 6356.6 6135.5 6142.9 6145.8 6150.9 6151.2 5365.3 5371.6 5379.5 5382.6 5384.1 6298.1 6335.4 6490.1 6525.2 6646.7 6293.0 6299.6 6357.9 6361.4 6370.0 6644.7 6653.9 6658.6 6659.0 6663.8 5959.6 5999.2 6111.3 6239.5 6244.3 6267.7 6276.1 6284.5 6300.4 6304.8 6142.1 6144.1 6144.6 6145.6 6146.9 5938.4 5985.0 6068.5 6068.5 6128.7 6044.8 6071.1 6125.4 6146.6 6155.6 6146.0 6149.6 6151.4 6153.1 6153.8 5763.5 5822.7 5889.4 5923.5 5947.8 22:27:26 INFO - PROCESS | 1404 | 22:27:26 INFO - PROCESS | 1404 | [#1] ext.html Cycles:180 Average:45511.91 Median:171291.77 stddev:73591.17 (43.0%) stddev-sans-first:73720.94 22:27:26 INFO - PROCESS | 1404 | Values: 769.2 823.7 841.8 914.6 927.2 30895.7 45392.5 45409.5 45457.0 45640.0 45678.1 46037.8 46077.5 46131.8 46159.1 9019.9 9168.2 9172.0 9193.2 9219.9 7371.5 7469.1 10326.5 10512.7 10879.3 10652.9 10670.2 10677.2 10691.6 10697.0 10528.4 10578.1 10598.7 10608.4 10636.3 10087.6 10090.3 10109.3 10136.4 10411.6 43417.1 43635.8 43685.6 43708.6 43740.3 4098.2 4119.2 4143.1 4202.2 4217.0 30725.2 30878.5 30999.5 31254.5 31356.0 4359.9 4379.9 4394.8 4403.6 4500.9 251256.0 252017.0 252181.0 252603.0 252685.7 55739.4 55962.4 56151.0 56190.0 56231.2 57337.7 57750.7 57753.4 57791.0 57852.0 16818.9 17116.4 17177.3 17178.5 17194.2 15197.0 15233.5 15249.7 15250.7 15262.3 12603.6 12807.8 13707.6 13821.3 13973.5 5317.0 5348.6 5409.0 5414.1 5439.4 1003.0 1024.6 1032.6 1033.2 1046.7 28428.6 28630.0 28634.0 28777.3 29084.0 1091.2 1102.4 1109.2 1114.2 1116.1 14569.6 15273.9 15459.3 15546.0 15657.8 309902.0 310053.0 310141.0 310974.0 311329.0 58061.0 58105.0 58118.0 58369.4 58385.0 1472.4 1492.2 1522.3 1533.1 1544.7 26248.9 27883.7 27996.9 28257.6 28337.9 43353.1 43548.6 43550.8 43551.8 43628.0 281137.0 281201.0 281233.0 281381.0 281450.0 25490.5 30361.2 30567.7 35545.3 35693.0 32889.0 33006.7 33299.5 39570.0 39610.6 34306.0 34620.1 34920.0 35175.8 35205.6 33942.7 34226.0 34235.8 34341.8 34440.0 35907.5 36364.3 36476.5 36496.5 37108.8 29974.6 31392.7 31966.0 32040.5 32247.5 25258.4 25465.9 25647.6 25676.4 26275.2 22:27:26 INFO - PROCESS | 1404 | 22:27:26 INFO - PROCESS | 1404 | [#2] jquery.html Cycles:180 Average:36805.10 Median:25262.18 stddev:105254.68 (416.6%) stddev-sans-first:105514.55 22:27:26 INFO - PROCESS | 1404 | Values: 447.2 457.2 460.1 466.8 481.6 19761.2 21183.8 21244.9 21329.5 21364.5 21015.9 21621.2 22484.8 23577.1 23825.0 6596.5 6629.0 6773.0 6813.2 6829.6 6729.1 6827.0 6830.8 6832.0 7156.1 7560.2 7620.5 7630.8 7631.0 7640.2 7243.5 7467.0 7500.5 7521.5 7621.1 7289.3 7429.8 7459.9 7467.5 7488.5 25223.4 25301.0 25648.0 25674.1 25976.5 2964.2 3085.3 3106.4 3168.4 3191.7 15250.7 15888.9 16119.2 16176.9 16514.1 2155.8 2239.9 2240.8 2286.1 2311.0 114890.0 115551.0 116258.4 116743.4 117732.0 17881.9 18161.5 18270.4 18575.2 18711.8 32244.4 32275.2 32319.7 32333.8 32557.5 10758.8 10805.4 10898.0 11010.2 11186.3 9258.8 9315.6 9335.9 9346.5 9551.9 9250.9 9359.0 9384.0 9439.0 9465.1 3511.9 3636.4 3811.5 3852.7 3907.2 899.1 926.3 929.3 935.5 938.0 19149.0 19979.4 20270.4 20482.3 20511.7 933.3 940.0 943.3 950.7 966.6 10178.9 11269.7 11281.3 11283.5 11363.1 626710.0 630822.0 634115.0 650287.0 657693.6 83159.0 84414.0 89663.6 98072.0 112064.0 1194.2 1210.3 1238.9 1250.8 1252.5 17991.7 18185.0 18611.3 18708.2 18962.0 49679.0 50742.5 51082.0 51251.0 52018.2 68163.0 68876.7 70167.0 70819.0 71252.0 11233.9 12114.6 12459.5 12517.9 12648.7 13943.8 14087.0 14128.3 14153.6 14299.1 12229.6 12252.3 12358.2 12489.9 12562.3 6394.7 11249.5 11466.8 11896.5 12103.3 12159.4 13029.7 13042.6 13112.5 13389.9 14246.1 14752.9 14780.0 14785.6 14878.2 13563.9 13734.5 13750.4 13929.8 13963.2 22:27:26 INFO - PROCESS | 1404 | 22:27:26 INFO - PROCESS | 1404 | [#3] mootools.html Cycles:180 Average:7208.07 Median:2363.30 stddev:4600.17 (194.7%) stddev-sans-first:4593.43 22:27:26 INFO - PROCESS | 1404 | Values: 1549.1 1562.5 1574.3 1580.2 1582.2 11033.6 11901.7 11902.3 11904.3 11904.6 10943.2 11195.4 11651.6 11662.4 11667.1 2465.1 2502.8 2507.5 2508.4 2511.9 2359.8 2421.5 2422.4 2423.6 2425.4 2366.8 2376.5 2381.9 2390.6 2393.0 2314.0 2318.4 2327.6 2334.3 2337.2 2185.4 2205.1 2230.5 2243.2 2243.9 11429.5 11663.2 11669.9 11680.8 11682.8 5756.1 5901.2 5904.8 5906.6 5907.0 3414.9 3446.6 3507.9 3616.0 3622.5 1318.0 1347.6 1352.3 1391.6 1423.4 14920.6 16191.2 17315.9 17660.2 17855.5 4643.3 4685.3 4795.6 4809.7 4828.5 11182.7 11450.5 13310.8 13311.5 13357.5 5677.4 5820.4 5900.3 5909.1 5916.3 5451.2 5512.9 5514.2 5536.6 5579.3 4027.8 4064.2 4134.3 4159.9 4168.4 1043.7 1047.0 1050.4 1051.8 1063.1 943.9 956.8 959.2 960.0 983.0 6570.4 6704.0 6777.8 6889.5 6912.9 1026.4 1049.8 1050.6 1064.4 1067.6 4563.2 4599.6 4658.0 4698.1 4702.7 13815.7 14129.9 14304.2 14688.0 14700.2 14706.3 14732.2 14752.5 14756.1 14775.3 10394.7 10565.7 10568.3 10648.1 10732.6 7303.2 7555.1 7703.0 7723.9 7824.5 12742.7 13176.8 13205.3 13417.9 13419.3 13017.8 13399.7 13534.6 13650.7 13703.3 10606.7 10880.8 10889.9 10898.8 10912.7 10460.8 11034.8 11099.2 11104.1 11146.7 9175.4 9227.5 9335.5 9418.0 9770.3 9573.7 9728.9 9784.5 9869.2 9981.1 8729.8 8732.4 8814.7 8818.8 8929.4 6354.4 6417.3 6428.3 6567.8 6579.7 6150.6 6262.1 6344.3 6375.5 6561.3 22:27:26 INFO - PROCESS | 1404 | 22:27:26 INFO - PROCESS | 1404 | [#4] prototype.html Cycles:180 Average:4868.70 Median:5359.58 stddev:1302.65 (24.3%) stddev-sans-first:1262.71 22:27:26 INFO - PROCESS | 1404 | Values: 416.4 438.9 440.9 443.9 449.8 5278.7 5333.6 5337.2 5344.9 5366.8 5001.9 5232.9 5256.6 5284.0 5317.4 4329.4 4335.5 4340.3 4341.6 4360.6 4348.7 4353.9 4375.8 4400.8 4416.6 4407.7 4415.0 4431.1 4433.6 4465.3 4178.9 4349.0 4355.2 4364.6 4402.5 4136.5 4140.6 4145.6 4149.8 4167.3 5226.6 5228.3 5232.8 5261.3 5298.6 5072.3 5156.6 5157.5 5159.1 5226.7 5525.5 5531.9 5581.9 5598.0 5613.3 4494.4 4565.4 4595.8 4606.7 4658.9 5535.4 5631.4 5652.2 5810.3 5825.5 4685.0 4704.3 4742.2 4787.8 4845.3 4835.7 4836.8 4863.2 4872.3 4897.3 4753.8 4846.4 5078.8 5126.6 5130.1 5564.3 5567.4 5604.9 5635.3 5638.8 1646.1 1673.6 1689.7 1694.1 1695.5 1269.2 1273.6 1275.7 1287.8 1304.4 5342.7 5482.0 5515.3 5518.5 5634.5 5689.4 5704.8 5735.4 5746.6 5757.2 5525.1 5567.8 5581.9 5637.9 5638.8 2861.1 3007.6 3038.4 3074.5 3076.9 5880.8 5934.7 5976.4 5978.7 5985.2 5562.5 5776.8 5838.9 5842.2 5927.5 5895.9 5942.3 5948.7 5953.2 5962.3 5704.3 5725.6 5765.0 5777.9 5785.6 5500.6 5517.9 5645.8 5676.7 5688.7 5742.9 5814.3 5820.5 5938.3 5970.7 4723.5 4740.9 4772.3 4791.4 4799.4 5505.2 5761.8 5782.2 5785.2 5785.4 5605.9 5617.8 5625.5 5629.3 5638.6 5622.3 5623.9 5678.4 5685.3 5685.4 5352.3 5503.6 5584.8 5600.3 5648.8 5621.3 5625.4 5644.5 5650.2 5654.7 5465.3 5540.4 5589.4 5596.6 5649.9 22:27:26 INFO - PROCESS | 1404 | 22:27:26 INFO - PROCESS | 1404 | [#5] yui.html Cycles:180 Average:18507.83 Median:45201.05 stddev:21937.93 (48.5%) stddev-sans-first:21959.23 22:27:26 INFO - PROCESS | 1404 | Values: 814.6 824.9 907.5 909.7 927.7 16874.4 17981.0 17992.0 18025.4 18131.1 14411.9 16025.5 16166.1 16195.8 16220.1 875.0 890.9 898.0 898.8 899.7 896.8 898.1 900.1 900.2 900.2 930.4 930.5 930.6 931.3 931.5 924.8 927.6 929.8 929.9 930.1 679.0 683.3 683.5 685.5 687.0 17417.1 17458.8 17478.5 17553.1 17581.1 17026.8 17099.2 17232.3 17641.4 18058.5 13450.5 13623.7 13666.3 13724.1 13863.2 4098.7 4119.0 4125.4 4127.9 4171.7 53279.5 55445.4 62791.4 65814.0 87129.0 13065.7 13801.8 13843.9 13846.6 13873.0 25379.7 25398.1 25433.2 25462.9 25750.2 8680.3 8951.8 9050.5 9114.0 9329.3 4808.2 4847.9 4899.7 4928.1 5051.1 3455.6 3534.9 3550.9 3566.3 3575.6 628.2 634.4 638.0 650.8 653.2 851.7 881.0 888.6 891.4 904.0 11335.3 11448.8 11529.3 11616.5 11786.8 840.4 852.3 855.9 866.7 869.0 5599.6 5629.6 5670.0 5674.0 5723.5 84875.6 85150.6 85901.6 86414.1 89541.6 46597.8 60391.4 63594.0 73097.3 74969.6 58159.7 68118.0 70453.3 71273.6 73076.0 11540.4 11744.3 11808.4 12113.6 12140.8 45400.3 45915.3 46182.9 46322.0 47122.5 45001.8 46930.8 50880.5 51524.2 51665.5 13286.9 13709.6 15860.3 16148.3 16285.2 15957.8 16097.3 16231.2 17064.3 17068.5 15423.4 15586.1 15962.4 16688.8 16746.1 16057.2 16339.5 16701.1 16878.5 17026.1 16668.0 16732.9 16947.2 17089.8 17523.5 12947.5 13364.7 13670.9 13880.7 14692.9 12582.6 13177.9 13221.4 13288.3 13420.6 22:27:26 INFO - PROCESS | 1404 | -------- Summary: end -------- 22:27:26 INFO - PROCESS | 1404 | 22:27:27 INFO - TEST-INFO | 1404: exit 0 22:27:27 INFO - TEST-OK | dromaeo_css | took 1115647ms 22:27:27 INFO - TEST-START | kraken 22:27:27 INFO - operating with platform_type : linux_ 22:27:27 INFO - Initialising browser for kraken test... 22:27:27 INFO - TEST-INFO | started process 1733 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmparTaec/profile http://localhost:44096/getInfo.html) 22:27:30 INFO - PROCESS | 1733 | __metrics Screen width/height:1600/1200 22:27:30 INFO - PROCESS | 1733 | colorDepth:24 22:27:30 INFO - PROCESS | 1733 | Browser inner width/height: 1024/697 22:27:30 INFO - PROCESS | 1733 | __metrics 22:27:31 INFO - PROCESS | 1733 | 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" 22:27:31 INFO - PROCESS | 1733 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:27:32 INFO - PROCESS | 1733 | console.error: PushService: 22:27:32 INFO - PROCESS | 1733 | stateChangeProcessEnqueue: Error transitioning state 22:27:32 INFO - PROCESS | 1733 | UnknownError 22:27:32 INFO - TEST-INFO | 1733: exit 0 22:27:32 INFO - Browser initialized. 22:27:32 INFO - Running cycle 1/1 for kraken test... 22:27:32 INFO - TEST-INFO | started process 1827 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmparTaec/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:27:44 INFO - PROCESS | 1827 | RSS: Main: 139546624 22:27:44 INFO - PROCESS | 1827 | 22:27:47 INFO - PROCESS | 1827 | Cycle 1(1): loaded http://localhost:44096/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44096/tests/kraken/driver.html?testName=audio-beat-detection) 22:27:47 INFO - PROCESS | 1827 | RSS: Main: 182435840 22:27:47 INFO - PROCESS | 1827 | 22:27:50 INFO - PROCESS | 1827 | Cycle 1(1): loaded http://localhost:44096/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44096/tests/kraken/driver.html?testName=audio-dft) 22:27:50 INFO - PROCESS | 1827 | RSS: Main: 173588480 22:27:50 INFO - PROCESS | 1827 | 22:27:53 INFO - PROCESS | 1827 | Cycle 1(1): loaded http://localhost:44096/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44096/tests/kraken/driver.html?testName=audio-fft) 22:27:54 INFO - PROCESS | 1827 | RSS: Main: 265420800 22:27:54 INFO - PROCESS | 1827 | 22:27:56 INFO - PROCESS | 1827 | Cycle 1(1): loaded http://localhost:44096/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44096/tests/kraken/driver.html?testName=audio-oscillator) 22:27:57 INFO - PROCESS | 1827 | RSS: Main: 171986944 22:27:57 INFO - PROCESS | 1827 | 22:27:59 INFO - PROCESS | 1827 | Cycle 1(1): loaded http://localhost:44096/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44096/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:27:59 INFO - PROCESS | 1827 | RSS: Main: 174444544 22:27:59 INFO - PROCESS | 1827 | 22:28:02 INFO - PROCESS | 1827 | Cycle 1(1): loaded http://localhost:44096/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44096/tests/kraken/driver.html?testName=imaging-darkroom) 22:28:03 INFO - PROCESS | 1827 | RSS: Main: 213680128 22:28:03 INFO - PROCESS | 1827 | 22:28:06 INFO - PROCESS | 1827 | Cycle 1(1): loaded http://localhost:44096/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44096/tests/kraken/driver.html?testName=imaging-desaturate) 22:28:07 INFO - PROCESS | 1827 | RSS: Main: 212271104 22:28:07 INFO - PROCESS | 1827 | 22:28:09 INFO - PROCESS | 1827 | Cycle 1(1): loaded http://localhost:44096/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44096/tests/kraken/driver.html?testName=json-parse-financial) 22:28:10 INFO - PROCESS | 1827 | RSS: Main: 210313216 22:28:10 INFO - PROCESS | 1827 | 22:28:12 INFO - PROCESS | 1827 | Cycle 1(1): loaded http://localhost:44096/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44096/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:28:12 INFO - PROCESS | 1827 | RSS: Main: 173170688 22:28:12 INFO - PROCESS | 1827 | 22:28:14 INFO - PROCESS | 1827 | Cycle 1(1): loaded http://localhost:44096/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44096/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:28:14 INFO - PROCESS | 1827 | RSS: Main: 179515392 22:28:14 INFO - PROCESS | 1827 | 22:28:16 INFO - PROCESS | 1827 | Cycle 1(1): loaded http://localhost:44096/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44096/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:28:17 INFO - PROCESS | 1827 | RSS: Main: 189091840 22:28:17 INFO - PROCESS | 1827 | 22:28:20 INFO - PROCESS | 1827 | Cycle 1(1): loaded http://localhost:44096/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44096/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:28:20 INFO - PROCESS | 1827 | RSS: Main: 198385664 22:28:20 INFO - PROCESS | 1827 | 22:28:23 INFO - PROCESS | 1827 | Cycle 1(1): loaded http://localhost:44096/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44096/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:28:24 INFO - PROCESS | 1827 | RSS: Main: 194756608 22:28:24 INFO - PROCESS | 1827 | 22:28:25 INFO - PROCESS | 1827 | Cycle 1(1): loaded http://localhost:44096/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44096/tests/kraken/driver.html?testName=ai-astar) 22:28:25 INFO - PROCESS | 1827 | RSS: Main: 245555200 22:28:25 INFO - PROCESS | 1827 | 22:28:25 INFO - PROCESS | 1827 | __start_tp_report 22:28:25 INFO - PROCESS | 1827 | _x_x_mozilla_page_load 22:28:25 INFO - PROCESS | 1827 | _x_x_mozilla_page_load_details 22:28:25 INFO - PROCESS | 1827 | |i|pagename|runs| 22:28:25 INFO - PROCESS | 1827 | |0;ai-astar;104;112;112;113;114;115;111;112;113;113 22:28:25 INFO - PROCESS | 1827 | |1;audio-beat-detection;145;116;123;145;116;117;115;117;135;117 22:28:25 INFO - PROCESS | 1827 | |2;audio-dft;160;161;162;161;161;160;162;161;161;163 22:28:25 INFO - PROCESS | 1827 | |3;audio-fft;74;76;75;111;77;76;76;75;89;76 22:28:25 INFO - PROCESS | 1827 | |4;audio-oscillator;81;82;112;82;81;81;92;81;81;98 22:28:25 INFO - PROCESS | 1827 | |5;imaging-gaussian-blur;114;113;113;113;113;113;113;114;114;114 22:28:25 INFO - PROCESS | 1827 | |6;imaging-darkroom;147;146;147;146;147;147;147;147;146;147 22:28:26 INFO - PROCESS | 1827 | |7;imaging-desaturate;94;95;93;94;94;93;94;94;94;94 22:28:26 INFO - PROCESS | 1827 | |8;json-parse-financial;54;54;53;53;54;55;54;54;55;55 22:28:26 INFO - PROCESS | 1827 | |9;json-stringify-tinderbox;52;53;55;53;54;53;53;52;53;55 22:28:26 INFO - PROCESS | 1827 | |10;stanford-crypto-aes;84;78;80;75;80;85;75;81;79;75 22:28:26 INFO - PROCESS | 1827 | |11;stanford-crypto-ccm;122;123;132;121;122;126;127;119;163;124 22:28:26 INFO - PROCESS | 1827 | |12;stanford-crypto-pbkdf2;162;162;163;163;159;164;162;163;161;158 22:28:26 INFO - PROCESS | 1827 | |13;stanford-crypto-sha256-iterative;61;60;70;58;59;58;58;58;58;58 22:28:26 INFO - PROCESS | 1827 | __end_tp_report 22:28:26 INFO - PROCESS | 1827 | __start_cc_report 22:28:26 INFO - PROCESS | 1827 | _x_x_mozilla_cycle_collect,1661 22:28:26 INFO - PROCESS | 1827 | __end_cc_report 22:28:26 INFO - PROCESS | 1827 | __startTimestamp1489728505994__endTimestamp 22:28:26 INFO - PROCESS | 1827 | 22:28:26 INFO - PROCESS | 1827 | ------- Summary: start ------- 22:28:26 INFO - PROCESS | 1827 | Number of tests: 14 22:28:26 INFO - PROCESS | 1827 | 22:28:26 INFO - PROCESS | 1827 | [#0] ai-astar Cycles:10 Average:111.90 Median:113.00 stddev:3.00 (2.7%) stddev-sans-first:1.20 22:28:26 INFO - PROCESS | 1827 | Values: 104.0 112.0 112.0 113.0 114.0 115.0 111.0 112.0 113.0 113.0 22:28:26 INFO - PROCESS | 1827 | 22:28:26 INFO - PROCESS | 1827 | [#1] audio-beat-detection Cycles:10 Average:124.60 Median:120.00 stddev:12.28 (10.2%) stddev-sans-first:10.57 22:28:26 INFO - PROCESS | 1827 | Values: 145.0 116.0 123.0 145.0 116.0 117.0 115.0 117.0 135.0 117.0 22:28:26 INFO - PROCESS | 1827 | 22:28:26 INFO - PROCESS | 1827 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:0.92 (0.6%) stddev-sans-first:0.87 22:28:26 INFO - PROCESS | 1827 | Values: 160.0 161.0 162.0 161.0 161.0 160.0 162.0 161.0 161.0 163.0 22:28:26 INFO - PROCESS | 1827 | 22:28:26 INFO - PROCESS | 1827 | [#3] audio-fft Cycles:10 Average:80.50 Median:76.00 stddev:11.54 (15.2%) stddev-sans-first:12.00 22:28:26 INFO - PROCESS | 1827 | Values: 74.0 76.0 75.0 111.0 77.0 76.0 76.0 75.0 89.0 76.0 22:28:26 INFO - PROCESS | 1827 | 22:28:26 INFO - PROCESS | 1827 | [#4] audio-oscillator Cycles:10 Average:87.10 Median:81.50 stddev:10.55 (12.9%) stddev-sans-first:10.95 22:28:26 INFO - PROCESS | 1827 | Values: 81.0 82.0 112.0 82.0 81.0 81.0 92.0 81.0 81.0 98.0 22:28:26 INFO - PROCESS | 1827 | 22:28:26 INFO - PROCESS | 1827 | [#5] imaging-gaussian-blur Cycles:10 Average:113.40 Median:113.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 22:28:26 INFO - PROCESS | 1827 | Values: 114.0 113.0 113.0 113.0 113.0 113.0 113.0 114.0 114.0 114.0 22:28:26 INFO - PROCESS | 1827 | 22:28:26 INFO - PROCESS | 1827 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 22:28:26 INFO - PROCESS | 1827 | Values: 147.0 146.0 147.0 146.0 147.0 147.0 147.0 147.0 146.0 147.0 22:28:26 INFO - PROCESS | 1827 | 22:28:26 INFO - PROCESS | 1827 | [#7] imaging-desaturate Cycles:10 Average:93.90 Median:94.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 22:28:26 INFO - PROCESS | 1827 | Values: 94.0 95.0 93.0 94.0 94.0 93.0 94.0 94.0 94.0 94.0 22:28:26 INFO - PROCESS | 1827 | 22:28:26 INFO - PROCESS | 1827 | [#8] json-parse-financial Cycles:10 Average:54.10 Median:54.00 stddev:0.74 (1.4%) stddev-sans-first:0.78 22:28:26 INFO - PROCESS | 1827 | Values: 54.0 54.0 53.0 53.0 54.0 55.0 54.0 54.0 55.0 55.0 22:28:26 INFO - PROCESS | 1827 | 22:28:26 INFO - PROCESS | 1827 | [#9] json-stringify-tinderbox Cycles:10 Average:53.30 Median:53.00 stddev:1.06 (2.0%) stddev-sans-first:1.01 22:28:26 INFO - PROCESS | 1827 | Values: 52.0 53.0 55.0 53.0 54.0 53.0 53.0 52.0 53.0 55.0 22:28:26 INFO - PROCESS | 1827 | 22:28:26 INFO - PROCESS | 1827 | [#10] stanford-crypto-aes Cycles:10 Average:79.20 Median:80.00 stddev:3.58 (4.5%) stddev-sans-first:3.35 22:28:26 INFO - PROCESS | 1827 | Values: 84.0 78.0 80.0 75.0 80.0 85.0 75.0 81.0 79.0 75.0 22:28:26 INFO - PROCESS | 1827 | 22:28:26 INFO - PROCESS | 1827 | [#11] stanford-crypto-ccm Cycles:10 Average:127.90 Median:125.00 stddev:12.86 (10.3%) stddev-sans-first:13.46 22:28:26 INFO - PROCESS | 1827 | Values: 122.0 123.0 132.0 121.0 122.0 126.0 127.0 119.0 163.0 124.0 22:28:26 INFO - PROCESS | 1827 | 22:28:26 INFO - PROCESS | 1827 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.70 Median:162.50 stddev:1.89 (1.2%) stddev-sans-first:2.00 22:28:26 INFO - PROCESS | 1827 | Values: 162.0 162.0 163.0 163.0 159.0 164.0 162.0 163.0 161.0 158.0 22:28:26 INFO - PROCESS | 1827 | 22:28:26 INFO - PROCESS | 1827 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:59.80 Median:58.50 stddev:3.74 (6.4%) stddev-sans-first:3.94 22:28:26 INFO - PROCESS | 1827 | Values: 61.0 60.0 70.0 58.0 59.0 58.0 58.0 58.0 58.0 58.0 22:28:26 INFO - PROCESS | 1827 | -------- Summary: end -------- 22:28:26 INFO - PROCESS | 1827 | 22:28:27 INFO - TEST-INFO | 1827: exit 0 22:28:27 INFO - TEST-OK | kraken | took 59951ms 22:28:27 INFO - SUITE-END | took 1175s 22:28:27 INFO - Completed test suite (00:19:35) 22:28:27 INFO - javascript benchmark 22:28:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7934.825197201486, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3382.391169589474, 3419.4357930941383, 3430.6740859618344, 3446.7242620590355, 3472.4791281307803, 5746.1668058131545, 5831.825045248644, 5850.151727999448, 5856.531477481802, 5859.765609375625, 5793.304803423584, 5887.793927212538, 5892.852678683024, 5901.439363260494, 5911.645301281927, 5216.76524556394, 5245.7377131143485, 5274.604404669665, 5291.735413229342, 5326.573874090082, 5110.28456016158, 5332.253484512172, 5346.91979620304, 5353.116735738598, 5354.063038968185, 5154.226865970097, 5171.948280517185, 5252.658577192489, 5332.120200166968, 5332.92000619991, 5312.521873031426, 5351.357837059539, 5352.036633405985, 5352.759125839308, 5354.009508240968, 5017.071841709296, 5216.713080780555, 5265.236540701615, 5297.099493086146, 5364.490373414558, 5674.00704876645, 5770.451807078321, 5824.359320474744, 5827.417258274181, 5837.153612726173, 6321.683915804238, 6326.367363263636, 6345.0482427636225, 6356.0783686365685, 6363.268224154189, 6115.510759139258, 6375.0, 6377.872442551169, 6382.0, 6390.169277993878, 5730.426957304237, 5778.219940308089, 5792.478676919098, 5793.362730099686, 5793.826185214451, 6281.842953926189, 6292.968535157295, 6346.968265158737, 6400.935990640034, 6441.1626488556185, 6126.754929802847, 6173.074038894202, 6175.413335733098, 6176.197094377702, 6182.629042257479, 6300.30696623371, 6302.054691796267, 6303.0, 6307.400796924285, 6316.526260530479, 6021.42796434338, 6057.545684073712, 6113.484984902833, 6130.948521380002, 6261.592996455216, 6059.1820104286235, 6109.053096770008, 6139.8601398601395, 6259.280182778948, 6267.1539342189135, 4750.049990002013, 4756.357891684647, 4757.619390448755, 4780.211265141283, 4790.4969978152485, 4278.294081476583, 4304.225239456928, 4315.546867578922, 4322.308430651081, 4344.348347747863, 5915.881682366328, 5969.522438204933, 6137.263528376534, 6137.96931015342, 6140.385961403824, 6164.075388691732, 6219.222597175353, 6340.587861788969, 6350.682465876687, 6356.586821856565, 6135.509159267248, 6142.877142457215, 6145.8156255312415, 6150.938490615036, 6151.200343955257, 5365.302510673666, 5371.6239863209985, 5379.5427388671615, 5382.623216374895, 5384.111621582473, 6298.055291706189, 6335.366463353628, 6490.091387205795, 6525.249596296487, 6646.734130634721, 6293.0, 6299.622022678471, 6357.90463143044, 6361.427471527585, 6370.044493326038, 6644.667766611747, 6653.933460665331, 6658.600483970978, 6659.034440006075, 6663.83340416474, 5959.553033522417, 5999.1901093351835, 6111.327753947151, 6239.469645080219, 6244.344343844013, 6267.6866156692895, 6276.089966954857, 6284.528660350584, 6300.369963003663, 6304.842378940563, 6142.109394137736, 6144.10910417978, 6144.56988010835, 6145.631262124287, 6146.907796382969, 5938.406159384027, 5985.0, 6068.4538391544975, 6068.514518838394, 6128.724207410588, 6044.788432404845, 6071.058985857199, 6125.388069147376, 6146.631202127886, 6155.599886007395, 6146.0, 6149.569530133027, 6151.415615516519, 6153.138560601609, 6153.753849845956, 5763.452472015152, 5822.679752613647, 5889.440503152194, 5923.466887980103, 5947.821565353046], "value": 5772.708860008436, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [769.1923480345639, 823.7117009046833, 841.760098371964, 914.6295750221159, 927.2026057590475, 30895.691043089562, 45392.54607453924, 45409.54590454099, 45457.0, 45640.0, 45678.08643827122, 46037.76981115098, 46077.539224607746, 46131.76934115333, 46159.07681846361, 9019.909800902005, 9168.220701240403, 9172.0, 9193.172614464696, 9219.907800922005, 7371.520851144658, 7469.066366704162, 10326.483675816216, 10512.737181570483, 10879.347239165636, 10652.946735266352, 10670.199735019865, 10677.199210059238, 10691.625793097242, 10697.0, 10528.42093684847, 10578.100861426788, 10598.735031624194, 10608.416537090457, 10636.30863993838, 10087.596496140146, 10090.293679442442, 10109.292349535535, 10136.391816491034, 10411.583536658525, 43417.13165736699, 43635.78182109101, 43685.56314436847, 43708.56291437077, 43740.3438948416, 4098.221337945781, 4119.217348703737, 4143.129942712004, 4202.159568086365, 4216.9578304216875, 30725.231869203224, 30878.536821947688, 30999.535006974915, 31254.53118203229, 31356.0, 4359.934600980988, 4379.896961203366, 4394.780260986938, 4403.647827513853, 4500.932486012713, 251256.0, 252017.0, 252181.0, 252603.0, 252685.7365713178, 55739.44260557424, 55962.440375595725, 56151.0, 56190.0, 56231.15653265204, 57337.713311433174, 57750.7112464435, 57753.42246577564, 57791.0, 57852.0, 16818.91590542064, 17116.400925967533, 17177.31290748381, 17178.484645460656, 17194.226259818337, 15197.0, 15233.542993710207, 15249.695006099815, 15250.694986100216, 15262.313195905988, 12603.558875439316, 12807.807882881763, 13707.588772336845, 13821.308934553232, 13973.510927117502, 5316.973415132899, 5348.572114230852, 5408.971635636636, 5414.133738601883, 5439.428859969726, 1003.0370843989851, 1024.574801457387, 1032.6024480575034, 1033.1579762493693, 1046.6912260882905, 28428.573571396446, 28630.0, 28634.0, 28777.280567985967, 29083.982060627775, 1091.1979694924225, 1102.3716481605409, 1109.1570406491126, 1114.2089116727213, 1116.1461481966303, 14569.635759105895, 15273.923630382, 15459.304331305118, 15546.0, 15657.843421565867, 309902.0, 310053.0, 310141.0, 310974.0, 311329.0, 58061.0, 58105.0, 58118.0, 58369.4163058364, 58385.0, 1472.4036765110147, 1492.2165862921836, 1522.2540954932003, 1533.1031346662328, 1544.6601747615507, 26248.868755656098, 27883.72116278811, 27996.860015699793, 28257.57613635756, 28337.858310708314, 43353.132937340444, 43548.56451435572, 43550.782246088565, 43551.78224108859, 43628.0, 281137.0, 281201.0, 281233.0, 281381.0, 281450.0, 25490.49019019572, 30361.24096897595, 30567.694323056483, 35545.28909421849, 35693.0, 32889.0, 33006.669933300356, 33299.500507491925, 39570.0, 39610.60389396069, 34306.0, 34620.134496636776, 34920.0, 35175.82412088026, 35205.64794352126, 33942.66057339395, 34226.0, 34235.828820855735, 34341.828290858386, 34440.0, 35907.46138807972, 36364.27271454609, 36476.45285320775, 36496.452553211195, 37108.814455927546, 29974.550381744728, 31392.686073138975, 31966.0, 32040.5193922096, 32247.51628725524, 25258.36854078663, 25465.872670636527, 25647.615285770356, 25676.358091047874, 26275.21174364772], "value": 19031.50205064897, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [447.23299541286684, 457.1884904294876, 460.09820751327396, 466.8389405655048, 481.63877092180866, 19761.209551617936, 21183.834889081096, 21244.93775311234, 21329.466763330925, 21364.4658883528, 21015.894920525414, 21621.243256486025, 22484.775152248472, 23577.056917723272, 23825.046998120055, 6596.538242323039, 6628.972509261061, 6772.966135169342, 6813.2164801047775, 6829.590224586541, 6729.091572637704, 6827.044213810071, 6830.760923367683, 6832.043513908056, 7156.141263048441, 7560.168381478033, 7620.542767433972, 7630.847383052335, 7631.046119235096, 7640.235976402371, 7243.529170603894, 7466.9626651866665, 7500.549967001943, 7521.548707077593, 7621.085469743639, 7289.271072892721, 7429.777106686808, 7459.888101678479, 7467.514611550232, 7488.475806693534, 25223.36941576457, 25301.0, 25648.0, 25674.101406450685, 25976.480470390674, 2964.172136980981, 3085.274960384308, 3106.4253113174136, 3168.3821654777325, 3191.7287030602192, 15250.694986100327, 15888.920555397264, 16119.194040297938, 16176.919115404347, 16514.091724955124, 2155.7520885098256, 2239.8992045358, 2240.843140980132, 2286.0512887151813, 2311.0062673050584, 114890.0, 115551.0, 116258.41870790676, 116743.41628291804, 117732.0, 17881.910590447224, 18161.45515634533, 18270.360537381126, 18575.16411761447, 18711.812881871007, 32244.35511289761, 32275.193120171713, 32319.73761836696, 32333.838330808667, 32557.51163732546, 10758.768470707288, 10805.40570268627, 10898.0, 11010.174236932262, 11186.32882027081, 9258.814823703487, 9315.627374905063, 9335.90664093364, 9346.532673366304, 9551.856722149034, 9250.907490925005, 9359.0, 9383.953080234554, 9439.0, 9465.148136667733, 3511.9437050207052, 3636.4363523653874, 3811.5045044144085, 3852.7110466715108, 3907.159960608426, 899.109881217603, 926.3006430145332, 929.3355250995571, 935.4714586258742, 938.0, 19149.0, 19979.400617981482, 20270.391888243375, 20482.283120091022, 20511.692324615142, 933.2533972821716, 939.9859002114973, 943.2501161576563, 950.7147855643418, 966.5795379010153, 10178.898211017795, 11269.66191014271, 11281.282781357579, 11283.492242849092, 11363.14776391774, 626710.0, 630822.0, 634115.0, 650287.0, 657693.5576610623, 83159.0, 84414.0, 89663.55168224117, 98072.01927980629, 112064.0, 1194.205853107691, 1210.334316126127, 1238.8575313838844, 1250.8186312984567, 1252.473960936409, 17991.73012404789, 18185.0, 18611.255549778398, 18708.158132884324, 18962.0, 49679.0, 50742.49257507525, 51081.999999998516, 51251.0, 52018.21972670337, 68163.0, 68876.65561672159, 70167.0, 70819.0, 71252.0, 11233.943830280796, 12114.575989840665, 12459.501619935101, 12517.93741031289, 12648.747025059263, 13943.790843137564, 14087.0, 14128.293585320487, 14153.646158846112, 14299.07056041354, 12229.633111006684, 12252.264864108181, 12358.196717213352, 12489.875101248872, 12562.309073000708, 6394.7442102317245, 11249.493772780408, 11466.827997579876, 11896.524139034342, 12103.273803571814, 12159.392030398622, 13029.739405212033, 13042.608721738363, 13112.475500979854, 13389.866101338863, 14246.145231286157, 14752.852471475147, 14780.0, 14785.556433307018, 14878.181700006604, 13563.932180339036, 13734.45062197541, 13750.449982001008, 13929.791053134413, 13963.162210267417], "value": 11532.524519321447, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1549.10926217425, 1562.5234303537416, 1574.2600977540556, 1580.1862041048855, 1582.2484319948026, 11033.613823516178, 11901.702457438569, 11902.34537100459, 11904.285742855423, 11904.642860714182, 10943.179261555395, 11195.384253866034, 11651.592194273202, 11662.358570278631, 11667.12496562759, 2465.0632759551345, 2502.8373155744816, 2507.53610582042, 2508.4481414088873, 2511.937201569957, 2359.7640235976437, 2421.539907417594, 2422.358075110097, 2423.612222044473, 2425.3936515871032, 2366.8343215974887, 2376.4534157143867, 2381.8570885746826, 2390.5696974544576, 2393.042782886842, 2313.9884300578556, 2318.3508617587104, 2327.55776402483, 2334.2997100869757, 2337.1703045418803, 2185.442712108418, 2205.095910676615, 2230.453538882984, 2243.23729931824, 2243.8653680779207, 11429.542818287258, 11663.24188927717, 11669.883301166965, 11680.824787628193, 11682.766344673058, 5756.107803290497, 5901.203337549462, 5904.763809447617, 5906.616069955439, 5907.0, 3414.9487757683655, 3446.6208717041104, 3507.94738078929, 3615.963840361589, 3622.5290712207507, 1317.9934100329533, 1347.6226656536185, 1352.2900477249425, 1391.5527851034913, 1423.3523746695332, 14920.62698432537, 16191.190440477929, 17315.913420432942, 17660.205290761947, 17855.464336069937, 4643.326717625993, 4685.320628508915, 4795.568398844121, 4809.663323567387, 4828.517148285214, 11182.66452006441, 11450.484728187252, 13310.800337994939, 13311.467541298432, 13357.53248636293, 5677.37548869624, 5820.417958204231, 5900.262467191601, 5909.084091965752, 5916.319623243296, 5451.182322651634, 5512.944870551243, 5514.228008078872, 5536.584756143306, 5579.2746942897165, 4027.8187481562813, 4064.227796718614, 4134.297169481196, 4159.91680166395, 4168.353905144708, 1043.7129789308, 1047.0471870597871, 1050.3540322701483, 1051.7738686182508, 1063.0857462582173, 943.8867335919733, 956.818204541135, 959.1511512311515, 959.9904000960041, 982.9508524573743, 6570.408663220333, 6704.0, 6777.830554236183, 6889.517733758689, 6912.861742765116, 1026.440589878518, 1049.8057859296055, 1050.632278702448, 1064.3720205078885, 1067.5783065689009, 4563.224251877189, 4599.6090332321455, 4657.975245445997, 4698.060387922361, 4702.717836929795, 13815.723685526233, 14129.85870141306, 14304.213268270138, 14688.04527705717, 14700.191489468181, 14706.264686765619, 14732.189729564763, 14752.483663071742, 14756.114633122046, 14775.261236938326, 10394.740131496621, 10565.683029509128, 10568.260221784401, 10648.094911932418, 10732.570697172026, 7303.196648368781, 7555.09338879338, 7702.961485192538, 7723.922760772545, 7824.530528168328, 12742.745145097231, 13176.80234796498, 13205.33973301312, 13417.932910335387, 13419.261940593362, 13017.804732929204, 13399.732005360032, 13534.59396218115, 13650.726985460435, 13703.314834258446, 10606.734831629272, 10880.836787448035, 10889.945550272514, 10898.836517452086, 10912.672619821418, 10460.843087353847, 11034.834477483004, 11099.223054386115, 11104.111671066457, 11146.665600032013, 9175.403598766059, 9227.538623068685, 9335.48654823964, 9418.0, 9770.31607787448, 9573.712788616353, 9728.902710973083, 9784.461854597781, 9869.161121304769, 9981.051800078982, 8729.825403491768, 8732.388732788899, 8814.735557933273, 8818.823623527365, 8929.374943753875, 6354.3963323484195, 6417.326180751141, 6428.260750013808, 6567.835804104936, 6579.703913323816, 6150.630962142286, 6262.123302737711, 6344.270408903035, 6375.521835862236, 6561.343865613591], "value": 5423.386971421986, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [416.38375204697064, 438.86395217482584, 440.9140217657556, 443.8681362525559, 449.781855799937, 5278.683279003258, 5333.626646134772, 5337.1994200869885, 5344.877575709106, 5366.838994830161, 5001.949980500194, 5232.92150617741, 5256.580723204733, 5283.969625922947, 5317.3619165700175, 4329.372241025049, 4335.544767799383, 4340.283853164224, 4341.630961368288, 4360.629346505535, 4348.7390756554705, 4353.891152721191, 4375.803088861009, 4400.845970391037, 4416.5583441655735, 4407.735535867858, 4415.0, 4431.135928493945, 4433.630440864949, 4465.330200469939, 4178.937315940263, 4349.0, 4355.216061108983, 4364.563543645641, 4402.471703395581, 4136.503619565641, 4140.565240649748, 4145.647619952308, 4149.813258403379, 4167.291560434734, 5226.634135610509, 5228.320318358627, 5232.764525596357, 5261.316028916216, 5298.602604804655, 5072.250073724559, 5156.639035267533, 5157.48425157485, 5159.1229490986625, 5226.660267082628, 5525.4528731955115, 5531.944680553223, 5581.916271255935, 5598.033042487447, 5613.326400831886, 4494.37078808967, 4565.360849481075, 4595.816167353335, 4606.723596584216, 4658.9068218635775, 5535.391106978229, 5631.352394474647, 5652.236948012048, 5810.302763668345, 5825.475707186331, 4684.95315046852, 4704.341392205094, 4742.217534106834, 4787.832425865078, 4845.2732090186755, 4835.734034628059, 4836.806527738851, 4863.221884498464, 4872.269159626085, 4897.2898929655, 4753.765730106844, 4846.39420072491, 5078.847634570969, 5126.615503837227, 5130.127878260705, 5564.276644036249, 5567.359753628303, 5604.943950560524, 5635.295588051494, 5638.830835074954, 1646.0699954081754, 1673.573238824092, 1689.6536210076904, 1694.110591939217, 1695.465928232603, 1269.2447993443886, 1273.5988163728582, 1275.6810797300675, 1287.8068289756611, 1304.3543445994103, 5342.652727572696, 5481.972590137104, 5515.338159420895, 5518.475744804237, 5634.548971197542, 5689.374168841424, 5704.832163777738, 5735.369109398046, 5746.569007324384, 5757.193992841006, 5525.088360420566, 5567.805126820542, 5581.944180558143, 5637.887242255214, 5638.830835074954, 2861.141657502741, 3007.5789389485053, 3038.3923215356576, 3074.4773388524004, 3076.8769249230227, 5880.764769409176, 5934.703264836741, 5976.402359763989, 5978.730957106854, 5985.221921150222, 5562.471565201299, 5776.840674714199, 5838.854028649318, 5842.211301474246, 5927.496162826122, 5895.852603684856, 5942.3166335871065, 5948.702564871739, 5953.226080609493, 5962.34414214436, 5704.3154821421695, 5725.627834190765, 5764.971175144097, 5777.91333129995, 5785.566082543742, 5500.642458240201, 5517.862053448696, 5645.774169033192, 5676.68778217202, 5688.687122208318, 5742.913856292075, 5814.273215848019, 5820.476157145878, 5938.257717785277, 5970.701464926649, 4723.45680246776, 4740.862193073706, 4772.308015337826, 4791.448983366958, 4799.424069111729, 5505.174223866452, 5761.769529218785, 5782.2194003808945, 5785.218995435563, 5785.3636100028125, 5605.850800585951, 5617.8033768817895, 5625.549956003428, 5629.296337957755, 5638.631774654737, 5622.269105016322, 5623.8875222496135, 5678.422593765901, 5685.289338832646, 5685.431456854281, 5352.330958630171, 5503.587230957774, 5584.776608935597, 5600.271964644733, 5648.802291919763, 5621.297337832771, 5625.353084395347, 5644.463775941279, 5650.208970744181, 5654.717264136694, 5465.262189604353, 5540.418256083053, 5589.441055894378, 5596.636218645775, 5649.915251271316], "value": 4493.99935119604, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [814.6415577146051, 824.9175082491752, 907.4782000349801, 909.7134402663161, 927.6706769096968, 16874.409395671155, 17981.0, 17991.999999999967, 18025.36911208108, 18131.09344532773, 14411.855881441208, 16025.519234422956, 16166.11086390248, 16195.757063644025, 16220.10789406582, 874.9912500874989, 890.888638920135, 897.995510022449, 898.8112496375769, 899.6626265150569, 896.8116695493921, 898.0660113481971, 900.0729248873671, 900.1673452056854, 900.1718419054486, 930.3952430919888, 930.5254320296664, 930.5533343994887, 931.2503434735036, 931.4504442379028, 924.8150369925975, 927.5686805635345, 929.8233335666201, 929.930255230857, 930.1396208507138, 679.0493309366876, 683.3132701634826, 683.5249501596393, 685.4619123987695, 687.0107045853954, 17417.129143542898, 17458.825411745845, 17478.475645730647, 17553.122343882882, 17581.120943952752, 17026.829731702648, 17099.23053462597, 17232.310707571683, 17641.38255161076, 18058.548536286566, 13450.461981520728, 13623.659408514768, 13666.316684165751, 13724.107932984323, 13863.168209907439, 4098.7130900836955, 4118.979405102985, 4125.422440858282, 4127.938080928789, 4171.707980441371, 53279.46720532784, 55445.44554554483, 62791.372086279465, 65814.0, 87129.0, 13065.673358165932, 13801.792973105412, 13843.930780346236, 13846.584602461942, 13873.0, 25379.74620253774, 25398.111066112597, 25433.237002889942, 25462.872685636823, 25750.227493175236, 8680.30557555394, 8951.820963580692, 9050.547472626475, 9114.04302548223, 9329.30030247734, 4808.182608956486, 4847.878803029882, 4899.730514821719, 4928.137575924199, 5051.1413059779925, 3455.6026057003264, 3534.8939531814085, 3550.9112272192883, 3566.3045706087582, 3575.6245594212755, 628.1739512540994, 634.3624657219465, 637.971291291893, 650.7624716978269, 653.1606885152556, 851.7181641629309, 880.9911900880909, 888.6312180445043, 891.4294851295176, 903.9683611073581, 11335.319880807177, 11448.771024579462, 11529.308241505536, 11616.477258523386, 11786.823197652042, 840.3991146330403, 852.2840813716508, 855.9215338910099, 866.6836604639387, 868.9591767130863, 5599.636023658449, 5629.577781666391, 5669.971650141723, 5674.0, 5723.484886360247, 84875.5756221215, 85150.57424712837, 85901.57049214713, 86414.13585864186, 89541.55229223943, 46597.767011164724, 60391.39608603946, 63594.0460893087, 73097.2690273101, 74969.62515187498, 58159.70920145372, 68118.0, 70453.2954670457, 71273.64363178151, 73076.0, 11540.422978850856, 11744.29534227949, 11808.409579520818, 12113.636590902288, 12140.817887731868, 45400.31899521444, 45915.311270330305, 46182.921768519824, 46322.0, 47122.52877471319, 45001.77499112483, 46930.76534617305, 50880.49119508905, 51524.227136593734, 51665.48334516757, 13286.933565332112, 13709.588712338646, 15860.286287117338, 16148.273327700517, 16285.185740713154, 15957.8404215961, 16097.275622596777, 16231.18844057816, 17064.31742730277, 17068.48794536166, 15423.383064677288, 15586.14276214819, 15962.361505539648, 16688.833111669213, 16746.078965657005, 16057.197140142713, 16339.509814705103, 16701.081440520888, 16878.493645190665, 17026.14869256557, 16667.999920004837, 16732.916335418246, 16947.15264236808, 17089.829101708823, 17523.474295771146, 12947.498801342557, 13364.732705345645, 13670.93164534171, 13880.722385552433, 14692.85749987496, 12582.559610413959, 13177.868221317663, 13221.405036773176, 13288.284936074035, 13420.597382078553], "value": 8081.755678367682, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1455.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 112.0, 112.0, 113.0, 114.0, 115.0, 111.0, 112.0, 113.0, 113.0], "value": 111.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 116.0, 123.0, 145.0, 116.0, 117.0, 115.0, 117.0, 135.0, 117.0], "value": 124.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 162.0, 161.0, 161.0, 160.0, 162.0, 161.0, 161.0, 163.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 75.0, 111.0, 77.0, 76.0, 76.0, 75.0, 89.0, 76.0], "value": 80.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 112.0, 82.0, 81.0, 81.0, 92.0, 81.0, 81.0, 98.0], "value": 87.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 113.0, 113.0, 113.0, 113.0, 113.0, 114.0, 114.0, 114.0], "value": 113.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 146.0, 147.0, 147.0, 147.0, 147.0, 146.0, 147.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 93.0, 94.0, 94.0, 93.0, 94.0, 94.0, 94.0, 94.0], "value": 93.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 53.0, 53.0, 54.0, 55.0, 54.0, 54.0, 55.0, 55.0], "value": 54.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 53.0, 55.0, 53.0, 54.0, 53.0, 53.0, 52.0, 53.0, 55.0], "value": 53.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 78.0, 80.0, 75.0, 80.0, 85.0, 75.0, 81.0, 79.0, 75.0], "value": 79.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 123.0, 132.0, 121.0, 122.0, 126.0, 127.0, 119.0, 163.0, 124.0], "value": 127.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 163.0, 163.0, 159.0, 164.0, 162.0, 163.0, 161.0, 158.0], "value": 161.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 70.0, 58.0, 59.0, 58.0, 58.0, 58.0, 58.0, 58.0], "value": 59.8, "unit": "score"}]}]} 22:28:27 INFO - Return code: 0 22:28:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:28:27 ERROR - # TBPL SUCCESS # 22:28:27 INFO - Running post-action listener: _resource_record_post_action 22:28:27 INFO - [mozharness: 2017-03-17 05:28:27.322035Z] Finished run-tests step (success) 22:28:27 INFO - Running post-run listener: _resource_record_post_run 22:28:27 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 266240; Write bytes: 366739456; Read time: 36; Write time: 208840 22:28:27 INFO - TinderboxPrint: CPU usage
13.1% 22:28:27 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 36 22:28:27 INFO - TinderboxPrint: I/O write bytes / time
366,739,456 / 208,840 22:28:27 INFO - TinderboxPrint: CPU idle
8,262.4 (86.8%) 22:28:27 INFO - TinderboxPrint: CPU user
1,203.6 (12.7%) 22:28:27 INFO - TinderboxPrint: Swap in / out
0 / 0 22:28:27 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 111054848; Read time: 0; Write time: 67572 22:28:27 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 266240; Write bytes: 255684608; Read time: 36; Write time: 141268 22:28:27 INFO - Running post-run listener: _upload_blobber_files 22:28:27 INFO - Blob upload gear active. 22:28:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:28:27 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 22:28:27 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'] 22:28:27 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 22:28:28 INFO - (blobuploader) - INFO - Open directory for files ... 22:28:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:28:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:28:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:28:32 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:28:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:28:32 INFO - (blobuploader) - INFO - Done attempting. 22:28:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 22:28:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:28:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:28:32 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 22:28:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:28:32 INFO - (blobuploader) - INFO - Done attempting. 22:28:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:28:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:28:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:28:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:28:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:28:33 INFO - (blobuploader) - INFO - Done attempting. 22:28:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 22:28:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:28:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:28:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:28:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:28:34 INFO - (blobuploader) - INFO - Done attempting. 22:28:34 INFO - (blobuploader) - INFO - Iteration through files over. 22:28:34 INFO - Return code: 0 22:28:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:28:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:28:34 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1083d7f6b50a21c92132494ddd1a43a03df51b7e193d7639fbfc93bff4bb04d470e57a1f4bb8bae0b61d629d7945f5e43f0db1db1c26dd6c8910b0ad52faf83a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0b062d1ef2bef3926ed0cb9de7cde5cecfedf134ba03d50d0249d8ac807afdeb1ed8ad4bb4f3e17b380ed15d276d35844079226a54e32a3c653ac3a422c2183b", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/396cdc826cf46531e9bf9be44f5f5851ed3fe5ab19320a0284580002941a639a06ef5e4ea465227555a2dab472e90c4d320dffd4455183791bbf84b6c3717ae9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b66b633c8d7655537ef8d994fa9c5c1e78c1059527c418f7e9786601fea3763e06987b0e57cf2d9bfcb36a806a701ad78120394ad0fedad1436c4a25ca25ff18"} 22:28:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:28:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:28:34 INFO - Contents: 22:28:34 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1083d7f6b50a21c92132494ddd1a43a03df51b7e193d7639fbfc93bff4bb04d470e57a1f4bb8bae0b61d629d7945f5e43f0db1db1c26dd6c8910b0ad52faf83a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0b062d1ef2bef3926ed0cb9de7cde5cecfedf134ba03d50d0249d8ac807afdeb1ed8ad4bb4f3e17b380ed15d276d35844079226a54e32a3c653ac3a422c2183b", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/396cdc826cf46531e9bf9be44f5f5851ed3fe5ab19320a0284580002941a639a06ef5e4ea465227555a2dab472e90c4d320dffd4455183791bbf84b6c3717ae9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b66b633c8d7655537ef8d994fa9c5c1e78c1059527c418f7e9786601fea3763e06987b0e57cf2d9bfcb36a806a701ad78120394ad0fedad1436c4a25ca25ff18"} 22:28:34 INFO - Running post-run listener: copy_logs_to_upload_dir 22:28:34 INFO - Copying logs to upload dir... 22:28:34 INFO - mkdir: /builds/slave/test/build/upload/logs 22:28:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.594921 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-03-16 22:28:34.490434) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-16 22:28:34.494264) ========= 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=db0483c52d987ecb441a263b000001ad-1489726431.561765-1911677626 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1083d7f6b50a21c92132494ddd1a43a03df51b7e193d7639fbfc93bff4bb04d470e57a1f4bb8bae0b61d629d7945f5e43f0db1db1c26dd6c8910b0ad52faf83a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0b062d1ef2bef3926ed0cb9de7cde5cecfedf134ba03d50d0249d8ac807afdeb1ed8ad4bb4f3e17b380ed15d276d35844079226a54e32a3c653ac3a422c2183b", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/396cdc826cf46531e9bf9be44f5f5851ed3fe5ab19320a0284580002941a639a06ef5e4ea465227555a2dab472e90c4d320dffd4455183791bbf84b6c3717ae9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b66b633c8d7655537ef8d994fa9c5c1e78c1059527c418f7e9786601fea3763e06987b0e57cf2d9bfcb36a806a701ad78120394ad0fedad1436c4a25ca25ff18"} build_url:https://queue.taskcluster.net/v1/task/To2NTRFkTI2cEeg1u-ty6w/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011445 build_url: 'https://queue.taskcluster.net/v1/task/To2NTRFkTI2cEeg1u-ty6w/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1083d7f6b50a21c92132494ddd1a43a03df51b7e193d7639fbfc93bff4bb04d470e57a1f4bb8bae0b61d629d7945f5e43f0db1db1c26dd6c8910b0ad52faf83a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0b062d1ef2bef3926ed0cb9de7cde5cecfedf134ba03d50d0249d8ac807afdeb1ed8ad4bb4f3e17b380ed15d276d35844079226a54e32a3c653ac3a422c2183b", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/396cdc826cf46531e9bf9be44f5f5851ed3fe5ab19320a0284580002941a639a06ef5e4ea465227555a2dab472e90c4d320dffd4455183791bbf84b6c3717ae9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b66b633c8d7655537ef8d994fa9c5c1e78c1059527c418f7e9786601fea3763e06987b0e57cf2d9bfcb36a806a701ad78120394ad0fedad1436c4a25ca25ff18"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-16 22:28:34.522330) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-16 22:28:34.522902) ========= 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=db0483c52d987ecb441a263b000001ad-1489726431.561765-1911677626 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004534 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-16 22:28:34.605629) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-16 22:28:34.605976) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-16 22:28:34.606322) ========= ========= Total master_lag: 0.22 =========