builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-072 starttime: 1490887922.02 results: success (0) revision: 3364cc17988c013c36f2a8123315db2855393011 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-30 08:32:02.022557) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-30 08:32:02.023078) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-30 08:32:02.023358) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-30 08:32:02.038792) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-30 08:32:02.039195) ========= 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=199fb4c72b90437b990b419b000001c5-1490887420.724272-363469947 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-30 08:32:02-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 89.1M=0s 2017-03-30 08:32:02 (89.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.117363 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-30 08:32:02.174878) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-30 08:32:02.175212) ========= 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=199fb4c72b90437b990b419b000001c5-1490887420.724272-363469947 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015191 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-30 08:32:02.225733) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-30 08:32:02.226101) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3364cc17988c013c36f2a8123315db2855393011 --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 3364cc17988c013c36f2a8123315db2855393011 --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=199fb4c72b90437b990b419b000001c5-1490887420.724272-363469947 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-30 08:32:02,706 truncating revision to first 12 chars 2017-03-30 08:32:02,706 Setting DEBUG logging. 2017-03-30 08:32:02,706 attempt 1/10 2017-03-30 08:32:02,706 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3364cc17988c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-30 08:32:03,439 unpacking tar archive at: mozilla-central-3364cc17988c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.108443 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-30 08:32:03.348131) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-30 08:32:03.348557) ========= script_repo_revision: 3364cc17988c013c36f2a8123315db2855393011 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-30 08:32:03.348980) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-30 08:32:03.349258) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-30 08:32:03.360960) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2017-03-30 08:32:03.361542) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=199fb4c72b90437b990b419b000001c5-1490887420.724272-363469947 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:32:03 INFO - MultiFileLogger online at 20170330 08:32:03 in /builds/slave/test 08:32:03 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 08:32:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:32:03 INFO - {'append_to_log': False, 08:32:03 INFO - 'base_work_dir': '/builds/slave/test', 08:32:03 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 08:32:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:32:03 INFO - 'branch': 'Firefox-Non-PGO', 08:32:03 INFO - 'buildbot_json_path': 'buildprops.json', 08:32:03 INFO - 'config_files': ('talos/linux_config.py',), 08:32:03 INFO - 'default_actions': ('clobber', 08:32:03 INFO - 'read-buildbot-config', 08:32:03 INFO - 'download-and-extract', 08:32:03 INFO - 'populate-webroot', 08:32:03 INFO - 'create-virtualenv', 08:32:03 INFO - 'install', 08:32:03 INFO - 'run-tests'), 08:32:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:32:03 INFO - 'download_minidump_stackwalk': True, 08:32:03 INFO - 'download_symbols': 'ondemand', 08:32:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:32:03 INFO - 'tooltool.py': '/tools/tooltool.py', 08:32:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:32:03 INFO - '/tools/misc-python/virtualenv.py')}, 08:32:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:32:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:32:03 INFO - 'gecko_profile': False, 08:32:03 INFO - 'gecko_profile_interval': 0, 08:32:03 INFO - 'installer_path': 'installer.exe', 08:32:03 INFO - 'log_level': 'info', 08:32:03 INFO - 'log_name': 'talos', 08:32:03 INFO - 'log_to_console': True, 08:32:03 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:32:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:32:03 INFO - 'opt_config_files': (), 08:32:03 INFO - 'pip_index': False, 08:32:03 INFO - 'suite': 'dromaeojs', 08:32:03 INFO - 'system_bits': '32', 08:32:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:32:03 INFO - 'title': 'talos-linux64-ix-072', 08:32:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:32:03 INFO - 'use_talos_json': True, 08:32:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:32:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:32:03 INFO - 'work_dir': 'build'} 08:32:03 INFO - [mozharness: 2017-03-30 15:32:03.945879Z] Running clobber step. 08:32:03 INFO - Running pre-action listener: _resource_record_pre_action 08:32:03 INFO - Running main action method: clobber 08:32:03 INFO - rmtree: /builds/slave/test/build 08:32:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:32:05 INFO - Running post-action listener: _resource_record_post_action 08:32:05 INFO - [mozharness: 2017-03-30 15:32:05.394495Z] Finished clobber step (success) 08:32:05 INFO - [mozharness: 2017-03-30 15:32:05.394594Z] Running read-buildbot-config step. 08:32:05 INFO - Running pre-action listener: _resource_record_pre_action 08:32:05 INFO - Running main action method: read_buildbot_config 08:32:05 INFO - Using buildbot properties: 08:32:05 INFO - { 08:32:05 INFO - "project": "", 08:32:05 INFO - "product": "firefox", 08:32:05 INFO - "who": "ffxbld@noreply.mozilla.org", 08:32:05 INFO - "installer_path": "public/build/target.tar.bz2", 08:32:05 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 08:32:05 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 08:32:05 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 08:32:05 INFO - "stage_platform": "linux64", 08:32:05 INFO - "basedir": "/builds/slave/test", 08:32:05 INFO - "buildnumber": 518, 08:32:05 INFO - "platform": "ubuntu64_hw", 08:32:05 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:32:05 INFO - "slavebuilddir": "test", 08:32:05 INFO - "taskId": "bRY9AucaSj2Lx5D1SDJSag", 08:32:05 INFO - "branch": "mozilla-central", 08:32:05 INFO - "script_repo_revision": "production", 08:32:05 INFO - "revision": "3364cc17988c013c36f2a8123315db2855393011", 08:32:05 INFO - "slavename": "talos-linux64-ix-072", 08:32:05 INFO - "repo_path": "mozilla-central" 08:32:05 INFO - } 08:32:05 INFO - Finding installer, test and symbols from parent task. 08:32:05 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bRY9AucaSj2Lx5D1SDJSag'}, attempt #1 08:32:05 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bRY9AucaSj2Lx5D1SDJSag'}, attempt #1 08:32:06 INFO - Task dependencies: WPrw1PBMSS-vUjG5HGKOMw 08:32:06 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WPrw1PBMSS-vUjG5HGKOMw'}, attempt #1 08:32:06 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/WPrw1PBMSS-vUjG5HGKOMw/artifacts/public/build/target.tar.bz2 08:32:06 INFO - Set test_url: https://queue.taskcluster.net/v1/task/WPrw1PBMSS-vUjG5HGKOMw/artifacts/public/build/test_packages.json 08:32:06 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/WPrw1PBMSS-vUjG5HGKOMw/artifacts/public/build/target.crashreporter-symbols.zip 08:32:06 INFO - Running post-action listener: _resource_record_post_action 08:32:06 INFO - [mozharness: 2017-03-30 15:32:06.889182Z] Finished read-buildbot-config step (success) 08:32:06 INFO - [mozharness: 2017-03-30 15:32:06.889406Z] Running download-and-extract step. 08:32:06 INFO - Running pre-action listener: _resource_record_pre_action 08:32:06 INFO - Running main action method: download_and_extract 08:32:06 INFO - mkdir: /builds/slave/test/build/tests 08:32: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')]} 08:32:06 INFO - trying https://queue.taskcluster.net/v1/task/WPrw1PBMSS-vUjG5HGKOMw/artifacts/public/build/target.test_packages.json 08:32:06 INFO - Downloading https://queue.taskcluster.net/v1/task/WPrw1PBMSS-vUjG5HGKOMw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 08:32:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WPrw1PBMSS-vUjG5HGKOMw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 08:32:07 INFO - Downloaded 986 bytes. 08:32:07 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 08:32:07 INFO - Using the following test package requirements: 08:32:07 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 08:32:07 INFO - u'common': [u'target.common.tests.zip'], 08:32:07 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 08:32:07 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 08:32:07 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 08:32:07 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 08:32:07 INFO - u'mozbase': [u'target.common.tests.zip'], 08:32:07 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 08:32:07 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 08:32:07 INFO - u'web-platform': [u'target.common.tests.zip', 08:32:07 INFO - u'target.web-platform.tests.zip'], 08:32:07 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 08:32:07 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 08:32:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WPrw1PBMSS-vUjG5HGKOMw/artifacts/public/build/target.common.tests.zip 08:32:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WPrw1PBMSS-vUjG5HGKOMw/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:32:07 INFO - Fetch https://queue.taskcluster.net/v1/task/WPrw1PBMSS-vUjG5HGKOMw/artifacts/public/build/target.common.tests.zip into memory 08:32:09 INFO - Expected file size: 58234116 08:32:09 INFO - Obtained file size: 58234116 08:32:19 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 08:32:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WPrw1PBMSS-vUjG5HGKOMw/artifacts/public/build/target.common.tests.zip 08:32:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WPrw1PBMSS-vUjG5HGKOMw/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:32:19 INFO - Fetch https://queue.taskcluster.net/v1/task/WPrw1PBMSS-vUjG5HGKOMw/artifacts/public/build/target.common.tests.zip into memory 08:32:20 INFO - Expected file size: 58234116 08:32:20 INFO - Obtained file size: 58234116 08:32:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WPrw1PBMSS-vUjG5HGKOMw/artifacts/public/build/target.talos.tests.zip 08:32:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WPrw1PBMSS-vUjG5HGKOMw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 08:32:31 INFO - Fetch https://queue.taskcluster.net/v1/task/WPrw1PBMSS-vUjG5HGKOMw/artifacts/public/build/target.talos.tests.zip into memory 08:32:32 INFO - Expected file size: 14404152 08:32:32 INFO - Obtained file size: 14404152 08:32:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:32:33 INFO - trying https://queue.taskcluster.net/v1/task/WPrw1PBMSS-vUjG5HGKOMw/artifacts/public/build/target.tar.bz2 08:32:33 INFO - Downloading https://queue.taskcluster.net/v1/task/WPrw1PBMSS-vUjG5HGKOMw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 08:32:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WPrw1PBMSS-vUjG5HGKOMw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 08:32:35 INFO - Downloaded 62548797 bytes. 08:32:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WPrw1PBMSS-vUjG5HGKOMw/artifacts/public/build/target.tar.bz2 08:32:35 INFO - mkdir: /builds/slave/test/properties 08:32:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:32:35 INFO - Writing to file /builds/slave/test/properties/build_url 08:32:35 INFO - Contents: 08:32:35 INFO - build_url:https://queue.taskcluster.net/v1/task/WPrw1PBMSS-vUjG5HGKOMw/artifacts/public/build/target.tar.bz2 08:32:35 INFO - Running post-action listener: _resource_record_post_action 08:32:35 INFO - Running post-action listener: set_extra_try_arguments 08:32:35 INFO - [mozharness: 2017-03-30 15:32:35.554027Z] Finished download-and-extract step (success) 08:32:35 INFO - [mozharness: 2017-03-30 15:32:35.554163Z] Running populate-webroot step. 08:32:35 INFO - Running pre-action listener: _resource_record_pre_action 08:32:35 INFO - Running main action method: populate_webroot 08:32:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:32:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:32:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:32:35 INFO - '--tppagecycles', 08:32:35 INFO - '7'], 08:32:35 INFO - 'tests': ['tsvgm']}}, 08:32:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:32:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:32:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:32:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:32:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:32:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:32:35 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:32:35 INFO - 'talos_options': ['--disable-e10s'], 08:32:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:32:35 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:32:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:32:35 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:32:35 INFO - 'talos_options': ['--disable-e10s'], 08:32:35 INFO - 'tests': ['damp', 'tps']}, 08:32:35 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:32:35 INFO - 'tests': ['damp', 'tps']}, 08:32:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:32:35 INFO - 'tests': ['dromaeo_dom']}, 08:32:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:32:35 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:32:35 INFO - 'tests': ['basic_compositor_video']}, 08:32:35 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:32:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:32:35 INFO - 'tests': ['a11yr', 08:32:35 INFO - 'ts_paint', 08:32:35 INFO - 'tpaint', 08:32:35 INFO - 'sessionrestore', 08:32:35 INFO - 'sessionrestore_no_auto_restore', 08:32:35 INFO - 'tabpaint']}, 08:32:35 INFO - 'other-e10s': {'tests': ['a11yr', 08:32:35 INFO - 'ts_paint', 08:32:35 INFO - 'tpaint', 08:32:35 INFO - 'sessionrestore', 08:32:35 INFO - 'sessionrestore_no_auto_restore', 08:32:35 INFO - 'tabpaint']}, 08:32:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:32:35 INFO - 'ts_paint', 08:32:35 INFO - 'tpaint', 08:32:35 INFO - 'sessionrestore', 08:32:35 INFO - 'sessionrestore_no_auto_restore', 08:32:35 INFO - 'tabpaint']}, 08:32:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:32:35 INFO - 'ts_paint', 08:32:35 INFO - 'tpaint', 08:32:35 INFO - 'sessionrestore', 08:32:35 INFO - 'sessionrestore_no_auto_restore', 08:32:35 INFO - 'tabpaint']}, 08:32:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:32:35 INFO - 'tests': ['a11yr', 08:32:35 INFO - 'ts_paint', 08:32:35 INFO - 'tpaint', 08:32:35 INFO - 'sessionrestore', 08:32:35 INFO - 'sessionrestore_no_auto_restore', 08:32:35 INFO - 'tabpaint']}, 08:32:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:32:35 INFO - 'tests': ['a11yr', 08:32:35 INFO - 'ts_paint', 08:32:35 INFO - 'tpaint', 08:32:35 INFO - 'sessionrestore', 08:32:35 INFO - 'sessionrestore_no_auto_restore', 08:32:35 INFO - 'tabpaint']}, 08:32:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:32:35 INFO - 'tests': ['tsvgx', 08:32:35 INFO - 'tsvgr_opacity', 08:32:35 INFO - 'tart', 08:32:35 INFO - 'tscrollx', 08:32:35 INFO - 'cart', 08:32:35 INFO - 'tsvg_static']}, 08:32:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:32:35 INFO - 'tsvgr_opacity', 08:32:35 INFO - 'tart', 08:32:35 INFO - 'tscrollx', 08:32:35 INFO - 'cart', 08:32:35 INFO - 'tsvg_static']}, 08:32:35 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:32:35 INFO - 'talos_options': ['--disable-e10s'], 08:32:35 INFO - 'tests': ['tp5o']}, 08:32:35 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:32:35 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:32:35 INFO - 'talos_options': ['--disable-e10s', 08:32:35 INFO - '--xperf_path', 08:32:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:32:35 INFO - 'tests': ['tp5n']}, 08:32:35 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:32:35 INFO - 'talos_options': ['--xperf_path', 08:32:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:32:35 INFO - 'tests': ['tp5n']}}, 08:32:35 INFO - 'talos.zip': {'path': '', 08:32:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:32:35 INFO - Running post-action listener: _resource_record_post_action 08:32:35 INFO - [mozharness: 2017-03-30 15:32:35.569687Z] Finished populate-webroot step (success) 08:32:35 INFO - [mozharness: 2017-03-30 15:32:35.569778Z] Running create-virtualenv step. 08:32:35 INFO - Running pre-action listener: _resource_record_pre_action 08:32:35 INFO - Running main action method: create_virtualenv 08:32:35 INFO - Creating virtualenv /builds/slave/test/build/venv 08:32:35 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 08:32:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:32:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:32:35 INFO - Using real prefix '/usr' 08:32:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:32:36 INFO - Installing distribute.............................................................................................................................................................................................done. 08:32:38 INFO - Installing pip.................done. 08:32:38 INFO - Return code: 0 08:32:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:32:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:32:38 INFO - Reading from file tmpfile_stdout 08:32:38 INFO - Output received: 08:32:38 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) 08:32:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:32:38 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')]} 08:32:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:32:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:38 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')]} 08:32:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:32:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:38 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 0x21c91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2466b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2464290>, '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 0x2464b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2465040>, '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': '199fb4c72b90437b990b419b000001c5-1490887420.724272-363469947', '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 08:32:38 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 08:32:38 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 08:32:38 INFO - Using env: {'DISPLAY': ':0', 08:32:38 INFO - 'HOME': '/home/cltbld', 08:32:38 INFO - 'LANG': 'en_US.UTF-8', 08:32:38 INFO - 'LANGUAGE': 'en_US:en', 08:32:38 INFO - 'LOGNAME': 'cltbld', 08:32:38 INFO - 'MAIL': '/var/mail/cltbld', 08:32:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:38 INFO - 'MOZ_NO_REMOTE': '1', 08:32:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:32:38 INFO - 'NO_EM_RESTART': '1', 08:32:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:32:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:32:38 INFO - 'PWD': '/builds/slave/test', 08:32:38 INFO - 'SHELL': '/bin/bash', 08:32:38 INFO - 'SHLVL': '1', 08:32:38 INFO - 'TERM': 'linux', 08:32:38 INFO - 'TMOUT': '86400', 08:32:38 INFO - 'USER': 'cltbld', 08:32:38 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1490887420.724272-363469947', 08:32:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:38 INFO - '_': '/tools/buildbot/bin/python'} 08:32:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:32:38 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 08:32:38 INFO - Cleaning up... 08:32:38 INFO - Return code: 0 08:32:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:32:38 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')]} 08:32:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:32:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:38 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')]} 08:32:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:32:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:38 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 0x21c91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2466b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2464290>, '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 0x2464b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2465040>, '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': '199fb4c72b90437b990b419b000001c5-1490887420.724272-363469947', '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 08:32:38 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 08:32:38 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 08:32:38 INFO - Using env: {'DISPLAY': ':0', 08:32:38 INFO - 'HOME': '/home/cltbld', 08:32:38 INFO - 'LANG': 'en_US.UTF-8', 08:32:38 INFO - 'LANGUAGE': 'en_US:en', 08:32:38 INFO - 'LOGNAME': 'cltbld', 08:32:38 INFO - 'MAIL': '/var/mail/cltbld', 08:32:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:38 INFO - 'MOZ_NO_REMOTE': '1', 08:32:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:32:38 INFO - 'NO_EM_RESTART': '1', 08:32:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:32:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:32:38 INFO - 'PWD': '/builds/slave/test', 08:32:38 INFO - 'SHELL': '/bin/bash', 08:32:38 INFO - 'SHLVL': '1', 08:32:38 INFO - 'TERM': 'linux', 08:32:38 INFO - 'TMOUT': '86400', 08:32:38 INFO - 'USER': 'cltbld', 08:32:38 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1490887420.724272-363469947', 08:32:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:38 INFO - '_': '/tools/buildbot/bin/python'} 08:32:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:32:38 INFO - Downloading/unpacking psutil>=3.1.1 08:32:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:32:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:32:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:32:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:32:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:32:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:32:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:32:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:32:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:32:40 INFO - Installing collected packages: psutil 08:32:40 INFO - Running setup.py install for psutil 08:32:40 INFO - building 'psutil._psutil_linux' extension 08:32:40 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 08:32:41 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 08:32:41 INFO - building 'psutil._psutil_posix' extension 08:32:41 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 08:32:41 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 08:32:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:32:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:32:41 INFO - Successfully installed psutil 08:32:41 INFO - Cleaning up... 08:32:41 INFO - Return code: 0 08:32:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:32:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:32:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:32:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:32:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:32:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21c91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2466b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2464290>, '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 0x2464b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2465040>, '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': '199fb4c72b90437b990b419b000001c5-1490887420.724272-363469947', '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 08:32:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:32:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:32:41 INFO - Using env: {'DISPLAY': ':0', 08:32:41 INFO - 'HOME': '/home/cltbld', 08:32:41 INFO - 'LANG': 'en_US.UTF-8', 08:32:41 INFO - 'LANGUAGE': 'en_US:en', 08:32:41 INFO - 'LOGNAME': 'cltbld', 08:32:41 INFO - 'MAIL': '/var/mail/cltbld', 08:32:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:41 INFO - 'MOZ_NO_REMOTE': '1', 08:32:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:32:41 INFO - 'NO_EM_RESTART': '1', 08:32:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:32:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:32:41 INFO - 'PWD': '/builds/slave/test', 08:32:41 INFO - 'SHELL': '/bin/bash', 08:32:41 INFO - 'SHLVL': '1', 08:32:41 INFO - 'TERM': 'linux', 08:32:41 INFO - 'TMOUT': '86400', 08:32:41 INFO - 'USER': 'cltbld', 08:32:41 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1490887420.724272-363469947', 08:32:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:41 INFO - '_': '/tools/buildbot/bin/python'} 08:32:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:32:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:32:41 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 08:32:41 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 08:32:41 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 08:32:41 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 08:32:41 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 08:32:41 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 08:32:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:32:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:32:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:32:43 INFO - Installing collected packages: mozsystemmonitor 08:32:43 INFO - Running setup.py install for mozsystemmonitor 08:32:43 INFO - Successfully installed mozsystemmonitor 08:32:43 INFO - Cleaning up... 08:32:43 INFO - Return code: 0 08:32:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:32:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:32:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:32:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:32:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:32:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:43 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 0x21c91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2466b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2464290>, '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 0x2464b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2465040>, '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': '199fb4c72b90437b990b419b000001c5-1490887420.724272-363469947', '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 08:32:43 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 08:32:43 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 08:32:43 INFO - Using env: {'DISPLAY': ':0', 08:32:43 INFO - 'HOME': '/home/cltbld', 08:32:43 INFO - 'LANG': 'en_US.UTF-8', 08:32:43 INFO - 'LANGUAGE': 'en_US:en', 08:32:43 INFO - 'LOGNAME': 'cltbld', 08:32:43 INFO - 'MAIL': '/var/mail/cltbld', 08:32:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:43 INFO - 'MOZ_NO_REMOTE': '1', 08:32:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:32:43 INFO - 'NO_EM_RESTART': '1', 08:32:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:32:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:32:43 INFO - 'PWD': '/builds/slave/test', 08:32:43 INFO - 'SHELL': '/bin/bash', 08:32:43 INFO - 'SHLVL': '1', 08:32:43 INFO - 'TERM': 'linux', 08:32:43 INFO - 'TMOUT': '86400', 08:32:43 INFO - 'USER': 'cltbld', 08:32:43 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1490887420.724272-363469947', 08:32:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:43 INFO - '_': '/tools/buildbot/bin/python'} 08:32:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:32:44 INFO - Downloading/unpacking jsonschema==2.5.1 08:32:44 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 08:32:44 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 08:32:44 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 08:32:44 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 08:32:44 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 08:32:44 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 08:32:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:32:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:32:46 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 08:32:46 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 08:32:46 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 08:32:46 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 08:32:46 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 08:32:46 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 08:32:46 INFO - Downloading functools32-3.2.3-2.tar.gz 08:32:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:32:46 INFO - warning: no files found matching '*.txt' 08:32:46 INFO - no previously-included directories found matching 'build' 08:32:46 INFO - no previously-included directories found matching 'dist' 08:32:46 INFO - no previously-included directories found matching '.git*' 08:32:46 INFO - Installing collected packages: jsonschema, functools32 08:32:46 INFO - Running setup.py install for functools32 08:32:46 INFO - warning: no files found matching '*.txt' 08:32:46 INFO - no previously-included directories found matching 'build' 08:32:46 INFO - no previously-included directories found matching 'dist' 08:32:46 INFO - no previously-included directories found matching '.git*' 08:32:46 INFO - Successfully installed jsonschema functools32 08:32:46 INFO - Cleaning up... 08:32:46 INFO - Return code: 0 08:32:46 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:32:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:32:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:32:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:32:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:32:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:46 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 0x21c91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2466b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2464290>, '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 0x2464b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2465040>, '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': '199fb4c72b90437b990b419b000001c5-1490887420.724272-363469947', '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 08:32:46 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 08:32:46 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 08:32:46 INFO - Using env: {'DISPLAY': ':0', 08:32:46 INFO - 'HOME': '/home/cltbld', 08:32:46 INFO - 'LANG': 'en_US.UTF-8', 08:32:46 INFO - 'LANGUAGE': 'en_US:en', 08:32:46 INFO - 'LOGNAME': 'cltbld', 08:32:46 INFO - 'MAIL': '/var/mail/cltbld', 08:32:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:46 INFO - 'MOZ_NO_REMOTE': '1', 08:32:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:32:46 INFO - 'NO_EM_RESTART': '1', 08:32:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:32:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:32:46 INFO - 'PWD': '/builds/slave/test', 08:32:46 INFO - 'SHELL': '/bin/bash', 08:32:46 INFO - 'SHLVL': '1', 08:32:46 INFO - 'TERM': 'linux', 08:32:46 INFO - 'TMOUT': '86400', 08:32:46 INFO - 'USER': 'cltbld', 08:32:46 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1490887420.724272-363469947', 08:32:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:46 INFO - '_': '/tools/buildbot/bin/python'} 08:32:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:32:46 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:32:46 INFO - Cleaning up... 08:32:46 INFO - Return code: 0 08:32:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:32:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:32:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:32:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:32:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:32:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:46 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 0x21c91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2466b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2464290>, '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 0x2464b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2465040>, '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': '199fb4c72b90437b990b419b000001c5-1490887420.724272-363469947', '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 08:32:46 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 08:32:46 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 08:32:46 INFO - Using env: {'DISPLAY': ':0', 08:32:46 INFO - 'HOME': '/home/cltbld', 08:32:46 INFO - 'LANG': 'en_US.UTF-8', 08:32:46 INFO - 'LANGUAGE': 'en_US:en', 08:32:46 INFO - 'LOGNAME': 'cltbld', 08:32:46 INFO - 'MAIL': '/var/mail/cltbld', 08:32:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:46 INFO - 'MOZ_NO_REMOTE': '1', 08:32:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:32:46 INFO - 'NO_EM_RESTART': '1', 08:32:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:32:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:32:46 INFO - 'PWD': '/builds/slave/test', 08:32:46 INFO - 'SHELL': '/bin/bash', 08:32:46 INFO - 'SHLVL': '1', 08:32:46 INFO - 'TERM': 'linux', 08:32:46 INFO - 'TMOUT': '86400', 08:32:46 INFO - 'USER': 'cltbld', 08:32:46 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1490887420.724272-363469947', 08:32:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:46 INFO - '_': '/tools/buildbot/bin/python'} 08:32:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:32:47 INFO - Downloading/unpacking blobuploader==1.2.4 08:32:47 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 08:32:47 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 08:32:47 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 08:32:47 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 08:32:47 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 08:32:47 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 08:32:49 INFO - Downloading blobuploader-1.2.4.tar.gz 08:32:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:32:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:32:49 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 08:32:49 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 08:32:49 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 08:32:49 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 08:32:49 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 08:32:49 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 08:32:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:32:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:32:49 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 08:32:49 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 08:32:49 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 08:32:49 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 08:32:49 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 08:32:49 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 08:32:49 INFO - Downloading docopt-0.6.1.tar.gz 08:32:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:32:49 INFO - Installing collected packages: blobuploader, requests, docopt 08:32:49 INFO - Running setup.py install for blobuploader 08:32:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:32:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:32:49 INFO - Running setup.py install for requests 08:32:50 INFO - Running setup.py install for docopt 08:32:50 INFO - Successfully installed blobuploader requests docopt 08:32:50 INFO - Cleaning up... 08:32:50 INFO - Return code: 0 08:32:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:32:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:32:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:32:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:32:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:32:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:50 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 0x21c91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2466b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2464290>, '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 0x2464b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2465040>, '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': '199fb4c72b90437b990b419b000001c5-1490887420.724272-363469947', '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 08:32:50 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 08:32:50 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 08:32:50 INFO - Using env: {'DISPLAY': ':0', 08:32:50 INFO - 'HOME': '/home/cltbld', 08:32:50 INFO - 'LANG': 'en_US.UTF-8', 08:32:50 INFO - 'LANGUAGE': 'en_US:en', 08:32:50 INFO - 'LOGNAME': 'cltbld', 08:32:50 INFO - 'MAIL': '/var/mail/cltbld', 08:32:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:50 INFO - 'MOZ_NO_REMOTE': '1', 08:32:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:32:50 INFO - 'NO_EM_RESTART': '1', 08:32:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:32:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:32:50 INFO - 'PWD': '/builds/slave/test', 08:32:50 INFO - 'SHELL': '/bin/bash', 08:32:50 INFO - 'SHLVL': '1', 08:32:50 INFO - 'TERM': 'linux', 08:32:50 INFO - 'TMOUT': '86400', 08:32:50 INFO - 'USER': 'cltbld', 08:32:50 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1490887420.724272-363469947', 08:32:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:50 INFO - '_': '/tools/buildbot/bin/python'} 08:32:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:32:50 INFO - Running setup.py (path:/tmp/pip-TgOc3N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:32:50 INFO - Running setup.py (path:/tmp/pip-qm_EaI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:32:50 INFO - Running setup.py (path:/tmp/pip-trY7j5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:32:50 INFO - Running setup.py (path:/tmp/pip-DAUTeh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:32:50 INFO - Running setup.py (path:/tmp/pip-ZqNiwF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:32:51 INFO - Running setup.py (path:/tmp/pip-lMsmyB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:32:51 INFO - Running setup.py (path:/tmp/pip-dvXuC_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:32:51 INFO - Running setup.py (path:/tmp/pip-TknW4B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:32:51 INFO - Running setup.py (path:/tmp/pip-Ku4Fzn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:32:51 INFO - Running setup.py (path:/tmp/pip-rAgQEL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:32:51 INFO - Running setup.py (path:/tmp/pip-cu55s2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:32:51 INFO - Running setup.py (path:/tmp/pip-itDQ14-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:32:51 INFO - Running setup.py (path:/tmp/pip-3A5Fzy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:32:51 INFO - Running setup.py (path:/tmp/pip-72xPVm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:32:51 INFO - Running setup.py (path:/tmp/pip-XgrEr1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:32:51 INFO - Running setup.py (path:/tmp/pip-BEA_Vm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:32:51 INFO - Running setup.py (path:/tmp/pip-NGGjOz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:32:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:32:51 INFO - Running setup.py install for manifestparser 08:32:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:32:52 INFO - Running setup.py install for mozcrash 08:32:52 INFO - Running setup.py install for mozdebug 08:32:52 INFO - Running setup.py install for mozdevice 08:32:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:32:52 INFO - Running setup.py install for mozfile 08:32:52 INFO - Running setup.py install for mozhttpd 08:32:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:32:52 INFO - Running setup.py install for mozinfo 08:32:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:32:52 INFO - Running setup.py install for mozInstall 08:32:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:32:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:32:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:32:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:32:52 INFO - Running setup.py install for mozleak 08:32:52 INFO - Running setup.py install for mozlog 08:32:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:32:52 INFO - Running setup.py install for moznetwork 08:32:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:32:53 INFO - Running setup.py install for mozprocess 08:32:53 INFO - Running setup.py install for mozprofile 08:32:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:32:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:32:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:32:53 INFO - Running setup.py install for mozrunner 08:32:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:32:53 INFO - Running setup.py install for mozscreenshot 08:32:53 INFO - Running setup.py install for moztest 08:32:53 INFO - Running setup.py install for mozversion 08:32:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:32:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:32:53 INFO - Cleaning up... 08:32:53 INFO - Return code: 0 08:32:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:32:53 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')]} 08:32:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:32:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:53 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')]} 08:32:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:32:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:53 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 0x21c91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2466b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2464290>, '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 0x2464b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2465040>, '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': '199fb4c72b90437b990b419b000001c5-1490887420.724272-363469947', '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 08:32:53 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 08:32:53 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 08:32:53 INFO - Using env: {'DISPLAY': ':0', 08:32:53 INFO - 'HOME': '/home/cltbld', 08:32:53 INFO - 'LANG': 'en_US.UTF-8', 08:32:53 INFO - 'LANGUAGE': 'en_US:en', 08:32:53 INFO - 'LOGNAME': 'cltbld', 08:32:53 INFO - 'MAIL': '/var/mail/cltbld', 08:32:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:53 INFO - 'MOZ_NO_REMOTE': '1', 08:32:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:32:53 INFO - 'NO_EM_RESTART': '1', 08:32:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:32:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:32:53 INFO - 'PWD': '/builds/slave/test', 08:32:53 INFO - 'SHELL': '/bin/bash', 08:32:53 INFO - 'SHLVL': '1', 08:32:53 INFO - 'TERM': 'linux', 08:32:53 INFO - 'TMOUT': '86400', 08:32:53 INFO - 'USER': 'cltbld', 08:32:53 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1490887420.724272-363469947', 08:32:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:53 INFO - '_': '/tools/buildbot/bin/python'} 08:32:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:32:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:32:53 INFO - Running setup.py (path:/tmp/pip-W0nbSr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:32:54 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)) 08:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:32:54 INFO - Running setup.py (path:/tmp/pip-zuR0WK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:32:54 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)) 08:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:32:54 INFO - Running setup.py (path:/tmp/pip-8QMZPw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:32:54 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)) 08:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:32:54 INFO - Running setup.py (path:/tmp/pip-d61UOB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:32:54 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)) 08:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:32:54 INFO - Running setup.py (path:/tmp/pip-aPCG3h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:32:54 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)) 08:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:32:54 INFO - Running setup.py (path:/tmp/pip-_R8arC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:32:54 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)) 08:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:32:54 INFO - Running setup.py (path:/tmp/pip-NzIOr2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:32:54 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)) 08:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:32:54 INFO - Running setup.py (path:/tmp/pip-HRciuz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:32:54 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)) 08:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:32:54 INFO - Running setup.py (path:/tmp/pip-7PvAb8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:32:54 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)) 08:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:32:54 INFO - Running setup.py (path:/tmp/pip-Y2XgFG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:32:54 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)) 08:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:32:54 INFO - Running setup.py (path:/tmp/pip-j1oWcn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:32:54 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)) 08:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:32:54 INFO - Running setup.py (path:/tmp/pip-GW5_G9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:32:54 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)) 08:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:32:54 INFO - Running setup.py (path:/tmp/pip-oGWbOV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:32:54 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)) 08:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:32:54 INFO - Running setup.py (path:/tmp/pip-_3QCIn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:32:54 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)) 08:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:32:54 INFO - Running setup.py (path:/tmp/pip-V3ZFYp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:32:55 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)) 08:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:32:55 INFO - Running setup.py (path:/tmp/pip-SQdnqw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:32:55 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)) 08:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:32:55 INFO - Running setup.py (path:/tmp/pip-qhAeEE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:32:55 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)) 08:32:55 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)) 08:32:55 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)) 08:32:55 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)) 08:32:55 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)) 08:32:55 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)) 08:32:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:32:55 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 08:32:55 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 08:32:55 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 08:32:55 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 08:32:55 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 08:32:55 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 08:32:57 INFO - Downloading blessings-1.6.tar.gz 08:32:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:32:57 INFO - Installing collected packages: blessings 08:32:57 INFO - Running setup.py install for blessings 08:32:57 INFO - Successfully installed blessings 08:32:57 INFO - Cleaning up... 08:32:57 INFO - Return code: 0 08:32:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:32:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:32:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:32:57 INFO - Reading from file tmpfile_stdout 08:32:57 INFO - Current package versions: 08:32:57 INFO - argparse == 1.2.1 08:32:57 INFO - blessings == 1.6 08:32:57 INFO - blobuploader == 1.2.4 08:32:57 INFO - docopt == 0.6.1 08:32:57 INFO - functools32 == 3.2.3-2 08:32:57 INFO - jsonschema == 2.5.1 08:32:57 INFO - manifestparser == 1.1 08:32:57 INFO - mozInstall == 1.12 08:32:57 INFO - mozcrash == 1.0 08:32:57 INFO - mozdebug == 0.1 08:32:57 INFO - mozdevice == 0.49 08:32:57 INFO - mozfile == 1.2 08:32:57 INFO - mozhttpd == 0.7 08:32:57 INFO - mozinfo == 0.9 08:32:57 INFO - mozleak == 0.1 08:32:57 INFO - mozlog == 3.4 08:32:57 INFO - moznetwork == 0.27 08:32:57 INFO - mozprocess == 0.25 08:32:57 INFO - mozprofile == 0.28 08:32:57 INFO - mozrunner == 6.13 08:32:57 INFO - mozscreenshot == 0.1 08:32:57 INFO - mozsystemmonitor == 0.3 08:32:57 INFO - moztest == 0.8 08:32:57 INFO - mozversion == 1.4 08:32:57 INFO - psutil == 3.1.1 08:32:57 INFO - requests == 1.2.3 08:32:57 INFO - wsgiref == 0.1.2 08:32:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:32:57 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')]} 08:32:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:32:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:57 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')]} 08:32:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:32:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:57 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 0x21c91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2466b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2464290>, '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 0x2464b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2465040>, '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': '199fb4c72b90437b990b419b000001c5-1490887420.724272-363469947', '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 08:32:57 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 08:32:57 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 08:32:57 INFO - Using env: {'DISPLAY': ':0', 08:32:57 INFO - 'HOME': '/home/cltbld', 08:32:57 INFO - 'LANG': 'en_US.UTF-8', 08:32:57 INFO - 'LANGUAGE': 'en_US:en', 08:32:57 INFO - 'LOGNAME': 'cltbld', 08:32:57 INFO - 'MAIL': '/var/mail/cltbld', 08:32:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:57 INFO - 'MOZ_NO_REMOTE': '1', 08:32:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:32:57 INFO - 'NO_EM_RESTART': '1', 08:32:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:32:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:32:57 INFO - 'PWD': '/builds/slave/test', 08:32:57 INFO - 'SHELL': '/bin/bash', 08:32:57 INFO - 'SHLVL': '1', 08:32:57 INFO - 'TERM': 'linux', 08:32:57 INFO - 'TMOUT': '86400', 08:32:57 INFO - 'USER': 'cltbld', 08:32:57 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1490887420.724272-363469947', 08:32:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:57 INFO - '_': '/tools/buildbot/bin/python'} 08:32:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:32:57 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)) 08:32:57 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)) 08:32:57 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)) 08:32:57 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)) 08:32:57 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)) 08:32:57 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)) 08:32:57 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)) 08:32:57 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)) 08:32:57 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)) 08:32:57 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)) 08:32:57 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)) 08:32:57 INFO - Cleaning up... 08:32:57 INFO - Return code: 0 08:32:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:32:57 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')]} 08:32:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:32:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:57 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')]} 08:32:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:32:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:57 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 0x21c91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2466b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2464290>, '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 0x2464b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2465040>, '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': '199fb4c72b90437b990b419b000001c5-1490887420.724272-363469947', '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 08:32:57 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 08:32:57 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 08:32:57 INFO - Using env: {'DISPLAY': ':0', 08:32:57 INFO - 'HOME': '/home/cltbld', 08:32:57 INFO - 'LANG': 'en_US.UTF-8', 08:32:57 INFO - 'LANGUAGE': 'en_US:en', 08:32:57 INFO - 'LOGNAME': 'cltbld', 08:32:57 INFO - 'MAIL': '/var/mail/cltbld', 08:32:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:57 INFO - 'MOZ_NO_REMOTE': '1', 08:32:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:32:57 INFO - 'NO_EM_RESTART': '1', 08:32:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:32:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:32:57 INFO - 'PWD': '/builds/slave/test', 08:32:57 INFO - 'SHELL': '/bin/bash', 08:32:57 INFO - 'SHLVL': '1', 08:32:57 INFO - 'TERM': 'linux', 08:32:57 INFO - 'TMOUT': '86400', 08:32:57 INFO - 'USER': 'cltbld', 08:32:57 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1490887420.724272-363469947', 08:32:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:57 INFO - '_': '/tools/buildbot/bin/python'} 08:32:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:32:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:32:58 INFO - Cleaning up... 08:32:58 INFO - Return code: 0 08:32:58 INFO - Running post-action listener: _resource_record_post_action 08:32:58 INFO - Running post-action listener: _start_resource_monitoring 08:32:58 INFO - Starting resource monitoring. 08:32:58 INFO - [mozharness: 2017-03-30 15:32:58.126501Z] Finished create-virtualenv step (success) 08:32:58 INFO - [mozharness: 2017-03-30 15:32:58.126972Z] Running install step. 08:32:58 INFO - Running pre-action listener: _resource_record_pre_action 08:32:58 INFO - Running main action method: install 08:32:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:32:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:32:58 INFO - Reading from file tmpfile_stdout 08:32:58 INFO - Detecting whether we're running mozinstall >=1.0... 08:32:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:32:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:32:58 INFO - Reading from file tmpfile_stdout 08:32:58 INFO - Output received: 08:32:58 INFO - Usage: mozinstall [options] installer 08:32:58 INFO - Options: 08:32:58 INFO - -h, --help show this help message and exit 08:32:58 INFO - -d DEST, --destination=DEST 08:32:58 INFO - Directory to install application into. [default: 08:32:58 INFO - "/builds/slave/test"] 08:32:58 INFO - --app=APP Application being installed. [default: firefox] 08:32:58 INFO - mkdir: /builds/slave/test/build/application 08:32:58 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'] 08:32:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 08:33:14 INFO - Reading from file tmpfile_stdout 08:33:14 INFO - Output received: 08:33:14 INFO - /builds/slave/test/build/application/firefox/firefox 08:33:14 INFO - Running post-action listener: _resource_record_post_action 08:33:14 INFO - [mozharness: 2017-03-30 15:33:14.073474Z] Finished install step (success) 08:33:14 INFO - [mozharness: 2017-03-30 15:33:14.073746Z] Running run-tests step. 08:33:14 INFO - Running pre-action listener: _resource_record_pre_action 08:33:14 INFO - Running main action method: run_tests 08:33:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:33:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:33:14 INFO - Python 2.7.3 08:33:14 INFO - Return code: 0 08:33:14 INFO - grabbing minidump binary from tooltool 08:33:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:33:14 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 0x2464290>, '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 0x2464b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2465040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:33:14 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 08:33:14 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 08:33:14 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 08:33:14 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:33:14 INFO - Return code: 0 08:33:14 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:33:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:33:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:33:14 INFO - ENV: RUST_BACKTRACE is now 1 08:33:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:33:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:33:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WPrw1PBMSS-vUjG5HGKOMw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-072', '--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 08:33:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WPrw1PBMSS-vUjG5HGKOMw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-072 --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 08:33:14 INFO - Using env: {'DISPLAY': ':0', 08:33:14 INFO - 'HOME': '/home/cltbld', 08:33:14 INFO - 'LANG': 'en_US.UTF-8', 08:33:14 INFO - 'LANGUAGE': 'en_US:en', 08:33:14 INFO - 'LOGNAME': 'cltbld', 08:33:14 INFO - 'MAIL': '/var/mail/cltbld', 08:33:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:33:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:33:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:14 INFO - 'MOZ_NO_REMOTE': '1', 08:33:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:33:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:33:14 INFO - 'NO_EM_RESTART': '1', 08:33:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:33:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:33:14 INFO - 'PWD': '/builds/slave/test', 08:33:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:33:14 INFO - 'RUST_BACKTRACE': '1', 08:33:14 INFO - 'SHELL': '/bin/bash', 08:33:14 INFO - 'SHLVL': '1', 08:33:14 INFO - 'TERM': 'linux', 08:33:14 INFO - 'TMOUT': '86400', 08:33:14 INFO - 'USER': 'cltbld', 08:33:14 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1490887420.724272-363469947', 08:33:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:14 INFO - '_': '/tools/buildbot/bin/python'} 08:33:14 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WPrw1PBMSS-vUjG5HGKOMw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-072', '--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 08:33:14 INFO - mozversion application_buildid: 20170330145930 08:33:14 INFO - mozversion application_changeset: 3364cc17988c013c36f2a8123315db2855393011 08:33:14 INFO - mozversion application_display_name: Nightly 08:33:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:33:14 INFO - mozversion application_name: Firefox 08:33:14 INFO - mozversion application_remotingname: firefox 08:33:14 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:33:14 INFO - mozversion application_vendor: Mozilla 08:33:14 INFO - mozversion application_version: 55.0a1 08:33:14 INFO - mozversion platform_buildid: 20170330145930 08:33:14 INFO - mozversion platform_changeset: 3364cc17988c013c36f2a8123315db2855393011 08:33:14 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:33:14 INFO - mozversion platform_version: 55.0a1 08:33:14 INFO - using testdate: 1490887994 08:33:14 INFO - actual date: 1490887994 08:33:14 INFO - starting webserver on 'localhost:40525' 08:33:14 INFO - SUITE-START | Running 2 tests 08:33:14 INFO - TEST-START | dromaeo_css 08:33:14 INFO - operating with platform_type : linux_ 08:33:14 INFO - Initialising browser for dromaeo_css test... 08:33:14 INFO - TEST-INFO | started process 27073 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdCd5Px/profile http://localhost:40525/getInfo.html) 08:33:18 INFO - PID 27073 | __metrics Screen width/height:1600/1200 08:33:18 INFO - PID 27073 | colorDepth:24 08:33:18 INFO - PID 27073 | Browser inner width/height: 1024/697 08:33:18 INFO - PID 27073 | __metrics 08:33:19 ERROR - PID 27073 | 1490887999796 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 08:33:19 INFO - PID 27073 | 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" 08:33:19 INFO - PID 27073 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:33:20 INFO - TEST-INFO | 27073: exit 0 08:33:20 INFO - Browser initialized. 08:33:20 INFO - Running cycle 1/1 for dromaeo_css test... 08:33:20 INFO - TEST-INFO | started process 27167 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdCd5Px/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:33:32 INFO - PID 27167 | RSS: Main: 149442560 08:33:32 INFO - PID 27167 | 08:36:39 INFO - PID 27167 | Cycle 1(1): loaded http://localhost:40525/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40525/tests/dromaeo/cssquery-ext.html) 08:36:41 INFO - PID 27167 | RSS: Main: 280240128 08:36:41 INFO - PID 27167 | 08:38:22 INFO - PID 27167 | ************************* 08:38:22 INFO - PID 27167 | A coding exception was thrown and uncaught in a Task. 08:38:22 INFO - PID 27167 | 08:38:22 ERROR - PID 27167 | Full message: TypeError: NetworkError when attempting to fetch resource. 08:38:22 INFO - PID 27167 | Full stack: 08:38:22 INFO - PID 27167 | ************************* 08:38:22 INFO - PID 27167 | ************************* 08:38:22 INFO - PID 27167 | A coding exception was thrown and uncaught in a Task. 08:38:22 INFO - PID 27167 | 08:38:22 ERROR - PID 27167 | Full message: TypeError: NetworkError when attempting to fetch resource. 08:38:22 INFO - PID 27167 | Full stack: 08:38:22 INFO - PID 27167 | ************************* 08:38:22 INFO - PID 27167 | ************************* 08:38:22 INFO - PID 27167 | A coding exception was thrown and uncaught in a Task. 08:38:22 INFO - PID 27167 | 08:38:22 ERROR - PID 27167 | Full message: TypeError: NetworkError when attempting to fetch resource. 08:38:22 INFO - PID 27167 | Full stack: 08:38:22 INFO - PID 27167 | ************************* 08:38:22 INFO - PID 27167 | ************************* 08:38:22 INFO - PID 27167 | A coding exception was thrown and uncaught in a Task. 08:38:22 INFO - PID 27167 | 08:38:22 ERROR - PID 27167 | Full message: TypeError: NetworkError when attempting to fetch resource. 08:38:22 INFO - PID 27167 | Full stack: 08:38:22 INFO - PID 27167 | ************************* 08:39:43 INFO - PID 27167 | Cycle 1(1): loaded http://localhost:40525/tests/dromaeo/cssquery-ext.html (next: http://localhost:40525/tests/dromaeo/cssquery-jquery.html) 08:39:44 INFO - PID 27167 | RSS: Main: 238358528 08:39:44 INFO - PID 27167 | 08:42:46 INFO - PID 27167 | Cycle 1(1): loaded http://localhost:40525/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40525/tests/dromaeo/cssquery-mootools.html) 08:42:47 INFO - PID 27167 | RSS: Main: 179130368 08:42:47 INFO - PID 27167 | 08:45:49 INFO - PID 27167 | Cycle 1(1): loaded http://localhost:40525/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40525/tests/dromaeo/cssquery-prototype.html) 08:45:50 INFO - PID 27167 | RSS: Main: 213393408 08:45:50 INFO - PID 27167 | 08:48:53 INFO - PID 27167 | Cycle 1(1): loaded http://localhost:40525/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40525/tests/dromaeo/cssquery-yui.html) 08:48:54 INFO - PID 27167 | RSS: Main: 188473344 08:48:54 INFO - PID 27167 | 08:51:57 INFO - PID 27167 | Cycle 1(1): loaded http://localhost:40525/tests/dromaeo/cssquery-yui.html (next: http://localhost:40525/tests/dromaeo/cssquery-dojo.html) 08:51:57 INFO - PID 27167 | RSS: Main: 277184512 08:51:57 INFO - PID 27167 | 08:51:57 INFO - PID 27167 | __start_tp_report 08:51:57 INFO - PID 27167 | _x_x_mozilla_page_load 08:51:57 INFO - PID 27167 | _x_x_mozilla_page_load_details 08:51:57 INFO - PID 27167 | |i|pagename|runs| 08:51:57 INFO - PID 27167 | |0;dojo.html;2670.359113812685;2684.5838894971284;2706.3369474478754;2714.5249581323264;2718.768904643104;5010.273510341008;5110.463401342861;5154.407243167032;5160.741962901854;5202.245674377218;5072.695638261707;5102.795888164478;5158.148905430599;5160.638755287131;5203.661761985469;4431.26884064129;4689.062187562493;4788.209945359012;4821.6865903716325;4830.372051633282;4741.596964258025;4747.90504189916;4769.117713223065;4790.736509491977;4838.225883858583;4566.589006989354;4646.3495110684535;4661.766911654404;4667.766611669437;4713.575778179946;4692.976535117336;4700.177468942956;4714.929276060861;4766;4779.641526885497;4640.164770341337;4657.69724967876;4688.46082700487;4691.530846915315;4712.2224832902875;4991.800327986876;5085.186370180791;5138.203578445347;5144.485551444863;5181.792728290864;5444.50999410051;5473.7263136843;5476.644018138848;5480.616356855022;5484.012877682016;5469.234307196995;5510.228568000483;5595.608307418483;5602;5607.102863541813;5055.797768089235;5058.165402708585;5059.215821547592;5065.924011139836;5073.1122053640465;5508.807191748269;5541.5289700375115;5590.049691552445;5596.384397716248;5661.46216109469;5345.812896548602;5375.946240537544;5400.783968641211;5440.700761458158;5465.4261302563455;5566.192902029264;5567.387587365387;5567.47109024642;5567.888642227133;5603.719814009283;5462.754176062087;5489.34127904646;5500.3949565547755;5509.338879334506;5523.558115350762;5307.416184219733;5387.919181212285;5388.0570900092325;5390.568754499709;5543.944560554423;4721.220998535272;4760.523947605281;4760.7619619018915;4761.547652972962;4761.5714585686765;4028.91942161161;4033.092554175287;4034.899127521777;4060.9847538115473;4062.5531191568903;4758.119747846659;4760;4760.857174284777;4761.47623761386;4814.831480898151;5404.621676482687;5422.783088676488;5487.890242195133;5495.6153069284765;5586.86032849182;4676.929846052312;4714.6464015199;4721.220998535272;4723.95276047242;4725.40932383452;4929.580985616263;4948.455669876311;4951.3810773653295;4951.752412379366;4955.504449555087;5160.225966105114;5171.586273098218;5171.715555644476;5175.585953123666;5175.689458632494;5528.336599608073;5540.168974653834;5541.889162216814;5547.11246200606;5552.52803511706;5159.17453207485;5162.741862906764;5167.974160129175;5170.8965820684125;5170.97414512925;5409.702466364388;5428.7285635718845;5433.673979561239;5444.673319600836;5444.754986025718;5483.314585676791;5492.47821456961;5492.862678433071;5492.972535137299;5496.230527726041;5263.052650522943;5310.070737620824;5343.7060961647485;5348.304720386325;5398.325209348832;5327.067763141357;5368.32895888014;5405.324334458192;5406.75669594877;5426.728663566885;5241.292425522658;5245.895082098413;5250.789968401374;5256.053910296183;5257.684538927677;5242.868928276824;5360.758765855624;5384.246205531151;5400.1089820180805;5418;5165.070287348313;5165.147750621106;5173.63784535079;5185.144451165515;5186.144286192736 08:51:57 INFO - PID 27167 | |1;ext.html;611.8103387949736;664.933506649335;685.9314068593142;1062.3572738493212;1080.8540846985654;27178.107940570688;27893.721062789366;27911.302217444572;27946;27949.301267468323;32668.836655816747;32839.343213135784;32884.34231315372;33006.854554454;33030.009099727045;7460.850782984324;7656.923430765677;7658.961705191494;7677.539347639132;7682.654280557361;5654.293213348332;7486.812829679247;7637.312641862231;7642;7649.235076492362;5861.296644402678;7252.854942901139;7435.814104647373;7436.442266829982;7441.404687625004;7436.2191969842925;7474.327310542023;7493.887591686156;7503.587302698349;7503.737369192107;5635.71821408932;7243.927560724378;7323.780286591357;7336.669849856769;7341.816454588625;25884.74115258861;26250.606240906403;26282.86858565695;30808.691913080806;31432.842835785676;2634.9987004938193;2638.60420936861;2654.734526547349;2659.188947371051;2683.5035518429154;24028;24142;24148;24248.393790155213;24613.63079553808;2389.4026493376655;2433.476802487474;2433.598456254716;2442.3161514775893;2477.677901872745;151883;152251;152398.23800881035;152793.23603381912;153157;43488;43494;43542;43572.128557428674;43605.345919811225;45190.54809451929;45315.546844531134;45423.77288113604;45424.54575454203;45536.3169552457;12003.459844306852;12461.06542009353;12465.439055242536;12493.12548121641;12625.116241863165;10005.79988400228;10021.498925053718;10037.949810251048;10219.080282774587;10320;10241.129503992095;10679.626213082505;11988.520459181535;12537.247765134121;12621.116521843567;4796.688215265996;4964.106460837012;4971.552560269521;4973.726445045485;5045.8738531537;858.6908712863365;882.8896387951506;893.1871996483169;896.7982204004047;915.8076803871129;19368.806311936984;19856.10647520865;19909.303174388828;19953.201871925252;19954.501137471678;961.6153538584622;966.1932286540817;971.5676523946776;971.7376308396694;987.6790043235977;10396.636117735843;10615.097716694167;10833.945830270799;10840.349579025125;10882;209394;209583;209879;210024;210367;41204;41435;41492.37761433581;41679.79160104241;41718.37422438666;1173.9433292253416;1222.1200735470625;1227.1410012990941;1233.975320493585;1244.3840299051847;18205.817941820944;18537.35119270819;19412.2235110594;19571;19639;30500;30543.84728076434;30564.694353056184;30605.540916886708;30607.54088688716;216047;216140;216835;217299;217660;28165.295867603472;28214.294642634097;28243.576346355232;28310.71689283081;28615.570766438104;34739.652603473645;35241.82379088088;35818.462723058656;35923.281534369686;36333.63666363408;26657;26995.460090797682;27283.86358068197;27391.863040684668;27918.441631166857;26972.460550789267;27387.86306068457;27741.445171096868;27921.301967450978;28027.299317517227;29628;30295.545566816956;30432;30534;30557.388852222386;26902.461950761266;27169;27754.86122569455;28316.716832831407;28353.71646283511;19731.336269603995;20346.796532034492;20411.79588204099;20593;20612.587748244652 08:51:57 INFO - PID 27167 | |2;jquery.html;389.73303287248217;398.86637976277945;427.61728253213386;427.6771037866412;437.49687858962193;11981.700457488567;13379.26414047227;18349.7247541287;18657;18928.148233329517;16225.83774162258;16668.916655416706;16926.83073169268;16976.15119244039;17153.742693859604;5571.9721401392935;5733.140028995643;5772.393898640646;5776.913346299788;5785.537157027427;5391.56867450603;5650.29371328584;5673.631213971079;5674.3190817102;5682.403347648499;5647.237622920894;5649.745761440745;5650.208970744099;5652.576056795757;5660.462256085686;6020.488258498033;6310.305866354697;6368;6369;6372.235331760218;6011.939880601181;6103.816885493442;6161.045038019114;6208.037754148114;6237.87524249517;23384.64923026156;23548.411289717722;24028.759712402825;24103.15638952646;24223.394415139584;1588.1424031023348;1589.102157281144;1607.2285303054482;1608.1557182479291;1632.4612877750315;14400.63998400038;15031.624209394744;15149.621259468491;15283.770743438858;15726;1598.20888660114;1703.6422351306242;1711.8031426385876;1722.4067737343032;1744.1715185286887;84248.57875710582;86723.56638216769;86862.5656871718;91292.54353728256;91875;17561.736573951403;17834.56045906011;18022;18149.818501814814;18384.724229136573;33148.02779583082;33179.50230746541;33237;33248.335033299685;33327.83336083304;8419.705310314232;8660.826783464296;8735.825283494294;8970.506622135714;8995.505247211466;6853.451723862079;6884.965575172092;6893.379595836399;7073.893891591631;7094.645267736592;9413.670521531714;9423.528823558794;9451.716448506555;9618.374805637752;9800.11798938099;3790.298794722985;3930.272899513599;3943.2507823514015;3959.524857017119;3996.4005399190355;854.3848429131016;863.8531449653574;870.0951010948543;884.3853521802414;908.246155690775;15647.68704625901;15903.920480397755;15926.60183495422;16145.59636009109;16557.25492352847;882.8587426011808;884.0408157149436;890.8040231149137;899.1188635137602;903.75146834621;8740.650373984969;8811.69159079442;8912.415399534193;9345.626174953062;9393.154616084448;440966.2888767833;447358;452388;453401;456062;85701.57149214215;86767.56616216879;90821.12632636285;90838.54580727186;91237.54381228185;1054.4938429553856;1057.957681692739;1075.548269726701;1079.3631757263252;1080.9621663241749;13695.246761428218;13799.172049677052;13850.376733047238;13985.090969086978;14396.42414303416;38928;39703.40444893387;40563.797181013906;40759.796201018806;41106.9723256909;51342.48657513377;51811.74094129505;52103;52227.73886130545;54109.18836217539;11472.88527114718;11609.3614851184;11661.591844285409;11843.467043983213;11905.702357441134;12023.699407514881;12063.457144428698;13159.407826647632;13408.664783380103;13596.86403135956;10760.148560631282;10790.622328218475;11080.501377437873;11132.666020019413;11275.830862537232;10801.945990269998;10837.729056773644;10938.124950003821;11015;11031.22781405294;11151.275167114112;11374.43127843621;11422.771544569228;11434.542618295507;11824;11559.653210403701;11583.8262426062;11588.6523404298;11647.359395233343;12247.510099595916;11080.778384432428;11314.321140731583;12053.216540925163;12186.695332616755;12364.62906112818 08:51:57 INFO - PID 27167 | |3;mootools.html;1099.0603034405578;1223.7491314280574;1271.980920286196;1286.9935650321752;1299.3957809618526;8116.756497305076;8506.27696645785;9196;9651.276154288422;9659.420434773918;9423.81152376952;9489.572969216384;9510.952445237765;9523.571439285231;9525.095115963972;2182.9890850545726;2230.2528652901296;2233.486298151426;2233.7542870284337;2237.3288013595857;1795.0665653859985;1863.7670291213599;2163.9891800540977;2235.0389332586983;2237.65316375962;2115.8730476171404;2140.9250676226334;2142.4429648291402;2143.446001648808;2144.3995681209285;2154.601398741238;2194.9122035118576;2195.089038049208;2195.121951219525;2197.0772275644267;2122.7877212278804;2123.193186589086;2133.423975526615;2175.3908905506482;2176.0425412818468;9597.904020959772;9623.56693948767;9694.418334899858;9708.61165553377;9745.31782775206;5330.7334633268565;5516.172574113875;5520.696361700105;5535.861603459945;5536.252605898233;3226.8547915343865;3315.55240042596;3363.899083027489;3447.7241820654285;3514.1566024154276;1021.1830535571513;1037.7768779712399;1058.9311694739818;1093.6117678224196;1102.614085070227;13680.90552755787;13706.52027179054;13711.382987765475;13719.657008574766;13759.518416855462;4763.309320148559;4881.780319885614;5002.89994200114;5041.319421878073;5148.2020286855595;11749.060075193964;11753.941230293794;11761.705957351134;11778.88221117795;11788.115891308014;5463.808766693226;5471.343438787371;5472.425395333512;5477.75350109246;5483.067878460672;4196.433481480022;4845.95154048455;4874.341963834908;4888.289098815386;5008.824691135793;3652.342578335872;3980.144268982183;4127.669786417079;4142.730722503027;4172.895677608084;1265.8923991460645;1301.804729290595;1305.9673508162373;1318.821959035537;1320.7810877725321;683.1085433509219;683.1255992329826;695.474916438086;702.125853312629;719.5287086957946;5108.7190204538365;5136.794528218904;5203.8178663746585;5237.6071794615555;5311;800.3477166109602;803.2650125135435;806.7539400482792;809.5062012172571;814.1207495904409;3217.3565286942703;3235.8058516489086;3242.416365054313;3256.8371581420834;3333.5999680038067;12295.508179672714;12603.93698031504;12697.746045079231;12740.872591273968;12744.044196685285;12294.262344259194;12593.92951599106;12620;12647.683807904876;12684.175528590613;9126.817463650823;9297.349185556946;9320.673776417792;9321.394109382869;9321.394109383004;5510.641808282448;5545.3622833373065;5563.8887222256135;5666.376698563073;5694.715264236855;11259.042981346349;11311.490982905954;11316.321020738453;11351.318920864775;11472.598459053894;11422.314661120026;11614.12894032934;11780.882191177978;11827.290362578273;11870.52517899309;7952.403569732178;8037.477563958324;8045.9597702011115;8051.677932882853;8066.798330041796;8998.23515001206;9209.723708288762;9273.675421360489;9286.95356523213;9317.34778565521;7433.10802703679;7550.924490755022;7561.621918904143;7563.827606720967;7772.067351917806;7276.781696549112;7309.232530584425;7357.2642735726;7392.926070739224;7645;6626;6757.087793147862;6757.966210168917;6758.493113016445;6769;4976.751162441936;5029.5221953914315;5082.771275292695;5097.439281679087;5140.306058682179;4779.976100119477;4780.235162374003;4888.706677599355;5187.610929180251;5285.577153827608 08:51:57 INFO - PID 27167 | |4;prototype.html;360.32978659692964;379.5729803970533;381.9121602031531;390.843662534986;394.94470774091616;5360.303160589123;5381.762194695222;5389.838304850851;5409.810656627019;5424.755885985141;5108.974455127719;5234.73826308684;5249;5270.445218660495;5317.229001794747;4120.423140760296;4121.423000779893;4121.9381709274385;4133.979330103345;4139.503259608851;4114.7119701620895;4127.772972486512;4141.467656966926;4143.730657507267;4150.094933546515;3936.3308237599676;4092.2224777292217;4101.4668093148;4104.1381309924955;4113.095119073799;4080.3879418087226;4082.122343696105;4087.632113109805;4105.261053010457;4107.137501124767;3589.587197472298;3592.568891733009;3602.35157671619;3605.296967091418;3605.4591811228265;4923.2183816144125;5171.612129090333;5173.025510331574;5179.870503237412;5184.377874655065;4698.741569213692;4705.317728929286;4738.739369334685;4742.312364707098;4756.6432517561325;5566.385748133037;5572.749226284786;5577.637453565505;5593.7693707384315;5605.467480589337;3785.261873934584;3932;3960.980195099035;3961.920761584781;3976.840926362942;5598.300212473441;5683.204351390808;5762.481376676077;5873.85315367115;5928.822135335947;4025.879223623296;4036.6367026967714;4038.071243613985;4038.596140385938;4065.3698676705158;4102.610252026053;4109;4123.8556650517085;4129;4129.587041295907;4416.66874984371;4492.37106805041;4558.384618076583;4638.327442520816;4720.480747117815;5541.5289700375915;5561.805336813192;5562.3881373048935;5564.582656300794;5571.888562228733;1388.55566218809;1392.2481859795798;1393.3869097597026;1393.986060139406;1399.1535121251495;919.7194855569115;948.7248697877676;959.7456673981401;965.9613615455303;968.9612415503301;4861.829835955725;4869.196582563908;4872.3909511311085;4880.316755654211;4910.48439913811;5772.942270577324;5788.18965344852;5797.565182611321;5800.680962547016;5804.245448091721;4660.184467718136;4841.588464980446;4890.706557606484;4895.4370247422;4901.877453063702;3037.4228896509594;3059.7858149929734;3073.2163298359224;3073.4775088234605;3074.4773388524004;5365.960934844812;5369.838904832784;5377.247185394048;5394.460553944574;5397.325334333208;5688.402717714663;5842.824715258549;5863.2670916135485;5865.560082993792;5936.436038576328;5351.866203344792;5351.92264447944;5363.329583801947;5374.4088150304215;5376.623636345418;5585.664860108406;5769.567282453917;5775.826725198251;5792.53659707214;5793.9420605795085;5637.520810731134;5705.258316418839;5707.68607726579;5713.885722285448;5718.714064296852;5161.174212126042;5245.895082098413;5247.107991641354;5372.146609419744;5393.325834270716;4014.0968282136287;4016.9598304016586;4021.33647948097;4026.879193624196;4039.293123703399;5471.2887324647545;5768.423157684198;5768.53851691872;5780.421957804354;5811.27359080115;5494.5988772862665;5520.1167813149705;5537.9169312459535;5587.608867379245;5589.608727389043;5510.338759348904;5525.917111243415;5550.833474995757;5582.102085291021;5597.44025597437;5352.678839269501;5486.753096110605;5491.780328786964;5493.340799103973;5524.7348587079105;5565.526930210977;5625.803096891589;5633.2395126657375;5648.802291919763;5658.377578466283;5433.022056029952;5440.755166017618;5454.645448045864;5464.508194262536;5489.64317319373 08:51:57 INFO - PID 27167 | |5;yui.html;609.3510411411846;611.2390074357426;623.728678025059;627.1940556385044;632.531926374483;12986.155899866513;13461.125026873246;13871.722565548684;13889.861101388995;14230.146191228534;13361.732765344712;13498.730025399485;13847.09993850399;13860.930695346535;13894.583162505116;883.4743327719997;911.8723378726951;915.7298596913927;915.9633614655439;916.4730280088942;914.2046419614911;952.6713283917038;958.6884262614643;958.8226178157029;958.9760255993586;1003.4882210072878;1008.8184126857162;1011.0142610954298;1011.1506334678868;1011.4891979550354;995.6515219673056;997.4414327976357;997.4663554998041;997.9550920208608;998.4658207858797;739.006036880395;739.4269441183072;740.2967181177848;740.9925900740977;741.0625558668289;12679.23924564529;13154.934225328907;14176.078554893898;14203.360848761831;14218.85781142196;13227.338633068308;13516.256605886672;13729.45082196711;13780.070790089396;13803.447862085504;8460.365472589581;8530.104339044374;8697.084993558801;8873.157050080232;8999.910000899972;2192.5395666909967;2204.548067646129;2206.58074965756;2251.1670681847822;2261.2424837679396;62756.68621656908;62840;62926.70732926716;63678.68160659213;63976;9338.393004454825;9426.245900327956;9496;9555.378900371592;9696.418214907128;19403.029848507802;19459.12433940476;19459.8054019458;19544.413667589994;19590.412287631392;6045.33501314855;6058.848528786815;6062.393760623902;6145.170401995673;6237.688115594202;3015.1406849047917;3026.228311780482;3067.5552044953356;3070.8771649134233;3075.7231849133686;3390.271091715293;3473;3501.1072176594807;3501.7548771586253;3503.5795704515112;574.2964868036705;576.9336526299445;583.3903570768557;584.2288179602883;587.216066551159;427.1009524949998;452.3734627540814;465.4554171619214;465.66704806063825;486.341007934244;6655.267920528738;7176.210616832144;7326.706931722778;7418.221086785918;7745.806354841061;449.43595787286745;470.2100471208403;472.63370887562417;509.88527581293914;520.7994921954999;3341.8329083545727;3344.6153692325693;3423.9828800855835;3481.1993241554583;3589.9102522437147;59218.703906480194;60332.39667603355;60485.39514604885;60489;61708.38291617116;51817.74091129596;52483.47516524786;52530.474695253324;53181.46818531842;53350.46649533533;47932.28101578479;49058.50941490539;49567.75216123896;49937.250941235914;50168.74915625399;6895.689693963884;7131.607761573163;7151.499395042297;7347;7355.043844300207;25412.74587254104;25650.871745641154;25846.483070338865;26241.081562146;26817;41289.79355103325;43219.135617288106;43574.782126089165;43772;43925.341119883866;10600.46997650099;10712.839307410239;10847.40339281347;10870.510827012962;10932.453377331261;10851;10960.671179864617;11076.889231107585;11217.943910280397;11833.19578813387;10138.797224055625;10152.543135559064;10393.792124157626;10414.166866650801;10761.623343182951;9945.950270248602;10459.320144190604;10471.115199264206;10734.087602553871;10788.568457261936;10515.631952881613;10963.725906852074;11031.448427578749;11144.164187685794;11387.487563059847;8165.183481652025;8467;8537.87193192115;8538.402311838112;8603.139686031347;7932.881006784787;8081.555514446527;8952.462852228888;9115.665189131232;9259.444433334022 08:51:57 INFO - PID 27167 | __end_tp_report 08:51:57 INFO - PID 27167 | __start_cc_report 08:51:57 INFO - PID 27167 | _x_x_mozilla_cycle_collect,1620 08:51:57 INFO - PID 27167 | __end_cc_report 08:51:57 INFO - PID 27167 | __startTimestamp1490889117254__endTimestamp 08:51:57 INFO - PID 27167 | 08:51:57 INFO - PID 27167 | ------- Summary: start ------- 08:51:57 INFO - PID 27167 | Number of tests: 6 08:51:57 INFO - PID 27167 | 08:51:57 INFO - PID 27167 | [#0] dojo.html Cycles:165 Average:5066.44 Median:5173.64 stddev:554.27 (10.7%) stddev-sans-first:523.12 08:51:57 INFO - PID 27167 | Values: 2670.4 2684.6 2706.3 2714.5 2718.8 5010.3 5110.5 5154.4 5160.7 5202.2 5072.7 5102.8 5158.1 5160.6 5203.7 4431.3 4689.1 4788.2 4821.7 4830.4 4741.6 4747.9 4769.1 4790.7 4838.2 4566.6 4646.3 4661.8 4667.8 4713.6 4693.0 4700.2 4714.9 4766.0 4779.6 4640.2 4657.7 4688.5 4691.5 4712.2 4991.8 5085.2 5138.2 5144.5 5181.8 5444.5 5473.7 5476.6 5480.6 5484.0 5469.2 5510.2 5595.6 5602.0 5607.1 5055.8 5058.2 5059.2 5065.9 5073.1 5508.8 5541.5 5590.0 5596.4 5661.5 5345.8 5375.9 5400.8 5440.7 5465.4 5566.2 5567.4 5567.5 5567.9 5603.7 5462.8 5489.3 5500.4 5509.3 5523.6 5307.4 5387.9 5388.1 5390.6 5543.9 4721.2 4760.5 4760.8 4761.5 4761.6 4028.9 4033.1 4034.9 4061.0 4062.6 4758.1 4760.0 4760.9 4761.5 4814.8 5404.6 5422.8 5487.9 5495.6 5586.9 4676.9 4714.6 4721.2 4724.0 4725.4 4929.6 4948.5 4951.4 4951.8 4955.5 5160.2 5171.6 5171.7 5175.6 5175.7 5528.3 5540.2 5541.9 5547.1 5552.5 5159.2 5162.7 5168.0 5170.9 5171.0 5409.7 5428.7 5433.7 5444.7 5444.8 5483.3 5492.5 5492.9 5493.0 5496.2 5263.1 5310.1 5343.7 5348.3 5398.3 5327.1 5368.3 5405.3 5406.8 5426.7 5241.3 5245.9 5250.8 5256.1 5257.7 5242.9 5360.8 5384.2 5400.1 5418.0 5165.1 5165.1 5173.6 5185.1 5186.1 08:51:57 INFO - PID 27167 | 08:51:57 INFO - PID 27167 | [#1] ext.html Cycles:180 Average:32898.23 Median:27947.65 stddev:50810.81 (181.8%) stddev-sans-first:50895.52 08:51:57 INFO - PID 27167 | Values: 611.8 664.9 685.9 1062.4 1080.9 27178.1 27893.7 27911.3 27946.0 27949.3 32668.8 32839.3 32884.3 33006.9 33030.0 7460.9 7656.9 7659.0 7677.5 7682.7 5654.3 7486.8 7637.3 7642.0 7649.2 5861.3 7252.9 7435.8 7436.4 7441.4 7436.2 7474.3 7493.9 7503.6 7503.7 5635.7 7243.9 7323.8 7336.7 7341.8 25884.7 26250.6 26282.9 30808.7 31432.8 2635.0 2638.6 2654.7 2659.2 2683.5 24028.0 24142.0 24148.0 24248.4 24613.6 2389.4 2433.5 2433.6 2442.3 2477.7 151883.0 152251.0 152398.2 152793.2 153157.0 43488.0 43494.0 43542.0 43572.1 43605.3 45190.5 45315.5 45423.8 45424.5 45536.3 12003.5 12461.1 12465.4 12493.1 12625.1 10005.8 10021.5 10037.9 10219.1 10320.0 10241.1 10679.6 11988.5 12537.2 12621.1 4796.7 4964.1 4971.6 4973.7 5045.9 858.7 882.9 893.2 896.8 915.8 19368.8 19856.1 19909.3 19953.2 19954.5 961.6 966.2 971.6 971.7 987.7 10396.6 10615.1 10833.9 10840.3 10882.0 209394.0 209583.0 209879.0 210024.0 210367.0 41204.0 41435.0 41492.4 41679.8 41718.4 1173.9 1222.1 1227.1 1234.0 1244.4 18205.8 18537.4 19412.2 19571.0 19639.0 30500.0 30543.8 30564.7 30605.5 30607.5 216047.0 216140.0 216835.0 217299.0 217660.0 28165.3 28214.3 28243.6 28310.7 28615.6 34739.7 35241.8 35818.5 35923.3 36333.6 26657.0 26995.5 27283.9 27391.9 27918.4 26972.5 27387.9 27741.4 27921.3 28027.3 29628.0 30295.5 30432.0 30534.0 30557.4 26902.5 27169.0 27754.9 28316.7 28353.7 19731.3 20346.8 20411.8 20593.0 20612.6 08:51:57 INFO - PID 27167 | 08:51:57 INFO - PID 27167 | [#2] jquery.html Cycles:180 Average:28575.53 Median:2090.02 stddev:74355.02 (3557.6%) stddev-sans-first:74533.49 08:51:57 INFO - PID 27167 | Values: 389.7 398.9 427.6 427.7 437.5 11981.7 13379.3 18349.7 18657.0 18928.1 16225.8 16668.9 16926.8 16976.2 17153.7 5572.0 5733.1 5772.4 5776.9 5785.5 5391.6 5650.3 5673.6 5674.3 5682.4 5647.2 5649.7 5650.2 5652.6 5660.5 6020.5 6310.3 6368.0 6369.0 6372.2 6011.9 6103.8 6161.0 6208.0 6237.9 23384.6 23548.4 24028.8 24103.2 24223.4 1588.1 1589.1 1607.2 1608.2 1632.5 14400.6 15031.6 15149.6 15283.8 15726.0 1598.2 1703.6 1711.8 1722.4 1744.2 84248.6 86723.6 86862.6 91292.5 91875.0 17561.7 17834.6 18022.0 18149.8 18384.7 33148.0 33179.5 33237.0 33248.3 33327.8 8419.7 8660.8 8735.8 8970.5 8995.5 6853.5 6885.0 6893.4 7073.9 7094.6 9413.7 9423.5 9451.7 9618.4 9800.1 3790.3 3930.3 3943.3 3959.5 3996.4 854.4 863.9 870.1 884.4 908.2 15647.7 15903.9 15926.6 16145.6 16557.3 882.9 884.0 890.8 899.1 903.8 8740.7 8811.7 8912.4 9345.6 9393.2 440966.3 447358.0 452388.0 453401.0 456062.0 85701.6 86767.6 90821.1 90838.5 91237.5 1054.5 1058.0 1075.5 1079.4 1081.0 13695.2 13799.2 13850.4 13985.1 14396.4 38928.0 39703.4 40563.8 40759.8 41107.0 51342.5 51811.7 52103.0 52227.7 54109.2 11472.9 11609.4 11661.6 11843.5 11905.7 12023.7 12063.5 13159.4 13408.7 13596.9 10760.1 10790.6 11080.5 11132.7 11275.8 10801.9 10837.7 10938.1 11015.0 11031.2 11151.3 11374.4 11422.8 11434.5 11824.0 11559.7 11583.8 11588.7 11647.4 12247.5 11080.8 11314.3 12053.2 12186.7 12364.6 08:51:57 INFO - PID 27167 | 08:51:57 INFO - PID 27167 | [#3] mootools.html Cycles:180 Average:6060.56 Median:4878.06 stddev:3844.02 (78.8%) stddev-sans-first:3836.72 08:51:57 INFO - PID 27167 | Values: 1099.1 1223.7 1272.0 1287.0 1299.4 8116.8 8506.3 9196.0 9651.3 9659.4 9423.8 9489.6 9511.0 9523.6 9525.1 2183.0 2230.3 2233.5 2233.8 2237.3 1795.1 1863.8 2164.0 2235.0 2237.7 2115.9 2140.9 2142.4 2143.4 2144.4 2154.6 2194.9 2195.1 2195.1 2197.1 2122.8 2123.2 2133.4 2175.4 2176.0 9597.9 9623.6 9694.4 9708.6 9745.3 5330.7 5516.2 5520.7 5535.9 5536.3 3226.9 3315.6 3363.9 3447.7 3514.2 1021.2 1037.8 1058.9 1093.6 1102.6 13680.9 13706.5 13711.4 13719.7 13759.5 4763.3 4881.8 5002.9 5041.3 5148.2 11749.1 11753.9 11761.7 11778.9 11788.1 5463.8 5471.3 5472.4 5477.8 5483.1 4196.4 4846.0 4874.3 4888.3 5008.8 3652.3 3980.1 4127.7 4142.7 4172.9 1265.9 1301.8 1306.0 1318.8 1320.8 683.1 683.1 695.5 702.1 719.5 5108.7 5136.8 5203.8 5237.6 5311.0 800.3 803.3 806.8 809.5 814.1 3217.4 3235.8 3242.4 3256.8 3333.6 12295.5 12603.9 12697.7 12740.9 12744.0 12294.3 12593.9 12620.0 12647.7 12684.2 9126.8 9297.3 9320.7 9321.4 9321.4 5510.6 5545.4 5563.9 5666.4 5694.7 11259.0 11311.5 11316.3 11351.3 11472.6 11422.3 11614.1 11780.9 11827.3 11870.5 7952.4 8037.5 8046.0 8051.7 8066.8 8998.2 9209.7 9273.7 9287.0 9317.3 7433.1 7550.9 7561.6 7563.8 7772.1 7276.8 7309.2 7357.3 7392.9 7645.0 6626.0 6757.1 6758.0 6758.5 6769.0 4976.8 5029.5 5082.8 5097.4 5140.3 4780.0 4780.2 4888.7 5187.6 5285.6 08:51:57 INFO - PID 27167 | 08:51:57 INFO - PID 27167 | [#4] prototype.html Cycles:180 Average:4613.17 Median:5259.72 stddev:1343.37 (25.5%) stddev-sans-first:1308.67 08:51:57 INFO - PID 27167 | Values: 360.3 379.6 381.9 390.8 394.9 5360.3 5381.8 5389.8 5409.8 5424.8 5109.0 5234.7 5249.0 5270.4 5317.2 4120.4 4121.4 4121.9 4134.0 4139.5 4114.7 4127.8 4141.5 4143.7 4150.1 3936.3 4092.2 4101.5 4104.1 4113.1 4080.4 4082.1 4087.6 4105.3 4107.1 3589.6 3592.6 3602.4 3605.3 3605.5 4923.2 5171.6 5173.0 5179.9 5184.4 4698.7 4705.3 4738.7 4742.3 4756.6 5566.4 5572.7 5577.6 5593.8 5605.5 3785.3 3932.0 3961.0 3961.9 3976.8 5598.3 5683.2 5762.5 5873.9 5928.8 4025.9 4036.6 4038.1 4038.6 4065.4 4102.6 4109.0 4123.9 4129.0 4129.6 4416.7 4492.4 4558.4 4638.3 4720.5 5541.5 5561.8 5562.4 5564.6 5571.9 1388.6 1392.2 1393.4 1394.0 1399.2 919.7 948.7 959.7 966.0 969.0 4861.8 4869.2 4872.4 4880.3 4910.5 5772.9 5788.2 5797.6 5800.7 5804.2 4660.2 4841.6 4890.7 4895.4 4901.9 3037.4 3059.8 3073.2 3073.5 3074.5 5366.0 5369.8 5377.2 5394.5 5397.3 5688.4 5842.8 5863.3 5865.6 5936.4 5351.9 5351.9 5363.3 5374.4 5376.6 5585.7 5769.6 5775.8 5792.5 5793.9 5637.5 5705.3 5707.7 5713.9 5718.7 5161.2 5245.9 5247.1 5372.1 5393.3 4014.1 4017.0 4021.3 4026.9 4039.3 5471.3 5768.4 5768.5 5780.4 5811.3 5494.6 5520.1 5537.9 5587.6 5589.6 5510.3 5525.9 5550.8 5582.1 5597.4 5352.7 5486.8 5491.8 5493.3 5524.7 5565.5 5625.8 5633.2 5648.8 5658.4 5433.0 5440.8 5454.6 5464.5 5489.6 08:51:57 INFO - PID 27167 | 08:51:57 INFO - PID 27167 | [#5] yui.html Cycles:180 Average:13824.42 Median:24202.46 stddev:17311.65 (71.5%) stddev-sans-first:17331.77 08:51:57 INFO - PID 27167 | Values: 609.4 611.2 623.7 627.2 632.5 12986.2 13461.1 13871.7 13889.9 14230.1 13361.7 13498.7 13847.1 13860.9 13894.6 883.5 911.9 915.7 916.0 916.5 914.2 952.7 958.7 958.8 959.0 1003.5 1008.8 1011.0 1011.2 1011.5 995.7 997.4 997.5 998.0 998.5 739.0 739.4 740.3 741.0 741.1 12679.2 13154.9 14176.1 14203.4 14218.9 13227.3 13516.3 13729.5 13780.1 13803.4 8460.4 8530.1 8697.1 8873.2 8999.9 2192.5 2204.5 2206.6 2251.2 2261.2 62756.7 62840.0 62926.7 63678.7 63976.0 9338.4 9426.2 9496.0 9555.4 9696.4 19403.0 19459.1 19459.8 19544.4 19590.4 6045.3 6058.8 6062.4 6145.2 6237.7 3015.1 3026.2 3067.6 3070.9 3075.7 3390.3 3473.0 3501.1 3501.8 3503.6 574.3 576.9 583.4 584.2 587.2 427.1 452.4 465.5 465.7 486.3 6655.3 7176.2 7326.7 7418.2 7745.8 449.4 470.2 472.6 509.9 520.8 3341.8 3344.6 3424.0 3481.2 3589.9 59218.7 60332.4 60485.4 60489.0 61708.4 51817.7 52483.5 52530.5 53181.5 53350.5 47932.3 49058.5 49567.8 49937.3 50168.7 6895.7 7131.6 7151.5 7347.0 7355.0 25412.7 25650.9 25846.5 26241.1 26817.0 41289.8 43219.1 43574.8 43772.0 43925.3 10600.5 10712.8 10847.4 10870.5 10932.5 10851.0 10960.7 11076.9 11217.9 11833.2 10138.8 10152.5 10393.8 10414.2 10761.6 9946.0 10459.3 10471.1 10734.1 10788.6 10515.6 10963.7 11031.4 11144.2 11387.5 8165.2 8467.0 8537.9 8538.4 8603.1 7932.9 8081.6 8952.5 9115.7 9259.4 08:51:57 INFO - PID 27167 | -------- Summary: end -------- 08:51:57 INFO - PID 27167 | 08:51:58 INFO - TEST-INFO | 27167: exit 0 08:51:58 INFO - TEST-OK | dromaeo_css | took 1123829ms 08:51:58 INFO - TEST-START | kraken 08:51:58 INFO - operating with platform_type : linux_ 08:51:58 INFO - Initialising browser for kraken test... 08:51:58 INFO - TEST-INFO | started process 27495 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcH1S1F/profile http://localhost:40525/getInfo.html) 08:52:02 INFO - PID 27495 | __metrics Screen width/height:1600/1200 08:52:02 INFO - PID 27495 | colorDepth:24 08:52:02 INFO - PID 27495 | Browser inner width/height: 1024/697 08:52:02 INFO - PID 27495 | __metrics 08:52:03 ERROR - PID 27495 | 1490889123653 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 08:52:03 INFO - PID 27495 | 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" 08:52:03 INFO - PID 27495 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:52:04 INFO - TEST-INFO | 27495: exit 0 08:52:04 INFO - Browser initialized. 08:52:04 INFO - Running cycle 1/1 for kraken test... 08:52:04 INFO - TEST-INFO | started process 27587 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcH1S1F/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:52:16 INFO - PID 27587 | RSS: Main: 149172224 08:52:16 INFO - PID 27587 | 08:52:19 INFO - PID 27587 | Cycle 1(1): loaded http://localhost:40525/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40525/tests/kraken/driver.html?testName=audio-beat-detection) 08:52:20 INFO - PID 27587 | RSS: Main: 205225984 08:52:20 INFO - PID 27587 | 08:52:23 INFO - PID 27587 | Cycle 1(1): loaded http://localhost:40525/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40525/tests/kraken/driver.html?testName=audio-dft) 08:52:24 INFO - PID 27587 | RSS: Main: 186511360 08:52:24 INFO - PID 27587 | 08:52:27 INFO - PID 27587 | Cycle 1(1): loaded http://localhost:40525/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40525/tests/kraken/driver.html?testName=audio-fft) 08:52:27 INFO - PID 27587 | RSS: Main: 267345920 08:52:27 INFO - PID 27587 | 08:52:30 INFO - PID 27587 | Cycle 1(1): loaded http://localhost:40525/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40525/tests/kraken/driver.html?testName=audio-oscillator) 08:52:30 INFO - PID 27587 | RSS: Main: 177655808 08:52:30 INFO - PID 27587 | 08:52:32 INFO - PID 27587 | Cycle 1(1): loaded http://localhost:40525/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40525/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:52:33 INFO - PID 27587 | RSS: Main: 180568064 08:52:33 INFO - PID 27587 | 08:52:36 INFO - PID 27587 | Cycle 1(1): loaded http://localhost:40525/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40525/tests/kraken/driver.html?testName=imaging-darkroom) 08:52:37 INFO - PID 27587 | RSS: Main: 220106752 08:52:37 INFO - PID 27587 | 08:52:41 INFO - PID 27587 | Cycle 1(1): loaded http://localhost:40525/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40525/tests/kraken/driver.html?testName=imaging-desaturate) 08:52:41 INFO - PID 27587 | RSS: Main: 214880256 08:52:41 INFO - PID 27587 | 08:52:44 INFO - PID 27587 | Cycle 1(1): loaded http://localhost:40525/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40525/tests/kraken/driver.html?testName=json-parse-financial) 08:52:45 INFO - PID 27587 | RSS: Main: 217411584 08:52:45 INFO - PID 27587 | 08:52:47 INFO - PID 27587 | Cycle 1(1): loaded http://localhost:40525/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40525/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:52:47 INFO - PID 27587 | RSS: Main: 180887552 08:52:47 INFO - PID 27587 | 08:52:49 INFO - PID 27587 | Cycle 1(1): loaded http://localhost:40525/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40525/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:52:50 INFO - PID 27587 | RSS: Main: 189071360 08:52:50 INFO - PID 27587 | 08:52:52 INFO - PID 27587 | Cycle 1(1): loaded http://localhost:40525/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40525/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:52:53 INFO - PID 27587 | RSS: Main: 196579328 08:52:53 INFO - PID 27587 | 08:52:55 INFO - PID 27587 | Cycle 1(1): loaded http://localhost:40525/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40525/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:52:56 INFO - PID 27587 | RSS: Main: 206336000 08:52:56 INFO - PID 27587 | 08:53:00 INFO - PID 27587 | Cycle 1(1): loaded http://localhost:40525/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40525/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:53:00 INFO - PID 27587 | RSS: Main: 203194368 08:53:00 INFO - PID 27587 | 08:53:02 INFO - PID 27587 | Cycle 1(1): loaded http://localhost:40525/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40525/tests/kraken/driver.html?testName=ai-astar) 08:53:02 INFO - PID 27587 | RSS: Main: 272207872 08:53:02 INFO - PID 27587 | 08:53:02 INFO - PID 27587 | __start_tp_report 08:53:02 INFO - PID 27587 | _x_x_mozilla_page_load 08:53:02 INFO - PID 27587 | _x_x_mozilla_page_load_details 08:53:02 INFO - PID 27587 | |i|pagename|runs| 08:53:02 INFO - PID 27587 | |0;ai-astar;108;112;110;110;111;111;113;113;112;111 08:53:02 INFO - PID 27587 | |1;audio-beat-detection;151;125;138;182;125;130;130;124;153;127 08:53:02 INFO - PID 27587 | |2;audio-dft;165;166;166;164;164;165;164;163;164;165 08:53:02 INFO - PID 27587 | |3;audio-fft;75;75;76;109;77;77;75;78;97;77 08:53:02 INFO - PID 27587 | |4;audio-oscillator;85;84;107;85;85;85;111;85;84;106 08:53:02 INFO - PID 27587 | |5;imaging-gaussian-blur;114;113;114;115;114;114;114;114;113;114 08:53:02 INFO - PID 27587 | |6;imaging-darkroom;151;149;151;156;150;150;150;150;150;151 08:53:02 INFO - PID 27587 | |7;imaging-desaturate;94;94;95;95;94;95;94;95;94;94 08:53:02 INFO - PID 27587 | |8;json-parse-financial;65;65;64;64;64;65;67;66;66;66 08:53:02 INFO - PID 27587 | |9;json-stringify-tinderbox;57;57;57;56;57;58;57;57;57;57 08:53:02 INFO - PID 27587 | |10;stanford-crypto-aes;85;85;87;86;85;93;92;83;84;85 08:53:02 INFO - PID 27587 | |11;stanford-crypto-ccm;136;134;136;147;133;142;141;142;182;151 08:53:02 INFO - PID 27587 | |12;stanford-crypto-pbkdf2;187;195;201;199;199;203;197;194;209;185 08:53:02 INFO - PID 27587 | |13;stanford-crypto-sha256-iterative;74;70;70;71;73;70;77;71;71;76 08:53:02 INFO - PID 27587 | __end_tp_report 08:53:02 INFO - PID 27587 | __start_cc_report 08:53:02 INFO - PID 27587 | _x_x_mozilla_cycle_collect,2013 08:53:02 INFO - PID 27587 | __end_cc_report 08:53:02 INFO - PID 27587 | __startTimestamp1490889182745__endTimestamp 08:53:02 INFO - PID 27587 | 08:53:02 INFO - PID 27587 | ------- Summary: start ------- 08:53:02 INFO - PID 27587 | Number of tests: 14 08:53:02 INFO - PID 27587 | 08:53:02 INFO - PID 27587 | [#0] ai-astar Cycles:10 Average:111.10 Median:111.50 stddev:1.52 (1.4%) stddev-sans-first:1.13 08:53:02 INFO - PID 27587 | Values: 108.0 112.0 110.0 110.0 111.0 111.0 113.0 113.0 112.0 111.0 08:53:02 INFO - PID 27587 | 08:53:02 INFO - PID 27587 | [#1] audio-beat-detection Cycles:10 Average:138.50 Median:134.00 stddev:18.59 (13.9%) stddev-sans-first:19.16 08:53:02 INFO - PID 27587 | Values: 151.0 125.0 138.0 182.0 125.0 130.0 130.0 124.0 153.0 127.0 08:53:02 INFO - PID 27587 | 08:53:02 INFO - PID 27587 | [#2] audio-dft Cycles:10 Average:164.60 Median:165.00 stddev:0.97 (0.6%) stddev-sans-first:1.01 08:53:02 INFO - PID 27587 | Values: 165.0 166.0 166.0 164.0 164.0 165.0 164.0 163.0 164.0 165.0 08:53:02 INFO - PID 27587 | 08:53:02 INFO - PID 27587 | [#3] audio-fft Cycles:10 Average:81.60 Median:77.00 stddev:11.67 (15.2%) stddev-sans-first:12.13 08:53:02 INFO - PID 27587 | Values: 75.0 75.0 76.0 109.0 77.0 77.0 75.0 78.0 97.0 77.0 08:53:02 INFO - PID 27587 | 08:53:02 INFO - PID 27587 | [#4] audio-oscillator Cycles:10 Average:91.70 Median:85.00 stddev:11.32 (13.3%) stddev-sans-first:11.75 08:53:02 INFO - PID 27587 | Values: 85.0 84.0 107.0 85.0 85.0 85.0 111.0 85.0 84.0 106.0 08:53:02 INFO - PID 27587 | 08:53:02 INFO - PID 27587 | [#5] imaging-gaussian-blur Cycles:10 Average:113.90 Median:114.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 08:53:02 INFO - PID 27587 | Values: 114.0 113.0 114.0 115.0 114.0 114.0 114.0 114.0 113.0 114.0 08:53:02 INFO - PID 27587 | 08:53:02 INFO - PID 27587 | [#6] imaging-darkroom Cycles:10 Average:150.80 Median:150.50 stddev:1.93 (1.3%) stddev-sans-first:2.05 08:53:02 INFO - PID 27587 | Values: 151.0 149.0 151.0 156.0 150.0 150.0 150.0 150.0 150.0 151.0 08:53:02 INFO - PID 27587 | 08:53:02 INFO - PID 27587 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 08:53:02 INFO - PID 27587 | Values: 94.0 94.0 95.0 95.0 94.0 95.0 94.0 95.0 94.0 94.0 08:53:02 INFO - PID 27587 | 08:53:02 INFO - PID 27587 | [#8] json-parse-financial Cycles:10 Average:65.20 Median:65.50 stddev:1.03 (1.6%) stddev-sans-first:1.09 08:53:02 INFO - PID 27587 | Values: 65.0 65.0 64.0 64.0 64.0 65.0 67.0 66.0 66.0 66.0 08:53:02 INFO - PID 27587 | 08:53:02 INFO - PID 27587 | [#9] json-stringify-tinderbox Cycles:10 Average:57.00 Median:57.00 stddev:0.47 (0.8%) stddev-sans-first:0.50 08:53:02 INFO - PID 27587 | Values: 57.0 57.0 57.0 56.0 57.0 58.0 57.0 57.0 57.0 57.0 08:53:02 INFO - PID 27587 | 08:53:02 INFO - PID 27587 | [#10] stanford-crypto-aes Cycles:10 Average:86.50 Median:85.50 stddev:3.34 (3.9%) stddev-sans-first:3.50 08:53:02 INFO - PID 27587 | Values: 85.0 85.0 87.0 86.0 85.0 93.0 92.0 83.0 84.0 85.0 08:53:02 INFO - PID 27587 | 08:53:02 INFO - PID 27587 | [#11] stanford-crypto-ccm Cycles:10 Average:144.40 Median:142.00 stddev:14.40 (10.1%) stddev-sans-first:14.95 08:53:02 INFO - PID 27587 | Values: 136.0 134.0 136.0 147.0 133.0 142.0 141.0 142.0 182.0 151.0 08:53:02 INFO - PID 27587 | 08:53:02 INFO - PID 27587 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:196.90 Median:199.00 stddev:7.16 (3.6%) stddev-sans-first:6.63 08:53:02 INFO - PID 27587 | Values: 187.0 195.0 201.0 199.0 199.0 203.0 197.0 194.0 209.0 185.0 08:53:02 INFO - PID 27587 | 08:53:02 INFO - PID 27587 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.30 Median:72.00 stddev:2.58 (3.6%) stddev-sans-first:2.67 08:53:02 INFO - PID 27587 | Values: 74.0 70.0 70.0 71.0 73.0 70.0 77.0 71.0 71.0 76.0 08:53:02 INFO - PID 27587 | -------- Summary: end -------- 08:53:02 INFO - PID 27587 | 08:53:03 INFO - TEST-INFO | 27587: exit 0 08:53:03 INFO - TEST-OK | kraken | took 65737ms 08:53:03 INFO - SUITE-END | took 1189s 08:53:04 INFO - Completed test suite (00:19:50) 08:53:04 INFO - javascript benchmark 08:53:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6582.7191159855965, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2670.359113812685, 2684.5838894971284, 2706.3369474478754, 2714.5249581323264, 2718.768904643104, 5010.273510341008, 5110.463401342861, 5154.407243167032, 5160.741962901854, 5202.245674377218, 5072.695638261707, 5102.795888164478, 5158.148905430599, 5160.638755287131, 5203.661761985469, 4431.26884064129, 4689.062187562493, 4788.209945359012, 4821.6865903716325, 4830.372051633282, 4741.596964258025, 4747.90504189916, 4769.117713223065, 4790.736509491977, 4838.225883858583, 4566.589006989354, 4646.3495110684535, 4661.766911654404, 4667.766611669437, 4713.575778179946, 4692.976535117336, 4700.177468942956, 4714.929276060861, 4766.0, 4779.641526885497, 4640.164770341337, 4657.69724967876, 4688.46082700487, 4691.530846915315, 4712.2224832902875, 4991.800327986876, 5085.186370180791, 5138.203578445347, 5144.485551444863, 5181.792728290864, 5444.50999410051, 5473.7263136843, 5476.644018138848, 5480.616356855022, 5484.012877682016, 5469.234307196995, 5510.228568000483, 5595.608307418483, 5602.0, 5607.102863541813, 5055.797768089235, 5058.165402708585, 5059.215821547592, 5065.924011139836, 5073.1122053640465, 5508.807191748269, 5541.5289700375115, 5590.049691552445, 5596.384397716248, 5661.46216109469, 5345.812896548602, 5375.946240537544, 5400.783968641211, 5440.700761458158, 5465.4261302563455, 5566.192902029264, 5567.387587365387, 5567.47109024642, 5567.888642227133, 5603.719814009283, 5462.754176062087, 5489.34127904646, 5500.3949565547755, 5509.338879334506, 5523.558115350762, 5307.416184219733, 5387.919181212285, 5388.0570900092325, 5390.568754499709, 5543.944560554423, 4721.220998535272, 4760.523947605281, 4760.7619619018915, 4761.547652972962, 4761.5714585686765, 4028.91942161161, 4033.092554175287, 4034.899127521777, 4060.9847538115473, 4062.5531191568903, 4758.119747846659, 4760.0, 4760.857174284777, 4761.47623761386, 4814.831480898151, 5404.621676482687, 5422.783088676488, 5487.890242195133, 5495.6153069284765, 5586.86032849182, 4676.929846052312, 4714.6464015199, 4721.220998535272, 4723.95276047242, 4725.40932383452, 4929.580985616263, 4948.455669876311, 4951.3810773653295, 4951.752412379366, 4955.504449555087, 5160.225966105114, 5171.586273098218, 5171.715555644476, 5175.585953123666, 5175.689458632494, 5528.336599608073, 5540.168974653834, 5541.889162216814, 5547.11246200606, 5552.52803511706, 5159.17453207485, 5162.741862906764, 5167.974160129175, 5170.8965820684125, 5170.97414512925, 5409.702466364388, 5428.7285635718845, 5433.673979561239, 5444.673319600836, 5444.754986025718, 5483.314585676791, 5492.47821456961, 5492.862678433071, 5492.972535137299, 5496.230527726041, 5263.052650522943, 5310.070737620824, 5343.7060961647485, 5348.304720386325, 5398.325209348832, 5327.067763141357, 5368.32895888014, 5405.324334458192, 5406.75669594877, 5426.728663566885, 5241.292425522658, 5245.895082098413, 5250.789968401374, 5256.053910296183, 5257.684538927677, 5242.868928276824, 5360.758765855624, 5384.246205531151, 5400.1089820180805, 5418.0, 5165.070287348313, 5165.147750621106, 5173.63784535079, 5185.144451165515, 5186.144286192736], "value": 5028.211177597576, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [611.8103387949736, 664.933506649335, 685.9314068593142, 1062.3572738493212, 1080.8540846985654, 27178.107940570688, 27893.721062789366, 27911.302217444572, 27946.0, 27949.301267468323, 32668.836655816747, 32839.343213135784, 32884.34231315372, 33006.854554454, 33030.009099727045, 7460.850782984324, 7656.923430765677, 7658.961705191494, 7677.539347639132, 7682.654280557361, 5654.293213348332, 7486.812829679247, 7637.312641862231, 7642.0, 7649.235076492362, 5861.296644402678, 7252.854942901139, 7435.814104647373, 7436.442266829982, 7441.404687625004, 7436.2191969842925, 7474.327310542023, 7493.887591686156, 7503.587302698349, 7503.737369192107, 5635.71821408932, 7243.927560724378, 7323.780286591357, 7336.669849856769, 7341.816454588625, 25884.74115258861, 26250.606240906403, 26282.86858565695, 30808.691913080806, 31432.842835785676, 2634.9987004938193, 2638.60420936861, 2654.734526547349, 2659.188947371051, 2683.5035518429154, 24028.0, 24142.0, 24148.0, 24248.393790155213, 24613.63079553808, 2389.4026493376655, 2433.476802487474, 2433.598456254716, 2442.3161514775893, 2477.677901872745, 151883.0, 152251.0, 152398.23800881035, 152793.23603381912, 153157.0, 43488.0, 43494.0, 43542.0, 43572.128557428674, 43605.345919811225, 45190.54809451929, 45315.546844531134, 45423.77288113604, 45424.54575454203, 45536.3169552457, 12003.459844306852, 12461.06542009353, 12465.439055242536, 12493.12548121641, 12625.116241863165, 10005.79988400228, 10021.498925053718, 10037.949810251048, 10219.080282774587, 10320.0, 10241.129503992095, 10679.626213082505, 11988.520459181535, 12537.247765134121, 12621.116521843567, 4796.688215265996, 4964.106460837012, 4971.552560269521, 4973.726445045485, 5045.8738531537, 858.6908712863365, 882.8896387951506, 893.1871996483169, 896.7982204004047, 915.8076803871129, 19368.806311936984, 19856.10647520865, 19909.303174388828, 19953.201871925252, 19954.501137471678, 961.6153538584622, 966.1932286540817, 971.5676523946776, 971.7376308396694, 987.6790043235977, 10396.636117735843, 10615.097716694167, 10833.945830270799, 10840.349579025125, 10882.0, 209394.0, 209583.0, 209879.0, 210024.0, 210367.0, 41204.0, 41435.0, 41492.37761433581, 41679.79160104241, 41718.37422438666, 1173.9433292253416, 1222.1200735470625, 1227.1410012990941, 1233.975320493585, 1244.3840299051847, 18205.817941820944, 18537.35119270819, 19412.2235110594, 19571.0, 19639.0, 30500.0, 30543.84728076434, 30564.694353056184, 30605.540916886708, 30607.54088688716, 216047.0, 216140.0, 216835.0, 217299.0, 217660.0, 28165.295867603472, 28214.294642634097, 28243.576346355232, 28310.71689283081, 28615.570766438104, 34739.652603473645, 35241.82379088088, 35818.462723058656, 35923.281534369686, 36333.63666363408, 26657.0, 26995.460090797682, 27283.86358068197, 27391.863040684668, 27918.441631166857, 26972.460550789267, 27387.86306068457, 27741.445171096868, 27921.301967450978, 28027.299317517227, 29628.0, 30295.545566816956, 30432.0, 30534.0, 30557.388852222386, 26902.461950761266, 27169.0, 27754.86122569455, 28316.716832831407, 28353.71646283511, 19731.336269603995, 20346.796532034492, 20411.79588204099, 20593.0, 20612.587748244652], "value": 14372.355093391621, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [389.73303287248217, 398.86637976277945, 427.61728253213386, 427.6771037866412, 437.49687858962193, 11981.700457488567, 13379.26414047227, 18349.7247541287, 18657.0, 18928.148233329517, 16225.83774162258, 16668.916655416706, 16926.83073169268, 16976.15119244039, 17153.742693859604, 5571.9721401392935, 5733.140028995643, 5772.393898640646, 5776.913346299788, 5785.537157027427, 5391.56867450603, 5650.29371328584, 5673.631213971079, 5674.3190817102, 5682.403347648499, 5647.237622920894, 5649.745761440745, 5650.208970744099, 5652.576056795757, 5660.462256085686, 6020.488258498033, 6310.305866354697, 6368.0, 6369.0, 6372.235331760218, 6011.939880601181, 6103.816885493442, 6161.045038019114, 6208.037754148114, 6237.87524249517, 23384.64923026156, 23548.411289717722, 24028.759712402825, 24103.15638952646, 24223.394415139584, 1588.1424031023348, 1589.102157281144, 1607.2285303054482, 1608.1557182479291, 1632.4612877750315, 14400.63998400038, 15031.624209394744, 15149.621259468491, 15283.770743438858, 15726.0, 1598.20888660114, 1703.6422351306242, 1711.8031426385876, 1722.4067737343032, 1744.1715185286887, 84248.57875710582, 86723.56638216769, 86862.5656871718, 91292.54353728256, 91875.0, 17561.736573951403, 17834.56045906011, 18022.0, 18149.818501814814, 18384.724229136573, 33148.02779583082, 33179.50230746541, 33237.0, 33248.335033299685, 33327.83336083304, 8419.705310314232, 8660.826783464296, 8735.825283494294, 8970.506622135714, 8995.505247211466, 6853.451723862079, 6884.965575172092, 6893.379595836399, 7073.893891591631, 7094.645267736592, 9413.670521531714, 9423.528823558794, 9451.716448506555, 9618.374805637752, 9800.11798938099, 3790.298794722985, 3930.272899513599, 3943.2507823514015, 3959.524857017119, 3996.4005399190355, 854.3848429131016, 863.8531449653574, 870.0951010948543, 884.3853521802414, 908.246155690775, 15647.68704625901, 15903.920480397755, 15926.60183495422, 16145.59636009109, 16557.25492352847, 882.8587426011808, 884.0408157149436, 890.8040231149137, 899.1188635137602, 903.75146834621, 8740.650373984969, 8811.69159079442, 8912.415399534193, 9345.626174953062, 9393.154616084448, 440966.2888767833, 447358.0, 452388.0, 453401.0, 456062.0, 85701.57149214215, 86767.56616216879, 90821.12632636285, 90838.54580727186, 91237.54381228185, 1054.4938429553856, 1057.957681692739, 1075.548269726701, 1079.3631757263252, 1080.9621663241749, 13695.246761428218, 13799.172049677052, 13850.376733047238, 13985.090969086978, 14396.42414303416, 38928.0, 39703.40444893387, 40563.797181013906, 40759.796201018806, 41106.9723256909, 51342.48657513377, 51811.74094129505, 52103.0, 52227.73886130545, 54109.18836217539, 11472.88527114718, 11609.3614851184, 11661.591844285409, 11843.467043983213, 11905.702357441134, 12023.699407514881, 12063.457144428698, 13159.407826647632, 13408.664783380103, 13596.86403135956, 10760.148560631282, 10790.622328218475, 11080.501377437873, 11132.666020019413, 11275.830862537232, 10801.945990269998, 10837.729056773644, 10938.124950003821, 11015.0, 11031.22781405294, 11151.275167114112, 11374.43127843621, 11422.771544569228, 11434.542618295507, 11824.0, 11559.653210403701, 11583.8262426062, 11588.6523404298, 11647.359395233343, 12247.510099595916, 11080.778384432428, 11314.321140731583, 12053.216540925163, 12186.695332616755, 12364.62906112818], "value": 9739.676592216078, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1099.0603034405578, 1223.7491314280574, 1271.980920286196, 1286.9935650321752, 1299.3957809618526, 8116.756497305076, 8506.27696645785, 9196.0, 9651.276154288422, 9659.420434773918, 9423.81152376952, 9489.572969216384, 9510.952445237765, 9523.571439285231, 9525.095115963972, 2182.9890850545726, 2230.2528652901296, 2233.486298151426, 2233.7542870284337, 2237.3288013595857, 1795.0665653859985, 1863.7670291213599, 2163.9891800540977, 2235.0389332586983, 2237.65316375962, 2115.8730476171404, 2140.9250676226334, 2142.4429648291402, 2143.446001648808, 2144.3995681209285, 2154.601398741238, 2194.9122035118576, 2195.089038049208, 2195.121951219525, 2197.0772275644267, 2122.7877212278804, 2123.193186589086, 2133.423975526615, 2175.3908905506482, 2176.0425412818468, 9597.904020959772, 9623.56693948767, 9694.418334899858, 9708.61165553377, 9745.31782775206, 5330.7334633268565, 5516.172574113875, 5520.696361700105, 5535.861603459945, 5536.252605898233, 3226.8547915343865, 3315.55240042596, 3363.899083027489, 3447.7241820654285, 3514.1566024154276, 1021.1830535571513, 1037.7768779712399, 1058.9311694739818, 1093.6117678224196, 1102.614085070227, 13680.90552755787, 13706.52027179054, 13711.382987765475, 13719.657008574766, 13759.518416855462, 4763.309320148559, 4881.780319885614, 5002.89994200114, 5041.319421878073, 5148.2020286855595, 11749.060075193964, 11753.941230293794, 11761.705957351134, 11778.88221117795, 11788.115891308014, 5463.808766693226, 5471.343438787371, 5472.425395333512, 5477.75350109246, 5483.067878460672, 4196.433481480022, 4845.95154048455, 4874.341963834908, 4888.289098815386, 5008.824691135793, 3652.342578335872, 3980.144268982183, 4127.669786417079, 4142.730722503027, 4172.895677608084, 1265.8923991460645, 1301.804729290595, 1305.9673508162373, 1318.821959035537, 1320.7810877725321, 683.1085433509219, 683.1255992329826, 695.474916438086, 702.125853312629, 719.5287086957946, 5108.7190204538365, 5136.794528218904, 5203.8178663746585, 5237.6071794615555, 5311.0, 800.3477166109602, 803.2650125135435, 806.7539400482792, 809.5062012172571, 814.1207495904409, 3217.3565286942703, 3235.8058516489086, 3242.416365054313, 3256.8371581420834, 3333.5999680038067, 12295.508179672714, 12603.93698031504, 12697.746045079231, 12740.872591273968, 12744.044196685285, 12294.262344259194, 12593.92951599106, 12620.0, 12647.683807904876, 12684.175528590613, 9126.817463650823, 9297.349185556946, 9320.673776417792, 9321.394109382869, 9321.394109383004, 5510.641808282448, 5545.3622833373065, 5563.8887222256135, 5666.376698563073, 5694.715264236855, 11259.042981346349, 11311.490982905954, 11316.321020738453, 11351.318920864775, 11472.598459053894, 11422.314661120026, 11614.12894032934, 11780.882191177978, 11827.290362578273, 11870.52517899309, 7952.403569732178, 8037.477563958324, 8045.9597702011115, 8051.677932882853, 8066.798330041796, 8998.23515001206, 9209.723708288762, 9273.675421360489, 9286.95356523213, 9317.34778565521, 7433.10802703679, 7550.924490755022, 7561.621918904143, 7563.827606720967, 7772.067351917806, 7276.781696549112, 7309.232530584425, 7357.2642735726, 7392.926070739224, 7645.0, 6626.0, 6757.087793147862, 6757.966210168917, 6758.493113016445, 6769.0, 4976.751162441936, 5029.5221953914315, 5082.771275292695, 5097.439281679087, 5140.306058682179, 4779.976100119477, 4780.235162374003, 4888.706677599355, 5187.610929180251, 5285.577153827608], "value": 4603.901636916097, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [360.32978659692964, 379.5729803970533, 381.9121602031531, 390.843662534986, 394.94470774091616, 5360.303160589123, 5381.762194695222, 5389.838304850851, 5409.810656627019, 5424.755885985141, 5108.974455127719, 5234.73826308684, 5249.0, 5270.445218660495, 5317.229001794747, 4120.423140760296, 4121.423000779893, 4121.9381709274385, 4133.979330103345, 4139.503259608851, 4114.7119701620895, 4127.772972486512, 4141.467656966926, 4143.730657507267, 4150.094933546515, 3936.3308237599676, 4092.2224777292217, 4101.4668093148, 4104.1381309924955, 4113.095119073799, 4080.3879418087226, 4082.122343696105, 4087.632113109805, 4105.261053010457, 4107.137501124767, 3589.587197472298, 3592.568891733009, 3602.35157671619, 3605.296967091418, 3605.4591811228265, 4923.2183816144125, 5171.612129090333, 5173.025510331574, 5179.870503237412, 5184.377874655065, 4698.741569213692, 4705.317728929286, 4738.739369334685, 4742.312364707098, 4756.6432517561325, 5566.385748133037, 5572.749226284786, 5577.637453565505, 5593.7693707384315, 5605.467480589337, 3785.261873934584, 3932.0, 3960.980195099035, 3961.920761584781, 3976.840926362942, 5598.300212473441, 5683.204351390808, 5762.481376676077, 5873.85315367115, 5928.822135335947, 4025.879223623296, 4036.6367026967714, 4038.071243613985, 4038.596140385938, 4065.3698676705158, 4102.610252026053, 4109.0, 4123.8556650517085, 4129.0, 4129.587041295907, 4416.66874984371, 4492.37106805041, 4558.384618076583, 4638.327442520816, 4720.480747117815, 5541.5289700375915, 5561.805336813192, 5562.3881373048935, 5564.582656300794, 5571.888562228733, 1388.55566218809, 1392.2481859795798, 1393.3869097597026, 1393.986060139406, 1399.1535121251495, 919.7194855569115, 948.7248697877676, 959.7456673981401, 965.9613615455303, 968.9612415503301, 4861.829835955725, 4869.196582563908, 4872.3909511311085, 4880.316755654211, 4910.48439913811, 5772.942270577324, 5788.18965344852, 5797.565182611321, 5800.680962547016, 5804.245448091721, 4660.184467718136, 4841.588464980446, 4890.706557606484, 4895.4370247422, 4901.877453063702, 3037.4228896509594, 3059.7858149929734, 3073.2163298359224, 3073.4775088234605, 3074.4773388524004, 5365.960934844812, 5369.838904832784, 5377.247185394048, 5394.460553944574, 5397.325334333208, 5688.402717714663, 5842.824715258549, 5863.2670916135485, 5865.560082993792, 5936.436038576328, 5351.866203344792, 5351.92264447944, 5363.329583801947, 5374.4088150304215, 5376.623636345418, 5585.664860108406, 5769.567282453917, 5775.826725198251, 5792.53659707214, 5793.9420605795085, 5637.520810731134, 5705.258316418839, 5707.68607726579, 5713.885722285448, 5718.714064296852, 5161.174212126042, 5245.895082098413, 5247.107991641354, 5372.146609419744, 5393.325834270716, 4014.0968282136287, 4016.9598304016586, 4021.33647948097, 4026.879193624196, 4039.293123703399, 5471.2887324647545, 5768.423157684198, 5768.53851691872, 5780.421957804354, 5811.27359080115, 5494.5988772862665, 5520.1167813149705, 5537.9169312459535, 5587.608867379245, 5589.608727389043, 5510.338759348904, 5525.917111243415, 5550.833474995757, 5582.102085291021, 5597.44025597437, 5352.678839269501, 5486.753096110605, 5491.780328786964, 5493.340799103973, 5524.7348587079105, 5565.526930210977, 5625.803096891589, 5633.2395126657375, 5648.802291919763, 5658.377578466283, 5433.022056029952, 5440.755166017618, 5454.645448045864, 5464.508194262536, 5489.64317319373], "value": 4201.003577631391, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [609.3510411411846, 611.2390074357426, 623.728678025059, 627.1940556385044, 632.531926374483, 12986.155899866513, 13461.125026873246, 13871.722565548684, 13889.861101388995, 14230.146191228534, 13361.732765344712, 13498.730025399485, 13847.09993850399, 13860.930695346535, 13894.583162505116, 883.4743327719997, 911.8723378726951, 915.7298596913927, 915.9633614655439, 916.4730280088942, 914.2046419614911, 952.6713283917038, 958.6884262614643, 958.8226178157029, 958.9760255993586, 1003.4882210072878, 1008.8184126857162, 1011.0142610954298, 1011.1506334678868, 1011.4891979550354, 995.6515219673056, 997.4414327976357, 997.4663554998041, 997.9550920208608, 998.4658207858797, 739.006036880395, 739.4269441183072, 740.2967181177848, 740.9925900740977, 741.0625558668289, 12679.23924564529, 13154.934225328907, 14176.078554893898, 14203.360848761831, 14218.85781142196, 13227.338633068308, 13516.256605886672, 13729.45082196711, 13780.070790089396, 13803.447862085504, 8460.365472589581, 8530.104339044374, 8697.084993558801, 8873.157050080232, 8999.910000899972, 2192.5395666909967, 2204.548067646129, 2206.58074965756, 2251.1670681847822, 2261.2424837679396, 62756.68621656908, 62840.0, 62926.70732926716, 63678.68160659213, 63976.0, 9338.393004454825, 9426.245900327956, 9496.0, 9555.378900371592, 9696.418214907128, 19403.029848507802, 19459.12433940476, 19459.8054019458, 19544.413667589994, 19590.412287631392, 6045.33501314855, 6058.848528786815, 6062.393760623902, 6145.170401995673, 6237.688115594202, 3015.1406849047917, 3026.228311780482, 3067.5552044953356, 3070.8771649134233, 3075.7231849133686, 3390.271091715293, 3473.0, 3501.1072176594807, 3501.7548771586253, 3503.5795704515112, 574.2964868036705, 576.9336526299445, 583.3903570768557, 584.2288179602883, 587.216066551159, 427.1009524949998, 452.3734627540814, 465.4554171619214, 465.66704806063825, 486.341007934244, 6655.267920528738, 7176.210616832144, 7326.706931722778, 7418.221086785918, 7745.806354841061, 449.43595787286745, 470.2100471208403, 472.63370887562417, 509.88527581293914, 520.7994921954999, 3341.8329083545727, 3344.6153692325693, 3423.9828800855835, 3481.1993241554583, 3589.9102522437147, 59218.703906480194, 60332.39667603355, 60485.39514604885, 60489.0, 61708.38291617116, 51817.74091129596, 52483.47516524786, 52530.474695253324, 53181.46818531842, 53350.46649533533, 47932.28101578479, 49058.50941490539, 49567.75216123896, 49937.250941235914, 50168.74915625399, 6895.689693963884, 7131.607761573163, 7151.499395042297, 7347.0, 7355.043844300207, 25412.74587254104, 25650.871745641154, 25846.483070338865, 26241.081562146, 26817.0, 41289.79355103325, 43219.135617288106, 43574.782126089165, 43772.0, 43925.341119883866, 10600.46997650099, 10712.839307410239, 10847.40339281347, 10870.510827012962, 10932.453377331261, 10851.0, 10960.671179864617, 11076.889231107585, 11217.943910280397, 11833.19578813387, 10138.797224055625, 10152.543135559064, 10393.792124157626, 10414.166866650801, 10761.623343182951, 9945.950270248602, 10459.320144190604, 10471.115199264206, 10734.087602553871, 10788.568457261936, 10515.631952881613, 10963.725906852074, 11031.448427578749, 11144.164187685794, 11387.487563059847, 8165.183481652025, 8467.0, 8537.87193192115, 8538.402311838112, 8603.139686031347, 7932.881006784787, 8081.555514446527, 8952.462852228888, 9115.665189131232, 9259.444433334022], "value": 5976.283264943, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1568.9000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 112.0, 110.0, 110.0, 111.0, 111.0, 113.0, 113.0, 112.0, 111.0], "value": 111.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 125.0, 138.0, 182.0, 125.0, 130.0, 130.0, 124.0, 153.0, 127.0], "value": 138.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 166.0, 166.0, 164.0, 164.0, 165.0, 164.0, 163.0, 164.0, 165.0], "value": 164.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 109.0, 77.0, 77.0, 75.0, 78.0, 97.0, 77.0], "value": 81.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 107.0, 85.0, 85.0, 85.0, 111.0, 85.0, 84.0, 106.0], "value": 91.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 114.0, 115.0, 114.0, 114.0, 114.0, 114.0, 113.0, 114.0], "value": 113.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 149.0, 151.0, 156.0, 150.0, 150.0, 150.0, 150.0, 150.0, 151.0], "value": 150.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 95.0, 94.0, 95.0, 94.0, 95.0, 94.0, 94.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 64.0, 64.0, 64.0, 65.0, 67.0, 66.0, 66.0, 66.0], "value": 65.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 57.0, 56.0, 57.0, 58.0, 57.0, 57.0, 57.0, 57.0], "value": 57.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 87.0, 86.0, 85.0, 93.0, 92.0, 83.0, 84.0, 85.0], "value": 86.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 134.0, 136.0, 147.0, 133.0, 142.0, 141.0, 142.0, 182.0, 151.0], "value": 144.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 195.0, 201.0, 199.0, 199.0, 203.0, 197.0, 194.0, 209.0, 185.0], "value": 196.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 70.0, 70.0, 71.0, 73.0, 70.0, 77.0, 71.0, 71.0, 76.0], "value": 72.3, "unit": "score"}]}]} 08:53:04 INFO - Return code: 0 08:53:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:53:04 ERROR - # TBPL SUCCESS # 08:53:04 INFO - Running post-action listener: _resource_record_post_action 08:53:04 INFO - [mozharness: 2017-03-30 15:53:04.523947Z] Finished run-tests step (success) 08:53:04 INFO - Running post-run listener: _resource_record_post_run 08:53:04 INFO - Total resource usage - Wall time: 1206s; CPU: 13.0%; Read bytes: 0; Write bytes: 366792704; Read time: 0; Write time: 203692 08:53:04 INFO - TinderboxPrint: CPU usage
13.0% 08:53:04 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 08:53:04 INFO - TinderboxPrint: I/O write bytes / time
366,792,704 / 203,692 08:53:04 INFO - TinderboxPrint: CPU idle
8,371.5 (87.0%) 08:53:04 INFO - TinderboxPrint: CPU user
1,204.3 (12.5%) 08:53:04 INFO - TinderboxPrint: Swap in / out
0 / 0 08:53:04 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 106807296; Read time: 0; Write time: 88272 08:53:04 INFO - run-tests - Wall time: 1190s; CPU: 13.0%; Read bytes: 0; Write bytes: 259985408; Read time: 0; Write time: 115420 08:53:05 INFO - Running post-run listener: _upload_blobber_files 08:53:05 INFO - Blob upload gear active. 08:53:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:53:05 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 08:53:05 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:53:05 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:53:05 INFO - (blobuploader) - INFO - Open directory for files ... 08:53:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:53:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:53:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:53:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:53:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:53:09 INFO - (blobuploader) - INFO - Done attempting. 08:53:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:53:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:53:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:53:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:53:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:53:09 INFO - (blobuploader) - INFO - Done attempting. 08:53:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:53:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:53:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:53:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:53:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:53:10 INFO - (blobuploader) - INFO - Done attempting. 08:53:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:53:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:53:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:53:11 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:53:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:53:11 INFO - (blobuploader) - INFO - Done attempting. 08:53:11 INFO - (blobuploader) - INFO - Iteration through files over. 08:53:11 INFO - Return code: 0 08:53:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:53:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:53:11 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7ad5b82501be1a4b36b2a4961b29fa55c471256761ba67a5de796d7dd5cf6a0f72ea7e59132c95d5ee6ad8a25e27db11e42a4feea42f2399825554ab5cdc52cb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a54e7678a4fd53cf69df902c31887cb7b4adbae3b9bb5eb6b88bb35ae9f7d35bf88c5b126fc6fcf988fbd9472f6ab8e2d5e58fdb52a6ab7a5bd630f3d215afa5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/72f2e19e3a8e7cb27f6d7287fe43bf46377369ebd236c9aaba3adbb8d5b11d1d2dac338153b904a311cc71b448e4ffb5e68e06437e5326a8d35cb0f7a5a8063f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bb7c2016d6360a4cb779cdf2d7aa10e46a8a2d5aeb70d4451fabc3f9421f978313db2bfbe9a844a91b10368d6cfdd58ed1ddbcebf0fc636d55db04219f9cba01"} 08:53:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:53:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:53:11 INFO - Contents: 08:53:11 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7ad5b82501be1a4b36b2a4961b29fa55c471256761ba67a5de796d7dd5cf6a0f72ea7e59132c95d5ee6ad8a25e27db11e42a4feea42f2399825554ab5cdc52cb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a54e7678a4fd53cf69df902c31887cb7b4adbae3b9bb5eb6b88bb35ae9f7d35bf88c5b126fc6fcf988fbd9472f6ab8e2d5e58fdb52a6ab7a5bd630f3d215afa5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/72f2e19e3a8e7cb27f6d7287fe43bf46377369ebd236c9aaba3adbb8d5b11d1d2dac338153b904a311cc71b448e4ffb5e68e06437e5326a8d35cb0f7a5a8063f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bb7c2016d6360a4cb779cdf2d7aa10e46a8a2d5aeb70d4451fabc3f9421f978313db2bfbe9a844a91b10368d6cfdd58ed1ddbcebf0fc636d55db04219f9cba01"} 08:53:11 INFO - Running post-run listener: copy_logs_to_upload_dir 08:53:11 INFO - Copying logs to upload dir... 08:53:11 INFO - mkdir: /builds/slave/test/build/upload/logs 08:53:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.578522 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2017-03-30 08:53:10.933779) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-30 08:53:10.936870) ========= 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=199fb4c72b90437b990b419b000001c5-1490887420.724272-363469947 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7ad5b82501be1a4b36b2a4961b29fa55c471256761ba67a5de796d7dd5cf6a0f72ea7e59132c95d5ee6ad8a25e27db11e42a4feea42f2399825554ab5cdc52cb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a54e7678a4fd53cf69df902c31887cb7b4adbae3b9bb5eb6b88bb35ae9f7d35bf88c5b126fc6fcf988fbd9472f6ab8e2d5e58fdb52a6ab7a5bd630f3d215afa5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/72f2e19e3a8e7cb27f6d7287fe43bf46377369ebd236c9aaba3adbb8d5b11d1d2dac338153b904a311cc71b448e4ffb5e68e06437e5326a8d35cb0f7a5a8063f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bb7c2016d6360a4cb779cdf2d7aa10e46a8a2d5aeb70d4451fabc3f9421f978313db2bfbe9a844a91b10368d6cfdd58ed1ddbcebf0fc636d55db04219f9cba01"} build_url:https://queue.taskcluster.net/v1/task/WPrw1PBMSS-vUjG5HGKOMw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011335 build_url: 'https://queue.taskcluster.net/v1/task/WPrw1PBMSS-vUjG5HGKOMw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7ad5b82501be1a4b36b2a4961b29fa55c471256761ba67a5de796d7dd5cf6a0f72ea7e59132c95d5ee6ad8a25e27db11e42a4feea42f2399825554ab5cdc52cb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a54e7678a4fd53cf69df902c31887cb7b4adbae3b9bb5eb6b88bb35ae9f7d35bf88c5b126fc6fcf988fbd9472f6ab8e2d5e58fdb52a6ab7a5bd630f3d215afa5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/72f2e19e3a8e7cb27f6d7287fe43bf46377369ebd236c9aaba3adbb8d5b11d1d2dac338153b904a311cc71b448e4ffb5e68e06437e5326a8d35cb0f7a5a8063f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bb7c2016d6360a4cb779cdf2d7aa10e46a8a2d5aeb70d4451fabc3f9421f978313db2bfbe9a844a91b10368d6cfdd58ed1ddbcebf0fc636d55db04219f9cba01"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-30 08:53:10.962969) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-30 08:53:10.963300) ========= 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=199fb4c72b90437b990b419b000001c5-1490887420.724272-363469947 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004504 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-30 08:53:11.048560) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-30 08:53:11.048875) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-30 08:53:11.049180) ========= ========= Total master_lag: 0.16 =========