builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-026 starttime: 1477000427.9 results: success (0) buildid: 20161020114750 builduid: 72c1fb1ee31a407695b87b4ef392cc61 revision: 44754fcbce505bb509c290657231d65918f819af ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-20 14:53:47.904080) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-20 14:53:47.904481) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-20 14:53:47.904779) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-20 14:53:47.916099) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 14:53:47.916381) ========= 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=41bf3e9aed84707956354da8000001c5-1477000417.332948-828228526 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-20 14:53:47-- 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% 36.9M=0s 2016-10-20 14:53:48 (36.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.072576 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 14:53:47.998506) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 14:53:47.998805) ========= 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=41bf3e9aed84707956354da8000001c5-1477000417.332948-828228526 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020508 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 14:53:48.048244) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 14:53:48.048689) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 44754fcbce505bb509c290657231d65918f819af --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 44754fcbce505bb509c290657231d65918f819af --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=41bf3e9aed84707956354da8000001c5-1477000417.332948-828228526 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-20 14:53:48,173 truncating revision to first 12 chars 2016-10-20 14:53:48,174 Setting DEBUG logging. 2016-10-20 14:53:48,174 attempt 1/10 2016-10-20 14:53:48,174 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/44754fcbce50?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-20 14:53:48,473 unpacking tar archive at: mozilla-aurora-44754fcbce50/testing/mozharness/ program finished with exit code 0 elapsedTime=0.642600 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 14:53:48.707125) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-20 14:53:48.707716) ========= script_repo_revision: 44754fcbce505bb509c290657231d65918f819af ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-20 14:53:48.708382) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-20 14:53:48.708833) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-20 14:53:48.720331) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-10-20 14:53:48.720943) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41bf3e9aed84707956354da8000001c5-1477000417.332948-828228526 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:53:48 INFO - MultiFileLogger online at 20161020 14:53:48 in /builds/slave/test 14:53:48 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 14:53:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:53:48 INFO - {'append_to_log': False, 14:53:48 INFO - 'base_work_dir': '/builds/slave/test', 14:53:48 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 14:53:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:53:48 INFO - 'branch': 'Mozilla-Aurora', 14:53:48 INFO - 'buildbot_json_path': 'buildprops.json', 14:53:48 INFO - 'config_files': ('talos/linux_config.py',), 14:53:48 INFO - 'default_actions': ('clobber', 14:53:48 INFO - 'read-buildbot-config', 14:53:48 INFO - 'download-and-extract', 14:53:48 INFO - 'populate-webroot', 14:53:48 INFO - 'create-virtualenv', 14:53:48 INFO - 'install', 14:53:48 INFO - 'run-tests'), 14:53:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:53:48 INFO - 'download_minidump_stackwalk': True, 14:53:48 INFO - 'download_symbols': 'ondemand', 14:53:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:53:48 INFO - 'tooltool.py': '/tools/tooltool.py', 14:53:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:53:48 INFO - '/tools/misc-python/virtualenv.py')}, 14:53:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:53:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:53:48 INFO - 'installer_path': 'installer.exe', 14:53:48 INFO - 'log_level': 'info', 14:53:48 INFO - 'log_name': 'talos', 14:53:48 INFO - 'log_to_console': True, 14:53:48 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:53:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:53:48 INFO - 'opt_config_files': (), 14:53:48 INFO - 'pip_index': False, 14:53:48 INFO - 'sps_profile': False, 14:53:48 INFO - 'sps_profile_interval': 0, 14:53:48 INFO - 'suite': 'dromaeojs', 14:53:48 INFO - 'system_bits': '32', 14:53:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:53:48 INFO - 'title': 'talos-linux64-ix-026', 14:53:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:53:48 INFO - 'use_talos_json': True, 14:53:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:53:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:53:48 INFO - 'work_dir': 'build'} 14:53:48 INFO - [mozharness: 2016-10-20 21:53:48.937420Z] Running clobber step. 14:53:48 INFO - Running pre-action listener: _resource_record_pre_action 14:53:48 INFO - Running main action method: clobber 14:53:48 INFO - rmtree: /builds/slave/test/build 14:53:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:53:49 INFO - Running post-action listener: _resource_record_post_action 14:53:49 INFO - [mozharness: 2016-10-20 21:53:49.392535Z] Finished clobber step (success) 14:53:49 INFO - [mozharness: 2016-10-20 21:53:49.392635Z] Running read-buildbot-config step. 14:53:49 INFO - Running pre-action listener: _resource_record_pre_action 14:53:49 INFO - Running main action method: read_buildbot_config 14:53:49 INFO - Using buildbot properties: 14:53:49 INFO - { 14:53:49 INFO - "project": "", 14:53:49 INFO - "product": "firefox", 14:53:49 INFO - "script_repo_revision": "production", 14:53:49 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 14:53:49 INFO - "repository": "", 14:53:49 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 14:53:49 INFO - "buildid": "20161020114750", 14:53:49 INFO - "pgo_build": "True", 14:53:49 INFO - "basedir": "/builds/slave/test", 14:53:49 INFO - "buildnumber": 539, 14:53:49 INFO - "slavename": "talos-linux64-ix-026", 14:53:49 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 14:53:49 INFO - "platform": "ubuntu64_hw", 14:53:49 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 14:53:49 INFO - "branch": "mozilla-aurora", 14:53:49 INFO - "repo_path": "releases/mozilla-aurora", 14:53:49 INFO - "revision": "44754fcbce505bb509c290657231d65918f819af", 14:53:49 INFO - "stage_platform": "linux64-pgo", 14:53:49 INFO - "builduid": "72c1fb1ee31a407695b87b4ef392cc61", 14:53:49 INFO - "slavebuilddir": "test" 14:53:49 INFO - } 14:53:49 INFO - Found installer url https://queue.taskcluster.net/v1/task/XdK-4iWJQrCE0i9krD_J3A/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2. 14:53:49 INFO - Running post-action listener: _resource_record_post_action 14:53:49 INFO - [mozharness: 2016-10-20 21:53:49.395095Z] Finished read-buildbot-config step (success) 14:53:49 INFO - [mozharness: 2016-10-20 21:53:49.395185Z] Running download-and-extract step. 14:53:49 INFO - Running pre-action listener: _resource_record_pre_action 14:53:49 INFO - Running main action method: download_and_extract 14:53:49 INFO - mkdir: /builds/slave/test/build/tests 14:53:49 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')]} 14:53:49 INFO - trying https://queue.taskcluster.net/v1/task/XdK-4iWJQrCE0i9krD_J3A/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 14:53:49 INFO - Downloading https://queue.taskcluster.net/v1/task/XdK-4iWJQrCE0i9krD_J3A/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 14:53:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XdK-4iWJQrCE0i9krD_J3A/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 14:53:50 INFO - Downloaded 1361 bytes. 14:53:50 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 14:53:50 INFO - Using the following test package requirements: 14:53:50 INFO - {u'common': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 14:53:50 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 14:53:50 INFO - u'firefox-51.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 14:53:50 INFO - u'gtest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 14:53:50 INFO - u'firefox-51.0a2.en-US.linux-x86_64.gtest.tests.zip'], 14:53:50 INFO - u'jittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 14:53:50 INFO - u'jsshell-linux-x86_64.zip'], 14:53:50 INFO - u'mochitest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 14:53:50 INFO - u'firefox-51.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 14:53:50 INFO - u'mozbase': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 14:53:50 INFO - u'reftest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 14:53:50 INFO - u'firefox-51.0a2.en-US.linux-x86_64.reftest.tests.zip'], 14:53:50 INFO - u'talos': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 14:53:50 INFO - u'firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'], 14:53:50 INFO - u'web-platform': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 14:53:50 INFO - u'firefox-51.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 14:53:50 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 14:53:50 INFO - u'firefox-51.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 14:53:50 INFO - Downloading packages: [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:53:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XdK-4iWJQrCE0i9krD_J3A/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 14:53:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XdK-4iWJQrCE0i9krD_J3A/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:53:50 INFO - Fetch https://queue.taskcluster.net/v1/task/XdK-4iWJQrCE0i9krD_J3A/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 14:53:50 INFO - Expected file size: 21908864 14:53:55 INFO - Downloading packages: [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:53:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XdK-4iWJQrCE0i9krD_J3A/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 14:53:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XdK-4iWJQrCE0i9krD_J3A/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:53:55 INFO - Fetch https://queue.taskcluster.net/v1/task/XdK-4iWJQrCE0i9krD_J3A/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 14:53:56 INFO - Expected file size: 21908864 14:54:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XdK-4iWJQrCE0i9krD_J3A/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip 14:54:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XdK-4iWJQrCE0i9krD_J3A/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:54:00 INFO - Fetch https://queue.taskcluster.net/v1/task/XdK-4iWJQrCE0i9krD_J3A/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip into memory 14:54:01 INFO - Expected file size: 14414081 14:54:02 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')]} 14:54:02 INFO - trying https://queue.taskcluster.net/v1/task/XdK-4iWJQrCE0i9krD_J3A/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 14:54:02 INFO - Downloading https://queue.taskcluster.net/v1/task/XdK-4iWJQrCE0i9krD_J3A/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 14:54:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XdK-4iWJQrCE0i9krD_J3A/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:54:05 INFO - Downloaded 63986981 bytes. 14:54:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XdK-4iWJQrCE0i9krD_J3A/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 14:54:05 INFO - mkdir: /builds/slave/test/properties 14:54:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:54:05 INFO - Writing to file /builds/slave/test/properties/build_url 14:54:05 INFO - Contents: 14:54:05 INFO - build_url:https://queue.taskcluster.net/v1/task/XdK-4iWJQrCE0i9krD_J3A/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 14:54:05 INFO - Running post-action listener: _resource_record_post_action 14:54:05 INFO - Running post-action listener: set_extra_try_arguments 14:54:05 INFO - [mozharness: 2016-10-20 21:54:05.843955Z] Finished download-and-extract step (success) 14:54:05 INFO - [mozharness: 2016-10-20 21:54:05.844184Z] Running populate-webroot step. 14:54:05 INFO - Running pre-action listener: _resource_record_pre_action 14:54:05 INFO - Running main action method: populate_webroot 14:54:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:54:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:54:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:54:05 INFO - '--tppagecycles', 14:54:05 INFO - '7'], 14:54:05 INFO - 'tests': ['tsvgm']}}, 14:54:05 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:54:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:54:05 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:54:05 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:54:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:54:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:54:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:54:05 INFO - 'talos_options': ['--disable-e10s'], 14:54:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:54:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:54:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:54:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:54:05 INFO - 'talos_options': ['--disable-e10s'], 14:54:05 INFO - 'tests': ['damp', 'tps']}, 14:54:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:54:05 INFO - 'tests': ['damp', 'tps']}, 14:54:05 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:54:05 INFO - 'tests': ['dromaeo_dom']}, 14:54:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:54:05 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:54:05 INFO - 'tests': ['basic_compositor_video']}, 14:54:05 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:54:05 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:54:05 INFO - 'tests': ['a11yr', 14:54:05 INFO - 'ts_paint', 14:54:05 INFO - 'tpaint', 14:54:05 INFO - 'sessionrestore', 14:54:05 INFO - 'sessionrestore_no_auto_restore', 14:54:05 INFO - 'tabpaint']}, 14:54:05 INFO - 'other-e10s': {'tests': ['a11yr', 14:54:05 INFO - 'ts_paint', 14:54:05 INFO - 'tpaint', 14:54:05 INFO - 'sessionrestore', 14:54:05 INFO - 'sessionrestore_no_auto_restore', 14:54:05 INFO - 'tabpaint']}, 14:54:05 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:54:05 INFO - 'ts_paint', 14:54:05 INFO - 'tpaint', 14:54:05 INFO - 'sessionrestore', 14:54:05 INFO - 'sessionrestore_no_auto_restore', 14:54:05 INFO - 'tabpaint']}, 14:54:05 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:54:05 INFO - 'ts_paint', 14:54:05 INFO - 'tpaint', 14:54:05 INFO - 'sessionrestore', 14:54:05 INFO - 'sessionrestore_no_auto_restore', 14:54:05 INFO - 'tabpaint']}, 14:54:05 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:54:05 INFO - 'tests': ['a11yr', 14:54:05 INFO - 'ts_paint', 14:54:05 INFO - 'tpaint', 14:54:05 INFO - 'sessionrestore', 14:54:05 INFO - 'sessionrestore_no_auto_restore', 14:54:05 INFO - 'tabpaint']}, 14:54:05 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:54:05 INFO - 'tests': ['a11yr', 14:54:05 INFO - 'ts_paint', 14:54:05 INFO - 'tpaint', 14:54:05 INFO - 'sessionrestore', 14:54:05 INFO - 'sessionrestore_no_auto_restore', 14:54:05 INFO - 'tabpaint']}, 14:54:05 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:54:05 INFO - 'tests': ['tsvgx', 14:54:05 INFO - 'tsvgr_opacity', 14:54:05 INFO - 'tart', 14:54:05 INFO - 'tscrollx', 14:54:05 INFO - 'cart']}, 14:54:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:54:05 INFO - 'tsvgr_opacity', 14:54:05 INFO - 'tart', 14:54:05 INFO - 'tscrollx', 14:54:05 INFO - 'cart']}, 14:54:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:54:05 INFO - 'talos_options': ['--disable-e10s'], 14:54:05 INFO - 'tests': ['tp5o']}, 14:54:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:54:05 INFO - 'tests': ['tp5o']}, 14:54:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:54:05 INFO - 'talos_options': ['--disable-e10s', 14:54:05 INFO - '--xperf_path', 14:54:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:54:05 INFO - 'tests': ['tp5n']}, 14:54:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:54:05 INFO - 'talos_options': ['--xperf_path', 14:54:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:54:05 INFO - 'tests': ['tp5n']}}, 14:54:05 INFO - 'talos.zip': {'path': '', 14:54:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:54:05 INFO - Running post-action listener: _resource_record_post_action 14:54:05 INFO - [mozharness: 2016-10-20 21:54:05.864727Z] Finished populate-webroot step (success) 14:54:05 INFO - [mozharness: 2016-10-20 21:54:05.864816Z] Running create-virtualenv step. 14:54:05 INFO - Running pre-action listener: _resource_record_pre_action 14:54:05 INFO - Running main action method: create_virtualenv 14:54:05 INFO - Creating virtualenv /builds/slave/test/build/venv 14:54:05 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 14:54:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:54:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:54:05 INFO - Using real prefix '/usr' 14:54:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:54:06 INFO - Installing distribute.............................................................................................................................................................................................done. 14:54:08 INFO - Installing pip.................done. 14:54:08 INFO - Return code: 0 14:54:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:54:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:54:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:54:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:54:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:54:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:08 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 0x7f61d5c2ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ceca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cbf60>, '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 0x29ccd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29cd1d0>, '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': '41bf3e9aed84707956354da8000001c5-1477000417.332948-828228526', '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 14:54:08 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 14:54:08 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 14:54:08 INFO - Using env: {'DISPLAY': ':0', 14:54:08 INFO - 'HOME': '/home/cltbld', 14:54:08 INFO - 'LANG': 'en_US.UTF-8', 14:54:08 INFO - 'LANGUAGE': 'en_US:en', 14:54:08 INFO - 'LOGNAME': 'cltbld', 14:54:08 INFO - 'MAIL': '/var/mail/cltbld', 14:54:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:54:08 INFO - 'MOZ_NO_REMOTE': '1', 14:54:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:54:08 INFO - 'NO_EM_RESTART': '1', 14:54:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:54:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:54:08 INFO - 'PWD': '/builds/slave/test', 14:54:08 INFO - 'SHELL': '/bin/bash', 14:54:08 INFO - 'SHLVL': '1', 14:54:08 INFO - 'TERM': 'linux', 14:54:08 INFO - 'TMOUT': '86400', 14:54:08 INFO - 'USER': 'cltbld', 14:54:08 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1477000417.332948-828228526', 14:54:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:54:08 INFO - '_': '/tools/buildbot/bin/python'} 14:54:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:54:08 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 14:54:08 INFO - Cleaning up... 14:54:08 INFO - Return code: 0 14:54:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:54:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:54:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:54:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:54:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:54:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:08 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 0x7f61d5c2ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ceca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cbf60>, '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 0x29ccd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29cd1d0>, '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': '41bf3e9aed84707956354da8000001c5-1477000417.332948-828228526', '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 14:54:08 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 14:54:08 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 14:54:08 INFO - Using env: {'DISPLAY': ':0', 14:54:08 INFO - 'HOME': '/home/cltbld', 14:54:08 INFO - 'LANG': 'en_US.UTF-8', 14:54:08 INFO - 'LANGUAGE': 'en_US:en', 14:54:08 INFO - 'LOGNAME': 'cltbld', 14:54:08 INFO - 'MAIL': '/var/mail/cltbld', 14:54:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:54:08 INFO - 'MOZ_NO_REMOTE': '1', 14:54:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:54:08 INFO - 'NO_EM_RESTART': '1', 14:54:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:54:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:54:08 INFO - 'PWD': '/builds/slave/test', 14:54:08 INFO - 'SHELL': '/bin/bash', 14:54:08 INFO - 'SHLVL': '1', 14:54:08 INFO - 'TERM': 'linux', 14:54:08 INFO - 'TMOUT': '86400', 14:54:08 INFO - 'USER': 'cltbld', 14:54:08 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1477000417.332948-828228526', 14:54:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:54:08 INFO - '_': '/tools/buildbot/bin/python'} 14:54:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:54:08 INFO - Downloading/unpacking psutil>=3.1.1 14:54:08 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 14:54:08 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 14:54:08 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 14:54:08 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 14:54:08 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 14:54:08 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 14:54:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:54:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:54:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:54:10 INFO - Installing collected packages: psutil 14:54:10 INFO - Running setup.py install for psutil 14:54:10 INFO - building 'psutil._psutil_linux' extension 14:54:10 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 14:54:11 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 14:54:11 INFO - building 'psutil._psutil_posix' extension 14:54:11 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 14:54:11 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 14:54:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:54:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:54:11 INFO - Successfully installed psutil 14:54:11 INFO - Cleaning up... 14:54:11 INFO - Return code: 0 14:54:11 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:54:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:54:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:54:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:54:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:54:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:11 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 0x7f61d5c2ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ceca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cbf60>, '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 0x29ccd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29cd1d0>, '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': '41bf3e9aed84707956354da8000001c5-1477000417.332948-828228526', '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 14:54:11 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 14:54:11 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 14:54:11 INFO - Using env: {'DISPLAY': ':0', 14:54:11 INFO - 'HOME': '/home/cltbld', 14:54:11 INFO - 'LANG': 'en_US.UTF-8', 14:54:11 INFO - 'LANGUAGE': 'en_US:en', 14:54:11 INFO - 'LOGNAME': 'cltbld', 14:54:11 INFO - 'MAIL': '/var/mail/cltbld', 14:54:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:54:11 INFO - 'MOZ_NO_REMOTE': '1', 14:54:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:54:11 INFO - 'NO_EM_RESTART': '1', 14:54:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:54:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:54:11 INFO - 'PWD': '/builds/slave/test', 14:54:11 INFO - 'SHELL': '/bin/bash', 14:54:11 INFO - 'SHLVL': '1', 14:54:11 INFO - 'TERM': 'linux', 14:54:11 INFO - 'TMOUT': '86400', 14:54:11 INFO - 'USER': 'cltbld', 14:54:11 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1477000417.332948-828228526', 14:54:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:54:11 INFO - '_': '/tools/buildbot/bin/python'} 14:54:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:54:11 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:54:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:54:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:54:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:54:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:54:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:54:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:54:13 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:54:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:54:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:54:13 INFO - Installing collected packages: mozsystemmonitor 14:54:13 INFO - Running setup.py install for mozsystemmonitor 14:54:13 INFO - Successfully installed mozsystemmonitor 14:54:13 INFO - Cleaning up... 14:54:13 INFO - Return code: 0 14:54:13 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:54:13 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')]} 14:54:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:54:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:13 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')]} 14:54:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:54:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:13 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 0x7f61d5c2ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ceca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cbf60>, '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 0x29ccd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29cd1d0>, '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': '41bf3e9aed84707956354da8000001c5-1477000417.332948-828228526', '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 14:54:13 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 14:54:13 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 14:54:13 INFO - Using env: {'DISPLAY': ':0', 14:54:13 INFO - 'HOME': '/home/cltbld', 14:54:13 INFO - 'LANG': 'en_US.UTF-8', 14:54:13 INFO - 'LANGUAGE': 'en_US:en', 14:54:13 INFO - 'LOGNAME': 'cltbld', 14:54:13 INFO - 'MAIL': '/var/mail/cltbld', 14:54:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:54:13 INFO - 'MOZ_NO_REMOTE': '1', 14:54:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:54:13 INFO - 'NO_EM_RESTART': '1', 14:54:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:54:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:54:13 INFO - 'PWD': '/builds/slave/test', 14:54:13 INFO - 'SHELL': '/bin/bash', 14:54:13 INFO - 'SHLVL': '1', 14:54:13 INFO - 'TERM': 'linux', 14:54:13 INFO - 'TMOUT': '86400', 14:54:13 INFO - 'USER': 'cltbld', 14:54:13 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1477000417.332948-828228526', 14:54:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:54:13 INFO - '_': '/tools/buildbot/bin/python'} 14:54:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:54:13 INFO - Downloading/unpacking jsonschema==2.5.1 14:54:13 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 14:54:13 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 14:54:13 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 14:54:13 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 14:54:13 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 14:54:13 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 14:54:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:54:15 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:54:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:54:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:54:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:54:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:54:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:54:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:54:16 INFO - Downloading functools32-3.2.3-2.tar.gz 14:54:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:54:16 INFO - warning: no files found matching '*.txt' 14:54:16 INFO - no previously-included directories found matching 'build' 14:54:16 INFO - no previously-included directories found matching 'dist' 14:54:16 INFO - no previously-included directories found matching '.git*' 14:54:16 INFO - Installing collected packages: jsonschema, functools32 14:54:16 INFO - Running setup.py install for functools32 14:54:16 INFO - warning: no files found matching '*.txt' 14:54:16 INFO - no previously-included directories found matching 'build' 14:54:16 INFO - no previously-included directories found matching 'dist' 14:54:16 INFO - no previously-included directories found matching '.git*' 14:54:16 INFO - Successfully installed jsonschema functools32 14:54:16 INFO - Cleaning up... 14:54:16 INFO - Return code: 0 14:54:16 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:54:16 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')]} 14:54:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:54:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:16 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')]} 14:54:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:54:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:16 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 0x7f61d5c2ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ceca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cbf60>, '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 0x29ccd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29cd1d0>, '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': '41bf3e9aed84707956354da8000001c5-1477000417.332948-828228526', '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 14:54:16 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 14:54:16 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 14:54:16 INFO - Using env: {'DISPLAY': ':0', 14:54:16 INFO - 'HOME': '/home/cltbld', 14:54:16 INFO - 'LANG': 'en_US.UTF-8', 14:54:16 INFO - 'LANGUAGE': 'en_US:en', 14:54:16 INFO - 'LOGNAME': 'cltbld', 14:54:16 INFO - 'MAIL': '/var/mail/cltbld', 14:54:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:54:16 INFO - 'MOZ_NO_REMOTE': '1', 14:54:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:54:16 INFO - 'NO_EM_RESTART': '1', 14:54:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:54:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:54:16 INFO - 'PWD': '/builds/slave/test', 14:54:16 INFO - 'SHELL': '/bin/bash', 14:54:16 INFO - 'SHLVL': '1', 14:54:16 INFO - 'TERM': 'linux', 14:54:16 INFO - 'TMOUT': '86400', 14:54:16 INFO - 'USER': 'cltbld', 14:54:16 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1477000417.332948-828228526', 14:54:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:54:16 INFO - '_': '/tools/buildbot/bin/python'} 14:54:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:54:16 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:54:16 INFO - Cleaning up... 14:54:16 INFO - Return code: 0 14:54:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:54:16 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')]} 14:54:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:54:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:16 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')]} 14:54:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:54:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:16 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 0x7f61d5c2ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ceca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cbf60>, '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 0x29ccd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29cd1d0>, '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': '41bf3e9aed84707956354da8000001c5-1477000417.332948-828228526', '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 14:54:16 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 14:54:16 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 14:54:16 INFO - Using env: {'DISPLAY': ':0', 14:54:16 INFO - 'HOME': '/home/cltbld', 14:54:16 INFO - 'LANG': 'en_US.UTF-8', 14:54:16 INFO - 'LANGUAGE': 'en_US:en', 14:54:16 INFO - 'LOGNAME': 'cltbld', 14:54:16 INFO - 'MAIL': '/var/mail/cltbld', 14:54:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:54:16 INFO - 'MOZ_NO_REMOTE': '1', 14:54:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:54:16 INFO - 'NO_EM_RESTART': '1', 14:54:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:54:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:54:16 INFO - 'PWD': '/builds/slave/test', 14:54:16 INFO - 'SHELL': '/bin/bash', 14:54:16 INFO - 'SHLVL': '1', 14:54:16 INFO - 'TERM': 'linux', 14:54:16 INFO - 'TMOUT': '86400', 14:54:16 INFO - 'USER': 'cltbld', 14:54:16 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1477000417.332948-828228526', 14:54:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:54:16 INFO - '_': '/tools/buildbot/bin/python'} 14:54:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:54:16 INFO - Downloading/unpacking blobuploader==1.2.4 14:54:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:54:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:54:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:54:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:54:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:54:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:54:18 INFO - Downloading blobuploader-1.2.4.tar.gz 14:54:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:54:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:54:18 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 14:54:18 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 14:54:18 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 14:54:18 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 14:54:18 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 14:54:18 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 14:54:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:54:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:54:19 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 14:54:19 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 14:54:19 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 14:54:19 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 14:54:19 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 14:54:19 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 14:54:19 INFO - Downloading docopt-0.6.1.tar.gz 14:54:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:54:19 INFO - Installing collected packages: blobuploader, requests, docopt 14:54:19 INFO - Running setup.py install for blobuploader 14:54:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:54:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:54:19 INFO - Running setup.py install for requests 14:54:20 INFO - Running setup.py install for docopt 14:54:20 INFO - Successfully installed blobuploader requests docopt 14:54:20 INFO - Cleaning up... 14:54:20 INFO - Return code: 0 14:54:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:54:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:54:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:54:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:54:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:54:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:20 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 0x7f61d5c2ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ceca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cbf60>, '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 0x29ccd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29cd1d0>, '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': '41bf3e9aed84707956354da8000001c5-1477000417.332948-828228526', '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 14:54:20 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 14:54:20 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 14:54:20 INFO - Using env: {'DISPLAY': ':0', 14:54:20 INFO - 'HOME': '/home/cltbld', 14:54:20 INFO - 'LANG': 'en_US.UTF-8', 14:54:20 INFO - 'LANGUAGE': 'en_US:en', 14:54:20 INFO - 'LOGNAME': 'cltbld', 14:54:20 INFO - 'MAIL': '/var/mail/cltbld', 14:54:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:54:20 INFO - 'MOZ_NO_REMOTE': '1', 14:54:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:54:20 INFO - 'NO_EM_RESTART': '1', 14:54:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:54:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:54:20 INFO - 'PWD': '/builds/slave/test', 14:54:20 INFO - 'SHELL': '/bin/bash', 14:54:20 INFO - 'SHLVL': '1', 14:54:20 INFO - 'TERM': 'linux', 14:54:20 INFO - 'TMOUT': '86400', 14:54:20 INFO - 'USER': 'cltbld', 14:54:20 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1477000417.332948-828228526', 14:54:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:54:20 INFO - '_': '/tools/buildbot/bin/python'} 14:54:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:54:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:54:20 INFO - Running setup.py (path:/tmp/pip-XslX1J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:54:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:54:20 INFO - Running setup.py (path:/tmp/pip-qxn9Nh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:54:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:54:20 INFO - Running setup.py (path:/tmp/pip-Mq1T4I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:54:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:54:20 INFO - Running setup.py (path:/tmp/pip-cyoZHq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:54:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:54:20 INFO - Running setup.py (path:/tmp/pip-sO1G50-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:54:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:54:20 INFO - Running setup.py (path:/tmp/pip-svlNBn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:54:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:54:20 INFO - Running setup.py (path:/tmp/pip-qC9qF0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:54:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:54:21 INFO - Running setup.py (path:/tmp/pip-JwFy8m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:54:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:54:21 INFO - Running setup.py (path:/tmp/pip-9DJ8Qn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:54:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:54:21 INFO - Running setup.py (path:/tmp/pip-TGxfr4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:54:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:54:21 INFO - Running setup.py (path:/tmp/pip-8pM7ys-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:54:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:54:21 INFO - Running setup.py (path:/tmp/pip-f0vbNv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:54:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:54:21 INFO - Running setup.py (path:/tmp/pip-ySHlxE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:54:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:54:21 INFO - Running setup.py (path:/tmp/pip-F4VTsv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:54:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:54:21 INFO - Running setup.py (path:/tmp/pip-W2iwmG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:54:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:54:21 INFO - Running setup.py (path:/tmp/pip-MMcLKz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:54:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:54:21 INFO - Running setup.py (path:/tmp/pip-L633Pl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:54:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:54:21 INFO - Running setup.py install for manifestparser 14:54:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:54:21 INFO - Running setup.py install for mozcrash 14:54:21 INFO - Running setup.py install for mozdebug 14:54:22 INFO - Running setup.py install for mozdevice 14:54:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:54:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:54:22 INFO - Running setup.py install for mozfile 14:54:22 INFO - Running setup.py install for mozhttpd 14:54:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:54:22 INFO - Running setup.py install for mozinfo 14:54:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:54:22 INFO - Running setup.py install for mozInstall 14:54:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:54:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:54:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:54:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:54:22 INFO - Running setup.py install for mozleak 14:54:22 INFO - Running setup.py install for mozlog 14:54:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:54:22 INFO - Running setup.py install for moznetwork 14:54:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:54:22 INFO - Running setup.py install for mozprocess 14:54:22 INFO - Running setup.py install for mozprofile 14:54:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:54:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:54:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:54:23 INFO - Running setup.py install for mozrunner 14:54:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:54:23 INFO - Running setup.py install for mozscreenshot 14:54:23 INFO - Running setup.py install for moztest 14:54:23 INFO - Running setup.py install for mozversion 14:54:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:54:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:54:23 INFO - Cleaning up... 14:54:23 INFO - Return code: 0 14:54:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:54:23 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')]} 14:54:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:54:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:23 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')]} 14:54:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:54:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:23 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 0x7f61d5c2ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ceca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cbf60>, '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 0x29ccd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29cd1d0>, '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': '41bf3e9aed84707956354da8000001c5-1477000417.332948-828228526', '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 14:54:23 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 14:54:23 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 14:54:23 INFO - Using env: {'DISPLAY': ':0', 14:54:23 INFO - 'HOME': '/home/cltbld', 14:54:23 INFO - 'LANG': 'en_US.UTF-8', 14:54:23 INFO - 'LANGUAGE': 'en_US:en', 14:54:23 INFO - 'LOGNAME': 'cltbld', 14:54:23 INFO - 'MAIL': '/var/mail/cltbld', 14:54:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:54:23 INFO - 'MOZ_NO_REMOTE': '1', 14:54:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:54:23 INFO - 'NO_EM_RESTART': '1', 14:54:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:54:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:54:23 INFO - 'PWD': '/builds/slave/test', 14:54:23 INFO - 'SHELL': '/bin/bash', 14:54:23 INFO - 'SHLVL': '1', 14:54:23 INFO - 'TERM': 'linux', 14:54:23 INFO - 'TMOUT': '86400', 14:54:23 INFO - 'USER': 'cltbld', 14:54:23 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1477000417.332948-828228526', 14:54:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:54:23 INFO - '_': '/tools/buildbot/bin/python'} 14:54:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:54:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:54:23 INFO - Running setup.py (path:/tmp/pip-FjUAOt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:54:23 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)) 14:54:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:54:23 INFO - Running setup.py (path:/tmp/pip-WGluaE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:54:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 14:54:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:54:23 INFO - Running setup.py (path:/tmp/pip-IWPqI4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:54:23 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)) 14:54:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:54:23 INFO - Running setup.py (path:/tmp/pip-GwuA3l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:54:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 14:54:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:54:24 INFO - Running setup.py (path:/tmp/pip-ARecxx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:54:24 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)) 14:54:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:54:24 INFO - Running setup.py (path:/tmp/pip-YeO0mC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:54:24 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)) 14:54:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:54:24 INFO - Running setup.py (path:/tmp/pip-XOexcF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:54:24 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)) 14:54:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:54:24 INFO - Running setup.py (path:/tmp/pip-WqPUeO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:54:24 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)) 14:54:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:54:24 INFO - Running setup.py (path:/tmp/pip-HNrfD7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:54:24 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)) 14:54:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:54:24 INFO - Running setup.py (path:/tmp/pip-UbfhWX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:54:24 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)) 14:54:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:54:24 INFO - Running setup.py (path:/tmp/pip-OiZwtq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:54:24 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)) 14:54:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:54:24 INFO - Running setup.py (path:/tmp/pip-6XK764-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:54:24 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)) 14:54:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:54:24 INFO - Running setup.py (path:/tmp/pip-J8XkQ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:54:24 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)) 14:54:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:54:24 INFO - Running setup.py (path:/tmp/pip-OrHbEa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:54:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 14:54:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:54:24 INFO - Running setup.py (path:/tmp/pip-VWy1Wb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:54:24 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)) 14:54:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:54:24 INFO - Running setup.py (path:/tmp/pip-jyw8hB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:54:24 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)) 14:54:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:54:24 INFO - Running setup.py (path:/tmp/pip-MJXrET-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:54:24 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)) 14:54:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:54:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:54:24 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)) 14:54:24 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:54:24 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:54:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:54:24 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 14:54:24 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 14:54:24 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 14:54:24 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 14:54:24 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 14:54:24 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 14:54:26 INFO - Downloading blessings-1.6.tar.gz 14:54:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:54:26 INFO - Installing collected packages: blessings 14:54:26 INFO - Running setup.py install for blessings 14:54:27 INFO - Successfully installed blessings 14:54:27 INFO - Cleaning up... 14:54:27 INFO - Return code: 0 14:54:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:54:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:54:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:54:27 INFO - Reading from file tmpfile_stdout 14:54:27 INFO - Current package versions: 14:54:27 INFO - argparse == 1.2.1 14:54:27 INFO - blessings == 1.6 14:54:27 INFO - blobuploader == 1.2.4 14:54:27 INFO - docopt == 0.6.1 14:54:27 INFO - functools32 == 3.2.3-2 14:54:27 INFO - jsonschema == 2.5.1 14:54:27 INFO - manifestparser == 1.1 14:54:27 INFO - mozInstall == 1.12 14:54:27 INFO - mozcrash == 0.17 14:54:27 INFO - mozdebug == 0.1 14:54:27 INFO - mozdevice == 0.48 14:54:27 INFO - mozfile == 1.2 14:54:27 INFO - mozhttpd == 0.7 14:54:27 INFO - mozinfo == 0.9 14:54:27 INFO - mozleak == 0.1 14:54:27 INFO - mozlog == 3.4 14:54:27 INFO - moznetwork == 0.27 14:54:27 INFO - mozprocess == 0.23 14:54:27 INFO - mozprofile == 0.28 14:54:27 INFO - mozrunner == 6.12 14:54:27 INFO - mozscreenshot == 0.1 14:54:27 INFO - mozsystemmonitor == 0.3 14:54:27 INFO - moztest == 0.7 14:54:27 INFO - mozversion == 1.4 14:54:27 INFO - psutil == 3.1.1 14:54:27 INFO - requests == 1.2.3 14:54:27 INFO - wsgiref == 0.1.2 14:54:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:54: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')]} 14:54:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:54:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54: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')]} 14:54:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:54:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:27 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 0x7f61d5c2ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ceca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cbf60>, '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 0x29ccd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29cd1d0>, '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': '41bf3e9aed84707956354da8000001c5-1477000417.332948-828228526', '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 14:54:27 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 14:54:27 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 14:54:27 INFO - Using env: {'DISPLAY': ':0', 14:54:27 INFO - 'HOME': '/home/cltbld', 14:54:27 INFO - 'LANG': 'en_US.UTF-8', 14:54:27 INFO - 'LANGUAGE': 'en_US:en', 14:54:27 INFO - 'LOGNAME': 'cltbld', 14:54:27 INFO - 'MAIL': '/var/mail/cltbld', 14:54:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:54:27 INFO - 'MOZ_NO_REMOTE': '1', 14:54:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:54:27 INFO - 'NO_EM_RESTART': '1', 14:54:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:54:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:54:27 INFO - 'PWD': '/builds/slave/test', 14:54:27 INFO - 'SHELL': '/bin/bash', 14:54:27 INFO - 'SHLVL': '1', 14:54:27 INFO - 'TERM': 'linux', 14:54:27 INFO - 'TMOUT': '86400', 14:54:27 INFO - 'USER': 'cltbld', 14:54:27 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1477000417.332948-828228526', 14:54:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:54:27 INFO - '_': '/tools/buildbot/bin/python'} 14:54:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:54:27 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)) 14:54:27 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)) 14:54:27 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)) 14:54:27 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)) 14:54:27 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)) 14:54:27 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)) 14:54:27 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)) 14:54:27 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)) 14:54:27 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)) 14:54:27 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)) 14:54:27 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)) 14:54:27 INFO - Cleaning up... 14:54:27 INFO - Return code: 0 14:54:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:54: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')]} 14:54:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:54:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54: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')]} 14:54:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:54:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54: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']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f61d5c2ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ceca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cbf60>, '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 0x29ccd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29cd1d0>, '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': '41bf3e9aed84707956354da8000001c5-1477000417.332948-828228526', '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 14:54: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'] in /builds/slave/test/build 14:54: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 14:54:27 INFO - Using env: {'DISPLAY': ':0', 14:54:27 INFO - 'HOME': '/home/cltbld', 14:54:27 INFO - 'LANG': 'en_US.UTF-8', 14:54:27 INFO - 'LANGUAGE': 'en_US:en', 14:54:27 INFO - 'LOGNAME': 'cltbld', 14:54:27 INFO - 'MAIL': '/var/mail/cltbld', 14:54:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:54:27 INFO - 'MOZ_NO_REMOTE': '1', 14:54:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:54:27 INFO - 'NO_EM_RESTART': '1', 14:54:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:54:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:54:27 INFO - 'PWD': '/builds/slave/test', 14:54:27 INFO - 'SHELL': '/bin/bash', 14:54:27 INFO - 'SHLVL': '1', 14:54:27 INFO - 'TERM': 'linux', 14:54:27 INFO - 'TMOUT': '86400', 14:54:27 INFO - 'USER': 'cltbld', 14:54:27 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1477000417.332948-828228526', 14:54:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:54:27 INFO - '_': '/tools/buildbot/bin/python'} 14:54:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:54:27 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:54:27 INFO - Cleaning up... 14:54:27 INFO - Return code: 0 14:54:27 INFO - Running post-action listener: _resource_record_post_action 14:54:27 INFO - Running post-action listener: _start_resource_monitoring 14:54:27 INFO - Starting resource monitoring. 14:54:27 INFO - [mozharness: 2016-10-20 21:54:27.841459Z] Finished create-virtualenv step (success) 14:54:27 INFO - [mozharness: 2016-10-20 21:54:27.841911Z] Running install step. 14:54:27 INFO - Running pre-action listener: _resource_record_pre_action 14:54:27 INFO - Running main action method: install 14:54:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:54:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:54:28 INFO - Reading from file tmpfile_stdout 14:54:28 INFO - Detecting whether we're running mozinstall >=1.0... 14:54:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:54:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:54:28 INFO - Reading from file tmpfile_stdout 14:54:28 INFO - Output received: 14:54:28 INFO - Usage: mozinstall [options] installer 14:54:28 INFO - Options: 14:54:28 INFO - -h, --help show this help message and exit 14:54:28 INFO - -d DEST, --destination=DEST 14:54:28 INFO - Directory to install application into. [default: 14:54:28 INFO - "/builds/slave/test"] 14:54:28 INFO - --app=APP Application being installed. [default: firefox] 14:54:28 INFO - mkdir: /builds/slave/test/build/application 14:54:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 14:54:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 14:54:44 INFO - Reading from file tmpfile_stdout 14:54:44 INFO - Output received: 14:54:44 INFO - /builds/slave/test/build/application/firefox/firefox 14:54:44 INFO - Running post-action listener: _resource_record_post_action 14:54:44 INFO - [mozharness: 2016-10-20 21:54:44.101454Z] Finished install step (success) 14:54:44 INFO - [mozharness: 2016-10-20 21:54:44.101698Z] Running run-tests step. 14:54:44 INFO - Running pre-action listener: _resource_record_pre_action 14:54:44 INFO - Running main action method: run_tests 14:54:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:54:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:54:44 INFO - Python 2.7.3 14:54:44 INFO - Return code: 0 14:54:44 INFO - grabbing minidump binary from tooltool 14:54:44 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')]} 14:54:44 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 0x29cbf60>, '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 0x29ccd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29cd1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:54:44 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 14:54:44 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 14:54:44 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 14:54:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:54:44 INFO - Return code: 0 14:54:44 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:54:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:54:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:54:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:54:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:54:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XdK-4iWJQrCE0i9krD_J3A/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 14:54:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XdK-4iWJQrCE0i9krD_J3A/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-026 --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 14:54:44 INFO - Using env: {'DISPLAY': ':0', 14:54:44 INFO - 'HOME': '/home/cltbld', 14:54:44 INFO - 'LANG': 'en_US.UTF-8', 14:54:44 INFO - 'LANGUAGE': 'en_US:en', 14:54:44 INFO - 'LOGNAME': 'cltbld', 14:54:44 INFO - 'MAIL': '/var/mail/cltbld', 14:54:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:54:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:54:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:54:44 INFO - 'MOZ_NO_REMOTE': '1', 14:54:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:54:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:54:44 INFO - 'NO_EM_RESTART': '1', 14:54:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:54:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:54:44 INFO - 'PWD': '/builds/slave/test', 14:54:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:54:44 INFO - 'SHELL': '/bin/bash', 14:54:44 INFO - 'SHLVL': '1', 14:54:44 INFO - 'TERM': 'linux', 14:54:44 INFO - 'TMOUT': '86400', 14:54:44 INFO - 'USER': 'cltbld', 14:54:44 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1477000417.332948-828228526', 14:54:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:54:44 INFO - '_': '/tools/buildbot/bin/python'} 14:54:44 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XdK-4iWJQrCE0i9krD_J3A/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 14:54:44 INFO - mozversion application_buildid: 20161020114750 14:54:44 INFO - mozversion application_changeset: 44754fcbce505bb509c290657231d65918f819af 14:54:44 INFO - mozversion application_display_name: FirefoxDeveloperEdition 14:54:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:54:44 INFO - mozversion application_name: Firefox 14:54:44 INFO - mozversion application_remotingname: firefox-dev 14:54:44 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:54:44 INFO - mozversion application_vendor: Mozilla 14:54:44 INFO - mozversion application_version: 51.0a2 14:54:44 INFO - mozversion platform_buildid: 20161020114750 14:54:44 INFO - mozversion platform_changeset: 44754fcbce505bb509c290657231d65918f819af 14:54:44 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:54:44 INFO - mozversion platform_version: 51.0a2 14:54:44 INFO - using testdate: 1477000484 14:54:44 INFO - actual date: 1477000484 14:54:44 INFO - starting webserver on 'localhost:41628' 14:54:44 INFO - SUITE-START | Running 2 tests 14:54:44 INFO - TEST-START | dromaeo_css 14:54:44 INFO - operating with platform_type : linux_ 14:54:44 INFO - Initialising browser for dromaeo_css test... 14:54:44 INFO - TEST-INFO | started process 21209 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnF5T6j/profile http://localhost:41628/getInfo.html) 14:54:48 INFO - PROCESS | 21209 | __metrics Screen width/height:1600/1200 14:54:48 INFO - PROCESS | 21209 | colorDepth:24 14:54:48 INFO - PROCESS | 21209 | Browser inner width/height: 1024/697 14:54:48 INFO - PROCESS | 21209 | __metrics 14:54:48 INFO - PROCESS | 21209 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:54:48 INFO - PROCESS | 21209 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:54:49 INFO - PROCESS | 21209 | console.error: PushService: 14:54:49 INFO - PROCESS | 21209 | stateChangeProcessEnqueue: Error transitioning state 14:54:49 INFO - PROCESS | 21209 | UnknownError 14:54:50 INFO - TEST-INFO | 21209: exit 0 14:54:50 INFO - Browser initialized. 14:54:50 INFO - Running cycle 1/1 for dromaeo_css test... 14:54:50 INFO - TEST-INFO | started process 21303 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnF5T6j/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:55:01 INFO - PROCESS | 21303 | RSS: Main: 144576512 14:55:01 INFO - PROCESS | 21303 | 14:55:52 INFO - PROCESS | 21303 | 1477000552987 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] 14:58:01 INFO - PROCESS | 21303 | Cycle 1(1): loaded http://localhost:41628/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41628/tests/dromaeo/cssquery-ext.html) 14:58:02 INFO - PROCESS | 21303 | RSS: Main: 241467392 14:58:02 INFO - PROCESS | 21303 | 15:01:05 INFO - PROCESS | 21303 | Cycle 1(1): loaded http://localhost:41628/tests/dromaeo/cssquery-ext.html (next: http://localhost:41628/tests/dromaeo/cssquery-jquery.html) 15:01:05 INFO - PROCESS | 21303 | RSS: Main: 230653952 15:01:05 INFO - PROCESS | 21303 | 15:04:07 INFO - PROCESS | 21303 | Cycle 1(1): loaded http://localhost:41628/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41628/tests/dromaeo/cssquery-mootools.html) 15:04:08 INFO - PROCESS | 21303 | RSS: Main: 174383104 15:04:08 INFO - PROCESS | 21303 | 15:07:10 INFO - PROCESS | 21303 | Cycle 1(1): loaded http://localhost:41628/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41628/tests/dromaeo/cssquery-prototype.html) 15:07:10 INFO - PROCESS | 21303 | RSS: Main: 221519872 15:07:10 INFO - PROCESS | 21303 | 15:10:13 INFO - PROCESS | 21303 | Cycle 1(1): loaded http://localhost:41628/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41628/tests/dromaeo/cssquery-yui.html) 15:10:14 INFO - PROCESS | 21303 | RSS: Main: 178065408 15:10:14 INFO - PROCESS | 21303 | 15:13:16 INFO - PROCESS | 21303 | Cycle 1(1): loaded http://localhost:41628/tests/dromaeo/cssquery-yui.html (next: http://localhost:41628/tests/dromaeo/cssquery-dojo.html) 15:13:16 INFO - PROCESS | 21303 | RSS: Main: 269975552 15:13:16 INFO - PROCESS | 21303 | 15:13:16 INFO - PROCESS | 21303 | __start_tp_report 15:13:16 INFO - PROCESS | 21303 | _x_x_mozilla_page_load 15:13:16 INFO - PROCESS | 21303 | _x_x_mozilla_page_load_details 15:13:16 INFO - PROCESS | 21303 | |i|pagename|runs| 15:13:16 INFO - PROCESS | 21303 | |0;dojo.html;3108.2540190354316;3152.4956007038872;3159.0838656789533;3177.793443426179;3194.6965038321364;5480.671159730414;5511.145772405273;5548.140038294061;5553.555715542757;5567.415421380758;5639.125935479997;5681.744321505532;5690.321355200215;5723.627964182325;5739.827805165842;5094.974525127378;5141.228815677641;5171.0692075426405;5176.5082317179995;5206.843794686166;4946.109700253953;4975.9004819903585;5160.329157209576;5212.50481204285;5215.113430716788;5051.06555287273;5059.11465493539;5070.822521211759;5099.515546023141;5104.974475127638;5129.0767661820855;5136.794528218867;5221.034108689904;5224.947750522484;5240.292560504359;4810.134175848346;5113.360829896263;5141.331626888481;5188.7146206958605;5202.661826981272;5359.249705041298;5481.972590137024;5516.448355164492;5526.364468086182;5565.638233514808;5916.437938395846;5921;6039;6042.879142417171;6049.062395328687;5734.856628584277;6052.9697351513405;6065.4844338231305;6067.939320606782;6077.179580756586;5404.189371594253;5533.280673512418;5584.888302233973;5593.07714227148;5596.384397716248;6157.96921015392;6167.938320616737;6168.1056246843955;6169.198004259507;6179.073139029092;5665.405132461115;5903.468687818117;5913.940860591339;5919.496842768327;5929.851753706105;5793.913091303634;5822.7088645567555;5874.089516125007;5878.088896221093;5975.133605627159;5898.557608179318;5908.586398952032;5913.172155898178;5916.319623243296;5916.881662366814;5871.853203669943;5927;5931.08068249422;5931.73307201177;5953.22608060958;4285.657147428261;4320.978395108004;4325.1565944641125;4342.956570434255;4350.630196433339;3922.627350401707;3932.193900250442;3949.3681011038097;3961.088949541622;3966.8099570129425;5660.85847853807;5663.008973429633;5666.036773748473;5667.348254950651;5667.631603945731;5748.798792042258;5799.130130480462;5866.208061911672;5998.310194327621;6002.54980876436;5533.529649979716;5583.720813959286;5593.440655934455;5623.0159722048475;5630;5015.4733752956145;5045.041442125985;5052.1663925451885;5056.82301119459;5084.745762711849;5933.940660593339;5950.523958083257;6128.540359473057;6176.505879529627;6181.5363847710705;5805.41945805433;5822.621529600562;5856.736446859816;5898.528117750656;5936.37668044849;6085.026395776655;6093.116498107838;6096.603720758314;6099.207103076572;6102.359252278625;5640.943590564042;5790.971045144747;5791.218185545066;5801.94198058014;5803.535717142534;5805.76776928935;5902.055671092605;5949.553783466344;5974.761009559569;6064.696765161812;5853.2976042875125;5854.9121763174435;5897.085951677497;5897.557683173865;5898.675572843535;5813.651180929158;5888.970555147197;5890.7349169288345;5892.94107058924;5893.027650437802;5564.360098588552;5616.4383561645145;5685.800996965252;5703.344115426779;5745.971270143623;5844.590878638454;5859.267591551056;5862.94137058641;5869.442402971711;5894.056950887837;5499.615026948075;5703.230063941315;5703.657780533182;5709.25779648643;5719.942800572107 15:13:16 INFO - PROCESS | 21303 | |1;ext.html;595.7497850902623;625.2465778736623;651.3388910256087;655.1842955520381;656.5076192855358;35539.46690799637;36291;46458.5354146458;47418.52581474184;47506.287405688854;47378;47744.283835742404;47789.28316075253;47800.76099619497;47817.76091119539;9410.341276110657;9567.904320956806;9572.42565446072;9573.282003849705;9578.856317155249;8610.612522436473;8823.95588022059;9412.199963003153;10986.352047192906;11329.773404531945;11461.31232126071;11540.249883757571;11550.36472993985;11599.478023488964;11666.125040621988;11459;11468;11526.88473115275;11534.307941523535;11538.769224615502;8486.957565212197;8743.475391476468;10914.181436392302;11254.54981800727;11261.943690281578;46861.297080543816;47358;47366.526334736904;47403.28895066577;47442;3834.194819087995;4046.3728122141115;4214.620684138442;4267.146570685875;4571.9314210286875;35640.28719425597;36128.458073128924;36135.4579681305;36446.63553364459;37540;4648.372469716613;4691.765411729434;4748.216544270192;4753.144434001878;4776.785044672998;380157;382297;382697;382896;383157;60357;66050;66170;66550.33449665441;66623.33376666268;68486.65756671184;68575;68649.65675171593;68725.31274687289;68755.65622171958;19338;20020.199192032447;20074.498137546678;20081.497962550762;20089.799102008794;13520.526781562598;15310.923445382925;15375.538733838002;15378.1542015188;15396.61508462275;16943.23755430984;18750.81249187518;18933;19374.225030998885;20013.199472021246;6565.310642382481;6646.102776125162;6666;6743.561668491532;6784.219814721271;1034.8551202831609;1060.1669515246;1137.2891942535914;1144.3820337017917;1160.0893298760432;35240.11899702528;35380.64619353825;35442.46836297458;35572.64427355745;35660.64339356625;1203.9939800301117;1232.5870833270956;1242.136714983078;1251.974960500803;1291.044626976031;18303;18375.54061148482;18455.446336609923;18519;18564.535886602942;547680;551791;551795;552673;553035;64628;64818.67590662016;64825.675871621286;64862.675686622206;64908;1312;1354.119822115613;1382.2121390807145;1401.3973991183684;1431.806706094664;32872.34255314928;35665.64334356727;35901.64098359088;36025.63974360328;36142.277154456235;56699.149512758166;57185.71407142938;57259.713701431225;57383.42616573781;57457.42542574688;404919;405205;407781;407920;408802;28617.713822861504;29365.26586835346;29439.705602944552;30817.383652326378;46580.30129547992;49815.75092124516;50210.24684629807;50492;50498.74750626223;50852.74573627256;42255;42371.7881410591;42713;42761.57238427576;44210.55789442064;41776.79111604422;42015.159696806506;43201;43278;44214.557854421044;40470.392944106454;40749.185016298914;40820;41306.793466032475;43306.35040474332;34999;37343.253134937695;37825.81087094547;38000;38028.61971380251;27338.589921151597;28394.945443909564;28548.572571371762;28764.712352876202;29026.564601530572 15:13:16 INFO - PROCESS | 21303 | |2;jquery.html;396.2036307022883;426.1158096948831;434.12956054072373;434.78478153314114;436.8776742512098;16675.332986680532;20014.799852001477;21665.458363540918;22000.797527664272;22138.557228855414;20735.585288294224;21223.151073957022;21258.46853828655;21311.25410610629;21366.145354185814;5450.672959622416;5897.144913987469;5973.910391344133;6242.157308763327;6243.094751261065;6099.054646529773;6197.969010154966;6221.657808820513;6232.937670623303;6249.406306400884;5998.370171132034;6187.876242475148;6192.535559833031;6251.031090181029;6291.685415729218;6177.413145751147;6318.684065796715;6354;6358.237011558596;6360.522960777914;6161.537884658668;6199.163112979735;6205;6206.72069756862;6206.937930620681;15240.923795381063;15251.161186134757;15321.540353789404;15470.071795692294;15598.844011559853;2457.4225057111744;2496.500699860035;2509.0967251789343;2560.1679454177465;2642.8017898657486;10806.351618902812;10837.349759014405;11013.669589912315;11268.605598804003;11715.472803723767;1992.4919145617919;2001.7998200179866;2060.6599911014664;2062.618415593105;2127.1704035426196;90878;91729;94326;95559;96538.51730741371;10489.790204195873;11963.76072478563;12057.457414416373;12062.638120856389;12112.697182570506;15756.527304180892;16260;16525.421610243582;16537.090460024814;17180;8998.235150012322;9251.629934802668;9258.120478554527;9337.112974267433;9379.155875971195;8873.822523549492;9003.279737620975;9050.818983620422;9271.211946984447;9374.296927730447;5043.899122017539;5052.9242061369105;5213.60897932649;5226.085435048852;5352.892942141136;2092.257248676728;2128.7658357580654;2142.346584291806;2149.1188612669043;2153.267888917744;891.7012800711705;963.8265112279857;1002.1832206751474;1008.742770593494;1021.1881554164457;20828.47928801792;21092.894535527223;21127.154913803584;21144.154233830475;21218;501.3282201849539;525.8737902903275;1060.7719340341864;1066.589363095214;1070.6937536205817;6710.630915299607;6715.227748808852;6857.55425897315;7010.088688470568;7018;613991;627614;630866;631525;634320;104446;105409.47295263475;106357.46821265844;108318.45840770745;110710.44644776724;448.31631761563875;516.857864087379;523.1394356283892;525.0758664750067;526.6839896062409;10498.47507624631;12034.819477708017;12265.325407102695;12581.370931453574;12673.93663031679;46637;46935.29597055978;47730;47936.5206347932;48378.274325884435;63650;63678;63710.36289637044;64720;66070;8827.337949653931;8998.325125615736;9031.27749780029;9125;9356.204722598382;13627.863721362659;13793.86206137966;13804.792928105886;13893.652658683613;13997.300134993413;12289.201201921847;12446.377681115728;12448.937755311166;12459.875401245872;12559.497620095459;6344.873102537831;8960.1935825776;11456.140789440658;11717.531298747954;11863.644090677293;12272.693182670148;12671;12677.429515672002;12794.912432442974;12956.8056479151;9299.72100836976;9316.161545460942;9373.109554592304;9435.952820235854;9569.449719162729;11303.886961130613;12511.687207819514;12721.173123746927;12834;12884.806727899277 15:13:16 INFO - PROCESS | 21303 | |3;mootools.html;1544.1275679241228;1577.5188567486916;1755.7366395040742;1861.3578315481154;1872.3914727713498;8766.342524310678;9389.530523473815;9394.953025234881;9400.059994000614;9404.670836520723;8260.710875119372;8469.66121355145;8475.491470511774;8693.174148455886;9215.216706579931;2352.411897025739;2427.332483567024;2428.3079322393123;2456.3736247256925;2463.4334103156284;2429.0526694589125;2455.226603619854;2456.2140115163156;2461.5815311397105;2493.4265119022634;2433.6957880264968;2433.9391515212083;2436.8172387070954;2437.3784684905413;2476.9752302476923;2401.075585899424;2408.5303365843665;2411.987940060297;2419.334682962182;2421.878906054708;2398.9760102398927;2426.3206302235403;2426.7815896569396;2431.258466167818;2432.1852179519883;9366.157045865837;9388.483633400161;9428.952855235748;9522.619095236252;9539.284553658434;5425.050616142199;5560.332760068777;5568.582356323292;5578.44215578443;5589.385167631557;3404.3531728971416;3519.8592056317716;3623.0942264433893;3630.965174925134;3663.835127419246;1279.3219593615306;1297.2929753284482;1333.6132521568734;1335.1121504199696;2185.846990710651;12671.683207919783;13121.86878131216;13136.277504737236;13143.474261029547;13159;4668.393108895822;4745.738984355894;4748.857534273978;4851.442084160296;4943.530364615356;9850.064243896819;9855.359401639014;9858.901410985942;9864.654737084167;9867.40795552269;5453.563714902798;5455.0453670607485;5455.8363249102595;5461.972690136524;5465.234867118606;5000.349954505891;5060.822871199491;5087.033463641897;5091.541761241506;5118.718470484085;3903.1413089120347;3943.4873466449176;3964.345882929342;4017.799110044486;4023.3562629979065;1175.0893057880041;1176.9352685602373;1195.0738177912187;1196.8683444821063;1208.1542919956066;1010.8635334229932;1017.29298137795;1069.4652673663168;1072.7157303314627;1077.8652668416448;6332.620042797447;6408.953699894453;6463;6636.502262330248;6745.561538499982;488.92666100085273;493.5927859515914;499.4805402381555;514.6567458932184;515.2142981952552;4431.7916461720915;4595.310703394451;4600.838970636079;4621.075784843045;4634.351190833286;11395.145364097725;11657.475413606408;11684.88315116838;11709.590164344207;11710.94144529272;11639.709007274716;11675.299482031105;11684.70788230301;11700.824487632692;11707.356095414663;8396.160383961676;8681.088485709037;8693.043765185825;8693.782655433664;8747.737567872973;6239.126522286792;6426.935730642821;6658.83352916181;6784.93215067843;6874.8625027500175;10529.36823790575;10689.625863094754;10900.07349375312;11034.724131896766;11058.889411106107;10360.274780765576;11029.338239705643;11042.33745975244;11069.612563560559;11149.219554631098;8588.098249683693;9087.273018158663;9102.089791020844;9106.635734570544;9116.4074335168;8853.867191992254;9120.863187052331;9145.771355715895;9153.359264851397;9205.263578913804;8211.05572859129;8283.710070147516;8285;8322.583870806315;8457.281131103926;8012.759617211493;8213.79465513367;8234.423590348619;8352.33181345503;8419.579021048801;7560.8487830244185;7586.3930885527925;7620.771376858703;7685.961570192113;7686.3082322589;5308.628396012242;5465.9726701366235;5504.091824848855;5575.107982722745;5592.720363981866;5371.4897084776885;5552.361478429871;5605.915911261416;5647.576431767552;5703.401142880104 15:13:16 INFO - PROCESS | 21303 | |4;prototype.html;317.3795230324715;349.9125218695326;359.6942598791028;367.33145674871736;368.8469285246623;5167.5607573356265;5300.6289559730785;5419.5393391561765;5496.917546236805;5571.804986825462;5458.699771512565;5465.180222966557;5474.863128421782;5495.203195536645;5519.254900588419;4281.443412356397;4281.801095693196;4282.8715138545895;4297.173701177003;4327.242732521796;4104.40486129511;4289.806958686867;4326.221280169569;4345.174416860802;4351.2377487117765;4283.886189590713;4293.22721910056;4293.261229202162;4296.312589985603;4298.806553705075;4122.670186385082;4274.893127671802;4294.871153865389;4295.506016808075;4296.63478604319;3783.1109689223013;3794.8102594870147;3799.1262009737916;3804.6766024887916;3806.619338066199;5344.599155063347;5360.597955153379;5371.3822910365025;5379.542738867201;5403.83788486346;4794.472608013116;4913.901721965576;4916.139675556763;4922.704637721748;4924.80300787968;5720.885582288331;5722.799702010409;5725.198472213893;5737.967165910134;5743.368229494752;4162.271602469556;4163.333866581363;4169.4162817205615;4171.457710497616;4174.624283814441;5503;5659.745311460994;5949.613275137102;5957.523398128096;5975.671338076404;4215.515215750228;4240.279152544075;4240.512341080754;4264.270866645349;4279.186954478701;4303.63419109373;4323.718958267703;4324.935125973113;4332.4367832181615;4333.479982402132;4791.281307803857;4860.73265970375;4899.583535399531;4914.115459217303;4927.556519913225;5719.685417302005;5725.5133313667975;5743.885122297531;5771.88456230873;5780.653160810365;1458.3145921416917;1485.5469081930114;1485.5988883001528;1486.138039936834;1487.2043456750587;911.9375927044919;954.2652157838426;966.0484422843634;967.3132076225959;968.8885778135464;4937.654364194472;4941.530554597308;4953.00939812039;4960.70235785854;4966.950330496721;5209.583233341324;5223.5559977402345;5226.869328266824;5230.573974047005;5231.973840130851;4496.168208881368;4841.733704646278;4929.679570827885;4934.383202099738;4939.160342741742;2729.549624312006;2740.4930087933794;2746;2749.780017598587;2775.875085621152;5307.5585230793495;5325.227841962894;5330.520253177155;5336.839894803162;5338.572914166857;5048.343715316985;5241.161414173714;5265.21021846726;5279.709615971158;5298.390685071189;5323.787048518016;5324.653897496728;5340.759665815048;5342.759575819097;5350.571954243729;5175.948240517547;5177.585793136464;5180.948190518197;5197.22041693749;5205.765740541609;4851.248056551241;5095.643304968617;5097.515736005073;5166.896662066662;5182.471171004488;5918.928375068692;5980.850478738066;6033.396660333931;6135.239142385855;6164.537659675452;4294.957050429456;4321.330193819963;4331.501877284152;4333.58830911063;4345.587169219046;5728;5875.764969401176;5948.553858460719;5948.851278718067;5954.523638109027;5740.253767010429;5742.559412249693;5746.56335916021;5765.538756899522;5811.56413268998;5714.514266287246;5742.942570574241;5747.770089196385;5770.422957704196;5802.854928626818;5605.775768969195;5652.3824752157825;5767.452092051249;5775.978407557489;5787.479126878601;5795.536357091507;5805.76776928935;5806.216160818235;5829.242198514166;5838.854028649318;5381.73091345439;5643.858903527281;5653.519450846724;5655.179998900054;5691.487766100905 15:13:16 INFO - PROCESS | 21303 | |5;yui.html;798.4969469234381;822.0669540072016;824.0688022534536;851.8679604661276;902.1654969153532;15867.68264634708;16776.58058548534;16791.74812377814;16805.57986050346;16887.49337519875;16230.83769162308;16376.508704738848;16385.42651007215;16391.59021024475;16422.589435264123;721.1058287723212;734.713461749918;857.3012994409568;860.1398601398602;887.6183241206279;876.2945828607968;879.0594064351114;879.5426378283289;879.7096958003875;880.2210044110976;933.0809152984305;937.5780898595625;937.7046230437425;938.2775263047483;938.8216238914619;758.5865703191746;774.2025713515088;895.1719659315107;906.7279816055222;923.5336155241628;666.3902529185789;670.6814263224978;670.7115940145735;671;672.4788289075956;15952.840471595251;15982.440614578434;15983;16004.279807408579;16014.519564413085;15145.394184232617;15406.306716197798;15443.845561544353;15705.764413533807;15882.841171588252;13782.60478952259;13924.51264205748;13978.091424057404;14072.929635351758;14168.149911005372;4697.506761789997;4708.0819240248165;4710.269908164206;4766.571008609207;4772.49888761682;87166.12833871643;87994.56002720009;88833.55583222171;89255;90592;12476.75046499065;12604.55884044054;12663.303518306582;12794;12853.421596028014;23914.282571522883;23943.760562394502;23948.88025559861;23959.760402396103;23973.52052958931;9259.157723690789;9550.808983820285;9584.37701549397;9638.566264518113;10002.649907253211;5250.868728281747;5309.3894202166475;5314.362276526842;5346.518813306821;5520.06158952979;3489.7033752130847;3609.1157666371905;3660.103274697716;3667.7065834733157;3668.284684486553;573.8823541174049;618.5453691536717;636.3604577399684;638.6136387485504;640.0750914927977;639.7568923808923;652.5236577298599;696.9789258735976;774.1832366852911;796.398718967176;10142.797144057078;10311.9484402579;10595.205359598061;10933.398663073449;10969.62879640045;654.9443297319685;685.4447897203281;689.396777819408;712.8004158835535;778.7235531386276;5080.288759573663;5320.982762036884;5325.307709997675;5354;5367.684917195312;132226;133222;135762;136657.31671341578;138858;67059.32940670628;69300.30699692939;113772;117388;119156;100267.49866250622;100976.29286799733;101178;101650;101837.99999999852;9811.411315321104;10058.245631577514;10135;10145.49272536385;10187.541560629641;58890.705546473706;59410.40589594049;60238.39761602503;61164.694176528836;63069;49765.50234497753;50349;84158.57920710357;86535;90357.09642903486;13711.451541938211;13783.312254110353;13794.724105518035;13876.514321998682;14133.787993179905;14469.348879300247;14759.704805904037;14846.109233446028;15162.24188790578;15386.307616157525;12244.857279540558;12639.304838233618;12687.555935542212;12878.935605321913;13970.231637260049;13152.342382880626;13326.666833329244;13544.119632223874;14317.928410357881;14333.426662933365;12082.697932551757;12691.80962285585;12881.613551593467;13829.930850345683;14051.789223161457;10652.946735266274;10969.725756856142;11317.717057073309;11697.06423486102;11741.29552226869;10719.517621707198;12049.51801927913;12105.636830895088;12391.256524608552;12436.129470937309 15:13:16 INFO - PROCESS | 21303 | __end_tp_report 15:13:16 INFO - PROCESS | 21303 | __start_cc_report 15:13:16 INFO - PROCESS | 21303 | _x_x_mozilla_cycle_collect,883 15:13:16 INFO - PROCESS | 21303 | __end_cc_report 15:13:16 INFO - PROCESS | 21303 | __startTimestamp1477001596899__endTimestamp 15:13:16 INFO - PROCESS | 21303 | 15:13:16 INFO - PROCESS | 21303 | ------- Summary: start ------- 15:13:16 INFO - PROCESS | 21303 | Number of tests: 6 15:13:16 INFO - PROCESS | 21303 | 15:13:16 INFO - PROCESS | 21303 | [#0] dojo.html Cycles:165 Average:5512.78 Median:5709.26 stddev:645.48 (11.3%) stddev-sans-first:619.29 15:13:16 INFO - PROCESS | 21303 | Values: 3108.3 3152.5 3159.1 3177.8 3194.7 5480.7 5511.1 5548.1 5553.6 5567.4 5639.1 5681.7 5690.3 5723.6 5739.8 5095.0 5141.2 5171.1 5176.5 5206.8 4946.1 4975.9 5160.3 5212.5 5215.1 5051.1 5059.1 5070.8 5099.5 5105.0 5129.1 5136.8 5221.0 5224.9 5240.3 4810.1 5113.4 5141.3 5188.7 5202.7 5359.2 5482.0 5516.4 5526.4 5565.6 5916.4 5921.0 6039.0 6042.9 6049.1 5734.9 6053.0 6065.5 6067.9 6077.2 5404.2 5533.3 5584.9 5593.1 5596.4 6158.0 6167.9 6168.1 6169.2 6179.1 5665.4 5903.5 5913.9 5919.5 5929.9 5793.9 5822.7 5874.1 5878.1 5975.1 5898.6 5908.6 5913.2 5916.3 5916.9 5871.9 5927.0 5931.1 5931.7 5953.2 4285.7 4321.0 4325.2 4343.0 4350.6 3922.6 3932.2 3949.4 3961.1 3966.8 5660.9 5663.0 5666.0 5667.3 5667.6 5748.8 5799.1 5866.2 5998.3 6002.5 5533.5 5583.7 5593.4 5623.0 5630.0 5015.5 5045.0 5052.2 5056.8 5084.7 5933.9 5950.5 6128.5 6176.5 6181.5 5805.4 5822.6 5856.7 5898.5 5936.4 6085.0 6093.1 6096.6 6099.2 6102.4 5640.9 5791.0 5791.2 5801.9 5803.5 5805.8 5902.1 5949.6 5974.8 6064.7 5853.3 5854.9 5897.1 5897.6 5898.7 5813.7 5889.0 5890.7 5892.9 5893.0 5564.4 5616.4 5685.8 5703.3 5746.0 5844.6 5859.3 5862.9 5869.4 5894.1 5499.6 5703.2 5703.7 5709.3 5719.9 15:13:16 INFO - PROCESS | 21303 | 15:13:16 INFO - PROCESS | 21303 | [#1] ext.html Cycles:180 Average:62831.26 Median:222977.09 stddev:119760.63 (53.7%) stddev-sans-first:120005.43 15:13:16 INFO - PROCESS | 21303 | Values: 595.7 625.2 651.3 655.2 656.5 35539.5 36291.0 46458.5 47418.5 47506.3 47378.0 47744.3 47789.3 47800.8 47817.8 9410.3 9567.9 9572.4 9573.3 9578.9 8610.6 8824.0 9412.2 10986.4 11329.8 11461.3 11540.2 11550.4 11599.5 11666.1 11459.0 11468.0 11526.9 11534.3 11538.8 8487.0 8743.5 10914.2 11254.5 11261.9 46861.3 47358.0 47366.5 47403.3 47442.0 3834.2 4046.4 4214.6 4267.1 4571.9 35640.3 36128.5 36135.5 36446.6 37540.0 4648.4 4691.8 4748.2 4753.1 4776.8 380157.0 382297.0 382697.0 382896.0 383157.0 60357.0 66050.0 66170.0 66550.3 66623.3 68486.7 68575.0 68649.7 68725.3 68755.7 19338.0 20020.2 20074.5 20081.5 20089.8 13520.5 15310.9 15375.5 15378.2 15396.6 16943.2 18750.8 18933.0 19374.2 20013.2 6565.3 6646.1 6666.0 6743.6 6784.2 1034.9 1060.2 1137.3 1144.4 1160.1 35240.1 35380.6 35442.5 35572.6 35660.6 1204.0 1232.6 1242.1 1252.0 1291.0 18303.0 18375.5 18455.4 18519.0 18564.5 547680.0 551791.0 551795.0 552673.0 553035.0 64628.0 64818.7 64825.7 64862.7 64908.0 1312.0 1354.1 1382.2 1401.4 1431.8 32872.3 35665.6 35901.6 36025.6 36142.3 56699.1 57185.7 57259.7 57383.4 57457.4 404919.0 405205.0 407781.0 407920.0 408802.0 28617.7 29365.3 29439.7 30817.4 46580.3 49815.8 50210.2 50492.0 50498.7 50852.7 42255.0 42371.8 42713.0 42761.6 44210.6 41776.8 42015.2 43201.0 43278.0 44214.6 40470.4 40749.2 40820.0 41306.8 43306.4 34999.0 37343.3 37825.8 38000.0 38028.6 27338.6 28394.9 28548.6 28764.7 29026.6 15:13:16 INFO - PROCESS | 21303 | 15:13:16 INFO - PROCESS | 21303 | [#2] jquery.html Cycles:180 Average:33903.42 Median:430.12 stddev:103422.53 (24044.9%) stddev-sans-first:103682.05 15:13:16 INFO - PROCESS | 21303 | Values: 396.2 426.1 434.1 434.8 436.9 16675.3 20014.8 21665.5 22000.8 22138.6 20735.6 21223.2 21258.5 21311.3 21366.1 5450.7 5897.1 5973.9 6242.2 6243.1 6099.1 6198.0 6221.7 6232.9 6249.4 5998.4 6187.9 6192.5 6251.0 6291.7 6177.4 6318.7 6354.0 6358.2 6360.5 6161.5 6199.2 6205.0 6206.7 6206.9 15240.9 15251.2 15321.5 15470.1 15598.8 2457.4 2496.5 2509.1 2560.2 2642.8 10806.4 10837.3 11013.7 11268.6 11715.5 1992.5 2001.8 2060.7 2062.6 2127.2 90878.0 91729.0 94326.0 95559.0 96538.5 10489.8 11963.8 12057.5 12062.6 12112.7 15756.5 16260.0 16525.4 16537.1 17180.0 8998.2 9251.6 9258.1 9337.1 9379.2 8873.8 9003.3 9050.8 9271.2 9374.3 5043.9 5052.9 5213.6 5226.1 5352.9 2092.3 2128.8 2142.3 2149.1 2153.3 891.7 963.8 1002.2 1008.7 1021.2 20828.5 21092.9 21127.2 21144.2 21218.0 501.3 525.9 1060.8 1066.6 1070.7 6710.6 6715.2 6857.6 7010.1 7018.0 613991.0 627614.0 630866.0 631525.0 634320.0 104446.0 105409.5 106357.5 108318.5 110710.4 448.3 516.9 523.1 525.1 526.7 10498.5 12034.8 12265.3 12581.4 12673.9 46637.0 46935.3 47730.0 47936.5 48378.3 63650.0 63678.0 63710.4 64720.0 66070.0 8827.3 8998.3 9031.3 9125.0 9356.2 13627.9 13793.9 13804.8 13893.7 13997.3 12289.2 12446.4 12448.9 12459.9 12559.5 6344.9 8960.2 11456.1 11717.5 11863.6 12272.7 12671.0 12677.4 12794.9 12956.8 9299.7 9316.2 9373.1 9436.0 9569.4 11303.9 12511.7 12721.2 12834.0 12884.8 15:13:16 INFO - PROCESS | 21303 | 15:13:16 INFO - PROCESS | 21303 | [#3] mootools.html Cycles:180 Average:6153.77 Median:2718.56 stddev:3507.25 (129.0%) stddev-sans-first:3499.98 15:13:16 INFO - PROCESS | 21303 | Values: 1544.1 1577.5 1755.7 1861.4 1872.4 8766.3 9389.5 9395.0 9400.1 9404.7 8260.7 8469.7 8475.5 8693.2 9215.2 2352.4 2427.3 2428.3 2456.4 2463.4 2429.1 2455.2 2456.2 2461.6 2493.4 2433.7 2433.9 2436.8 2437.4 2477.0 2401.1 2408.5 2412.0 2419.3 2421.9 2399.0 2426.3 2426.8 2431.3 2432.2 9366.2 9388.5 9429.0 9522.6 9539.3 5425.1 5560.3 5568.6 5578.4 5589.4 3404.4 3519.9 3623.1 3631.0 3663.8 1279.3 1297.3 1333.6 1335.1 2185.8 12671.7 13121.9 13136.3 13143.5 13159.0 4668.4 4745.7 4748.9 4851.4 4943.5 9850.1 9855.4 9858.9 9864.7 9867.4 5453.6 5455.0 5455.8 5462.0 5465.2 5000.3 5060.8 5087.0 5091.5 5118.7 3903.1 3943.5 3964.3 4017.8 4023.4 1175.1 1176.9 1195.1 1196.9 1208.2 1010.9 1017.3 1069.5 1072.7 1077.9 6332.6 6409.0 6463.0 6636.5 6745.6 488.9 493.6 499.5 514.7 515.2 4431.8 4595.3 4600.8 4621.1 4634.4 11395.1 11657.5 11684.9 11709.6 11710.9 11639.7 11675.3 11684.7 11700.8 11707.4 8396.2 8681.1 8693.0 8693.8 8747.7 6239.1 6426.9 6658.8 6784.9 6874.9 10529.4 10689.6 10900.1 11034.7 11058.9 10360.3 11029.3 11042.3 11069.6 11149.2 8588.1 9087.3 9102.1 9106.6 9116.4 8853.9 9120.9 9145.8 9153.4 9205.3 8211.1 8283.7 8285.0 8322.6 8457.3 8012.8 8213.8 8234.4 8352.3 8419.6 7560.8 7586.4 7620.8 7686.0 7686.3 5308.6 5466.0 5504.1 5575.1 5592.7 5371.5 5552.4 5605.9 5647.6 5703.4 15:13:16 INFO - PROCESS | 21303 | 15:13:16 INFO - PROCESS | 21303 | [#4] prototype.html Cycles:180 Average:4682.96 Median:5201.49 stddev:1346.78 (25.9%) stddev-sans-first:1310.10 15:13:16 INFO - PROCESS | 21303 | Values: 317.4 349.9 359.7 367.3 368.8 5167.6 5300.6 5419.5 5496.9 5571.8 5458.7 5465.2 5474.9 5495.2 5519.3 4281.4 4281.8 4282.9 4297.2 4327.2 4104.4 4289.8 4326.2 4345.2 4351.2 4283.9 4293.2 4293.3 4296.3 4298.8 4122.7 4274.9 4294.9 4295.5 4296.6 3783.1 3794.8 3799.1 3804.7 3806.6 5344.6 5360.6 5371.4 5379.5 5403.8 4794.5 4913.9 4916.1 4922.7 4924.8 5720.9 5722.8 5725.2 5738.0 5743.4 4162.3 4163.3 4169.4 4171.5 4174.6 5503.0 5659.7 5949.6 5957.5 5975.7 4215.5 4240.3 4240.5 4264.3 4279.2 4303.6 4323.7 4324.9 4332.4 4333.5 4791.3 4860.7 4899.6 4914.1 4927.6 5719.7 5725.5 5743.9 5771.9 5780.7 1458.3 1485.5 1485.6 1486.1 1487.2 911.9 954.3 966.0 967.3 968.9 4937.7 4941.5 4953.0 4960.7 4967.0 5209.6 5223.6 5226.9 5230.6 5232.0 4496.2 4841.7 4929.7 4934.4 4939.2 2729.5 2740.5 2746.0 2749.8 2775.9 5307.6 5325.2 5330.5 5336.8 5338.6 5048.3 5241.2 5265.2 5279.7 5298.4 5323.8 5324.7 5340.8 5342.8 5350.6 5175.9 5177.6 5180.9 5197.2 5205.8 4851.2 5095.6 5097.5 5166.9 5182.5 5918.9 5980.9 6033.4 6135.2 6164.5 4295.0 4321.3 4331.5 4333.6 4345.6 5728.0 5875.8 5948.6 5948.9 5954.5 5740.3 5742.6 5746.6 5765.5 5811.6 5714.5 5742.9 5747.8 5770.4 5802.9 5605.8 5652.4 5767.5 5776.0 5787.5 5795.5 5805.8 5806.2 5829.2 5838.9 5381.7 5643.9 5653.5 5655.2 5691.5 15:13:16 INFO - PROCESS | 21303 | 15:13:16 INFO - PROCESS | 21303 | [#5] yui.html Cycles:180 Average:22736.93 Median:23954.32 stddev:33710.17 (140.7%) stddev-sans-first:33764.49 15:13:16 INFO - PROCESS | 21303 | Values: 798.5 822.1 824.1 851.9 902.2 15867.7 16776.6 16791.7 16805.6 16887.5 16230.8 16376.5 16385.4 16391.6 16422.6 721.1 734.7 857.3 860.1 887.6 876.3 879.1 879.5 879.7 880.2 933.1 937.6 937.7 938.3 938.8 758.6 774.2 895.2 906.7 923.5 666.4 670.7 670.7 671.0 672.5 15952.8 15982.4 15983.0 16004.3 16014.5 15145.4 15406.3 15443.8 15705.8 15882.8 13782.6 13924.5 13978.1 14072.9 14168.1 4697.5 4708.1 4710.3 4766.6 4772.5 87166.1 87994.6 88833.6 89255.0 90592.0 12476.8 12604.6 12663.3 12794.0 12853.4 23914.3 23943.8 23948.9 23959.8 23973.5 9259.2 9550.8 9584.4 9638.6 10002.6 5250.9 5309.4 5314.4 5346.5 5520.1 3489.7 3609.1 3660.1 3667.7 3668.3 573.9 618.5 636.4 638.6 640.1 639.8 652.5 697.0 774.2 796.4 10142.8 10311.9 10595.2 10933.4 10969.6 654.9 685.4 689.4 712.8 778.7 5080.3 5321.0 5325.3 5354.0 5367.7 132226.0 133222.0 135762.0 136657.3 138858.0 67059.3 69300.3 113772.0 117388.0 119156.0 100267.5 100976.3 101178.0 101650.0 101838.0 9811.4 10058.2 10135.0 10145.5 10187.5 58890.7 59410.4 60238.4 61164.7 63069.0 49765.5 50349.0 84158.6 86535.0 90357.1 13711.5 13783.3 13794.7 13876.5 14133.8 14469.3 14759.7 14846.1 15162.2 15386.3 12244.9 12639.3 12687.6 12878.9 13970.2 13152.3 13326.7 13544.1 14317.9 14333.4 12082.7 12691.8 12881.6 13829.9 14051.8 10652.9 10969.7 11317.7 11697.1 11741.3 10719.5 12049.5 12105.6 12391.3 12436.1 15:13:16 INFO - PROCESS | 21303 | -------- Summary: end -------- 15:13:16 INFO - PROCESS | 21303 | 15:13:17 INFO - TEST-INFO | 21303: exit 0 15:13:17 INFO - TEST-OK | dromaeo_css | took 1113154ms 15:13:17 INFO - TEST-START | kraken 15:13:17 INFO - operating with platform_type : linux_ 15:13:17 INFO - Initialising browser for kraken test... 15:13:17 INFO - TEST-INFO | started process 21621 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmr5YWE/profile http://localhost:41628/getInfo.html) 15:13:21 INFO - PROCESS | 21621 | __metrics Screen width/height:1600/1200 15:13:21 INFO - PROCESS | 21621 | colorDepth:24 15:13:21 INFO - PROCESS | 21621 | Browser inner width/height: 1024/697 15:13:21 INFO - PROCESS | 21621 | __metrics 15:13:21 INFO - PROCESS | 21621 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:13:21 INFO - PROCESS | 21621 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:13:22 INFO - PROCESS | 21621 | console.error: PushService: 15:13:22 INFO - PROCESS | 21621 | stateChangeProcessEnqueue: Error transitioning state 15:13:22 INFO - PROCESS | 21621 | UnknownError 15:13:22 INFO - TEST-INFO | 21621: exit 0 15:13:22 INFO - Browser initialized. 15:13:22 INFO - Running cycle 1/1 for kraken test... 15:13:22 INFO - TEST-INFO | started process 21713 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmr5YWE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:13:34 INFO - PROCESS | 21713 | RSS: Main: 144953344 15:13:34 INFO - PROCESS | 21713 | 15:13:37 INFO - PROCESS | 21713 | Cycle 1(1): loaded http://localhost:41628/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41628/tests/kraken/driver.html?testName=audio-beat-detection) 15:13:38 INFO - PROCESS | 21713 | RSS: Main: 186912768 15:13:38 INFO - PROCESS | 21713 | 15:13:40 INFO - PROCESS | 21713 | Cycle 1(1): loaded http://localhost:41628/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41628/tests/kraken/driver.html?testName=audio-dft) 15:13:41 INFO - PROCESS | 21713 | RSS: Main: 175542272 15:13:41 INFO - PROCESS | 21713 | 15:13:43 INFO - PROCESS | 21713 | Cycle 1(1): loaded http://localhost:41628/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41628/tests/kraken/driver.html?testName=audio-fft) 15:13:44 INFO - PROCESS | 21713 | RSS: Main: 267968512 15:13:44 INFO - PROCESS | 21713 | 15:13:46 INFO - PROCESS | 21713 | Cycle 1(1): loaded http://localhost:41628/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41628/tests/kraken/driver.html?testName=audio-oscillator) 15:13:47 INFO - PROCESS | 21713 | RSS: Main: 173215744 15:13:47 INFO - PROCESS | 21713 | 15:13:49 INFO - PROCESS | 21713 | Cycle 1(1): loaded http://localhost:41628/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41628/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:13:49 INFO - PROCESS | 21713 | RSS: Main: 175534080 15:13:49 INFO - PROCESS | 21713 | 15:13:52 INFO - PROCESS | 21713 | Cycle 1(1): loaded http://localhost:41628/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41628/tests/kraken/driver.html?testName=imaging-darkroom) 15:13:53 INFO - PROCESS | 21713 | RSS: Main: 210800640 15:13:53 INFO - PROCESS | 21713 | 15:13:56 INFO - PROCESS | 21713 | Cycle 1(1): loaded http://localhost:41628/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41628/tests/kraken/driver.html?testName=imaging-desaturate) 15:13:57 INFO - PROCESS | 21713 | RSS: Main: 209985536 15:13:57 INFO - PROCESS | 21713 | 15:14:00 INFO - PROCESS | 21713 | Cycle 1(1): loaded http://localhost:41628/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41628/tests/kraken/driver.html?testName=json-parse-financial) 15:14:00 INFO - PROCESS | 21713 | RSS: Main: 209727488 15:14:00 INFO - PROCESS | 21713 | 15:14:02 INFO - PROCESS | 21713 | Cycle 1(1): loaded http://localhost:41628/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41628/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:14:02 INFO - PROCESS | 21713 | RSS: Main: 171958272 15:14:02 INFO - PROCESS | 21713 | 15:14:04 INFO - PROCESS | 21713 | Cycle 1(1): loaded http://localhost:41628/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41628/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:14:05 INFO - PROCESS | 21713 | RSS: Main: 179081216 15:14:05 INFO - PROCESS | 21713 | 15:14:07 INFO - PROCESS | 21713 | Cycle 1(1): loaded http://localhost:41628/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41628/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:14:07 INFO - PROCESS | 21713 | RSS: Main: 188780544 15:14:07 INFO - PROCESS | 21713 | 15:14:10 INFO - PROCESS | 21713 | Cycle 1(1): loaded http://localhost:41628/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41628/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:14:10 INFO - PROCESS | 21713 | RSS: Main: 197976064 15:14:10 INFO - PROCESS | 21713 | 15:14:13 INFO - PROCESS | 21713 | Cycle 1(1): loaded http://localhost:41628/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41628/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:14:14 INFO - PROCESS | 21713 | RSS: Main: 193572864 15:14:14 INFO - PROCESS | 21713 | 15:14:15 INFO - PROCESS | 21713 | Cycle 1(1): loaded http://localhost:41628/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41628/tests/kraken/driver.html?testName=ai-astar) 15:14:16 INFO - PROCESS | 21713 | RSS: Main: 245350400 15:14:16 INFO - PROCESS | 21713 | 15:14:16 INFO - PROCESS | 21713 | __start_tp_report 15:14:16 INFO - PROCESS | 21713 | _x_x_mozilla_page_load 15:14:16 INFO - PROCESS | 21713 | _x_x_mozilla_page_load_details 15:14:16 INFO - PROCESS | 21713 | |i|pagename|runs| 15:14:16 INFO - PROCESS | 21713 | |0;ai-astar;111;110;110;111;111;111;111;110;112;111 15:14:16 INFO - PROCESS | 21713 | |1;audio-beat-detection;145;117;114;166;122;118;118;118;153;117 15:14:16 INFO - PROCESS | 21713 | |2;audio-dft;161;161;159;160;161;162;161;161;162;161 15:14:16 INFO - PROCESS | 21713 | |3;audio-fft;76;76;76;104;76;76;76;75;103;76 15:14:16 INFO - PROCESS | 21713 | |4;audio-oscillator;81;81;117;81;81;81;112;81;81;104 15:14:16 INFO - PROCESS | 21713 | |5;imaging-gaussian-blur;116;116;116;117;117;117;116;116;118;117 15:14:16 INFO - PROCESS | 21713 | |6;imaging-darkroom;147;146;145;146;147;146;146;146;146;146 15:14:16 INFO - PROCESS | 21713 | |7;imaging-desaturate;94;95;100;95;94;95;95;96;95;95 15:14:16 INFO - PROCESS | 21713 | |8;json-parse-financial;51;51;49;49;49;49;48;49;59;50 15:14:16 INFO - PROCESS | 21713 | |9;json-stringify-tinderbox;59;60;59;60;59;59;64;60;60;61 15:14:16 INFO - PROCESS | 21713 | |10;stanford-crypto-aes;75;78;73;74;73;74;80;75;73;75 15:14:16 INFO - PROCESS | 21713 | |11;stanford-crypto-ccm;132;129;135;124;125;123;127;119;153;128 15:14:16 INFO - PROCESS | 21713 | |12;stanford-crypto-pbkdf2;160;161;161;160;159;160;157;159;157;156 15:14:16 INFO - PROCESS | 21713 | |13;stanford-crypto-sha256-iterative;65;63;63;63;63;62;63;63;61;62 15:14:16 INFO - PROCESS | 21713 | __end_tp_report 15:14:16 INFO - PROCESS | 21713 | __start_cc_report 15:14:16 INFO - PROCESS | 21713 | _x_x_mozilla_cycle_collect,1577 15:14:16 INFO - PROCESS | 21713 | __end_cc_report 15:14:16 INFO - PROCESS | 21713 | __startTimestamp1477001656110__endTimestamp 15:14:16 INFO - PROCESS | 21713 | 15:14:16 INFO - PROCESS | 21713 | ------- Summary: start ------- 15:14:16 INFO - PROCESS | 21713 | Number of tests: 14 15:14:16 INFO - PROCESS | 21713 | 15:14:16 INFO - PROCESS | 21713 | [#0] ai-astar Cycles:10 Average:110.80 Median:111.00 stddev:0.63 (0.6%) stddev-sans-first:0.67 15:14:16 INFO - PROCESS | 21713 | Values: 111.0 110.0 110.0 111.0 111.0 111.0 111.0 110.0 112.0 111.0 15:14:16 INFO - PROCESS | 21713 | 15:14:16 INFO - PROCESS | 21713 | [#1] audio-beat-detection Cycles:10 Average:128.80 Median:120.00 stddev:18.64 (15.5%) stddev-sans-first:18.82 15:14:16 INFO - PROCESS | 21713 | Values: 145.0 117.0 114.0 166.0 122.0 118.0 118.0 118.0 153.0 117.0 15:14:16 INFO - PROCESS | 21713 | 15:14:16 INFO - PROCESS | 21713 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:0.88 (0.5%) stddev-sans-first:0.93 15:14:16 INFO - PROCESS | 21713 | Values: 161.0 161.0 159.0 160.0 161.0 162.0 161.0 161.0 162.0 161.0 15:14:16 INFO - PROCESS | 21713 | 15:14:16 INFO - PROCESS | 21713 | [#3] audio-fft Cycles:10 Average:81.40 Median:76.00 stddev:11.65 (15.3%) stddev-sans-first:12.20 15:14:16 INFO - PROCESS | 21713 | Values: 76.0 76.0 76.0 104.0 76.0 76.0 76.0 75.0 103.0 76.0 15:14:16 INFO - PROCESS | 21713 | 15:14:16 INFO - PROCESS | 21713 | [#4] audio-oscillator Cycles:10 Average:90.00 Median:81.00 stddev:14.82 (18.3%) stddev-sans-first:15.35 15:14:16 INFO - PROCESS | 21713 | Values: 81.0 81.0 117.0 81.0 81.0 81.0 112.0 81.0 81.0 104.0 15:14:16 INFO - PROCESS | 21713 | 15:14:16 INFO - PROCESS | 21713 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 15:14:16 INFO - PROCESS | 21713 | Values: 116.0 116.0 116.0 117.0 117.0 117.0 116.0 116.0 118.0 117.0 15:14:16 INFO - PROCESS | 21713 | 15:14:16 INFO - PROCESS | 21713 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.50 15:14:16 INFO - PROCESS | 21713 | Values: 147.0 146.0 145.0 146.0 147.0 146.0 146.0 146.0 146.0 146.0 15:14:16 INFO - PROCESS | 21713 | 15:14:16 INFO - PROCESS | 21713 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.00 stddev:1.71 (1.8%) stddev-sans-first:1.74 15:14:16 INFO - PROCESS | 21713 | Values: 94.0 95.0 100.0 95.0 94.0 95.0 95.0 96.0 95.0 95.0 15:14:16 INFO - PROCESS | 21713 | 15:14:16 INFO - PROCESS | 21713 | [#8] json-parse-financial Cycles:10 Average:50.40 Median:49.50 stddev:3.17 (6.4%) stddev-sans-first:3.35 15:14:16 INFO - PROCESS | 21713 | Values: 51.0 51.0 49.0 49.0 49.0 49.0 48.0 49.0 59.0 50.0 15:14:16 INFO - PROCESS | 21713 | 15:14:16 INFO - PROCESS | 21713 | [#9] json-stringify-tinderbox Cycles:10 Average:60.10 Median:60.00 stddev:1.52 (2.5%) stddev-sans-first:1.56 15:14:16 INFO - PROCESS | 21713 | Values: 59.0 60.0 59.0 60.0 59.0 59.0 64.0 60.0 60.0 61.0 15:14:16 INFO - PROCESS | 21713 | 15:14:16 INFO - PROCESS | 21713 | [#10] stanford-crypto-aes Cycles:10 Average:75.00 Median:75.00 stddev:2.31 (3.1%) stddev-sans-first:2.45 15:14:16 INFO - PROCESS | 21713 | Values: 75.0 78.0 73.0 74.0 73.0 74.0 80.0 75.0 73.0 75.0 15:14:16 INFO - PROCESS | 21713 | 15:14:16 INFO - PROCESS | 21713 | [#11] stanford-crypto-ccm Cycles:10 Average:129.50 Median:128.50 stddev:9.43 (7.3%) stddev-sans-first:9.96 15:14:16 INFO - PROCESS | 21713 | Values: 132.0 129.0 135.0 124.0 125.0 123.0 127.0 119.0 153.0 128.0 15:14:16 INFO - PROCESS | 21713 | 15:14:16 INFO - PROCESS | 21713 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.00 Median:160.00 stddev:1.76 (1.1%) stddev-sans-first:1.83 15:14:16 INFO - PROCESS | 21713 | Values: 160.0 161.0 161.0 160.0 159.0 160.0 157.0 159.0 157.0 156.0 15:14:16 INFO - PROCESS | 21713 | 15:14:16 INFO - PROCESS | 21713 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.80 Median:63.00 stddev:1.03 (1.6%) stddev-sans-first:0.73 15:14:16 INFO - PROCESS | 21713 | Values: 65.0 63.0 63.0 63.0 63.0 62.0 63.0 63.0 61.0 62.0 15:14:16 INFO - PROCESS | 21713 | -------- Summary: end -------- 15:14:16 INFO - PROCESS | 21713 | 15:14:17 INFO - TEST-INFO | 21713: exit 0 15:14:17 INFO - TEST-OK | kraken | took 59492ms 15:14:17 INFO - SUITE-END | took 1172s 15:14:17 INFO - Completed test suite (00:19:32) 15:14:17 INFO - javascript benchmark 15:14:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3108.2540190354316, 3152.4956007038872, 3159.0838656789533, 3177.793443426179, 3194.6965038321364, 5480.671159730414, 5511.145772405273, 5548.140038294061, 5553.555715542757, 5567.415421380758, 5639.125935479997, 5681.744321505532, 5690.321355200215, 5723.627964182325, 5739.827805165842, 5094.974525127378, 5141.228815677641, 5171.0692075426405, 5176.5082317179995, 5206.843794686166, 4946.109700253953, 4975.9004819903585, 5160.329157209576, 5212.50481204285, 5215.113430716788, 5051.06555287273, 5059.11465493539, 5070.822521211759, 5099.515546023141, 5104.974475127638, 5129.0767661820855, 5136.794528218867, 5221.034108689904, 5224.947750522484, 5240.292560504359, 4810.134175848346, 5113.360829896263, 5141.331626888481, 5188.7146206958605, 5202.661826981272, 5359.249705041298, 5481.972590137024, 5516.448355164492, 5526.364468086182, 5565.638233514808, 5916.437938395846, 5921.0, 6039.0, 6042.879142417171, 6049.062395328687, 5734.856628584277, 6052.9697351513405, 6065.4844338231305, 6067.939320606782, 6077.179580756586, 5404.189371594253, 5533.280673512418, 5584.888302233973, 5593.07714227148, 5596.384397716248, 6157.96921015392, 6167.938320616737, 6168.1056246843955, 6169.198004259507, 6179.073139029092, 5665.405132461115, 5903.468687818117, 5913.940860591339, 5919.496842768327, 5929.851753706105, 5793.913091303634, 5822.7088645567555, 5874.089516125007, 5878.088896221093, 5975.133605627159, 5898.557608179318, 5908.586398952032, 5913.172155898178, 5916.319623243296, 5916.881662366814, 5871.853203669943, 5927.0, 5931.08068249422, 5931.73307201177, 5953.22608060958, 4285.657147428261, 4320.978395108004, 4325.1565944641125, 4342.956570434255, 4350.630196433339, 3922.627350401707, 3932.193900250442, 3949.3681011038097, 3961.088949541622, 3966.8099570129425, 5660.85847853807, 5663.008973429633, 5666.036773748473, 5667.348254950651, 5667.631603945731, 5748.798792042258, 5799.130130480462, 5866.208061911672, 5998.310194327621, 6002.54980876436, 5533.529649979716, 5583.720813959286, 5593.440655934455, 5623.0159722048475, 5630.0, 5015.4733752956145, 5045.041442125985, 5052.1663925451885, 5056.82301119459, 5084.745762711849, 5933.940660593339, 5950.523958083257, 6128.540359473057, 6176.505879529627, 6181.5363847710705, 5805.41945805433, 5822.621529600562, 5856.736446859816, 5898.528117750656, 5936.37668044849, 6085.026395776655, 6093.116498107838, 6096.603720758314, 6099.207103076572, 6102.359252278625, 5640.943590564042, 5790.971045144747, 5791.218185545066, 5801.94198058014, 5803.535717142534, 5805.76776928935, 5902.055671092605, 5949.553783466344, 5974.761009559569, 6064.696765161812, 5853.2976042875125, 5854.9121763174435, 5897.085951677497, 5897.557683173865, 5898.675572843535, 5813.651180929158, 5888.970555147197, 5890.7349169288345, 5892.94107058924, 5893.027650437802, 5564.360098588552, 5616.4383561645145, 5685.800996965252, 5703.344115426779, 5745.971270143623, 5844.590878638454, 5859.267591551056, 5862.94137058641, 5869.442402971711, 5894.056950887837, 5499.615026948075, 5703.230063941315, 5703.657780533182, 5709.25779648643, 5719.942800572107], "value": 5467.34192523371, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [595.7497850902623, 625.2465778736623, 651.3388910256087, 655.1842955520381, 656.5076192855358, 35539.46690799637, 36291.0, 46458.5354146458, 47418.52581474184, 47506.287405688854, 47378.0, 47744.283835742404, 47789.28316075253, 47800.76099619497, 47817.76091119539, 9410.341276110657, 9567.904320956806, 9572.42565446072, 9573.282003849705, 9578.856317155249, 8610.612522436473, 8823.95588022059, 9412.199963003153, 10986.352047192906, 11329.773404531945, 11461.31232126071, 11540.249883757571, 11550.36472993985, 11599.478023488964, 11666.125040621988, 11459.0, 11468.0, 11526.88473115275, 11534.307941523535, 11538.769224615502, 8486.957565212197, 8743.475391476468, 10914.181436392302, 11254.54981800727, 11261.943690281578, 46861.297080543816, 47358.0, 47366.526334736904, 47403.28895066577, 47442.0, 3834.194819087995, 4046.3728122141115, 4214.620684138442, 4267.146570685875, 4571.9314210286875, 35640.28719425597, 36128.458073128924, 36135.4579681305, 36446.63553364459, 37540.0, 4648.372469716613, 4691.765411729434, 4748.216544270192, 4753.144434001878, 4776.785044672998, 380157.0, 382297.0, 382697.0, 382896.0, 383157.0, 60357.0, 66050.0, 66170.0, 66550.33449665441, 66623.33376666268, 68486.65756671184, 68575.0, 68649.65675171593, 68725.31274687289, 68755.65622171958, 19338.0, 20020.199192032447, 20074.498137546678, 20081.497962550762, 20089.799102008794, 13520.526781562598, 15310.923445382925, 15375.538733838002, 15378.1542015188, 15396.61508462275, 16943.23755430984, 18750.81249187518, 18933.0, 19374.225030998885, 20013.199472021246, 6565.310642382481, 6646.102776125162, 6666.0, 6743.561668491532, 6784.219814721271, 1034.8551202831609, 1060.1669515246, 1137.2891942535914, 1144.3820337017917, 1160.0893298760432, 35240.11899702528, 35380.64619353825, 35442.46836297458, 35572.64427355745, 35660.64339356625, 1203.9939800301117, 1232.5870833270956, 1242.136714983078, 1251.974960500803, 1291.044626976031, 18303.0, 18375.54061148482, 18455.446336609923, 18519.0, 18564.535886602942, 547680.0, 551791.0, 551795.0, 552673.0, 553035.0, 64628.0, 64818.67590662016, 64825.675871621286, 64862.675686622206, 64908.0, 1312.0, 1354.119822115613, 1382.2121390807145, 1401.3973991183684, 1431.806706094664, 32872.34255314928, 35665.64334356727, 35901.64098359088, 36025.63974360328, 36142.277154456235, 56699.149512758166, 57185.71407142938, 57259.713701431225, 57383.42616573781, 57457.42542574688, 404919.0, 405205.0, 407781.0, 407920.0, 408802.0, 28617.713822861504, 29365.26586835346, 29439.705602944552, 30817.383652326378, 46580.30129547992, 49815.75092124516, 50210.24684629807, 50492.0, 50498.74750626223, 50852.74573627256, 42255.0, 42371.7881410591, 42713.0, 42761.57238427576, 44210.55789442064, 41776.79111604422, 42015.159696806506, 43201.0, 43278.0, 44214.557854421044, 40470.392944106454, 40749.185016298914, 40820.0, 41306.793466032475, 43306.35040474332, 34999.0, 37343.253134937695, 37825.81087094547, 38000.0, 38028.61971380251, 27338.589921151597, 28394.945443909564, 28548.572571371762, 28764.712352876202, 29026.564601530572], "value": 21880.63422484235, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [396.2036307022883, 426.1158096948831, 434.12956054072373, 434.78478153314114, 436.8776742512098, 16675.332986680532, 20014.799852001477, 21665.458363540918, 22000.797527664272, 22138.557228855414, 20735.585288294224, 21223.151073957022, 21258.46853828655, 21311.25410610629, 21366.145354185814, 5450.672959622416, 5897.144913987469, 5973.910391344133, 6242.157308763327, 6243.094751261065, 6099.054646529773, 6197.969010154966, 6221.657808820513, 6232.937670623303, 6249.406306400884, 5998.370171132034, 6187.876242475148, 6192.535559833031, 6251.031090181029, 6291.685415729218, 6177.413145751147, 6318.684065796715, 6354.0, 6358.237011558596, 6360.522960777914, 6161.537884658668, 6199.163112979735, 6205.0, 6206.72069756862, 6206.937930620681, 15240.923795381063, 15251.161186134757, 15321.540353789404, 15470.071795692294, 15598.844011559853, 2457.4225057111744, 2496.500699860035, 2509.0967251789343, 2560.1679454177465, 2642.8017898657486, 10806.351618902812, 10837.349759014405, 11013.669589912315, 11268.605598804003, 11715.472803723767, 1992.4919145617919, 2001.7998200179866, 2060.6599911014664, 2062.618415593105, 2127.1704035426196, 90878.0, 91729.0, 94326.0, 95559.0, 96538.51730741371, 10489.790204195873, 11963.76072478563, 12057.457414416373, 12062.638120856389, 12112.697182570506, 15756.527304180892, 16260.0, 16525.421610243582, 16537.090460024814, 17180.0, 8998.235150012322, 9251.629934802668, 9258.120478554527, 9337.112974267433, 9379.155875971195, 8873.822523549492, 9003.279737620975, 9050.818983620422, 9271.211946984447, 9374.296927730447, 5043.899122017539, 5052.9242061369105, 5213.60897932649, 5226.085435048852, 5352.892942141136, 2092.257248676728, 2128.7658357580654, 2142.346584291806, 2149.1188612669043, 2153.267888917744, 891.7012800711705, 963.8265112279857, 1002.1832206751474, 1008.742770593494, 1021.1881554164457, 20828.47928801792, 21092.894535527223, 21127.154913803584, 21144.154233830475, 21218.0, 501.3282201849539, 525.8737902903275, 1060.7719340341864, 1066.589363095214, 1070.6937536205817, 6710.630915299607, 6715.227748808852, 6857.55425897315, 7010.088688470568, 7018.0, 613991.0, 627614.0, 630866.0, 631525.0, 634320.0, 104446.0, 105409.47295263475, 106357.46821265844, 108318.45840770745, 110710.44644776724, 448.31631761563875, 516.857864087379, 523.1394356283892, 525.0758664750067, 526.6839896062409, 10498.47507624631, 12034.819477708017, 12265.325407102695, 12581.370931453574, 12673.93663031679, 46637.0, 46935.29597055978, 47730.0, 47936.5206347932, 48378.274325884435, 63650.0, 63678.0, 63710.36289637044, 64720.0, 66070.0, 8827.337949653931, 8998.325125615736, 9031.27749780029, 9125.0, 9356.204722598382, 13627.863721362659, 13793.86206137966, 13804.792928105886, 13893.652658683613, 13997.300134993413, 12289.201201921847, 12446.377681115728, 12448.937755311166, 12459.875401245872, 12559.497620095459, 6344.873102537831, 8960.1935825776, 11456.140789440658, 11717.531298747954, 11863.644090677293, 12272.693182670148, 12671.0, 12677.429515672002, 12794.912432442974, 12956.8056479151, 9299.72100836976, 9316.161545460942, 9373.109554592304, 9435.952820235854, 9569.449719162729, 11303.886961130613, 12511.687207819514, 12721.173123746927, 12834.0, 12884.806727899277], "value": 9343.968297239286, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1544.1275679241228, 1577.5188567486916, 1755.7366395040742, 1861.3578315481154, 1872.3914727713498, 8766.342524310678, 9389.530523473815, 9394.953025234881, 9400.059994000614, 9404.670836520723, 8260.710875119372, 8469.66121355145, 8475.491470511774, 8693.174148455886, 9215.216706579931, 2352.411897025739, 2427.332483567024, 2428.3079322393123, 2456.3736247256925, 2463.4334103156284, 2429.0526694589125, 2455.226603619854, 2456.2140115163156, 2461.5815311397105, 2493.4265119022634, 2433.6957880264968, 2433.9391515212083, 2436.8172387070954, 2437.3784684905413, 2476.9752302476923, 2401.075585899424, 2408.5303365843665, 2411.987940060297, 2419.334682962182, 2421.878906054708, 2398.9760102398927, 2426.3206302235403, 2426.7815896569396, 2431.258466167818, 2432.1852179519883, 9366.157045865837, 9388.483633400161, 9428.952855235748, 9522.619095236252, 9539.284553658434, 5425.050616142199, 5560.332760068777, 5568.582356323292, 5578.44215578443, 5589.385167631557, 3404.3531728971416, 3519.8592056317716, 3623.0942264433893, 3630.965174925134, 3663.835127419246, 1279.3219593615306, 1297.2929753284482, 1333.6132521568734, 1335.1121504199696, 2185.846990710651, 12671.683207919783, 13121.86878131216, 13136.277504737236, 13143.474261029547, 13159.0, 4668.393108895822, 4745.738984355894, 4748.857534273978, 4851.442084160296, 4943.530364615356, 9850.064243896819, 9855.359401639014, 9858.901410985942, 9864.654737084167, 9867.40795552269, 5453.563714902798, 5455.0453670607485, 5455.8363249102595, 5461.972690136524, 5465.234867118606, 5000.349954505891, 5060.822871199491, 5087.033463641897, 5091.541761241506, 5118.718470484085, 3903.1413089120347, 3943.4873466449176, 3964.345882929342, 4017.799110044486, 4023.3562629979065, 1175.0893057880041, 1176.9352685602373, 1195.0738177912187, 1196.8683444821063, 1208.1542919956066, 1010.8635334229932, 1017.29298137795, 1069.4652673663168, 1072.7157303314627, 1077.8652668416448, 6332.620042797447, 6408.953699894453, 6463.0, 6636.502262330248, 6745.561538499982, 488.92666100085273, 493.5927859515914, 499.4805402381555, 514.6567458932184, 515.2142981952552, 4431.7916461720915, 4595.310703394451, 4600.838970636079, 4621.075784843045, 4634.351190833286, 11395.145364097725, 11657.475413606408, 11684.88315116838, 11709.590164344207, 11710.94144529272, 11639.709007274716, 11675.299482031105, 11684.70788230301, 11700.824487632692, 11707.356095414663, 8396.160383961676, 8681.088485709037, 8693.043765185825, 8693.782655433664, 8747.737567872973, 6239.126522286792, 6426.935730642821, 6658.83352916181, 6784.93215067843, 6874.8625027500175, 10529.36823790575, 10689.625863094754, 10900.07349375312, 11034.724131896766, 11058.889411106107, 10360.274780765576, 11029.338239705643, 11042.33745975244, 11069.612563560559, 11149.219554631098, 8588.098249683693, 9087.273018158663, 9102.089791020844, 9106.635734570544, 9116.4074335168, 8853.867191992254, 9120.863187052331, 9145.771355715895, 9153.359264851397, 9205.263578913804, 8211.05572859129, 8283.710070147516, 8285.0, 8322.583870806315, 8457.281131103926, 8012.759617211493, 8213.79465513367, 8234.423590348619, 8352.33181345503, 8419.579021048801, 7560.8487830244185, 7586.3930885527925, 7620.771376858703, 7685.961570192113, 7686.3082322589, 5308.628396012242, 5465.9726701366235, 5504.091824848855, 5575.107982722745, 5592.720363981866, 5371.4897084776885, 5552.361478429871, 5605.915911261416, 5647.576431767552, 5703.401142880104], "value": 4853.5459688596875, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [317.3795230324715, 349.9125218695326, 359.6942598791028, 367.33145674871736, 368.8469285246623, 5167.5607573356265, 5300.6289559730785, 5419.5393391561765, 5496.917546236805, 5571.804986825462, 5458.699771512565, 5465.180222966557, 5474.863128421782, 5495.203195536645, 5519.254900588419, 4281.443412356397, 4281.801095693196, 4282.8715138545895, 4297.173701177003, 4327.242732521796, 4104.40486129511, 4289.806958686867, 4326.221280169569, 4345.174416860802, 4351.2377487117765, 4283.886189590713, 4293.22721910056, 4293.261229202162, 4296.312589985603, 4298.806553705075, 4122.670186385082, 4274.893127671802, 4294.871153865389, 4295.506016808075, 4296.63478604319, 3783.1109689223013, 3794.8102594870147, 3799.1262009737916, 3804.6766024887916, 3806.619338066199, 5344.599155063347, 5360.597955153379, 5371.3822910365025, 5379.542738867201, 5403.83788486346, 4794.472608013116, 4913.901721965576, 4916.139675556763, 4922.704637721748, 4924.80300787968, 5720.885582288331, 5722.799702010409, 5725.198472213893, 5737.967165910134, 5743.368229494752, 4162.271602469556, 4163.333866581363, 4169.4162817205615, 4171.457710497616, 4174.624283814441, 5503.0, 5659.745311460994, 5949.613275137102, 5957.523398128096, 5975.671338076404, 4215.515215750228, 4240.279152544075, 4240.512341080754, 4264.270866645349, 4279.186954478701, 4303.63419109373, 4323.718958267703, 4324.935125973113, 4332.4367832181615, 4333.479982402132, 4791.281307803857, 4860.73265970375, 4899.583535399531, 4914.115459217303, 4927.556519913225, 5719.685417302005, 5725.5133313667975, 5743.885122297531, 5771.88456230873, 5780.653160810365, 1458.3145921416917, 1485.5469081930114, 1485.5988883001528, 1486.138039936834, 1487.2043456750587, 911.9375927044919, 954.2652157838426, 966.0484422843634, 967.3132076225959, 968.8885778135464, 4937.654364194472, 4941.530554597308, 4953.00939812039, 4960.70235785854, 4966.950330496721, 5209.583233341324, 5223.5559977402345, 5226.869328266824, 5230.573974047005, 5231.973840130851, 4496.168208881368, 4841.733704646278, 4929.679570827885, 4934.383202099738, 4939.160342741742, 2729.549624312006, 2740.4930087933794, 2746.0, 2749.780017598587, 2775.875085621152, 5307.5585230793495, 5325.227841962894, 5330.520253177155, 5336.839894803162, 5338.572914166857, 5048.343715316985, 5241.161414173714, 5265.21021846726, 5279.709615971158, 5298.390685071189, 5323.787048518016, 5324.653897496728, 5340.759665815048, 5342.759575819097, 5350.571954243729, 5175.948240517547, 5177.585793136464, 5180.948190518197, 5197.22041693749, 5205.765740541609, 4851.248056551241, 5095.643304968617, 5097.515736005073, 5166.896662066662, 5182.471171004488, 5918.928375068692, 5980.850478738066, 6033.396660333931, 6135.239142385855, 6164.537659675452, 4294.957050429456, 4321.330193819963, 4331.501877284152, 4333.58830911063, 4345.587169219046, 5728.0, 5875.764969401176, 5948.553858460719, 5948.851278718067, 5954.523638109027, 5740.253767010429, 5742.559412249693, 5746.56335916021, 5765.538756899522, 5811.56413268998, 5714.514266287246, 5742.942570574241, 5747.770089196385, 5770.422957704196, 5802.854928626818, 5605.775768969195, 5652.3824752157825, 5767.452092051249, 5775.978407557489, 5787.479126878601, 5795.536357091507, 5805.76776928935, 5806.216160818235, 5829.242198514166, 5838.854028649318, 5381.73091345439, 5643.858903527281, 5653.519450846724, 5655.179998900054, 5691.487766100905], "value": 4259.302541096643, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [798.4969469234381, 822.0669540072016, 824.0688022534536, 851.8679604661276, 902.1654969153532, 15867.68264634708, 16776.58058548534, 16791.74812377814, 16805.57986050346, 16887.49337519875, 16230.83769162308, 16376.508704738848, 16385.42651007215, 16391.59021024475, 16422.589435264123, 721.1058287723212, 734.713461749918, 857.3012994409568, 860.1398601398602, 887.6183241206279, 876.2945828607968, 879.0594064351114, 879.5426378283289, 879.7096958003875, 880.2210044110976, 933.0809152984305, 937.5780898595625, 937.7046230437425, 938.2775263047483, 938.8216238914619, 758.5865703191746, 774.2025713515088, 895.1719659315107, 906.7279816055222, 923.5336155241628, 666.3902529185789, 670.6814263224978, 670.7115940145735, 671.0, 672.4788289075956, 15952.840471595251, 15982.440614578434, 15983.0, 16004.279807408579, 16014.519564413085, 15145.394184232617, 15406.306716197798, 15443.845561544353, 15705.764413533807, 15882.841171588252, 13782.60478952259, 13924.51264205748, 13978.091424057404, 14072.929635351758, 14168.149911005372, 4697.506761789997, 4708.0819240248165, 4710.269908164206, 4766.571008609207, 4772.49888761682, 87166.12833871643, 87994.56002720009, 88833.55583222171, 89255.0, 90592.0, 12476.75046499065, 12604.55884044054, 12663.303518306582, 12794.0, 12853.421596028014, 23914.282571522883, 23943.760562394502, 23948.88025559861, 23959.760402396103, 23973.52052958931, 9259.157723690789, 9550.808983820285, 9584.37701549397, 9638.566264518113, 10002.649907253211, 5250.868728281747, 5309.3894202166475, 5314.362276526842, 5346.518813306821, 5520.06158952979, 3489.7033752130847, 3609.1157666371905, 3660.103274697716, 3667.7065834733157, 3668.284684486553, 573.8823541174049, 618.5453691536717, 636.3604577399684, 638.6136387485504, 640.0750914927977, 639.7568923808923, 652.5236577298599, 696.9789258735976, 774.1832366852911, 796.398718967176, 10142.797144057078, 10311.9484402579, 10595.205359598061, 10933.398663073449, 10969.62879640045, 654.9443297319685, 685.4447897203281, 689.396777819408, 712.8004158835535, 778.7235531386276, 5080.288759573663, 5320.982762036884, 5325.307709997675, 5354.0, 5367.684917195312, 132226.0, 133222.0, 135762.0, 136657.31671341578, 138858.0, 67059.32940670628, 69300.30699692939, 113772.0, 117388.0, 119156.0, 100267.49866250622, 100976.29286799733, 101178.0, 101650.0, 101837.99999999852, 9811.411315321104, 10058.245631577514, 10135.0, 10145.49272536385, 10187.541560629641, 58890.705546473706, 59410.40589594049, 60238.39761602503, 61164.694176528836, 63069.0, 49765.50234497753, 50349.0, 84158.57920710357, 86535.0, 90357.09642903486, 13711.451541938211, 13783.312254110353, 13794.724105518035, 13876.514321998682, 14133.787993179905, 14469.348879300247, 14759.704805904037, 14846.109233446028, 15162.24188790578, 15386.307616157525, 12244.857279540558, 12639.304838233618, 12687.555935542212, 12878.935605321913, 13970.231637260049, 13152.342382880626, 13326.666833329244, 13544.119632223874, 14317.928410357881, 14333.426662933365, 12082.697932551757, 12691.80962285585, 12881.613551593467, 13829.930850345683, 14051.789223161457, 10652.946735266274, 10969.725756856142, 11317.717057073309, 11697.06423486102, 11741.29552226869, 10719.517621707198, 12049.51801927913, 12105.636830895088, 12391.256524608552, 12436.129470937309], "value": 8087.227179476073, "unit": "score"}], "name": "dromaeo_css", "value": 7561.393556088706, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 110.0, 110.0, 111.0, 111.0, 111.0, 111.0, 110.0, 112.0, 111.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 117.0, 114.0, 166.0, 122.0, 118.0, 118.0, 118.0, 153.0, 117.0], "value": 128.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 159.0, 160.0, 161.0, 162.0, 161.0, 161.0, 162.0, 161.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 104.0, 76.0, 76.0, 76.0, 75.0, 103.0, 76.0], "value": 81.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 117.0, 81.0, 81.0, 81.0, 112.0, 81.0, 81.0, 104.0], "value": 90.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 116.0, 117.0, 117.0, 117.0, 116.0, 116.0, 118.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 145.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 100.0, 95.0, 94.0, 95.0, 95.0, 96.0, 95.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 49.0, 49.0, 49.0, 49.0, 48.0, 49.0, 59.0, 50.0], "value": 50.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 59.0, 60.0, 59.0, 59.0, 64.0, 60.0, 60.0, 61.0], "value": 60.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 78.0, 73.0, 74.0, 73.0, 74.0, 80.0, 75.0, 73.0, 75.0], "value": 75.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 129.0, 135.0, 124.0, 125.0, 123.0, 127.0, 119.0, 153.0, 128.0], "value": 129.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 161.0, 160.0, 159.0, 160.0, 157.0, 159.0, 157.0, 156.0], "value": 159.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 63.0, 63.0, 63.0, 62.0, 63.0, 63.0, 61.0, 62.0], "value": 62.8, "unit": "score"}], "name": "kraken", "value": 1466.8, "alertThreshold": 2.0}]} 15:14:17 INFO - Return code: 0 15:14:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:14:17 INFO - # TBPL SUCCESS # 15:14:17 INFO - Running post-action listener: _resource_record_post_action 15:14:17 INFO - [mozharness: 2016-10-20 22:14:17.451169Z] Finished run-tests step (success) 15:14:17 INFO - Running post-run listener: _resource_record_post_run 15:14:17 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 2002944; Write bytes: 360181760; Read time: 248; Write time: 238752 15:14:17 INFO - TinderboxPrint: CPU usage
13.0% 15:14:17 INFO - TinderboxPrint: I/O read bytes / time
2,002,944 / 248 15:14:17 INFO - TinderboxPrint: I/O write bytes / time
360,181,760 / 238,752 15:14:17 INFO - TinderboxPrint: CPU idle
8,256.8 (87.0%) 15:14:17 INFO - TinderboxPrint: CPU user
1,189.5 (12.5%) 15:14:17 INFO - TinderboxPrint: Swap in / out
0 / 0 15:14:17 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 107397120; Read time: 0; Write time: 75284 15:14:17 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 266240; Write bytes: 249937920; Read time: 204; Write time: 163024 15:14:18 INFO - Running post-run listener: _upload_blobber_files 15:14:18 INFO - Blob upload gear active. 15:14:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:14:18 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:14:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:14:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:14:18 INFO - (blobuploader) - INFO - Open directory for files ... 15:14:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:14:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:14:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:14:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:14:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:14:19 INFO - (blobuploader) - INFO - Done attempting. 15:14:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:14:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:14:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:14:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:14:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:14:20 INFO - (blobuploader) - INFO - Done attempting. 15:14:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:14:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:14:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:14:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:14:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:14:23 INFO - (blobuploader) - INFO - Done attempting. 15:14:23 INFO - (blobuploader) - INFO - Iteration through files over. 15:14:23 INFO - Return code: 0 15:14:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:14:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:14:23 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/648375e6bb41904bda963bc6898745520879e26fdee5118a27a7939357374690e9adeadb2e095c37e457d95a1083c09d71ccee582b56c8a5e99ff8beba801898", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b12578170b7f8aca4eae641038221d978010a5c1d1e2686c4e69714daf6a4fbd80291f75e82cfc457f235ef4185e8ed15069da794c8b020358086a662cfeabbf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/41b76b1bb8f12a72febadc1987730dec270dead1e7aa6031683c41b33a35da20850ee7e365fd003080cabf4cc51529d2c0d9ba2bb3ebb9531c135052d78f4ec0"} 15:14:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:14:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:14:23 INFO - Contents: 15:14:23 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/648375e6bb41904bda963bc6898745520879e26fdee5118a27a7939357374690e9adeadb2e095c37e457d95a1083c09d71ccee582b56c8a5e99ff8beba801898", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b12578170b7f8aca4eae641038221d978010a5c1d1e2686c4e69714daf6a4fbd80291f75e82cfc457f235ef4185e8ed15069da794c8b020358086a662cfeabbf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/41b76b1bb8f12a72febadc1987730dec270dead1e7aa6031683c41b33a35da20850ee7e365fd003080cabf4cc51529d2c0d9ba2bb3ebb9531c135052d78f4ec0"} 15:14:23 INFO - Running post-run listener: copy_logs_to_upload_dir 15:14:23 INFO - Copying logs to upload dir... 15:14:23 INFO - mkdir: /builds/slave/test/build/upload/logs 15:14:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.654685 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-10-20 15:14:23.391807) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-20 15:14:23.397651) ========= 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=41bf3e9aed84707956354da8000001c5-1477000417.332948-828228526 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/648375e6bb41904bda963bc6898745520879e26fdee5118a27a7939357374690e9adeadb2e095c37e457d95a1083c09d71ccee582b56c8a5e99ff8beba801898", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b12578170b7f8aca4eae641038221d978010a5c1d1e2686c4e69714daf6a4fbd80291f75e82cfc457f235ef4185e8ed15069da794c8b020358086a662cfeabbf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/41b76b1bb8f12a72febadc1987730dec270dead1e7aa6031683c41b33a35da20850ee7e365fd003080cabf4cc51529d2c0d9ba2bb3ebb9531c135052d78f4ec0"} build_url:https://queue.taskcluster.net/v1/task/XdK-4iWJQrCE0i9krD_J3A/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011394 build_url: 'https://queue.taskcluster.net/v1/task/XdK-4iWJQrCE0i9krD_J3A/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/648375e6bb41904bda963bc6898745520879e26fdee5118a27a7939357374690e9adeadb2e095c37e457d95a1083c09d71ccee582b56c8a5e99ff8beba801898", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b12578170b7f8aca4eae641038221d978010a5c1d1e2686c4e69714daf6a4fbd80291f75e82cfc457f235ef4185e8ed15069da794c8b020358086a662cfeabbf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/41b76b1bb8f12a72febadc1987730dec270dead1e7aa6031683c41b33a35da20850ee7e365fd003080cabf4cc51529d2c0d9ba2bb3ebb9531c135052d78f4ec0"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-20 15:14:23.423396) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 15:14:23.423717) ========= 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=41bf3e9aed84707956354da8000001c5-1477000417.332948-828228526 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004467 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 15:14:23.509597) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-20 15:14:23.509940) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-20 15:14:23.510301) ========= ========= Total master_lag: 0.17 =========