builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-031 starttime: 1482015783.82 results: success (0) buildid: 20161217140149 builduid: e07c5f664d7845cb983cb5f0ef45c0f5 revision: 5745bab28ff5e85128c774b56b4cc27c2afe2e1b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-17 15:03:03.822223) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-17 15:03:03.822987) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-17 15:03:03.823292) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-17 15:03:03.842695) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-17 15:03:03.843159) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=db0483c52d987ecb441a263b000001ad-1482014998.892341-89311437 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-17 15:03:04-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 69.9M=0s 2016-12-17 15:03:04 (69.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.089511 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-17 15:03:03.946957) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-17 15:03:03.947278) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=db0483c52d987ecb441a263b000001ad-1482014998.892341-89311437 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022372 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-17 15:03:03.998043) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-17 15:03:03.998445) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 5745bab28ff5e85128c774b56b4cc27c2afe2e1b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 5745bab28ff5e85128c774b56b4cc27c2afe2e1b --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=db0483c52d987ecb441a263b000001ad-1482014998.892341-89311437 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-17 15:03:04,484 truncating revision to first 12 chars 2016-12-17 15:03:04,484 Setting DEBUG logging. 2016-12-17 15:03:04,484 attempt 1/10 2016-12-17 15:03:04,484 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/5745bab28ff5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-17 15:03:05,010 unpacking tar archive at: mozilla-central-5745bab28ff5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.853577 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-17 15:03:04.865662) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-17 15:03:04.866022) ========= script_repo_revision: 5745bab28ff5e85128c774b56b4cc27c2afe2e1b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-17 15:03:04.866502) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-17 15:03:04.866789) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-17 15:03:04.874923) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-12-17 15:03:04.875202) ========= /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=db0483c52d987ecb441a263b000001ad-1482014998.892341-89311437 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:03:05 INFO - MultiFileLogger online at 20161217 15:03:05 in /builds/slave/test 15:03:05 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 15:03:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:03:05 INFO - {'append_to_log': False, 15:03:05 INFO - 'base_work_dir': '/builds/slave/test', 15:03:05 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 15:03:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:03:05 INFO - 'branch': 'Firefox-Non-PGO', 15:03:05 INFO - 'buildbot_json_path': 'buildprops.json', 15:03:05 INFO - 'config_files': ('talos/linux_config.py',), 15:03:05 INFO - 'default_actions': ('clobber', 15:03:05 INFO - 'read-buildbot-config', 15:03:05 INFO - 'download-and-extract', 15:03:05 INFO - 'populate-webroot', 15:03:05 INFO - 'create-virtualenv', 15:03:05 INFO - 'install', 15:03:05 INFO - 'run-tests'), 15:03:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:03:05 INFO - 'download_minidump_stackwalk': True, 15:03:05 INFO - 'download_symbols': 'ondemand', 15:03:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:03:05 INFO - 'tooltool.py': '/tools/tooltool.py', 15:03:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:03:05 INFO - '/tools/misc-python/virtualenv.py')}, 15:03:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:03:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:03:05 INFO - 'installer_path': 'installer.exe', 15:03:05 INFO - 'log_level': 'info', 15:03:05 INFO - 'log_name': 'talos', 15:03:05 INFO - 'log_to_console': True, 15:03:05 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:03:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:03:05 INFO - 'opt_config_files': (), 15:03:05 INFO - 'pip_index': False, 15:03:05 INFO - 'sps_profile': False, 15:03:05 INFO - 'sps_profile_interval': 0, 15:03:05 INFO - 'suite': 'dromaeojs', 15:03:05 INFO - 'system_bits': '32', 15:03:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:03:05 INFO - 'title': 'talos-linux64-ix-031', 15:03:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:03:05 INFO - 'use_talos_json': True, 15:03:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:03:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:03:05 INFO - 'work_dir': 'build'} 15:03:05 INFO - [mozharness: 2016-12-17 23:03:05.451302Z] Running clobber step. 15:03:05 INFO - Running pre-action listener: _resource_record_pre_action 15:03:05 INFO - Running main action method: clobber 15:03:05 INFO - rmtree: /builds/slave/test/build 15:03:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:03:05 INFO - Running post-action listener: _resource_record_post_action 15:03:05 INFO - [mozharness: 2016-12-17 23:03:05.912635Z] Finished clobber step (success) 15:03:05 INFO - [mozharness: 2016-12-17 23:03:05.912736Z] Running read-buildbot-config step. 15:03:05 INFO - Running pre-action listener: _resource_record_pre_action 15:03:05 INFO - Running main action method: read_buildbot_config 15:03:05 INFO - Using buildbot properties: 15:03:05 INFO - { 15:03:05 INFO - "project": "", 15:03:05 INFO - "product": "firefox", 15:03:05 INFO - "script_repo_revision": "production", 15:03:05 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 15:03:05 INFO - "repository": "", 15:03:05 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 15:03:05 INFO - "buildid": "20161217140149", 15:03:05 INFO - "pgo_build": "False", 15:03:05 INFO - "basedir": "/builds/slave/test", 15:03:05 INFO - "buildnumber": 877, 15:03:05 INFO - "slavename": "talos-linux64-ix-031", 15:03:05 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:03:05 INFO - "platform": "ubuntu64_hw", 15:03:05 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 15:03:05 INFO - "branch": "mozilla-central", 15:03:05 INFO - "repo_path": "mozilla-central", 15:03:05 INFO - "revision": "5745bab28ff5e85128c774b56b4cc27c2afe2e1b", 15:03:05 INFO - "stage_platform": "linux64", 15:03:05 INFO - "builduid": "e07c5f664d7845cb983cb5f0ef45c0f5", 15:03:05 INFO - "slavebuilddir": "test" 15:03:05 INFO - } 15:03:05 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ev_uCDHEQCaeUNLnCbJmGw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 15:03:05 INFO - Running post-action listener: _resource_record_post_action 15:03:05 INFO - [mozharness: 2016-12-17 23:03:05.915182Z] Finished read-buildbot-config step (success) 15:03:05 INFO - [mozharness: 2016-12-17 23:03:05.915271Z] Running download-and-extract step. 15:03:05 INFO - Running pre-action listener: _resource_record_pre_action 15:03:05 INFO - Running main action method: download_and_extract 15:03:05 INFO - mkdir: /builds/slave/test/build/tests 15:03:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:03:05 INFO - trying https://queue.taskcluster.net/v1/task/Ev_uCDHEQCaeUNLnCbJmGw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 15:03:05 INFO - Downloading https://queue.taskcluster.net/v1/task/Ev_uCDHEQCaeUNLnCbJmGw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 15:03:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ev_uCDHEQCaeUNLnCbJmGw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 15:03:06 INFO - Downloaded 1361 bytes. 15:03:06 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 15:03:06 INFO - Using the following test package requirements: 15:03:06 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 15:03:06 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 15:03:06 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:03:06 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 15:03:06 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:03:06 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 15:03:06 INFO - u'jsshell-linux-x86_64.zip'], 15:03:06 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 15:03:06 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:03:06 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 15:03:06 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 15:03:06 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:03:06 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 15:03:06 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:03:06 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 15:03:06 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:03:06 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 15:03:06 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:03:06 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:03:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ev_uCDHEQCaeUNLnCbJmGw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 15:03:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ev_uCDHEQCaeUNLnCbJmGw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:03:06 INFO - Fetch https://queue.taskcluster.net/v1/task/Ev_uCDHEQCaeUNLnCbJmGw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 15:03:07 INFO - Expected file size: 20257475 15:03:07 INFO - Obtained file size: 20257475 15:03:11 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:03:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ev_uCDHEQCaeUNLnCbJmGw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 15:03:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ev_uCDHEQCaeUNLnCbJmGw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:03:11 INFO - Fetch https://queue.taskcluster.net/v1/task/Ev_uCDHEQCaeUNLnCbJmGw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 15:03:12 INFO - Expected file size: 20257475 15:03:12 INFO - Obtained file size: 20257475 15:03:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ev_uCDHEQCaeUNLnCbJmGw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 15:03:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ev_uCDHEQCaeUNLnCbJmGw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:03:16 INFO - Fetch https://queue.taskcluster.net/v1/task/Ev_uCDHEQCaeUNLnCbJmGw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 15:03:17 INFO - Expected file size: 14409734 15:03:17 INFO - Obtained file size: 14409734 15:03:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:03:17 INFO - trying https://queue.taskcluster.net/v1/task/Ev_uCDHEQCaeUNLnCbJmGw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 15:03:17 INFO - Downloading https://queue.taskcluster.net/v1/task/Ev_uCDHEQCaeUNLnCbJmGw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 15:03:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ev_uCDHEQCaeUNLnCbJmGw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:03:18 INFO - Downloaded 55637438 bytes. 15:03:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ev_uCDHEQCaeUNLnCbJmGw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 15:03:18 INFO - mkdir: /builds/slave/test/properties 15:03:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:03:18 INFO - Writing to file /builds/slave/test/properties/build_url 15:03:18 INFO - Contents: 15:03:18 INFO - build_url:https://queue.taskcluster.net/v1/task/Ev_uCDHEQCaeUNLnCbJmGw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 15:03:19 INFO - Running post-action listener: _resource_record_post_action 15:03:19 INFO - Running post-action listener: set_extra_try_arguments 15:03:19 INFO - [mozharness: 2016-12-17 23:03:19.187698Z] Finished download-and-extract step (success) 15:03:19 INFO - [mozharness: 2016-12-17 23:03:19.187925Z] Running populate-webroot step. 15:03:19 INFO - Running pre-action listener: _resource_record_pre_action 15:03:19 INFO - Running main action method: populate_webroot 15:03:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:03:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:03:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:03:19 INFO - '--tppagecycles', 15:03:19 INFO - '7'], 15:03:19 INFO - 'tests': ['tsvgm']}}, 15:03:19 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:03:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:03:19 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:03:19 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:03:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:03:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:03:19 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 15:03:19 INFO - 'talos_options': ['--disable-e10s'], 15:03:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:03:19 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:03:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:03:19 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 15:03:19 INFO - 'talos_options': ['--disable-e10s'], 15:03:19 INFO - 'tests': ['damp', 'tps']}, 15:03:19 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:03:19 INFO - 'tests': ['damp', 'tps']}, 15:03:19 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:03:19 INFO - 'tests': ['dromaeo_dom']}, 15:03:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:03:19 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:03:19 INFO - 'tests': ['basic_compositor_video']}, 15:03:19 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:03:19 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:03:19 INFO - 'tests': ['a11yr', 15:03:19 INFO - 'ts_paint', 15:03:19 INFO - 'tpaint', 15:03:19 INFO - 'sessionrestore', 15:03:19 INFO - 'sessionrestore_no_auto_restore', 15:03:19 INFO - 'tabpaint']}, 15:03:19 INFO - 'other-e10s': {'tests': ['a11yr', 15:03:19 INFO - 'ts_paint', 15:03:19 INFO - 'tpaint', 15:03:19 INFO - 'sessionrestore', 15:03:19 INFO - 'sessionrestore_no_auto_restore', 15:03:19 INFO - 'tabpaint']}, 15:03:19 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:03:19 INFO - 'ts_paint', 15:03:19 INFO - 'tpaint', 15:03:19 INFO - 'sessionrestore', 15:03:19 INFO - 'sessionrestore_no_auto_restore', 15:03:19 INFO - 'tabpaint']}, 15:03:19 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:03:19 INFO - 'ts_paint', 15:03:19 INFO - 'tpaint', 15:03:19 INFO - 'sessionrestore', 15:03:19 INFO - 'sessionrestore_no_auto_restore', 15:03:19 INFO - 'tabpaint']}, 15:03:19 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:03:19 INFO - 'tests': ['a11yr', 15:03:19 INFO - 'ts_paint', 15:03:19 INFO - 'tpaint', 15:03:19 INFO - 'sessionrestore', 15:03:19 INFO - 'sessionrestore_no_auto_restore', 15:03:19 INFO - 'tabpaint']}, 15:03:19 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:03:19 INFO - 'tests': ['a11yr', 15:03:19 INFO - 'ts_paint', 15:03:19 INFO - 'tpaint', 15:03:19 INFO - 'sessionrestore', 15:03:19 INFO - 'sessionrestore_no_auto_restore', 15:03:19 INFO - 'tabpaint']}, 15:03:19 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:03:19 INFO - 'tests': ['tsvgx', 15:03:19 INFO - 'tsvgr_opacity', 15:03:19 INFO - 'tart', 15:03:19 INFO - 'tscrollx', 15:03:19 INFO - 'cart', 15:03:19 INFO - 'tsvg_static']}, 15:03:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:03:19 INFO - 'tsvgr_opacity', 15:03:19 INFO - 'tart', 15:03:19 INFO - 'tscrollx', 15:03:19 INFO - 'cart', 15:03:19 INFO - 'tsvg_static']}, 15:03:19 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 15:03:19 INFO - 'talos_options': ['--disable-e10s'], 15:03:19 INFO - 'tests': ['tp5o']}, 15:03:19 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:03:19 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 15:03:19 INFO - 'talos_options': ['--disable-e10s', 15:03:19 INFO - '--xperf_path', 15:03:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:03:19 INFO - 'tests': ['tp5n']}, 15:03:19 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:03:19 INFO - 'talos_options': ['--xperf_path', 15:03:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:03:19 INFO - 'tests': ['tp5n']}}, 15:03:19 INFO - 'talos.zip': {'path': '', 15:03:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:03:19 INFO - Running post-action listener: _resource_record_post_action 15:03:19 INFO - [mozharness: 2016-12-17 23:03:19.207948Z] Finished populate-webroot step (success) 15:03:19 INFO - [mozharness: 2016-12-17 23:03:19.208037Z] Running create-virtualenv step. 15:03:19 INFO - Running pre-action listener: _resource_record_pre_action 15:03:19 INFO - Running main action method: create_virtualenv 15:03:19 INFO - Creating virtualenv /builds/slave/test/build/venv 15:03:19 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:03:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:03:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:03:19 INFO - Using real prefix '/usr' 15:03:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:03:19 INFO - Installing distribute.............................................................................................................................................................................................done. 15:03:21 INFO - Installing pip.................done. 15:03:21 INFO - Return code: 0 15:03:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:03:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:03:22 INFO - Reading from file tmpfile_stdout 15:03:22 INFO - Output received: 15:03:22 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 15:03:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:03:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:03:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:03:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:03:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:03:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29731f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a83a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ce5630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d6e850>, '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 0x2ce36d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ce3b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1482014998.892341-89311437', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:03:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:03:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:03:22 INFO - Using env: {'DISPLAY': ':0', 15:03:22 INFO - 'HOME': '/home/cltbld', 15:03:22 INFO - 'LANG': 'en_US.UTF-8', 15:03:22 INFO - 'LANGUAGE': 'en_US:en', 15:03:22 INFO - 'LOGNAME': 'cltbld', 15:03:22 INFO - 'MAIL': '/var/mail/cltbld', 15:03:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:03:22 INFO - 'MOZ_NO_REMOTE': '1', 15:03:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:03:22 INFO - 'NO_EM_RESTART': '1', 15:03:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:03:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:03:22 INFO - 'PWD': '/builds/slave/test', 15:03:22 INFO - 'SHELL': '/bin/bash', 15:03:22 INFO - 'SHLVL': '1', 15:03:22 INFO - 'TERM': 'linux', 15:03:22 INFO - 'TMOUT': '86400', 15:03:22 INFO - 'USER': 'cltbld', 15:03:22 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1482014998.892341-89311437', 15:03:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:03:22 INFO - '_': '/tools/buildbot/bin/python'} 15:03:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:03:22 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 15:03:22 INFO - Cleaning up... 15:03:22 INFO - Return code: 0 15:03:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:03:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:03:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:03:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:03:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:03:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x29731f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a83a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ce5630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d6e850>, '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 0x2ce36d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ce3b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1482014998.892341-89311437', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:03:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:03:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:03:22 INFO - Using env: {'DISPLAY': ':0', 15:03:22 INFO - 'HOME': '/home/cltbld', 15:03:22 INFO - 'LANG': 'en_US.UTF-8', 15:03:22 INFO - 'LANGUAGE': 'en_US:en', 15:03:22 INFO - 'LOGNAME': 'cltbld', 15:03:22 INFO - 'MAIL': '/var/mail/cltbld', 15:03:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:03:22 INFO - 'MOZ_NO_REMOTE': '1', 15:03:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:03:22 INFO - 'NO_EM_RESTART': '1', 15:03:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:03:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:03:22 INFO - 'PWD': '/builds/slave/test', 15:03:22 INFO - 'SHELL': '/bin/bash', 15:03:22 INFO - 'SHLVL': '1', 15:03:22 INFO - 'TERM': 'linux', 15:03:22 INFO - 'TMOUT': '86400', 15:03:22 INFO - 'USER': 'cltbld', 15:03:22 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1482014998.892341-89311437', 15:03:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:03:22 INFO - '_': '/tools/buildbot/bin/python'} 15:03:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:03:22 INFO - Downloading/unpacking psutil>=3.1.1 15:03:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:03:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:03:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:03:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:03:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:03:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:03:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:03:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:03:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:03:24 INFO - Installing collected packages: psutil 15:03:24 INFO - Running setup.py install for psutil 15:03:24 INFO - building 'psutil._psutil_linux' extension 15:03:24 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 15:03:24 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 15:03:24 INFO - building 'psutil._psutil_posix' extension 15:03:24 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 15:03:24 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 15:03:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:03:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:03:25 INFO - Successfully installed psutil 15:03:25 INFO - Cleaning up... 15:03:25 INFO - Return code: 0 15:03:25 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:03:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:03:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:03:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:03:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:03:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29731f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a83a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ce5630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d6e850>, '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 0x2ce36d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ce3b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1482014998.892341-89311437', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:03:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:03:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:03:25 INFO - Using env: {'DISPLAY': ':0', 15:03:25 INFO - 'HOME': '/home/cltbld', 15:03:25 INFO - 'LANG': 'en_US.UTF-8', 15:03:25 INFO - 'LANGUAGE': 'en_US:en', 15:03:25 INFO - 'LOGNAME': 'cltbld', 15:03:25 INFO - 'MAIL': '/var/mail/cltbld', 15:03:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:03:25 INFO - 'MOZ_NO_REMOTE': '1', 15:03:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:03:25 INFO - 'NO_EM_RESTART': '1', 15:03:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:03:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:03:25 INFO - 'PWD': '/builds/slave/test', 15:03:25 INFO - 'SHELL': '/bin/bash', 15:03:25 INFO - 'SHLVL': '1', 15:03:25 INFO - 'TERM': 'linux', 15:03:25 INFO - 'TMOUT': '86400', 15:03:25 INFO - 'USER': 'cltbld', 15:03:25 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1482014998.892341-89311437', 15:03:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:03:25 INFO - '_': '/tools/buildbot/bin/python'} 15:03:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:03:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:03:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:03:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:03:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:03:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:03:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:03:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:03:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:03:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:03:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:03:27 INFO - Installing collected packages: mozsystemmonitor 15:03:27 INFO - Running setup.py install for mozsystemmonitor 15:03:27 INFO - Successfully installed mozsystemmonitor 15:03:27 INFO - Cleaning up... 15:03:27 INFO - Return code: 0 15:03:27 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:03:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:03:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:03:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:03:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:03:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03:27 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 0x29731f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a83a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ce5630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d6e850>, '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 0x2ce36d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ce3b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1482014998.892341-89311437', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:03:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:03:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:03:27 INFO - Using env: {'DISPLAY': ':0', 15:03:27 INFO - 'HOME': '/home/cltbld', 15:03:27 INFO - 'LANG': 'en_US.UTF-8', 15:03:27 INFO - 'LANGUAGE': 'en_US:en', 15:03:27 INFO - 'LOGNAME': 'cltbld', 15:03:27 INFO - 'MAIL': '/var/mail/cltbld', 15:03:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:03:27 INFO - 'MOZ_NO_REMOTE': '1', 15:03:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:03:27 INFO - 'NO_EM_RESTART': '1', 15:03:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:03:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:03:27 INFO - 'PWD': '/builds/slave/test', 15:03:27 INFO - 'SHELL': '/bin/bash', 15:03:27 INFO - 'SHLVL': '1', 15:03:27 INFO - 'TERM': 'linux', 15:03:27 INFO - 'TMOUT': '86400', 15:03:27 INFO - 'USER': 'cltbld', 15:03:27 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1482014998.892341-89311437', 15:03:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:03:27 INFO - '_': '/tools/buildbot/bin/python'} 15:03:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:03:27 INFO - Downloading/unpacking jsonschema==2.5.1 15:03:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:03:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:03:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:03:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:03:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:03:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:03:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:03:29 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:03:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:03:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:03:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:03:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:03:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:03:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:03:29 INFO - Downloading functools32-3.2.3-2.tar.gz 15:03:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:03:29 INFO - warning: no files found matching '*.txt' 15:03:29 INFO - no previously-included directories found matching 'build' 15:03:29 INFO - no previously-included directories found matching 'dist' 15:03:29 INFO - no previously-included directories found matching '.git*' 15:03:29 INFO - Installing collected packages: jsonschema, functools32 15:03:30 INFO - Running setup.py install for functools32 15:03:30 INFO - warning: no files found matching '*.txt' 15:03:30 INFO - no previously-included directories found matching 'build' 15:03:30 INFO - no previously-included directories found matching 'dist' 15:03:30 INFO - no previously-included directories found matching '.git*' 15:03:30 INFO - Successfully installed jsonschema functools32 15:03:30 INFO - Cleaning up... 15:03:30 INFO - Return code: 0 15:03:30 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:03:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:03:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:03:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:03:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:03:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03:30 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 0x29731f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a83a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ce5630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d6e850>, '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 0x2ce36d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ce3b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1482014998.892341-89311437', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:03:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:03:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 15:03:30 INFO - Using env: {'DISPLAY': ':0', 15:03:30 INFO - 'HOME': '/home/cltbld', 15:03:30 INFO - 'LANG': 'en_US.UTF-8', 15:03:30 INFO - 'LANGUAGE': 'en_US:en', 15:03:30 INFO - 'LOGNAME': 'cltbld', 15:03:30 INFO - 'MAIL': '/var/mail/cltbld', 15:03:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:03:30 INFO - 'MOZ_NO_REMOTE': '1', 15:03:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:03:30 INFO - 'NO_EM_RESTART': '1', 15:03:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:03:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:03:30 INFO - 'PWD': '/builds/slave/test', 15:03:30 INFO - 'SHELL': '/bin/bash', 15:03:30 INFO - 'SHLVL': '1', 15:03:30 INFO - 'TERM': 'linux', 15:03:30 INFO - 'TMOUT': '86400', 15:03:30 INFO - 'USER': 'cltbld', 15:03:30 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1482014998.892341-89311437', 15:03:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:03:30 INFO - '_': '/tools/buildbot/bin/python'} 15:03:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:03:30 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:03:30 INFO - Cleaning up... 15:03:30 INFO - Return code: 0 15:03:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:03:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:03:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:03:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:03:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:03:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03:30 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 0x29731f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a83a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ce5630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d6e850>, '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 0x2ce36d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ce3b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1482014998.892341-89311437', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:03:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:03:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:03:30 INFO - Using env: {'DISPLAY': ':0', 15:03:30 INFO - 'HOME': '/home/cltbld', 15:03:30 INFO - 'LANG': 'en_US.UTF-8', 15:03:30 INFO - 'LANGUAGE': 'en_US:en', 15:03:30 INFO - 'LOGNAME': 'cltbld', 15:03:30 INFO - 'MAIL': '/var/mail/cltbld', 15:03:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:03:30 INFO - 'MOZ_NO_REMOTE': '1', 15:03:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:03:30 INFO - 'NO_EM_RESTART': '1', 15:03:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:03:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:03:30 INFO - 'PWD': '/builds/slave/test', 15:03:30 INFO - 'SHELL': '/bin/bash', 15:03:30 INFO - 'SHLVL': '1', 15:03:30 INFO - 'TERM': 'linux', 15:03:30 INFO - 'TMOUT': '86400', 15:03:30 INFO - 'USER': 'cltbld', 15:03:30 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1482014998.892341-89311437', 15:03:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:03:30 INFO - '_': '/tools/buildbot/bin/python'} 15:03:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:03:30 INFO - Downloading/unpacking blobuploader==1.2.4 15:03:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:03:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:03:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:03:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:03:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:03:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:03:32 INFO - Downloading blobuploader-1.2.4.tar.gz 15:03:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:03:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:03:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:03:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:03:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:03:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:03:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:03:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:03:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:03:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:03:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:03:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:03:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:03:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:03:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:03:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:03:33 INFO - Downloading docopt-0.6.1.tar.gz 15:03:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:03:33 INFO - Installing collected packages: blobuploader, requests, docopt 15:03:33 INFO - Running setup.py install for blobuploader 15:03:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:03:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:03:33 INFO - Running setup.py install for requests 15:03:33 INFO - Running setup.py install for docopt 15:03:33 INFO - Successfully installed blobuploader requests docopt 15:03:33 INFO - Cleaning up... 15:03:33 INFO - Return code: 0 15:03:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:03: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')]} 15:03:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:03:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03: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')]} 15:03:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:03:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03:33 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 0x29731f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a83a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ce5630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d6e850>, '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 0x2ce36d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ce3b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1482014998.892341-89311437', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:03:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:03:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:03:33 INFO - Using env: {'DISPLAY': ':0', 15:03:33 INFO - 'HOME': '/home/cltbld', 15:03:33 INFO - 'LANG': 'en_US.UTF-8', 15:03:33 INFO - 'LANGUAGE': 'en_US:en', 15:03:33 INFO - 'LOGNAME': 'cltbld', 15:03:33 INFO - 'MAIL': '/var/mail/cltbld', 15:03:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:03:33 INFO - 'MOZ_NO_REMOTE': '1', 15:03:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:03:33 INFO - 'NO_EM_RESTART': '1', 15:03:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:03:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:03:33 INFO - 'PWD': '/builds/slave/test', 15:03:33 INFO - 'SHELL': '/bin/bash', 15:03:33 INFO - 'SHLVL': '1', 15:03:33 INFO - 'TERM': 'linux', 15:03:33 INFO - 'TMOUT': '86400', 15:03:33 INFO - 'USER': 'cltbld', 15:03:33 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1482014998.892341-89311437', 15:03:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:03:33 INFO - '_': '/tools/buildbot/bin/python'} 15:03:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:03:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:03:34 INFO - Running setup.py (path:/tmp/pip-L_cb6J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:03:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:03:34 INFO - Running setup.py (path:/tmp/pip-8OO9jI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:03:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:03:34 INFO - Running setup.py (path:/tmp/pip-UpXCLD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:03:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:03:34 INFO - Running setup.py (path:/tmp/pip-_e0dcF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:03:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:03:34 INFO - Running setup.py (path:/tmp/pip-Km64Zh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:03:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:03:34 INFO - Running setup.py (path:/tmp/pip-Gkm8j6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:03:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:03:34 INFO - Running setup.py (path:/tmp/pip-9hEbUc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:03:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:03:34 INFO - Running setup.py (path:/tmp/pip-Wv39i7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:03:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:03:34 INFO - Running setup.py (path:/tmp/pip-OrF4rr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:03:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:03:34 INFO - Running setup.py (path:/tmp/pip-60YfRz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:03:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:03:34 INFO - Running setup.py (path:/tmp/pip-q3O94c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:03:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:03:34 INFO - Running setup.py (path:/tmp/pip-yYciST-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:03:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:03:35 INFO - Running setup.py (path:/tmp/pip-8deTQw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:03:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:03:35 INFO - Running setup.py (path:/tmp/pip-WDcvUU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:03:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:03:35 INFO - Running setup.py (path:/tmp/pip-vDGGSK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:03:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:03:35 INFO - Running setup.py (path:/tmp/pip-6ghLDH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:03:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:03:35 INFO - Running setup.py (path:/tmp/pip-hPtuId-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:03:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:03:35 INFO - Running setup.py install for manifestparser 15:03:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:03:35 INFO - Running setup.py install for mozcrash 15:03:35 INFO - Running setup.py install for mozdebug 15:03:35 INFO - Running setup.py install for mozdevice 15:03:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:03:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:03:35 INFO - Running setup.py install for mozfile 15:03:35 INFO - Running setup.py install for mozhttpd 15:03:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:03:36 INFO - Running setup.py install for mozinfo 15:03:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:03:36 INFO - Running setup.py install for mozInstall 15:03:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:03:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:03:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:03:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:03:36 INFO - Running setup.py install for mozleak 15:03:36 INFO - Running setup.py install for mozlog 15:03:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:03:36 INFO - Running setup.py install for moznetwork 15:03:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:03:36 INFO - Running setup.py install for mozprocess 15:03:36 INFO - Running setup.py install for mozprofile 15:03:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:03:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:03:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:03:36 INFO - Running setup.py install for mozrunner 15:03:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:03:36 INFO - Running setup.py install for mozscreenshot 15:03:36 INFO - Running setup.py install for moztest 15:03:37 INFO - Running setup.py install for mozversion 15:03:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:03:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:03:37 INFO - Cleaning up... 15:03:37 INFO - Return code: 0 15:03:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:03:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:03:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:03:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:03:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:03:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03:37 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 0x29731f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a83a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ce5630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d6e850>, '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 0x2ce36d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ce3b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1482014998.892341-89311437', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:03:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:03:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:03:37 INFO - Using env: {'DISPLAY': ':0', 15:03:37 INFO - 'HOME': '/home/cltbld', 15:03:37 INFO - 'LANG': 'en_US.UTF-8', 15:03:37 INFO - 'LANGUAGE': 'en_US:en', 15:03:37 INFO - 'LOGNAME': 'cltbld', 15:03:37 INFO - 'MAIL': '/var/mail/cltbld', 15:03:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:03:37 INFO - 'MOZ_NO_REMOTE': '1', 15:03:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:03:37 INFO - 'NO_EM_RESTART': '1', 15:03:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:03:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:03:37 INFO - 'PWD': '/builds/slave/test', 15:03:37 INFO - 'SHELL': '/bin/bash', 15:03:37 INFO - 'SHLVL': '1', 15:03:37 INFO - 'TERM': 'linux', 15:03:37 INFO - 'TMOUT': '86400', 15:03:37 INFO - 'USER': 'cltbld', 15:03:37 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1482014998.892341-89311437', 15:03:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:03:37 INFO - '_': '/tools/buildbot/bin/python'} 15:03:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:03:37 INFO - Running setup.py (path:/tmp/pip-achLgV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:03:37 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 15:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:03:37 INFO - Running setup.py (path:/tmp/pip-cHPxGg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:03:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:03:37 INFO - Running setup.py (path:/tmp/pip-hJYSrl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:03:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:03:37 INFO - Running setup.py (path:/tmp/pip-D0cNnP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:03:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:03:37 INFO - Running setup.py (path:/tmp/pip-1uOrRq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:03:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 15:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:03:37 INFO - Running setup.py (path:/tmp/pip-jtHRqG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:03:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 15:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:03:37 INFO - Running setup.py (path:/tmp/pip-e_SuW5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:03:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 15:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:03:37 INFO - Running setup.py (path:/tmp/pip-HavW5G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:03:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:03:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:03:38 INFO - Running setup.py (path:/tmp/pip-Pgw0q_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:03:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 15:03:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:03:38 INFO - Running setup.py (path:/tmp/pip-eKHKvY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:03:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:03:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:03:38 INFO - Running setup.py (path:/tmp/pip-yvHnP6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:03:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 15:03:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:03:38 INFO - Running setup.py (path:/tmp/pip-5Trvfl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:03:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 15:03:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:03:38 INFO - Running setup.py (path:/tmp/pip-gmMHQU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:03:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 15:03:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:03:38 INFO - Running setup.py (path:/tmp/pip-LwqxI5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:03:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:03:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:03:38 INFO - Running setup.py (path:/tmp/pip-Rz2FEE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:03:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 15:03:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:03:38 INFO - Running setup.py (path:/tmp/pip-r5Mykv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:03:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 15:03:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:03:38 INFO - Running setup.py (path:/tmp/pip-gPeYW9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:03:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 15:03:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:03:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:03:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:03:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:03:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:03:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:03: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 15:03: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 15:03: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 15:03: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 15:03: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 15:03: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 15:03:40 INFO - Downloading blessings-1.6.tar.gz 15:03:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:03:40 INFO - Installing collected packages: blessings 15:03:40 INFO - Running setup.py install for blessings 15:03:40 INFO - Successfully installed blessings 15:03:40 INFO - Cleaning up... 15:03:40 INFO - Return code: 0 15:03:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:03:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:03:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:03:41 INFO - Reading from file tmpfile_stdout 15:03:41 INFO - Current package versions: 15:03:41 INFO - argparse == 1.2.1 15:03:41 INFO - blessings == 1.6 15:03:41 INFO - blobuploader == 1.2.4 15:03:41 INFO - docopt == 0.6.1 15:03:41 INFO - functools32 == 3.2.3-2 15:03:41 INFO - jsonschema == 2.5.1 15:03:41 INFO - manifestparser == 1.1 15:03:41 INFO - mozInstall == 1.12 15:03:41 INFO - mozcrash == 1.0 15:03:41 INFO - mozdebug == 0.1 15:03:41 INFO - mozdevice == 0.49 15:03:41 INFO - mozfile == 1.2 15:03:41 INFO - mozhttpd == 0.7 15:03:41 INFO - mozinfo == 0.9 15:03:41 INFO - mozleak == 0.1 15:03:41 INFO - mozlog == 3.4 15:03:41 INFO - moznetwork == 0.27 15:03:41 INFO - mozprocess == 0.23 15:03:41 INFO - mozprofile == 0.28 15:03:41 INFO - mozrunner == 6.13 15:03:41 INFO - mozscreenshot == 0.1 15:03:41 INFO - mozsystemmonitor == 0.3 15:03:41 INFO - moztest == 0.7 15:03:41 INFO - mozversion == 1.4 15:03:41 INFO - psutil == 3.1.1 15:03:41 INFO - requests == 1.2.3 15:03:41 INFO - wsgiref == 0.1.2 15:03:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:03: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')]} 15:03:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:03:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03: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')]} 15:03:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:03:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03:41 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 0x29731f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a83a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ce5630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d6e850>, '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 0x2ce36d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ce3b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1482014998.892341-89311437', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:03:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 15:03:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:03:41 INFO - Using env: {'DISPLAY': ':0', 15:03:41 INFO - 'HOME': '/home/cltbld', 15:03:41 INFO - 'LANG': 'en_US.UTF-8', 15:03:41 INFO - 'LANGUAGE': 'en_US:en', 15:03:41 INFO - 'LOGNAME': 'cltbld', 15:03:41 INFO - 'MAIL': '/var/mail/cltbld', 15:03:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:03:41 INFO - 'MOZ_NO_REMOTE': '1', 15:03:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:03:41 INFO - 'NO_EM_RESTART': '1', 15:03:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:03:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:03:41 INFO - 'PWD': '/builds/slave/test', 15:03:41 INFO - 'SHELL': '/bin/bash', 15:03:41 INFO - 'SHLVL': '1', 15:03:41 INFO - 'TERM': 'linux', 15:03:41 INFO - 'TMOUT': '86400', 15:03:41 INFO - 'USER': 'cltbld', 15:03:41 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1482014998.892341-89311437', 15:03:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:03:41 INFO - '_': '/tools/buildbot/bin/python'} 15:03:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:03:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:03:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 15:03:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 15:03:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:03:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 15:03:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 15:03:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 15:03:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 15:03:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 15:03:41 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:03:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:03:41 INFO - Cleaning up... 15:03:41 INFO - Return code: 0 15:03:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:03: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')]} 15:03:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:03:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03: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')]} 15:03:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:03:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29731f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a83a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ce5630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d6e850>, '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 0x2ce36d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ce3b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1482014998.892341-89311437', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:03: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', 'jsonschema'] in /builds/slave/test/build 15:03: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 jsonschema 15:03:41 INFO - Using env: {'DISPLAY': ':0', 15:03:41 INFO - 'HOME': '/home/cltbld', 15:03:41 INFO - 'LANG': 'en_US.UTF-8', 15:03:41 INFO - 'LANGUAGE': 'en_US:en', 15:03:41 INFO - 'LOGNAME': 'cltbld', 15:03:41 INFO - 'MAIL': '/var/mail/cltbld', 15:03:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:03:41 INFO - 'MOZ_NO_REMOTE': '1', 15:03:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:03:41 INFO - 'NO_EM_RESTART': '1', 15:03:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:03:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:03:41 INFO - 'PWD': '/builds/slave/test', 15:03:41 INFO - 'SHELL': '/bin/bash', 15:03:41 INFO - 'SHLVL': '1', 15:03:41 INFO - 'TERM': 'linux', 15:03:41 INFO - 'TMOUT': '86400', 15:03:41 INFO - 'USER': 'cltbld', 15:03:41 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1482014998.892341-89311437', 15:03:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:03:41 INFO - '_': '/tools/buildbot/bin/python'} 15:03:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:03:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:03:41 INFO - Cleaning up... 15:03:41 INFO - Return code: 0 15:03:41 INFO - Running post-action listener: _resource_record_post_action 15:03:41 INFO - Running post-action listener: _start_resource_monitoring 15:03:41 INFO - Starting resource monitoring. 15:03:41 INFO - [mozharness: 2016-12-17 23:03:41.628209Z] Finished create-virtualenv step (success) 15:03:41 INFO - [mozharness: 2016-12-17 23:03:41.628737Z] Running install step. 15:03:41 INFO - Running pre-action listener: _resource_record_pre_action 15:03:41 INFO - Running main action method: install 15:03:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:03:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:03:41 INFO - Reading from file tmpfile_stdout 15:03:41 INFO - Detecting whether we're running mozinstall >=1.0... 15:03:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:03:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:03:41 INFO - Reading from file tmpfile_stdout 15:03:41 INFO - Output received: 15:03:41 INFO - Usage: mozinstall [options] installer 15:03:41 INFO - Options: 15:03:41 INFO - -h, --help show this help message and exit 15:03:41 INFO - -d DEST, --destination=DEST 15:03:41 INFO - Directory to install application into. [default: 15:03:41 INFO - "/builds/slave/test"] 15:03:41 INFO - --app=APP Application being installed. [default: firefox] 15:03:41 INFO - mkdir: /builds/slave/test/build/application 15:03:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:03:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 15:03:57 INFO - Reading from file tmpfile_stdout 15:03:57 INFO - Output received: 15:03:57 INFO - /builds/slave/test/build/application/firefox/firefox 15:03:57 INFO - Running post-action listener: _resource_record_post_action 15:03:57 INFO - [mozharness: 2016-12-17 23:03:57.957252Z] Finished install step (success) 15:03:57 INFO - [mozharness: 2016-12-17 23:03:57.957500Z] Running run-tests step. 15:03:57 INFO - Running pre-action listener: _resource_record_pre_action 15:03:57 INFO - Running main action method: run_tests 15:03:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:03:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:03:57 INFO - Python 2.7.3 15:03:57 INFO - Return code: 0 15:03:57 INFO - grabbing minidump binary from tooltool 15:03: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')]} 15:03:57 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 0x2d6e850>, '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 0x2ce36d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ce3b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:03:57 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 15:03:57 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 15:03:57 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 15:03:58 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:03:58 INFO - Return code: 0 15:03:58 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:03:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:03:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:03:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:03:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:03:58 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/Ev_uCDHEQCaeUNLnCbJmGw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 15:03:58 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/Ev_uCDHEQCaeUNLnCbJmGw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-031 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 15:03:58 INFO - Using env: {'DISPLAY': ':0', 15:03:58 INFO - 'HOME': '/home/cltbld', 15:03:58 INFO - 'LANG': 'en_US.UTF-8', 15:03:58 INFO - 'LANGUAGE': 'en_US:en', 15:03:58 INFO - 'LOGNAME': 'cltbld', 15:03:58 INFO - 'MAIL': '/var/mail/cltbld', 15:03:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:03:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:03:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:03:58 INFO - 'MOZ_NO_REMOTE': '1', 15:03:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:03:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:03:58 INFO - 'NO_EM_RESTART': '1', 15:03:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:03:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:03:58 INFO - 'PWD': '/builds/slave/test', 15:03:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:03:58 INFO - 'SHELL': '/bin/bash', 15:03:58 INFO - 'SHLVL': '1', 15:03:58 INFO - 'TERM': 'linux', 15:03:58 INFO - 'TMOUT': '86400', 15:03:58 INFO - 'USER': 'cltbld', 15:03:58 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1482014998.892341-89311437', 15:03:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:03:58 INFO - '_': '/tools/buildbot/bin/python'} 15:03:58 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/Ev_uCDHEQCaeUNLnCbJmGw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 15:03:58 INFO - mozversion application_buildid: 20161217140149 15:03:58 INFO - mozversion application_changeset: 5745bab28ff5e85128c774b56b4cc27c2afe2e1b 15:03:58 INFO - mozversion application_display_name: Nightly 15:03:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:03:58 INFO - mozversion application_name: Firefox 15:03:58 INFO - mozversion application_remotingname: firefox 15:03:58 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:03:58 INFO - mozversion application_vendor: Mozilla 15:03:58 INFO - mozversion application_version: 53.0a1 15:03:58 INFO - mozversion platform_buildid: 20161217140149 15:03:58 INFO - mozversion platform_changeset: 5745bab28ff5e85128c774b56b4cc27c2afe2e1b 15:03:58 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:03:58 INFO - mozversion platform_version: 53.0a1 15:03:58 INFO - using testdate: 1482015838 15:03:58 INFO - actual date: 1482015838 15:03:58 INFO - starting webserver on 'localhost:51882' 15:03:58 INFO - SUITE-START | Running 2 tests 15:03:58 INFO - TEST-START | dromaeo_css 15:03:58 INFO - operating with platform_type : linux_ 15:03:58 INFO - Initialising browser for dromaeo_css test... 15:03:58 INFO - TEST-INFO | started process 14917 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLUX03I/profile http://localhost:51882/getInfo.html) 15:04:02 INFO - PROCESS | 14917 | __metrics Screen width/height:1600/1200 15:04:02 INFO - PROCESS | 14917 | colorDepth:24 15:04:02 INFO - PROCESS | 14917 | Browser inner width/height: 1024/697 15:04:02 INFO - PROCESS | 14917 | __metrics 15:04:02 INFO - PROCESS | 14917 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:04:02 INFO - PROCESS | 14917 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:04:03 INFO - PROCESS | 14917 | console.error: PushService: 15:04:03 INFO - PROCESS | 14917 | stateChangeProcessEnqueue: Error transitioning state 15:04:03 INFO - PROCESS | 14917 | UnknownError 15:04:04 INFO - TEST-INFO | 14917: exit 0 15:04:04 INFO - Browser initialized. 15:04:04 INFO - Running cycle 1/1 for dromaeo_css test... 15:04:04 INFO - TEST-INFO | started process 14999 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLUX03I/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:04:16 INFO - PROCESS | 14999 | RSS: Main: 156053504 15:04:16 INFO - PROCESS | 14999 | 15:05:07 INFO - PROCESS | 14999 | 1482015907108 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 15:07:21 INFO - PROCESS | 14999 | Cycle 1(1): loaded http://localhost:51882/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51882/tests/dromaeo/cssquery-ext.html) 15:07:22 INFO - PROCESS | 14999 | RSS: Main: 284798976 15:07:22 INFO - PROCESS | 14999 | 15:10:25 INFO - PROCESS | 14999 | Cycle 1(1): loaded http://localhost:51882/tests/dromaeo/cssquery-ext.html (next: http://localhost:51882/tests/dromaeo/cssquery-jquery.html) 15:10:26 INFO - PROCESS | 14999 | RSS: Main: 244961280 15:10:26 INFO - PROCESS | 14999 | 15:13:28 INFO - PROCESS | 14999 | Cycle 1(1): loaded http://localhost:51882/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51882/tests/dromaeo/cssquery-mootools.html) 15:13:29 INFO - PROCESS | 14999 | RSS: Main: 188915712 15:13:29 INFO - PROCESS | 14999 | 15:16:31 INFO - PROCESS | 14999 | Cycle 1(1): loaded http://localhost:51882/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51882/tests/dromaeo/cssquery-prototype.html) 15:16:32 INFO - PROCESS | 14999 | RSS: Main: 190992384 15:16:32 INFO - PROCESS | 14999 | 15:19:35 INFO - PROCESS | 14999 | Cycle 1(1): loaded http://localhost:51882/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51882/tests/dromaeo/cssquery-yui.html) 15:19:35 INFO - PROCESS | 14999 | RSS: Main: 189988864 15:19:35 INFO - PROCESS | 14999 | 15:22:39 INFO - PROCESS | 14999 | Cycle 1(1): loaded http://localhost:51882/tests/dromaeo/cssquery-yui.html (next: http://localhost:51882/tests/dromaeo/cssquery-dojo.html) 15:22:39 INFO - PROCESS | 14999 | RSS: Main: 283160576 15:22:39 INFO - PROCESS | 14999 | 15:22:39 INFO - PROCESS | 14999 | __start_tp_report 15:22:39 INFO - PROCESS | 14999 | _x_x_mozilla_page_load 15:22:39 INFO - PROCESS | 14999 | _x_x_mozilla_page_load_details 15:22:39 INFO - PROCESS | 14999 | |i|pagename|runs| 15:22:39 INFO - PROCESS | 14999 | |0;dojo.html;2575.7681808637217;2642.9471410571778;2668.8265262757927;2678.7990900682453;2683.51696694595;4628.4677262114865;4651.255799072149;4702.741349225791;4758.310045043467;4814.662973591846;4707;4719.90560188796;4757.191277482828;4786.282057691348;4820.6143508519235;4298.376735373369;4318.67609929255;4361.062371590107;4379.430674012374;4442.8667139985855;3988.0935179030716;4304.870853874389;4338.522762496123;4377.824887004532;4417.072414792898;4275.593818587229;4323.481182258118;4417.028253784162;4441.911161776747;4483.125790470859;4342.392065110887;4361.542038086019;4365.432493775789;4365.7817109144735;4367.388565600819;4333.458317710286;4333.523312435629;4339.891502712426;4340.761258130801;4343.305071188626;4670.206064968964;4711.952880471185;4722.787474563653;4724.173269677827;4789.473157952622;5062.974685126587;5075.6447048706605;5078.5175408336145;5079.771410286546;5126.307948426952;4959.132151873444;5100.15847385181;5108.233764935289;5110.514501122388;5112.233165025239;4624.028953919681;4699.295105734167;4710.599599034052;4713.363695901009;4787.736674482937;5156.20078887773;5215.217717342429;5220.1908704150155;5226.320578324793;5253.579713622901;4959.727215003138;4999.975000125049;5011.123053465629;5011.298418221452;5050.722210278396;4934.925976110361;4954.603631709455;4977.701337919664;4980.028894365564;5081.898362032813;4926.679765815211;4972.975135124301;5007.173816320339;5015;5024.84925452237;4954.157793175169;4957.182064959314;4958.479359667255;4966.975165124151;5006.224035274538;4171;4205.1589682063095;4212.68404869636;4218.831246750157;4250.043740158501;3691.8154092295276;3720.497732806091;3737.028372623138;3739.569949455793;3809.3524100902914;4378.627816635558;4379.080393117417;4379.233634114017;4380;4423.292273236267;5123.718195499208;5129.820456284012;5139.8458046258675;5149.124648809711;5184.662996905189;4225.049363893161;4249.3413520904305;4251.256984636284;4255.659547236213;4300.80646370914;4552.658550608718;4557.635389168859;4559.293309537027;4561.384213131185;4609.285560738091;4702.100471208334;4708.034852855225;4710.340552322746;4711.905761884812;4757.785899634525;4926.8768280793265;4935.136351138464;5072.797088116434;5074.06129865976;5120.539151476236;4669.369635099218;4677.579017888406;4682.812687492598;4730.1958667026;4789.425268967607;5013.423456302572;5017.774200161075;5018.974905125451;5019.297298378303;5072.036313100499;5092.261622064854;5095.15929871567;5095.235714642833;5102.056119617882;5102.08162530748;4790.233562629963;4831.830885918976;4842.201036828884;4931.038447502702;4936.111499929903;4869.537393947569;4896.755162241945;4915.631327650369;4924.433690125538;4984.825531106394;4853.344798452164;4865.270209468608;4871.634627402888;4916.975415122902;4919.335889654851;4973.875653108701;4983.127952608352;4983.626228032985;4985.476524964826;4986.002799440199;4663.930041049455;4746.43042834862;4757.45289291722;4854.83008094715;4895.33912921751 15:22:39 INFO - PROCESS | 14999 | |1;ext.html;511.3480312601433;534.3801190618883;546.428981714109;552.1303946284603;559.4992481728852;27298.5905211422;35612.643873561254;36273;36287.63712362875;36368.09079773;38150.4277435838;38428;38490.422643660364;38545.421818672745;38617.61382386175;7327.157376901671;7377.040984671999;7538.472306938489;7539.283768042027;7543.849123017564;7397.298621317101;9511.429314241133;9755.365901216433;9763.316567840255;10015.198784097254;9732.75668108296;9811.705648830512;9815.116639502443;9816.803663926752;9830.164436022947;9693.22454203662;9695;9705.272104592148;9748.658796942143;9763.463009534473;9471.14759671626;9545.856812147824;9568.378055426376;9613.711588652352;9618.903810961941;35184.12039699028;35360;35366.92661467717;35447.64552354495;35485.46771798425;2921.780866435026;2922.4885645012037;2954.689757575445;2959.748421384185;3319.369319829249;26816.195514134608;27046.245698247625;27376.726232737816;28262.717372826213;28287.717122828715;3231.0791424444155;3367.326534693071;3437.759356845022;3453.9309213815836;3454.758166928316;242008;242014.78992605102;244212;244365;245251;45158.54841451543;45633.31550026752;45646.31530527045;45675.771621141685;45696.3145552817;47831.76084119557;47940;47997.280040799415;48002.27996580054;48011.519884801404;13446.596602101952;13735.107218030797;13739.450421983209;13754.037217394887;13800.447982080805;9848.704538863845;10059.849102263472;10559.102476289601;10787;10876.075533579735;14499;15222.77165842491;15362.769558456632;15367.6959453718;15375.461858834888;5871.588988770745;6056.303525094582;6061.818145455643;6138.263408391022;6149.2620885494025;729.5950747335173;798.5049269452976;879.0462348351982;960.6685693435893;993.036754348281;24398.26805195847;25856;25896.74103258981;25907.611385829226;26084.73915260861;874.4185116897319;896.1441823058963;930.8829404714235;987.4667679453158;1018.2363227579316;13123.934380328228;13651.59045228625;14120.646983825281;14127.858721412655;14200.573982780534;362955;366852;367220;368065;368775;47854.28218576724;48340.27489587659;48412.27381589279;48445;48486;1032.2258306270298;1087.0325410384764;1104.3815463340554;1106.6569363497342;1160.4139909345727;24160.024692710147;24808.503829923662;26200;26317.736822632294;26361.868190658923;40572.1885562293;41100.588994109676;41115.794421027706;41153.588464114975;41158;277313;278968;279058;279780;279843;22339.329820105424;23034.654480182475;23046;24209.515809683355;24419.511609768062;35041.824790875886;35123.29753404867;35296.63782238069;36034.45948310725;36471.08822279358;29530.55704164482;30264.243393915327;30264.394712106074;30479.238019048815;30712.84643576768;29799.553006704482;30102.24744381408;31321.8433907829;31397;31726.36547269088;27529.587056194574;27951.161465156078;28128.85935570309;28202.85898570494;28347.716522834507;26313.21060368192;27747.861260693568;27837.721622784324;27911.302217444725;27974.72025279721;21847.344579662637;22339.441513961632;22357.21749738751;22412.439689007904;22434.77565224327 15:22:39 INFO - PROCESS | 14999 | |2;jquery.html;341.23563218390814;353.4009853298658;361.92037751694625;366.4082506751596;379.04102620370475;12415.31715755633;15201.84798152018;15280.617984550378;16670.166491675398;16837.663246735057;16354.918225408856;16375.4268600599;16474.341026358932;16537;16606.66786664266;4082.734622249559;4827.396575428081;4976.4277108132665;4995.775190116454;5030.899382012358;4901.68139070961;4918.803247870081;4930.926036109461;4933.580645645125;4937.407511098673;4706.270528068155;4882.731449770261;4899.216125419934;4899.363082799249;4951.900961980758;4932.432770231433;4941.061198372316;4989.750512474362;4996.975015124937;4997.225430058346;4266.2320782259185;4404.4494438195225;4479.476977827521;4494.056248187884;4494.303382975644;19007.61984760311;19233.615327693507;19409.4177174685;19442.902785486123;19456.513587160294;1758.4548789875053;1912.3306842605116;1988.3935399703084;2342.7657234276608;2456.2631210636737;12143.149979501439;12431.440585173688;12504.562340318045;12574.308413037279;13172.209667419986;1695.2117265471616;1755.183839514632;1756.2974810075943;1782.3049010885766;1782.3316256403848;59527;61292.693536532475;62233.688831555555;68506.31493685099;70012.6499367505;9550.946546492538;9567.37812042215;9912.55393507294;9940.117365963933;10135;13302;13326.267055311857;13333.399996999964;13334.866651333556;13345.532906348231;6812;6830.21452532965;6984.476164287698;7030.964845175844;7187.856242875113;6515.902261466082;6545.738170473128;6706.329367063255;6715.966420167868;6731.259561448237;4165;4196.832126714959;4229.238737027365;4294;4405.801738921757;1618.6843565504848;1737.7740893683992;1789.6868048091533;1798.8111248319;1802.477281588351;646.886363298129;802.9076656184496;838.9077201507829;840.6469282901074;876.4872549558452;15198.924005379902;15344.769828452581;15410.845891541165;16229.756553651705;16242.350305987864;393;398.67440759474863;402.2618495061536;404.3691840728473;407.28318160038543;5330;5549;5686.232358631614;5731;5741.5119714824705;160774;160879;160975;161095;161122;52572.474275256754;60513;72239;72345;73160;415.89186811429244;422.210466427782;424.1495800919137;424.8767857321404;425.41505430033703;8862.468251904906;8903.154200350957;9009.729708108767;9334.25325973907;9641.132298093205;36586.8170659145;36601.45097823588;37597.81201094086;39064.2187156261;39739.40390894081;47788.592768120994;49931;50243.74878125586;50913.23630145625;51355.74322128366;6655.800325990228;7420.295071968154;10589.311694739818;10694;11252.887471125185;12089.697757556132;12097.334646594521;12207.938960305142;12260.632181034583;12719.618411447671;10144.340617859816;10180.694579162637;10289.536970836181;10849.783004340026;10937.835932460861;10218.437985910847;10656.733581660521;10683.465826708789;10737.570497180337;10767.838482422614;10646.946765266433;10813.513391897226;10814.56741730322;10882.279430142464;10947.56209751601;10779.299345542515;10966.451677416257;10992;11105.444727763741;11200.327980321206;10089.445080520349;10302.124319432933;10335.22485813552;10568.788624227625;10812.891486160122 15:22:39 INFO - PROCESS | 14999 | |3;mootools.html;1292.9547465838696;1306.2358520265643;1380.8964327675426;1616.9418365179931;1624.1716724470523;6005.849853753658;6179.660118693481;6814.216365118013;7225.494215404924;7231.999999999994;6753.898691519631;6983.092198014251;6985.511014229006;7161.928380716205;7165.426765858731;2082.1359135958596;2117.788221177885;2118.248021952208;2120.607687577803;2121.278765219825;1827.232562323827;1899.3827006222964;2077.5221699009235;2110.02938648222;2141.357592722185;1993.8205561499462;2082.562661841015;2091.979080209201;2096.695979083032;2106.73665791776;2074.2117995161893;2114.0381126587445;2117.195465723031;2135.1032566322183;2168.902399392031;2158.4388059104745;2163.53484000939;2182.334388011656;2183.094015983365;2183.912643494258;7161.89257161143;7219.7473088442175;7262.891056634155;7272.745453909088;7278.199398066208;4254.851080212208;4384.276594361926;4387.956120438818;4388;4390.758508282043;2703.2701170684004;2777.361206922419;2835.3620435402077;2835.53213719736;2846.018123747304;879.3800370738614;885.2740752582885;908.5593487158723;913.4930113786845;922.5156792683828;9199.632014719404;9410.764730881714;9427.245820334425;9428.858567121499;9429;3845.73079884411;3877.2439374321734;3904.902377440587;3910.2570511602703;3963.742356746802;8108.2297181767635;8120.878186827203;8162.959185204036;8170.223828736261;8170.42807003504;4378.8029538670835;4380.627646650007;4485.282354823213;4486.035502367007;4501.662375321798;3959.4852669152824;4055;4076.103257283393;4078.632923036941;4086.6322031016757;3258.918527036843;3263.200515873626;3337.199072222698;3337.5828021497314;3446.879359222465;1012.1143999000874;1044.1385856668128;1053.9789204215872;1091.44881834673;1096.3969816600838;668.7926742709775;692.6571347183177;711.4628455516053;724.9782506524813;767.7274567528559;4481.170983368087;4664.906701865943;4674.906501870011;4789.6530699956775;4917.065757506062;786.7207141464697;850.5959669157224;854.6752234151107;855.8373908957278;856.7772379181457;3202;3207.7914935529116;3207.8716851325685;3214.3089235814414;3337.7997320160866;7920.841583168304;8162.877556836652;8272.669093236203;8272.793180170544;8318.292945099613;8219.712310069119;8223.095459499451;8223.21879421454;8227.958860205781;8275.917240827635;6490.318516555788;6546.607203567801;6556.639384833785;6559.114519539897;6561.40947314744;4614.054118905549;4631.397918270603;4639.675222734376;4684.765761711833;4686.742229177428;7491.288327608869;7554.697812087455;7564.8487030260185;7634.274743899321;7635.732749353746;7611.314981651678;7670.309672129535;7764.378849692124;7838.372930165687;7856.646450909609;5940.673262970578;5992.1910542078;6013.368596297326;6019.638821670714;6093.268807743099;6509.446697030806;6613.66931653425;6615.6030638161865;6630.9336906630315;6631.701573429304;5991.071383935497;6076.483498902643;6081.239845019372;6082.847928801815;6155.84610384744;5863.912041319469;5899.616524925866;5913.674747888907;5942.6731529766275;6021.307549631849;5629.183768353648;5638.041532939492;5651.915221271766;5673.858153546029;5675.914861277167;4056.20903923732;4081.7142800003717;4187.874363769091;4207.684423668176;4277.893052673708;4054.1688953764997;4060.127072679388;4119.114390406077;4165.854195103157;4202.033532287652 15:22:39 INFO - PROCESS | 14999 | |4;prototype.html;347.82608695652175;351.5342171622599;352.52233223981494;353.5774749174737;363.90174652843734;4800.591949684281;4808.302796094564;4813.521036666115;4830.492798256181;4831.661783675144;4748.453927798304;4759.833405830788;4761.381020467343;4772.642051846116;4784.091022705684;3401;3630.52803135592;3735.010222291095;3856.3636999895125;3879.1078052047974;3829.5787463379006;3834.482344883433;3837.827297771593;3850.5571859236125;3855.8264878080554;3803.4865293185344;3824.1969186470874;3824.6749026332795;3825.7321987460887;3835.42468629705;3641.8725344612812;3651.5070465487083;3743.7458451418806;3827.5981021992848;3839.8656047038357;3385.8307084645917;3392.9660703393142;3402.1664692150334;3418.2821607462215;3444.0356700124007;4586.633069354443;4594.632429405639;4618.0763847230355;4627.120847039052;4662.393888794469;4349.760763158025;4377.5403582623685;4386.649068074546;4397.142557201347;4404.339349097629;4831.970572359617;4917.827876024322;4957.876053098666;4978.8050867791835;4993.251012348141;3755.380362240227;3756.7790468097705;3768.1144930941205;3768.2651882882847;3768.3782175940937;4981.576565991895;5081.415637201695;5232.816851410221;5250.847152667388;5259.658122222043;3668.669819716238;3719.795411252353;3856.3636999895266;3867.651911327994;3872.7095467840027;3925.450436938831;3926.9018274543364;3943.7633741975574;3944.5660977292473;3951.92096158081;4356.564343565618;4367.257566213688;4367.410399596014;4380.452443444569;4388.630139724577;4849.75751212438;4935.407751069894;4985.302057711923;4994.650374473752;4994.9750251248515;1311.1018952017898;1316.8156458095875;1319.5051855554168;1321.154461144868;1324.3113580937859;897.9506127162938;942.7972985808084;944.4474982135528;954.656323723459;956.1585804492141;4268.530461649216;4272.252355837716;4297.441332626801;4304.548022457597;4316.5467625899455;5035.571976381975;5038.546530812245;5043.268726034705;5056.342675452242;5066.895814390356;4180.414741936132;4258.339957306623;4276.294411422143;4284.807183676679;4336.371226172188;2677.6786785585855;2688;2688.7042425333198;2695.2318589202378;2695.4770554636566;4677;4687.296905464208;4702.200625893538;4712.764361781898;4718.88202794926;4971.701697898137;5107.157319042391;5116.334876466036;5148.4851514848215;5171.4311425743135;4834.734089625104;4854.757262136879;4878.0975219823285;4885.877853053773;4892.2661600760175;5160.303359046631;5201.349831271091;5201.557867581298;5215.817446389358;5220.554434073493;4915.5330243626795;5053;5117.437081920912;5119.846404607868;5120.846374608767;4597.632189424771;4730.716157030589;4798.808047678054;4819.927701084556;4840.709557426566;3499.107727529464;3537.628549002318;3537.699295559906;3542.3800834854314;3554.626764189826;5093.752030752489;5180.533751962342;5211.583073354047;5219.2953951216095;5223.667964668985;4980.601551875914;5061.7469126544265;5086.847394578169;5098.9490105098475;5105.387353517602;5050.035721958245;5053.545180933586;5057.570106540985;5058.2179801108505;5074.720890350918;4976.5023497649945;4990.301357809982;4996.60027197816;5042.117629414911;5042.873928151826;4917.6311776616185;5058.9494105058475;5113.057038325413;5126.846194614019;5137.537621614073;4972.154733695353;4974.651774375759;4976.626752993612;4979.925301120558;4983.925241121314 15:22:39 INFO - PROCESS | 14999 | |5;yui.html;610.6702380714414;626.0546574672246;671.6540981394583;693.3621068616872;736.3336180756414;11711.355875426849;12961.157524760896;13079.476820927164;13079.869201307984;13088.083834131614;12591.370431478435;12681.365931703423;12754.10721249513;12777.10560260782;12786.93606531966;620.1349117980415;761.7067429039818;775.6160700453255;776.9184235655259;777.5412506621093;628.4249911331126;755.2334380603692;777.0170734021467;780.5433821214568;782.3545574900701;800.6877317846045;802.6307898366729;802.7110240313511;803.1566854802463;803.8713805791075;641.1504756198057;795.3756301303507;795.8209402884363;795.8686816675241;795.9602019898982;489.5471688687949;582.5077809251176;600.0758831399639;600.1208229943154;600.6606267458916;12726.427310771038;12733.61799146027;12749.298788566624;12834.35828208586;12860.614181574567;12265.632031039084;12375.62873113808;12545.372731363486;12747.61757147287;12929.547465838745;11454.255473394203;11457.885421145766;11720.765584688344;11738.237014594024;11744.823827642593;4029.395590661395;4044.797760111983;4065.552789193216;4099;4116.423700681877;60819;61395.386046139414;61497.6925115376;64183.67908160429;64529.67735161294;8274.793130171673;8376.790580235422;8485.151484851465;10171.135453486537;10177.084062434416;18173.54566135857;18416.079196040144;18417.90791046063;18470.538236543925;18521.722174167397;6332.588381755263;6353.68231588428;6356.713947872357;6409.487241020707;6664.666766661648;3560.5193298904314;3586.6951309139017;3624.4200927851416;3627.8548858045383;3740.0462881964927;2775.1258353618546;2826.222788733115;2833.617461642693;2839;2856.442993616225;452.377980277119;453.6506889694916;460.8939943812875;462.6090953144587;467.0145991956968;514.920187370958;567.4835899331589;600.1957377114687;603.5744799916049;631.7630888416844;7817.57003364809;8426.325893928471;8545.829083418297;8619.784505387415;8679.17547832955;484.4259552430381;511.8592387093579;594.839393363798;610.5878531990888;610.7554736343918;3920.745151565196;3936.566977632458;4130.607592278729;4156.085661154541;4178.707490475698;65001.34998650048;65773.34226657767;66211;66992;67188;48058.519414806105;56887.431125688214;58951.705241474374;59248;59599;52849.207261891104;53065.73467132717;53121.4687853132;53304.20043699347;53451.46548534465;8203.179682031749;8823.120054081957;8860.955695221483;8866.866996995179;9088.863667045132;31598;31976.840115799274;34210.65789342075;34938;35404;44356.778216108716;44648.107037859714;45234.54765452435;46058.539414605424;47517;11555.2489088209;11608.292493038072;11681.88318116808;11989.880101198876;12239.449224785085;12112;12145.635630931087;12185.756284874076;12195.878041219828;13301.534446294334;11037.779244414905;11313.321200727984;11778.234414763014;11800.746531306477;11873.940630296793;11291.491882865126;11397.145214108808;12135;12536.498540058661;12553.184043037174;11410.486528106088;12033.157678962389;12128.75742485163;12267.815982760445;12942.547010854574;8917.777055573662;9094.681686141217;9636.75908102275;9688;9725.9027409725;9399.577019034297;10248.180145588483;10515.762725323568;10534.736631583964;10564.894351056391 15:22:39 INFO - PROCESS | 14999 | __end_tp_report 15:22:39 INFO - PROCESS | 14999 | __start_cc_report 15:22:39 INFO - PROCESS | 14999 | _x_x_mozilla_cycle_collect,1483 15:22:39 INFO - PROCESS | 14999 | __end_cc_report 15:22:39 INFO - PROCESS | 14999 | __startTimestamp1482016959311__endTimestamp 15:22:39 INFO - PROCESS | 14999 | 15:22:39 INFO - PROCESS | 14999 | ------- Summary: start ------- 15:22:39 INFO - PROCESS | 14999 | Number of tests: 6 15:22:39 INFO - PROCESS | 14999 | 15:22:39 INFO - PROCESS | 14999 | [#0] dojo.html Cycles:165 Average:4664.67 Median:4786.28 stddev:493.95 (10.3%) stddev-sans-first:467.49 15:22:39 INFO - PROCESS | 14999 | Values: 2575.8 2642.9 2668.8 2678.8 2683.5 4628.5 4651.3 4702.7 4758.3 4814.7 4707.0 4719.9 4757.2 4786.3 4820.6 4298.4 4318.7 4361.1 4379.4 4442.9 3988.1 4304.9 4338.5 4377.8 4417.1 4275.6 4323.5 4417.0 4441.9 4483.1 4342.4 4361.5 4365.4 4365.8 4367.4 4333.5 4333.5 4339.9 4340.8 4343.3 4670.2 4712.0 4722.8 4724.2 4789.5 5063.0 5075.6 5078.5 5079.8 5126.3 4959.1 5100.2 5108.2 5110.5 5112.2 4624.0 4699.3 4710.6 4713.4 4787.7 5156.2 5215.2 5220.2 5226.3 5253.6 4959.7 5000.0 5011.1 5011.3 5050.7 4934.9 4954.6 4977.7 4980.0 5081.9 4926.7 4973.0 5007.2 5015.0 5024.8 4954.2 4957.2 4958.5 4967.0 5006.2 4171.0 4205.2 4212.7 4218.8 4250.0 3691.8 3720.5 3737.0 3739.6 3809.4 4378.6 4379.1 4379.2 4380.0 4423.3 5123.7 5129.8 5139.8 5149.1 5184.7 4225.0 4249.3 4251.3 4255.7 4300.8 4552.7 4557.6 4559.3 4561.4 4609.3 4702.1 4708.0 4710.3 4711.9 4757.8 4926.9 4935.1 5072.8 5074.1 5120.5 4669.4 4677.6 4682.8 4730.2 4789.4 5013.4 5017.8 5019.0 5019.3 5072.0 5092.3 5095.2 5095.2 5102.1 5102.1 4790.2 4831.8 4842.2 4931.0 4936.1 4869.5 4896.8 4915.6 4924.4 4984.8 4853.3 4865.3 4871.6 4917.0 4919.3 4973.9 4983.1 4983.6 4985.5 4986.0 4663.9 4746.4 4757.5 4854.8 4895.3 15:22:39 INFO - PROCESS | 14999 | 15:22:39 INFO - PROCESS | 14999 | [#1] ext.html Cycles:180 Average:43666.55 Median:3454.34 stddev:79165.70 (2291.8%) stddev-sans-first:79321.47 15:22:39 INFO - PROCESS | 14999 | Values: 511.3 534.4 546.4 552.1 559.5 27298.6 35612.6 36273.0 36287.6 36368.1 38150.4 38428.0 38490.4 38545.4 38617.6 7327.2 7377.0 7538.5 7539.3 7543.8 7397.3 9511.4 9755.4 9763.3 10015.2 9732.8 9811.7 9815.1 9816.8 9830.2 9693.2 9695.0 9705.3 9748.7 9763.5 9471.1 9545.9 9568.4 9613.7 9618.9 35184.1 35360.0 35366.9 35447.6 35485.5 2921.8 2922.5 2954.7 2959.7 3319.4 26816.2 27046.2 27376.7 28262.7 28287.7 3231.1 3367.3 3437.8 3453.9 3454.8 242008.0 242014.8 244212.0 244365.0 245251.0 45158.5 45633.3 45646.3 45675.8 45696.3 47831.8 47940.0 47997.3 48002.3 48011.5 13446.6 13735.1 13739.5 13754.0 13800.4 9848.7 10059.8 10559.1 10787.0 10876.1 14499.0 15222.8 15362.8 15367.7 15375.5 5871.6 6056.3 6061.8 6138.3 6149.3 729.6 798.5 879.0 960.7 993.0 24398.3 25856.0 25896.7 25907.6 26084.7 874.4 896.1 930.9 987.5 1018.2 13123.9 13651.6 14120.6 14127.9 14200.6 362955.0 366852.0 367220.0 368065.0 368775.0 47854.3 48340.3 48412.3 48445.0 48486.0 1032.2 1087.0 1104.4 1106.7 1160.4 24160.0 24808.5 26200.0 26317.7 26361.9 40572.2 41100.6 41115.8 41153.6 41158.0 277313.0 278968.0 279058.0 279780.0 279843.0 22339.3 23034.7 23046.0 24209.5 24419.5 35041.8 35123.3 35296.6 36034.5 36471.1 29530.6 30264.2 30264.4 30479.2 30712.8 29799.6 30102.2 31321.8 31397.0 31726.4 27529.6 27951.2 28128.9 28202.9 28347.7 26313.2 27747.9 27837.7 27911.3 27974.7 21847.3 22339.4 22357.2 22412.4 22434.8 15:22:39 INFO - PROCESS | 14999 | 15:22:39 INFO - PROCESS | 14999 | [#2] jquery.html Cycles:180 Average:17249.99 Median:18988.43 stddev:29172.31 (153.6%) stddev-sans-first:29226.52 15:22:39 INFO - PROCESS | 14999 | Values: 341.2 353.4 361.9 366.4 379.0 12415.3 15201.8 15280.6 16670.2 16837.7 16354.9 16375.4 16474.3 16537.0 16606.7 4082.7 4827.4 4976.4 4995.8 5030.9 4901.7 4918.8 4930.9 4933.6 4937.4 4706.3 4882.7 4899.2 4899.4 4951.9 4932.4 4941.1 4989.8 4997.0 4997.2 4266.2 4404.4 4479.5 4494.1 4494.3 19007.6 19233.6 19409.4 19442.9 19456.5 1758.5 1912.3 1988.4 2342.8 2456.3 12143.1 12431.4 12504.6 12574.3 13172.2 1695.2 1755.2 1756.3 1782.3 1782.3 59527.0 61292.7 62233.7 68506.3 70012.6 9550.9 9567.4 9912.6 9940.1 10135.0 13302.0 13326.3 13333.4 13334.9 13345.5 6812.0 6830.2 6984.5 7031.0 7187.9 6515.9 6545.7 6706.3 6716.0 6731.3 4165.0 4196.8 4229.2 4294.0 4405.8 1618.7 1737.8 1789.7 1798.8 1802.5 646.9 802.9 838.9 840.6 876.5 15198.9 15344.8 15410.8 16229.8 16242.4 393.0 398.7 402.3 404.4 407.3 5330.0 5549.0 5686.2 5731.0 5741.5 160774.0 160879.0 160975.0 161095.0 161122.0 52572.5 60513.0 72239.0 72345.0 73160.0 415.9 422.2 424.1 424.9 425.4 8862.5 8903.2 9009.7 9334.3 9641.1 36586.8 36601.5 37597.8 39064.2 39739.4 47788.6 49931.0 50243.7 50913.2 51355.7 6655.8 7420.3 10589.3 10694.0 11252.9 12089.7 12097.3 12207.9 12260.6 12719.6 10144.3 10180.7 10289.5 10849.8 10937.8 10218.4 10656.7 10683.5 10737.6 10767.8 10646.9 10813.5 10814.6 10882.3 10947.6 10779.3 10966.5 10992.0 11105.4 11200.3 10089.4 10302.1 10335.2 10568.8 10812.9 15:22:39 INFO - PROCESS | 14999 | 15:22:39 INFO - PROCESS | 14999 | [#3] mootools.html Cycles:180 Average:4617.85 Median:5633.61 stddev:2464.34 (43.7%) stddev-sans-first:2458.58 15:22:39 INFO - PROCESS | 14999 | Values: 1293.0 1306.2 1380.9 1616.9 1624.2 6005.8 6179.7 6814.2 7225.5 7232.0 6753.9 6983.1 6985.5 7161.9 7165.4 2082.1 2117.8 2118.2 2120.6 2121.3 1827.2 1899.4 2077.5 2110.0 2141.4 1993.8 2082.6 2092.0 2096.7 2106.7 2074.2 2114.0 2117.2 2135.1 2168.9 2158.4 2163.5 2182.3 2183.1 2183.9 7161.9 7219.7 7262.9 7272.7 7278.2 4254.9 4384.3 4388.0 4388.0 4390.8 2703.3 2777.4 2835.4 2835.5 2846.0 879.4 885.3 908.6 913.5 922.5 9199.6 9410.8 9427.2 9428.9 9429.0 3845.7 3877.2 3904.9 3910.3 3963.7 8108.2 8120.9 8163.0 8170.2 8170.4 4378.8 4380.6 4485.3 4486.0 4501.7 3959.5 4055.0 4076.1 4078.6 4086.6 3258.9 3263.2 3337.2 3337.6 3446.9 1012.1 1044.1 1054.0 1091.4 1096.4 668.8 692.7 711.5 725.0 767.7 4481.2 4664.9 4674.9 4789.7 4917.1 786.7 850.6 854.7 855.8 856.8 3202.0 3207.8 3207.9 3214.3 3337.8 7920.8 8162.9 8272.7 8272.8 8318.3 8219.7 8223.1 8223.2 8228.0 8275.9 6490.3 6546.6 6556.6 6559.1 6561.4 4614.1 4631.4 4639.7 4684.8 4686.7 7491.3 7554.7 7564.8 7634.3 7635.7 7611.3 7670.3 7764.4 7838.4 7856.6 5940.7 5992.2 6013.4 6019.6 6093.3 6509.4 6613.7 6615.6 6630.9 6631.7 5991.1 6076.5 6081.2 6082.8 6155.8 5863.9 5899.6 5913.7 5942.7 6021.3 5629.2 5638.0 5651.9 5673.9 5675.9 4056.2 4081.7 4187.9 4207.7 4277.9 4054.2 4060.1 4119.1 4165.9 4202.0 15:22:39 INFO - PROCESS | 14999 | 15:22:39 INFO - PROCESS | 14999 | [#4] prototype.html Cycles:180 Average:4181.21 Median:4724.80 stddev:1182.68 (25.0%) stddev-sans-first:1150.46 15:22:39 INFO - PROCESS | 14999 | Values: 347.8 351.5 352.5 353.6 363.9 4800.6 4808.3 4813.5 4830.5 4831.7 4748.5 4759.8 4761.4 4772.6 4784.1 3401.0 3630.5 3735.0 3856.4 3879.1 3829.6 3834.5 3837.8 3850.6 3855.8 3803.5 3824.2 3824.7 3825.7 3835.4 3641.9 3651.5 3743.7 3827.6 3839.9 3385.8 3393.0 3402.2 3418.3 3444.0 4586.6 4594.6 4618.1 4627.1 4662.4 4349.8 4377.5 4386.6 4397.1 4404.3 4832.0 4917.8 4957.9 4978.8 4993.3 3755.4 3756.8 3768.1 3768.3 3768.4 4981.6 5081.4 5232.8 5250.8 5259.7 3668.7 3719.8 3856.4 3867.7 3872.7 3925.5 3926.9 3943.8 3944.6 3951.9 4356.6 4367.3 4367.4 4380.5 4388.6 4849.8 4935.4 4985.3 4994.7 4995.0 1311.1 1316.8 1319.5 1321.2 1324.3 898.0 942.8 944.4 954.7 956.2 4268.5 4272.3 4297.4 4304.5 4316.5 5035.6 5038.5 5043.3 5056.3 5066.9 4180.4 4258.3 4276.3 4284.8 4336.4 2677.7 2688.0 2688.7 2695.2 2695.5 4677.0 4687.3 4702.2 4712.8 4718.9 4971.7 5107.2 5116.3 5148.5 5171.4 4834.7 4854.8 4878.1 4885.9 4892.3 5160.3 5201.3 5201.6 5215.8 5220.6 4915.5 5053.0 5117.4 5119.8 5120.8 4597.6 4730.7 4798.8 4819.9 4840.7 3499.1 3537.6 3537.7 3542.4 3554.6 5093.8 5180.5 5211.6 5219.3 5223.7 4980.6 5061.7 5086.8 5098.9 5105.4 5050.0 5053.5 5057.6 5058.2 5074.7 4976.5 4990.3 4996.6 5042.1 5042.9 4917.6 5058.9 5113.1 5126.8 5137.5 4972.2 4974.7 4976.6 4979.9 4983.9 15:22:39 INFO - PROCESS | 14999 | 15:22:39 INFO - PROCESS | 14999 | [#5] yui.html Cycles:180 Average:14757.22 Median:457.27 stddev:18363.14 (4015.8%) stddev-sans-first:18383.93 15:22:39 INFO - PROCESS | 14999 | Values: 610.7 626.1 671.7 693.4 736.3 11711.4 12961.2 13079.5 13079.9 13088.1 12591.4 12681.4 12754.1 12777.1 12786.9 620.1 761.7 775.6 776.9 777.5 628.4 755.2 777.0 780.5 782.4 800.7 802.6 802.7 803.2 803.9 641.2 795.4 795.8 795.9 796.0 489.5 582.5 600.1 600.1 600.7 12726.4 12733.6 12749.3 12834.4 12860.6 12265.6 12375.6 12545.4 12747.6 12929.5 11454.3 11457.9 11720.8 11738.2 11744.8 4029.4 4044.8 4065.6 4099.0 4116.4 60819.0 61395.4 61497.7 64183.7 64529.7 8274.8 8376.8 8485.2 10171.1 10177.1 18173.5 18416.1 18417.9 18470.5 18521.7 6332.6 6353.7 6356.7 6409.5 6664.7 3560.5 3586.7 3624.4 3627.9 3740.0 2775.1 2826.2 2833.6 2839.0 2856.4 452.4 453.7 460.9 462.6 467.0 514.9 567.5 600.2 603.6 631.8 7817.6 8426.3 8545.8 8619.8 8679.2 484.4 511.9 594.8 610.6 610.8 3920.7 3936.6 4130.6 4156.1 4178.7 65001.3 65773.3 66211.0 66992.0 67188.0 48058.5 56887.4 58951.7 59248.0 59599.0 52849.2 53065.7 53121.5 53304.2 53451.5 8203.2 8823.1 8861.0 8866.9 9088.9 31598.0 31976.8 34210.7 34938.0 35404.0 44356.8 44648.1 45234.5 46058.5 47517.0 11555.2 11608.3 11681.9 11989.9 12239.4 12112.0 12145.6 12185.8 12195.9 13301.5 11037.8 11313.3 11778.2 11800.7 11873.9 11291.5 11397.1 12135.0 12536.5 12553.2 11410.5 12033.2 12128.8 12267.8 12942.5 8917.8 9094.7 9636.8 9688.0 9725.9 9399.6 10248.2 10515.8 10534.7 10564.9 15:22:39 INFO - PROCESS | 14999 | -------- Summary: end -------- 15:22:39 INFO - PROCESS | 14999 | 15:22:40 INFO - TEST-INFO | 14999: exit 0 15:22:40 INFO - TEST-OK | dromaeo_css | took 1121939ms 15:22:40 INFO - TEST-START | kraken 15:22:40 INFO - operating with platform_type : linux_ 15:22:40 INFO - Initialising browser for kraken test... 15:22:40 INFO - TEST-INFO | started process 15298 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMnap6q/profile http://localhost:51882/getInfo.html) 15:22:44 INFO - PROCESS | 15298 | __metrics Screen width/height:1600/1200 15:22:44 INFO - PROCESS | 15298 | colorDepth:24 15:22:44 INFO - PROCESS | 15298 | Browser inner width/height: 1024/697 15:22:44 INFO - PROCESS | 15298 | __metrics 15:22:44 INFO - PROCESS | 15298 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:22:44 INFO - PROCESS | 15298 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:22:45 INFO - PROCESS | 15298 | console.error: PushService: 15:22:45 INFO - PROCESS | 15298 | stateChangeProcessEnqueue: Error transitioning state 15:22:45 INFO - PROCESS | 15298 | UnknownError 15:22:46 INFO - TEST-INFO | 15298: exit 0 15:22:46 INFO - Browser initialized. 15:22:46 INFO - Running cycle 1/1 for kraken test... 15:22:46 INFO - TEST-INFO | started process 15379 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMnap6q/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:22:58 INFO - PROCESS | 15379 | RSS: Main: 155660288 15:22:58 INFO - PROCESS | 15379 | 15:23:01 INFO - PROCESS | 15379 | Cycle 1(1): loaded http://localhost:51882/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51882/tests/kraken/driver.html?testName=audio-beat-detection) 15:23:01 INFO - PROCESS | 15379 | RSS: Main: 209514496 15:23:01 INFO - PROCESS | 15379 | 15:23:04 INFO - PROCESS | 15379 | Cycle 1(1): loaded http://localhost:51882/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51882/tests/kraken/driver.html?testName=audio-dft) 15:23:05 INFO - PROCESS | 15379 | RSS: Main: 187183104 15:23:05 INFO - PROCESS | 15379 | 15:23:08 INFO - PROCESS | 15379 | Cycle 1(1): loaded http://localhost:51882/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51882/tests/kraken/driver.html?testName=audio-fft) 15:23:09 INFO - PROCESS | 15379 | RSS: Main: 270123008 15:23:09 INFO - PROCESS | 15379 | 15:23:11 INFO - PROCESS | 15379 | Cycle 1(1): loaded http://localhost:51882/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51882/tests/kraken/driver.html?testName=audio-oscillator) 15:23:11 INFO - PROCESS | 15379 | RSS: Main: 181010432 15:23:11 INFO - PROCESS | 15379 | 15:23:13 INFO - PROCESS | 15379 | Cycle 1(1): loaded http://localhost:51882/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51882/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:23:14 INFO - PROCESS | 15379 | RSS: Main: 184680448 15:23:14 INFO - PROCESS | 15379 | 15:23:17 INFO - PROCESS | 15379 | Cycle 1(1): loaded http://localhost:51882/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51882/tests/kraken/driver.html?testName=imaging-darkroom) 15:23:18 INFO - PROCESS | 15379 | RSS: Main: 224129024 15:23:18 INFO - PROCESS | 15379 | 15:23:21 INFO - PROCESS | 15379 | Cycle 1(1): loaded http://localhost:51882/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51882/tests/kraken/driver.html?testName=imaging-desaturate) 15:23:22 INFO - PROCESS | 15379 | RSS: Main: 218378240 15:23:22 INFO - PROCESS | 15379 | 15:23:25 INFO - PROCESS | 15379 | Cycle 1(1): loaded http://localhost:51882/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51882/tests/kraken/driver.html?testName=json-parse-financial) 15:23:26 INFO - PROCESS | 15379 | RSS: Main: 219656192 15:23:26 INFO - PROCESS | 15379 | 15:23:27 INFO - PROCESS | 15379 | Cycle 1(1): loaded http://localhost:51882/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51882/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:23:28 INFO - PROCESS | 15379 | RSS: Main: 183369728 15:23:28 INFO - PROCESS | 15379 | 15:23:30 INFO - PROCESS | 15379 | Cycle 1(1): loaded http://localhost:51882/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51882/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:23:30 INFO - PROCESS | 15379 | RSS: Main: 190107648 15:23:30 INFO - PROCESS | 15379 | 15:23:33 INFO - PROCESS | 15379 | Cycle 1(1): loaded http://localhost:51882/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51882/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:23:33 INFO - PROCESS | 15379 | RSS: Main: 197873664 15:23:33 INFO - PROCESS | 15379 | 15:23:36 INFO - PROCESS | 15379 | Cycle 1(1): loaded http://localhost:51882/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51882/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:23:37 INFO - PROCESS | 15379 | RSS: Main: 209510400 15:23:37 INFO - PROCESS | 15379 | 15:23:40 INFO - PROCESS | 15379 | Cycle 1(1): loaded http://localhost:51882/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51882/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:23:40 INFO - PROCESS | 15379 | RSS: Main: 204410880 15:23:40 INFO - PROCESS | 15379 | 15:23:42 INFO - PROCESS | 15379 | Cycle 1(1): loaded http://localhost:51882/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51882/tests/kraken/driver.html?testName=ai-astar) 15:23:42 INFO - PROCESS | 15379 | RSS: Main: 256446464 15:23:42 INFO - PROCESS | 15379 | 15:23:42 INFO - PROCESS | 15379 | __start_tp_report 15:23:42 INFO - PROCESS | 15379 | _x_x_mozilla_page_load 15:23:42 INFO - PROCESS | 15379 | _x_x_mozilla_page_load_details 15:23:42 INFO - PROCESS | 15379 | |i|pagename|runs| 15:23:42 INFO - PROCESS | 15379 | |0;ai-astar;116;115;115;117;115;115;114;114;114;113 15:23:42 INFO - PROCESS | 15379 | |1;audio-beat-detection;151;131;132;166;129;124;127;128;152;127 15:23:42 INFO - PROCESS | 15379 | |2;audio-dft;162;162;161;160;160;161;163;162;160;161 15:23:42 INFO - PROCESS | 15379 | |3;audio-fft;76;78;77;103;77;78;76;76;89;76 15:23:42 INFO - PROCESS | 15379 | |4;audio-oscillator;85;85;116;85;84;84;101;85;85;113 15:23:42 INFO - PROCESS | 15379 | |5;imaging-gaussian-blur;127;127;127;127;127;127;127;127;127;127 15:23:42 INFO - PROCESS | 15379 | |6;imaging-darkroom;147;147;146;146;146;147;146;146;147;146 15:23:42 INFO - PROCESS | 15379 | |7;imaging-desaturate;95;96;95;95;96;95;96;95;95;95 15:23:42 INFO - PROCESS | 15379 | |8;json-parse-financial;65;64;64;65;65;66;65;65;66;65 15:23:42 INFO - PROCESS | 15379 | |9;json-stringify-tinderbox;65;66;66;66;65;65;66;65;66;66 15:23:42 INFO - PROCESS | 15379 | |10;stanford-crypto-aes;85;84;83;85;85;86;84;85;85;84 15:23:42 INFO - PROCESS | 15379 | |11;stanford-crypto-ccm;134;137;137;145;134;134;139;143;184;147 15:23:42 INFO - PROCESS | 15379 | |12;stanford-crypto-pbkdf2;173;180;174;179;182;178;180;174;181;179 15:23:42 INFO - PROCESS | 15379 | |13;stanford-crypto-sha256-iterative;68;70;68;73;68;67;68;69;67;69 15:23:42 INFO - PROCESS | 15379 | __end_tp_report 15:23:42 INFO - PROCESS | 15379 | __start_cc_report 15:23:42 INFO - PROCESS | 15379 | _x_x_mozilla_cycle_collect,1973 15:23:42 INFO - PROCESS | 15379 | __end_cc_report 15:23:42 INFO - PROCESS | 15379 | __startTimestamp1482017022903__endTimestamp 15:23:42 INFO - PROCESS | 15379 | 15:23:42 INFO - PROCESS | 15379 | ------- Summary: start ------- 15:23:42 INFO - PROCESS | 15379 | Number of tests: 14 15:23:42 INFO - PROCESS | 15379 | 15:23:42 INFO - PROCESS | 15379 | [#0] ai-astar Cycles:10 Average:114.80 Median:115.00 stddev:1.14 (1.0%) stddev-sans-first:1.12 15:23:42 INFO - PROCESS | 15379 | Values: 116.0 115.0 115.0 117.0 115.0 115.0 114.0 114.0 114.0 113.0 15:23:42 INFO - PROCESS | 15379 | 15:23:42 INFO - PROCESS | 15379 | [#1] audio-beat-detection Cycles:10 Average:136.70 Median:131.50 stddev:14.28 (10.9%) stddev-sans-first:14.18 15:23:42 INFO - PROCESS | 15379 | Values: 151.0 131.0 132.0 166.0 129.0 124.0 127.0 128.0 152.0 127.0 15:23:42 INFO - PROCESS | 15379 | 15:23:42 INFO - PROCESS | 15379 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.50 stddev:1.03 (0.6%) stddev-sans-first:1.05 15:23:42 INFO - PROCESS | 15379 | Values: 162.0 162.0 161.0 160.0 160.0 161.0 163.0 162.0 160.0 161.0 15:23:42 INFO - PROCESS | 15379 | 15:23:42 INFO - PROCESS | 15379 | [#3] audio-fft Cycles:10 Average:80.60 Median:77.00 stddev:8.80 (11.4%) stddev-sans-first:9.17 15:23:42 INFO - PROCESS | 15379 | Values: 76.0 78.0 77.0 103.0 77.0 78.0 76.0 76.0 89.0 76.0 15:23:42 INFO - PROCESS | 15379 | 15:23:42 INFO - PROCESS | 15379 | [#4] audio-oscillator Cycles:10 Average:92.30 Median:85.00 stddev:12.78 (15.0%) stddev-sans-first:13.28 15:23:42 INFO - PROCESS | 15379 | Values: 85.0 85.0 116.0 85.0 84.0 84.0 101.0 85.0 85.0 113.0 15:23:42 INFO - PROCESS | 15379 | 15:23:42 INFO - PROCESS | 15379 | [#5] imaging-gaussian-blur Cycles:10 Average:127.00 Median:127.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 15:23:42 INFO - PROCESS | 15379 | Values: 127.0 127.0 127.0 127.0 127.0 127.0 127.0 127.0 127.0 127.0 15:23:42 INFO - PROCESS | 15379 | 15:23:42 INFO - PROCESS | 15379 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 15:23:42 INFO - PROCESS | 15379 | Values: 147.0 147.0 146.0 146.0 146.0 147.0 146.0 146.0 147.0 146.0 15:23:42 INFO - PROCESS | 15379 | 15:23:42 INFO - PROCESS | 15379 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 15:23:42 INFO - PROCESS | 15379 | Values: 95.0 96.0 95.0 95.0 96.0 95.0 96.0 95.0 95.0 95.0 15:23:42 INFO - PROCESS | 15379 | 15:23:42 INFO - PROCESS | 15379 | [#8] json-parse-financial Cycles:10 Average:65.00 Median:65.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 15:23:42 INFO - PROCESS | 15379 | Values: 65.0 64.0 64.0 65.0 65.0 66.0 65.0 65.0 66.0 65.0 15:23:42 INFO - PROCESS | 15379 | 15:23:42 INFO - PROCESS | 15379 | [#9] json-stringify-tinderbox Cycles:10 Average:65.60 Median:66.00 stddev:0.52 (0.8%) stddev-sans-first:0.50 15:23:42 INFO - PROCESS | 15379 | Values: 65.0 66.0 66.0 66.0 65.0 65.0 66.0 65.0 66.0 66.0 15:23:42 INFO - PROCESS | 15379 | 15:23:42 INFO - PROCESS | 15379 | [#10] stanford-crypto-aes Cycles:10 Average:84.60 Median:85.00 stddev:0.84 (1.0%) stddev-sans-first:0.88 15:23:42 INFO - PROCESS | 15379 | Values: 85.0 84.0 83.0 85.0 85.0 86.0 84.0 85.0 85.0 84.0 15:23:42 INFO - PROCESS | 15379 | 15:23:42 INFO - PROCESS | 15379 | [#11] stanford-crypto-ccm Cycles:10 Average:143.40 Median:141.00 stddev:15.02 (10.7%) stddev-sans-first:15.54 15:23:42 INFO - PROCESS | 15379 | Values: 134.0 137.0 137.0 145.0 134.0 134.0 139.0 143.0 184.0 147.0 15:23:42 INFO - PROCESS | 15379 | 15:23:42 INFO - PROCESS | 15379 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.00 Median:179.50 stddev:3.20 (1.8%) stddev-sans-first:2.83 15:23:42 INFO - PROCESS | 15379 | Values: 173.0 180.0 174.0 179.0 182.0 178.0 180.0 174.0 181.0 179.0 15:23:42 INFO - PROCESS | 15379 | 15:23:42 INFO - PROCESS | 15379 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:68.50 stddev:1.77 (2.6%) stddev-sans-first:1.86 15:23:42 INFO - PROCESS | 15379 | Values: 68.0 70.0 68.0 73.0 68.0 67.0 68.0 69.0 67.0 69.0 15:23:42 INFO - PROCESS | 15379 | -------- Summary: end -------- 15:23:42 INFO - PROCESS | 15379 | 15:23:44 INFO - TEST-INFO | 15379: exit 0 15:23:44 INFO - TEST-OK | kraken | took 63935ms 15:23:44 INFO - SUITE-END | took 1185s 15:23:44 INFO - Completed test suite (00:19:46) 15:23:44 INFO - javascript benchmark 15:23:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2575.7681808637217, 2642.9471410571778, 2668.8265262757927, 2678.7990900682453, 2683.51696694595, 4628.4677262114865, 4651.255799072149, 4702.741349225791, 4758.310045043467, 4814.662973591846, 4707.0, 4719.90560188796, 4757.191277482828, 4786.282057691348, 4820.6143508519235, 4298.376735373369, 4318.67609929255, 4361.062371590107, 4379.430674012374, 4442.8667139985855, 3988.0935179030716, 4304.870853874389, 4338.522762496123, 4377.824887004532, 4417.072414792898, 4275.593818587229, 4323.481182258118, 4417.028253784162, 4441.911161776747, 4483.125790470859, 4342.392065110887, 4361.542038086019, 4365.432493775789, 4365.7817109144735, 4367.388565600819, 4333.458317710286, 4333.523312435629, 4339.891502712426, 4340.761258130801, 4343.305071188626, 4670.206064968964, 4711.952880471185, 4722.787474563653, 4724.173269677827, 4789.473157952622, 5062.974685126587, 5075.6447048706605, 5078.5175408336145, 5079.771410286546, 5126.307948426952, 4959.132151873444, 5100.15847385181, 5108.233764935289, 5110.514501122388, 5112.233165025239, 4624.028953919681, 4699.295105734167, 4710.599599034052, 4713.363695901009, 4787.736674482937, 5156.20078887773, 5215.217717342429, 5220.1908704150155, 5226.320578324793, 5253.579713622901, 4959.727215003138, 4999.975000125049, 5011.123053465629, 5011.298418221452, 5050.722210278396, 4934.925976110361, 4954.603631709455, 4977.701337919664, 4980.028894365564, 5081.898362032813, 4926.679765815211, 4972.975135124301, 5007.173816320339, 5015.0, 5024.84925452237, 4954.157793175169, 4957.182064959314, 4958.479359667255, 4966.975165124151, 5006.224035274538, 4171.0, 4205.1589682063095, 4212.68404869636, 4218.831246750157, 4250.043740158501, 3691.8154092295276, 3720.497732806091, 3737.028372623138, 3739.569949455793, 3809.3524100902914, 4378.627816635558, 4379.080393117417, 4379.233634114017, 4380.0, 4423.292273236267, 5123.718195499208, 5129.820456284012, 5139.8458046258675, 5149.124648809711, 5184.662996905189, 4225.049363893161, 4249.3413520904305, 4251.256984636284, 4255.659547236213, 4300.80646370914, 4552.658550608718, 4557.635389168859, 4559.293309537027, 4561.384213131185, 4609.285560738091, 4702.100471208334, 4708.034852855225, 4710.340552322746, 4711.905761884812, 4757.785899634525, 4926.8768280793265, 4935.136351138464, 5072.797088116434, 5074.06129865976, 5120.539151476236, 4669.369635099218, 4677.579017888406, 4682.812687492598, 4730.1958667026, 4789.425268967607, 5013.423456302572, 5017.774200161075, 5018.974905125451, 5019.297298378303, 5072.036313100499, 5092.261622064854, 5095.15929871567, 5095.235714642833, 5102.056119617882, 5102.08162530748, 4790.233562629963, 4831.830885918976, 4842.201036828884, 4931.038447502702, 4936.111499929903, 4869.537393947569, 4896.755162241945, 4915.631327650369, 4924.433690125538, 4984.825531106394, 4853.344798452164, 4865.270209468608, 4871.634627402888, 4916.975415122902, 4919.335889654851, 4973.875653108701, 4983.127952608352, 4983.626228032985, 4985.476524964826, 4986.002799440199, 4663.930041049455, 4746.43042834862, 4757.45289291722, 4854.83008094715, 4895.33912921751], "value": 4633.099127592895, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [511.3480312601433, 534.3801190618883, 546.428981714109, 552.1303946284603, 559.4992481728852, 27298.5905211422, 35612.643873561254, 36273.0, 36287.63712362875, 36368.09079773, 38150.4277435838, 38428.0, 38490.422643660364, 38545.421818672745, 38617.61382386175, 7327.157376901671, 7377.040984671999, 7538.472306938489, 7539.283768042027, 7543.849123017564, 7397.298621317101, 9511.429314241133, 9755.365901216433, 9763.316567840255, 10015.198784097254, 9732.75668108296, 9811.705648830512, 9815.116639502443, 9816.803663926752, 9830.164436022947, 9693.22454203662, 9695.0, 9705.272104592148, 9748.658796942143, 9763.463009534473, 9471.14759671626, 9545.856812147824, 9568.378055426376, 9613.711588652352, 9618.903810961941, 35184.12039699028, 35360.0, 35366.92661467717, 35447.64552354495, 35485.46771798425, 2921.780866435026, 2922.4885645012037, 2954.689757575445, 2959.748421384185, 3319.369319829249, 26816.195514134608, 27046.245698247625, 27376.726232737816, 28262.717372826213, 28287.717122828715, 3231.0791424444155, 3367.326534693071, 3437.759356845022, 3453.9309213815836, 3454.758166928316, 242008.0, 242014.78992605102, 244212.0, 244365.0, 245251.0, 45158.54841451543, 45633.31550026752, 45646.31530527045, 45675.771621141685, 45696.3145552817, 47831.76084119557, 47940.0, 47997.280040799415, 48002.27996580054, 48011.519884801404, 13446.596602101952, 13735.107218030797, 13739.450421983209, 13754.037217394887, 13800.447982080805, 9848.704538863845, 10059.849102263472, 10559.102476289601, 10787.0, 10876.075533579735, 14499.0, 15222.77165842491, 15362.769558456632, 15367.6959453718, 15375.461858834888, 5871.588988770745, 6056.303525094582, 6061.818145455643, 6138.263408391022, 6149.2620885494025, 729.5950747335173, 798.5049269452976, 879.0462348351982, 960.6685693435893, 993.036754348281, 24398.26805195847, 25856.0, 25896.74103258981, 25907.611385829226, 26084.73915260861, 874.4185116897319, 896.1441823058963, 930.8829404714235, 987.4667679453158, 1018.2363227579316, 13123.934380328228, 13651.59045228625, 14120.646983825281, 14127.858721412655, 14200.573982780534, 362955.0, 366852.0, 367220.0, 368065.0, 368775.0, 47854.28218576724, 48340.27489587659, 48412.27381589279, 48445.0, 48486.0, 1032.2258306270298, 1087.0325410384764, 1104.3815463340554, 1106.6569363497342, 1160.4139909345727, 24160.024692710147, 24808.503829923662, 26200.0, 26317.736822632294, 26361.868190658923, 40572.1885562293, 41100.588994109676, 41115.794421027706, 41153.588464114975, 41158.0, 277313.0, 278968.0, 279058.0, 279780.0, 279843.0, 22339.329820105424, 23034.654480182475, 23046.0, 24209.515809683355, 24419.511609768062, 35041.824790875886, 35123.29753404867, 35296.63782238069, 36034.45948310725, 36471.08822279358, 29530.55704164482, 30264.243393915327, 30264.394712106074, 30479.238019048815, 30712.84643576768, 29799.553006704482, 30102.24744381408, 31321.8433907829, 31397.0, 31726.36547269088, 27529.587056194574, 27951.161465156078, 28128.85935570309, 28202.85898570494, 28347.716522834507, 26313.21060368192, 27747.861260693568, 27837.721622784324, 27911.302217444725, 27974.72025279721, 21847.344579662637, 22339.441513961632, 22357.21749738751, 22412.439689007904, 22434.77565224327], "value": 16516.921057255237, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [341.23563218390814, 353.4009853298658, 361.92037751694625, 366.4082506751596, 379.04102620370475, 12415.31715755633, 15201.84798152018, 15280.617984550378, 16670.166491675398, 16837.663246735057, 16354.918225408856, 16375.4268600599, 16474.341026358932, 16537.0, 16606.66786664266, 4082.734622249559, 4827.396575428081, 4976.4277108132665, 4995.775190116454, 5030.899382012358, 4901.68139070961, 4918.803247870081, 4930.926036109461, 4933.580645645125, 4937.407511098673, 4706.270528068155, 4882.731449770261, 4899.216125419934, 4899.363082799249, 4951.900961980758, 4932.432770231433, 4941.061198372316, 4989.750512474362, 4996.975015124937, 4997.225430058346, 4266.2320782259185, 4404.4494438195225, 4479.476977827521, 4494.056248187884, 4494.303382975644, 19007.61984760311, 19233.615327693507, 19409.4177174685, 19442.902785486123, 19456.513587160294, 1758.4548789875053, 1912.3306842605116, 1988.3935399703084, 2342.7657234276608, 2456.2631210636737, 12143.149979501439, 12431.440585173688, 12504.562340318045, 12574.308413037279, 13172.209667419986, 1695.2117265471616, 1755.183839514632, 1756.2974810075943, 1782.3049010885766, 1782.3316256403848, 59527.0, 61292.693536532475, 62233.688831555555, 68506.31493685099, 70012.6499367505, 9550.946546492538, 9567.37812042215, 9912.55393507294, 9940.117365963933, 10135.0, 13302.0, 13326.267055311857, 13333.399996999964, 13334.866651333556, 13345.532906348231, 6812.0, 6830.21452532965, 6984.476164287698, 7030.964845175844, 7187.856242875113, 6515.902261466082, 6545.738170473128, 6706.329367063255, 6715.966420167868, 6731.259561448237, 4165.0, 4196.832126714959, 4229.238737027365, 4294.0, 4405.801738921757, 1618.6843565504848, 1737.7740893683992, 1789.6868048091533, 1798.8111248319, 1802.477281588351, 646.886363298129, 802.9076656184496, 838.9077201507829, 840.6469282901074, 876.4872549558452, 15198.924005379902, 15344.769828452581, 15410.845891541165, 16229.756553651705, 16242.350305987864, 393.0, 398.67440759474863, 402.2618495061536, 404.3691840728473, 407.28318160038543, 5330.0, 5549.0, 5686.232358631614, 5731.0, 5741.5119714824705, 160774.0, 160879.0, 160975.0, 161095.0, 161122.0, 52572.474275256754, 60513.0, 72239.0, 72345.0, 73160.0, 415.89186811429244, 422.210466427782, 424.1495800919137, 424.8767857321404, 425.41505430033703, 8862.468251904906, 8903.154200350957, 9009.729708108767, 9334.25325973907, 9641.132298093205, 36586.8170659145, 36601.45097823588, 37597.81201094086, 39064.2187156261, 39739.40390894081, 47788.592768120994, 49931.0, 50243.74878125586, 50913.23630145625, 51355.74322128366, 6655.800325990228, 7420.295071968154, 10589.311694739818, 10694.0, 11252.887471125185, 12089.697757556132, 12097.334646594521, 12207.938960305142, 12260.632181034583, 12719.618411447671, 10144.340617859816, 10180.694579162637, 10289.536970836181, 10849.783004340026, 10937.835932460861, 10218.437985910847, 10656.733581660521, 10683.465826708789, 10737.570497180337, 10767.838482422614, 10646.946765266433, 10813.513391897226, 10814.56741730322, 10882.279430142464, 10947.56209751601, 10779.299345542515, 10966.451677416257, 10992.0, 11105.444727763741, 11200.327980321206, 10089.445080520349, 10302.124319432933, 10335.22485813552, 10568.788624227625, 10812.891486160122], "value": 7412.505592643359, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1292.9547465838696, 1306.2358520265643, 1380.8964327675426, 1616.9418365179931, 1624.1716724470523, 6005.849853753658, 6179.660118693481, 6814.216365118013, 7225.494215404924, 7231.999999999994, 6753.898691519631, 6983.092198014251, 6985.511014229006, 7161.928380716205, 7165.426765858731, 2082.1359135958596, 2117.788221177885, 2118.248021952208, 2120.607687577803, 2121.278765219825, 1827.232562323827, 1899.3827006222964, 2077.5221699009235, 2110.02938648222, 2141.357592722185, 1993.8205561499462, 2082.562661841015, 2091.979080209201, 2096.695979083032, 2106.73665791776, 2074.2117995161893, 2114.0381126587445, 2117.195465723031, 2135.1032566322183, 2168.902399392031, 2158.4388059104745, 2163.53484000939, 2182.334388011656, 2183.094015983365, 2183.912643494258, 7161.89257161143, 7219.7473088442175, 7262.891056634155, 7272.745453909088, 7278.199398066208, 4254.851080212208, 4384.276594361926, 4387.956120438818, 4388.0, 4390.758508282043, 2703.2701170684004, 2777.361206922419, 2835.3620435402077, 2835.53213719736, 2846.018123747304, 879.3800370738614, 885.2740752582885, 908.5593487158723, 913.4930113786845, 922.5156792683828, 9199.632014719404, 9410.764730881714, 9427.245820334425, 9428.858567121499, 9429.0, 3845.73079884411, 3877.2439374321734, 3904.902377440587, 3910.2570511602703, 3963.742356746802, 8108.2297181767635, 8120.878186827203, 8162.959185204036, 8170.223828736261, 8170.42807003504, 4378.8029538670835, 4380.627646650007, 4485.282354823213, 4486.035502367007, 4501.662375321798, 3959.4852669152824, 4055.0, 4076.103257283393, 4078.632923036941, 4086.6322031016757, 3258.918527036843, 3263.200515873626, 3337.199072222698, 3337.5828021497314, 3446.879359222465, 1012.1143999000874, 1044.1385856668128, 1053.9789204215872, 1091.44881834673, 1096.3969816600838, 668.7926742709775, 692.6571347183177, 711.4628455516053, 724.9782506524813, 767.7274567528559, 4481.170983368087, 4664.906701865943, 4674.906501870011, 4789.6530699956775, 4917.065757506062, 786.7207141464697, 850.5959669157224, 854.6752234151107, 855.8373908957278, 856.7772379181457, 3202.0, 3207.7914935529116, 3207.8716851325685, 3214.3089235814414, 3337.7997320160866, 7920.841583168304, 8162.877556836652, 8272.669093236203, 8272.793180170544, 8318.292945099613, 8219.712310069119, 8223.095459499451, 8223.21879421454, 8227.958860205781, 8275.917240827635, 6490.318516555788, 6546.607203567801, 6556.639384833785, 6559.114519539897, 6561.40947314744, 4614.054118905549, 4631.397918270603, 4639.675222734376, 4684.765761711833, 4686.742229177428, 7491.288327608869, 7554.697812087455, 7564.8487030260185, 7634.274743899321, 7635.732749353746, 7611.314981651678, 7670.309672129535, 7764.378849692124, 7838.372930165687, 7856.646450909609, 5940.673262970578, 5992.1910542078, 6013.368596297326, 6019.638821670714, 6093.268807743099, 6509.446697030806, 6613.66931653425, 6615.6030638161865, 6630.9336906630315, 6631.701573429304, 5991.071383935497, 6076.483498902643, 6081.239845019372, 6082.847928801815, 6155.84610384744, 5863.912041319469, 5899.616524925866, 5913.674747888907, 5942.6731529766275, 6021.307549631849, 5629.183768353648, 5638.041532939492, 5651.915221271766, 5673.858153546029, 5675.914861277167, 4056.20903923732, 4081.7142800003717, 4187.874363769091, 4207.684423668176, 4277.893052673708, 4054.1688953764997, 4060.127072679388, 4119.114390406077, 4165.854195103157, 4202.033532287652], "value": 3783.218738539525, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.82608695652175, 351.5342171622599, 352.52233223981494, 353.5774749174737, 363.90174652843734, 4800.591949684281, 4808.302796094564, 4813.521036666115, 4830.492798256181, 4831.661783675144, 4748.453927798304, 4759.833405830788, 4761.381020467343, 4772.642051846116, 4784.091022705684, 3401.0, 3630.52803135592, 3735.010222291095, 3856.3636999895125, 3879.1078052047974, 3829.5787463379006, 3834.482344883433, 3837.827297771593, 3850.5571859236125, 3855.8264878080554, 3803.4865293185344, 3824.1969186470874, 3824.6749026332795, 3825.7321987460887, 3835.42468629705, 3641.8725344612812, 3651.5070465487083, 3743.7458451418806, 3827.5981021992848, 3839.8656047038357, 3385.8307084645917, 3392.9660703393142, 3402.1664692150334, 3418.2821607462215, 3444.0356700124007, 4586.633069354443, 4594.632429405639, 4618.0763847230355, 4627.120847039052, 4662.393888794469, 4349.760763158025, 4377.5403582623685, 4386.649068074546, 4397.142557201347, 4404.339349097629, 4831.970572359617, 4917.827876024322, 4957.876053098666, 4978.8050867791835, 4993.251012348141, 3755.380362240227, 3756.7790468097705, 3768.1144930941205, 3768.2651882882847, 3768.3782175940937, 4981.576565991895, 5081.415637201695, 5232.816851410221, 5250.847152667388, 5259.658122222043, 3668.669819716238, 3719.795411252353, 3856.3636999895266, 3867.651911327994, 3872.7095467840027, 3925.450436938831, 3926.9018274543364, 3943.7633741975574, 3944.5660977292473, 3951.92096158081, 4356.564343565618, 4367.257566213688, 4367.410399596014, 4380.452443444569, 4388.630139724577, 4849.75751212438, 4935.407751069894, 4985.302057711923, 4994.650374473752, 4994.9750251248515, 1311.1018952017898, 1316.8156458095875, 1319.5051855554168, 1321.154461144868, 1324.3113580937859, 897.9506127162938, 942.7972985808084, 944.4474982135528, 954.656323723459, 956.1585804492141, 4268.530461649216, 4272.252355837716, 4297.441332626801, 4304.548022457597, 4316.5467625899455, 5035.571976381975, 5038.546530812245, 5043.268726034705, 5056.342675452242, 5066.895814390356, 4180.414741936132, 4258.339957306623, 4276.294411422143, 4284.807183676679, 4336.371226172188, 2677.6786785585855, 2688.0, 2688.7042425333198, 2695.2318589202378, 2695.4770554636566, 4677.0, 4687.296905464208, 4702.200625893538, 4712.764361781898, 4718.88202794926, 4971.701697898137, 5107.157319042391, 5116.334876466036, 5148.4851514848215, 5171.4311425743135, 4834.734089625104, 4854.757262136879, 4878.0975219823285, 4885.877853053773, 4892.2661600760175, 5160.303359046631, 5201.349831271091, 5201.557867581298, 5215.817446389358, 5220.554434073493, 4915.5330243626795, 5053.0, 5117.437081920912, 5119.846404607868, 5120.846374608767, 4597.632189424771, 4730.716157030589, 4798.808047678054, 4819.927701084556, 4840.709557426566, 3499.107727529464, 3537.628549002318, 3537.699295559906, 3542.3800834854314, 3554.626764189826, 5093.752030752489, 5180.533751962342, 5211.583073354047, 5219.2953951216095, 5223.667964668985, 4980.601551875914, 5061.7469126544265, 5086.847394578169, 5098.9490105098475, 5105.387353517602, 5050.035721958245, 5053.545180933586, 5057.570106540985, 5058.2179801108505, 5074.720890350918, 4976.5023497649945, 4990.301357809982, 4996.60027197816, 5042.117629414911, 5042.873928151826, 4917.6311776616185, 5058.9494105058475, 5113.057038325413, 5126.846194614019, 5137.537621614073, 4972.154733695353, 4974.651774375759, 4976.626752993612, 4979.925301120558, 4983.925241121314], "value": 3825.621679497274, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [610.6702380714414, 626.0546574672246, 671.6540981394583, 693.3621068616872, 736.3336180756414, 11711.355875426849, 12961.157524760896, 13079.476820927164, 13079.869201307984, 13088.083834131614, 12591.370431478435, 12681.365931703423, 12754.10721249513, 12777.10560260782, 12786.93606531966, 620.1349117980415, 761.7067429039818, 775.6160700453255, 776.9184235655259, 777.5412506621093, 628.4249911331126, 755.2334380603692, 777.0170734021467, 780.5433821214568, 782.3545574900701, 800.6877317846045, 802.6307898366729, 802.7110240313511, 803.1566854802463, 803.8713805791075, 641.1504756198057, 795.3756301303507, 795.8209402884363, 795.8686816675241, 795.9602019898982, 489.5471688687949, 582.5077809251176, 600.0758831399639, 600.1208229943154, 600.6606267458916, 12726.427310771038, 12733.61799146027, 12749.298788566624, 12834.35828208586, 12860.614181574567, 12265.632031039084, 12375.62873113808, 12545.372731363486, 12747.61757147287, 12929.547465838745, 11454.255473394203, 11457.885421145766, 11720.765584688344, 11738.237014594024, 11744.823827642593, 4029.395590661395, 4044.797760111983, 4065.552789193216, 4099.0, 4116.423700681877, 60819.0, 61395.386046139414, 61497.6925115376, 64183.67908160429, 64529.67735161294, 8274.793130171673, 8376.790580235422, 8485.151484851465, 10171.135453486537, 10177.084062434416, 18173.54566135857, 18416.079196040144, 18417.90791046063, 18470.538236543925, 18521.722174167397, 6332.588381755263, 6353.68231588428, 6356.713947872357, 6409.487241020707, 6664.666766661648, 3560.5193298904314, 3586.6951309139017, 3624.4200927851416, 3627.8548858045383, 3740.0462881964927, 2775.1258353618546, 2826.222788733115, 2833.617461642693, 2839.0, 2856.442993616225, 452.377980277119, 453.6506889694916, 460.8939943812875, 462.6090953144587, 467.0145991956968, 514.920187370958, 567.4835899331589, 600.1957377114687, 603.5744799916049, 631.7630888416844, 7817.57003364809, 8426.325893928471, 8545.829083418297, 8619.784505387415, 8679.17547832955, 484.4259552430381, 511.8592387093579, 594.839393363798, 610.5878531990888, 610.7554736343918, 3920.745151565196, 3936.566977632458, 4130.607592278729, 4156.085661154541, 4178.707490475698, 65001.34998650048, 65773.34226657767, 66211.0, 66992.0, 67188.0, 48058.519414806105, 56887.431125688214, 58951.705241474374, 59248.0, 59599.0, 52849.207261891104, 53065.73467132717, 53121.4687853132, 53304.20043699347, 53451.46548534465, 8203.179682031749, 8823.120054081957, 8860.955695221483, 8866.866996995179, 9088.863667045132, 31598.0, 31976.840115799274, 34210.65789342075, 34938.0, 35404.0, 44356.778216108716, 44648.107037859714, 45234.54765452435, 46058.539414605424, 47517.0, 11555.2489088209, 11608.292493038072, 11681.88318116808, 11989.880101198876, 12239.449224785085, 12112.0, 12145.635630931087, 12185.756284874076, 12195.878041219828, 13301.534446294334, 11037.779244414905, 11313.321200727984, 11778.234414763014, 11800.746531306477, 11873.940630296793, 11291.491882865126, 11397.145214108808, 12135.0, 12536.498540058661, 12553.184043037174, 11410.486528106088, 12033.157678962389, 12128.75742485163, 12267.815982760445, 12942.547010854574, 8917.777055573662, 9094.681686141217, 9636.75908102275, 9688.0, 9725.9027409725, 9399.577019034297, 10248.180145588483, 10515.762725323568, 10534.736631583964, 10564.894351056391], "value": 6215.756527807233, "unit": "score"}], "name": "dromaeo_css", "value": 6090.39352468082, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 115.0, 115.0, 117.0, 115.0, 115.0, 114.0, 114.0, 114.0, 113.0], "value": 114.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 131.0, 132.0, 166.0, 129.0, 124.0, 127.0, 128.0, 152.0, 127.0], "value": 136.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 161.0, 160.0, 160.0, 161.0, 163.0, 162.0, 160.0, 161.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 78.0, 77.0, 103.0, 77.0, 78.0, 76.0, 76.0, 89.0, 76.0], "value": 80.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 116.0, 85.0, 84.0, 84.0, 101.0, 85.0, 85.0, 113.0], "value": 92.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 127.0, 127.0, 127.0, 127.0, 127.0, 127.0, 127.0, 127.0, 127.0], "value": 127.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 147.0, 146.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 64.0, 65.0, 65.0, 66.0, 65.0, 65.0, 66.0, 65.0], "value": 65.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 66.0, 65.0, 65.0, 66.0, 65.0, 66.0, 66.0], "value": 65.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 83.0, 85.0, 85.0, 86.0, 84.0, 85.0, 85.0, 84.0], "value": 84.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 137.0, 137.0, 145.0, 134.0, 134.0, 139.0, 143.0, 184.0, 147.0], "value": 143.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 180.0, 174.0, 179.0, 182.0, 178.0, 180.0, 174.0, 181.0, 179.0], "value": 178.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 70.0, 68.0, 73.0, 68.0, 67.0, 68.0, 69.0, 67.0, 69.0], "value": 68.7, "unit": "score"}], "name": "kraken", "value": 1559.6, "alertThreshold": 2.0}]} 15:23:44 INFO - Return code: 0 15:23:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:23:44 INFO - # TBPL SUCCESS # 15:23:44 INFO - Running post-action listener: _resource_record_post_action 15:23:44 INFO - [mozharness: 2016-12-17 23:23:44.696770Z] Finished run-tests step (success) 15:23:44 INFO - Running post-run listener: _resource_record_post_run 15:23:44 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 8192; Write bytes: 392589312; Read time: 160; Write time: 250044 15:23:44 INFO - TinderboxPrint: CPU usage
13.1% 15:23:44 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 160 15:23:44 INFO - TinderboxPrint: I/O write bytes / time
392,589,312 / 250,044 15:23:44 INFO - TinderboxPrint: CPU idle
8,336.1 (86.9%) 15:23:44 INFO - TinderboxPrint: CPU user
1,213.3 (12.6%) 15:23:44 INFO - TinderboxPrint: Swap in / out
0 / 0 15:23:44 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 110374912; Read time: 0; Write time: 69020 15:23:44 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 282214400; Read time: 152; Write time: 181024 15:23:45 INFO - Running post-run listener: _upload_blobber_files 15:23:45 INFO - Blob upload gear active. 15:23:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:23:45 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 15:23:45 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'] 15:23:45 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 15:23:45 INFO - (blobuploader) - INFO - Open directory for files ... 15:23:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:23:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:23:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:23:49 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:23:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:23:49 INFO - (blobuploader) - INFO - Done attempting. 15:23:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 15:23:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:23:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:23:50 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 15:23:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:23:50 INFO - (blobuploader) - INFO - Done attempting. 15:23:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:23:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:23:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:23:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:23:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:23:51 INFO - (blobuploader) - INFO - Done attempting. 15:23:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:23:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:23:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:23:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:23:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:23:52 INFO - (blobuploader) - INFO - Done attempting. 15:23:52 INFO - (blobuploader) - INFO - Iteration through files over. 15:23:52 INFO - Return code: 0 15:23:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:23:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:23:52 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4465ebdcc746d47db49d6b06c67f16b61438de2c178d689f2cf1e0626443e57aa9f0dd660f958be199755262c8e35a566a555dab8728cc83d0de61472b3a0237", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/385ffcef4b6fe0e56f06c6e7e2582a11879780aff758ae23aeac4139401a0a026b2e6a5277dbca541eff579f1238ff831d512213d03b1db4ed2a3b086683e395", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d74a36fad7c7f07c418e7032af19e60a74572c77d2cda88eb685d851b2193ce7ef760427e9ebe798ee79d0f7639d9c0c8c5a86b30fdd84959ee79cfa4465e933", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1cc4655a7b307e544f07b5b36073bfc8ba10c0c85b58ee14b8d32a8db2331096f778e64ed18923c3a018b37a0051a5fbbcdaf9b6dae255d7030faeaf8622c84c"} 15:23:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:23:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:23:52 INFO - Contents: 15:23:52 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4465ebdcc746d47db49d6b06c67f16b61438de2c178d689f2cf1e0626443e57aa9f0dd660f958be199755262c8e35a566a555dab8728cc83d0de61472b3a0237", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/385ffcef4b6fe0e56f06c6e7e2582a11879780aff758ae23aeac4139401a0a026b2e6a5277dbca541eff579f1238ff831d512213d03b1db4ed2a3b086683e395", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d74a36fad7c7f07c418e7032af19e60a74572c77d2cda88eb685d851b2193ce7ef760427e9ebe798ee79d0f7639d9c0c8c5a86b30fdd84959ee79cfa4465e933", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1cc4655a7b307e544f07b5b36073bfc8ba10c0c85b58ee14b8d32a8db2331096f778e64ed18923c3a018b37a0051a5fbbcdaf9b6dae255d7030faeaf8622c84c"} 15:23:52 INFO - Running post-run listener: copy_logs_to_upload_dir 15:23:52 INFO - Copying logs to upload dir... 15:23:52 INFO - mkdir: /builds/slave/test/build/upload/logs 15:23:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.971904 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-12-17 15:23:51.870212) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-17 15:23:51.874270) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=db0483c52d987ecb441a263b000001ad-1482014998.892341-89311437 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4465ebdcc746d47db49d6b06c67f16b61438de2c178d689f2cf1e0626443e57aa9f0dd660f958be199755262c8e35a566a555dab8728cc83d0de61472b3a0237", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/385ffcef4b6fe0e56f06c6e7e2582a11879780aff758ae23aeac4139401a0a026b2e6a5277dbca541eff579f1238ff831d512213d03b1db4ed2a3b086683e395", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d74a36fad7c7f07c418e7032af19e60a74572c77d2cda88eb685d851b2193ce7ef760427e9ebe798ee79d0f7639d9c0c8c5a86b30fdd84959ee79cfa4465e933", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1cc4655a7b307e544f07b5b36073bfc8ba10c0c85b58ee14b8d32a8db2331096f778e64ed18923c3a018b37a0051a5fbbcdaf9b6dae255d7030faeaf8622c84c"} build_url:https://queue.taskcluster.net/v1/task/Ev_uCDHEQCaeUNLnCbJmGw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011680 build_url: 'https://queue.taskcluster.net/v1/task/Ev_uCDHEQCaeUNLnCbJmGw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4465ebdcc746d47db49d6b06c67f16b61438de2c178d689f2cf1e0626443e57aa9f0dd660f958be199755262c8e35a566a555dab8728cc83d0de61472b3a0237", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/385ffcef4b6fe0e56f06c6e7e2582a11879780aff758ae23aeac4139401a0a026b2e6a5277dbca541eff579f1238ff831d512213d03b1db4ed2a3b086683e395", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d74a36fad7c7f07c418e7032af19e60a74572c77d2cda88eb685d851b2193ce7ef760427e9ebe798ee79d0f7639d9c0c8c5a86b30fdd84959ee79cfa4465e933", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1cc4655a7b307e544f07b5b36073bfc8ba10c0c85b58ee14b8d32a8db2331096f778e64ed18923c3a018b37a0051a5fbbcdaf9b6dae255d7030faeaf8622c84c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-17 15:23:51.899687) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-17 15:23:51.900034) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=db0483c52d987ecb441a263b000001ad-1482014998.892341-89311437 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004492 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-17 15:23:51.984814) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-17 15:23:51.985191) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-17 15:23:51.985637) ========= ========= Total master_lag: 0.17 =========