builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-050 starttime: 1490814918.08 results: success (0) revision: 4c7c05a49f3ce40aa0969beccb397380a8907f4a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-29 12:15:18.081401) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-29 12:15:18.081837) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-29 12:15:18.082105) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-29 12:15:18.097460) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 12:15:18.097812) ========= 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=6dbc10da6d83fee962c624be000001a8-1490814917.370061-630035441 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-29 12:15:18-- 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% 45.9M=0s 2017-03-29 12:15:18 (45.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.131030 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 12:15:18.245049) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 12:15:18.245359) ========= 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=6dbc10da6d83fee962c624be000001a8-1490814917.370061-630035441 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019459 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 12:15:18.294402) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-29 12:15:18.294736) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 4c7c05a49f3ce40aa0969beccb397380a8907f4a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 4c7c05a49f3ce40aa0969beccb397380a8907f4a --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=6dbc10da6d83fee962c624be000001a8-1490814917.370061-630035441 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-29 12:15:18,345 truncating revision to first 12 chars 2017-03-29 12:15:18,345 Setting DEBUG logging. 2017-03-29 12:15:18,345 attempt 1/10 2017-03-29 12:15:18,345 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/4c7c05a49f3c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-29 12:15:19,074 unpacking tar archive at: mozilla-central-4c7c05a49f3c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.099558 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-29 12:15:19.407571) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-29 12:15:19.407925) ========= script_repo_revision: 4c7c05a49f3ce40aa0969beccb397380a8907f4a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-29 12:15:19.408291) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-29 12:15:19.408549) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-29 12:15:19.417062) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-03-29 12:15:19.417364) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6dbc10da6d83fee962c624be000001a8-1490814917.370061-630035441 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:15:19 INFO - MultiFileLogger online at 20170329 12:15:19 in /builds/slave/test 12:15:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 12:15:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:15:19 INFO - {'append_to_log': False, 12:15:19 INFO - 'base_work_dir': '/builds/slave/test', 12:15:19 INFO - 'blob_upload_branch': 'Firefox', 12:15:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:15:19 INFO - 'branch': 'Firefox', 12:15:19 INFO - 'buildbot_json_path': 'buildprops.json', 12:15:19 INFO - 'config_files': ('talos/linux_config.py',), 12:15:19 INFO - 'default_actions': ('clobber', 12:15:19 INFO - 'read-buildbot-config', 12:15:19 INFO - 'download-and-extract', 12:15:19 INFO - 'populate-webroot', 12:15:19 INFO - 'create-virtualenv', 12:15:19 INFO - 'install', 12:15:19 INFO - 'run-tests'), 12:15:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:15:19 INFO - 'download_minidump_stackwalk': True, 12:15:19 INFO - 'download_symbols': 'ondemand', 12:15:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:15:19 INFO - 'tooltool.py': '/tools/tooltool.py', 12:15:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:15:19 INFO - '/tools/misc-python/virtualenv.py')}, 12:15:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:15:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:15:19 INFO - 'gecko_profile': False, 12:15:19 INFO - 'gecko_profile_interval': 0, 12:15:19 INFO - 'installer_path': 'installer.exe', 12:15:19 INFO - 'log_level': 'info', 12:15:19 INFO - 'log_name': 'talos', 12:15:19 INFO - 'log_to_console': True, 12:15:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:15:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:15:19 INFO - 'opt_config_files': (), 12:15:19 INFO - 'pip_index': False, 12:15:19 INFO - 'suite': 'dromaeojs', 12:15:19 INFO - 'system_bits': '32', 12:15:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:15:19 INFO - 'title': 'talos-linux64-ix-050', 12:15:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:15:19 INFO - 'use_talos_json': True, 12:15:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:15:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:15:19 INFO - 'work_dir': 'build'} 12:15:19 INFO - [mozharness: 2017-03-29 19:15:19.569768Z] Running clobber step. 12:15:19 INFO - Running pre-action listener: _resource_record_pre_action 12:15:19 INFO - Running main action method: clobber 12:15:19 INFO - rmtree: /builds/slave/test/build 12:15:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:15:21 INFO - Running post-action listener: _resource_record_post_action 12:15:21 INFO - [mozharness: 2017-03-29 19:15:21.013751Z] Finished clobber step (success) 12:15:21 INFO - [mozharness: 2017-03-29 19:15:21.013852Z] Running read-buildbot-config step. 12:15:21 INFO - Running pre-action listener: _resource_record_pre_action 12:15:21 INFO - Running main action method: read_buildbot_config 12:15:21 INFO - Using buildbot properties: 12:15:21 INFO - { 12:15:21 INFO - "project": "", 12:15:21 INFO - "product": "firefox", 12:15:21 INFO - "who": "kwierso@gmail.com", 12:15:21 INFO - "installer_path": "public/build/target.tar.bz2", 12:15:21 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 12:15:21 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 12:15:21 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 12:15:21 INFO - "stage_platform": "linux64-pgo", 12:15:21 INFO - "basedir": "/builds/slave/test", 12:15:21 INFO - "buildnumber": 114, 12:15:21 INFO - "platform": "ubuntu64_hw", 12:15:21 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 12:15:21 INFO - "slavebuilddir": "test", 12:15:21 INFO - "taskId": "TfgwNAHgQJOOxchsHnJPjw", 12:15:21 INFO - "branch": "mozilla-central", 12:15:21 INFO - "script_repo_revision": "production", 12:15:21 INFO - "revision": "4c7c05a49f3ce40aa0969beccb397380a8907f4a", 12:15:21 INFO - "slavename": "talos-linux64-ix-050", 12:15:21 INFO - "repo_path": "mozilla-central" 12:15:21 INFO - } 12:15:21 INFO - Finding installer, test and symbols from parent task. 12:15:21 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TfgwNAHgQJOOxchsHnJPjw'}, attempt #1 12:15:21 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TfgwNAHgQJOOxchsHnJPjw'}, attempt #1 12:15:21 INFO - Task dependencies: XzVzjrAsQiiK3FdmaqdoHQ 12:15:21 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XzVzjrAsQiiK3FdmaqdoHQ'}, attempt #1 12:15:22 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/XzVzjrAsQiiK3FdmaqdoHQ/artifacts/public/build/target.tar.bz2 12:15:22 INFO - Set test_url: https://queue.taskcluster.net/v1/task/XzVzjrAsQiiK3FdmaqdoHQ/artifacts/public/build/test_packages.json 12:15:22 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/XzVzjrAsQiiK3FdmaqdoHQ/artifacts/public/build/target.crashreporter-symbols.zip 12:15:22 INFO - Running post-action listener: _resource_record_post_action 12:15:22 INFO - [mozharness: 2017-03-29 19:15:22.392136Z] Finished read-buildbot-config step (success) 12:15:22 INFO - [mozharness: 2017-03-29 19:15:22.392352Z] Running download-and-extract step. 12:15:22 INFO - Running pre-action listener: _resource_record_pre_action 12:15:22 INFO - Running main action method: download_and_extract 12:15:22 INFO - mkdir: /builds/slave/test/build/tests 12:15:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:15:22 INFO - trying https://queue.taskcluster.net/v1/task/XzVzjrAsQiiK3FdmaqdoHQ/artifacts/public/build/target.test_packages.json 12:15:22 INFO - Downloading https://queue.taskcluster.net/v1/task/XzVzjrAsQiiK3FdmaqdoHQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 12:15:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XzVzjrAsQiiK3FdmaqdoHQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 12:15:22 INFO - Downloaded 986 bytes. 12:15:22 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 12:15:22 INFO - Using the following test package requirements: 12:15:22 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 12:15:22 INFO - u'common': [u'target.common.tests.zip'], 12:15:22 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 12:15:22 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 12:15:22 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 12:15:22 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 12:15:22 INFO - u'mozbase': [u'target.common.tests.zip'], 12:15:22 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 12:15:22 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 12:15:22 INFO - u'web-platform': [u'target.common.tests.zip', 12:15:22 INFO - u'target.web-platform.tests.zip'], 12:15:22 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 12:15:22 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 12:15:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XzVzjrAsQiiK3FdmaqdoHQ/artifacts/public/build/target.common.tests.zip 12:15:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XzVzjrAsQiiK3FdmaqdoHQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 12:15:22 INFO - Fetch https://queue.taskcluster.net/v1/task/XzVzjrAsQiiK3FdmaqdoHQ/artifacts/public/build/target.common.tests.zip into memory 12:15:24 INFO - Expected file size: 60348770 12:15:24 INFO - Obtained file size: 60348770 12:15:33 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 12:15:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XzVzjrAsQiiK3FdmaqdoHQ/artifacts/public/build/target.common.tests.zip 12:15:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XzVzjrAsQiiK3FdmaqdoHQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 12:15:33 INFO - Fetch https://queue.taskcluster.net/v1/task/XzVzjrAsQiiK3FdmaqdoHQ/artifacts/public/build/target.common.tests.zip into memory 12:15:35 INFO - Expected file size: 60348770 12:15:35 INFO - Obtained file size: 60348770 12:15:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XzVzjrAsQiiK3FdmaqdoHQ/artifacts/public/build/target.talos.tests.zip 12:15:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XzVzjrAsQiiK3FdmaqdoHQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 12:15:45 INFO - Fetch https://queue.taskcluster.net/v1/task/XzVzjrAsQiiK3FdmaqdoHQ/artifacts/public/build/target.talos.tests.zip into memory 12:15:46 INFO - Expected file size: 14404171 12:15:46 INFO - Obtained file size: 14404171 12:15:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:15:46 INFO - trying https://queue.taskcluster.net/v1/task/XzVzjrAsQiiK3FdmaqdoHQ/artifacts/public/build/target.tar.bz2 12:15:46 INFO - Downloading https://queue.taskcluster.net/v1/task/XzVzjrAsQiiK3FdmaqdoHQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 12:15:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XzVzjrAsQiiK3FdmaqdoHQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 12:15:48 INFO - Downloaded 67793390 bytes. 12:15:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XzVzjrAsQiiK3FdmaqdoHQ/artifacts/public/build/target.tar.bz2 12:15:48 INFO - mkdir: /builds/slave/test/properties 12:15:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:15:48 INFO - Writing to file /builds/slave/test/properties/build_url 12:15:48 INFO - Contents: 12:15:48 INFO - build_url:https://queue.taskcluster.net/v1/task/XzVzjrAsQiiK3FdmaqdoHQ/artifacts/public/build/target.tar.bz2 12:15:48 INFO - Running post-action listener: _resource_record_post_action 12:15:48 INFO - Running post-action listener: set_extra_try_arguments 12:15:48 INFO - [mozharness: 2017-03-29 19:15:48.174506Z] Finished download-and-extract step (success) 12:15:48 INFO - [mozharness: 2017-03-29 19:15:48.174601Z] Running populate-webroot step. 12:15:48 INFO - Running pre-action listener: _resource_record_pre_action 12:15:48 INFO - Running main action method: populate_webroot 12:15:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:15:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:15:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:15:48 INFO - '--tppagecycles', 12:15:48 INFO - '7'], 12:15:48 INFO - 'tests': ['tsvgm']}}, 12:15:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:15:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:15:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:15:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:15:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:15:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:15:48 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 12:15:48 INFO - 'talos_options': ['--disable-e10s'], 12:15:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:15:48 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 12:15:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:15:48 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 12:15:48 INFO - 'talos_options': ['--disable-e10s'], 12:15:48 INFO - 'tests': ['damp', 'tps']}, 12:15:48 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 12:15:48 INFO - 'tests': ['damp', 'tps']}, 12:15:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:15:48 INFO - 'tests': ['dromaeo_dom']}, 12:15:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:15:48 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:15:48 INFO - 'tests': ['basic_compositor_video']}, 12:15:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:15:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:15:48 INFO - 'tests': ['a11yr', 12:15:48 INFO - 'ts_paint', 12:15:48 INFO - 'tpaint', 12:15:48 INFO - 'sessionrestore', 12:15:48 INFO - 'sessionrestore_no_auto_restore', 12:15:48 INFO - 'tabpaint']}, 12:15:48 INFO - 'other-e10s': {'tests': ['a11yr', 12:15:48 INFO - 'ts_paint', 12:15:48 INFO - 'tpaint', 12:15:48 INFO - 'sessionrestore', 12:15:48 INFO - 'sessionrestore_no_auto_restore', 12:15:48 INFO - 'tabpaint']}, 12:15:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:15:48 INFO - 'ts_paint', 12:15:48 INFO - 'tpaint', 12:15:48 INFO - 'sessionrestore', 12:15:48 INFO - 'sessionrestore_no_auto_restore', 12:15:48 INFO - 'tabpaint']}, 12:15:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:15:48 INFO - 'ts_paint', 12:15:48 INFO - 'tpaint', 12:15:48 INFO - 'sessionrestore', 12:15:48 INFO - 'sessionrestore_no_auto_restore', 12:15:48 INFO - 'tabpaint']}, 12:15:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:15:48 INFO - 'tests': ['a11yr', 12:15:48 INFO - 'ts_paint', 12:15:48 INFO - 'tpaint', 12:15:48 INFO - 'sessionrestore', 12:15:48 INFO - 'sessionrestore_no_auto_restore', 12:15:48 INFO - 'tabpaint']}, 12:15:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:15:48 INFO - 'tests': ['a11yr', 12:15:48 INFO - 'ts_paint', 12:15:48 INFO - 'tpaint', 12:15:48 INFO - 'sessionrestore', 12:15:48 INFO - 'sessionrestore_no_auto_restore', 12:15:48 INFO - 'tabpaint']}, 12:15:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:15:48 INFO - 'tests': ['tsvgx', 12:15:48 INFO - 'tsvgr_opacity', 12:15:48 INFO - 'tart', 12:15:48 INFO - 'tscrollx', 12:15:48 INFO - 'cart', 12:15:48 INFO - 'tsvg_static']}, 12:15:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:15:48 INFO - 'tsvgr_opacity', 12:15:48 INFO - 'tart', 12:15:48 INFO - 'tscrollx', 12:15:48 INFO - 'cart', 12:15:48 INFO - 'tsvg_static']}, 12:15:48 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 12:15:48 INFO - 'talos_options': ['--disable-e10s'], 12:15:48 INFO - 'tests': ['tp5o']}, 12:15:48 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 12:15:48 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 12:15:48 INFO - 'talos_options': ['--disable-e10s', 12:15:48 INFO - '--xperf_path', 12:15:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:15:48 INFO - 'tests': ['tp5n']}, 12:15:48 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 12:15:48 INFO - 'talos_options': ['--xperf_path', 12:15:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:15:48 INFO - 'tests': ['tp5n']}}, 12:15:48 INFO - 'talos.zip': {'path': '', 12:15:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:15:48 INFO - Running post-action listener: _resource_record_post_action 12:15:48 INFO - [mozharness: 2017-03-29 19:15:48.187633Z] Finished populate-webroot step (success) 12:15:48 INFO - [mozharness: 2017-03-29 19:15:48.187724Z] Running create-virtualenv step. 12:15:48 INFO - Running pre-action listener: _resource_record_pre_action 12:15:48 INFO - Running main action method: create_virtualenv 12:15:48 INFO - Creating virtualenv /builds/slave/test/build/venv 12:15:48 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 12:15:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:15:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:15:48 INFO - Using real prefix '/usr' 12:15:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:15:48 INFO - Installing distribute.............................................................................................................................................................................................done. 12:15:50 INFO - Installing pip.................done. 12:15:50 INFO - Return code: 0 12:15:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:15:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:15:50 INFO - Reading from file tmpfile_stdout 12:15:50 INFO - Output received: 12:15:50 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 12:15:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:15:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:15:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:15:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:51 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 0x15821f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15bfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1820310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181d400>, '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 0x181e3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x181e840>, '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': '6dbc10da6d83fee962c624be000001a8-1490814917.370061-630035441', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:15:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 12:15:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:15:51 INFO - Using env: {'DISPLAY': ':0', 12:15:51 INFO - 'HOME': '/home/cltbld', 12:15:51 INFO - 'LANG': 'en_US.UTF-8', 12:15:51 INFO - 'LANGUAGE': 'en_US:en', 12:15:51 INFO - 'LOGNAME': 'cltbld', 12:15:51 INFO - 'MAIL': '/var/mail/cltbld', 12:15:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:51 INFO - 'MOZ_NO_REMOTE': '1', 12:15:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:15:51 INFO - 'NO_EM_RESTART': '1', 12:15:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:15:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:51 INFO - 'PWD': '/builds/slave/test', 12:15:51 INFO - 'SHELL': '/bin/bash', 12:15:51 INFO - 'SHLVL': '1', 12:15:51 INFO - 'TERM': 'linux', 12:15:51 INFO - 'TMOUT': '86400', 12:15:51 INFO - 'USER': 'cltbld', 12:15:51 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1490814917.370061-630035441', 12:15:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:51 INFO - '_': '/tools/buildbot/bin/python'} 12:15:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:51 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 12:15:51 INFO - Cleaning up... 12:15:51 INFO - Return code: 0 12:15:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:15: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')]} 12:15:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15: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')]} 12:15:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:51 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 0x15821f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15bfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1820310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181d400>, '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 0x181e3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x181e840>, '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': '6dbc10da6d83fee962c624be000001a8-1490814917.370061-630035441', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:15:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 12:15:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 12:15:51 INFO - Using env: {'DISPLAY': ':0', 12:15:51 INFO - 'HOME': '/home/cltbld', 12:15:51 INFO - 'LANG': 'en_US.UTF-8', 12:15:51 INFO - 'LANGUAGE': 'en_US:en', 12:15:51 INFO - 'LOGNAME': 'cltbld', 12:15:51 INFO - 'MAIL': '/var/mail/cltbld', 12:15:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:51 INFO - 'MOZ_NO_REMOTE': '1', 12:15:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:15:51 INFO - 'NO_EM_RESTART': '1', 12:15:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:15:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:51 INFO - 'PWD': '/builds/slave/test', 12:15:51 INFO - 'SHELL': '/bin/bash', 12:15:51 INFO - 'SHLVL': '1', 12:15:51 INFO - 'TERM': 'linux', 12:15:51 INFO - 'TMOUT': '86400', 12:15:51 INFO - 'USER': 'cltbld', 12:15:51 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1490814917.370061-630035441', 12:15:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:51 INFO - '_': '/tools/buildbot/bin/python'} 12:15:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:51 INFO - Downloading/unpacking psutil>=3.1.1 12:15:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:15:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:15:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:15:53 INFO - Installing collected packages: psutil 12:15:53 INFO - Running setup.py install for psutil 12:15:53 INFO - building 'psutil._psutil_linux' extension 12:15:53 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 12:15:53 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 12:15:53 INFO - building 'psutil._psutil_posix' extension 12:15:53 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 12:15:53 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 12:15:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:15:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:15:54 INFO - Successfully installed psutil 12:15:54 INFO - Cleaning up... 12:15:54 INFO - Return code: 0 12:15:54 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:15:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:15:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:15:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:54 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 0x15821f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15bfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1820310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181d400>, '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 0x181e3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x181e840>, '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': '6dbc10da6d83fee962c624be000001a8-1490814917.370061-630035441', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:15:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 12:15:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 12:15:54 INFO - Using env: {'DISPLAY': ':0', 12:15:54 INFO - 'HOME': '/home/cltbld', 12:15:54 INFO - 'LANG': 'en_US.UTF-8', 12:15:54 INFO - 'LANGUAGE': 'en_US:en', 12:15:54 INFO - 'LOGNAME': 'cltbld', 12:15:54 INFO - 'MAIL': '/var/mail/cltbld', 12:15:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:54 INFO - 'MOZ_NO_REMOTE': '1', 12:15:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:15:54 INFO - 'NO_EM_RESTART': '1', 12:15:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:15:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:54 INFO - 'PWD': '/builds/slave/test', 12:15:54 INFO - 'SHELL': '/bin/bash', 12:15:54 INFO - 'SHLVL': '1', 12:15:54 INFO - 'TERM': 'linux', 12:15:54 INFO - 'TMOUT': '86400', 12:15:54 INFO - 'USER': 'cltbld', 12:15:54 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1490814917.370061-630035441', 12:15:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:54 INFO - '_': '/tools/buildbot/bin/python'} 12:15:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:15:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:15:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:15:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:15:56 INFO - Installing collected packages: mozsystemmonitor 12:15:56 INFO - Running setup.py install for mozsystemmonitor 12:15:56 INFO - Successfully installed mozsystemmonitor 12:15:56 INFO - Cleaning up... 12:15:56 INFO - Return code: 0 12:15:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:15:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:15:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:15:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:56 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 0x15821f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15bfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1820310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181d400>, '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 0x181e3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x181e840>, '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': '6dbc10da6d83fee962c624be000001a8-1490814917.370061-630035441', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:15:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 12:15:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 12:15:56 INFO - Using env: {'DISPLAY': ':0', 12:15:56 INFO - 'HOME': '/home/cltbld', 12:15:56 INFO - 'LANG': 'en_US.UTF-8', 12:15:56 INFO - 'LANGUAGE': 'en_US:en', 12:15:56 INFO - 'LOGNAME': 'cltbld', 12:15:56 INFO - 'MAIL': '/var/mail/cltbld', 12:15:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:56 INFO - 'MOZ_NO_REMOTE': '1', 12:15:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:15:56 INFO - 'NO_EM_RESTART': '1', 12:15:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:15:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:56 INFO - 'PWD': '/builds/slave/test', 12:15:56 INFO - 'SHELL': '/bin/bash', 12:15:56 INFO - 'SHLVL': '1', 12:15:56 INFO - 'TERM': 'linux', 12:15:56 INFO - 'TMOUT': '86400', 12:15:56 INFO - 'USER': 'cltbld', 12:15:56 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1490814917.370061-630035441', 12:15:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:56 INFO - '_': '/tools/buildbot/bin/python'} 12:15:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:56 INFO - Downloading/unpacking jsonschema==2.5.1 12:15:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:15:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:15:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:59 INFO - Downloading functools32-3.2.3-2.tar.gz 12:15:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:15:59 INFO - warning: no files found matching '*.txt' 12:15:59 INFO - no previously-included directories found matching 'build' 12:15:59 INFO - no previously-included directories found matching 'dist' 12:15:59 INFO - no previously-included directories found matching '.git*' 12:15:59 INFO - Installing collected packages: jsonschema, functools32 12:15:59 INFO - Running setup.py install for functools32 12:15:59 INFO - warning: no files found matching '*.txt' 12:15:59 INFO - no previously-included directories found matching 'build' 12:15:59 INFO - no previously-included directories found matching 'dist' 12:15:59 INFO - no previously-included directories found matching '.git*' 12:15:59 INFO - Successfully installed jsonschema functools32 12:15:59 INFO - Cleaning up... 12:15:59 INFO - Return code: 0 12:15:59 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:15:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:15:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:15:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:59 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 0x15821f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15bfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1820310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181d400>, '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 0x181e3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x181e840>, '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': '6dbc10da6d83fee962c624be000001a8-1490814917.370061-630035441', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:15:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 12:15:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 12:15:59 INFO - Using env: {'DISPLAY': ':0', 12:15:59 INFO - 'HOME': '/home/cltbld', 12:15:59 INFO - 'LANG': 'en_US.UTF-8', 12:15:59 INFO - 'LANGUAGE': 'en_US:en', 12:15:59 INFO - 'LOGNAME': 'cltbld', 12:15:59 INFO - 'MAIL': '/var/mail/cltbld', 12:15:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:59 INFO - 'MOZ_NO_REMOTE': '1', 12:15:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:15:59 INFO - 'NO_EM_RESTART': '1', 12:15:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:15:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:59 INFO - 'PWD': '/builds/slave/test', 12:15:59 INFO - 'SHELL': '/bin/bash', 12:15:59 INFO - 'SHLVL': '1', 12:15:59 INFO - 'TERM': 'linux', 12:15:59 INFO - 'TMOUT': '86400', 12:15:59 INFO - 'USER': 'cltbld', 12:15:59 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1490814917.370061-630035441', 12:15:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:59 INFO - '_': '/tools/buildbot/bin/python'} 12:15:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:59 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:15:59 INFO - Cleaning up... 12:15:59 INFO - Return code: 0 12:15:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:15:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:15:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:15:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:59 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 0x15821f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15bfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1820310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181d400>, '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 0x181e3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x181e840>, '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': '6dbc10da6d83fee962c624be000001a8-1490814917.370061-630035441', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:15:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:15:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:15:59 INFO - Using env: {'DISPLAY': ':0', 12:15:59 INFO - 'HOME': '/home/cltbld', 12:15:59 INFO - 'LANG': 'en_US.UTF-8', 12:15:59 INFO - 'LANGUAGE': 'en_US:en', 12:15:59 INFO - 'LOGNAME': 'cltbld', 12:15:59 INFO - 'MAIL': '/var/mail/cltbld', 12:15:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:59 INFO - 'MOZ_NO_REMOTE': '1', 12:15:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:15:59 INFO - 'NO_EM_RESTART': '1', 12:15:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:15:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:59 INFO - 'PWD': '/builds/slave/test', 12:15:59 INFO - 'SHELL': '/bin/bash', 12:15:59 INFO - 'SHLVL': '1', 12:15:59 INFO - 'TERM': 'linux', 12:15:59 INFO - 'TMOUT': '86400', 12:15:59 INFO - 'USER': 'cltbld', 12:15:59 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1490814917.370061-630035441', 12:15:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:59 INFO - '_': '/tools/buildbot/bin/python'} 12:15:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:59 INFO - Downloading/unpacking blobuploader==1.2.4 12:15:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:16:01 INFO - Downloading blobuploader-1.2.4.tar.gz 12:16:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:16:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:16:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:16:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:16:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:16:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:16:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:16:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:16:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:16:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:16:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:16:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:16:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:16:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:16:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:16:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:16:02 INFO - Downloading docopt-0.6.1.tar.gz 12:16:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:16:02 INFO - Installing collected packages: blobuploader, requests, docopt 12:16:02 INFO - Running setup.py install for blobuploader 12:16:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:16:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:16:02 INFO - Running setup.py install for requests 12:16:03 INFO - Running setup.py install for docopt 12:16:03 INFO - Successfully installed blobuploader requests docopt 12:16:03 INFO - Cleaning up... 12:16:03 INFO - Return code: 0 12:16:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:16:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:16:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:16:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:16:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:16:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:03 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 0x15821f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15bfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1820310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181d400>, '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 0x181e3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x181e840>, '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': '6dbc10da6d83fee962c624be000001a8-1490814917.370061-630035441', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:16:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 12:16:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:16:03 INFO - Using env: {'DISPLAY': ':0', 12:16:03 INFO - 'HOME': '/home/cltbld', 12:16:03 INFO - 'LANG': 'en_US.UTF-8', 12:16:03 INFO - 'LANGUAGE': 'en_US:en', 12:16:03 INFO - 'LOGNAME': 'cltbld', 12:16:03 INFO - 'MAIL': '/var/mail/cltbld', 12:16:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:16:03 INFO - 'MOZ_NO_REMOTE': '1', 12:16:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:16:03 INFO - 'NO_EM_RESTART': '1', 12:16:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:16:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:16:03 INFO - 'PWD': '/builds/slave/test', 12:16:03 INFO - 'SHELL': '/bin/bash', 12:16:03 INFO - 'SHLVL': '1', 12:16:03 INFO - 'TERM': 'linux', 12:16:03 INFO - 'TMOUT': '86400', 12:16:03 INFO - 'USER': 'cltbld', 12:16:03 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1490814917.370061-630035441', 12:16:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:16:03 INFO - '_': '/tools/buildbot/bin/python'} 12:16:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:16:03 INFO - Running setup.py (path:/tmp/pip-BQfX1g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:16:03 INFO - Running setup.py (path:/tmp/pip-sHOdDg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:16:03 INFO - Running setup.py (path:/tmp/pip-Y13zhc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:16:03 INFO - Running setup.py (path:/tmp/pip-Djirtv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:16:03 INFO - Running setup.py (path:/tmp/pip-K0_yiC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:16:03 INFO - Running setup.py (path:/tmp/pip-7rnH7P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:16:03 INFO - Running setup.py (path:/tmp/pip-YRFtrA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:16:03 INFO - Running setup.py (path:/tmp/pip-1WEPDR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:16:04 INFO - Running setup.py (path:/tmp/pip-idRsgX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:16:04 INFO - Running setup.py (path:/tmp/pip-vRfRzq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:16:04 INFO - Running setup.py (path:/tmp/pip-cqLkRM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:16:04 INFO - Running setup.py (path:/tmp/pip-3tZqXF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:16:04 INFO - Running setup.py (path:/tmp/pip-DlRmos-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:16:04 INFO - Running setup.py (path:/tmp/pip-LqCaRa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:16:04 INFO - Running setup.py (path:/tmp/pip-CrMj6T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:16:04 INFO - Running setup.py (path:/tmp/pip-kWrM8W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:16:04 INFO - Running setup.py (path:/tmp/pip-0VejTC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:16:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:16:04 INFO - Running setup.py install for manifestparser 12:16:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:16:04 INFO - Running setup.py install for mozcrash 12:16:04 INFO - Running setup.py install for mozdebug 12:16:04 INFO - Running setup.py install for mozdevice 12:16:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:16:05 INFO - Running setup.py install for mozfile 12:16:05 INFO - Running setup.py install for mozhttpd 12:16:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:16:05 INFO - Running setup.py install for mozinfo 12:16:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:16:05 INFO - Running setup.py install for mozInstall 12:16:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:16:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:16:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:16:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:16:05 INFO - Running setup.py install for mozleak 12:16:05 INFO - Running setup.py install for mozlog 12:16:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:16:05 INFO - Running setup.py install for moznetwork 12:16:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:16:05 INFO - Running setup.py install for mozprocess 12:16:05 INFO - Running setup.py install for mozprofile 12:16:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:16:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:16:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:16:06 INFO - Running setup.py install for mozrunner 12:16:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:16:06 INFO - Running setup.py install for mozscreenshot 12:16:06 INFO - Running setup.py install for moztest 12:16:06 INFO - Running setup.py install for mozversion 12:16:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:16:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:16:06 INFO - Cleaning up... 12:16:06 INFO - Return code: 0 12:16:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:16:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:16:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:16:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:16:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:16:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:06 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 0x15821f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15bfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1820310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181d400>, '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 0x181e3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x181e840>, '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': '6dbc10da6d83fee962c624be000001a8-1490814917.370061-630035441', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:16:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 12:16:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:16:06 INFO - Using env: {'DISPLAY': ':0', 12:16:06 INFO - 'HOME': '/home/cltbld', 12:16:06 INFO - 'LANG': 'en_US.UTF-8', 12:16:06 INFO - 'LANGUAGE': 'en_US:en', 12:16:06 INFO - 'LOGNAME': 'cltbld', 12:16:06 INFO - 'MAIL': '/var/mail/cltbld', 12:16:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:16:06 INFO - 'MOZ_NO_REMOTE': '1', 12:16:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:16:06 INFO - 'NO_EM_RESTART': '1', 12:16:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:16:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:16:06 INFO - 'PWD': '/builds/slave/test', 12:16:06 INFO - 'SHELL': '/bin/bash', 12:16:06 INFO - 'SHLVL': '1', 12:16:06 INFO - 'TERM': 'linux', 12:16:06 INFO - 'TMOUT': '86400', 12:16:06 INFO - 'USER': 'cltbld', 12:16:06 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1490814917.370061-630035441', 12:16:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:16:06 INFO - '_': '/tools/buildbot/bin/python'} 12:16:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:16:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:16:06 INFO - Running setup.py (path:/tmp/pip-ScMZQM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:16:06 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 12:16:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:16:06 INFO - Running setup.py (path:/tmp/pip-DziIp8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:16:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:16:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:16:06 INFO - Running setup.py (path:/tmp/pip-Lr42vw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:16:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 12:16:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:16:06 INFO - Running setup.py (path:/tmp/pip-q2t0W4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:16:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:16:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:16:06 INFO - Running setup.py (path:/tmp/pip-PSAaiu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:16:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 12:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:16:07 INFO - Running setup.py (path:/tmp/pip-Kd2VwZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:16:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 12:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:16:07 INFO - Running setup.py (path:/tmp/pip-OTxWo4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:16:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 12:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:16:07 INFO - Running setup.py (path:/tmp/pip-cNIDUA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:16:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 12:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:16:07 INFO - Running setup.py (path:/tmp/pip-tSZg0f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:16:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 12:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:16:07 INFO - Running setup.py (path:/tmp/pip-CZ43BR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:16:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:16:07 INFO - Running setup.py (path:/tmp/pip-_4TcTn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:16:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 12:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:16:07 INFO - Running setup.py (path:/tmp/pip-VyGeRS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:16:07 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)) 12:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:16:07 INFO - Running setup.py (path:/tmp/pip-X3WqVk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:16:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 12:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:16:07 INFO - Running setup.py (path:/tmp/pip-KfsQTv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:16:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 12:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:16:07 INFO - Running setup.py (path:/tmp/pip-nwn3Vg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:16:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 12:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:16:07 INFO - Running setup.py (path:/tmp/pip-mpqe8w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:16:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 12:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:16:07 INFO - Running setup.py (path:/tmp/pip-v22lAV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:16:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 12:16:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:16:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:16:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 12:16:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:16:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:16:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:16:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:16:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:16:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:16:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:16:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:16:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:16:09 INFO - Downloading blessings-1.6.tar.gz 12:16:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:16:09 INFO - Installing collected packages: blessings 12:16:09 INFO - Running setup.py install for blessings 12:16:10 INFO - Successfully installed blessings 12:16:10 INFO - Cleaning up... 12:16:10 INFO - Return code: 0 12:16:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:16:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:16:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:16:10 INFO - Reading from file tmpfile_stdout 12:16:10 INFO - Current package versions: 12:16:10 INFO - argparse == 1.2.1 12:16:10 INFO - blessings == 1.6 12:16:10 INFO - blobuploader == 1.2.4 12:16:10 INFO - docopt == 0.6.1 12:16:10 INFO - functools32 == 3.2.3-2 12:16:10 INFO - jsonschema == 2.5.1 12:16:10 INFO - manifestparser == 1.1 12:16:10 INFO - mozInstall == 1.12 12:16:10 INFO - mozcrash == 1.0 12:16:10 INFO - mozdebug == 0.1 12:16:10 INFO - mozdevice == 0.49 12:16:10 INFO - mozfile == 1.2 12:16:10 INFO - mozhttpd == 0.7 12:16:10 INFO - mozinfo == 0.9 12:16:10 INFO - mozleak == 0.1 12:16:10 INFO - mozlog == 3.4 12:16:10 INFO - moznetwork == 0.27 12:16:10 INFO - mozprocess == 0.25 12:16:10 INFO - mozprofile == 0.28 12:16:10 INFO - mozrunner == 6.13 12:16:10 INFO - mozscreenshot == 0.1 12:16:10 INFO - mozsystemmonitor == 0.3 12:16:10 INFO - moztest == 0.8 12:16:10 INFO - mozversion == 1.4 12:16:10 INFO - psutil == 3.1.1 12:16:10 INFO - requests == 1.2.3 12:16:10 INFO - wsgiref == 0.1.2 12:16:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:16:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:16:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:16:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:16:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:16:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:10 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 0x15821f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15bfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1820310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181d400>, '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 0x181e3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x181e840>, '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': '6dbc10da6d83fee962c624be000001a8-1490814917.370061-630035441', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:16:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 12:16:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:16:10 INFO - Using env: {'DISPLAY': ':0', 12:16:10 INFO - 'HOME': '/home/cltbld', 12:16:10 INFO - 'LANG': 'en_US.UTF-8', 12:16:10 INFO - 'LANGUAGE': 'en_US:en', 12:16:10 INFO - 'LOGNAME': 'cltbld', 12:16:10 INFO - 'MAIL': '/var/mail/cltbld', 12:16:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:16:10 INFO - 'MOZ_NO_REMOTE': '1', 12:16:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:16:10 INFO - 'NO_EM_RESTART': '1', 12:16:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:16:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:16:10 INFO - 'PWD': '/builds/slave/test', 12:16:10 INFO - 'SHELL': '/bin/bash', 12:16:10 INFO - 'SHLVL': '1', 12:16:10 INFO - 'TERM': 'linux', 12:16:10 INFO - 'TMOUT': '86400', 12:16:10 INFO - 'USER': 'cltbld', 12:16:10 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1490814917.370061-630035441', 12:16:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:16:10 INFO - '_': '/tools/buildbot/bin/python'} 12:16:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:16:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:16:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 12:16:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 12:16:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 12:16:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 12:16:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 12:16:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 12:16:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 12:16:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 12:16:10 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:16:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 12:16:10 INFO - Cleaning up... 12:16:10 INFO - Return code: 0 12:16:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:16:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:16:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:16:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:16:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:16:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:10 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 0x15821f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15bfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1820310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181d400>, '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 0x181e3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x181e840>, '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': '6dbc10da6d83fee962c624be000001a8-1490814917.370061-630035441', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:16:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 12:16:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 12:16:10 INFO - Using env: {'DISPLAY': ':0', 12:16:10 INFO - 'HOME': '/home/cltbld', 12:16:10 INFO - 'LANG': 'en_US.UTF-8', 12:16:10 INFO - 'LANGUAGE': 'en_US:en', 12:16:10 INFO - 'LOGNAME': 'cltbld', 12:16:10 INFO - 'MAIL': '/var/mail/cltbld', 12:16:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:16:10 INFO - 'MOZ_NO_REMOTE': '1', 12:16:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:16:10 INFO - 'NO_EM_RESTART': '1', 12:16:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:16:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:16:10 INFO - 'PWD': '/builds/slave/test', 12:16:10 INFO - 'SHELL': '/bin/bash', 12:16:10 INFO - 'SHLVL': '1', 12:16:10 INFO - 'TERM': 'linux', 12:16:10 INFO - 'TMOUT': '86400', 12:16:10 INFO - 'USER': 'cltbld', 12:16:10 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1490814917.370061-630035441', 12:16:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:16:10 INFO - '_': '/tools/buildbot/bin/python'} 12:16:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:16:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:16:10 INFO - Cleaning up... 12:16:10 INFO - Return code: 0 12:16:10 INFO - Running post-action listener: _resource_record_post_action 12:16:10 INFO - Running post-action listener: _start_resource_monitoring 12:16:10 INFO - Starting resource monitoring. 12:16:10 INFO - [mozharness: 2017-03-29 19:16:10.852714Z] Finished create-virtualenv step (success) 12:16:10 INFO - [mozharness: 2017-03-29 19:16:10.853231Z] Running install step. 12:16:10 INFO - Running pre-action listener: _resource_record_pre_action 12:16:10 INFO - Running main action method: install 12:16:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:16:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:16:11 INFO - Reading from file tmpfile_stdout 12:16:11 INFO - Detecting whether we're running mozinstall >=1.0... 12:16:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:16:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:16:11 INFO - Reading from file tmpfile_stdout 12:16:11 INFO - Output received: 12:16:11 INFO - Usage: mozinstall [options] installer 12:16:11 INFO - Options: 12:16:11 INFO - -h, --help show this help message and exit 12:16:11 INFO - -d DEST, --destination=DEST 12:16:11 INFO - Directory to install application into. [default: 12:16:11 INFO - "/builds/slave/test"] 12:16:11 INFO - --app=APP Application being installed. [default: firefox] 12:16:11 INFO - mkdir: /builds/slave/test/build/application 12:16:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 12:16:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 12:16:28 INFO - Reading from file tmpfile_stdout 12:16:28 INFO - Output received: 12:16:28 INFO - /builds/slave/test/build/application/firefox/firefox 12:16:28 INFO - Running post-action listener: _resource_record_post_action 12:16:28 INFO - [mozharness: 2017-03-29 19:16:28.040386Z] Finished install step (success) 12:16:28 INFO - [mozharness: 2017-03-29 19:16:28.040664Z] Running run-tests step. 12:16:28 INFO - Running pre-action listener: _resource_record_pre_action 12:16:28 INFO - Running main action method: run_tests 12:16:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:16:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:16:28 INFO - Python 2.7.3 12:16:28 INFO - Return code: 0 12:16:28 INFO - grabbing minidump binary from tooltool 12:16:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:16:28 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 0x181d400>, '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 0x181e3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x181e840>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:16:28 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 12:16:28 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 12:16:28 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 12:16:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:16:28 INFO - Return code: 0 12:16:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:16:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:16:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:16:28 INFO - ENV: RUST_BACKTRACE is now 1 12:16:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:16:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:16:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XzVzjrAsQiiK3FdmaqdoHQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 12:16:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XzVzjrAsQiiK3FdmaqdoHQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-050 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 12:16:28 INFO - Using env: {'DISPLAY': ':0', 12:16:28 INFO - 'HOME': '/home/cltbld', 12:16:28 INFO - 'LANG': 'en_US.UTF-8', 12:16:28 INFO - 'LANGUAGE': 'en_US:en', 12:16:28 INFO - 'LOGNAME': 'cltbld', 12:16:28 INFO - 'MAIL': '/var/mail/cltbld', 12:16:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:16:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:16:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:16:28 INFO - 'MOZ_NO_REMOTE': '1', 12:16:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:16:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:16:28 INFO - 'NO_EM_RESTART': '1', 12:16:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:16:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:16:28 INFO - 'PWD': '/builds/slave/test', 12:16:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:16:28 INFO - 'RUST_BACKTRACE': '1', 12:16:28 INFO - 'SHELL': '/bin/bash', 12:16:28 INFO - 'SHLVL': '1', 12:16:28 INFO - 'TERM': 'linux', 12:16:28 INFO - 'TMOUT': '86400', 12:16:28 INFO - 'USER': 'cltbld', 12:16:28 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1490814917.370061-630035441', 12:16:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:16:28 INFO - '_': '/tools/buildbot/bin/python'} 12:16:28 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XzVzjrAsQiiK3FdmaqdoHQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 12:16:28 INFO - mozversion application_buildid: 20170329182208 12:16:28 INFO - mozversion application_changeset: 4c7c05a49f3ce40aa0969beccb397380a8907f4a 12:16:28 INFO - mozversion application_display_name: Nightly 12:16:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:16:28 INFO - mozversion application_name: Firefox 12:16:28 INFO - mozversion application_remotingname: firefox 12:16:28 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 12:16:28 INFO - mozversion application_vendor: Mozilla 12:16:28 INFO - mozversion application_version: 55.0a1 12:16:28 INFO - mozversion platform_buildid: 20170329182208 12:16:28 INFO - mozversion platform_changeset: 4c7c05a49f3ce40aa0969beccb397380a8907f4a 12:16:28 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 12:16:28 INFO - mozversion platform_version: 55.0a1 12:16:28 INFO - using testdate: 1490814988 12:16:28 INFO - actual date: 1490814988 12:16:28 INFO - starting webserver on 'localhost:47296' 12:16:28 INFO - SUITE-START | Running 2 tests 12:16:28 INFO - TEST-START | dromaeo_css 12:16:28 INFO - operating with platform_type : linux_ 12:16:28 INFO - Initialising browser for dromaeo_css test... 12:16:28 INFO - TEST-INFO | started process 6914 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_bZLdQ/profile http://localhost:47296/getInfo.html) 12:16:31 INFO - PID 6914 | __metrics Screen width/height:1600/1200 12:16:31 INFO - PID 6914 | colorDepth:24 12:16:31 INFO - PID 6914 | Browser inner width/height: 1024/697 12:16:31 INFO - PID 6914 | __metrics 12:16:32 ERROR - PID 6914 | 1490814992956 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: TypeError: log is null (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:96:5) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:96:5 < callBootstrapMethod@XPIProvider.jsm:4957:11 < observe@XPIProvider.jsm:2924:15 < canQuitApplication@quit.js:67:3 < goQuitApplication@quit.js:109:8 < whenDone@quit.js:100:7 < promise callback*goQuitApplication@quit.js:103:5 < onload@getInfo.html:7:5 12:16:33 INFO - PID 6914 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 12:16:33 INFO - PID 6914 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:16:34 INFO - TEST-INFO | 6914: exit 0 12:16:34 INFO - Browser initialized. 12:16:34 INFO - Running cycle 1/1 for dromaeo_css test... 12:16:34 INFO - TEST-INFO | started process 7007 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_bZLdQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:16:46 INFO - PID 7007 | RSS: Main: 144502784 12:16:46 INFO - PID 7007 | 12:19:48 INFO - PID 7007 | Cycle 1(1): loaded http://localhost:47296/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47296/tests/dromaeo/cssquery-ext.html) 12:19:50 INFO - PID 7007 | RSS: Main: 278528000 12:19:50 INFO - PID 7007 | 12:21:35 INFO - PID 7007 | ************************* 12:21:35 INFO - PID 7007 | A coding exception was thrown and uncaught in a Task. 12:21:35 INFO - PID 7007 | 12:21:35 ERROR - PID 7007 | Full message: TypeError: NetworkError when attempting to fetch resource. 12:21:35 INFO - PID 7007 | Full stack: 12:21:35 INFO - PID 7007 | ************************* 12:21:35 INFO - PID 7007 | ************************* 12:21:35 INFO - PID 7007 | A coding exception was thrown and uncaught in a Task. 12:21:35 INFO - PID 7007 | 12:21:35 ERROR - PID 7007 | Full message: TypeError: NetworkError when attempting to fetch resource. 12:21:35 INFO - PID 7007 | Full stack: 12:21:35 INFO - PID 7007 | ************************* 12:21:35 INFO - PID 7007 | ************************* 12:21:35 INFO - PID 7007 | A coding exception was thrown and uncaught in a Task. 12:21:35 INFO - PID 7007 | 12:21:35 ERROR - PID 7007 | Full message: TypeError: NetworkError when attempting to fetch resource. 12:21:35 INFO - PID 7007 | Full stack: 12:21:35 INFO - PID 7007 | ************************* 12:21:35 INFO - PID 7007 | ************************* 12:21:35 INFO - PID 7007 | A coding exception was thrown and uncaught in a Task. 12:21:35 INFO - PID 7007 | 12:21:35 ERROR - PID 7007 | Full message: TypeError: NetworkError when attempting to fetch resource. 12:21:35 INFO - PID 7007 | Full stack: 12:21:35 INFO - PID 7007 | ************************* 12:22:52 INFO - PID 7007 | Cycle 1(1): loaded http://localhost:47296/tests/dromaeo/cssquery-ext.html (next: http://localhost:47296/tests/dromaeo/cssquery-jquery.html) 12:22:53 INFO - PID 7007 | RSS: Main: 237047808 12:22:53 INFO - PID 7007 | 12:25:55 INFO - PID 7007 | Cycle 1(1): loaded http://localhost:47296/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47296/tests/dromaeo/cssquery-mootools.html) 12:25:55 INFO - PID 7007 | RSS: Main: 175546368 12:25:55 INFO - PID 7007 | 12:28:57 INFO - PID 7007 | Cycle 1(1): loaded http://localhost:47296/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47296/tests/dromaeo/cssquery-prototype.html) 12:28:58 INFO - PID 7007 | RSS: Main: 177364992 12:28:58 INFO - PID 7007 | 12:32:01 INFO - PID 7007 | Cycle 1(1): loaded http://localhost:47296/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47296/tests/dromaeo/cssquery-yui.html) 12:32:01 INFO - PID 7007 | RSS: Main: 181198848 12:32:01 INFO - PID 7007 | 12:35:04 INFO - PID 7007 | Cycle 1(1): loaded http://localhost:47296/tests/dromaeo/cssquery-yui.html (next: http://localhost:47296/tests/dromaeo/cssquery-dojo.html) 12:35:04 INFO - PID 7007 | RSS: Main: 277520384 12:35:04 INFO - PID 7007 | 12:35:04 INFO - PID 7007 | __start_tp_report 12:35:04 INFO - PID 7007 | _x_x_mozilla_page_load 12:35:04 INFO - PID 7007 | _x_x_mozilla_page_load_details 12:35:04 INFO - PID 7007 | |i|pagename|runs| 12:35:04 INFO - PID 7007 | |0;dojo.html;3299.868005279789;3300.455424854899;3319.850606722697;3331.483620038894;3364.5289659447667;5763.740631671574;5868.3838196989345;5868.61853979491;5880.9411905880925;5935.940640593598;5936.88126237475;5946.702664866761;5969.253843269591;6054.182685337478;6061.181740465036;5117.309163262949;5209.1404918188455;5212.087884620195;5263.421023687391;5351.09031464652;5271.130263506536;5280.656757310781;5343.17180836969;5343.171808369709;5350.973245133769;5192.688438693691;5248.81629142982;5261.842144735664;5267.815626453094;5273.34083239595;5139.357580302462;5154.639175257734;5156.561692256163;5159.793608255665;5190.688558686453;5076.720780357079;5116.744162791882;5133.948660513384;5135.537801597874;5142.254373115878;5620.803271885465;5642.125470552071;5661.46216109469;5664.6601203927485;5682.403347648478;6125;6129.448349648553;6132.601380910227;6139.447449729546;6143.201383820075;6111.053100029335;6125;6131.174202174114;6163.322034576193;6265.968670156665;5977.402259774031;5978.491828194608;5981.252343457068;6002.519798416116;6032.245969253843;6549.705263263165;6579;6599.274079851212;6606.2072551293195;6611.702473388613;6107.196453950035;6126.908096378558;6127.281156068166;6324.683765811691;6330.335314791881;6240.063990401385;6270.31026587075;6323.715432805535;6324.43080122782;6330.113784070234;6366.586171898812;6391.904121438182;6393.808185754435;6408.391202835816;6421.8715625688155;6214.533909956681;6316.9368306317265;6397.712102955378;6412.422881940648;6415.807525774234;4856.95143048572;4888.780004899717;4911.705297682151;4913.754312284372;4915.705057696549;4271.466066741657;4285.357196420562;4294.441722576045;4304.569543045671;4324.71889327199;6002.939970600325;6026.819195424145;6027.517798576104;6027.939720602738;6032.065029920369;6170.444659980623;6320.27316858558;6395.040743888454;6427.260865000491;6465.4827613790785;5970.701464926737;6020.819375418744;6023.915695174911;6024.0662697282;6075.754470333571;5436.10304299794;5442.700651464207;5445.754941027663;5447.210154527571;5453.045716999509;6406.743730250738;6564.8358791030605;6577.408033277028;6677.799666010027;6688.565243259075;6427.55007149495;6429.260635026844;6448.161738973903;6460.3862633049785;6471.2234531856475;6659.866802663822;6661.933380666132;6667.099941507834;6669.399754022162;6670.366315200048;6155.415235552616;6226.937730622817;6264.874702506016;6318.336574659778;6327.588706734047;6359.427651511386;6384.138141350858;6440.710168042356;6450.258220304725;6454.451371633464;6165.414285642857;6169.167162433194;6169.259688837189;6169.81490555284;6184.381561843779;6098.939010609837;6110.175126357884;6155.9842625968;6194.318624951342;6200.782972595937;6229.595076320024;6232.657203853651;6261.436470717657;6264.5301602379095;6266.37336266388;6254;6270.15352927349;6318;6321.873562528632;6328.303886572566;5950.523958083257;5957;6152.200213972155;6154.907676384947;6156.107364432043 12:35:04 INFO - PID 7007 | |1;ext.html;722.3426681719636;783.9882401763973;808.5108509351842;1101.9449027548626;1138.1918837625285;31246.53130203046;38763.80618096909;39489.4076588851;39530;39697.206055878865;41661;42071;42078.78960605193;42130;42240.366394504104;7981.361491080728;8143.552104634243;8145.877811832827;8145.959270203641;8150.103488616248;6102.938970610304;6321.178246827906;8068.636911338975;8280.461769984931;8283.17168283173;8301.252887240147;8413.28487078599;8414.326853851677;8414.915850841506;8416.705415310465;8179.959100204521;8348.081711011784;8350.415470917038;8352.582370881431;8356.749297521053;8165.265126138676;8242.629081691339;8248.793780155484;8257.587120643944;8259.21537453941;39211.8039409804;39446.21107577832;39448.802755986035;39569.80215098906;39576.208475830324;2948.778841586868;2980.2251414632133;2985.059706192564;2993.9550906736417;3023.546468029791;27764.722352776414;27854.3036424091;28257.858710706314;28646;28804.855975719987;3630.2013557017676;3639.7998110103936;3681.11653203232;3745.8501659933568;3751.606081361445;182933;183677;184321;184860;184897.99999999866;48108;48141.5185848144;48160.27759583609;48185;48272.27591586129;48910.266346004835;49102.50897491051;49158.508414916105;49244.50755492399;49251;15116.168610726516;15195.088294702133;15216.619584510476;15228.314725837365;15255.160966146746;10680.412577308323;12204.816927746091;12210.816837747441;12289.815652765215;12293.323867187391;12727.10910236293;13772.793408098887;14226.217558034201;14361.281935903164;14379.281035948161;5635.3237611486065;5709.8287051388525;5828.825135245949;5851.824445266649;5883.382244864228;1032.3031953431405;1044.738815296176;1051.709027169148;1060.125396547851;1083.225493771941;26024.86987565088;26112.73887261141;26168.476630467285;26188.60717089207;26256.73743262581;1104.5692180049787;1127.2954403497813;1133.557912414159;1141.7545227776068;1168.9649310520697;13390.330483475787;13691.657708557366;13723.313834308245;13739.450421983209;13853.099548529313;325158;325322;328285;328633;329162;54449.72775136099;54690;54718.45281547133;54796.45203547993;54802.45197548053;1447.8190226221511;1473.7641977283583;1477.253986736691;1491.1062950053372;1494.2006026775841;23878.522429550965;24951.500969980134;25129;25181.748182517942;25229.369265767768;40301.1939761209;40397.59602403938;40428.59571404366;40584.39123413092;40587.797061014506;305662.1319614218;305677;306432;307750;309235;33781.83109084439;34035.82982085173;34055.659443405246;34557.82721086378;36020;35308.64691353054;36506.45240321344;39352;43011.78494107509;43428.13143737171;31988;32509.837450812596;32645.836770815993;32714.34571308608;32824.83587582047;32125.518117228727;32276.35447291088;32621.510677340335;32648.34703305968;32896.578422322375;36795.26409471742;37484.625153749206;37497;37578.812105939294;37666.2466750658;30939.226519337197;31617.683823162395;31648.5252721214;31821.363572727954;32653.836730816194;24217.878910605334;25340.366490837878;25420.49159016846;25450.618240726035;25530.04372267333 12:35:04 INFO - PID 7007 | |2;jquery.html;384.33318192935235;385.201511022422;389.7641926634386;392.6740805131741;412.6368795459995;13354.465821367157;20356.796432035677;21081.68377474337;21089.68365474517;21838.454038649;15858.895248685682;18542.629147417043;20989.685154722654;21078.473038174052;21295.787042129574;5921.674307913063;6157.2919114301985;6161.815145545641;6161.907571386433;6168.352323006087;5892.616979896315;5981.551383646222;6018.127371531147;6095.29904061032;6106.816795496142;6053.576249662503;6064.393560643923;6066.787662431816;6067.332593414721;6070.453659170674;5776.566757493205;5847.210626565402;5877.9118313225335;5897.174395584579;6043.305019922721;5191.844244672666;5204.661696989721;5216.765245563959;5221.477852214786;5225.294585231021;24438.633420498707;24608.753912460827;25003.499930001297;25064.24807255767;25280.87359563209;2028.9391318260475;2043.8057345329032;2051.066764622093;2096.0462989339967;2105.3999610111046;15907.522774316789;15916.124613146272;16385.344586216655;16498.75251871223;16643.583910402216;1728.5160155156577;1766.611345503987;1775.9289628414977;1792.4981005318532;1795.4344381519911;95298.52350738202;96301;97685;97994.99999999929;98248.50875745647;11190.888091118984;11328.150388720878;11333;11383.487743051583;11558.133140014532;15304.311305991258;15317.080975141527;15330.846691533165;15333.236677782197;15345;7288.526245794006;7620.69517219305;8242.835143297101;8603.784905377415;8972.19250267466;8101.392395570356;8168.387370947203;8386.287165590993;8829.072947340437;8848.070952550019;7417.701902167099;7725.575093369918;7728.613569321511;7779.4554381192775;7810.23575618872;1918.7313776071362;1927.4892153579312;1934.6130773845007;1996.1316827180224;1998.9000549972443;1028.9639862604772;1042.8327636560823;1062.7661914378825;1069.641670040545;1076.2036093290908;20899.582008359746;20912.895435522725;21073.89463052675;21083.578328433345;21140;1048.8059708953867;1073.130764081097;1074.6352132791312;1092.7104317355906;1109.1847492093304;10536.892621475736;11260.549578016788;11358.659240222807;11449.053660877671;11499.482523286471;556625;556696;570310;588926;594995;108368.45815770871;109462;112663.86025257767;113785.4310728441;114572.42713786544;1168.2231316174818;1185.454690842205;1223.6451429085466;1228.3796682675193;1229.7540491901655;17344.566385840455;17374.305027798746;19881.01784732244;21321.573568528853;21570.568588628452;50686;50696.74651626718;51296;52153.217701735266;52795.736021319644;62326;62375.376246236956;62902.370976289654;63405.365946339945;64124.67937660282;9014.639414423613;9049.954750226207;9086.045965173562;9095.909040909506;9442.622295108118;15320.923395382952;15331.080135191924;15403.537893863202;15852.20738963024;15952.760708589149;13235.66910827237;13488.865111348761;13504.122232054886;13520.25638589887;13907.721845563234;11637.825432618349;11748.88251117478;12290.81563776562;12498;12902.354882256037;13008.609741707764;13558.661033474242;13868.810173659913;13882.930585347009;13932;8694.956525217334;8805.867911981453;8997.460152390615;9077.137671921157;9135.680251191176;12650.493980240688;12834.614961551168;13538.120022198525;13989;14142.646433839236 12:35:04 INFO - PID 7007 | |3;mootools.html;1270.447355400401;1341.7316536692663;1345.542515544715;1363.134409649872;1366.4056135581018;10203.08172264496;10567.735806604838;10602.098821600173;10604.57581696732;10609.15126789857;10426.739331516697;10586.947065264663;10811.189160812932;10845.674629761119;10940.671779846618;2307.3539408965476;2336.9766302337016;2349.6827928229727;2350.0717216699395;2351.4826738117586;1896.1941175000638;2184.5194057307367;2295.4031951692596;2298.310506847947;2307.515421761432;1925.894075825829;2228.6211344071467;2292.266474728079;2294.208498068172;2302.3323236261463;2220.5225876436643;2273.545290941818;2277.3737222263926;2283.1095872609612;2297.1959814065112;2225.2879078694823;2227.0535022615486;2227.532218234173;2227.5878962392007;2228.8774117423536;9942.254330925138;9968.800623987552;9986.850197247048;9998.500074996222;10023.148032417253;5670;6008.24896887889;6011.458968692838;6015.127806468081;6032.45707886288;3500.334936362083;3639.836207370648;3646.8541258349633;3747.475353450519;3749.193923306475;1155.2837240910605;1174.7180676637631;1183.2663748476;1190.708276472261;1724.8275172482777;14319.713605727931;14439;14473.565793026226;14495.927520362331;14501.41994320226;4690.085433340466;4956.306117143603;4986.102501549756;5095.515925987025;5103.3110530077965;11854.94072529632;11889.524419023315;11910.404479775976;11960.641180764416;11977.041836653047;5964.642121472725;5966.105084237312;5972.193753843262;5975.970120149372;5976.491998180203;5447.972760136253;5561.527270181999;5608.1027035674915;5611.6352437091455;5614.663120212718;3788.753731007476;3854.768713877176;3856.652901238902;3873.9806300968316;3995.440638310639;925.167349385545;1055.762453447968;1066.5893630951985;1077.4181941751524;1080.8865069167625;632.4750457120671;785.8192615698422;800.9427555626517;820.5240960243045;827.1893544326593;5554.277943867352;5698.943010569841;5766.135079738073;5839.073105875051;5990.341062483123;895.3285036222833;909.377076702461;914.3873604684877;917.8347897378536;929.6885543343055;3736.4955730976512;3742.401215805458;3749.268892565978;3755.080005398695;3758.755680880734;12917.418716157796;13371.732565348639;13376.531821386205;13381.330933453288;13382.732345353039;13190.406431710597;13255;13278.800817987738;13282.667933301746;13380.264085475392;9485.241180705527;9891.950540247253;9900.752481187883;9902.504874756234;9908.653197138066;6238.15784869055;6281.654509001866;6360.268569114611;6443.162388889415;6589.604623722592;12710.936445317715;12948.676283092622;13010.154339967872;13031.152975056591;13034.543790967271;12638.178518396275;12738.363081845686;12795.488180472677;12913.935430322788;13088.149270297401;8979.55102244872;9268.397554158959;9281.350305478552;9283.907160928304;9284.21084207823;9898.006720257064;10028.147607453448;10034.949825250827;10038.347507411994;10119.7470063249;7961.363090952826;8411.495310281403;8561.44350617208;8600.741977740678;8816.118388161132;7848.686052557834;8054.4361894669155;8084.514929104273;8088.797780055545;8171.42800003994;7141.714331426685;7238.420926325986;7254.165770936199;7269.345758881726;7826.608669566613;5718.971405142947;5815.738291776965;5819;5828.708564571839;5882.441168089024;5904.143899134516;5987;5999.70001499932;6210.223722034746;6271 12:35:04 INFO - PID 7007 | |4;prototype.html;381.47547122706277;383.8042598274879;386.36057325126905;387.40726688167103;388.1673809678242;5908.527317814575;5943.3462319144855;5945.167676525284;5992.550558708103;6008.828278485692;5634.3520495143075;5783.479486846183;5800.82597522074;5874.118882167677;5886.852828679285;4521.299198624219;4545.295479200713;4552.52198519154;4565.680402371843;4566.70316429431;4575.473820510634;4583.8166473341025;4590.839320623779;4594.793234304448;4601.907961840761;4240.342746874224;4404.8017839197155;4459.219636563605;4555.61277291429;4559.635229181657;4389.670774691911;4417.160739459492;4417.690761646686;4429.6899217054815;4432.867013989586;3855.8072096395067;3862.439946207812;3864.806759662006;3887.7278590498677;3890.9688932432928;5652.660840349592;5790.3630600634315;5795.768169273224;5796.739146738407;5816.767329306865;5190.792368305263;5207.140821764404;5207.869803254911;5214.869628259324;5226.268322434862;6227.657478838662;6244;6244.3755624437645;6268.968655156695;6273.8745225095245;4135.1316223592785;4292.055747735493;4327.480702315711;4336.783160841946;4337.63130133939;6208;6352.809415717536;6493.0392460599;6533.7713180038945;6559.901601475982;4273.166732487197;4281.785910704452;4288.820574342081;4301.526832048472;4333.804978775899;4469.262571675702;4469.754163520973;4475.552444755498;4476.6418686505;4486.237339652267;4805.5972013993005;4872.317875497433;5166.095933211673;5166.147585648326;5176.352955880515;6189.319174890758;6191.133241346215;6236.345183755731;6236.469900058546;6260.311365749764;1527.1753253243123;1537.9077255364714;1537.9769303460457;1539.2303848075962;1549.883758718078;959.712086374085;1016.3800081950004;1016.4561959351711;1020.6172685243034;1040.15747244732;5942.762289508458;5949;5985.401459854067;6006.708557660124;6016.458518733335;6379.776707815204;6394.424501794768;6400.23197216337;6405.839854003594;6419.358064193637;5807.303123625107;5940;5973.163757074013;5981.7607295707685;6003.909941350883;3370.0395387314497;3380.9323813524084;3392.2028323343993;3392.3045775615938;3411.7441191910707;6499.707513161919;6621.867562648817;6625.602463852184;6644.335566443317;6678.799636010927;6542.24764152119;6549.639769812706;6573;6592.80221593353;6599.208095028627;6398.6160830351255;6623.138991931114;6636.270010298863;6641.468682505291;6666.699998500079;6439.356064393711;6439.517036222396;6472.773452929125;6473.48212143018;6494.220693516808;6215.197592698067;6387.68061596909;6394.648294343856;6398.392152745481;6418.133551970424;6375.203099612549;6463.870722585616;6533.5952770154645;6681.498887583353;6741.325867413219;4293.377460268306;4309.806058727428;4311.935320970125;4314.374415709767;4321.719088259253;6362.791069696928;6519.217693876765;6519.380658837403;6522.5760325578685;6525.347465253437;6273.9372606273355;6284.560080794484;6286.905696414649;6307.936920630918;6319.46284565817;6316.494680425647;6326;6328.114064030948;6332.525060620564;6342.143810585697;6087;6259.186305780219;6262.561620686508;6280.497560195082;6309.4952403806665;6325.652089135142;6327.493800495858;6329.651869147241;6333.714982825876;6337.334579869047;5914.556408269483;6091.903457377714;6097.664628445478;6140.723667434887;6161.168242287413 12:35:04 INFO - PID 7007 | |5;yui.html;758.3175142371865;771.6373304546863;771.8070482379405;779.5829231361223;805.3557154276581;14967.401303947843;15394.076355418669;15531.84468155318;17855;18934.43196704101;17050.317987280527;17142.82857171428;17224.655506889856;17515.91242043788;17549;927.0451435021904;945.8723072385243;949.0841338108723;949.1505102932871;949.3402085550545;924.9306302027342;935.3172184305461;949.5537097564134;958.5782255807458;959.1415682963743;1001.4992503748126;1004.964826231082;1006.104566935428;1006.2553710254396;1007.2294694558668;993.4536005197149;996.7358649957768;997.5211898288862;997.8453339732353;999.0708640963901;725.8983742276085;730.2551397574445;730.6383340246559;731.6122455098806;732.143392231091;15949;16115.516534503984;16297.83702162975;16374.672506549921;16480.83519164805;16118.194090295437;16238.512844614681;16339.18304084791;16387.59031024222;16705.081220532866;12441.688957776038;12654.177478463871;12796.808047879289;12971.286579238138;13072.607821765363;3112.3152906360565;3155.8106513609255;3169.524571314298;3264.5592844965863;3274.787138835968;73565;74990.62504687441;75716;84130;85625;12335.75328493443;12676.239425634307;12836.16564923277;12925.224486530838;13084.607461776162;23750.287491375286;24005.759942400702;24096.759032409802;24199.15302964388;24254;8272.545010024507;8313.41806073569;8319.251267385964;8344.332453403835;8461.873071903927;3940.231654827281;4042.838286468508;4043.0903046814233;4048.0487085534874;4053.412255222976;4023.5574086850424;4181.435506206623;4437.445319335083;4483.766964084837;4501.324801279834;815.5636734347096;824.9340052795762;826.6486743134144;837.8785076163922;847.3475423923544;619.3094699410125;632.7532262417661;647.8250872264463;651.9348065193537;664.6045602866287;10617.13337398898;11291.266067705574;11325.2072354936;11403.258788178742;11752.94123529394;657.2015001772869;659.1562799616498;662.6057495789997;666.1739443090532;668.1514476614672;4669.252919532859;4963.492079217753;5012.635854049714;5032.421271553745;5042.621803364762;78068.31590104499;78716;79417.60291198507;80285.59857200793;81010.18989810144;69741.30258697449;71773.64113179401;72505.6374718123;72813.63593182106;75938.62030689811;62625.686871566264;63307.6834615824;63360;63943.99999999907;64613.67693161504;10074.14369778577;10164;10314.719391452463;10457.111145552713;10459.215558832966;30275.697243027287;30975.225619359695;31370.529442058843;31615.525767113053;32600.413954465464;49760.751196243786;51934.740326298124;53050;54247;54251.72874135604;14099.65205149849;14328.785068224193;14723.190224537753;14760.261986900827;14900.62748431298;15683.607909802346;15973.121478318804;16051.598710032342;16977.320907163576;16977.87776527934;14957.77563336529;15116.848831511545;15238.542843714706;15408.922955385151;15417.922910385825;14136;15087.849121509083;15107.093574385572;15165.545033649008;15221.6194595136;14239.288035597972;14864.730554396232;14904.552863414116;14989.100653960797;15042.774358384415;10715.892841071489;10781.407022613517;11348.659540213806;11355.48900299472;11365.374904380338;10290.3825770454;10893.782640640278;11859.40702964831;12204.633860984184;12297.385130743249 12:35:04 INFO - PID 7007 | __end_tp_report 12:35:04 INFO - PID 7007 | __start_cc_report 12:35:04 INFO - PID 7007 | _x_x_mozilla_cycle_collect,1365 12:35:04 INFO - PID 7007 | __end_cc_report 12:35:04 INFO - PID 7007 | __startTimestamp1490816104357__endTimestamp 12:35:04 INFO - PID 7007 | 12:35:04 INFO - PID 7007 | ------- Summary: start ------- 12:35:04 INFO - PID 7007 | Number of tests: 6 12:35:04 INFO - PID 7007 | 12:35:04 INFO - PID 7007 | [#0] dojo.html Cycles:165 Average:5860.59 Median:6125.00 stddev:712.08 (11.6%) stddev-sans-first:685.34 12:35:04 INFO - PID 7007 | Values: 3299.9 3300.5 3319.9 3331.5 3364.5 5763.7 5868.4 5868.6 5880.9 5935.9 5936.9 5946.7 5969.3 6054.2 6061.2 5117.3 5209.1 5212.1 5263.4 5351.1 5271.1 5280.7 5343.2 5343.2 5351.0 5192.7 5248.8 5261.8 5267.8 5273.3 5139.4 5154.6 5156.6 5159.8 5190.7 5076.7 5116.7 5133.9 5135.5 5142.3 5620.8 5642.1 5661.5 5664.7 5682.4 6125.0 6129.4 6132.6 6139.4 6143.2 6111.1 6125.0 6131.2 6163.3 6266.0 5977.4 5978.5 5981.3 6002.5 6032.2 6549.7 6579.0 6599.3 6606.2 6611.7 6107.2 6126.9 6127.3 6324.7 6330.3 6240.1 6270.3 6323.7 6324.4 6330.1 6366.6 6391.9 6393.8 6408.4 6421.9 6214.5 6316.9 6397.7 6412.4 6415.8 4857.0 4888.8 4911.7 4913.8 4915.7 4271.5 4285.4 4294.4 4304.6 4324.7 6002.9 6026.8 6027.5 6027.9 6032.1 6170.4 6320.3 6395.0 6427.3 6465.5 5970.7 6020.8 6023.9 6024.1 6075.8 5436.1 5442.7 5445.8 5447.2 5453.0 6406.7 6564.8 6577.4 6677.8 6688.6 6427.6 6429.3 6448.2 6460.4 6471.2 6659.9 6661.9 6667.1 6669.4 6670.4 6155.4 6226.9 6264.9 6318.3 6327.6 6359.4 6384.1 6440.7 6450.3 6454.5 6165.4 6169.2 6169.3 6169.8 6184.4 6098.9 6110.2 6156.0 6194.3 6200.8 6229.6 6232.7 6261.4 6264.5 6266.4 6254.0 6270.2 6318.0 6321.9 6328.3 5950.5 5957.0 6152.2 6154.9 6156.1 12:35:04 INFO - PID 7007 | 12:35:04 INFO - PID 7007 | [#1] ext.html Cycles:180 Average:43194.19 Median:180764.79 stddev:73497.44 (40.7%) stddev-sans-first:73634.44 12:35:04 INFO - PID 7007 | Values: 722.3 784.0 808.5 1101.9 1138.2 31246.5 38763.8 39489.4 39530.0 39697.2 41661.0 42071.0 42078.8 42130.0 42240.4 7981.4 8143.6 8145.9 8146.0 8150.1 6102.9 6321.2 8068.6 8280.5 8283.2 8301.3 8413.3 8414.3 8414.9 8416.7 8180.0 8348.1 8350.4 8352.6 8356.7 8165.3 8242.6 8248.8 8257.6 8259.2 39211.8 39446.2 39448.8 39569.8 39576.2 2948.8 2980.2 2985.1 2994.0 3023.5 27764.7 27854.3 28257.9 28646.0 28804.9 3630.2 3639.8 3681.1 3745.9 3751.6 182933.0 183677.0 184321.0 184860.0 184898.0 48108.0 48141.5 48160.3 48185.0 48272.3 48910.3 49102.5 49158.5 49244.5 49251.0 15116.2 15195.1 15216.6 15228.3 15255.2 10680.4 12204.8 12210.8 12289.8 12293.3 12727.1 13772.8 14226.2 14361.3 14379.3 5635.3 5709.8 5828.8 5851.8 5883.4 1032.3 1044.7 1051.7 1060.1 1083.2 26024.9 26112.7 26168.5 26188.6 26256.7 1104.6 1127.3 1133.6 1141.8 1169.0 13390.3 13691.7 13723.3 13739.5 13853.1 325158.0 325322.0 328285.0 328633.0 329162.0 54449.7 54690.0 54718.5 54796.5 54802.5 1447.8 1473.8 1477.3 1491.1 1494.2 23878.5 24951.5 25129.0 25181.7 25229.4 40301.2 40397.6 40428.6 40584.4 40587.8 305662.1 305677.0 306432.0 307750.0 309235.0 33781.8 34035.8 34055.7 34557.8 36020.0 35308.6 36506.5 39352.0 43011.8 43428.1 31988.0 32509.8 32645.8 32714.3 32824.8 32125.5 32276.4 32621.5 32648.3 32896.6 36795.3 37484.6 37497.0 37578.8 37666.2 30939.2 31617.7 31648.5 31821.4 32653.8 24217.9 25340.4 25420.5 25450.6 25530.0 12:35:04 INFO - PID 7007 | 12:35:04 INFO - PID 7007 | [#2] jquery.html Cycles:180 Average:33478.40 Median:21076.18 stddev:94816.39 (449.9%) stddev-sans-first:95049.81 12:35:04 INFO - PID 7007 | Values: 384.3 385.2 389.8 392.7 412.6 13354.5 20356.8 21081.7 21089.7 21838.5 15858.9 18542.6 20989.7 21078.5 21295.8 5921.7 6157.3 6161.8 6161.9 6168.4 5892.6 5981.6 6018.1 6095.3 6106.8 6053.6 6064.4 6066.8 6067.3 6070.5 5776.6 5847.2 5877.9 5897.2 6043.3 5191.8 5204.7 5216.8 5221.5 5225.3 24438.6 24608.8 25003.5 25064.2 25280.9 2028.9 2043.8 2051.1 2096.0 2105.4 15907.5 15916.1 16385.3 16498.8 16643.6 1728.5 1766.6 1775.9 1792.5 1795.4 95298.5 96301.0 97685.0 97995.0 98248.5 11190.9 11328.2 11333.0 11383.5 11558.1 15304.3 15317.1 15330.8 15333.2 15345.0 7288.5 7620.7 8242.8 8603.8 8972.2 8101.4 8168.4 8386.3 8829.1 8848.1 7417.7 7725.6 7728.6 7779.5 7810.2 1918.7 1927.5 1934.6 1996.1 1998.9 1029.0 1042.8 1062.8 1069.6 1076.2 20899.6 20912.9 21073.9 21083.6 21140.0 1048.8 1073.1 1074.6 1092.7 1109.2 10536.9 11260.5 11358.7 11449.1 11499.5 556625.0 556696.0 570310.0 588926.0 594995.0 108368.5 109462.0 112663.9 113785.4 114572.4 1168.2 1185.5 1223.6 1228.4 1229.8 17344.6 17374.3 19881.0 21321.6 21570.6 50686.0 50696.7 51296.0 52153.2 52795.7 62326.0 62375.4 62902.4 63405.4 64124.7 9014.6 9050.0 9086.0 9095.9 9442.6 15320.9 15331.1 15403.5 15852.2 15952.8 13235.7 13488.9 13504.1 13520.3 13907.7 11637.8 11748.9 12290.8 12498.0 12902.4 13008.6 13558.7 13868.8 13882.9 13932.0 8695.0 8805.9 8997.5 9077.1 9135.7 12650.5 12834.6 13538.1 13989.0 14142.6 12:35:04 INFO - PID 7007 | 12:35:04 INFO - PID 7007 | [#3] mootools.html Cycles:180 Average:6589.60 Median:3749.23 stddev:4148.01 (110.6%) stddev-sans-first:4140.38 12:35:04 INFO - PID 7007 | Values: 1270.4 1341.7 1345.5 1363.1 1366.4 10203.1 10567.7 10602.1 10604.6 10609.2 10426.7 10586.9 10811.2 10845.7 10940.7 2307.4 2337.0 2349.7 2350.1 2351.5 1896.2 2184.5 2295.4 2298.3 2307.5 1925.9 2228.6 2292.3 2294.2 2302.3 2220.5 2273.5 2277.4 2283.1 2297.2 2225.3 2227.1 2227.5 2227.6 2228.9 9942.3 9968.8 9986.9 9998.5 10023.1 5670.0 6008.2 6011.5 6015.1 6032.5 3500.3 3639.8 3646.9 3747.5 3749.2 1155.3 1174.7 1183.3 1190.7 1724.8 14319.7 14439.0 14473.6 14495.9 14501.4 4690.1 4956.3 4986.1 5095.5 5103.3 11854.9 11889.5 11910.4 11960.6 11977.0 5964.6 5966.1 5972.2 5976.0 5976.5 5448.0 5561.5 5608.1 5611.6 5614.7 3788.8 3854.8 3856.7 3874.0 3995.4 925.2 1055.8 1066.6 1077.4 1080.9 632.5 785.8 800.9 820.5 827.2 5554.3 5698.9 5766.1 5839.1 5990.3 895.3 909.4 914.4 917.8 929.7 3736.5 3742.4 3749.3 3755.1 3758.8 12917.4 13371.7 13376.5 13381.3 13382.7 13190.4 13255.0 13278.8 13282.7 13380.3 9485.2 9892.0 9900.8 9902.5 9908.7 6238.2 6281.7 6360.3 6443.2 6589.6 12710.9 12948.7 13010.2 13031.2 13034.5 12638.2 12738.4 12795.5 12913.9 13088.1 8979.6 9268.4 9281.4 9283.9 9284.2 9898.0 10028.1 10034.9 10038.3 10119.7 7961.4 8411.5 8561.4 8600.7 8816.1 7848.7 8054.4 8084.5 8088.8 8171.4 7141.7 7238.4 7254.2 7269.3 7826.6 5719.0 5815.7 5819.0 5828.7 5882.4 5904.1 5987.0 5999.7 6210.2 6271.0 12:35:04 INFO - PID 7007 | 12:35:04 INFO - PID 7007 | [#4] prototype.html Cycles:180 Average:5208.12 Median:5947.08 stddev:1582.94 (26.6%) stddev-sans-first:1545.37 12:35:04 INFO - PID 7007 | Values: 381.5 383.8 386.4 387.4 388.2 5908.5 5943.3 5945.2 5992.6 6008.8 5634.4 5783.5 5800.8 5874.1 5886.9 4521.3 4545.3 4552.5 4565.7 4566.7 4575.5 4583.8 4590.8 4594.8 4601.9 4240.3 4404.8 4459.2 4555.6 4559.6 4389.7 4417.2 4417.7 4429.7 4432.9 3855.8 3862.4 3864.8 3887.7 3891.0 5652.7 5790.4 5795.8 5796.7 5816.8 5190.8 5207.1 5207.9 5214.9 5226.3 6227.7 6244.0 6244.4 6269.0 6273.9 4135.1 4292.1 4327.5 4336.8 4337.6 6208.0 6352.8 6493.0 6533.8 6559.9 4273.2 4281.8 4288.8 4301.5 4333.8 4469.3 4469.8 4475.6 4476.6 4486.2 4805.6 4872.3 5166.1 5166.1 5176.4 6189.3 6191.1 6236.3 6236.5 6260.3 1527.2 1537.9 1538.0 1539.2 1549.9 959.7 1016.4 1016.5 1020.6 1040.2 5942.8 5949.0 5985.4 6006.7 6016.5 6379.8 6394.4 6400.2 6405.8 6419.4 5807.3 5940.0 5973.2 5981.8 6003.9 3370.0 3380.9 3392.2 3392.3 3411.7 6499.7 6621.9 6625.6 6644.3 6678.8 6542.2 6549.6 6573.0 6592.8 6599.2 6398.6 6623.1 6636.3 6641.5 6666.7 6439.4 6439.5 6472.8 6473.5 6494.2 6215.2 6387.7 6394.6 6398.4 6418.1 6375.2 6463.9 6533.6 6681.5 6741.3 4293.4 4309.8 4311.9 4314.4 4321.7 6362.8 6519.2 6519.4 6522.6 6525.3 6273.9 6284.6 6286.9 6307.9 6319.5 6316.5 6326.0 6328.1 6332.5 6342.1 6087.0 6259.2 6262.6 6280.5 6309.5 6325.7 6327.5 6329.7 6333.7 6337.3 5914.6 6091.9 6097.7 6140.7 6161.2 12:35:04 INFO - PID 7007 | 12:35:04 INFO - PID 7007 | [#5] yui.html Cycles:180 Average:17970.50 Median:17392.53 stddev:22299.43 (128.2%) stddev-sans-first:22324.53 12:35:04 INFO - PID 7007 | Values: 758.3 771.6 771.8 779.6 805.4 14967.4 15394.1 15531.8 17855.0 18934.4 17050.3 17142.8 17224.7 17515.9 17549.0 927.0 945.9 949.1 949.2 949.3 924.9 935.3 949.6 958.6 959.1 1001.5 1005.0 1006.1 1006.3 1007.2 993.5 996.7 997.5 997.8 999.1 725.9 730.3 730.6 731.6 732.1 15949.0 16115.5 16297.8 16374.7 16480.8 16118.2 16238.5 16339.2 16387.6 16705.1 12441.7 12654.2 12796.8 12971.3 13072.6 3112.3 3155.8 3169.5 3264.6 3274.8 73565.0 74990.6 75716.0 84130.0 85625.0 12335.8 12676.2 12836.2 12925.2 13084.6 23750.3 24005.8 24096.8 24199.2 24254.0 8272.5 8313.4 8319.3 8344.3 8461.9 3940.2 4042.8 4043.1 4048.0 4053.4 4023.6 4181.4 4437.4 4483.8 4501.3 815.6 824.9 826.6 837.9 847.3 619.3 632.8 647.8 651.9 664.6 10617.1 11291.3 11325.2 11403.3 11752.9 657.2 659.2 662.6 666.2 668.2 4669.3 4963.5 5012.6 5032.4 5042.6 78068.3 78716.0 79417.6 80285.6 81010.2 69741.3 71773.6 72505.6 72813.6 75938.6 62625.7 63307.7 63360.0 63944.0 64613.7 10074.1 10164.0 10314.7 10457.1 10459.2 30275.7 30975.2 31370.5 31615.5 32600.4 49760.8 51934.7 53050.0 54247.0 54251.7 14099.7 14328.8 14723.2 14760.3 14900.6 15683.6 15973.1 16051.6 16977.3 16977.9 14957.8 15116.8 15238.5 15408.9 15417.9 14136.0 15087.8 15107.1 15165.5 15221.6 14239.3 14864.7 14904.6 14989.1 15042.8 10715.9 10781.4 11348.7 11355.5 11365.4 10290.4 10893.8 11859.4 12204.6 12297.4 12:35:04 INFO - PID 7007 | -------- Summary: end -------- 12:35:04 INFO - PID 7007 | 12:35:05 INFO - TEST-INFO | 7007: exit 0 12:35:05 INFO - TEST-OK | dromaeo_css | took 1116857ms 12:35:05 INFO - TEST-START | kraken 12:35:05 INFO - operating with platform_type : linux_ 12:35:05 INFO - Initialising browser for kraken test... 12:35:05 INFO - TEST-INFO | started process 7329 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGXqHcf/profile http://localhost:47296/getInfo.html) 12:35:08 INFO - PID 7329 | __metrics Screen width/height:1600/1200 12:35:08 INFO - PID 7329 | colorDepth:24 12:35:08 INFO - PID 7329 | Browser inner width/height: 1024/697 12:35:08 INFO - PID 7329 | __metrics 12:35:09 ERROR - PID 7329 | 1490816109796 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: TypeError: log is null (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:96:5) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:96:5 < callBootstrapMethod@XPIProvider.jsm:4957:11 < observe@XPIProvider.jsm:2924:15 < canQuitApplication@quit.js:67:3 < goQuitApplication@quit.js:109:8 < whenDone@quit.js:100:7 < promise callback*goQuitApplication@quit.js:103:5 < onload@getInfo.html:7:5 12:35:09 INFO - PID 7329 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 12:35:09 INFO - PID 7329 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:35:10 INFO - TEST-INFO | 7329: exit 0 12:35:10 INFO - Browser initialized. 12:35:10 INFO - Running cycle 1/1 for kraken test... 12:35:10 INFO - TEST-INFO | started process 7424 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGXqHcf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:35:22 INFO - PID 7424 | RSS: Main: 144658432 12:35:22 INFO - PID 7424 | 12:35:25 INFO - PID 7424 | Cycle 1(1): loaded http://localhost:47296/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47296/tests/kraken/driver.html?testName=audio-beat-detection) 12:35:26 INFO - PID 7424 | RSS: Main: 200617984 12:35:26 INFO - PID 7424 | 12:35:28 INFO - PID 7424 | Cycle 1(1): loaded http://localhost:47296/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47296/tests/kraken/driver.html?testName=audio-dft) 12:35:29 INFO - PID 7424 | RSS: Main: 179990528 12:35:29 INFO - PID 7424 | 12:35:32 INFO - PID 7424 | Cycle 1(1): loaded http://localhost:47296/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47296/tests/kraken/driver.html?testName=audio-fft) 12:35:32 INFO - PID 7424 | RSS: Main: 262238208 12:35:32 INFO - PID 7424 | 12:35:35 INFO - PID 7424 | Cycle 1(1): loaded http://localhost:47296/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47296/tests/kraken/driver.html?testName=audio-oscillator) 12:35:35 INFO - PID 7424 | RSS: Main: 173281280 12:35:35 INFO - PID 7424 | 12:35:37 INFO - PID 7424 | Cycle 1(1): loaded http://localhost:47296/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47296/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:35:38 INFO - PID 7424 | RSS: Main: 177262592 12:35:38 INFO - PID 7424 | 12:35:41 INFO - PID 7424 | Cycle 1(1): loaded http://localhost:47296/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47296/tests/kraken/driver.html?testName=imaging-darkroom) 12:35:42 INFO - PID 7424 | RSS: Main: 215183360 12:35:42 INFO - PID 7424 | 12:35:45 INFO - PID 7424 | Cycle 1(1): loaded http://localhost:47296/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47296/tests/kraken/driver.html?testName=imaging-desaturate) 12:35:46 INFO - PID 7424 | RSS: Main: 210993152 12:35:46 INFO - PID 7424 | 12:35:49 INFO - PID 7424 | Cycle 1(1): loaded http://localhost:47296/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47296/tests/kraken/driver.html?testName=json-parse-financial) 12:35:49 INFO - PID 7424 | RSS: Main: 213221376 12:35:49 INFO - PID 7424 | 12:35:51 INFO - PID 7424 | Cycle 1(1): loaded http://localhost:47296/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47296/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:35:51 INFO - PID 7424 | RSS: Main: 176594944 12:35:51 INFO - PID 7424 | 12:35:53 INFO - PID 7424 | Cycle 1(1): loaded http://localhost:47296/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47296/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:35:54 INFO - PID 7424 | RSS: Main: 183238656 12:35:54 INFO - PID 7424 | 12:35:56 INFO - PID 7424 | Cycle 1(1): loaded http://localhost:47296/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47296/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:35:56 INFO - PID 7424 | RSS: Main: 193282048 12:35:56 INFO - PID 7424 | 12:35:59 INFO - PID 7424 | Cycle 1(1): loaded http://localhost:47296/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47296/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:36:00 INFO - PID 7424 | RSS: Main: 202694656 12:36:00 INFO - PID 7424 | 12:36:03 INFO - PID 7424 | Cycle 1(1): loaded http://localhost:47296/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47296/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:36:03 INFO - PID 7424 | RSS: Main: 198934528 12:36:03 INFO - PID 7424 | 12:36:05 INFO - PID 7424 | Cycle 1(1): loaded http://localhost:47296/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47296/tests/kraken/driver.html?testName=ai-astar) 12:36:05 INFO - PID 7424 | RSS: Main: 268283904 12:36:05 INFO - PID 7424 | 12:36:05 INFO - PID 7424 | __start_tp_report 12:36:05 INFO - PID 7424 | _x_x_mozilla_page_load 12:36:05 INFO - PID 7424 | _x_x_mozilla_page_load_details 12:36:05 INFO - PID 7424 | |i|pagename|runs| 12:36:05 INFO - PID 7424 | |0;ai-astar;101;110;109;110;111;111;109;111;109;109 12:36:05 INFO - PID 7424 | |1;audio-beat-detection;152;118;118;155;122;121;120;118;147;120 12:36:05 INFO - PID 7424 | |2;audio-dft;164;163;166;165;165;163;164;163;164;164 12:36:05 INFO - PID 7424 | |3;audio-fft;74;74;74;112;75;76;76;74;98;75 12:36:05 INFO - PID 7424 | |4;audio-oscillator;83;84;109;85;83;83;98;83;84;110 12:36:05 INFO - PID 7424 | |5;imaging-gaussian-blur;114;114;114;115;113;114;114;114;113;113 12:36:05 INFO - PID 7424 | |6;imaging-darkroom;147;149;148;149;149;149;148;148;148;148 12:36:05 INFO - PID 7424 | |7;imaging-desaturate;94;94;94;94;94;94;96;94;94;95 12:36:05 INFO - PID 7424 | |8;json-parse-financial;56;56;57;57;57;57;58;57;57;65 12:36:05 INFO - PID 7424 | |9;json-stringify-tinderbox;55;55;55;55;54;55;55;54;54;56 12:36:05 INFO - PID 7424 | |10;stanford-crypto-aes;88;80;80;82;83;81;82;80;80;86 12:36:05 INFO - PID 7424 | |11;stanford-crypto-ccm;129;130;136;132;137;126;133;126;178;126 12:36:05 INFO - PID 7424 | |12;stanford-crypto-pbkdf2;190;192;183;183;187;184;180;193;191;194 12:36:05 INFO - PID 7424 | |13;stanford-crypto-sha256-iterative;67;67;65;67;70;65;66;64;66;65 12:36:05 INFO - PID 7424 | __end_tp_report 12:36:05 INFO - PID 7424 | __start_cc_report 12:36:05 INFO - PID 7424 | _x_x_mozilla_cycle_collect,1759 12:36:05 INFO - PID 7424 | __end_cc_report 12:36:05 INFO - PID 7424 | __startTimestamp1490816165870__endTimestamp 12:36:05 INFO - PID 7424 | 12:36:05 INFO - PID 7424 | ------- Summary: start ------- 12:36:05 INFO - PID 7424 | Number of tests: 14 12:36:05 INFO - PID 7424 | 12:36:05 INFO - PID 7424 | [#0] ai-astar Cycles:10 Average:109.00 Median:110.00 stddev:2.94 (2.7%) stddev-sans-first:0.93 12:36:05 INFO - PID 7424 | Values: 101.0 110.0 109.0 110.0 111.0 111.0 109.0 111.0 109.0 109.0 12:36:05 INFO - PID 7424 | 12:36:05 INFO - PID 7424 | [#1] audio-beat-detection Cycles:10 Average:129.10 Median:121.50 stddev:15.52 (12.8%) stddev-sans-first:14.07 12:36:05 INFO - PID 7424 | Values: 152.0 118.0 118.0 155.0 122.0 121.0 120.0 118.0 147.0 120.0 12:36:05 INFO - PID 7424 | 12:36:05 INFO - PID 7424 | [#2] audio-dft Cycles:10 Average:164.10 Median:164.00 stddev:0.99 (0.6%) stddev-sans-first:1.05 12:36:05 INFO - PID 7424 | Values: 164.0 163.0 166.0 165.0 165.0 163.0 164.0 163.0 164.0 164.0 12:36:05 INFO - PID 7424 | 12:36:05 INFO - PID 7424 | [#3] audio-fft Cycles:10 Average:80.80 Median:75.00 stddev:13.20 (17.6%) stddev-sans-first:13.77 12:36:05 INFO - PID 7424 | Values: 74.0 74.0 74.0 112.0 75.0 76.0 76.0 74.0 98.0 75.0 12:36:05 INFO - PID 7424 | 12:36:05 INFO - PID 7424 | [#4] audio-oscillator Cycles:10 Average:90.20 Median:83.50 stddev:11.14 (13.3%) stddev-sans-first:11.51 12:36:05 INFO - PID 7424 | Values: 83.0 84.0 109.0 85.0 83.0 83.0 98.0 83.0 84.0 110.0 12:36:05 INFO - PID 7424 | 12:36:05 INFO - PID 7424 | [#5] imaging-gaussian-blur Cycles:10 Average:113.80 Median:114.00 stddev:0.63 (0.6%) stddev-sans-first:0.67 12:36:05 INFO - PID 7424 | Values: 114.0 114.0 114.0 115.0 113.0 114.0 114.0 114.0 113.0 113.0 12:36:05 INFO - PID 7424 | 12:36:05 INFO - PID 7424 | [#6] imaging-darkroom Cycles:10 Average:148.30 Median:148.50 stddev:0.67 (0.5%) stddev-sans-first:0.53 12:36:05 INFO - PID 7424 | Values: 147.0 149.0 148.0 149.0 149.0 149.0 148.0 148.0 148.0 148.0 12:36:05 INFO - PID 7424 | 12:36:05 INFO - PID 7424 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:94.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 12:36:05 INFO - PID 7424 | Values: 94.0 94.0 94.0 94.0 94.0 94.0 96.0 94.0 94.0 95.0 12:36:05 INFO - PID 7424 | 12:36:05 INFO - PID 7424 | [#8] json-parse-financial Cycles:10 Average:57.70 Median:57.00 stddev:2.63 (4.6%) stddev-sans-first:2.71 12:36:05 INFO - PID 7424 | Values: 56.0 56.0 57.0 57.0 57.0 57.0 58.0 57.0 57.0 65.0 12:36:05 INFO - PID 7424 | 12:36:05 INFO - PID 7424 | [#9] json-stringify-tinderbox Cycles:10 Average:54.80 Median:55.00 stddev:0.63 (1.1%) stddev-sans-first:0.67 12:36:05 INFO - PID 7424 | Values: 55.0 55.0 55.0 55.0 54.0 55.0 55.0 54.0 54.0 56.0 12:36:05 INFO - PID 7424 | 12:36:05 INFO - PID 7424 | [#10] stanford-crypto-aes Cycles:10 Average:82.20 Median:82.00 stddev:2.78 (3.4%) stddev-sans-first:2.01 12:36:05 INFO - PID 7424 | Values: 88.0 80.0 80.0 82.0 83.0 81.0 82.0 80.0 80.0 86.0 12:36:05 INFO - PID 7424 | 12:36:05 INFO - PID 7424 | [#11] stanford-crypto-ccm Cycles:10 Average:135.30 Median:132.50 stddev:15.53 (11.7%) stddev-sans-first:16.30 12:36:05 INFO - PID 7424 | Values: 129.0 130.0 136.0 132.0 137.0 126.0 133.0 126.0 178.0 126.0 12:36:05 INFO - PID 7424 | 12:36:05 INFO - PID 7424 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:187.70 Median:190.50 stddev:4.95 (2.6%) stddev-sans-first:5.17 12:36:05 INFO - PID 7424 | Values: 190.0 192.0 183.0 183.0 187.0 184.0 180.0 193.0 191.0 194.0 12:36:05 INFO - PID 7424 | 12:36:05 INFO - PID 7424 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.20 Median:66.50 stddev:1.69 (2.5%) stddev-sans-first:1.76 12:36:05 INFO - PID 7424 | Values: 67.0 67.0 65.0 67.0 70.0 65.0 66.0 64.0 66.0 65.0 12:36:05 INFO - PID 7424 | -------- Summary: end -------- 12:36:05 INFO - PID 7424 | 12:36:06 INFO - TEST-INFO | 7424: exit 0 12:36:06 INFO - TEST-OK | kraken | took 61699ms 12:36:06 INFO - SUITE-END | took 1178s 12:36:07 INFO - Completed test suite (00:19:38) 12:36:07 INFO - javascript benchmark 12:36:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7545.844892113899, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3299.868005279789, 3300.455424854899, 3319.850606722697, 3331.483620038894, 3364.5289659447667, 5763.740631671574, 5868.3838196989345, 5868.61853979491, 5880.9411905880925, 5935.940640593598, 5936.88126237475, 5946.702664866761, 5969.253843269591, 6054.182685337478, 6061.181740465036, 5117.309163262949, 5209.1404918188455, 5212.087884620195, 5263.421023687391, 5351.09031464652, 5271.130263506536, 5280.656757310781, 5343.17180836969, 5343.171808369709, 5350.973245133769, 5192.688438693691, 5248.81629142982, 5261.842144735664, 5267.815626453094, 5273.34083239595, 5139.357580302462, 5154.639175257734, 5156.561692256163, 5159.793608255665, 5190.688558686453, 5076.720780357079, 5116.744162791882, 5133.948660513384, 5135.537801597874, 5142.254373115878, 5620.803271885465, 5642.125470552071, 5661.46216109469, 5664.6601203927485, 5682.403347648478, 6125.0, 6129.448349648553, 6132.601380910227, 6139.447449729546, 6143.201383820075, 6111.053100029335, 6125.0, 6131.174202174114, 6163.322034576193, 6265.968670156665, 5977.402259774031, 5978.491828194608, 5981.252343457068, 6002.519798416116, 6032.245969253843, 6549.705263263165, 6579.0, 6599.274079851212, 6606.2072551293195, 6611.702473388613, 6107.196453950035, 6126.908096378558, 6127.281156068166, 6324.683765811691, 6330.335314791881, 6240.063990401385, 6270.31026587075, 6323.715432805535, 6324.43080122782, 6330.113784070234, 6366.586171898812, 6391.904121438182, 6393.808185754435, 6408.391202835816, 6421.8715625688155, 6214.533909956681, 6316.9368306317265, 6397.712102955378, 6412.422881940648, 6415.807525774234, 4856.95143048572, 4888.780004899717, 4911.705297682151, 4913.754312284372, 4915.705057696549, 4271.466066741657, 4285.357196420562, 4294.441722576045, 4304.569543045671, 4324.71889327199, 6002.939970600325, 6026.819195424145, 6027.517798576104, 6027.939720602738, 6032.065029920369, 6170.444659980623, 6320.27316858558, 6395.040743888454, 6427.260865000491, 6465.4827613790785, 5970.701464926737, 6020.819375418744, 6023.915695174911, 6024.0662697282, 6075.754470333571, 5436.10304299794, 5442.700651464207, 5445.754941027663, 5447.210154527571, 5453.045716999509, 6406.743730250738, 6564.8358791030605, 6577.408033277028, 6677.799666010027, 6688.565243259075, 6427.55007149495, 6429.260635026844, 6448.161738973903, 6460.3862633049785, 6471.2234531856475, 6659.866802663822, 6661.933380666132, 6667.099941507834, 6669.399754022162, 6670.366315200048, 6155.415235552616, 6226.937730622817, 6264.874702506016, 6318.336574659778, 6327.588706734047, 6359.427651511386, 6384.138141350858, 6440.710168042356, 6450.258220304725, 6454.451371633464, 6165.414285642857, 6169.167162433194, 6169.259688837189, 6169.81490555284, 6184.381561843779, 6098.939010609837, 6110.175126357884, 6155.9842625968, 6194.318624951342, 6200.782972595937, 6229.595076320024, 6232.657203853651, 6261.436470717657, 6264.5301602379095, 6266.37336266388, 6254.0, 6270.15352927349, 6318.0, 6321.873562528632, 6328.303886572566, 5950.523958083257, 5957.0, 6152.200213972155, 6154.907676384947, 6156.107364432043], "value": 5809.317246275965, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [722.3426681719636, 783.9882401763973, 808.5108509351842, 1101.9449027548626, 1138.1918837625285, 31246.53130203046, 38763.80618096909, 39489.4076588851, 39530.0, 39697.206055878865, 41661.0, 42071.0, 42078.78960605193, 42130.0, 42240.366394504104, 7981.361491080728, 8143.552104634243, 8145.877811832827, 8145.959270203641, 8150.103488616248, 6102.938970610304, 6321.178246827906, 8068.636911338975, 8280.461769984931, 8283.17168283173, 8301.252887240147, 8413.28487078599, 8414.326853851677, 8414.915850841506, 8416.705415310465, 8179.959100204521, 8348.081711011784, 8350.415470917038, 8352.582370881431, 8356.749297521053, 8165.265126138676, 8242.629081691339, 8248.793780155484, 8257.587120643944, 8259.21537453941, 39211.8039409804, 39446.21107577832, 39448.802755986035, 39569.80215098906, 39576.208475830324, 2948.778841586868, 2980.2251414632133, 2985.059706192564, 2993.9550906736417, 3023.546468029791, 27764.722352776414, 27854.3036424091, 28257.858710706314, 28646.0, 28804.855975719987, 3630.2013557017676, 3639.7998110103936, 3681.11653203232, 3745.8501659933568, 3751.606081361445, 182933.0, 183677.0, 184321.0, 184860.0, 184897.99999999866, 48108.0, 48141.5185848144, 48160.27759583609, 48185.0, 48272.27591586129, 48910.266346004835, 49102.50897491051, 49158.508414916105, 49244.50755492399, 49251.0, 15116.168610726516, 15195.088294702133, 15216.619584510476, 15228.314725837365, 15255.160966146746, 10680.412577308323, 12204.816927746091, 12210.816837747441, 12289.815652765215, 12293.323867187391, 12727.10910236293, 13772.793408098887, 14226.217558034201, 14361.281935903164, 14379.281035948161, 5635.3237611486065, 5709.8287051388525, 5828.825135245949, 5851.824445266649, 5883.382244864228, 1032.3031953431405, 1044.738815296176, 1051.709027169148, 1060.125396547851, 1083.225493771941, 26024.86987565088, 26112.73887261141, 26168.476630467285, 26188.60717089207, 26256.73743262581, 1104.5692180049787, 1127.2954403497813, 1133.557912414159, 1141.7545227776068, 1168.9649310520697, 13390.330483475787, 13691.657708557366, 13723.313834308245, 13739.450421983209, 13853.099548529313, 325158.0, 325322.0, 328285.0, 328633.0, 329162.0, 54449.72775136099, 54690.0, 54718.45281547133, 54796.45203547993, 54802.45197548053, 1447.8190226221511, 1473.7641977283583, 1477.253986736691, 1491.1062950053372, 1494.2006026775841, 23878.522429550965, 24951.500969980134, 25129.0, 25181.748182517942, 25229.369265767768, 40301.1939761209, 40397.59602403938, 40428.59571404366, 40584.39123413092, 40587.797061014506, 305662.1319614218, 305677.0, 306432.0, 307750.0, 309235.0, 33781.83109084439, 34035.82982085173, 34055.659443405246, 34557.82721086378, 36020.0, 35308.64691353054, 36506.45240321344, 39352.0, 43011.78494107509, 43428.13143737171, 31988.0, 32509.837450812596, 32645.836770815993, 32714.34571308608, 32824.83587582047, 32125.518117228727, 32276.35447291088, 32621.510677340335, 32648.34703305968, 32896.578422322375, 36795.26409471742, 37484.625153749206, 37497.0, 37578.812105939294, 37666.2466750658, 30939.226519337197, 31617.683823162395, 31648.5252721214, 31821.363572727954, 32653.836730816194, 24217.878910605334, 25340.366490837878, 25420.49159016846, 25450.618240726035, 25530.04372267333], "value": 17524.2688624944, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.33318192935235, 385.201511022422, 389.7641926634386, 392.6740805131741, 412.6368795459995, 13354.465821367157, 20356.796432035677, 21081.68377474337, 21089.68365474517, 21838.454038649, 15858.895248685682, 18542.629147417043, 20989.685154722654, 21078.473038174052, 21295.787042129574, 5921.674307913063, 6157.2919114301985, 6161.815145545641, 6161.907571386433, 6168.352323006087, 5892.616979896315, 5981.551383646222, 6018.127371531147, 6095.29904061032, 6106.816795496142, 6053.576249662503, 6064.393560643923, 6066.787662431816, 6067.332593414721, 6070.453659170674, 5776.566757493205, 5847.210626565402, 5877.9118313225335, 5897.174395584579, 6043.305019922721, 5191.844244672666, 5204.661696989721, 5216.765245563959, 5221.477852214786, 5225.294585231021, 24438.633420498707, 24608.753912460827, 25003.499930001297, 25064.24807255767, 25280.87359563209, 2028.9391318260475, 2043.8057345329032, 2051.066764622093, 2096.0462989339967, 2105.3999610111046, 15907.522774316789, 15916.124613146272, 16385.344586216655, 16498.75251871223, 16643.583910402216, 1728.5160155156577, 1766.611345503987, 1775.9289628414977, 1792.4981005318532, 1795.4344381519911, 95298.52350738202, 96301.0, 97685.0, 97994.99999999929, 98248.50875745647, 11190.888091118984, 11328.150388720878, 11333.0, 11383.487743051583, 11558.133140014532, 15304.311305991258, 15317.080975141527, 15330.846691533165, 15333.236677782197, 15345.0, 7288.526245794006, 7620.69517219305, 8242.835143297101, 8603.784905377415, 8972.19250267466, 8101.392395570356, 8168.387370947203, 8386.287165590993, 8829.072947340437, 8848.070952550019, 7417.701902167099, 7725.575093369918, 7728.613569321511, 7779.4554381192775, 7810.23575618872, 1918.7313776071362, 1927.4892153579312, 1934.6130773845007, 1996.1316827180224, 1998.9000549972443, 1028.9639862604772, 1042.8327636560823, 1062.7661914378825, 1069.641670040545, 1076.2036093290908, 20899.582008359746, 20912.895435522725, 21073.89463052675, 21083.578328433345, 21140.0, 1048.8059708953867, 1073.130764081097, 1074.6352132791312, 1092.7104317355906, 1109.1847492093304, 10536.892621475736, 11260.549578016788, 11358.659240222807, 11449.053660877671, 11499.482523286471, 556625.0, 556696.0, 570310.0, 588926.0, 594995.0, 108368.45815770871, 109462.0, 112663.86025257767, 113785.4310728441, 114572.42713786544, 1168.2231316174818, 1185.454690842205, 1223.6451429085466, 1228.3796682675193, 1229.7540491901655, 17344.566385840455, 17374.305027798746, 19881.01784732244, 21321.573568528853, 21570.568588628452, 50686.0, 50696.74651626718, 51296.0, 52153.217701735266, 52795.736021319644, 62326.0, 62375.376246236956, 62902.370976289654, 63405.365946339945, 64124.67937660282, 9014.639414423613, 9049.954750226207, 9086.045965173562, 9095.909040909506, 9442.622295108118, 15320.923395382952, 15331.080135191924, 15403.537893863202, 15852.20738963024, 15952.760708589149, 13235.66910827237, 13488.865111348761, 13504.122232054886, 13520.25638589887, 13907.721845563234, 11637.825432618349, 11748.88251117478, 12290.81563776562, 12498.0, 12902.354882256037, 13008.609741707764, 13558.661033474242, 13868.810173659913, 13882.930585347009, 13932.0, 8694.956525217334, 8805.867911981453, 8997.460152390615, 9077.137671921157, 9135.680251191176, 12650.493980240688, 12834.614961551168, 13538.120022198525, 13989.0, 14142.646433839236], "value": 10086.78651416026, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1270.447355400401, 1341.7316536692663, 1345.542515544715, 1363.134409649872, 1366.4056135581018, 10203.08172264496, 10567.735806604838, 10602.098821600173, 10604.57581696732, 10609.15126789857, 10426.739331516697, 10586.947065264663, 10811.189160812932, 10845.674629761119, 10940.671779846618, 2307.3539408965476, 2336.9766302337016, 2349.6827928229727, 2350.0717216699395, 2351.4826738117586, 1896.1941175000638, 2184.5194057307367, 2295.4031951692596, 2298.310506847947, 2307.515421761432, 1925.894075825829, 2228.6211344071467, 2292.266474728079, 2294.208498068172, 2302.3323236261463, 2220.5225876436643, 2273.545290941818, 2277.3737222263926, 2283.1095872609612, 2297.1959814065112, 2225.2879078694823, 2227.0535022615486, 2227.532218234173, 2227.5878962392007, 2228.8774117423536, 9942.254330925138, 9968.800623987552, 9986.850197247048, 9998.500074996222, 10023.148032417253, 5670.0, 6008.24896887889, 6011.458968692838, 6015.127806468081, 6032.45707886288, 3500.334936362083, 3639.836207370648, 3646.8541258349633, 3747.475353450519, 3749.193923306475, 1155.2837240910605, 1174.7180676637631, 1183.2663748476, 1190.708276472261, 1724.8275172482777, 14319.713605727931, 14439.0, 14473.565793026226, 14495.927520362331, 14501.41994320226, 4690.085433340466, 4956.306117143603, 4986.102501549756, 5095.515925987025, 5103.3110530077965, 11854.94072529632, 11889.524419023315, 11910.404479775976, 11960.641180764416, 11977.041836653047, 5964.642121472725, 5966.105084237312, 5972.193753843262, 5975.970120149372, 5976.491998180203, 5447.972760136253, 5561.527270181999, 5608.1027035674915, 5611.6352437091455, 5614.663120212718, 3788.753731007476, 3854.768713877176, 3856.652901238902, 3873.9806300968316, 3995.440638310639, 925.167349385545, 1055.762453447968, 1066.5893630951985, 1077.4181941751524, 1080.8865069167625, 632.4750457120671, 785.8192615698422, 800.9427555626517, 820.5240960243045, 827.1893544326593, 5554.277943867352, 5698.943010569841, 5766.135079738073, 5839.073105875051, 5990.341062483123, 895.3285036222833, 909.377076702461, 914.3873604684877, 917.8347897378536, 929.6885543343055, 3736.4955730976512, 3742.401215805458, 3749.268892565978, 3755.080005398695, 3758.755680880734, 12917.418716157796, 13371.732565348639, 13376.531821386205, 13381.330933453288, 13382.732345353039, 13190.406431710597, 13255.0, 13278.800817987738, 13282.667933301746, 13380.264085475392, 9485.241180705527, 9891.950540247253, 9900.752481187883, 9902.504874756234, 9908.653197138066, 6238.15784869055, 6281.654509001866, 6360.268569114611, 6443.162388889415, 6589.604623722592, 12710.936445317715, 12948.676283092622, 13010.154339967872, 13031.152975056591, 13034.543790967271, 12638.178518396275, 12738.363081845686, 12795.488180472677, 12913.935430322788, 13088.149270297401, 8979.55102244872, 9268.397554158959, 9281.350305478552, 9283.907160928304, 9284.21084207823, 9898.006720257064, 10028.147607453448, 10034.949825250827, 10038.347507411994, 10119.7470063249, 7961.363090952826, 8411.495310281403, 8561.44350617208, 8600.741977740678, 8816.118388161132, 7848.686052557834, 8054.4361894669155, 8084.514929104273, 8088.797780055545, 8171.42800003994, 7141.714331426685, 7238.420926325986, 7254.165770936199, 7269.345758881726, 7826.608669566613, 5718.971405142947, 5815.738291776965, 5819.0, 5828.708564571839, 5882.441168089024, 5904.143899134516, 5987.0, 5999.70001499932, 6210.223722034746, 6271.0], "value": 4981.695005580126, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [381.47547122706277, 383.8042598274879, 386.36057325126905, 387.40726688167103, 388.1673809678242, 5908.527317814575, 5943.3462319144855, 5945.167676525284, 5992.550558708103, 6008.828278485692, 5634.3520495143075, 5783.479486846183, 5800.82597522074, 5874.118882167677, 5886.852828679285, 4521.299198624219, 4545.295479200713, 4552.52198519154, 4565.680402371843, 4566.70316429431, 4575.473820510634, 4583.8166473341025, 4590.839320623779, 4594.793234304448, 4601.907961840761, 4240.342746874224, 4404.8017839197155, 4459.219636563605, 4555.61277291429, 4559.635229181657, 4389.670774691911, 4417.160739459492, 4417.690761646686, 4429.6899217054815, 4432.867013989586, 3855.8072096395067, 3862.439946207812, 3864.806759662006, 3887.7278590498677, 3890.9688932432928, 5652.660840349592, 5790.3630600634315, 5795.768169273224, 5796.739146738407, 5816.767329306865, 5190.792368305263, 5207.140821764404, 5207.869803254911, 5214.869628259324, 5226.268322434862, 6227.657478838662, 6244.0, 6244.3755624437645, 6268.968655156695, 6273.8745225095245, 4135.1316223592785, 4292.055747735493, 4327.480702315711, 4336.783160841946, 4337.63130133939, 6208.0, 6352.809415717536, 6493.0392460599, 6533.7713180038945, 6559.901601475982, 4273.166732487197, 4281.785910704452, 4288.820574342081, 4301.526832048472, 4333.804978775899, 4469.262571675702, 4469.754163520973, 4475.552444755498, 4476.6418686505, 4486.237339652267, 4805.5972013993005, 4872.317875497433, 5166.095933211673, 5166.147585648326, 5176.352955880515, 6189.319174890758, 6191.133241346215, 6236.345183755731, 6236.469900058546, 6260.311365749764, 1527.1753253243123, 1537.9077255364714, 1537.9769303460457, 1539.2303848075962, 1549.883758718078, 959.712086374085, 1016.3800081950004, 1016.4561959351711, 1020.6172685243034, 1040.15747244732, 5942.762289508458, 5949.0, 5985.401459854067, 6006.708557660124, 6016.458518733335, 6379.776707815204, 6394.424501794768, 6400.23197216337, 6405.839854003594, 6419.358064193637, 5807.303123625107, 5940.0, 5973.163757074013, 5981.7607295707685, 6003.909941350883, 3370.0395387314497, 3380.9323813524084, 3392.2028323343993, 3392.3045775615938, 3411.7441191910707, 6499.707513161919, 6621.867562648817, 6625.602463852184, 6644.335566443317, 6678.799636010927, 6542.24764152119, 6549.639769812706, 6573.0, 6592.80221593353, 6599.208095028627, 6398.6160830351255, 6623.138991931114, 6636.270010298863, 6641.468682505291, 6666.699998500079, 6439.356064393711, 6439.517036222396, 6472.773452929125, 6473.48212143018, 6494.220693516808, 6215.197592698067, 6387.68061596909, 6394.648294343856, 6398.392152745481, 6418.133551970424, 6375.203099612549, 6463.870722585616, 6533.5952770154645, 6681.498887583353, 6741.325867413219, 4293.377460268306, 4309.806058727428, 4311.935320970125, 4314.374415709767, 4321.719088259253, 6362.791069696928, 6519.217693876765, 6519.380658837403, 6522.5760325578685, 6525.347465253437, 6273.9372606273355, 6284.560080794484, 6286.905696414649, 6307.936920630918, 6319.46284565817, 6316.494680425647, 6326.0, 6328.114064030948, 6332.525060620564, 6342.143810585697, 6087.0, 6259.186305780219, 6262.561620686508, 6280.497560195082, 6309.4952403806665, 6325.652089135142, 6327.493800495858, 6329.651869147241, 6333.714982825876, 6337.334579869047, 5914.556408269483, 6091.903457377714, 6097.664628445478, 6140.723667434887, 6161.168242287413], "value": 4705.825130765989, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [758.3175142371865, 771.6373304546863, 771.8070482379405, 779.5829231361223, 805.3557154276581, 14967.401303947843, 15394.076355418669, 15531.84468155318, 17855.0, 18934.43196704101, 17050.317987280527, 17142.82857171428, 17224.655506889856, 17515.91242043788, 17549.0, 927.0451435021904, 945.8723072385243, 949.0841338108723, 949.1505102932871, 949.3402085550545, 924.9306302027342, 935.3172184305461, 949.5537097564134, 958.5782255807458, 959.1415682963743, 1001.4992503748126, 1004.964826231082, 1006.104566935428, 1006.2553710254396, 1007.2294694558668, 993.4536005197149, 996.7358649957768, 997.5211898288862, 997.8453339732353, 999.0708640963901, 725.8983742276085, 730.2551397574445, 730.6383340246559, 731.6122455098806, 732.143392231091, 15949.0, 16115.516534503984, 16297.83702162975, 16374.672506549921, 16480.83519164805, 16118.194090295437, 16238.512844614681, 16339.18304084791, 16387.59031024222, 16705.081220532866, 12441.688957776038, 12654.177478463871, 12796.808047879289, 12971.286579238138, 13072.607821765363, 3112.3152906360565, 3155.8106513609255, 3169.524571314298, 3264.5592844965863, 3274.787138835968, 73565.0, 74990.62504687441, 75716.0, 84130.0, 85625.0, 12335.75328493443, 12676.239425634307, 12836.16564923277, 12925.224486530838, 13084.607461776162, 23750.287491375286, 24005.759942400702, 24096.759032409802, 24199.15302964388, 24254.0, 8272.545010024507, 8313.41806073569, 8319.251267385964, 8344.332453403835, 8461.873071903927, 3940.231654827281, 4042.838286468508, 4043.0903046814233, 4048.0487085534874, 4053.412255222976, 4023.5574086850424, 4181.435506206623, 4437.445319335083, 4483.766964084837, 4501.324801279834, 815.5636734347096, 824.9340052795762, 826.6486743134144, 837.8785076163922, 847.3475423923544, 619.3094699410125, 632.7532262417661, 647.8250872264463, 651.9348065193537, 664.6045602866287, 10617.13337398898, 11291.266067705574, 11325.2072354936, 11403.258788178742, 11752.94123529394, 657.2015001772869, 659.1562799616498, 662.6057495789997, 666.1739443090532, 668.1514476614672, 4669.252919532859, 4963.492079217753, 5012.635854049714, 5032.421271553745, 5042.621803364762, 78068.31590104499, 78716.0, 79417.60291198507, 80285.59857200793, 81010.18989810144, 69741.30258697449, 71773.64113179401, 72505.6374718123, 72813.63593182106, 75938.62030689811, 62625.686871566264, 63307.6834615824, 63360.0, 63943.99999999907, 64613.67693161504, 10074.14369778577, 10164.0, 10314.719391452463, 10457.111145552713, 10459.215558832966, 30275.697243027287, 30975.225619359695, 31370.529442058843, 31615.525767113053, 32600.413954465464, 49760.751196243786, 51934.740326298124, 53050.0, 54247.0, 54251.72874135604, 14099.65205149849, 14328.785068224193, 14723.190224537753, 14760.261986900827, 14900.62748431298, 15683.607909802346, 15973.121478318804, 16051.598710032342, 16977.320907163576, 16977.87776527934, 14957.77563336529, 15116.848831511545, 15238.542843714706, 15408.922955385151, 15417.922910385825, 14136.0, 15087.849121509083, 15107.093574385572, 15165.545033649008, 15221.6194595136, 14239.288035597972, 14864.730554396232, 14904.552863414116, 14989.100653960797, 15042.774358384415, 10715.892841071489, 10781.407022613517, 11348.659540213806, 11355.48900299472, 11365.374904380338, 10290.3825770454, 10893.782640640278, 11859.40702964831, 12204.633860984184, 12297.385130743249], "value": 7668.018033984007, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1513.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 110.0, 109.0, 110.0, 111.0, 111.0, 109.0, 111.0, 109.0, 109.0], "value": 109.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 118.0, 118.0, 155.0, 122.0, 121.0, 120.0, 118.0, 147.0, 120.0], "value": 129.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 166.0, 165.0, 165.0, 163.0, 164.0, 163.0, 164.0, 164.0], "value": 164.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 74.0, 112.0, 75.0, 76.0, 76.0, 74.0, 98.0, 75.0], "value": 80.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 109.0, 85.0, 83.0, 83.0, 98.0, 83.0, 84.0, 110.0], "value": 90.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 115.0, 113.0, 114.0, 114.0, 114.0, 113.0, 113.0], "value": 113.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 149.0, 148.0, 149.0, 149.0, 149.0, 148.0, 148.0, 148.0, 148.0], "value": 148.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 96.0, 94.0, 94.0, 95.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 57.0, 57.0, 57.0, 57.0, 58.0, 57.0, 57.0, 65.0], "value": 57.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 55.0, 55.0, 54.0, 55.0, 55.0, 54.0, 54.0, 56.0], "value": 54.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 80.0, 80.0, 82.0, 83.0, 81.0, 82.0, 80.0, 80.0, 86.0], "value": 82.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 130.0, 136.0, 132.0, 137.0, 126.0, 133.0, 126.0, 178.0, 126.0], "value": 135.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [190.0, 192.0, 183.0, 183.0, 187.0, 184.0, 180.0, 193.0, 191.0, 194.0], "value": 187.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 65.0, 67.0, 70.0, 65.0, 66.0, 64.0, 66.0, 65.0], "value": 66.2, "unit": "score"}]}]} 12:36:07 INFO - Return code: 0 12:36:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:36:07 ERROR - # TBPL SUCCESS # 12:36:07 INFO - Running post-action listener: _resource_record_post_action 12:36:07 INFO - [mozharness: 2017-03-29 19:36:07.188163Z] Finished run-tests step (success) 12:36:07 INFO - Running post-run listener: _resource_record_post_run 12:36:07 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 371163136; Read time: 8; Write time: 193676 12:36:07 INFO - TinderboxPrint: CPU usage
13.0% 12:36:07 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 12:36:07 INFO - TinderboxPrint: I/O write bytes / time
371,163,136 / 193,676 12:36:07 INFO - TinderboxPrint: CPU idle
8,306.6 (87.0%) 12:36:07 INFO - TinderboxPrint: CPU user
1,192.1 (12.5%) 12:36:07 INFO - TinderboxPrint: Swap in / out
0 / 0 12:36:07 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 111112192; Read time: 0; Write time: 56944 12:36:07 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 0; Write bytes: 258924544; Read time: 0; Write time: 136692 12:36:07 INFO - Running post-run listener: _upload_blobber_files 12:36:07 INFO - Blob upload gear active. 12:36:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:36:07 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 12:36:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:36:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:36:08 INFO - (blobuploader) - INFO - Open directory for files ... 12:36:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:36:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:36:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:36:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:36:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:36:08 INFO - (blobuploader) - INFO - Done attempting. 12:36:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 12:36:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:36:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:36:09 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 12:36:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:36:09 INFO - (blobuploader) - INFO - Done attempting. 12:36:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:36:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:36:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:36:13 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:36:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:36:13 INFO - (blobuploader) - INFO - Done attempting. 12:36:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:36:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:36:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:36:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:36:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:36:14 INFO - (blobuploader) - INFO - Done attempting. 12:36:14 INFO - (blobuploader) - INFO - Iteration through files over. 12:36:14 INFO - Return code: 0 12:36:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:36:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:36:14 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0ee79cd70590521991a09dbe985a324d32c894b2c3c6926183673eb6f7a02dc0f51e46439be8f1d9a3ff1f26938e80e41bf4b27dee80f9b4f86d0e9b2eb1f7d1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dc87fe95fecfd63134bf08aa6efd57cda37dd5430abbc4d320f815d031393e0bf3d2fbcdd763bac301e969f29031141488a7633c86658fc9a5f826659dab7787", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fcf959a4a6a396d13d05265938862a647cdd45d9545ef12b106e89ac99d8649b72843b9912d5a7e221982d9d5feb18662f1c093ac2a8f3210932a97464674064", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e05f472745157b26a40213e2d0e296845a6b48d3e77fdc643b11a0f905ff7dd4429608c0452ea252def36dfcb75ba7d833c6c55aea33da5224eac60c386e84ee"} 12:36:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:36:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:36:14 INFO - Contents: 12:36:14 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0ee79cd70590521991a09dbe985a324d32c894b2c3c6926183673eb6f7a02dc0f51e46439be8f1d9a3ff1f26938e80e41bf4b27dee80f9b4f86d0e9b2eb1f7d1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dc87fe95fecfd63134bf08aa6efd57cda37dd5430abbc4d320f815d031393e0bf3d2fbcdd763bac301e969f29031141488a7633c86658fc9a5f826659dab7787", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fcf959a4a6a396d13d05265938862a647cdd45d9545ef12b106e89ac99d8649b72843b9912d5a7e221982d9d5feb18662f1c093ac2a8f3210932a97464674064", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e05f472745157b26a40213e2d0e296845a6b48d3e77fdc643b11a0f905ff7dd4429608c0452ea252def36dfcb75ba7d833c6c55aea33da5224eac60c386e84ee"} 12:36:14 INFO - Running post-run listener: copy_logs_to_upload_dir 12:36:14 INFO - Copying logs to upload dir... 12:36:14 INFO - mkdir: /builds/slave/test/build/upload/logs 12:36:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.674302 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-03-29 12:36:14.095660) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-29 12:36:14.099168) ========= 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=6dbc10da6d83fee962c624be000001a8-1490814917.370061-630035441 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0ee79cd70590521991a09dbe985a324d32c894b2c3c6926183673eb6f7a02dc0f51e46439be8f1d9a3ff1f26938e80e41bf4b27dee80f9b4f86d0e9b2eb1f7d1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dc87fe95fecfd63134bf08aa6efd57cda37dd5430abbc4d320f815d031393e0bf3d2fbcdd763bac301e969f29031141488a7633c86658fc9a5f826659dab7787", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fcf959a4a6a396d13d05265938862a647cdd45d9545ef12b106e89ac99d8649b72843b9912d5a7e221982d9d5feb18662f1c093ac2a8f3210932a97464674064", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e05f472745157b26a40213e2d0e296845a6b48d3e77fdc643b11a0f905ff7dd4429608c0452ea252def36dfcb75ba7d833c6c55aea33da5224eac60c386e84ee"} build_url:https://queue.taskcluster.net/v1/task/XzVzjrAsQiiK3FdmaqdoHQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011493 build_url: 'https://queue.taskcluster.net/v1/task/XzVzjrAsQiiK3FdmaqdoHQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0ee79cd70590521991a09dbe985a324d32c894b2c3c6926183673eb6f7a02dc0f51e46439be8f1d9a3ff1f26938e80e41bf4b27dee80f9b4f86d0e9b2eb1f7d1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dc87fe95fecfd63134bf08aa6efd57cda37dd5430abbc4d320f815d031393e0bf3d2fbcdd763bac301e969f29031141488a7633c86658fc9a5f826659dab7787", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fcf959a4a6a396d13d05265938862a647cdd45d9545ef12b106e89ac99d8649b72843b9912d5a7e221982d9d5feb18662f1c093ac2a8f3210932a97464674064", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e05f472745157b26a40213e2d0e296845a6b48d3e77fdc643b11a0f905ff7dd4429608c0452ea252def36dfcb75ba7d833c6c55aea33da5224eac60c386e84ee"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-29 12:36:14.128347) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 12:36:14.128674) ========= 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=6dbc10da6d83fee962c624be000001a8-1490814917.370061-630035441 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004428 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 12:36:14.210357) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-29 12:36:14.210673) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-29 12:36:14.210992) ========= ========= Total master_lag: 0.16 =========