builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-050 starttime: 1490652929.43 results: success (0) revision: a6f35285bd1e674553527873614c55e0b7366bdb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-27 15:15:29.427359) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-27 15:15:29.427836) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-27 15:15:29.428119) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-27 15:15:29.442860) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-27 15:15:29.443212) ========= 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-1490652929.223524-888603613 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-27 15:15:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.2M=0s 2017-03-27 15:15:30 (46.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.137732 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-27 15:15:29.595223) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-27 15:15:29.595560) ========= 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-1490652929.223524-888603613 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018367 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-27 15:15:29.644602) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-27 15:15:29.644953) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev a6f35285bd1e674553527873614c55e0b7366bdb --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 a6f35285bd1e674553527873614c55e0b7366bdb --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-1490652929.223524-888603613 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-27 15:15:30,139 truncating revision to first 12 chars 2017-03-27 15:15:30,139 Setting DEBUG logging. 2017-03-27 15:15:30,139 attempt 1/10 2017-03-27 15:15:30,139 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/a6f35285bd1e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-27 15:15:31,609 unpacking tar archive at: mozilla-central-a6f35285bd1e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.744073 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-27 15:15:31.402491) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-27 15:15:31.402830) ========= script_repo_revision: a6f35285bd1e674553527873614c55e0b7366bdb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-27 15:15:31.403246) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-27 15:15:31.403522) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-27 15:15:31.411958) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-03-27 15:15:31.412232) ========= /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-1490652929.223524-888603613 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:15:31 INFO - MultiFileLogger online at 20170327 15:15:31 in /builds/slave/test 15:15:31 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 15:15:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:15:32 INFO - {'append_to_log': False, 15:15:32 INFO - 'base_work_dir': '/builds/slave/test', 15:15:32 INFO - 'blob_upload_branch': 'Firefox', 15:15:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:15:32 INFO - 'branch': 'Firefox', 15:15:32 INFO - 'buildbot_json_path': 'buildprops.json', 15:15:32 INFO - 'config_files': ('talos/linux_config.py',), 15:15:32 INFO - 'default_actions': ('clobber', 15:15:32 INFO - 'read-buildbot-config', 15:15:32 INFO - 'download-and-extract', 15:15:32 INFO - 'populate-webroot', 15:15:32 INFO - 'create-virtualenv', 15:15:32 INFO - 'install', 15:15:32 INFO - 'run-tests'), 15:15:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:15:32 INFO - 'download_minidump_stackwalk': True, 15:15:32 INFO - 'download_symbols': 'ondemand', 15:15:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:15:32 INFO - 'tooltool.py': '/tools/tooltool.py', 15:15:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:15:32 INFO - '/tools/misc-python/virtualenv.py')}, 15:15:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:15:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:15:32 INFO - 'gecko_profile': False, 15:15:32 INFO - 'gecko_profile_interval': 0, 15:15:32 INFO - 'installer_path': 'installer.exe', 15:15:32 INFO - 'log_level': 'info', 15:15:32 INFO - 'log_name': 'talos', 15:15:32 INFO - 'log_to_console': True, 15:15:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:15:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:15:32 INFO - 'opt_config_files': (), 15:15:32 INFO - 'pip_index': False, 15:15:32 INFO - 'suite': 'dromaeojs', 15:15:32 INFO - 'system_bits': '32', 15:15:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:15:32 INFO - 'title': 'talos-linux64-ix-050', 15:15:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:15:32 INFO - 'use_talos_json': True, 15:15:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:15:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:15:32 INFO - 'work_dir': 'build'} 15:15:32 INFO - [mozharness: 2017-03-27 22:15:32.009867Z] Running clobber step. 15:15:32 INFO - Running pre-action listener: _resource_record_pre_action 15:15:32 INFO - Running main action method: clobber 15:15:32 INFO - rmtree: /builds/slave/test/build 15:15:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:15:33 INFO - Running post-action listener: _resource_record_post_action 15:15:33 INFO - [mozharness: 2017-03-27 22:15:33.503067Z] Finished clobber step (success) 15:15:33 INFO - [mozharness: 2017-03-27 22:15:33.503448Z] Running read-buildbot-config step. 15:15:33 INFO - Running pre-action listener: _resource_record_pre_action 15:15:33 INFO - Running main action method: read_buildbot_config 15:15:33 INFO - Using buildbot properties: 15:15:33 INFO - { 15:15:33 INFO - "project": "", 15:15:33 INFO - "product": "firefox", 15:15:33 INFO - "who": "kwierso@gmail.com", 15:15:33 INFO - "installer_path": "public/build/target.tar.bz2", 15:15:33 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 15:15:33 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 15:15:33 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 15:15:33 INFO - "stage_platform": "linux64-pgo", 15:15:33 INFO - "basedir": "/builds/slave/test", 15:15:33 INFO - "buildnumber": 112, 15:15:33 INFO - "platform": "ubuntu64_hw", 15:15:33 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 15:15:33 INFO - "slavebuilddir": "test", 15:15:33 INFO - "taskId": "SXK8MtkbSO-yq84EuyHX3Q", 15:15:33 INFO - "branch": "mozilla-central", 15:15:33 INFO - "script_repo_revision": "production", 15:15:33 INFO - "revision": "a6f35285bd1e674553527873614c55e0b7366bdb", 15:15:33 INFO - "slavename": "talos-linux64-ix-050", 15:15:33 INFO - "repo_path": "mozilla-central" 15:15:33 INFO - } 15:15:33 INFO - Finding installer, test and symbols from parent task. 15:15:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SXK8MtkbSO-yq84EuyHX3Q'}, attempt #1 15:15:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SXK8MtkbSO-yq84EuyHX3Q'}, attempt #1 15:15:34 INFO - Task dependencies: aZV0mLiPQcOUxtDC_aGQpQ 15:15:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aZV0mLiPQcOUxtDC_aGQpQ'}, attempt #1 15:15:34 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/aZV0mLiPQcOUxtDC_aGQpQ/artifacts/public/build/target.tar.bz2 15:15:34 INFO - Set test_url: https://queue.taskcluster.net/v1/task/aZV0mLiPQcOUxtDC_aGQpQ/artifacts/public/build/test_packages.json 15:15:34 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/aZV0mLiPQcOUxtDC_aGQpQ/artifacts/public/build/target.crashreporter-symbols.zip 15:15:34 INFO - Running post-action listener: _resource_record_post_action 15:15:34 INFO - [mozharness: 2017-03-27 22:15:34.968276Z] Finished read-buildbot-config step (success) 15:15:34 INFO - [mozharness: 2017-03-27 22:15:34.968492Z] Running download-and-extract step. 15:15:34 INFO - Running pre-action listener: _resource_record_pre_action 15:15:34 INFO - Running main action method: download_and_extract 15:15:34 INFO - mkdir: /builds/slave/test/build/tests 15:15:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:15:34 INFO - trying https://queue.taskcluster.net/v1/task/aZV0mLiPQcOUxtDC_aGQpQ/artifacts/public/build/target.test_packages.json 15:15:34 INFO - Downloading https://queue.taskcluster.net/v1/task/aZV0mLiPQcOUxtDC_aGQpQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 15:15:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aZV0mLiPQcOUxtDC_aGQpQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 15:15:35 INFO - Downloaded 986 bytes. 15:15:35 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 15:15:35 INFO - Using the following test package requirements: 15:15:35 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 15:15:35 INFO - u'common': [u'target.common.tests.zip'], 15:15:35 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 15:15:35 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 15:15:35 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 15:15:35 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 15:15:35 INFO - u'mozbase': [u'target.common.tests.zip'], 15:15:35 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 15:15:35 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 15:15:35 INFO - u'web-platform': [u'target.common.tests.zip', 15:15:35 INFO - u'target.web-platform.tests.zip'], 15:15:35 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 15:15:35 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 15:15:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aZV0mLiPQcOUxtDC_aGQpQ/artifacts/public/build/target.common.tests.zip 15:15:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aZV0mLiPQcOUxtDC_aGQpQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:15:35 INFO - Fetch https://queue.taskcluster.net/v1/task/aZV0mLiPQcOUxtDC_aGQpQ/artifacts/public/build/target.common.tests.zip into memory 15:15:36 INFO - Expected file size: 60255476 15:15:36 INFO - Obtained file size: 60255476 15:15:46 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 15:15:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aZV0mLiPQcOUxtDC_aGQpQ/artifacts/public/build/target.common.tests.zip 15:15:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aZV0mLiPQcOUxtDC_aGQpQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:15:46 INFO - Fetch https://queue.taskcluster.net/v1/task/aZV0mLiPQcOUxtDC_aGQpQ/artifacts/public/build/target.common.tests.zip into memory 15:15:47 INFO - Expected file size: 60255476 15:15:47 INFO - Obtained file size: 60255476 15:15:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aZV0mLiPQcOUxtDC_aGQpQ/artifacts/public/build/target.talos.tests.zip 15:15:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aZV0mLiPQcOUxtDC_aGQpQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 15:15:58 INFO - Fetch https://queue.taskcluster.net/v1/task/aZV0mLiPQcOUxtDC_aGQpQ/artifacts/public/build/target.talos.tests.zip into memory 15:15:59 INFO - Expected file size: 14404171 15:15:59 INFO - Obtained file size: 14404171 15: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')]} 15:15:59 INFO - trying https://queue.taskcluster.net/v1/task/aZV0mLiPQcOUxtDC_aGQpQ/artifacts/public/build/target.tar.bz2 15:15:59 INFO - Downloading https://queue.taskcluster.net/v1/task/aZV0mLiPQcOUxtDC_aGQpQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 15:15:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aZV0mLiPQcOUxtDC_aGQpQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 15:16:00 INFO - Downloaded 68102918 bytes. 15:16:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aZV0mLiPQcOUxtDC_aGQpQ/artifacts/public/build/target.tar.bz2 15:16:00 INFO - mkdir: /builds/slave/test/properties 15:16:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:16:00 INFO - Writing to file /builds/slave/test/properties/build_url 15:16:00 INFO - Contents: 15:16:00 INFO - build_url:https://queue.taskcluster.net/v1/task/aZV0mLiPQcOUxtDC_aGQpQ/artifacts/public/build/target.tar.bz2 15:16:00 INFO - Running post-action listener: _resource_record_post_action 15:16:00 INFO - Running post-action listener: set_extra_try_arguments 15:16:00 INFO - [mozharness: 2017-03-27 22:16:00.840247Z] Finished download-and-extract step (success) 15:16:00 INFO - [mozharness: 2017-03-27 22:16:00.840344Z] Running populate-webroot step. 15:16:00 INFO - Running pre-action listener: _resource_record_pre_action 15:16:00 INFO - Running main action method: populate_webroot 15:16:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:16:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:16:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:16:00 INFO - '--tppagecycles', 15:16:00 INFO - '7'], 15:16:00 INFO - 'tests': ['tsvgm']}}, 15:16:00 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:16:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:16:00 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:16:00 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:16:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:16:00 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:16:00 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 15:16:00 INFO - 'talos_options': ['--disable-e10s'], 15:16:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:16:00 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:16:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:16:00 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 15:16:00 INFO - 'talos_options': ['--disable-e10s'], 15:16:00 INFO - 'tests': ['damp', 'tps']}, 15:16:00 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:16:00 INFO - 'tests': ['damp', 'tps']}, 15:16:00 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:16:00 INFO - 'tests': ['dromaeo_dom']}, 15:16:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:16:00 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:16:00 INFO - 'tests': ['basic_compositor_video']}, 15:16:00 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:16:00 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:16:00 INFO - 'tests': ['a11yr', 15:16:00 INFO - 'ts_paint', 15:16:00 INFO - 'tpaint', 15:16:00 INFO - 'sessionrestore', 15:16:00 INFO - 'sessionrestore_no_auto_restore', 15:16:00 INFO - 'tabpaint']}, 15:16:00 INFO - 'other-e10s': {'tests': ['a11yr', 15:16:00 INFO - 'ts_paint', 15:16:00 INFO - 'tpaint', 15:16:00 INFO - 'sessionrestore', 15:16:00 INFO - 'sessionrestore_no_auto_restore', 15:16:00 INFO - 'tabpaint']}, 15:16:00 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:16:00 INFO - 'ts_paint', 15:16:00 INFO - 'tpaint', 15:16:00 INFO - 'sessionrestore', 15:16:00 INFO - 'sessionrestore_no_auto_restore', 15:16:00 INFO - 'tabpaint']}, 15:16:00 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:16:00 INFO - 'ts_paint', 15:16:00 INFO - 'tpaint', 15:16:00 INFO - 'sessionrestore', 15:16:00 INFO - 'sessionrestore_no_auto_restore', 15:16:00 INFO - 'tabpaint']}, 15:16:00 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:16:00 INFO - 'tests': ['a11yr', 15:16:00 INFO - 'ts_paint', 15:16:00 INFO - 'tpaint', 15:16:00 INFO - 'sessionrestore', 15:16:00 INFO - 'sessionrestore_no_auto_restore', 15:16:00 INFO - 'tabpaint']}, 15:16:00 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:16:00 INFO - 'tests': ['a11yr', 15:16:00 INFO - 'ts_paint', 15:16:00 INFO - 'tpaint', 15:16:00 INFO - 'sessionrestore', 15:16:00 INFO - 'sessionrestore_no_auto_restore', 15:16:00 INFO - 'tabpaint']}, 15:16:00 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:16:00 INFO - 'tests': ['tsvgx', 15:16:00 INFO - 'tsvgr_opacity', 15:16:00 INFO - 'tart', 15:16:00 INFO - 'tscrollx', 15:16:00 INFO - 'cart', 15:16:00 INFO - 'tsvg_static']}, 15:16:00 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:16:00 INFO - 'tsvgr_opacity', 15:16:00 INFO - 'tart', 15:16:00 INFO - 'tscrollx', 15:16:00 INFO - 'cart', 15:16:00 INFO - 'tsvg_static']}, 15:16:00 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 15:16:00 INFO - 'talos_options': ['--disable-e10s'], 15:16:00 INFO - 'tests': ['tp5o']}, 15:16:00 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:16:00 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 15:16:00 INFO - 'talos_options': ['--disable-e10s', 15:16:00 INFO - '--xperf_path', 15:16:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:16:00 INFO - 'tests': ['tp5n']}, 15:16:00 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:16:00 INFO - 'talos_options': ['--xperf_path', 15:16:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:16:00 INFO - 'tests': ['tp5n']}}, 15:16:00 INFO - 'talos.zip': {'path': '', 15:16:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:16:00 INFO - Running post-action listener: _resource_record_post_action 15:16:00 INFO - [mozharness: 2017-03-27 22:16:00.853444Z] Finished populate-webroot step (success) 15:16:00 INFO - [mozharness: 2017-03-27 22:16:00.853535Z] Running create-virtualenv step. 15:16:00 INFO - Running pre-action listener: _resource_record_pre_action 15:16:00 INFO - Running main action method: create_virtualenv 15:16:00 INFO - Creating virtualenv /builds/slave/test/build/venv 15:16:00 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 15:16:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:16:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:16:00 INFO - Using real prefix '/usr' 15:16:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:16:01 INFO - Installing distribute.............................................................................................................................................................................................done. 15:16:03 INFO - Installing pip.................done. 15:16:03 INFO - Return code: 0 15:16:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:16:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:16:03 INFO - Reading from file tmpfile_stdout 15:16:03 INFO - Output received: 15:16:03 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) 15:16:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15: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')]} 15:16:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:16:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15: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')]} 15:16:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:16:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:03 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 0xd7b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1019310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1016400>, '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 0x10173b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1017840>, '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-1490652929.223524-888603613', '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 15:16:03 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 15:16:03 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 15:16:03 INFO - Using env: {'DISPLAY': ':0', 15:16:03 INFO - 'HOME': '/home/cltbld', 15:16:03 INFO - 'LANG': 'en_US.UTF-8', 15:16:03 INFO - 'LANGUAGE': 'en_US:en', 15:16:03 INFO - 'LOGNAME': 'cltbld', 15:16:03 INFO - 'MAIL': '/var/mail/cltbld', 15:16:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:16:03 INFO - 'MOZ_NO_REMOTE': '1', 15:16:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:16:03 INFO - 'NO_EM_RESTART': '1', 15:16:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:16:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:16:03 INFO - 'PWD': '/builds/slave/test', 15:16:03 INFO - 'SHELL': '/bin/bash', 15:16:03 INFO - 'SHLVL': '1', 15:16:03 INFO - 'TERM': 'linux', 15:16:03 INFO - 'TMOUT': '86400', 15:16:03 INFO - 'USER': 'cltbld', 15:16:03 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1490652929.223524-888603613', 15:16:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:16:03 INFO - '_': '/tools/buildbot/bin/python'} 15:16:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:16:03 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 15:16:03 INFO - Cleaning up... 15:16:03 INFO - Return code: 0 15:16:03 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15: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')]} 15:16:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:16:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15: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')]} 15:16:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:16:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:03 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 0xd7b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1019310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1016400>, '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 0x10173b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1017840>, '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-1490652929.223524-888603613', '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 15:16:03 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 15:16:03 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 15:16:03 INFO - Using env: {'DISPLAY': ':0', 15:16:03 INFO - 'HOME': '/home/cltbld', 15:16:03 INFO - 'LANG': 'en_US.UTF-8', 15:16:03 INFO - 'LANGUAGE': 'en_US:en', 15:16:03 INFO - 'LOGNAME': 'cltbld', 15:16:03 INFO - 'MAIL': '/var/mail/cltbld', 15:16:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:16:03 INFO - 'MOZ_NO_REMOTE': '1', 15:16:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:16:03 INFO - 'NO_EM_RESTART': '1', 15:16:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:16:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:16:03 INFO - 'PWD': '/builds/slave/test', 15:16:03 INFO - 'SHELL': '/bin/bash', 15:16:03 INFO - 'SHLVL': '1', 15:16:03 INFO - 'TERM': 'linux', 15:16:03 INFO - 'TMOUT': '86400', 15:16:03 INFO - 'USER': 'cltbld', 15:16:03 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1490652929.223524-888603613', 15:16:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:16:03 INFO - '_': '/tools/buildbot/bin/python'} 15:16:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:16:04 INFO - Downloading/unpacking psutil>=3.1.1 15:16:04 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 15:16:04 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 15:16:04 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 15:16:04 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 15:16:04 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 15:16:04 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 15:16:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:16:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:16:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:16:06 INFO - Installing collected packages: psutil 15:16:06 INFO - Running setup.py install for psutil 15:16:06 INFO - building 'psutil._psutil_linux' extension 15:16:06 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 15:16:06 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 15:16:06 INFO - building 'psutil._psutil_posix' extension 15:16:06 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 15:16:06 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 15:16:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:16:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:16:06 INFO - Successfully installed psutil 15:16:06 INFO - Cleaning up... 15:16:06 INFO - Return code: 0 15:16:06 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15: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')]} 15:16:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:16:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15: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')]} 15:16:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:16:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd7b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1019310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1016400>, '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 0x10173b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1017840>, '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-1490652929.223524-888603613', '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 15:16:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:16:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:16:06 INFO - Using env: {'DISPLAY': ':0', 15:16:06 INFO - 'HOME': '/home/cltbld', 15:16:06 INFO - 'LANG': 'en_US.UTF-8', 15:16:06 INFO - 'LANGUAGE': 'en_US:en', 15:16:06 INFO - 'LOGNAME': 'cltbld', 15:16:06 INFO - 'MAIL': '/var/mail/cltbld', 15:16:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:16:06 INFO - 'MOZ_NO_REMOTE': '1', 15:16:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:16:06 INFO - 'NO_EM_RESTART': '1', 15:16:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:16:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:16:06 INFO - 'PWD': '/builds/slave/test', 15:16:06 INFO - 'SHELL': '/bin/bash', 15:16:06 INFO - 'SHLVL': '1', 15:16:06 INFO - 'TERM': 'linux', 15:16:06 INFO - 'TMOUT': '86400', 15:16:06 INFO - 'USER': 'cltbld', 15:16:06 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1490652929.223524-888603613', 15:16:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:16:06 INFO - '_': '/tools/buildbot/bin/python'} 15:16:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:16:07 INFO - Downloading/unpacking mozsystemmonitor==0.3 15: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 15: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 15: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 15: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 15: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 15: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 15:16:09 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:16:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:16:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:16:09 INFO - Installing collected packages: mozsystemmonitor 15:16:09 INFO - Running setup.py install for mozsystemmonitor 15:16:09 INFO - Successfully installed mozsystemmonitor 15:16:09 INFO - Cleaning up... 15:16:09 INFO - Return code: 0 15:16:09 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:16:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:16:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:16:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:16:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:16:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xd7b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1019310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1016400>, '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 0x10173b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1017840>, '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-1490652929.223524-888603613', '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 15:16:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:16:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:16:09 INFO - Using env: {'DISPLAY': ':0', 15:16:09 INFO - 'HOME': '/home/cltbld', 15:16:09 INFO - 'LANG': 'en_US.UTF-8', 15:16:09 INFO - 'LANGUAGE': 'en_US:en', 15:16:09 INFO - 'LOGNAME': 'cltbld', 15:16:09 INFO - 'MAIL': '/var/mail/cltbld', 15:16:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:16:09 INFO - 'MOZ_NO_REMOTE': '1', 15:16:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:16:09 INFO - 'NO_EM_RESTART': '1', 15:16:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:16:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:16:09 INFO - 'PWD': '/builds/slave/test', 15:16:09 INFO - 'SHELL': '/bin/bash', 15:16:09 INFO - 'SHLVL': '1', 15:16:09 INFO - 'TERM': 'linux', 15:16:09 INFO - 'TMOUT': '86400', 15:16:09 INFO - 'USER': 'cltbld', 15:16:09 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1490652929.223524-888603613', 15:16:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:16:09 INFO - '_': '/tools/buildbot/bin/python'} 15:16:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:16:09 INFO - Downloading/unpacking jsonschema==2.5.1 15:16:09 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 15:16:09 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 15:16:09 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 15:16:09 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 15:16:09 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 15:16:09 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 15:16:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:16:11 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:16:11 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 15:16:11 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 15:16:11 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 15:16:11 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 15:16:11 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 15:16:11 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 15:16:11 INFO - Downloading functools32-3.2.3-2.tar.gz 15:16:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:16:11 INFO - warning: no files found matching '*.txt' 15:16:11 INFO - no previously-included directories found matching 'build' 15:16:11 INFO - no previously-included directories found matching 'dist' 15:16:11 INFO - no previously-included directories found matching '.git*' 15:16:11 INFO - Installing collected packages: jsonschema, functools32 15:16:11 INFO - Running setup.py install for functools32 15:16:11 INFO - warning: no files found matching '*.txt' 15:16:11 INFO - no previously-included directories found matching 'build' 15:16:11 INFO - no previously-included directories found matching 'dist' 15:16:11 INFO - no previously-included directories found matching '.git*' 15:16:11 INFO - Successfully installed jsonschema functools32 15:16:11 INFO - Cleaning up... 15:16:11 INFO - Return code: 0 15:16:11 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:16:11 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')]} 15:16:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:16:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:11 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')]} 15:16:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:16:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xd7b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1019310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1016400>, '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 0x10173b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1017840>, '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-1490652929.223524-888603613', '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 15:16:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:16:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 15:16:12 INFO - Using env: {'DISPLAY': ':0', 15:16:12 INFO - 'HOME': '/home/cltbld', 15:16:12 INFO - 'LANG': 'en_US.UTF-8', 15:16:12 INFO - 'LANGUAGE': 'en_US:en', 15:16:12 INFO - 'LOGNAME': 'cltbld', 15:16:12 INFO - 'MAIL': '/var/mail/cltbld', 15:16:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:16:12 INFO - 'MOZ_NO_REMOTE': '1', 15:16:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:16:12 INFO - 'NO_EM_RESTART': '1', 15:16:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:16:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:16:12 INFO - 'PWD': '/builds/slave/test', 15:16:12 INFO - 'SHELL': '/bin/bash', 15:16:12 INFO - 'SHLVL': '1', 15:16:12 INFO - 'TERM': 'linux', 15:16:12 INFO - 'TMOUT': '86400', 15:16:12 INFO - 'USER': 'cltbld', 15:16:12 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1490652929.223524-888603613', 15:16:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:16:12 INFO - '_': '/tools/buildbot/bin/python'} 15:16:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:16:12 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:16:12 INFO - Cleaning up... 15:16:12 INFO - Return code: 0 15:16:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:16:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:16:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:16:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:16:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:16:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xd7b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1019310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1016400>, '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 0x10173b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1017840>, '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-1490652929.223524-888603613', '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 15:16:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:16:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:16:12 INFO - Using env: {'DISPLAY': ':0', 15:16:12 INFO - 'HOME': '/home/cltbld', 15:16:12 INFO - 'LANG': 'en_US.UTF-8', 15:16:12 INFO - 'LANGUAGE': 'en_US:en', 15:16:12 INFO - 'LOGNAME': 'cltbld', 15:16:12 INFO - 'MAIL': '/var/mail/cltbld', 15:16:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:16:12 INFO - 'MOZ_NO_REMOTE': '1', 15:16:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:16:12 INFO - 'NO_EM_RESTART': '1', 15:16:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:16:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:16:12 INFO - 'PWD': '/builds/slave/test', 15:16:12 INFO - 'SHELL': '/bin/bash', 15:16:12 INFO - 'SHLVL': '1', 15:16:12 INFO - 'TERM': 'linux', 15:16:12 INFO - 'TMOUT': '86400', 15:16:12 INFO - 'USER': 'cltbld', 15:16:12 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1490652929.223524-888603613', 15:16:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:16:12 INFO - '_': '/tools/buildbot/bin/python'} 15:16:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:16:12 INFO - Downloading/unpacking blobuploader==1.2.4 15:16:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:16:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:16:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:16:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:16:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:16:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:16:15 INFO - Downloading blobuploader-1.2.4.tar.gz 15:16:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:16:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:16:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:16:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:16:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:16:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:16:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:16:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:16:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:16:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:16:16 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 15:16:16 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 15:16:16 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 15:16:16 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 15:16:16 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 15:16:16 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 15:16:16 INFO - Downloading docopt-0.6.1.tar.gz 15:16:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:16:16 INFO - Installing collected packages: blobuploader, requests, docopt 15:16:16 INFO - Running setup.py install for blobuploader 15:16:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:16:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:16:16 INFO - Running setup.py install for requests 15:16:17 INFO - Running setup.py install for docopt 15:16:17 INFO - Successfully installed blobuploader requests docopt 15:16:17 INFO - Cleaning up... 15:16:17 INFO - Return code: 0 15:16:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:16:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:16:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:16:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:16:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:16:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:17 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 0xd7b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1019310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1016400>, '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 0x10173b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1017840>, '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-1490652929.223524-888603613', '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 15:16:17 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 15:16:17 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 15:16:17 INFO - Using env: {'DISPLAY': ':0', 15:16:17 INFO - 'HOME': '/home/cltbld', 15:16:17 INFO - 'LANG': 'en_US.UTF-8', 15:16:17 INFO - 'LANGUAGE': 'en_US:en', 15:16:17 INFO - 'LOGNAME': 'cltbld', 15:16:17 INFO - 'MAIL': '/var/mail/cltbld', 15:16:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:16:17 INFO - 'MOZ_NO_REMOTE': '1', 15:16:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:16:17 INFO - 'NO_EM_RESTART': '1', 15:16:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:16:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:16:17 INFO - 'PWD': '/builds/slave/test', 15:16:17 INFO - 'SHELL': '/bin/bash', 15:16:17 INFO - 'SHLVL': '1', 15:16:17 INFO - 'TERM': 'linux', 15:16:17 INFO - 'TMOUT': '86400', 15:16:17 INFO - 'USER': 'cltbld', 15:16:17 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1490652929.223524-888603613', 15:16:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:16:17 INFO - '_': '/tools/buildbot/bin/python'} 15:16:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:16:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:16:17 INFO - Running setup.py (path:/tmp/pip-Iaeg3I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:16:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:16:17 INFO - Running setup.py (path:/tmp/pip-NM3f6L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:16:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:16:17 INFO - Running setup.py (path:/tmp/pip-11KhdG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:16:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:16:17 INFO - Running setup.py (path:/tmp/pip-1pTGmk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:16:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:16:17 INFO - Running setup.py (path:/tmp/pip-EDuqXk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:16:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:16:17 INFO - Running setup.py (path:/tmp/pip-NvPNWB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:16:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:16:17 INFO - Running setup.py (path:/tmp/pip-6qOkZT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:16:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:16:17 INFO - Running setup.py (path:/tmp/pip-c88BKl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:16:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:16:17 INFO - Running setup.py (path:/tmp/pip-EjUhhY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:16:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:16:18 INFO - Running setup.py (path:/tmp/pip-roAj33-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:16:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:16:18 INFO - Running setup.py (path:/tmp/pip-2ltNaj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:16:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:16:18 INFO - Running setup.py (path:/tmp/pip-p1C_Un-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:16:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:16:18 INFO - Running setup.py (path:/tmp/pip-9uLDIS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:16:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:16:18 INFO - Running setup.py (path:/tmp/pip-Xo2RHV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:16:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:16:18 INFO - Running setup.py (path:/tmp/pip-q0rIVT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:16:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:16:18 INFO - Running setup.py (path:/tmp/pip-b8NlLW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:16:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:16:18 INFO - Running setup.py (path:/tmp/pip-lW5AEp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:16:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:16:18 INFO - Running setup.py install for manifestparser 15:16:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:16:18 INFO - Running setup.py install for mozcrash 15:16:18 INFO - Running setup.py install for mozdebug 15:16:18 INFO - Running setup.py install for mozdevice 15:16:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:16:19 INFO - Running setup.py install for mozfile 15:16:19 INFO - Running setup.py install for mozhttpd 15:16:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:16:19 INFO - Running setup.py install for mozinfo 15:16:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:16:19 INFO - Running setup.py install for mozInstall 15:16:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:16:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:16:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:16:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:16:19 INFO - Running setup.py install for mozleak 15:16:19 INFO - Running setup.py install for mozlog 15:16:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:16:19 INFO - Running setup.py install for moznetwork 15:16:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:16:19 INFO - Running setup.py install for mozprocess 15:16:19 INFO - Running setup.py install for mozprofile 15:16:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:16:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:16:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:16:19 INFO - Running setup.py install for mozrunner 15:16:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:16:20 INFO - Running setup.py install for mozscreenshot 15:16:20 INFO - Running setup.py install for moztest 15:16:20 INFO - Running setup.py install for mozversion 15:16:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:16:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:16:20 INFO - Cleaning up... 15:16:20 INFO - Return code: 0 15:16:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:16:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:16:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:16:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:16:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:16:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:20 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 0xd7b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1019310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1016400>, '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 0x10173b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1017840>, '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-1490652929.223524-888603613', '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 15:16:20 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 15:16:20 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 15:16:20 INFO - Using env: {'DISPLAY': ':0', 15:16:20 INFO - 'HOME': '/home/cltbld', 15:16:20 INFO - 'LANG': 'en_US.UTF-8', 15:16:20 INFO - 'LANGUAGE': 'en_US:en', 15:16:20 INFO - 'LOGNAME': 'cltbld', 15:16:20 INFO - 'MAIL': '/var/mail/cltbld', 15:16:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:16:20 INFO - 'MOZ_NO_REMOTE': '1', 15:16:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:16:20 INFO - 'NO_EM_RESTART': '1', 15:16:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:16:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:16:20 INFO - 'PWD': '/builds/slave/test', 15:16:20 INFO - 'SHELL': '/bin/bash', 15:16:20 INFO - 'SHLVL': '1', 15:16:20 INFO - 'TERM': 'linux', 15:16:20 INFO - 'TMOUT': '86400', 15:16:20 INFO - 'USER': 'cltbld', 15:16:20 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1490652929.223524-888603613', 15:16:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:16:20 INFO - '_': '/tools/buildbot/bin/python'} 15:16:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:16:20 INFO - Running setup.py (path:/tmp/pip-B_qSIa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:16:20 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)) 15:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:16:20 INFO - Running setup.py (path:/tmp/pip-1otoDc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:16:20 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)) 15:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:16:20 INFO - Running setup.py (path:/tmp/pip-cMp8ni-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:16:20 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)) 15:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:16:20 INFO - Running setup.py (path:/tmp/pip-fJGmsv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:16:20 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)) 15:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:16:20 INFO - Running setup.py (path:/tmp/pip-zf3eJy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:16:21 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)) 15:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:16:21 INFO - Running setup.py (path:/tmp/pip-UwM8YI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:16:21 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)) 15:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:16:21 INFO - Running setup.py (path:/tmp/pip-pYHJ2Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:16:21 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)) 15:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:16:21 INFO - Running setup.py (path:/tmp/pip-qYHvyJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:16:21 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)) 15:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:16:21 INFO - Running setup.py (path:/tmp/pip-yGD5t1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:16:21 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)) 15:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:16:21 INFO - Running setup.py (path:/tmp/pip-2zR7su-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:16:21 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)) 15:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:16:21 INFO - Running setup.py (path:/tmp/pip-0o0UkA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:16:21 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)) 15:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:16:21 INFO - Running setup.py (path:/tmp/pip-9n6lY4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:16:21 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)) 15:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:16:21 INFO - Running setup.py (path:/tmp/pip-XIs08a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:16:21 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)) 15:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:16:21 INFO - Running setup.py (path:/tmp/pip-ymzbc8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:16:21 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)) 15:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:16:21 INFO - Running setup.py (path:/tmp/pip-jh8PIa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:16:21 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)) 15:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:16:21 INFO - Running setup.py (path:/tmp/pip-j7iir_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:16:21 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)) 15:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:16:21 INFO - Running setup.py (path:/tmp/pip-PYLfde-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:16:21 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)) 15:16:21 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)) 15:16:21 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)) 15:16:21 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)) 15:16:21 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)) 15:16:21 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)) 15:16:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:16:21 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 15:16:21 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 15:16:21 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 15:16:21 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 15:16:21 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 15:16:21 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 15:16:24 INFO - Downloading blessings-1.6.tar.gz 15:16:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:16:24 INFO - Installing collected packages: blessings 15:16:24 INFO - Running setup.py install for blessings 15:16:24 INFO - Successfully installed blessings 15:16:24 INFO - Cleaning up... 15:16:24 INFO - Return code: 0 15:16:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:16:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:16:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:16:25 INFO - Reading from file tmpfile_stdout 15:16:25 INFO - Current package versions: 15:16:25 INFO - argparse == 1.2.1 15:16:25 INFO - blessings == 1.6 15:16:25 INFO - blobuploader == 1.2.4 15:16:25 INFO - docopt == 0.6.1 15:16:25 INFO - functools32 == 3.2.3-2 15:16:25 INFO - jsonschema == 2.5.1 15:16:25 INFO - manifestparser == 1.1 15:16:25 INFO - mozInstall == 1.12 15:16:25 INFO - mozcrash == 1.0 15:16:25 INFO - mozdebug == 0.1 15:16:25 INFO - mozdevice == 0.49 15:16:25 INFO - mozfile == 1.2 15:16:25 INFO - mozhttpd == 0.7 15:16:25 INFO - mozinfo == 0.9 15:16:25 INFO - mozleak == 0.1 15:16:25 INFO - mozlog == 3.4 15:16:25 INFO - moznetwork == 0.27 15:16:25 INFO - mozprocess == 0.25 15:16:25 INFO - mozprofile == 0.28 15:16:25 INFO - mozrunner == 6.13 15:16:25 INFO - mozscreenshot == 0.1 15:16:25 INFO - mozsystemmonitor == 0.3 15:16:25 INFO - moztest == 0.8 15:16:25 INFO - mozversion == 1.4 15:16:25 INFO - psutil == 3.1.1 15:16:25 INFO - requests == 1.2.3 15:16:25 INFO - wsgiref == 0.1.2 15:16:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:16:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:16:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:16:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:16:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:16:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:25 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 0xd7b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1019310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1016400>, '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 0x10173b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1017840>, '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-1490652929.223524-888603613', '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 15:16:25 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 15:16:25 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 15:16:25 INFO - Using env: {'DISPLAY': ':0', 15:16:25 INFO - 'HOME': '/home/cltbld', 15:16:25 INFO - 'LANG': 'en_US.UTF-8', 15:16:25 INFO - 'LANGUAGE': 'en_US:en', 15:16:25 INFO - 'LOGNAME': 'cltbld', 15:16:25 INFO - 'MAIL': '/var/mail/cltbld', 15:16:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:16:25 INFO - 'MOZ_NO_REMOTE': '1', 15:16:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:16:25 INFO - 'NO_EM_RESTART': '1', 15:16:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:16:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:16:25 INFO - 'PWD': '/builds/slave/test', 15:16:25 INFO - 'SHELL': '/bin/bash', 15:16:25 INFO - 'SHLVL': '1', 15:16:25 INFO - 'TERM': 'linux', 15:16:25 INFO - 'TMOUT': '86400', 15:16:25 INFO - 'USER': 'cltbld', 15:16:25 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1490652929.223524-888603613', 15:16:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:16:25 INFO - '_': '/tools/buildbot/bin/python'} 15:16:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:16:25 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)) 15:16:25 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)) 15:16:25 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)) 15:16:25 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)) 15:16:25 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)) 15:16:25 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)) 15:16:25 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)) 15:16:25 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)) 15:16:25 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)) 15:16:25 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)) 15:16:25 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)) 15:16:25 INFO - Cleaning up... 15:16:25 INFO - Return code: 0 15:16:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:16:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:16:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:16:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:16:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:16:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd7b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1019310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1016400>, '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 0x10173b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1017840>, '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-1490652929.223524-888603613', '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 15:16:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:16:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:16:25 INFO - Using env: {'DISPLAY': ':0', 15:16:25 INFO - 'HOME': '/home/cltbld', 15:16:25 INFO - 'LANG': 'en_US.UTF-8', 15:16:25 INFO - 'LANGUAGE': 'en_US:en', 15:16:25 INFO - 'LOGNAME': 'cltbld', 15:16:25 INFO - 'MAIL': '/var/mail/cltbld', 15:16:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:16:25 INFO - 'MOZ_NO_REMOTE': '1', 15:16:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:16:25 INFO - 'NO_EM_RESTART': '1', 15:16:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:16:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:16:25 INFO - 'PWD': '/builds/slave/test', 15:16:25 INFO - 'SHELL': '/bin/bash', 15:16:25 INFO - 'SHLVL': '1', 15:16:25 INFO - 'TERM': 'linux', 15:16:25 INFO - 'TMOUT': '86400', 15:16:25 INFO - 'USER': 'cltbld', 15:16:25 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1490652929.223524-888603613', 15:16:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:16:25 INFO - '_': '/tools/buildbot/bin/python'} 15:16:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:16:25 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:16:25 INFO - Cleaning up... 15:16:25 INFO - Return code: 0 15:16:25 INFO - Running post-action listener: _resource_record_post_action 15:16:25 INFO - Running post-action listener: _start_resource_monitoring 15:16:25 INFO - Starting resource monitoring. 15:16:25 INFO - [mozharness: 2017-03-27 22:16:25.524317Z] Finished create-virtualenv step (success) 15:16:25 INFO - [mozharness: 2017-03-27 22:16:25.524787Z] Running install step. 15:16:25 INFO - Running pre-action listener: _resource_record_pre_action 15:16:25 INFO - Running main action method: install 15:16:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:16:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:16:25 INFO - Reading from file tmpfile_stdout 15:16:25 INFO - Detecting whether we're running mozinstall >=1.0... 15:16:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:16:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:16:25 INFO - Reading from file tmpfile_stdout 15:16:25 INFO - Output received: 15:16:25 INFO - Usage: mozinstall [options] installer 15:16:25 INFO - Options: 15:16:25 INFO - -h, --help show this help message and exit 15:16:25 INFO - -d DEST, --destination=DEST 15:16:25 INFO - Directory to install application into. [default: 15:16:25 INFO - "/builds/slave/test"] 15:16:25 INFO - --app=APP Application being installed. [default: firefox] 15:16:25 INFO - mkdir: /builds/slave/test/build/application 15:16:25 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'] 15:16:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 15:16:42 INFO - Reading from file tmpfile_stdout 15:16:42 INFO - Output received: 15:16:42 INFO - /builds/slave/test/build/application/firefox/firefox 15:16:42 INFO - Running post-action listener: _resource_record_post_action 15:16:42 INFO - [mozharness: 2017-03-27 22:16:42.767331Z] Finished install step (success) 15:16:42 INFO - [mozharness: 2017-03-27 22:16:42.767606Z] Running run-tests step. 15:16:42 INFO - Running pre-action listener: _resource_record_pre_action 15:16:42 INFO - Running main action method: run_tests 15:16:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:16:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:16:42 INFO - Python 2.7.3 15:16:42 INFO - Return code: 0 15:16:42 INFO - grabbing minidump binary from tooltool 15:16:42 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')]} 15:16:42 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 0x1016400>, '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 0x10173b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1017840>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:16:42 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 15:16:42 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 15:16:42 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 15:16:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:16:42 INFO - Return code: 0 15:16:42 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:16:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:16:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:16:42 INFO - ENV: RUST_BACKTRACE is now 1 15:16:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:16:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:16:42 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/aZV0mLiPQcOUxtDC_aGQpQ/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 15:16:42 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/aZV0mLiPQcOUxtDC_aGQpQ/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 15:16:42 INFO - Using env: {'DISPLAY': ':0', 15:16:42 INFO - 'HOME': '/home/cltbld', 15:16:42 INFO - 'LANG': 'en_US.UTF-8', 15:16:42 INFO - 'LANGUAGE': 'en_US:en', 15:16:42 INFO - 'LOGNAME': 'cltbld', 15:16:42 INFO - 'MAIL': '/var/mail/cltbld', 15:16:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:16:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:16:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:16:42 INFO - 'MOZ_NO_REMOTE': '1', 15:16:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:16:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:16:42 INFO - 'NO_EM_RESTART': '1', 15:16:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:16:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:16:42 INFO - 'PWD': '/builds/slave/test', 15:16:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:16:42 INFO - 'RUST_BACKTRACE': '1', 15:16:42 INFO - 'SHELL': '/bin/bash', 15:16:42 INFO - 'SHLVL': '1', 15:16:42 INFO - 'TERM': 'linux', 15:16:42 INFO - 'TMOUT': '86400', 15:16:42 INFO - 'USER': 'cltbld', 15:16:42 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1490652929.223524-888603613', 15:16:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:16:42 INFO - '_': '/tools/buildbot/bin/python'} 15:16:42 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/aZV0mLiPQcOUxtDC_aGQpQ/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 15:16:43 INFO - mozversion application_buildid: 20170327212148 15:16:43 INFO - mozversion application_changeset: a6f35285bd1e674553527873614c55e0b7366bdb 15:16:43 INFO - mozversion application_display_name: Nightly 15:16:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:16:43 INFO - mozversion application_name: Firefox 15:16:43 INFO - mozversion application_remotingname: firefox 15:16:43 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:16:43 INFO - mozversion application_vendor: Mozilla 15:16:43 INFO - mozversion application_version: 55.0a1 15:16:43 INFO - mozversion platform_buildid: 20170327212148 15:16:43 INFO - mozversion platform_changeset: a6f35285bd1e674553527873614c55e0b7366bdb 15:16:43 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:16:43 INFO - mozversion platform_version: 55.0a1 15:16:43 INFO - using testdate: 1490653003 15:16:43 INFO - actual date: 1490653003 15:16:43 INFO - starting webserver on 'localhost:52395' 15:16:43 INFO - SUITE-START | Running 2 tests 15:16:43 INFO - TEST-START | dromaeo_css 15:16:43 INFO - operating with platform_type : linux_ 15:16:43 INFO - Initialising browser for dromaeo_css test... 15:16:43 INFO - TEST-INFO | started process 5630 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQtIzm0/profile http://localhost:52395/getInfo.html) 15:16:46 INFO - PID 5630 | __metrics Screen width/height:1600/1200 15:16:46 INFO - PID 5630 | colorDepth:24 15:16:46 INFO - PID 5630 | Browser inner width/height: 1024/697 15:16:46 INFO - PID 5630 | __metrics 15:16:47 ERROR - PID 5630 | 1490653007705 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 15:16:47 INFO - PID 5630 | 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" 15:16:47 INFO - PID 5630 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:16:48 INFO - TEST-INFO | 5630: exit 0 15:16:48 INFO - Browser initialized. 15:16:48 INFO - Running cycle 1/1 for dromaeo_css test... 15:16:48 INFO - TEST-INFO | started process 5721 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQtIzm0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:17:00 INFO - PID 5721 | RSS: Main: 144760832 15:17:00 INFO - PID 5721 | 15:20:03 INFO - PID 5721 | Cycle 1(1): loaded http://localhost:52395/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52395/tests/dromaeo/cssquery-ext.html) 15:20:04 INFO - PID 5721 | RSS: Main: 301277184 15:20:04 INFO - PID 5721 | 15:21:50 INFO - PID 5721 | ************************* 15:21:50 INFO - PID 5721 | A coding exception was thrown and uncaught in a Task. 15:21:50 INFO - PID 5721 | 15:21:50 ERROR - PID 5721 | Full message: TypeError: NetworkError when attempting to fetch resource. 15:21:50 INFO - PID 5721 | Full stack: 15:21:50 INFO - PID 5721 | ************************* 15:21:50 INFO - PID 5721 | ************************* 15:21:50 INFO - PID 5721 | A coding exception was thrown and uncaught in a Task. 15:21:50 INFO - PID 5721 | 15:21:50 ERROR - PID 5721 | Full message: TypeError: NetworkError when attempting to fetch resource. 15:21:50 INFO - PID 5721 | Full stack: 15:21:50 INFO - PID 5721 | ************************* 15:21:50 INFO - PID 5721 | ************************* 15:21:50 INFO - PID 5721 | A coding exception was thrown and uncaught in a Task. 15:21:50 INFO - PID 5721 | 15:21:50 ERROR - PID 5721 | Full message: TypeError: NetworkError when attempting to fetch resource. 15:21:50 INFO - PID 5721 | Full stack: 15:21:50 INFO - PID 5721 | ************************* 15:21:50 INFO - PID 5721 | ************************* 15:21:50 INFO - PID 5721 | A coding exception was thrown and uncaught in a Task. 15:21:50 INFO - PID 5721 | 15:21:50 ERROR - PID 5721 | Full message: TypeError: NetworkError when attempting to fetch resource. 15:21:50 INFO - PID 5721 | Full stack: 15:21:50 INFO - PID 5721 | ************************* 15:23:07 INFO - PID 5721 | Cycle 1(1): loaded http://localhost:52395/tests/dromaeo/cssquery-ext.html (next: http://localhost:52395/tests/dromaeo/cssquery-jquery.html) 15:23:07 INFO - PID 5721 | RSS: Main: 232755200 15:23:07 INFO - PID 5721 | 15:26:09 INFO - PID 5721 | Cycle 1(1): loaded http://localhost:52395/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52395/tests/dromaeo/cssquery-mootools.html) 15:26:10 INFO - PID 5721 | RSS: Main: 244092928 15:26:10 INFO - PID 5721 | 15:29:12 INFO - PID 5721 | Cycle 1(1): loaded http://localhost:52395/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52395/tests/dromaeo/cssquery-prototype.html) 15:29:12 INFO - PID 5721 | RSS: Main: 175792128 15:29:12 INFO - PID 5721 | 15:32:15 INFO - PID 5721 | Cycle 1(1): loaded http://localhost:52395/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52395/tests/dromaeo/cssquery-yui.html) 15:32:16 INFO - PID 5721 | RSS: Main: 184754176 15:32:16 INFO - PID 5721 | 15:35:18 INFO - PID 5721 | Cycle 1(1): loaded http://localhost:52395/tests/dromaeo/cssquery-yui.html (next: http://localhost:52395/tests/dromaeo/cssquery-dojo.html) 15:35:18 INFO - PID 5721 | RSS: Main: 283373568 15:35:18 INFO - PID 5721 | 15:35:18 INFO - PID 5721 | __start_tp_report 15:35:18 INFO - PID 5721 | _x_x_mozilla_page_load 15:35:18 INFO - PID 5721 | _x_x_mozilla_page_load_details 15:35:18 INFO - PID 5721 | |i|pagename|runs| 15:35:18 INFO - PID 5721 | |0;dojo.html;3330.067581077298;3376.712979396751;3396.847141878616;3404.0128362774794;3427.880024199152;5630.1554766785;5748.942510574893;5858.7949421770245;5874.88250234995;5917.674527900958;5840.06558950568;5863.882722345561;5891.322497912731;5933.85165370866;5950.9107363389585;5134.1528647773075;5178.352705911761;5201.297824793652;5233.921491177635;5237.685738855681;5267.920981185285;5283.894322113555;5285.524302812746;5289.074411977907;5294.549963253128;5080.695158290514;5122.436531981479;5130.9230361544605;5178.741062946838;5203.817866374678;5231.084560201949;5254.133068043769;5259.5529380002745;5267.209918512215;5268.6575372600655;5117.360329958755;5167.586593072545;5177.534021938043;5179.223116532513;5185.585153187736;5758.42415758425;5761.165000124695;5785.47930686236;5785.681787501686;5820.767169313222;6138.386161383871;6150.477209437203;6151.507879369639;6159.476444502223;6292.5595208335435;6374.107624932513;6378.043293505965;6408.327125651833;6410.455111315544;6415.518836087265;5813.186153938452;5903.291605007384;5920.733566989496;5921.792737254218;5983.790567330209;6240.344763799826;6302.558820882494;6422.068800023971;6484.578502397329;6557.540972131905;6162.26052873658;6172.537059720539;6173.104899789505;6174.351693072163;6176.289726681399;6273.059041143773;6273.059041143865;6275.5920865144535;6277.05844123376;6282.623042617458;6126.2123341605975;6128.988716861757;6192.318844927055;6216.564840461215;6259.71831267594;6232.75068997235;6273.278572964076;6321.494280457552;6322.146510221153;6329;4823.059503396874;4827.637927155477;4830.7826147822725;4838.782254798542;4869.829555965524;4273.081287523198;4303.139372125587;4304.332828411601;4318.222719910446;4333.609975102256;5704.458076482728;5713.74288157034;5905.261842269716;5973.731182096816;5975.551833612496;6330.0821380899515;6347.52393570484;6374.84062898422;6376.521760867953;6383.329750376143;5934.7922822701;5944.019236825875;5951.3751056139345;5955.315138759098;5956.642601443928;5200.635955483155;5253.868653283698;5339.519443250126;5409.594280428983;5411.540019098421;6538.444232240217;6588.967055164693;6593.274739778716;6595.142631457879;6598.670066496656;6111.327753946974;6147.72335244924;6235.75056997715;6292.370762923671;6297.685115744286;6395.392437718409;6451;6546.574472659262;6549.181352330958;6552.082708420729;6184.969075154775;6222.315545290105;6232.594881332699;6234.064890266315;6234.127222188988;6358.745650174126;6360.618362898241;6360.713767880364;6361.077643741539;6365.7135428904885;5963.493103086286;6026.216591843032;6121.755129794937;6156.846078848064;6166.260048794174;6066.666333351708;6114.571104522845;6121.989871671302;6128.808691620048;6143.631382117087;6098.481629061402;6112.541559382975;6120.387961203844;6120.693965301806;6131.570790044654;5971.910421343597;6012.3386427493815;6031.668258245839;6112.052631842072;6177.320494745664;6048.455638992512;6071.028635418312;6078.5441091919165;6114.694265286629;6122.051082082285 15:35:18 INFO - PID 5721 | |1;ext.html;717.3328804212084;796.8366484870601;812.2283830361157;1137.4483375562857;1151.838742576039;30451.84774076129;36758;37538.81230593843;37569.06077348064;37614;43177.7841110794;43340.349894751605;43435.78282108593;43500.129997400036;43571.56428435715;6090.512758979271;6237.968810155943;8313.334933205344;8436.704715334965;8484.87272690907;7897.644605992716;8147.51114933103;8185.754427367188;8186;8188.508689478621;8243.381746369016;8394.412391132622;8407.201315874981;8407.831843363128;8411.873821892677;8283.420160588761;8285.378596605218;8304.045034820952;8338.458000229966;8351.290140338078;8219.383546234056;8279.95860020696;8280.130586288473;8302.667893284322;8332.291755200815;41304.58695413038;41532.58467415317;41535;41583;41598.79200604008;3010.1421094987822;3055.3431012332453;3069.079276217148;3094.876204951799;3133.8433078345993;28691.28271793201;28902.277443063882;28978;28996;29065.709342906513;3561.5013898054294;3694.2980833641523;3699.426588878728;3821;3827.4641550182996;217763;218290;218459;220972;222945;50307.24539131916;50362.24456633154;50378.748106259234;50397;50405.24392134121;52701.7364913173;52802.73598631982;52864.20703689448;52899.73550132225;52961.735191324566;14763.48327808543;14787.116512280003;14885.032472889228;14890.702185956221;14894.627634309229;10039.196864250842;10120.240981926238;11417.828732569018;11979.820302695467;11985.64043078709;13672.31638418075;13819.792703109462;13828.37772300249;13847.515336963359;13967.720645587031;5105.774614092666;5144.225242291403;5224.92162617561;5251.894962100737;5280.392754833167;1011.5346940407347;1026.4457193115784;1044.4307852220559;1049.968500944973;1055.0978913029403;26082.347941301618;26168.953241870113;26268.474630507666;28389.858050710027;30981.380372392425;1076.9461526923621;1115.642994241851;1119.798436281477;1125.0718157519916;1127.261643623428;13441.260730659907;13920.443182272596;13979.720405591832;14039.157650541;14161.433542658384;295146;298534;299271;299426;300390;54690.72654636701;54729.45270547244;54732.72633636806;54770.726146369016;54787.72606136944;1376.1536654957329;1414.0596503325173;1427.414759948437;1441.7981482592445;1448.8116544849102;23990;24307.39231519226;25009.74990250147;25212;25261;41857.37213941854;41864.581354187285;41923.1615367697;41925.37111943385;41936.16127677368;293112;293973;294793;295748;296142;25508.489830203664;33135.83432082824;33621.3275734479;33800.830995844866;33896;30358;34921;35749.821250893576;38775.41836872393;40371.394429084175;29200.415991679623;30065.54901676433;30774.384512310076;31113.911013114433;31236.37527249488;30474.390512190075;31083;32426;32921.83539082385;33532.32935341328;38123.046923827125;38800.22399552049;38860.6113938857;38861.80569097136;38977.41533877051;31996.84001579977;32253.193670158435;32374.83812581016;32456.188595285308;32642.836785815918;24239.757602424455;25601.903695408644;25701.3574660635;25706.20209197347;25934 15:35:18 INFO - PID 5721 | |2;jquery.html;429.7378599054574;441.5363867938665;443.2686067987822;448.2916991153975;453.3969820139214;18523.629527409445;19654.90172549137;20131.396058118244;20182.293619723314;20249.59500809983;21153.68269475959;22344.553108937813;22454;22500.54998900021;22651.660225096635;5924.466797988181;6171.845703857417;6172.660503672296;6181.690915454232;6182.567220294582;5852.824415267549;5938.792142275021;6033.42682445167;6071.848203794896;6075.696215189245;5954.851128721795;6033.969830150843;6041.516678665696;6048.727807248684;6050.455459008688;6037.305709843358;6102.420270074358;6124.816255512297;6135.263768347804;6136.263648362181;5287.4976877196605;5420.105682562373;5504.91742623861;5512.91730624041;5518.172274158908;25311.746882531308;25589.232323030337;25712.228633141036;25997.870010649825;26396;2021.444102871722;2029.1173339597174;2039.5512987142804;2077.522169900916;2084.3121769816075;15132.167730774803;16197.595060123473;16449.58876028097;16559;17072.317107315692;1820.7997120316754;1870.1584287070873;1898.905054747271;1918.3189967561593;1921.798211187819;101545;104020.47989760079;108989.45505272502;109655;109939.45030274878;11897.286162830258;11935.164538482397;12349.567765128177;12411.379431028412;12449.875501245053;17004.914975425043;17075.48773536796;17119.22963466647;17130.828691713174;17131.74302385465;8274.213949674771;8403.789905252417;8507.404481686346;8751.299896008304;8770.605322760492;7923.920760792434;8006.279434850891;8027.117017128111;8194.426390152752;8210.712625058213;7518.586477743776;7816.41376896735;7819.296263336213;7868.645910934022;7978.840423191504;2102.2431924507164;2176.216562037665;2176.8149707274742;2198.65920782279;2281.05336285443;992.8212921674024;1000.0849222960909;1011.4588695048114;1017.9389236645825;1019.0828254570797;19762.4071277859;19965.301214457424;20116.39650810478;20174.394768156977;20491.69262461064;1040.2926010312908;1046.2885238038054;1048.9737756556146;1060.379677888444;1064.9254552181428;10191.23565732573;11047.72380690473;11139.832902506469;11187.776244475064;11227.214095013434;561649;562158.4870193799;562814;596000;603840;105671.47164264129;109146.45426772974;113931.43034284776;114915;116548;1200.363807182195;1210.9515619375302;1265.5127775806382;1273.5287943460794;1285.2481298440516;18442.907785460986;18685.532861678566;20276.290329838386;20718.585628287652;20777.688334675295;49619;50334.74832625814;50787.23819142642;51192;52159.2176117351;61609.07586386118;61996.690016549626;64211;64882;67840;8770.473771573726;8789.208971192624;8794.340424468062;8997.865032024394;9136.314776391664;12554.43505042257;13598.86401135976;14052.859471405154;14262.429502820187;14699.265036748333;11398.145139114766;11746.647600571996;11844.585439509576;12619.684507887376;13139.14595551286;11585.362805045466;11632.18574699763;11707.590234341757;11828.112891532997;11977.461014254206;12388.504459821506;12531;12661.74676506483;12721.872781272068;13032.804507932198;8824.867626985471;8916.924090366874;9221.893372795308;9271.351005429555;9442.244620430212;11671.941640291745;12215.144939854481;12338.198017128858;12612.810807838074;12826.486940522274 15:35:18 INFO - PID 5721 | |3;mootools.html;1167.1421505193675;1305.6801083734485;1352.4049418255972;1365.5698454986677;1370.4107233889426;8861.113888611135;10452;10777.191710621715;10778.19163562732;10801.945990270056;10507.63223287185;10572.524236409361;10584.470776461165;10594.25840191185;10607.15142788577;2027.959440811183;2087.551176497053;2360.1503458754833;2396.2930935374106;2400.23192578375;2330.627099664054;2399.928002159938;2404.879756012201;2405.4106743847783;2409.8674572898485;2345.8006069484027;2350.9412264693347;2367.0413482539598;2369.656399822025;2369.9881500592473;2358.0803486640225;2359.7168339799164;2363.8463499872455;2367.4081479630095;2369.5024044950583;2188.0919418441326;2213.3249358945513;2337.5091230841545;2370.19413399445;2372.110458578033;11003.504842282116;11020.44897755109;11126;11150.163737719622;11186.496607652674;6199.132121502993;6412.3908228718665;6419.518536109764;6432.646204458753;6435.292117867031;3708.9443658345144;3727.720420968411;3872.9031774205587;3916.2167566486814;3921.3529767588598;1324.2650329067365;1329.1427029565973;1352.4860552989899;1398.979015314771;1432.5845504803594;16238.269277882406;16310.510684679479;16328.346866125341;16338.264778085015;16340.918295408446;5104.157813960729;5620.943790562042;5641.294838145232;5660.15097735343;5736.827895163068;13510.729785404237;13519.188848669111;13552.492788834097;13576.93211533936;13586.796198057036;6437.549371543947;6477.190351206099;6493;6495.64273964927;6497.772577959749;4885.609151267961;5007.4491805901325;5585.301837270341;5707.086866101404;5938;3952.2490726761825;3999.9800000999808;4007.6192761687594;4033.6773058155277;4208.431861698693;1184.490669012333;1191.6961174900518;1198.484651599803;1203.3622180244483;1210.7881120803825;847.8643417053241;856.7986523167051;860.3676297921023;878.310526236901;882.1090698394668;6581.506387020897;6838.247792742794;6896.689648965808;6908.3437073477935;7101.183363913113;955.8805149356331;965.2278177458005;969.14230905649;970.5680971967548;981.4062492192121;4542.386777784956;4639.9536004640195;4726.503717109723;4828.589569886599;4934.407871055496;13367.933160334136;13842.584722458343;13884.09753366028;14336.139831610137;14690;13500.392482338319;13612.455501780016;13700;13738.519151829638;13738.793918091236;9720.854187187057;9822.656207032862;9857.408555486694;9923.255755818342;9941.105300522988;6480.8703825922275;6659.500537459613;6903.930960690329;6940.687669054803;7147.499675022698;12159.148859580098;12554.748905022032;12696.301703406401;12727.93636031814;12795.680107997374;13067.607971760863;13140.540081097115;13233.933830331172;13297.933510332387;13340.799888001882;8682.739517814476;8915.063918288746;9838.754031148992;10013.849792253268;10116.59533618647;10109.39343639384;10223.693289201336;10346.430946298025;10355.17158627323;10377.066064054272;8796.60415281301;8831.69089081879;8960.955195223982;9062.456252624863;9077.954610226907;8589.527575983131;8802.691905783267;8808.251298639687;8911.73264802057;9060.864087038832;7240.818979525343;7454.4781865268915;7534.208908064794;7578.469507134448;7611.733589324569;5703.543716502752;5797.623154494944;5810;5866.090755932667;5973.701314934323;5704.0588302929555;5751.079827227623;5766.452187042224;5963.194968679173;6014 15:35:18 INFO - PID 5721 | |4;prototype.html;421.63317913415335;423.5002696817755;427.6899248045166;431.69781153192775;434.93258544925527;5698.145278208271;5902.49828764555;5906.409359064091;5949.196858424117;5987.790427335033;5813.593048486608;5837.678927658988;5847.4152584741505;5848.561357898154;5864.44287792659;4652.534746525354;4676.111538807616;4682.204025315705;4689.742064186468;4697.835575754849;4501.279795232747;4649.372334734801;4691.624670026406;4692.02056694;4701.600363969067;4617.699849509788;4628.120657075145;4637.814487420516;4641.837535686252;4662.479827730059;4636.420447444069;4639.188142075157;4640.2807564827335;4643.489216186217;4660.13787449323;3812.218495208476;4227.492700875884;4241.893952651178;4249.575042495757;4250.236151996917;5673.290838645169;5694.715264236772;5695.77216911323;5698.886022279531;5731.283589551306;5244.5542128918705;5258.894822103574;5266.60500462463;5279.973600132013;5308;6045;6188.47397971173;6222;6235.282942461584;6273.651164999502;4419.18245124653;4435.423394958667;4435.467743870724;4447.7776111194635;4447.799849006802;6150.630962142286;6356.968215158895;6434.613923164578;6527.5757075789925;6533.869322613568;4425.336199570091;4442.311441726538;4499.820007199675;4519.389882365905;4528.0943811237885;4565.726056436624;4570.748608826547;4587.587117159472;4588.403507544064;4591.701539399928;5100.719460429637;5201.6358854880555;5225.6603320784025;5234.371875374979;5245.239440281138;6184.928049103511;6185.938140618626;6194.225721784777;6204.937950620436;6209.348018458088;1566.154276690597;1582.6834633073431;1593.7768712380275;1595.5213435969395;1598.6403059311563;1069.198101423932;1074.9462526873624;1081.853235570298;1089.8147314956477;1102.729831191347;5954;5979.850503737442;5980.401959804072;5983.19226904371;5983.431574000463;6378.77674281398;6387.361263873576;6406.615603063831;6442.903356449657;6467.353264673495;5768.3366412862215;5882.735276912549;5892.263467066617;5948.256467941507;5977.790777322773;3332.166958260435;3374.274530975852;3388.457846744509;3403.846826892796;3406.5230867678547;6502.252240992347;6586.571872828251;6611.272759996396;6645.867082658417;6697.296783837627;6506.869862602722;6512.120863683437;6521.739130434825;6534.901976470357;6566.343365663491;6461.935380646133;6512.6743662815725;6622.437092847065;6673.265940746514;6686.699098540577;6313.463355614824;6356.300806911328;6359.618422894641;6361.777337793155;6369.394907483782;6101.420365065312;6313.494920406265;6329.683515824282;6352.745890164341;6363.268224154282;6609.810234157898;6633.800985970429;6647.169103862017;6647.401733843977;6653.534252602271;4561.885952851073;4566.337881007302;4579.473360563445;4594.310853372021;4602.976985115053;6348.555601107878;6425.261094973951;6426.325235850355;6476.838079048061;6492.35076492347;6149.754009839557;6203.379662033761;6210.130581718653;6231;6240.313565507881;5922.911156332744;6136.907946380898;6181.412765787243;6203.96898015507;6212.695333979734;6170;6173.59871608344;6189.226346706661;6194.38056194377;6217.782377616762;6214.881321362017;6219.564630476004;6236.469900058546;6242.406971337716;6262.937370626418;5684.7157642118555;6035.577509574287;6067.54493412987;6070.423309785563;6089.969550152221 15:35:18 INFO - PID 5721 | |5;yui.html;754.3135746470713;759.6505607420586;762.0702742653962;765.5751058162721;774.6823802241082;15179.620509487255;15838.128902910335;15902.681946361066;15968.441104561343;16647.91676041621;15418.61453463664;15560.45538406156;15569.92215038926;15572.922135389308;15590.06459612424;806.8063664720454;808.6118663041743;818.5866137600533;824.5506199121463;825.6614787936948;827.148037521354;841.0958219913587;842.5197637346715;843.5529169540154;844.5144042175742;859.866720658299;865.0614083719172;866.57537806475;866.5970323799432;868.3053557154283;852.8550146475083;860.0410542245352;861.0055386029146;864.9437786543855;867.4535042922981;632.0740115730476;634.7746549974738;635.6694518850218;639.2393052267787;640.2924768131242;16548.33806647745;16984.15079246033;17054.232559534852;17396.130193490273;17449.21478533469;15859.286332115082;15990.520284391487;16409.753853692204;16441.506754797254;16598.917005414896;12463.563775267821;12631.368431578385;12935.935320323431;12978.286194259312;13734.725305493834;3033.9544906826413;3177.6504584495688;3184.633767116788;3201.103690966533;3269.722073623745;69377.65311173412;70702;70835;71707.64146179288;72796.99999999948;12255;12265.57070502528;12291;12470.625881223577;12545.623631291075;23656;23819.166329178395;23866.522669546513;24689.012439502578;25073.49853002966;7801.127729344917;8051.677932882736;8245.216704413071;8264.793380165424;8736.650533978569;4116.444280022159;4204.138151678899;4403.84586539476;4445.555444455528;4553.590176884097;4266.253405653998;4383.16719823239;4383.583559561836;4415.735055896592;4440.68915175941;825.5707032343269;836.9497830130211;840.4411066640615;848.4315508609246;861.3625916821507;581.9679917604487;591.798788411942;596.2517041113375;602.3856065743848;605.797057985571;10128.746781330377;10451.111655509367;10673.57305707763;10838.512266947848;11073.446327683583;611.8623309755269;626.3673689573563;627.4697880291146;630.8738252349549;633.4140919649305;4797.088553174955;4943.184374578226;4946.183879659816;4955.182394904872;4963.553280204799;62266.377336226964;78445;80765.19234807577;81054.594727026;81392.59303703562;60521.69739151276;60932.39067609356;61433;62449.37550624435;62666.68666656638;56321;62132.378676213564;62614;62682.68658656769;62885.37114628795;10885.238033337908;11143.523341767064;11237.269577477438;11247.212695111264;11355.261907975955;32439.513407298437;32799.83600081984;32904.67095329016;32909;33358.83320583381;38498;39528.80235598804;39667.801660991514;40120.39819402653;49095.50904491052;13087.869121308666;13931.303434828016;13956.302184890917;14089.929550352183;14196.29018549089;15120.54638360851;15777.68444631078;15959.202039898191;15968.361265549247;16141.515754527383;15139.54581362561;15158.621034473785;15260.542183734506;15407.845921540642;15535.733775189332;13257.403416846073;13290.335483225606;13652.385642646303;14106.50627228083;15069;13922.582322530341;14515.92742036283;14517.397580765846;14667.413303468169;14775.113493190443;11048.944755276172;11415.714607134889;11798.646040618794;12310.168661207794;12416.875831241572;11160.218784684994;11325.377104259345;11349.602763903224;11453.083753299883;11519.76960460803 15:35:18 INFO - PID 5721 | __end_tp_report 15:35:18 INFO - PID 5721 | __start_cc_report 15:35:18 INFO - PID 5721 | _x_x_mozilla_cycle_collect,1609 15:35:18 INFO - PID 5721 | __end_cc_report 15:35:18 INFO - PID 5721 | __startTimestamp1490654118904__endTimestamp 15:35:18 INFO - PID 5721 | 15:35:18 INFO - PID 5721 | ------- Summary: start ------- 15:35:18 INFO - PID 5721 | Number of tests: 6 15:35:18 INFO - PID 5721 | 15:35:18 INFO - PID 5721 | [#0] dojo.html Cycles:165 Average:5809.50 Median:6071.03 stddev:681.53 (11.2%) stddev-sans-first:655.28 15:35:18 INFO - PID 5721 | Values: 3330.1 3376.7 3396.8 3404.0 3427.9 5630.2 5748.9 5858.8 5874.9 5917.7 5840.1 5863.9 5891.3 5933.9 5950.9 5134.2 5178.4 5201.3 5233.9 5237.7 5267.9 5283.9 5285.5 5289.1 5294.5 5080.7 5122.4 5130.9 5178.7 5203.8 5231.1 5254.1 5259.6 5267.2 5268.7 5117.4 5167.6 5177.5 5179.2 5185.6 5758.4 5761.2 5785.5 5785.7 5820.8 6138.4 6150.5 6151.5 6159.5 6292.6 6374.1 6378.0 6408.3 6410.5 6415.5 5813.2 5903.3 5920.7 5921.8 5983.8 6240.3 6302.6 6422.1 6484.6 6557.5 6162.3 6172.5 6173.1 6174.4 6176.3 6273.1 6273.1 6275.6 6277.1 6282.6 6126.2 6129.0 6192.3 6216.6 6259.7 6232.8 6273.3 6321.5 6322.1 6329.0 4823.1 4827.6 4830.8 4838.8 4869.8 4273.1 4303.1 4304.3 4318.2 4333.6 5704.5 5713.7 5905.3 5973.7 5975.6 6330.1 6347.5 6374.8 6376.5 6383.3 5934.8 5944.0 5951.4 5955.3 5956.6 5200.6 5253.9 5339.5 5409.6 5411.5 6538.4 6589.0 6593.3 6595.1 6598.7 6111.3 6147.7 6235.8 6292.4 6297.7 6395.4 6451.0 6546.6 6549.2 6552.1 6185.0 6222.3 6232.6 6234.1 6234.1 6358.7 6360.6 6360.7 6361.1 6365.7 5963.5 6026.2 6121.8 6156.8 6166.3 6066.7 6114.6 6122.0 6128.8 6143.6 6098.5 6112.5 6120.4 6120.7 6131.6 5971.9 6012.3 6031.7 6112.1 6177.3 6048.5 6071.0 6078.5 6114.7 6122.1 15:35:18 INFO - PID 5721 | 15:35:18 INFO - PID 5721 | [#1] ext.html Cycles:180 Average:43135.98 Median:32441.09 stddev:71519.67 (220.5%) stddev-sans-first:71649.38 15:35:18 INFO - PID 5721 | Values: 717.3 796.8 812.2 1137.4 1151.8 30451.8 36758.0 37538.8 37569.1 37614.0 43177.8 43340.3 43435.8 43500.1 43571.6 6090.5 6238.0 8313.3 8436.7 8484.9 7897.6 8147.5 8185.8 8186.0 8188.5 8243.4 8394.4 8407.2 8407.8 8411.9 8283.4 8285.4 8304.0 8338.5 8351.3 8219.4 8280.0 8280.1 8302.7 8332.3 41304.6 41532.6 41535.0 41583.0 41598.8 3010.1 3055.3 3069.1 3094.9 3133.8 28691.3 28902.3 28978.0 28996.0 29065.7 3561.5 3694.3 3699.4 3821.0 3827.5 217763.0 218290.0 218459.0 220972.0 222945.0 50307.2 50362.2 50378.7 50397.0 50405.2 52701.7 52802.7 52864.2 52899.7 52961.7 14763.5 14787.1 14885.0 14890.7 14894.6 10039.2 10120.2 11417.8 11979.8 11985.6 13672.3 13819.8 13828.4 13847.5 13967.7 5105.8 5144.2 5224.9 5251.9 5280.4 1011.5 1026.4 1044.4 1050.0 1055.1 26082.3 26169.0 26268.5 28389.9 30981.4 1076.9 1115.6 1119.8 1125.1 1127.3 13441.3 13920.4 13979.7 14039.2 14161.4 295146.0 298534.0 299271.0 299426.0 300390.0 54690.7 54729.5 54732.7 54770.7 54787.7 1376.2 1414.1 1427.4 1441.8 1448.8 23990.0 24307.4 25009.7 25212.0 25261.0 41857.4 41864.6 41923.2 41925.4 41936.2 293112.0 293973.0 294793.0 295748.0 296142.0 25508.5 33135.8 33621.3 33800.8 33896.0 30358.0 34921.0 35749.8 38775.4 40371.4 29200.4 30065.5 30774.4 31113.9 31236.4 30474.4 31083.0 32426.0 32921.8 33532.3 38123.0 38800.2 38860.6 38861.8 38977.4 31996.8 32253.2 32374.8 32456.2 32642.8 24239.8 25601.9 25701.4 25706.2 25934.0 15:35:18 INFO - PID 5721 | 15:35:18 INFO - PID 5721 | [#2] jquery.html Cycles:180 Average:33889.99 Median:11398.05 stddev:95642.25 (839.1%) stddev-sans-first:95877.56 15:35:18 INFO - PID 5721 | Values: 429.7 441.5 443.3 448.3 453.4 18523.6 19654.9 20131.4 20182.3 20249.6 21153.7 22344.6 22454.0 22500.5 22651.7 5924.5 6171.8 6172.7 6181.7 6182.6 5852.8 5938.8 6033.4 6071.8 6075.7 5954.9 6034.0 6041.5 6048.7 6050.5 6037.3 6102.4 6124.8 6135.3 6136.3 5287.5 5420.1 5504.9 5512.9 5518.2 25311.7 25589.2 25712.2 25997.9 26396.0 2021.4 2029.1 2039.6 2077.5 2084.3 15132.2 16197.6 16449.6 16559.0 17072.3 1820.8 1870.2 1898.9 1918.3 1921.8 101545.0 104020.5 108989.5 109655.0 109939.5 11897.3 11935.2 12349.6 12411.4 12449.9 17004.9 17075.5 17119.2 17130.8 17131.7 8274.2 8403.8 8507.4 8751.3 8770.6 7923.9 8006.3 8027.1 8194.4 8210.7 7518.6 7816.4 7819.3 7868.6 7978.8 2102.2 2176.2 2176.8 2198.7 2281.1 992.8 1000.1 1011.5 1017.9 1019.1 19762.4 19965.3 20116.4 20174.4 20491.7 1040.3 1046.3 1049.0 1060.4 1064.9 10191.2 11047.7 11139.8 11187.8 11227.2 561649.0 562158.5 562814.0 596000.0 603840.0 105671.5 109146.5 113931.4 114915.0 116548.0 1200.4 1211.0 1265.5 1273.5 1285.2 18442.9 18685.5 20276.3 20718.6 20777.7 49619.0 50334.7 50787.2 51192.0 52159.2 61609.1 61996.7 64211.0 64882.0 67840.0 8770.5 8789.2 8794.3 8997.9 9136.3 12554.4 13598.9 14052.9 14262.4 14699.3 11398.1 11746.6 11844.6 12619.7 13139.1 11585.4 11632.2 11707.6 11828.1 11977.5 12388.5 12531.0 12661.7 12721.9 13032.8 8824.9 8916.9 9221.9 9271.4 9442.2 11671.9 12215.1 12338.2 12612.8 12826.5 15:35:18 INFO - PID 5721 | 15:35:18 INFO - PID 5721 | [#3] mootools.html Cycles:180 Average:6928.97 Median:3059.41 stddev:4359.89 (142.5%) stddev-sans-first:4350.62 15:35:18 INFO - PID 5721 | Values: 1167.1 1305.7 1352.4 1365.6 1370.4 8861.1 10452.0 10777.2 10778.2 10801.9 10507.6 10572.5 10584.5 10594.3 10607.2 2028.0 2087.6 2360.2 2396.3 2400.2 2330.6 2399.9 2404.9 2405.4 2409.9 2345.8 2350.9 2367.0 2369.7 2370.0 2358.1 2359.7 2363.8 2367.4 2369.5 2188.1 2213.3 2337.5 2370.2 2372.1 11003.5 11020.4 11126.0 11150.2 11186.5 6199.1 6412.4 6419.5 6432.6 6435.3 3708.9 3727.7 3872.9 3916.2 3921.4 1324.3 1329.1 1352.5 1399.0 1432.6 16238.3 16310.5 16328.3 16338.3 16340.9 5104.2 5620.9 5641.3 5660.2 5736.8 13510.7 13519.2 13552.5 13576.9 13586.8 6437.5 6477.2 6493.0 6495.6 6497.8 4885.6 5007.4 5585.3 5707.1 5938.0 3952.2 4000.0 4007.6 4033.7 4208.4 1184.5 1191.7 1198.5 1203.4 1210.8 847.9 856.8 860.4 878.3 882.1 6581.5 6838.2 6896.7 6908.3 7101.2 955.9 965.2 969.1 970.6 981.4 4542.4 4640.0 4726.5 4828.6 4934.4 13367.9 13842.6 13884.1 14336.1 14690.0 13500.4 13612.5 13700.0 13738.5 13738.8 9720.9 9822.7 9857.4 9923.3 9941.1 6480.9 6659.5 6903.9 6940.7 7147.5 12159.1 12554.7 12696.3 12727.9 12795.7 13067.6 13140.5 13233.9 13297.9 13340.8 8682.7 8915.1 9838.8 10013.8 10116.6 10109.4 10223.7 10346.4 10355.2 10377.1 8796.6 8831.7 8961.0 9062.5 9078.0 8589.5 8802.7 8808.3 8911.7 9060.9 7240.8 7454.5 7534.2 7578.5 7611.7 5703.5 5797.6 5810.0 5866.1 5973.7 5704.1 5751.1 5766.5 5963.2 6014.0 15:35:18 INFO - PID 5721 | 15:35:18 INFO - PID 5721 | [#4] prototype.html Cycles:180 Average:5236.20 Median:5904.45 stddev:1530.02 (25.9%) stddev-sans-first:1491.03 15:35:18 INFO - PID 5721 | Values: 421.6 423.5 427.7 431.7 434.9 5698.1 5902.5 5906.4 5949.2 5987.8 5813.6 5837.7 5847.4 5848.6 5864.4 4652.5 4676.1 4682.2 4689.7 4697.8 4501.3 4649.4 4691.6 4692.0 4701.6 4617.7 4628.1 4637.8 4641.8 4662.5 4636.4 4639.2 4640.3 4643.5 4660.1 3812.2 4227.5 4241.9 4249.6 4250.2 5673.3 5694.7 5695.8 5698.9 5731.3 5244.6 5258.9 5266.6 5280.0 5308.0 6045.0 6188.5 6222.0 6235.3 6273.7 4419.2 4435.4 4435.5 4447.8 4447.8 6150.6 6357.0 6434.6 6527.6 6533.9 4425.3 4442.3 4499.8 4519.4 4528.1 4565.7 4570.7 4587.6 4588.4 4591.7 5100.7 5201.6 5225.7 5234.4 5245.2 6184.9 6185.9 6194.2 6204.9 6209.3 1566.2 1582.7 1593.8 1595.5 1598.6 1069.2 1074.9 1081.9 1089.8 1102.7 5954.0 5979.9 5980.4 5983.2 5983.4 6378.8 6387.4 6406.6 6442.9 6467.4 5768.3 5882.7 5892.3 5948.3 5977.8 3332.2 3374.3 3388.5 3403.8 3406.5 6502.3 6586.6 6611.3 6645.9 6697.3 6506.9 6512.1 6521.7 6534.9 6566.3 6461.9 6512.7 6622.4 6673.3 6686.7 6313.5 6356.3 6359.6 6361.8 6369.4 6101.4 6313.5 6329.7 6352.7 6363.3 6609.8 6633.8 6647.2 6647.4 6653.5 4561.9 4566.3 4579.5 4594.3 4603.0 6348.6 6425.3 6426.3 6476.8 6492.4 6149.8 6203.4 6210.1 6231.0 6240.3 5922.9 6136.9 6181.4 6204.0 6212.7 6170.0 6173.6 6189.2 6194.4 6217.8 6214.9 6219.6 6236.5 6242.4 6262.9 5684.7 6035.6 6067.5 6070.4 6090.0 15:35:18 INFO - PID 5721 | 15:35:18 INFO - PID 5721 | [#5] yui.html Cycles:180 Average:16931.77 Median:39013.40 stddev:20294.17 (52.0%) stddev-sans-first:20314.74 15:35:18 INFO - PID 5721 | Values: 754.3 759.7 762.1 765.6 774.7 15179.6 15838.1 15902.7 15968.4 16647.9 15418.6 15560.5 15569.9 15572.9 15590.1 806.8 808.6 818.6 824.6 825.7 827.1 841.1 842.5 843.6 844.5 859.9 865.1 866.6 866.6 868.3 852.9 860.0 861.0 864.9 867.5 632.1 634.8 635.7 639.2 640.3 16548.3 16984.2 17054.2 17396.1 17449.2 15859.3 15990.5 16409.8 16441.5 16598.9 12463.6 12631.4 12935.9 12978.3 13734.7 3034.0 3177.7 3184.6 3201.1 3269.7 69377.7 70702.0 70835.0 71707.6 72797.0 12255.0 12265.6 12291.0 12470.6 12545.6 23656.0 23819.2 23866.5 24689.0 25073.5 7801.1 8051.7 8245.2 8264.8 8736.7 4116.4 4204.1 4403.8 4445.6 4553.6 4266.3 4383.2 4383.6 4415.7 4440.7 825.6 836.9 840.4 848.4 861.4 582.0 591.8 596.3 602.4 605.8 10128.7 10451.1 10673.6 10838.5 11073.4 611.9 626.4 627.5 630.9 633.4 4797.1 4943.2 4946.2 4955.2 4963.6 62266.4 78445.0 80765.2 81054.6 81392.6 60521.7 60932.4 61433.0 62449.4 62666.7 56321.0 62132.4 62614.0 62682.7 62885.4 10885.2 11143.5 11237.3 11247.2 11355.3 32439.5 32799.8 32904.7 32909.0 33358.8 38498.0 39528.8 39667.8 40120.4 49095.5 13087.9 13931.3 13956.3 14089.9 14196.3 15120.5 15777.7 15959.2 15968.4 16141.5 15139.5 15158.6 15260.5 15407.8 15535.7 13257.4 13290.3 13652.4 14106.5 15069.0 13922.6 14515.9 14517.4 14667.4 14775.1 11048.9 11415.7 11798.6 12310.2 12416.9 11160.2 11325.4 11349.6 11453.1 11519.8 15:35:18 INFO - PID 5721 | -------- Summary: end -------- 15:35:18 INFO - PID 5721 | 15:35:19 INFO - TEST-INFO | 5721: exit 0 15:35:19 INFO - TEST-OK | dromaeo_css | took 1116689ms 15:35:19 INFO - TEST-START | kraken 15:35:19 INFO - operating with platform_type : linux_ 15:35:19 INFO - Initialising browser for kraken test... 15:35:19 INFO - TEST-INFO | started process 6051 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphqCM1Y/profile http://localhost:52395/getInfo.html) 15:35:23 INFO - PID 6051 | __metrics Screen width/height:1600/1200 15:35:23 INFO - PID 6051 | colorDepth:24 15:35:23 INFO - PID 6051 | Browser inner width/height: 1024/697 15:35:23 INFO - PID 6051 | __metrics 15:35:24 ERROR - PID 6051 | 1490654124148 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 15:35:24 INFO - PID 6051 | 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" 15:35:24 INFO - PID 6051 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:35:25 INFO - TEST-INFO | 6051: exit 0 15:35:25 INFO - Browser initialized. 15:35:25 INFO - Running cycle 1/1 for kraken test... 15:35:25 INFO - TEST-INFO | started process 6144 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphqCM1Y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:35:37 INFO - PID 6144 | RSS: Main: 145772544 15:35:37 INFO - PID 6144 | 15:35:39 INFO - PID 6144 | Cycle 1(1): loaded http://localhost:52395/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52395/tests/kraken/driver.html?testName=audio-beat-detection) 15:35:40 INFO - PID 6144 | RSS: Main: 201277440 15:35:40 INFO - PID 6144 | 15:35:43 INFO - PID 6144 | Cycle 1(1): loaded http://localhost:52395/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52395/tests/kraken/driver.html?testName=audio-dft) 15:35:43 INFO - PID 6144 | RSS: Main: 179744768 15:35:43 INFO - PID 6144 | 15:35:46 INFO - PID 6144 | Cycle 1(1): loaded http://localhost:52395/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52395/tests/kraken/driver.html?testName=audio-fft) 15:35:47 INFO - PID 6144 | RSS: Main: 261267456 15:35:47 INFO - PID 6144 | 15:35:49 INFO - PID 6144 | Cycle 1(1): loaded http://localhost:52395/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52395/tests/kraken/driver.html?testName=audio-oscillator) 15:35:49 INFO - PID 6144 | RSS: Main: 174174208 15:35:49 INFO - PID 6144 | 15:35:52 INFO - PID 6144 | Cycle 1(1): loaded http://localhost:52395/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52395/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:35:52 INFO - PID 6144 | RSS: Main: 176906240 15:35:52 INFO - PID 6144 | 15:35:55 INFO - PID 6144 | Cycle 1(1): loaded http://localhost:52395/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52395/tests/kraken/driver.html?testName=imaging-darkroom) 15:35:56 INFO - PID 6144 | RSS: Main: 215846912 15:35:56 INFO - PID 6144 | 15:35:59 INFO - PID 6144 | Cycle 1(1): loaded http://localhost:52395/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52395/tests/kraken/driver.html?testName=imaging-desaturate) 15:36:00 INFO - PID 6144 | RSS: Main: 229629952 15:36:00 INFO - PID 6144 | 15:36:03 INFO - PID 6144 | Cycle 1(1): loaded http://localhost:52395/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52395/tests/kraken/driver.html?testName=json-parse-financial) 15:36:03 INFO - PID 6144 | RSS: Main: 241295360 15:36:03 INFO - PID 6144 | 15:36:05 INFO - PID 6144 | Cycle 1(1): loaded http://localhost:52395/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52395/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:36:05 INFO - PID 6144 | RSS: Main: 178208768 15:36:05 INFO - PID 6144 | 15:36:07 INFO - PID 6144 | Cycle 1(1): loaded http://localhost:52395/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52395/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:36:08 INFO - PID 6144 | RSS: Main: 184492032 15:36:08 INFO - PID 6144 | 15:36:10 INFO - PID 6144 | Cycle 1(1): loaded http://localhost:52395/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52395/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:36:10 INFO - PID 6144 | RSS: Main: 195256320 15:36:10 INFO - PID 6144 | 15:36:13 INFO - PID 6144 | Cycle 1(1): loaded http://localhost:52395/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52395/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:36:14 INFO - PID 6144 | RSS: Main: 199315456 15:36:14 INFO - PID 6144 | 15:36:17 INFO - PID 6144 | Cycle 1(1): loaded http://localhost:52395/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52395/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:36:17 INFO - PID 6144 | RSS: Main: 200708096 15:36:17 INFO - PID 6144 | 15:36:19 INFO - PID 6144 | Cycle 1(1): loaded http://localhost:52395/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52395/tests/kraken/driver.html?testName=ai-astar) 15:36:19 INFO - PID 6144 | RSS: Main: 269438976 15:36:19 INFO - PID 6144 | 15:36:19 INFO - PID 6144 | __start_tp_report 15:36:19 INFO - PID 6144 | _x_x_mozilla_page_load 15:36:19 INFO - PID 6144 | _x_x_mozilla_page_load_details 15:36:19 INFO - PID 6144 | |i|pagename|runs| 15:36:19 INFO - PID 6144 | |0;ai-astar;100;108;109;108;110;109;110;108;108;108 15:36:19 INFO - PID 6144 | |1;audio-beat-detection;142;116;121;162;119;121;117;115;143;117 15:36:19 INFO - PID 6144 | |2;audio-dft;162;163;161;161;162;162;162;164;161;162 15:36:19 INFO - PID 6144 | |3;audio-fft;74;74;74;103;79;75;74;74;90;77 15:36:19 INFO - PID 6144 | |4;audio-oscillator;81;83;101;82;82;82;100;84;83;101 15:36:19 INFO - PID 6144 | |5;imaging-gaussian-blur;113;113;114;114;113;113;113;113;113;113 15:36:19 INFO - PID 6144 | |6;imaging-darkroom;147;148;146;147;147;147;147;148;147;147 15:36:19 INFO - PID 6144 | |7;imaging-desaturate;93;93;94;94;94;94;94;95;94;93 15:36:19 INFO - PID 6144 | |8;json-parse-financial;58;58;59;59;60;59;60;59;58;58 15:36:19 INFO - PID 6144 | |9;json-stringify-tinderbox;55;56;55;55;55;55;55;55;56;57 15:36:19 INFO - PID 6144 | |10;stanford-crypto-aes;78;81;79;79;79;78;78;80;79;87 15:36:19 INFO - PID 6144 | |11;stanford-crypto-ccm;126;127;125;139;130;125;124;124;211;125 15:36:19 INFO - PID 6144 | |12;stanford-crypto-pbkdf2;185;184;187;176;178;197;179;173;172;179 15:36:19 INFO - PID 6144 | |13;stanford-crypto-sha256-iterative;65;65;65;63;65;69;62;63;64;63 15:36:19 INFO - PID 6144 | __end_tp_report 15:36:19 INFO - PID 6144 | __start_cc_report 15:36:19 INFO - PID 6144 | _x_x_mozilla_cycle_collect,1776 15:36:19 INFO - PID 6144 | __end_cc_report 15:36:19 INFO - PID 6144 | __startTimestamp1490654179767__endTimestamp 15:36:19 INFO - PID 6144 | 15:36:19 INFO - PID 6144 | ------- Summary: start ------- 15:36:19 INFO - PID 6144 | Number of tests: 14 15:36:19 INFO - PID 6144 | 15:36:19 INFO - PID 6144 | [#0] ai-astar Cycles:10 Average:107.80 Median:108.50 stddev:2.86 (2.6%) stddev-sans-first:0.87 15:36:19 INFO - PID 6144 | Values: 100.0 108.0 109.0 108.0 110.0 109.0 110.0 108.0 108.0 108.0 15:36:19 INFO - PID 6144 | 15:36:19 INFO - PID 6144 | [#1] audio-beat-detection Cycles:10 Average:127.30 Median:121.00 stddev:16.01 (13.2%) stddev-sans-first:16.07 15:36:19 INFO - PID 6144 | Values: 142.0 116.0 121.0 162.0 119.0 121.0 117.0 115.0 143.0 117.0 15:36:19 INFO - PID 6144 | 15:36:19 INFO - PID 6144 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:0.94 (0.6%) stddev-sans-first:1.00 15:36:19 INFO - PID 6144 | Values: 162.0 163.0 161.0 161.0 162.0 162.0 162.0 164.0 161.0 162.0 15:36:19 INFO - PID 6144 | 15:36:19 INFO - PID 6144 | [#3] audio-fft Cycles:10 Average:79.40 Median:74.50 stddev:9.66 (13.0%) stddev-sans-first:10.05 15:36:19 INFO - PID 6144 | Values: 74.0 74.0 74.0 103.0 79.0 75.0 74.0 74.0 90.0 77.0 15:36:19 INFO - PID 6144 | 15:36:19 INFO - PID 6144 | [#4] audio-oscillator Cycles:10 Average:87.90 Median:82.00 stddev:8.85 (10.8%) stddev-sans-first:9.03 15:36:19 INFO - PID 6144 | Values: 81.0 83.0 101.0 82.0 82.0 82.0 100.0 84.0 83.0 101.0 15:36:19 INFO - PID 6144 | 15:36:19 INFO - PID 6144 | [#5] imaging-gaussian-blur Cycles:10 Average:113.20 Median:113.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 15:36:19 INFO - PID 6144 | Values: 113.0 113.0 114.0 114.0 113.0 113.0 113.0 113.0 113.0 113.0 15:36:19 INFO - PID 6144 | 15:36:19 INFO - PID 6144 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 15:36:19 INFO - PID 6144 | Values: 147.0 148.0 146.0 147.0 147.0 147.0 147.0 148.0 147.0 147.0 15:36:19 INFO - PID 6144 | 15:36:19 INFO - PID 6144 | [#7] imaging-desaturate Cycles:10 Average:93.80 Median:94.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 15:36:19 INFO - PID 6144 | Values: 93.0 93.0 94.0 94.0 94.0 94.0 94.0 95.0 94.0 93.0 15:36:19 INFO - PID 6144 | 15:36:19 INFO - PID 6144 | [#8] json-parse-financial Cycles:10 Average:58.80 Median:59.00 stddev:0.79 (1.3%) stddev-sans-first:0.78 15:36:19 INFO - PID 6144 | Values: 58.0 58.0 59.0 59.0 60.0 59.0 60.0 59.0 58.0 58.0 15:36:19 INFO - PID 6144 | 15:36:19 INFO - PID 6144 | [#9] json-stringify-tinderbox Cycles:10 Average:55.40 Median:55.00 stddev:0.70 (1.3%) stddev-sans-first:0.73 15:36:19 INFO - PID 6144 | Values: 55.0 56.0 55.0 55.0 55.0 55.0 55.0 55.0 56.0 57.0 15:36:19 INFO - PID 6144 | 15:36:19 INFO - PID 6144 | [#10] stanford-crypto-aes Cycles:10 Average:79.80 Median:79.00 stddev:2.70 (3.4%) stddev-sans-first:2.78 15:36:19 INFO - PID 6144 | Values: 78.0 81.0 79.0 79.0 79.0 78.0 78.0 80.0 79.0 87.0 15:36:19 INFO - PID 6144 | 15:36:19 INFO - PID 6144 | [#11] stanford-crypto-ccm Cycles:10 Average:135.60 Median:126.50 stddev:26.88 (21.2%) stddev-sans-first:28.28 15:36:19 INFO - PID 6144 | Values: 126.0 127.0 125.0 139.0 130.0 125.0 124.0 124.0 211.0 125.0 15:36:19 INFO - PID 6144 | 15:36:19 INFO - PID 6144 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.00 Median:181.50 stddev:7.48 (4.1%) stddev-sans-first:7.80 15:36:19 INFO - PID 6144 | Values: 185.0 184.0 187.0 176.0 178.0 197.0 179.0 173.0 172.0 179.0 15:36:19 INFO - PID 6144 | 15:36:19 INFO - PID 6144 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.40 Median:65.00 stddev:1.96 (3.0%) stddev-sans-first:2.06 15:36:19 INFO - PID 6144 | Values: 65.0 65.0 65.0 63.0 65.0 69.0 62.0 63.0 64.0 63.0 15:36:19 INFO - PID 6144 | -------- Summary: end -------- 15:36:19 INFO - PID 6144 | 15:36:20 INFO - TEST-INFO | 6144: exit 0 15:36:20 INFO - TEST-OK | kraken | took 61095ms 15:36:20 INFO - SUITE-END | took 1177s 15:36:20 INFO - Completed test suite (00:19:37) 15:36:20 INFO - javascript benchmark 15:36:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7574.395098740651, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3330.067581077298, 3376.712979396751, 3396.847141878616, 3404.0128362774794, 3427.880024199152, 5630.1554766785, 5748.942510574893, 5858.7949421770245, 5874.88250234995, 5917.674527900958, 5840.06558950568, 5863.882722345561, 5891.322497912731, 5933.85165370866, 5950.9107363389585, 5134.1528647773075, 5178.352705911761, 5201.297824793652, 5233.921491177635, 5237.685738855681, 5267.920981185285, 5283.894322113555, 5285.524302812746, 5289.074411977907, 5294.549963253128, 5080.695158290514, 5122.436531981479, 5130.9230361544605, 5178.741062946838, 5203.817866374678, 5231.084560201949, 5254.133068043769, 5259.5529380002745, 5267.209918512215, 5268.6575372600655, 5117.360329958755, 5167.586593072545, 5177.534021938043, 5179.223116532513, 5185.585153187736, 5758.42415758425, 5761.165000124695, 5785.47930686236, 5785.681787501686, 5820.767169313222, 6138.386161383871, 6150.477209437203, 6151.507879369639, 6159.476444502223, 6292.5595208335435, 6374.107624932513, 6378.043293505965, 6408.327125651833, 6410.455111315544, 6415.518836087265, 5813.186153938452, 5903.291605007384, 5920.733566989496, 5921.792737254218, 5983.790567330209, 6240.344763799826, 6302.558820882494, 6422.068800023971, 6484.578502397329, 6557.540972131905, 6162.26052873658, 6172.537059720539, 6173.104899789505, 6174.351693072163, 6176.289726681399, 6273.059041143773, 6273.059041143865, 6275.5920865144535, 6277.05844123376, 6282.623042617458, 6126.2123341605975, 6128.988716861757, 6192.318844927055, 6216.564840461215, 6259.71831267594, 6232.75068997235, 6273.278572964076, 6321.494280457552, 6322.146510221153, 6329.0, 4823.059503396874, 4827.637927155477, 4830.7826147822725, 4838.782254798542, 4869.829555965524, 4273.081287523198, 4303.139372125587, 4304.332828411601, 4318.222719910446, 4333.609975102256, 5704.458076482728, 5713.74288157034, 5905.261842269716, 5973.731182096816, 5975.551833612496, 6330.0821380899515, 6347.52393570484, 6374.84062898422, 6376.521760867953, 6383.329750376143, 5934.7922822701, 5944.019236825875, 5951.3751056139345, 5955.315138759098, 5956.642601443928, 5200.635955483155, 5253.868653283698, 5339.519443250126, 5409.594280428983, 5411.540019098421, 6538.444232240217, 6588.967055164693, 6593.274739778716, 6595.142631457879, 6598.670066496656, 6111.327753946974, 6147.72335244924, 6235.75056997715, 6292.370762923671, 6297.685115744286, 6395.392437718409, 6451.0, 6546.574472659262, 6549.181352330958, 6552.082708420729, 6184.969075154775, 6222.315545290105, 6232.594881332699, 6234.064890266315, 6234.127222188988, 6358.745650174126, 6360.618362898241, 6360.713767880364, 6361.077643741539, 6365.7135428904885, 5963.493103086286, 6026.216591843032, 6121.755129794937, 6156.846078848064, 6166.260048794174, 6066.666333351708, 6114.571104522845, 6121.989871671302, 6128.808691620048, 6143.631382117087, 6098.481629061402, 6112.541559382975, 6120.387961203844, 6120.693965301806, 6131.570790044654, 5971.910421343597, 6012.3386427493815, 6031.668258245839, 6112.052631842072, 6177.320494745664, 6048.455638992512, 6071.028635418312, 6078.5441091919165, 6114.694265286629, 6122.051082082285], "value": 5762.552777013336, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [717.3328804212084, 796.8366484870601, 812.2283830361157, 1137.4483375562857, 1151.838742576039, 30451.84774076129, 36758.0, 37538.81230593843, 37569.06077348064, 37614.0, 43177.7841110794, 43340.349894751605, 43435.78282108593, 43500.129997400036, 43571.56428435715, 6090.512758979271, 6237.968810155943, 8313.334933205344, 8436.704715334965, 8484.87272690907, 7897.644605992716, 8147.51114933103, 8185.754427367188, 8186.0, 8188.508689478621, 8243.381746369016, 8394.412391132622, 8407.201315874981, 8407.831843363128, 8411.873821892677, 8283.420160588761, 8285.378596605218, 8304.045034820952, 8338.458000229966, 8351.290140338078, 8219.383546234056, 8279.95860020696, 8280.130586288473, 8302.667893284322, 8332.291755200815, 41304.58695413038, 41532.58467415317, 41535.0, 41583.0, 41598.79200604008, 3010.1421094987822, 3055.3431012332453, 3069.079276217148, 3094.876204951799, 3133.8433078345993, 28691.28271793201, 28902.277443063882, 28978.0, 28996.0, 29065.709342906513, 3561.5013898054294, 3694.2980833641523, 3699.426588878728, 3821.0, 3827.4641550182996, 217763.0, 218290.0, 218459.0, 220972.0, 222945.0, 50307.24539131916, 50362.24456633154, 50378.748106259234, 50397.0, 50405.24392134121, 52701.7364913173, 52802.73598631982, 52864.20703689448, 52899.73550132225, 52961.735191324566, 14763.48327808543, 14787.116512280003, 14885.032472889228, 14890.702185956221, 14894.627634309229, 10039.196864250842, 10120.240981926238, 11417.828732569018, 11979.820302695467, 11985.64043078709, 13672.31638418075, 13819.792703109462, 13828.37772300249, 13847.515336963359, 13967.720645587031, 5105.774614092666, 5144.225242291403, 5224.92162617561, 5251.894962100737, 5280.392754833167, 1011.5346940407347, 1026.4457193115784, 1044.4307852220559, 1049.968500944973, 1055.0978913029403, 26082.347941301618, 26168.953241870113, 26268.474630507666, 28389.858050710027, 30981.380372392425, 1076.9461526923621, 1115.642994241851, 1119.798436281477, 1125.0718157519916, 1127.261643623428, 13441.260730659907, 13920.443182272596, 13979.720405591832, 14039.157650541, 14161.433542658384, 295146.0, 298534.0, 299271.0, 299426.0, 300390.0, 54690.72654636701, 54729.45270547244, 54732.72633636806, 54770.726146369016, 54787.72606136944, 1376.1536654957329, 1414.0596503325173, 1427.414759948437, 1441.7981482592445, 1448.8116544849102, 23990.0, 24307.39231519226, 25009.74990250147, 25212.0, 25261.0, 41857.37213941854, 41864.581354187285, 41923.1615367697, 41925.37111943385, 41936.16127677368, 293112.0, 293973.0, 294793.0, 295748.0, 296142.0, 25508.489830203664, 33135.83432082824, 33621.3275734479, 33800.830995844866, 33896.0, 30358.0, 34921.0, 35749.821250893576, 38775.41836872393, 40371.394429084175, 29200.415991679623, 30065.54901676433, 30774.384512310076, 31113.911013114433, 31236.37527249488, 30474.390512190075, 31083.0, 32426.0, 32921.83539082385, 33532.32935341328, 38123.046923827125, 38800.22399552049, 38860.6113938857, 38861.80569097136, 38977.41533877051, 31996.84001579977, 32253.193670158435, 32374.83812581016, 32456.188595285308, 32642.836785815918, 24239.757602424455, 25601.903695408644, 25701.3574660635, 25706.20209197347, 25934.0], "value": 17487.959599396163, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [429.7378599054574, 441.5363867938665, 443.2686067987822, 448.2916991153975, 453.3969820139214, 18523.629527409445, 19654.90172549137, 20131.396058118244, 20182.293619723314, 20249.59500809983, 21153.68269475959, 22344.553108937813, 22454.0, 22500.54998900021, 22651.660225096635, 5924.466797988181, 6171.845703857417, 6172.660503672296, 6181.690915454232, 6182.567220294582, 5852.824415267549, 5938.792142275021, 6033.42682445167, 6071.848203794896, 6075.696215189245, 5954.851128721795, 6033.969830150843, 6041.516678665696, 6048.727807248684, 6050.455459008688, 6037.305709843358, 6102.420270074358, 6124.816255512297, 6135.263768347804, 6136.263648362181, 5287.4976877196605, 5420.105682562373, 5504.91742623861, 5512.91730624041, 5518.172274158908, 25311.746882531308, 25589.232323030337, 25712.228633141036, 25997.870010649825, 26396.0, 2021.444102871722, 2029.1173339597174, 2039.5512987142804, 2077.522169900916, 2084.3121769816075, 15132.167730774803, 16197.595060123473, 16449.58876028097, 16559.0, 17072.317107315692, 1820.7997120316754, 1870.1584287070873, 1898.905054747271, 1918.3189967561593, 1921.798211187819, 101545.0, 104020.47989760079, 108989.45505272502, 109655.0, 109939.45030274878, 11897.286162830258, 11935.164538482397, 12349.567765128177, 12411.379431028412, 12449.875501245053, 17004.914975425043, 17075.48773536796, 17119.22963466647, 17130.828691713174, 17131.74302385465, 8274.213949674771, 8403.789905252417, 8507.404481686346, 8751.299896008304, 8770.605322760492, 7923.920760792434, 8006.279434850891, 8027.117017128111, 8194.426390152752, 8210.712625058213, 7518.586477743776, 7816.41376896735, 7819.296263336213, 7868.645910934022, 7978.840423191504, 2102.2431924507164, 2176.216562037665, 2176.8149707274742, 2198.65920782279, 2281.05336285443, 992.8212921674024, 1000.0849222960909, 1011.4588695048114, 1017.9389236645825, 1019.0828254570797, 19762.4071277859, 19965.301214457424, 20116.39650810478, 20174.394768156977, 20491.69262461064, 1040.2926010312908, 1046.2885238038054, 1048.9737756556146, 1060.379677888444, 1064.9254552181428, 10191.23565732573, 11047.72380690473, 11139.832902506469, 11187.776244475064, 11227.214095013434, 561649.0, 562158.4870193799, 562814.0, 596000.0, 603840.0, 105671.47164264129, 109146.45426772974, 113931.43034284776, 114915.0, 116548.0, 1200.363807182195, 1210.9515619375302, 1265.5127775806382, 1273.5287943460794, 1285.2481298440516, 18442.907785460986, 18685.532861678566, 20276.290329838386, 20718.585628287652, 20777.688334675295, 49619.0, 50334.74832625814, 50787.23819142642, 51192.0, 52159.2176117351, 61609.07586386118, 61996.690016549626, 64211.0, 64882.0, 67840.0, 8770.473771573726, 8789.208971192624, 8794.340424468062, 8997.865032024394, 9136.314776391664, 12554.43505042257, 13598.86401135976, 14052.859471405154, 14262.429502820187, 14699.265036748333, 11398.145139114766, 11746.647600571996, 11844.585439509576, 12619.684507887376, 13139.14595551286, 11585.362805045466, 11632.18574699763, 11707.590234341757, 11828.112891532997, 11977.461014254206, 12388.504459821506, 12531.0, 12661.74676506483, 12721.872781272068, 13032.804507932198, 8824.867626985471, 8916.924090366874, 9221.893372795308, 9271.351005429555, 9442.244620430212, 11671.941640291745, 12215.144939854481, 12338.198017128858, 12612.810807838074, 12826.486940522274], "value": 10175.14334561162, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1167.1421505193675, 1305.6801083734485, 1352.4049418255972, 1365.5698454986677, 1370.4107233889426, 8861.113888611135, 10452.0, 10777.191710621715, 10778.19163562732, 10801.945990270056, 10507.63223287185, 10572.524236409361, 10584.470776461165, 10594.25840191185, 10607.15142788577, 2027.959440811183, 2087.551176497053, 2360.1503458754833, 2396.2930935374106, 2400.23192578375, 2330.627099664054, 2399.928002159938, 2404.879756012201, 2405.4106743847783, 2409.8674572898485, 2345.8006069484027, 2350.9412264693347, 2367.0413482539598, 2369.656399822025, 2369.9881500592473, 2358.0803486640225, 2359.7168339799164, 2363.8463499872455, 2367.4081479630095, 2369.5024044950583, 2188.0919418441326, 2213.3249358945513, 2337.5091230841545, 2370.19413399445, 2372.110458578033, 11003.504842282116, 11020.44897755109, 11126.0, 11150.163737719622, 11186.496607652674, 6199.132121502993, 6412.3908228718665, 6419.518536109764, 6432.646204458753, 6435.292117867031, 3708.9443658345144, 3727.720420968411, 3872.9031774205587, 3916.2167566486814, 3921.3529767588598, 1324.2650329067365, 1329.1427029565973, 1352.4860552989899, 1398.979015314771, 1432.5845504803594, 16238.269277882406, 16310.510684679479, 16328.346866125341, 16338.264778085015, 16340.918295408446, 5104.157813960729, 5620.943790562042, 5641.294838145232, 5660.15097735343, 5736.827895163068, 13510.729785404237, 13519.188848669111, 13552.492788834097, 13576.93211533936, 13586.796198057036, 6437.549371543947, 6477.190351206099, 6493.0, 6495.64273964927, 6497.772577959749, 4885.609151267961, 5007.4491805901325, 5585.301837270341, 5707.086866101404, 5938.0, 3952.2490726761825, 3999.9800000999808, 4007.6192761687594, 4033.6773058155277, 4208.431861698693, 1184.490669012333, 1191.6961174900518, 1198.484651599803, 1203.3622180244483, 1210.7881120803825, 847.8643417053241, 856.7986523167051, 860.3676297921023, 878.310526236901, 882.1090698394668, 6581.506387020897, 6838.247792742794, 6896.689648965808, 6908.3437073477935, 7101.183363913113, 955.8805149356331, 965.2278177458005, 969.14230905649, 970.5680971967548, 981.4062492192121, 4542.386777784956, 4639.9536004640195, 4726.503717109723, 4828.589569886599, 4934.407871055496, 13367.933160334136, 13842.584722458343, 13884.09753366028, 14336.139831610137, 14690.0, 13500.392482338319, 13612.455501780016, 13700.0, 13738.519151829638, 13738.793918091236, 9720.854187187057, 9822.656207032862, 9857.408555486694, 9923.255755818342, 9941.105300522988, 6480.8703825922275, 6659.500537459613, 6903.930960690329, 6940.687669054803, 7147.499675022698, 12159.148859580098, 12554.748905022032, 12696.301703406401, 12727.93636031814, 12795.680107997374, 13067.607971760863, 13140.540081097115, 13233.933830331172, 13297.933510332387, 13340.799888001882, 8682.739517814476, 8915.063918288746, 9838.754031148992, 10013.849792253268, 10116.59533618647, 10109.39343639384, 10223.693289201336, 10346.430946298025, 10355.17158627323, 10377.066064054272, 8796.60415281301, 8831.69089081879, 8960.955195223982, 9062.456252624863, 9077.954610226907, 8589.527575983131, 8802.691905783267, 8808.251298639687, 8911.73264802057, 9060.864087038832, 7240.818979525343, 7454.4781865268915, 7534.208908064794, 7578.469507134448, 7611.733589324569, 5703.543716502752, 5797.623154494944, 5810.0, 5866.090755932667, 5973.701314934323, 5704.0588302929555, 5751.079827227623, 5766.452187042224, 5963.194968679173, 6014.0], "value": 5256.912005609962, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [421.63317913415335, 423.5002696817755, 427.6899248045166, 431.69781153192775, 434.93258544925527, 5698.145278208271, 5902.49828764555, 5906.409359064091, 5949.196858424117, 5987.790427335033, 5813.593048486608, 5837.678927658988, 5847.4152584741505, 5848.561357898154, 5864.44287792659, 4652.534746525354, 4676.111538807616, 4682.204025315705, 4689.742064186468, 4697.835575754849, 4501.279795232747, 4649.372334734801, 4691.624670026406, 4692.02056694, 4701.600363969067, 4617.699849509788, 4628.120657075145, 4637.814487420516, 4641.837535686252, 4662.479827730059, 4636.420447444069, 4639.188142075157, 4640.2807564827335, 4643.489216186217, 4660.13787449323, 3812.218495208476, 4227.492700875884, 4241.893952651178, 4249.575042495757, 4250.236151996917, 5673.290838645169, 5694.715264236772, 5695.77216911323, 5698.886022279531, 5731.283589551306, 5244.5542128918705, 5258.894822103574, 5266.60500462463, 5279.973600132013, 5308.0, 6045.0, 6188.47397971173, 6222.0, 6235.282942461584, 6273.651164999502, 4419.18245124653, 4435.423394958667, 4435.467743870724, 4447.7776111194635, 4447.799849006802, 6150.630962142286, 6356.968215158895, 6434.613923164578, 6527.5757075789925, 6533.869322613568, 4425.336199570091, 4442.311441726538, 4499.820007199675, 4519.389882365905, 4528.0943811237885, 4565.726056436624, 4570.748608826547, 4587.587117159472, 4588.403507544064, 4591.701539399928, 5100.719460429637, 5201.6358854880555, 5225.6603320784025, 5234.371875374979, 5245.239440281138, 6184.928049103511, 6185.938140618626, 6194.225721784777, 6204.937950620436, 6209.348018458088, 1566.154276690597, 1582.6834633073431, 1593.7768712380275, 1595.5213435969395, 1598.6403059311563, 1069.198101423932, 1074.9462526873624, 1081.853235570298, 1089.8147314956477, 1102.729831191347, 5954.0, 5979.850503737442, 5980.401959804072, 5983.19226904371, 5983.431574000463, 6378.77674281398, 6387.361263873576, 6406.615603063831, 6442.903356449657, 6467.353264673495, 5768.3366412862215, 5882.735276912549, 5892.263467066617, 5948.256467941507, 5977.790777322773, 3332.166958260435, 3374.274530975852, 3388.457846744509, 3403.846826892796, 3406.5230867678547, 6502.252240992347, 6586.571872828251, 6611.272759996396, 6645.867082658417, 6697.296783837627, 6506.869862602722, 6512.120863683437, 6521.739130434825, 6534.901976470357, 6566.343365663491, 6461.935380646133, 6512.6743662815725, 6622.437092847065, 6673.265940746514, 6686.699098540577, 6313.463355614824, 6356.300806911328, 6359.618422894641, 6361.777337793155, 6369.394907483782, 6101.420365065312, 6313.494920406265, 6329.683515824282, 6352.745890164341, 6363.268224154282, 6609.810234157898, 6633.800985970429, 6647.169103862017, 6647.401733843977, 6653.534252602271, 4561.885952851073, 4566.337881007302, 4579.473360563445, 4594.310853372021, 4602.976985115053, 6348.555601107878, 6425.261094973951, 6426.325235850355, 6476.838079048061, 6492.35076492347, 6149.754009839557, 6203.379662033761, 6210.130581718653, 6231.0, 6240.313565507881, 5922.911156332744, 6136.907946380898, 6181.412765787243, 6203.96898015507, 6212.695333979734, 6170.0, 6173.59871608344, 6189.226346706661, 6194.38056194377, 6217.782377616762, 6214.881321362017, 6219.564630476004, 6236.469900058546, 6242.406971337716, 6262.937370626418, 5684.7157642118555, 6035.577509574287, 6067.54493412987, 6070.423309785563, 6089.969550152221], "value": 4765.576910197019, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [754.3135746470713, 759.6505607420586, 762.0702742653962, 765.5751058162721, 774.6823802241082, 15179.620509487255, 15838.128902910335, 15902.681946361066, 15968.441104561343, 16647.91676041621, 15418.61453463664, 15560.45538406156, 15569.92215038926, 15572.922135389308, 15590.06459612424, 806.8063664720454, 808.6118663041743, 818.5866137600533, 824.5506199121463, 825.6614787936948, 827.148037521354, 841.0958219913587, 842.5197637346715, 843.5529169540154, 844.5144042175742, 859.866720658299, 865.0614083719172, 866.57537806475, 866.5970323799432, 868.3053557154283, 852.8550146475083, 860.0410542245352, 861.0055386029146, 864.9437786543855, 867.4535042922981, 632.0740115730476, 634.7746549974738, 635.6694518850218, 639.2393052267787, 640.2924768131242, 16548.33806647745, 16984.15079246033, 17054.232559534852, 17396.130193490273, 17449.21478533469, 15859.286332115082, 15990.520284391487, 16409.753853692204, 16441.506754797254, 16598.917005414896, 12463.563775267821, 12631.368431578385, 12935.935320323431, 12978.286194259312, 13734.725305493834, 3033.9544906826413, 3177.6504584495688, 3184.633767116788, 3201.103690966533, 3269.722073623745, 69377.65311173412, 70702.0, 70835.0, 71707.64146179288, 72796.99999999948, 12255.0, 12265.57070502528, 12291.0, 12470.625881223577, 12545.623631291075, 23656.0, 23819.166329178395, 23866.522669546513, 24689.012439502578, 25073.49853002966, 7801.127729344917, 8051.677932882736, 8245.216704413071, 8264.793380165424, 8736.650533978569, 4116.444280022159, 4204.138151678899, 4403.84586539476, 4445.555444455528, 4553.590176884097, 4266.253405653998, 4383.16719823239, 4383.583559561836, 4415.735055896592, 4440.68915175941, 825.5707032343269, 836.9497830130211, 840.4411066640615, 848.4315508609246, 861.3625916821507, 581.9679917604487, 591.798788411942, 596.2517041113375, 602.3856065743848, 605.797057985571, 10128.746781330377, 10451.111655509367, 10673.57305707763, 10838.512266947848, 11073.446327683583, 611.8623309755269, 626.3673689573563, 627.4697880291146, 630.8738252349549, 633.4140919649305, 4797.088553174955, 4943.184374578226, 4946.183879659816, 4955.182394904872, 4963.553280204799, 62266.377336226964, 78445.0, 80765.19234807577, 81054.594727026, 81392.59303703562, 60521.69739151276, 60932.39067609356, 61433.0, 62449.37550624435, 62666.68666656638, 56321.0, 62132.378676213564, 62614.0, 62682.68658656769, 62885.37114628795, 10885.238033337908, 11143.523341767064, 11237.269577477438, 11247.212695111264, 11355.261907975955, 32439.513407298437, 32799.83600081984, 32904.67095329016, 32909.0, 33358.83320583381, 38498.0, 39528.80235598804, 39667.801660991514, 40120.39819402653, 49095.50904491052, 13087.869121308666, 13931.303434828016, 13956.302184890917, 14089.929550352183, 14196.29018549089, 15120.54638360851, 15777.68444631078, 15959.202039898191, 15968.361265549247, 16141.515754527383, 15139.54581362561, 15158.621034473785, 15260.542183734506, 15407.845921540642, 15535.733775189332, 13257.403416846073, 13290.335483225606, 13652.385642646303, 14106.50627228083, 15069.0, 13922.582322530341, 14515.92742036283, 14517.397580765846, 14667.413303468169, 14775.113493190443, 11048.944755276172, 11415.714607134889, 11798.646040618794, 12310.168661207794, 12416.875831241572, 11160.218784684994, 11325.377104259345, 11349.602763903224, 11453.083753299883, 11519.76960460803], "value": 7350.472692011256, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1493.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 108.0, 109.0, 108.0, 110.0, 109.0, 110.0, 108.0, 108.0, 108.0], "value": 107.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 116.0, 121.0, 162.0, 119.0, 121.0, 117.0, 115.0, 143.0, 117.0], "value": 127.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 161.0, 161.0, 162.0, 162.0, 162.0, 164.0, 161.0, 162.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 74.0, 103.0, 79.0, 75.0, 74.0, 74.0, 90.0, 77.0], "value": 79.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 83.0, 101.0, 82.0, 82.0, 82.0, 100.0, 84.0, 83.0, 101.0], "value": 87.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 114.0, 114.0, 113.0, 113.0, 113.0, 113.0, 113.0, 113.0], "value": 113.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 146.0, 147.0, 147.0, 147.0, 147.0, 148.0, 147.0, 147.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 94.0, 94.0, 94.0, 94.0, 94.0, 95.0, 94.0, 93.0], "value": 93.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 59.0, 59.0, 60.0, 59.0, 60.0, 59.0, 58.0, 58.0], "value": 58.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 55.0, 55.0, 55.0, 55.0, 55.0, 55.0, 56.0, 57.0], "value": 55.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 81.0, 79.0, 79.0, 79.0, 78.0, 78.0, 80.0, 79.0, 87.0], "value": 79.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 127.0, 125.0, 139.0, 130.0, 125.0, 124.0, 124.0, 211.0, 125.0], "value": 135.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 184.0, 187.0, 176.0, 178.0, 197.0, 179.0, 173.0, 172.0, 179.0], "value": 181.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 63.0, 65.0, 69.0, 62.0, 63.0, 64.0, 63.0], "value": 64.4, "unit": "score"}]}]} 15:36:21 INFO - Return code: 0 15:36:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:36:21 ERROR - # TBPL SUCCESS # 15:36:21 INFO - Running post-action listener: _resource_record_post_action 15:36:21 INFO - [mozharness: 2017-03-27 22:36:21.072361Z] Finished run-tests step (success) 15:36:21 INFO - Running post-run listener: _resource_record_post_run 15:36:21 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 4096; Write bytes: 372948992; Read time: 8; Write time: 226660 15:36:21 INFO - TinderboxPrint: CPU usage
13.0% 15:36:21 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 15:36:21 INFO - TinderboxPrint: I/O write bytes / time
372,948,992 / 226,660 15:36:21 INFO - TinderboxPrint: CPU idle
8,300.7 (87.0%) 15:36:21 INFO - TinderboxPrint: CPU user
1,193.2 (12.5%) 15:36:21 INFO - TinderboxPrint: Swap in / out
0 / 0 15:36:21 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 112115712; Read time: 0; Write time: 96380 15:36:21 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 0; Write bytes: 260448256; Read time: 0; Write time: 130248 15:36:21 INFO - Running post-run listener: _upload_blobber_files 15:36:21 INFO - Blob upload gear active. 15:36:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:36:21 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 15:36:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:36:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:36:22 INFO - (blobuploader) - INFO - Open directory for files ... 15:36:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:36:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:36:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:36:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:36:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:36:22 INFO - (blobuploader) - INFO - Done attempting. 15:36:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 15:36:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:36:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:36:23 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 15:36:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:36:23 INFO - (blobuploader) - INFO - Done attempting. 15:36:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:36:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:36:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:36:26 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:36:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:36:26 INFO - (blobuploader) - INFO - Done attempting. 15:36:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:36:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:36:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:36:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:36:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:36:28 INFO - (blobuploader) - INFO - Done attempting. 15:36:28 INFO - (blobuploader) - INFO - Iteration through files over. 15:36:28 INFO - Return code: 0 15:36:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:36:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:36:28 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/45847ef08e74af8e12c0d227201bb1f822890116ca6d7b7ce0395fc9a15c922c945098afcb961da2cfd43f91e2487dc5314a4e0e840547f124258edc90c8023a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a0eb7965b606910644ce0e54134c60078eadbb7207336346dae575343da8b45343a07518b61c37c545238e4d1fe8aca3954ce81bb37911f3ab49488a1cc3186e", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7c9236608ead60eb04297fd30f14ce65f3e009119736cd7904e17ff8f6dcb99e3ba679b4b6a2fb900e79c4e6dfed9c23ffd3462d435f94665d2162e001713638", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/702225eacf25ff664e9e46598e1a831cad4abe98132d2f246bfc135d45c94bdc3e094cf2fa5da4495f7b8ef97ed7f66559394ceb2c4f63e9d1e7e015f63d4fc6"} 15:36:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:36:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:36:28 INFO - Contents: 15:36:28 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/45847ef08e74af8e12c0d227201bb1f822890116ca6d7b7ce0395fc9a15c922c945098afcb961da2cfd43f91e2487dc5314a4e0e840547f124258edc90c8023a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a0eb7965b606910644ce0e54134c60078eadbb7207336346dae575343da8b45343a07518b61c37c545238e4d1fe8aca3954ce81bb37911f3ab49488a1cc3186e", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7c9236608ead60eb04297fd30f14ce65f3e009119736cd7904e17ff8f6dcb99e3ba679b4b6a2fb900e79c4e6dfed9c23ffd3462d435f94665d2162e001713638", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/702225eacf25ff664e9e46598e1a831cad4abe98132d2f246bfc135d45c94bdc3e094cf2fa5da4495f7b8ef97ed7f66559394ceb2c4f63e9d1e7e015f63d4fc6"} 15:36:28 INFO - Running post-run listener: copy_logs_to_upload_dir 15:36:28 INFO - Copying logs to upload dir... 15:36:28 INFO - mkdir: /builds/slave/test/build/upload/logs 15:36:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.199893 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-03-27 15:36:27.616423) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-27 15:36:27.620129) ========= 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-1490652929.223524-888603613 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/45847ef08e74af8e12c0d227201bb1f822890116ca6d7b7ce0395fc9a15c922c945098afcb961da2cfd43f91e2487dc5314a4e0e840547f124258edc90c8023a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a0eb7965b606910644ce0e54134c60078eadbb7207336346dae575343da8b45343a07518b61c37c545238e4d1fe8aca3954ce81bb37911f3ab49488a1cc3186e", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7c9236608ead60eb04297fd30f14ce65f3e009119736cd7904e17ff8f6dcb99e3ba679b4b6a2fb900e79c4e6dfed9c23ffd3462d435f94665d2162e001713638", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/702225eacf25ff664e9e46598e1a831cad4abe98132d2f246bfc135d45c94bdc3e094cf2fa5da4495f7b8ef97ed7f66559394ceb2c4f63e9d1e7e015f63d4fc6"} build_url:https://queue.taskcluster.net/v1/task/aZV0mLiPQcOUxtDC_aGQpQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011212 build_url: 'https://queue.taskcluster.net/v1/task/aZV0mLiPQcOUxtDC_aGQpQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/45847ef08e74af8e12c0d227201bb1f822890116ca6d7b7ce0395fc9a15c922c945098afcb961da2cfd43f91e2487dc5314a4e0e840547f124258edc90c8023a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a0eb7965b606910644ce0e54134c60078eadbb7207336346dae575343da8b45343a07518b61c37c545238e4d1fe8aca3954ce81bb37911f3ab49488a1cc3186e", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7c9236608ead60eb04297fd30f14ce65f3e009119736cd7904e17ff8f6dcb99e3ba679b4b6a2fb900e79c4e6dfed9c23ffd3462d435f94665d2162e001713638", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/702225eacf25ff664e9e46598e1a831cad4abe98132d2f246bfc135d45c94bdc3e094cf2fa5da4495f7b8ef97ed7f66559394ceb2c4f63e9d1e7e015f63d4fc6"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-27 15:36:27.645080) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-27 15:36:27.645408) ========= 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-1490652929.223524-888603613 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004472 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-27 15:36:27.729265) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-27 15:36:27.729822) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-27 15:36:27.730310) ========= ========= Total master_lag: 0.16 =========