builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-048 starttime: 1482385861.21 results: success (0) buildid: 20161221200752 builduid: 14b18faa8bd04dae8dafa9906aacc197 revision: 67d97463e755c0987c8bf452bb6fe9b733621409 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-21 21:51:01.213063) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-21 21:51:01.213502) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-21 21:51:01.213794) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-21 21:51:01.231388) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 21:51:01.231667) ========= 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=fa44defc139c4ba8574fe040000001db-1482384360.637384-427996043 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-21 21:51:01-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 22.3M=0.001s 2016-12-21 21:51:02 (22.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.112352 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 21:51:01.357592) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 21:51:01.357901) ========= 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=fa44defc139c4ba8574fe040000001db-1482384360.637384-427996043 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015672 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 21:51:01.407239) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 21:51:01.407565) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 67d97463e755c0987c8bf452bb6fe9b733621409 --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-beta --rev 67d97463e755c0987c8bf452bb6fe9b733621409 --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=fa44defc139c4ba8574fe040000001db-1482384360.637384-427996043 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-21 21:51:02,121 truncating revision to first 12 chars 2016-12-21 21:51:02,122 Setting DEBUG logging. 2016-12-21 21:51:02,122 attempt 1/10 2016-12-21 21:51:02,122 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/67d97463e755?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-21 21:51:02,417 unpacking tar archive at: mozilla-beta-67d97463e755/testing/mozharness/ program finished with exit code 0 elapsedTime=0.651223 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 21:51:02.072354) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-21 21:51:02.072686) ========= script_repo_revision: 67d97463e755c0987c8bf452bb6fe9b733621409 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-21 21:51:02.073082) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-21 21:51:02.073343) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-21 21:51:02.082848) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-12-21 21:51:02.083187) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=fa44defc139c4ba8574fe040000001db-1482384360.637384-427996043 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:51:02 INFO - MultiFileLogger online at 20161221 21:51:02 in /builds/slave/test 21:51:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 21:51:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:51:02 INFO - {'append_to_log': False, 21:51:02 INFO - 'base_work_dir': '/builds/slave/test', 21:51:02 INFO - 'blob_upload_branch': 'Mozilla-Beta', 21:51:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:51:02 INFO - 'branch': 'Mozilla-Beta', 21:51:02 INFO - 'buildbot_json_path': 'buildprops.json', 21:51:02 INFO - 'config_files': ('talos/linux_config.py',), 21:51:02 INFO - 'default_actions': ('clobber', 21:51:02 INFO - 'read-buildbot-config', 21:51:02 INFO - 'download-and-extract', 21:51:02 INFO - 'populate-webroot', 21:51:02 INFO - 'create-virtualenv', 21:51:02 INFO - 'install', 21:51:02 INFO - 'run-tests'), 21:51:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:51:02 INFO - 'download_minidump_stackwalk': True, 21:51:02 INFO - 'download_symbols': 'ondemand', 21:51:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:51:02 INFO - 'tooltool.py': '/tools/tooltool.py', 21:51:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:51:02 INFO - '/tools/misc-python/virtualenv.py')}, 21:51:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:51:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:51:02 INFO - 'installer_path': 'installer.exe', 21:51:02 INFO - 'log_level': 'info', 21:51:02 INFO - 'log_name': 'talos', 21:51:02 INFO - 'log_to_console': True, 21:51:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:51:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:51:02 INFO - 'opt_config_files': (), 21:51:02 INFO - 'pip_index': False, 21:51:02 INFO - 'sps_profile': False, 21:51:02 INFO - 'sps_profile_interval': 0, 21:51:02 INFO - 'suite': 'dromaeojs', 21:51:02 INFO - 'system_bits': '32', 21:51:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:51:02 INFO - 'title': 'talos-linux64-ix-048', 21:51:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:51:02 INFO - 'use_talos_json': True, 21:51:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:51:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:51:02 INFO - 'work_dir': 'build'} 21:51:02 INFO - [mozharness: 2016-12-22 05:51:02.894594Z] Running clobber step. 21:51:02 INFO - Running pre-action listener: _resource_record_pre_action 21:51:02 INFO - Running main action method: clobber 21:51:02 INFO - rmtree: /builds/slave/test/build 21:51:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:51:03 INFO - Running post-action listener: _resource_record_post_action 21:51:03 INFO - [mozharness: 2016-12-22 05:51:03.867388Z] Finished clobber step (success) 21:51:03 INFO - [mozharness: 2016-12-22 05:51:03.867488Z] Running read-buildbot-config step. 21:51:03 INFO - Running pre-action listener: _resource_record_pre_action 21:51:03 INFO - Running main action method: read_buildbot_config 21:51:03 INFO - Using buildbot properties: 21:51:03 INFO - { 21:51:03 INFO - "project": "", 21:51:03 INFO - "product": "firefox", 21:51:03 INFO - "script_repo_revision": "production", 21:51:03 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 21:51:03 INFO - "repository": "", 21:51:03 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 21:51:03 INFO - "buildid": "20161221200752", 21:51:03 INFO - "pgo_build": "True", 21:51:03 INFO - "basedir": "/builds/slave/test", 21:51:03 INFO - "buildnumber": 59, 21:51:03 INFO - "slavename": "talos-linux64-ix-048", 21:51:03 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 21:51:03 INFO - "platform": "ubuntu64_hw", 21:51:03 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 21:51:03 INFO - "branch": "mozilla-beta", 21:51:03 INFO - "repo_path": "releases/mozilla-beta", 21:51:03 INFO - "revision": "67d97463e755c0987c8bf452bb6fe9b733621409", 21:51:03 INFO - "stage_platform": "linux64-pgo", 21:51:03 INFO - "builduid": "14b18faa8bd04dae8dafa9906aacc197", 21:51:03 INFO - "slavebuilddir": "test" 21:51:03 INFO - } 21:51:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/Vz4sCykWS5mpqFB9fwS0eQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2. 21:51:03 INFO - Running post-action listener: _resource_record_post_action 21:51:03 INFO - [mozharness: 2016-12-22 05:51:03.869938Z] Finished read-buildbot-config step (success) 21:51:03 INFO - [mozharness: 2016-12-22 05:51:03.870027Z] Running download-and-extract step. 21:51:03 INFO - Running pre-action listener: _resource_record_pre_action 21:51:03 INFO - Running main action method: download_and_extract 21:51:03 INFO - mkdir: /builds/slave/test/build/tests 21:51:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:51:03 INFO - trying https://queue.taskcluster.net/v1/task/Vz4sCykWS5mpqFB9fwS0eQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.test_packages.json 21:51:03 INFO - Downloading https://queue.taskcluster.net/v1/task/Vz4sCykWS5mpqFB9fwS0eQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.test_packages.json 21:51:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Vz4sCykWS5mpqFB9fwS0eQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 21:51:04 INFO - Downloaded 1327 bytes. 21:51:04 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.test_packages.json 21:51:04 INFO - Using the following test package requirements: 21:51:04 INFO - {u'common': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip'], 21:51:04 INFO - u'cppunittest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 21:51:04 INFO - u'firefox-51.0.en-US.linux-x86_64.cppunittest.tests.zip'], 21:51:04 INFO - u'gtest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 21:51:04 INFO - u'firefox-51.0.en-US.linux-x86_64.gtest.tests.zip'], 21:51:04 INFO - u'jittest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 21:51:04 INFO - u'jsshell-linux-x86_64.zip'], 21:51:04 INFO - u'mochitest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 21:51:04 INFO - u'firefox-51.0.en-US.linux-x86_64.mochitest.tests.zip'], 21:51:04 INFO - u'mozbase': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip'], 21:51:04 INFO - u'reftest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 21:51:04 INFO - u'firefox-51.0.en-US.linux-x86_64.reftest.tests.zip'], 21:51:04 INFO - u'talos': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 21:51:04 INFO - u'firefox-51.0.en-US.linux-x86_64.talos.tests.zip'], 21:51:04 INFO - u'web-platform': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 21:51:04 INFO - u'firefox-51.0.en-US.linux-x86_64.web-platform.tests.zip'], 21:51:04 INFO - u'xpcshell': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 21:51:04 INFO - u'firefox-51.0.en-US.linux-x86_64.xpcshell.tests.zip']} 21:51:04 INFO - Downloading packages: [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:51:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Vz4sCykWS5mpqFB9fwS0eQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip 21:51:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Vz4sCykWS5mpqFB9fwS0eQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:51:04 INFO - Fetch https://queue.taskcluster.net/v1/task/Vz4sCykWS5mpqFB9fwS0eQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip into memory 21:51:05 INFO - Expected file size: 21964018 21:51:09 INFO - Downloading packages: [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 21:51:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Vz4sCykWS5mpqFB9fwS0eQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip 21:51:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Vz4sCykWS5mpqFB9fwS0eQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:51:09 INFO - Fetch https://queue.taskcluster.net/v1/task/Vz4sCykWS5mpqFB9fwS0eQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip into memory 21:51:10 INFO - Expected file size: 21964018 21:51:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Vz4sCykWS5mpqFB9fwS0eQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.talos.tests.zip 21:51:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Vz4sCykWS5mpqFB9fwS0eQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 21:51:14 INFO - Fetch https://queue.taskcluster.net/v1/task/Vz4sCykWS5mpqFB9fwS0eQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.talos.tests.zip into memory 21:51:15 INFO - Expected file size: 14414089 21:51:15 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')]} 21:51:15 INFO - trying https://queue.taskcluster.net/v1/task/Vz4sCykWS5mpqFB9fwS0eQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 21:51:15 INFO - Downloading https://queue.taskcluster.net/v1/task/Vz4sCykWS5mpqFB9fwS0eQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 21:51:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Vz4sCykWS5mpqFB9fwS0eQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 21:51:19 INFO - Downloaded 56935234 bytes. 21:51:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Vz4sCykWS5mpqFB9fwS0eQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 21:51:19 INFO - mkdir: /builds/slave/test/properties 21:51:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:51:19 INFO - Writing to file /builds/slave/test/properties/build_url 21:51:19 INFO - Contents: 21:51:19 INFO - build_url:https://queue.taskcluster.net/v1/task/Vz4sCykWS5mpqFB9fwS0eQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 21:51:19 INFO - Running post-action listener: _resource_record_post_action 21:51:19 INFO - Running post-action listener: set_extra_try_arguments 21:51:19 INFO - [mozharness: 2016-12-22 05:51:19.807903Z] Finished download-and-extract step (success) 21:51:19 INFO - [mozharness: 2016-12-22 05:51:19.808131Z] Running populate-webroot step. 21:51:19 INFO - Running pre-action listener: _resource_record_pre_action 21:51:19 INFO - Running main action method: populate_webroot 21:51:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:51:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:51:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:51:19 INFO - '--tppagecycles', 21:51:19 INFO - '7'], 21:51:19 INFO - 'tests': ['tsvgm']}}, 21:51:19 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:51:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:51:19 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:51:19 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:51:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:51:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:51:19 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:51:19 INFO - 'talos_options': ['--disable-e10s'], 21:51:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:51:19 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:51:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:51:19 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:51:19 INFO - 'talos_options': ['--disable-e10s'], 21:51:19 INFO - 'tests': ['damp', 'tps']}, 21:51:19 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:51:19 INFO - 'tests': ['damp', 'tps']}, 21:51:19 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:51:19 INFO - 'tests': ['dromaeo_dom']}, 21:51:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:51:19 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:51:19 INFO - 'tests': ['basic_compositor_video']}, 21:51:19 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:51:19 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:51:19 INFO - 'tests': ['a11yr', 21:51:19 INFO - 'ts_paint', 21:51:19 INFO - 'tpaint', 21:51:19 INFO - 'sessionrestore', 21:51:19 INFO - 'sessionrestore_no_auto_restore', 21:51:19 INFO - 'tabpaint']}, 21:51:19 INFO - 'other-e10s': {'tests': ['a11yr', 21:51:19 INFO - 'ts_paint', 21:51:19 INFO - 'tpaint', 21:51:19 INFO - 'sessionrestore', 21:51:19 INFO - 'sessionrestore_no_auto_restore', 21:51:19 INFO - 'tabpaint']}, 21:51:19 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:51:19 INFO - 'ts_paint', 21:51:19 INFO - 'tpaint', 21:51:19 INFO - 'sessionrestore', 21:51:19 INFO - 'sessionrestore_no_auto_restore', 21:51:19 INFO - 'tabpaint']}, 21:51:19 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:51:19 INFO - 'ts_paint', 21:51:19 INFO - 'tpaint', 21:51:19 INFO - 'sessionrestore', 21:51:19 INFO - 'sessionrestore_no_auto_restore', 21:51:19 INFO - 'tabpaint']}, 21:51:19 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:51:19 INFO - 'tests': ['a11yr', 21:51:19 INFO - 'ts_paint', 21:51:19 INFO - 'tpaint', 21:51:19 INFO - 'sessionrestore', 21:51:19 INFO - 'sessionrestore_no_auto_restore', 21:51:19 INFO - 'tabpaint']}, 21:51:19 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:51:19 INFO - 'tests': ['a11yr', 21:51:19 INFO - 'ts_paint', 21:51:19 INFO - 'tpaint', 21:51:19 INFO - 'sessionrestore', 21:51:19 INFO - 'sessionrestore_no_auto_restore', 21:51:19 INFO - 'tabpaint']}, 21:51:19 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:51:19 INFO - 'tests': ['tsvgx', 21:51:19 INFO - 'tsvgr_opacity', 21:51:19 INFO - 'tart', 21:51:19 INFO - 'tscrollx', 21:51:19 INFO - 'cart']}, 21:51:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:51:19 INFO - 'tsvgr_opacity', 21:51:19 INFO - 'tart', 21:51:19 INFO - 'tscrollx', 21:51:19 INFO - 'cart']}, 21:51:19 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:51:19 INFO - 'talos_options': ['--disable-e10s'], 21:51:19 INFO - 'tests': ['tp5o']}, 21:51:19 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:51:19 INFO - 'tests': ['tp5o']}, 21:51:19 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:51:19 INFO - 'talos_options': ['--disable-e10s', 21:51:19 INFO - '--xperf_path', 21:51:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:51:19 INFO - 'tests': ['tp5n']}, 21:51:19 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:51:19 INFO - 'talos_options': ['--xperf_path', 21:51:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:51:19 INFO - 'tests': ['tp5n']}}, 21:51:19 INFO - 'talos.zip': {'path': '', 21:51:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:51:19 INFO - Running post-action listener: _resource_record_post_action 21:51:19 INFO - [mozharness: 2016-12-22 05:51:19.824615Z] Finished populate-webroot step (success) 21:51:19 INFO - [mozharness: 2016-12-22 05:51:19.824714Z] Running create-virtualenv step. 21:51:19 INFO - Running pre-action listener: _resource_record_pre_action 21:51:19 INFO - Running main action method: create_virtualenv 21:51:19 INFO - Creating virtualenv /builds/slave/test/build/venv 21:51:19 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 21:51:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:51:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:51:19 INFO - Using real prefix '/usr' 21:51:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:51:20 INFO - Installing distribute.............................................................................................................................................................................................done. 21:51:22 INFO - Installing pip.................done. 21:51:22 INFO - Return code: 0 21:51:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:51:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:51:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:51:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:51:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:51:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:51:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:51:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff357c39f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd7aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd77f60>, '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 0xd78d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd791d0>, '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': 'fa44defc139c4ba8574fe040000001db-1482384360.637384-427996043', '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 21:51:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 21:51:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 21:51:22 INFO - Using env: {'DISPLAY': ':0', 21:51:22 INFO - 'HOME': '/home/cltbld', 21:51:22 INFO - 'LANG': 'en_US.UTF-8', 21:51:22 INFO - 'LANGUAGE': 'en_US:en', 21:51:22 INFO - 'LOGNAME': 'cltbld', 21:51:22 INFO - 'MAIL': '/var/mail/cltbld', 21:51:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:51:22 INFO - 'MOZ_NO_REMOTE': '1', 21:51:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:51:22 INFO - 'NO_EM_RESTART': '1', 21:51:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:51:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:51:22 INFO - 'PWD': '/builds/slave/test', 21:51:22 INFO - 'SHELL': '/bin/bash', 21:51:22 INFO - 'SHLVL': '1', 21:51:22 INFO - 'TERM': 'linux', 21:51:22 INFO - 'TMOUT': '86400', 21:51:22 INFO - 'USER': 'cltbld', 21:51:22 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1482384360.637384-427996043', 21:51:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:51:22 INFO - '_': '/tools/buildbot/bin/python'} 21:51:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:51:22 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 21:51:22 INFO - Cleaning up... 21:51:22 INFO - Return code: 0 21:51:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:51:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:51:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:51:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:51:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:51:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:51:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:51:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff357c39f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd7aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd77f60>, '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 0xd78d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd791d0>, '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': 'fa44defc139c4ba8574fe040000001db-1482384360.637384-427996043', '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 21:51:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 21:51:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 21:51:22 INFO - Using env: {'DISPLAY': ':0', 21:51:22 INFO - 'HOME': '/home/cltbld', 21:51:22 INFO - 'LANG': 'en_US.UTF-8', 21:51:22 INFO - 'LANGUAGE': 'en_US:en', 21:51:22 INFO - 'LOGNAME': 'cltbld', 21:51:22 INFO - 'MAIL': '/var/mail/cltbld', 21:51:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:51:22 INFO - 'MOZ_NO_REMOTE': '1', 21:51:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:51:22 INFO - 'NO_EM_RESTART': '1', 21:51:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:51:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:51:22 INFO - 'PWD': '/builds/slave/test', 21:51:22 INFO - 'SHELL': '/bin/bash', 21:51:22 INFO - 'SHLVL': '1', 21:51:22 INFO - 'TERM': 'linux', 21:51:22 INFO - 'TMOUT': '86400', 21:51:22 INFO - 'USER': 'cltbld', 21:51:22 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1482384360.637384-427996043', 21:51:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:51:22 INFO - '_': '/tools/buildbot/bin/python'} 21:51:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:51:22 INFO - Downloading/unpacking psutil>=3.1.1 21:51:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:51:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:51:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:51:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:51:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:51:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:51:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:51:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:51:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:51:24 INFO - Installing collected packages: psutil 21:51:24 INFO - Running setup.py install for psutil 21:51:25 INFO - building 'psutil._psutil_linux' extension 21:51:25 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 21:51:25 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 21:51:25 INFO - building 'psutil._psutil_posix' extension 21:51:25 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 21:51:25 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 21:51:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:51:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:51:25 INFO - Successfully installed psutil 21:51:25 INFO - Cleaning up... 21:51:25 INFO - Return code: 0 21:51:25 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:51:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:51:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:51:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:51:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:51:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:51:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:51:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff357c39f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd7aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd77f60>, '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 0xd78d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd791d0>, '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': 'fa44defc139c4ba8574fe040000001db-1482384360.637384-427996043', '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 21:51:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 21:51:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 21:51:25 INFO - Using env: {'DISPLAY': ':0', 21:51:25 INFO - 'HOME': '/home/cltbld', 21:51:25 INFO - 'LANG': 'en_US.UTF-8', 21:51:25 INFO - 'LANGUAGE': 'en_US:en', 21:51:25 INFO - 'LOGNAME': 'cltbld', 21:51:25 INFO - 'MAIL': '/var/mail/cltbld', 21:51:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:51:25 INFO - 'MOZ_NO_REMOTE': '1', 21:51:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:51:25 INFO - 'NO_EM_RESTART': '1', 21:51:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:51:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:51:25 INFO - 'PWD': '/builds/slave/test', 21:51:25 INFO - 'SHELL': '/bin/bash', 21:51:25 INFO - 'SHLVL': '1', 21:51:25 INFO - 'TERM': 'linux', 21:51:25 INFO - 'TMOUT': '86400', 21:51:25 INFO - 'USER': 'cltbld', 21:51:25 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1482384360.637384-427996043', 21:51:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:51:25 INFO - '_': '/tools/buildbot/bin/python'} 21:51:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:51:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:51:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:51:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:51:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:51:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:51:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:51:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:51:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:51:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:51:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:51:27 INFO - Installing collected packages: mozsystemmonitor 21:51:27 INFO - Running setup.py install for mozsystemmonitor 21:51:27 INFO - Successfully installed mozsystemmonitor 21:51:27 INFO - Cleaning up... 21:51:27 INFO - Return code: 0 21:51:27 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:51: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')]} 21:51:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:51:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:51: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')]} 21:51:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:51:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:51:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff357c39f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd7aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd77f60>, '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 0xd78d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd791d0>, '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': 'fa44defc139c4ba8574fe040000001db-1482384360.637384-427996043', '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 21:51:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 21:51:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 21:51:27 INFO - Using env: {'DISPLAY': ':0', 21:51:27 INFO - 'HOME': '/home/cltbld', 21:51:27 INFO - 'LANG': 'en_US.UTF-8', 21:51:27 INFO - 'LANGUAGE': 'en_US:en', 21:51:27 INFO - 'LOGNAME': 'cltbld', 21:51:27 INFO - 'MAIL': '/var/mail/cltbld', 21:51:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:51:27 INFO - 'MOZ_NO_REMOTE': '1', 21:51:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:51:27 INFO - 'NO_EM_RESTART': '1', 21:51:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:51:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:51:27 INFO - 'PWD': '/builds/slave/test', 21:51:27 INFO - 'SHELL': '/bin/bash', 21:51:27 INFO - 'SHLVL': '1', 21:51:27 INFO - 'TERM': 'linux', 21:51:27 INFO - 'TMOUT': '86400', 21:51:27 INFO - 'USER': 'cltbld', 21:51:27 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1482384360.637384-427996043', 21:51:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:51:27 INFO - '_': '/tools/buildbot/bin/python'} 21:51:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:51:28 INFO - Downloading/unpacking jsonschema==2.5.1 21:51:28 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 21:51:28 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 21:51:28 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 21:51:28 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 21:51:28 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 21:51:28 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 21:51:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:51:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:51:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:51:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:51:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:51:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:51:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:51:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:51:30 INFO - Downloading functools32-3.2.3-2.tar.gz 21:51:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:51:30 INFO - warning: no files found matching '*.txt' 21:51:30 INFO - no previously-included directories found matching 'build' 21:51:30 INFO - no previously-included directories found matching 'dist' 21:51:30 INFO - no previously-included directories found matching '.git*' 21:51:30 INFO - Installing collected packages: jsonschema, functools32 21:51:30 INFO - Running setup.py install for functools32 21:51:30 INFO - warning: no files found matching '*.txt' 21:51:30 INFO - no previously-included directories found matching 'build' 21:51:30 INFO - no previously-included directories found matching 'dist' 21:51:30 INFO - no previously-included directories found matching '.git*' 21:51:30 INFO - Successfully installed jsonschema functools32 21:51:30 INFO - Cleaning up... 21:51:30 INFO - Return code: 0 21:51:30 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:51:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:51:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:51:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:51:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:51:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:51:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:51:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff357c39f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd7aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd77f60>, '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 0xd78d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd791d0>, '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': 'fa44defc139c4ba8574fe040000001db-1482384360.637384-427996043', '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 21:51:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 21:51:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 21:51:30 INFO - Using env: {'DISPLAY': ':0', 21:51:30 INFO - 'HOME': '/home/cltbld', 21:51:30 INFO - 'LANG': 'en_US.UTF-8', 21:51:30 INFO - 'LANGUAGE': 'en_US:en', 21:51:30 INFO - 'LOGNAME': 'cltbld', 21:51:30 INFO - 'MAIL': '/var/mail/cltbld', 21:51:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:51:30 INFO - 'MOZ_NO_REMOTE': '1', 21:51:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:51:30 INFO - 'NO_EM_RESTART': '1', 21:51:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:51:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:51:30 INFO - 'PWD': '/builds/slave/test', 21:51:30 INFO - 'SHELL': '/bin/bash', 21:51:30 INFO - 'SHLVL': '1', 21:51:30 INFO - 'TERM': 'linux', 21:51:30 INFO - 'TMOUT': '86400', 21:51:30 INFO - 'USER': 'cltbld', 21:51:30 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1482384360.637384-427996043', 21:51:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:51:30 INFO - '_': '/tools/buildbot/bin/python'} 21:51:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:51:30 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:51:30 INFO - Cleaning up... 21:51:30 INFO - Return code: 0 21:51:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:51:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:51:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:51:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:51:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:51:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:51:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:51:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff357c39f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd7aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd77f60>, '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 0xd78d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd791d0>, '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': 'fa44defc139c4ba8574fe040000001db-1482384360.637384-427996043', '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 21:51:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 21:51:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 21:51:30 INFO - Using env: {'DISPLAY': ':0', 21:51:30 INFO - 'HOME': '/home/cltbld', 21:51:30 INFO - 'LANG': 'en_US.UTF-8', 21:51:30 INFO - 'LANGUAGE': 'en_US:en', 21:51:30 INFO - 'LOGNAME': 'cltbld', 21:51:30 INFO - 'MAIL': '/var/mail/cltbld', 21:51:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:51:30 INFO - 'MOZ_NO_REMOTE': '1', 21:51:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:51:30 INFO - 'NO_EM_RESTART': '1', 21:51:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:51:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:51:30 INFO - 'PWD': '/builds/slave/test', 21:51:30 INFO - 'SHELL': '/bin/bash', 21:51:30 INFO - 'SHLVL': '1', 21:51:30 INFO - 'TERM': 'linux', 21:51:30 INFO - 'TMOUT': '86400', 21:51:30 INFO - 'USER': 'cltbld', 21:51:30 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1482384360.637384-427996043', 21:51:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:51:30 INFO - '_': '/tools/buildbot/bin/python'} 21:51:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:51:31 INFO - Downloading/unpacking blobuploader==1.2.4 21:51:31 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 21:51:31 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 21:51:31 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 21:51:31 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 21:51:31 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 21:51:31 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 21:51:33 INFO - Downloading blobuploader-1.2.4.tar.gz 21:51:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:51:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:51:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:51:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:51:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:51:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:51:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:51:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:51:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:51:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:51:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:51:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:51:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:51:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:51:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:51:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:51:33 INFO - Downloading docopt-0.6.1.tar.gz 21:51:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:51:33 INFO - Installing collected packages: blobuploader, requests, docopt 21:51:33 INFO - Running setup.py install for blobuploader 21:51:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:51:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:51:33 INFO - Running setup.py install for requests 21:51:34 INFO - Running setup.py install for docopt 21:51:34 INFO - Successfully installed blobuploader requests docopt 21:51:34 INFO - Cleaning up... 21:51:34 INFO - Return code: 0 21:51:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:51:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:51:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:51:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:51:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:51:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:51:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:51:34 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 0x7ff357c39f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd7aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd77f60>, '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 0xd78d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd791d0>, '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': 'fa44defc139c4ba8574fe040000001db-1482384360.637384-427996043', '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 21:51:34 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 21:51:34 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 21:51:34 INFO - Using env: {'DISPLAY': ':0', 21:51:34 INFO - 'HOME': '/home/cltbld', 21:51:34 INFO - 'LANG': 'en_US.UTF-8', 21:51:34 INFO - 'LANGUAGE': 'en_US:en', 21:51:34 INFO - 'LOGNAME': 'cltbld', 21:51:34 INFO - 'MAIL': '/var/mail/cltbld', 21:51:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:51:34 INFO - 'MOZ_NO_REMOTE': '1', 21:51:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:51:34 INFO - 'NO_EM_RESTART': '1', 21:51:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:51:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:51:34 INFO - 'PWD': '/builds/slave/test', 21:51:34 INFO - 'SHELL': '/bin/bash', 21:51:34 INFO - 'SHLVL': '1', 21:51:34 INFO - 'TERM': 'linux', 21:51:34 INFO - 'TMOUT': '86400', 21:51:34 INFO - 'USER': 'cltbld', 21:51:34 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1482384360.637384-427996043', 21:51:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:51:34 INFO - '_': '/tools/buildbot/bin/python'} 21:51:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:51:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:51:34 INFO - Running setup.py (path:/tmp/pip-o1RItT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:51:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:51:34 INFO - Running setup.py (path:/tmp/pip-0whCH4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:51:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:51:34 INFO - Running setup.py (path:/tmp/pip-vPCpdi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:51:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:51:34 INFO - Running setup.py (path:/tmp/pip-j4iOhA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:51:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:51:34 INFO - Running setup.py (path:/tmp/pip-E737BG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:51:35 INFO - Running setup.py (path:/tmp/pip-B69o9O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:51:35 INFO - Running setup.py (path:/tmp/pip-zA6hgF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:51:35 INFO - Running setup.py (path:/tmp/pip-8n3kuR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:51:35 INFO - Running setup.py (path:/tmp/pip-ekNnwg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:51:35 INFO - Running setup.py (path:/tmp/pip-ZCq6kH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:51:35 INFO - Running setup.py (path:/tmp/pip-USznrj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:51:35 INFO - Running setup.py (path:/tmp/pip-DtcmFs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:51:35 INFO - Running setup.py (path:/tmp/pip-lVqb8c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:51:35 INFO - Running setup.py (path:/tmp/pip-6LMNZb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:51:35 INFO - Running setup.py (path:/tmp/pip-ZULZbn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:51:35 INFO - Running setup.py (path:/tmp/pip-yaLfbq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:51:35 INFO - Running setup.py (path:/tmp/pip-JUOGaa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:51:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:51:35 INFO - Running setup.py install for manifestparser 21:51:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:51:36 INFO - Running setup.py install for mozcrash 21:51:36 INFO - Running setup.py install for mozdebug 21:51:36 INFO - Running setup.py install for mozdevice 21:51:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:51:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:51:36 INFO - Running setup.py install for mozfile 21:51:36 INFO - Running setup.py install for mozhttpd 21:51:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:51:36 INFO - Running setup.py install for mozinfo 21:51:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:51:36 INFO - Running setup.py install for mozInstall 21:51:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:51:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:51:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:51:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:51:36 INFO - Running setup.py install for mozleak 21:51:36 INFO - Running setup.py install for mozlog 21:51:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:51:36 INFO - Running setup.py install for moznetwork 21:51:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:51:37 INFO - Running setup.py install for mozprocess 21:51:37 INFO - Running setup.py install for mozprofile 21:51:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:51:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:51:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:51:37 INFO - Running setup.py install for mozrunner 21:51:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:51:37 INFO - Running setup.py install for mozscreenshot 21:51:37 INFO - Running setup.py install for moztest 21:51:37 INFO - Running setup.py install for mozversion 21:51:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:51:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:51:37 INFO - Cleaning up... 21:51:37 INFO - Return code: 0 21:51:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:51:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:51:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:51:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:51:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:51:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:51:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:51:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff357c39f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd7aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd77f60>, '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 0xd78d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd791d0>, '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': 'fa44defc139c4ba8574fe040000001db-1482384360.637384-427996043', '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 21:51:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 21:51:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:51:37 INFO - Using env: {'DISPLAY': ':0', 21:51:37 INFO - 'HOME': '/home/cltbld', 21:51:37 INFO - 'LANG': 'en_US.UTF-8', 21:51:37 INFO - 'LANGUAGE': 'en_US:en', 21:51:37 INFO - 'LOGNAME': 'cltbld', 21:51:37 INFO - 'MAIL': '/var/mail/cltbld', 21:51:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:51:37 INFO - 'MOZ_NO_REMOTE': '1', 21:51:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:51:37 INFO - 'NO_EM_RESTART': '1', 21:51:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:51:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:51:37 INFO - 'PWD': '/builds/slave/test', 21:51:37 INFO - 'SHELL': '/bin/bash', 21:51:37 INFO - 'SHLVL': '1', 21:51:37 INFO - 'TERM': 'linux', 21:51:37 INFO - 'TMOUT': '86400', 21:51:37 INFO - 'USER': 'cltbld', 21:51:37 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1482384360.637384-427996043', 21:51:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:51:37 INFO - '_': '/tools/buildbot/bin/python'} 21:51:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:51:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:51:37 INFO - Running setup.py (path:/tmp/pip-X2p0VL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:51:38 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)) 21:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:51:38 INFO - Running setup.py (path:/tmp/pip-DoP8d3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:51:38 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)) 21:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:51:38 INFO - Running setup.py (path:/tmp/pip-bvwUtC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:51:38 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)) 21:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:51:38 INFO - Running setup.py (path:/tmp/pip-7Ui7iP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:51:38 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)) 21:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:51:38 INFO - Running setup.py (path:/tmp/pip-2tr2dz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:51:38 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)) 21:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:51:38 INFO - Running setup.py (path:/tmp/pip-PqfoLR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:51:38 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)) 21:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:51:38 INFO - Running setup.py (path:/tmp/pip-n_tvIa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:51:38 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)) 21:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:51:38 INFO - Running setup.py (path:/tmp/pip-0ZTrb1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:51:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 21:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:51:38 INFO - Running setup.py (path:/tmp/pip-fFvVA7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:51:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 21:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:51:38 INFO - Running setup.py (path:/tmp/pip-fZBu7W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:51:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:51:38 INFO - Running setup.py (path:/tmp/pip-oq1BW6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:51:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 21:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:51:38 INFO - Running setup.py (path:/tmp/pip-44ARAy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:51:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 21:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:51:38 INFO - Running setup.py (path:/tmp/pip-3b8a76-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:51:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 21:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:51:38 INFO - Running setup.py (path:/tmp/pip-9EC37p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:51:38 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)) 21:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:51:38 INFO - Running setup.py (path:/tmp/pip-RsB4k3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:51:39 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)) 21:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:51:39 INFO - Running setup.py (path:/tmp/pip-PVcyGN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:51:39 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)) 21:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:51:39 INFO - Running setup.py (path:/tmp/pip-BybsdT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:51:39 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)) 21:51:39 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)) 21:51:39 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)) 21:51:39 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)) 21:51:39 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)) 21:51:39 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)) 21:51:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:51:39 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 21:51:39 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 21:51:39 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 21:51:39 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 21:51:39 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 21:51:39 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 21:51:41 INFO - Downloading blessings-1.6.tar.gz 21:51:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:51:41 INFO - Installing collected packages: blessings 21:51:41 INFO - Running setup.py install for blessings 21:51:41 INFO - Successfully installed blessings 21:51:41 INFO - Cleaning up... 21:51:41 INFO - Return code: 0 21:51:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:51:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:51:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:51:41 INFO - Reading from file tmpfile_stdout 21:51:41 INFO - Current package versions: 21:51:41 INFO - argparse == 1.2.1 21:51:41 INFO - blessings == 1.6 21:51:41 INFO - blobuploader == 1.2.4 21:51:41 INFO - docopt == 0.6.1 21:51:41 INFO - functools32 == 3.2.3-2 21:51:41 INFO - jsonschema == 2.5.1 21:51:41 INFO - manifestparser == 1.1 21:51:41 INFO - mozInstall == 1.12 21:51:41 INFO - mozcrash == 0.17 21:51:41 INFO - mozdebug == 0.1 21:51:41 INFO - mozdevice == 0.48 21:51:41 INFO - mozfile == 1.2 21:51:41 INFO - mozhttpd == 0.7 21:51:41 INFO - mozinfo == 0.9 21:51:41 INFO - mozleak == 0.1 21:51:41 INFO - mozlog == 3.4 21:51:41 INFO - moznetwork == 0.27 21:51:41 INFO - mozprocess == 0.23 21:51:41 INFO - mozprofile == 0.28 21:51:41 INFO - mozrunner == 6.12 21:51:41 INFO - mozscreenshot == 0.1 21:51:41 INFO - mozsystemmonitor == 0.3 21:51:41 INFO - moztest == 0.7 21:51:41 INFO - mozversion == 1.4 21:51:41 INFO - psutil == 3.1.1 21:51:41 INFO - requests == 1.2.3 21:51:41 INFO - wsgiref == 0.1.2 21:51:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:51:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:51:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:51:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:51:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:51:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:51:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:51:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff357c39f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd7aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd77f60>, '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 0xd78d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd791d0>, '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': 'fa44defc139c4ba8574fe040000001db-1482384360.637384-427996043', '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 21:51:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 21:51:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:51:41 INFO - Using env: {'DISPLAY': ':0', 21:51:41 INFO - 'HOME': '/home/cltbld', 21:51:41 INFO - 'LANG': 'en_US.UTF-8', 21:51:41 INFO - 'LANGUAGE': 'en_US:en', 21:51:41 INFO - 'LOGNAME': 'cltbld', 21:51:41 INFO - 'MAIL': '/var/mail/cltbld', 21:51:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:51:41 INFO - 'MOZ_NO_REMOTE': '1', 21:51:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:51:41 INFO - 'NO_EM_RESTART': '1', 21:51:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:51:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:51:41 INFO - 'PWD': '/builds/slave/test', 21:51:41 INFO - 'SHELL': '/bin/bash', 21:51:41 INFO - 'SHLVL': '1', 21:51:41 INFO - 'TERM': 'linux', 21:51:41 INFO - 'TMOUT': '86400', 21:51:41 INFO - 'USER': 'cltbld', 21:51:41 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1482384360.637384-427996043', 21:51:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:51:41 INFO - '_': '/tools/buildbot/bin/python'} 21:51:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:51:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 21:51:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 21:51:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 21:51:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 21:51:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 21:51:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 21:51:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 21:51:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 21:51:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 21:51:41 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 21:51:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 21:51:41 INFO - Cleaning up... 21:51:41 INFO - Return code: 0 21:51:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:51:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:51:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:51:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:51:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:51:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:51:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:51:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff357c39f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd7aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd77f60>, '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 0xd78d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd791d0>, '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': 'fa44defc139c4ba8574fe040000001db-1482384360.637384-427996043', '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 21:51:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 21:51:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 21:51:41 INFO - Using env: {'DISPLAY': ':0', 21:51:41 INFO - 'HOME': '/home/cltbld', 21:51:41 INFO - 'LANG': 'en_US.UTF-8', 21:51:41 INFO - 'LANGUAGE': 'en_US:en', 21:51:41 INFO - 'LOGNAME': 'cltbld', 21:51:41 INFO - 'MAIL': '/var/mail/cltbld', 21:51:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:51:41 INFO - 'MOZ_NO_REMOTE': '1', 21:51:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:51:41 INFO - 'NO_EM_RESTART': '1', 21:51:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:51:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:51:41 INFO - 'PWD': '/builds/slave/test', 21:51:41 INFO - 'SHELL': '/bin/bash', 21:51:41 INFO - 'SHLVL': '1', 21:51:41 INFO - 'TERM': 'linux', 21:51:41 INFO - 'TMOUT': '86400', 21:51:41 INFO - 'USER': 'cltbld', 21:51:41 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1482384360.637384-427996043', 21:51:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:51:41 INFO - '_': '/tools/buildbot/bin/python'} 21:51:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:51:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:51:42 INFO - Cleaning up... 21:51:42 INFO - Return code: 0 21:51:42 INFO - Running post-action listener: _resource_record_post_action 21:51:42 INFO - Running post-action listener: _start_resource_monitoring 21:51:42 INFO - Starting resource monitoring. 21:51:42 INFO - [mozharness: 2016-12-22 05:51:42.125912Z] Finished create-virtualenv step (success) 21:51:42 INFO - [mozharness: 2016-12-22 05:51:42.126417Z] Running install step. 21:51:42 INFO - Running pre-action listener: _resource_record_pre_action 21:51:42 INFO - Running main action method: install 21:51:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:51:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:51:42 INFO - Reading from file tmpfile_stdout 21:51:42 INFO - Detecting whether we're running mozinstall >=1.0... 21:51:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:51:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:51:42 INFO - Reading from file tmpfile_stdout 21:51:42 INFO - Output received: 21:51:42 INFO - Usage: mozinstall [options] installer 21:51:42 INFO - Options: 21:51:42 INFO - -h, --help show this help message and exit 21:51:42 INFO - -d DEST, --destination=DEST 21:51:42 INFO - Directory to install application into. [default: 21:51:42 INFO - "/builds/slave/test"] 21:51:42 INFO - --app=APP Application being installed. [default: firefox] 21:51:42 INFO - mkdir: /builds/slave/test/build/application 21:51:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 21:51:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 21:51:55 INFO - Reading from file tmpfile_stdout 21:51:55 INFO - Output received: 21:51:55 INFO - /builds/slave/test/build/application/firefox/firefox 21:51:55 INFO - Running post-action listener: _resource_record_post_action 21:51:55 INFO - [mozharness: 2016-12-22 05:51:55.981381Z] Finished install step (success) 21:51:55 INFO - [mozharness: 2016-12-22 05:51:55.981713Z] Running run-tests step. 21:51:55 INFO - Running pre-action listener: _resource_record_pre_action 21:51:55 INFO - Running main action method: run_tests 21:51:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:51:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:51:55 INFO - Python 2.7.3 21:51:55 INFO - Return code: 0 21:51:55 INFO - grabbing minidump binary from tooltool 21:51:55 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')]} 21:51:55 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 0xd77f60>, '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 0xd78d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd791d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:51:55 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 21:51:55 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 21:51:55 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 21:51:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:51:56 INFO - Return code: 0 21:51:56 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:51:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:51:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:51:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:51:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:51:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Vz4sCykWS5mpqFB9fwS0eQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--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 21:51:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Vz4sCykWS5mpqFB9fwS0eQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-048 --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 21:51:56 INFO - Using env: {'DISPLAY': ':0', 21:51:56 INFO - 'HOME': '/home/cltbld', 21:51:56 INFO - 'LANG': 'en_US.UTF-8', 21:51:56 INFO - 'LANGUAGE': 'en_US:en', 21:51:56 INFO - 'LOGNAME': 'cltbld', 21:51:56 INFO - 'MAIL': '/var/mail/cltbld', 21:51:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:51:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:51:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:51:56 INFO - 'MOZ_NO_REMOTE': '1', 21:51:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:51:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:51:56 INFO - 'NO_EM_RESTART': '1', 21:51:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:51:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:51:56 INFO - 'PWD': '/builds/slave/test', 21:51:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:51:56 INFO - 'SHELL': '/bin/bash', 21:51:56 INFO - 'SHLVL': '1', 21:51:56 INFO - 'TERM': 'linux', 21:51:56 INFO - 'TMOUT': '86400', 21:51:56 INFO - 'USER': 'cltbld', 21:51:56 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1482384360.637384-427996043', 21:51:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:51:56 INFO - '_': '/tools/buildbot/bin/python'} 21:51:56 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Vz4sCykWS5mpqFB9fwS0eQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--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 21:51:56 INFO - mozversion application_buildid: 20161221200752 21:51:56 INFO - mozversion application_changeset: 67d97463e755c0987c8bf452bb6fe9b733621409 21:51:56 INFO - mozversion application_display_name: Firefox 21:51:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:51:56 INFO - mozversion application_name: Firefox 21:51:56 INFO - mozversion application_remotingname: firefox 21:51:56 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 21:51:56 INFO - mozversion application_vendor: Mozilla 21:51:56 INFO - mozversion application_version: 51.0 21:51:56 INFO - mozversion platform_buildid: 20161221200752 21:51:56 INFO - mozversion platform_changeset: 67d97463e755c0987c8bf452bb6fe9b733621409 21:51:56 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 21:51:56 INFO - mozversion platform_version: 51.0 21:51:56 INFO - using testdate: 1482385916 21:51:56 INFO - actual date: 1482385916 21:51:56 INFO - starting webserver on 'localhost:49230' 21:51:56 INFO - SUITE-START | Running 2 tests 21:51:56 INFO - TEST-START | dromaeo_css 21:51:56 INFO - operating with platform_type : linux_ 21:51:56 INFO - Initialising browser for dromaeo_css test... 21:51:56 INFO - TEST-INFO | started process 9353 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpn97sYA/profile http://localhost:49230/getInfo.html) 21:52:00 INFO - PROCESS | 9353 | __metrics Screen width/height:1600/1200 21:52:00 INFO - PROCESS | 9353 | colorDepth:24 21:52:00 INFO - PROCESS | 9353 | Browser inner width/height: 1024/697 21:52:00 INFO - PROCESS | 9353 | __metrics 21:52:00 INFO - PROCESS | 9353 | 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" 21:52:00 INFO - PROCESS | 9353 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:52:01 INFO - PROCESS | 9353 | console.error: PushService: 21:52:01 INFO - PROCESS | 9353 | stateChangeProcessEnqueue: Error transitioning state 21:52:01 INFO - PROCESS | 9353 | UnknownError 21:52:01 INFO - TEST-INFO | 9353: exit 0 21:52:01 INFO - Browser initialized. 21:52:01 INFO - Running cycle 1/1 for dromaeo_css test... 21:52:01 INFO - TEST-INFO | started process 9446 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpn97sYA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:52:13 INFO - PROCESS | 9446 | RSS: Main: 142929920 21:52:13 INFO - PROCESS | 9446 | 21:53:04 INFO - PROCESS | 9446 | 1482385984754 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] 21:55:14 INFO - PROCESS | 9446 | Cycle 1(1): loaded http://localhost:49230/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49230/tests/dromaeo/cssquery-ext.html) 21:55:15 INFO - PROCESS | 9446 | RSS: Main: 237010944 21:55:15 INFO - PROCESS | 9446 | 21:58:17 INFO - PROCESS | 9446 | Cycle 1(1): loaded http://localhost:49230/tests/dromaeo/cssquery-ext.html (next: http://localhost:49230/tests/dromaeo/cssquery-jquery.html) 21:58:17 INFO - PROCESS | 9446 | RSS: Main: 236687360 21:58:17 INFO - PROCESS | 9446 | 22:01:19 INFO - PROCESS | 9446 | Cycle 1(1): loaded http://localhost:49230/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49230/tests/dromaeo/cssquery-mootools.html) 22:01:20 INFO - PROCESS | 9446 | RSS: Main: 209461248 22:01:20 INFO - PROCESS | 9446 | 22:04:22 INFO - PROCESS | 9446 | Cycle 1(1): loaded http://localhost:49230/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49230/tests/dromaeo/cssquery-prototype.html) 22:04:22 INFO - PROCESS | 9446 | RSS: Main: 225075200 22:04:22 INFO - PROCESS | 9446 | 22:07:25 INFO - PROCESS | 9446 | Cycle 1(1): loaded http://localhost:49230/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49230/tests/dromaeo/cssquery-yui.html) 22:07:25 INFO - PROCESS | 9446 | RSS: Main: 177618944 22:07:25 INFO - PROCESS | 9446 | 22:10:28 INFO - PROCESS | 9446 | Cycle 1(1): loaded http://localhost:49230/tests/dromaeo/cssquery-yui.html (next: http://localhost:49230/tests/dromaeo/cssquery-dojo.html) 22:10:28 INFO - PROCESS | 9446 | RSS: Main: 265605120 22:10:28 INFO - PROCESS | 9446 | 22:10:28 INFO - PROCESS | 9446 | __start_tp_report 22:10:28 INFO - PROCESS | 9446 | _x_x_mozilla_page_load 22:10:28 INFO - PROCESS | 9446 | _x_x_mozilla_page_load_details 22:10:28 INFO - PROCESS | 9446 | |i|pagename|runs| 22:10:28 INFO - PROCESS | 9446 | |0;dojo.html;3143.7485001199907;3186.888458903939;3199.4241036613416;3207.3905957867987;3225.5484232207496;5652.717364131792;5758.913616295759;5774.740136693848;5778.335491418477;5785.103308987113;5707.514861236789;5763.164341170528;5771.769129234836;5771.826845194651;5773.220615216945;5133.974330128344;5177.585793136559;5179.352580927384;5240.816571420001;5250.947490525104;5085.084684756743;5253.395859476152;5266.868328291805;5267.341582302212;5267.683938963655;5068.366454193226;5110.565601923841;5124.4106927703415;5130.153524668425;5156.20078887773;5178.0679477694;5188.507091826271;5196.220566914955;5279.947200527984;5300.708461034642;5144;5161.483851614846;5239.79040838366;5248.527632513092;5299.73501324936;5483.150111732688;5495.258140151109;5584.301962254718;5607.943920560783;5645.661260324394;5989.730462129215;6027.517798576104;6032.879342413127;6169.136320915076;6173.351798061184;6192.535559832985;6193.442590166862;6194.318624951252;6202.28673702521;6210.565260431772;5497.670139791585;5560.582956278255;5608.4111168327145;5659.830205093854;5676.631018983835;6223.253209614784;6252.437280644764;6252.781152659726;6260.655663938527;6260.968695156495;5963.552733544915;5967.075103358986;5969.731362088716;5972.193753843262;6011.579189456784;5829.358770535237;5880.059190529495;5955.612885162537;6020.217371741645;6062.636241825505;6058.303295121029;6067.180930574405;6071.51427885768;6094.634321940609;6108.816735497942;6023.849403764941;6044.697765111727;6085.36103709113;6091.269047714302;6115.266168059861;4512.3908272382805;4543.750093744809;4578.633709303248;4638.1883170445035;4642.280446530793;4110.0752330725345;4125.1131006833675;4126.442930204444;4145.7719825409895;4172.165566886635;5819.883602328015;5827.679477628686;5831.125331200354;5836.88326233473;5856.531477481792;5988.760449581968;6102.877942441215;6105.114758360101;6131.724072416663;6148;5787.479126878601;5795.13073039039;5795.710214489343;5888.852778680482;5926.911096333559;5306.575473962073;5331.5201631853315;5342.2253773202665;5343.412224655285;5346.224797404355;6084.269887613515;6346.143270658495;6391.296957334689;6407.199100112486;6413.935860641427;5964.731587078679;6086.087086936995;6120.264288666237;6128.992047069418;6175.2589689237575;6371.776987805404;6375.043743438521;6383.457406120532;6385.042243663488;6386.233651961795;6063.848403789941;6083.239595050619;6083.939160608337;6089;6091.116788065794;5871.823845284648;5990.910136348046;6052.606580572248;6090.330063692902;6103.633781973096;5985.132155837467;5993.70031498432;5995.5803093783015;5996.640201587918;6001.609895356788;6000.819975400745;6005.819825405245;6009.729562169626;6013.128096426081;6013.729382177725;5757.050086735641;5875.148103525051;5883.146943693226;5921.911171332519;5950.256217972754;6025.276966764016;6101.572889897842;6113.083037544404;6116.724747386467;6119.908201376894;5865.149553314831;5925.1704761332585;5933.465988061095;5936.940630593639;5950.2264705587995 22:10:28 INFO - PROCESS | 9446 | |1;ext.html;589.5460495418528;605.8848818724442;631.9684015799212;633.4109278371113;633.5913335898344;34600.48099278513;37891.24217515655;37896.81051594745;37901.43147852785;37968;46710.29934550985;48214.75892620541;48319.75840120803;51964.480355196436;52024.479755202534;9270.953645231764;9410.058994100604;9413;9423.34036617437;9425.151736343727;8227.712030078948;8434.746957591251;9325.253979681609;9418.529073546295;9425.952870235638;11093.611723589676;11279.323240605549;11375.146863985194;11744.295342279447;11755.294682319089;11197.328160310366;11224.719382015433;11279.548818047268;11283.605073822377;11289.717757056058;11004.779904401947;11064;11068.944655276753;11083.50124244411;11085.445727713583;46963.76518117422;47188.76405617984;47229.76385118087;47304.76347618274;47382.76308618469;3726.441033844918;3823.2353529293973;3982.4424580558743;4034.8789536313957;4393.956060439386;31501.52747708786;34191.31617367639;34631.13422164441;34983.82508087469;35477.82261088704;4611.1930412177735;4725.1730947084125;4735.928961065587;4750.501197374295;4778.784954677048;364361;365618;367849;369255;369282;66379;66590.66704666543;66601.33398666048;66812.33187668158;66989.66505167443;40853;71951;72097.55804883978;72120.63939680268;72163.63918180375;18007.54981125456;18760;18778.906105469385;18780.06099695037;18788.154533046047;13693.315334233248;13710.588682339347;13710.725785484234;13716.314184290746;13760.449582016607;18843.05784710759;19051.809481905282;20158.596828063357;21350;21533.353999380044;7131.465140114512;7277.672504737299;7416.629168541659;7528.661210245552;7694.653740581575;894.181823631383;964.71058682395;1036.212478516333;1068.7541865371008;1071.892810718922;34215.31569368599;34385.140371490415;34691.13272168166;34730.13174670653;34826.20121981435;1083.1659622090947;1112.3203962017412;1114.4984756859283;1134.3987686526154;1172.9706757331135;17295.65408691819;18017.639647206983;18140.546486337684;18170.45488635343;18233.544161395806;525579;525679;527592;529776;530338;63812.36187638157;64301;64314.6784266085;64457.355426446076;64630;1294.3463550906731;1321.5704895908868;1334.4595438847282;1359.8436179839446;1364.249662685519;32290;33868.3988476537;33963.3207335847;33967.83016084904;34045.319093617494;56461;56711.43288567061;56822.43177568171;56926;56958.14562781645;416235;416876;418035;418506;418952;26999.59500607453;28372.57441138426;29055.273618159714;32248.35503289968;32813.17967050843;46831;48352.5164748348;51776.22335665044;51816;51869.48130518646;42781.57218427776;42885.57114428816;44001.77999110112;44323;45715.54284457113;43146.35280470733;44441.88895277644;45102;45365.54634453613;45411.54588454205;44216.55783442124;44773.776131119135;44802.10395792131;45134.32298515459;45141.32288015616;36323;39463.42146314115;39745.626397486005;40196.19607607773;40284;30370.544441833834;30414.54378184373;30504.84747576248;30506.237344066576;30579.54130688086 22:10:28 INFO - PROCESS | 9446 | |2;jquery.html;396.2570180910792;436.75105190041677;439.85484790019296;441.9176245686338;448.4148186616464;16604.252808623613;20315.39053828384;20341.186352545898;20352.084156212968;21253.787462125376;20095.899520502415;20344.59310813783;20354.59290814183;20371.898140509278;20594.897025514852;5941.346451890288;5975.804839032189;6111.572189946705;6134.018557030876;6143.631382117065;5947;6081.695915204245;6152.107944348067;6166.4450199482035;6166.568340216187;6064.332923378425;6100.054491553794;6104.4200800923845;6106.206193194901;6114.908276375858;5890.469857712784;6097;6105.389461053904;6106.572539922185;6157.384261573851;6094.969525152346;6162.7534898604;6171.321154672983;6172.9074063889075;6173.629582225036;14748.557543273719;14935.626609334744;15135.924320378437;15248.542543723706;15323.157226352547;2391.8086553075714;2507.862067586282;2581.9414040243596;2940.309322139778;3018.5773991641186;10798.51406686701;10936;11055.502502387411;11097.223194376396;11166.162537809696;2092.9581408371746;2106.09437941685;2106.7787882272296;2155.91376344946;2165.2854557995825;56643;62997;66445.33554664488;71127.99999999948;80184;11199;12069.456874440672;12183.878161218452;12254.877451225551;12363.381830908418;17378.82621173772;17405.825941740673;17406.47780566585;17411.303547857944;17430.91284543569;8678.6528538859;8765.561721914006;8839.69061082859;8846.115388461103;8862.512561809162;8266.13205613414;8295.129011453831;8322.126176751475;8531.829363412697;8538.658453661908;5118.923216151761;5161.38063432383;5208.218767184952;5242.423333433319;5253.317068781111;2062.7215325930806;2102.7056212130315;2106.252280440452;2131.9893400532897;2135.4341099608614;919.8114386550741;955.2883102088988;1065.6749691344214;1068.615298492542;1105.4417519152776;20088.39734807929;20302.69545956812;20402.18391264333;20548.32069933077;20658.17367305321;958.8993155718689;982.597135174575;993.7118235711707;1018.4907546226887;1018.8930162332997;10464.925004860079;11106.833397499044;11170.106391488662;11200.159988000933;11341;442688;443036;461029;471888;476234;55371.44628553744;57745.42254577485;74665.62667186737;75678.24321756711;96327.51836240914;1019.5972590826582;1021.6066814276558;1025.7640742629087;1038.3354653022072;1044.383813550009;13213.339333033502;17333.56666083358;18483.353082642043;18518.57404880749;18582.721259180853;40225.39661905015;40819;40997;41202.1759564801;41804.95487612834;51030;53841.653958651346;54625.45374546362;55094.44905550893;56225;7120.0387947626405;7931.722389716563;8858.158474945129;8909.955450222707;8979.595918183566;12322.383880805744;12401.13192076546;12831.165974211646;12848.614541563767;12987.870121298665;11325.862000079867;11457.140714446616;11483.425828708365;11724;11760.300373469523;5540.833774986757;9657.758556035875;10845.24083314192;11178.105751539695;11370.374629395463;11771.293722376684;11802.937735603837;11854.348010859485;11974.46114924813;12083.320839205559;8995.550222488719;9057.320700947586;9092.223113844608;9113.225375843127;9160.450372977642;9084.743057772124;11837.408129593658;12063.75872482563;12189.817152742538;12220.816687749513 22:10:28 INFO - PROCESS | 9446 | |3;mootools.html;1518.7949626800382;1539.9307031183596;1687.5696697342175;1777.0848013273176;1806.918688659011;9109.681161159353;9736.756581085467;9758.512074396287;9874.802503949935;9879.209663226942;8493.66025358985;8751.86872196916;8957;9219.262459003281;9682.080202380763;2508.059477695864;2537.3022418834876;2537.391026153719;2538.7588179122954;2541.009006487471;2411.3127758588807;2491.676082109323;2495.8752062396898;2497.8126640501946;2497.987510062447;2450.1791899713617;2458.323960910746;2534.8479091254585;2537.733537978513;2538.8730563471754;2389.95220095598;2391.6053851114543;2399.4121440247163;2446.7063952325657;2447.5104979004273;2364.4679947011955;2373.050779688121;2381.9642705359433;2382.5115851250453;2424.35754525051;9426.717198484057;9630.374025688308;9635.662751803724;9700;9757.365771224848;5619.915701264485;5641.182028605829;5646.745896434671;5696.3449203341315;5760;3440.122768693967;3540.4335306351118;3579.534660494145;3595.3708101082207;3605.7656252343777;1202.597129961464;1217.2392254840724;1235.2773627427966;1240.4046057892263;1271.230905302288;13543.119697219649;13558.186508809504;13566.864331356757;13570.93214533931;13585.116967397087;4897.657163998557;4994.625403094782;5097.08252514551;5098.439171691111;5196.428392876781;11390.37352945596;11393.03159231458;11397.772044559062;11398.829017564743;11411.657650270505;5764.538836893039;5766.135079738073;5767.452092051249;5767.567432442584;5770.855728606818;4349.3041113421705;4379.781010949439;5179.559737422362;5240.187770895441;5303.416624171338;4280.293751531025;4319.136172765459;4395.1868904252815;4434.046679963823;4435.090806384684;1351.2770667692737;1395.5813256023152;1399.230423267199;1399.3213291553589;1402.2708191740237;849.634657097454;956.8373376526007;961.423146112327;968.1915600473543;992.9404235745734;6203.6587987660205;6347.841303967438;6440.645764482999;6558.376954189344;6644.767433139817;464.13670572734685;478.50474758624654;484.8424262114827;487.91705410080374;488.6066716293418;4147.730397524151;4219.282721937278;4244.596763307481;4268.423762791983;4271.10306835568;11080.279781814317;11517.769644607228;11523.596674116534;11586.942065289619;11601;11430;11456.255343402652;11456.885431145582;11471.197016208785;11478.196526243082;8419.873701894354;8542.273906717874;8683.739487815375;8688.348373871859;8949.284057275272;6421.357864213542;6495.123158373559;6501.577397469149;6579.835504112435;6581.177352830896;10908.61819836302;10966.616168434066;11207.10343172528;11217.27087739327;11362.261453005529;10906.400147991937;11163.162762792661;11237.3257604544;11326.660200194008;11328.263662861887;7404.296591823768;7638.541687498768;8405.327573794204;8421.15788421153;8579.785505362166;9298.395604285699;9523.428594284365;9544.093311135432;9547;9553.665621703207;8494.53280069602;8503.23470887623;8539.444936079135;8589.14108589136;8684.175003374668;7772.417068719756;7990.360771138178;8092.79768005781;8136.633851476816;8196.754097377088;7302.306280903305;7363.447741419523;7368.263173682589;7385.224551422023;7480.551166930001;5393.191021346829;5457.399686034453;5601.411851755507;5602.887942241214;5832.766689332549;5483.561315094703;5501.724913754377;5553.222548843084;5609.635373700697;5619.438056194348 22:10:28 INFO - PROCESS | 9446 | |4;prototype.html;359.71762166699136;359.7337969902273;366.251016670908;372.3929994109601;374.9568799588045;5441.863953401167;5596.692181929992;5605.635633683818;5628.127640215763;5643.294588176478;5325.840224793253;5498.4501549845;5514.724263786815;5523.25436066131;5523.420040895709;4366.1922544329245;4377.190219809329;4383.605475507204;4389.341598760179;4393.648508119359;4238.5840071159455;4341.2836881914445;4375.8249670013165;4389.275769498029;4417.911641767163;4307.138572285539;4324.481062272532;4333.804978775946;4336.48223121908;4340.893072266567;4331.393604895317;4331.501877284106;4337.436133302682;4342.416262323913;4373.785267828143;3827.27281816454;3923.941140882889;3935.5206220081163;3953.1105501261986;3959.6238357356006;5419.34967803866;5421;5423.101914329993;5423.186522021689;5452;5061.392632884041;5074.31496747938;5078.542931136216;5084.51697088776;5095.719735414551;5582.49757521825;5821.650700957956;5850.561207909382;5852.648841069549;5875;4400.295952647593;4404.933925991113;4407.184670835905;4415.779211039435;4433.002574420761;5985.5810093293485;6085.8353656099025;6099.908501372527;6121.66330851803;6135.32511423743;4492.820287188541;4506.774661266989;4511.210538155809;4523.615492683159;4530.207213737583;4571.839985600488;4572.337011133367;4580.679352445363;4587.839425620087;4590.67865249436;4970.552650261494;5023.346964894614;5098.286239926413;5118.360204974379;5125.333706618116;5551.861203469945;5868.853278667982;5876.7355469004;5877.735501902424;5886.852828679232;1484.5917372722372;1486.695227478386;1514.4018112845586;1520.1259275916393;1532.4176812811284;1077.7628921637227;1102.2669924500278;1112.4604566785104;1122.5117074072805;1126.4367816091954;5648.63283886546;5649.548036157097;5651.6043876928225;5665.830025099253;5674.460926212003;5968.671723055187;5977.521798256129;5984.700764961822;5987.5808693391045;6006.939930600725;5451.1569343612655;5631.1980166346375;5660.575456840754;5667.4332566743;5674.517665998436;2782.692134696689;2807.540079158826;2811.2128603990914;2811.676657184409;2839.914802555885;5138.717370544581;5329.122273972089;5335.413104558495;5345.1447768356875;5399.70301633414;5154.221793481243;5180.948190518046;5330.853866418739;5372.328458942632;5402.891942161214;5394.2448057272795;5397.218917757131;5402.459754024566;5412.458754124635;5417.566594672417;4998.250262460515;5191.29917461153;5222.55608273301;5241.9737901310245;5298.920516192183;5205.245239440335;5218.165093585008;5220.347456567929;5228.268042474133;5244.501772331622;5346.919796203138;5349.144136938071;5352.866178345573;5362.436944120811;5374.7581358839725;3833.4058220975794;3959.4852669152824;3983.8605648802154;4058.573849745734;4079.2453396121814;5174.016936781999;5193.143131383431;5239.318888544617;5734.770609175586;5876.471117599436;5722.6852523109965;5864.912026319524;5879.823605291848;5879.911801322898;5902.675352855634;5868;5882;5888.823335299948;5890.941090589039;5891.293044834647;5631.183478395692;5779.393163717749;5831.970840145772;5835;5857.531397488276;5889.617174883619;5917.792877249276;5921.230240068936;5925.40745925404;5932.228810254639;5625.268715067179;5734.799282025109;5762.538996880324;5769.68266745333;5770.422957704364 22:10:28 INFO - PROCESS | 9446 | |5;yui.html;794.3883209928355;830.7715378270979;842.3766412854486;850.987235191472;923.3029063057388;15339.539813805604;16232.350705971761;17397.739033914502;17416.651666966653;17441.302347906083;15398.384064637401;15438.228088595553;15503.689926201498;15585.064896106242;15688.215589220521;676.4520738202048;689.1420181873574;806.8870358149863;828.1387357148558;839.0434904209206;844.5186243841013;847.2036285891273;848.2832006954114;851.8296340731847;856.4861083349971;900.6982660808637;902.1474706402453;903.0563061600643;903.2006674093442;904.3172404834373;902.0122965352928;903.8237543678986;903.8418276801566;904.0868722590199;904.5612877754284;663.9236487803917;664.4219529009744;665.4310564467407;666.3935818405228;666.5700623098074;16156.27296771648;16262;16303.755443668355;16304.592385190346;16326;15729.37082516698;16577.254023568967;16661.750073748903;17182.74225886613;17664.381746638806;11339.886601133965;11461.656150315504;11715.882841171564;11959.760804783942;12137.332446715427;3983.1260658402434;4118.5263694675195;4144.109016561423;4156.251874662559;4247.8088486018205;71891;75696;76114;83111.584442078;85176;12437.875621243853;12674.619761407173;12760.6809829755;12966.157199781985;13098.607041788762;22342.106315747515;22454.887725561595;22491.43771405728;22611.321660350215;22613;8961.507117108622;9077.863832042392;9173.58718857653;9186.219171370374;9247;4373.234683930299;4690.882727931829;4736.194846876039;4820.180569303227;5006.799728010911;3864.381698928214;3953.169834334822;4003.6997225208224;4010.3382941814275;4046.9392959105635;655.9737610495526;657.6580178307349;663.3598577372762;679.5582871133803;701.7508784381573;652.7552167937024;744.6351287868905;778.4473024152802;791.701609360649;814.0882211922566;9780.266480014028;10109.747256318651;10199.847002294971;10265.178785697126;10652.786944261072;746.4625469661835;768.3891306411416;781.3631890009624;781.4607920534813;787.830616417473;4687.67186296956;4997.675151115166;5066.974665126724;5192.446087798084;5463.344398672185;127064;127789;129730.35134824454;130145;132925.3353733225;66648.66675666688;68053;77637.223627763;98948;110428;98925;100102.4994875021;102980.48509757403;104597.47701261444;104634.24511651932;10508.264421490423;10974.396408197626;11005;11099.833502497308;11526.308421494738;59610.70194648999;60308.69845650744;61462;63007.6849615749;63154.684226578574;81271;83558.58220708858;91666.54166729124;92039.47763134234;94798;13940;13944.860551394357;13994.300284985913;14691.412343506567;15124.39502419891;14841.554753357417;14997.400103995718;15339.233038347815;15629.14039727826;15854.286557104728;14857.405703771728;15240.237988100773;15925.761113583074;16359.100249486393;16476.588085297484;13980.650483737987;14119.364628591533;14176.929115354356;14235.572932812032;14865.108093514424;14091.295435227992;14157.150570965776;14242.07426517273;14572.271386430424;14957.925210373878;11577.778438779578;11936;12230.87769122333;12294.077944154045;12377.752444951231;11656.776038515834;12479.25124492497;12565.685857853261;12720.936395317964;12862.421191046613 22:10:28 INFO - PROCESS | 9446 | __end_tp_report 22:10:28 INFO - PROCESS | 9446 | __start_cc_report 22:10:28 INFO - PROCESS | 9446 | _x_x_mozilla_cycle_collect,863 22:10:28 INFO - PROCESS | 9446 | __end_cc_report 22:10:28 INFO - PROCESS | 9446 | __startTimestamp1482387028891__endTimestamp 22:10:28 INFO - PROCESS | 9446 | 22:10:28 INFO - PROCESS | 9446 | ------- Summary: start ------- 22:10:28 INFO - PROCESS | 9446 | Number of tests: 6 22:10:28 INFO - PROCESS | 9446 | 22:10:28 INFO - PROCESS | 9446 | [#0] dojo.html Cycles:165 Average:5669.31 Median:5925.17 stddev:664.09 (11.2%) stddev-sans-first:635.89 22:10:28 INFO - PROCESS | 9446 | Values: 3143.7 3186.9 3199.4 3207.4 3225.5 5652.7 5758.9 5774.7 5778.3 5785.1 5707.5 5763.2 5771.8 5771.8 5773.2 5134.0 5177.6 5179.4 5240.8 5250.9 5085.1 5253.4 5266.9 5267.3 5267.7 5068.4 5110.6 5124.4 5130.2 5156.2 5178.1 5188.5 5196.2 5279.9 5300.7 5144.0 5161.5 5239.8 5248.5 5299.7 5483.2 5495.3 5584.3 5607.9 5645.7 5989.7 6027.5 6032.9 6169.1 6173.4 6192.5 6193.4 6194.3 6202.3 6210.6 5497.7 5560.6 5608.4 5659.8 5676.6 6223.3 6252.4 6252.8 6260.7 6261.0 5963.6 5967.1 5969.7 5972.2 6011.6 5829.4 5880.1 5955.6 6020.2 6062.6 6058.3 6067.2 6071.5 6094.6 6108.8 6023.8 6044.7 6085.4 6091.3 6115.3 4512.4 4543.8 4578.6 4638.2 4642.3 4110.1 4125.1 4126.4 4145.8 4172.2 5819.9 5827.7 5831.1 5836.9 5856.5 5988.8 6102.9 6105.1 6131.7 6148.0 5787.5 5795.1 5795.7 5888.9 5926.9 5306.6 5331.5 5342.2 5343.4 5346.2 6084.3 6346.1 6391.3 6407.2 6413.9 5964.7 6086.1 6120.3 6129.0 6175.3 6371.8 6375.0 6383.5 6385.0 6386.2 6063.8 6083.2 6083.9 6089.0 6091.1 5871.8 5990.9 6052.6 6090.3 6103.6 5985.1 5993.7 5995.6 5996.6 6001.6 6000.8 6005.8 6009.7 6013.1 6013.7 5757.1 5875.1 5883.1 5921.9 5950.3 6025.3 6101.6 6113.1 6116.7 6119.9 5865.1 5925.2 5933.5 5936.9 5950.2 22:10:28 INFO - PROCESS | 9446 | 22:10:28 INFO - PROCESS | 9446 | [#1] ext.html Cycles:180 Average:61906.22 Median:22159.44 stddev:116942.29 (527.7%) stddev-sans-first:117179.72 22:10:28 INFO - PROCESS | 9446 | Values: 589.5 605.9 632.0 633.4 633.6 34600.5 37891.2 37896.8 37901.4 37968.0 46710.3 48214.8 48319.8 51964.5 52024.5 9271.0 9410.1 9413.0 9423.3 9425.2 8227.7 8434.7 9325.3 9418.5 9426.0 11093.6 11279.3 11375.1 11744.3 11755.3 11197.3 11224.7 11279.5 11283.6 11289.7 11004.8 11064.0 11068.9 11083.5 11085.4 46963.8 47188.8 47229.8 47304.8 47382.8 3726.4 3823.2 3982.4 4034.9 4394.0 31501.5 34191.3 34631.1 34983.8 35477.8 4611.2 4725.2 4735.9 4750.5 4778.8 364361.0 365618.0 367849.0 369255.0 369282.0 66379.0 66590.7 66601.3 66812.3 66989.7 40853.0 71951.0 72097.6 72120.6 72163.6 18007.5 18760.0 18778.9 18780.1 18788.2 13693.3 13710.6 13710.7 13716.3 13760.4 18843.1 19051.8 20158.6 21350.0 21533.4 7131.5 7277.7 7416.6 7528.7 7694.7 894.2 964.7 1036.2 1068.8 1071.9 34215.3 34385.1 34691.1 34730.1 34826.2 1083.2 1112.3 1114.5 1134.4 1173.0 17295.7 18017.6 18140.5 18170.5 18233.5 525579.0 525679.0 527592.0 529776.0 530338.0 63812.4 64301.0 64314.7 64457.4 64630.0 1294.3 1321.6 1334.5 1359.8 1364.2 32290.0 33868.4 33963.3 33967.8 34045.3 56461.0 56711.4 56822.4 56926.0 56958.1 416235.0 416876.0 418035.0 418506.0 418952.0 26999.6 28372.6 29055.3 32248.4 32813.2 46831.0 48352.5 51776.2 51816.0 51869.5 42781.6 42885.6 44001.8 44323.0 45715.5 43146.4 44441.9 45102.0 45365.5 45411.5 44216.6 44773.8 44802.1 45134.3 45141.3 36323.0 39463.4 39745.6 40196.2 40284.0 30370.5 30414.5 30504.8 30506.2 30579.5 22:10:28 INFO - PROCESS | 9446 | 22:10:28 INFO - PROCESS | 9446 | [#2] jquery.html Cycles:180 Average:27109.63 Median:2979.44 stddev:75241.58 (2525.4%) stddev-sans-first:75425.92 22:10:28 INFO - PROCESS | 9446 | Values: 396.3 436.8 439.9 441.9 448.4 16604.3 20315.4 20341.2 20352.1 21253.8 20095.9 20344.6 20354.6 20371.9 20594.9 5941.3 5975.8 6111.6 6134.0 6143.6 5947.0 6081.7 6152.1 6166.4 6166.6 6064.3 6100.1 6104.4 6106.2 6114.9 5890.5 6097.0 6105.4 6106.6 6157.4 6095.0 6162.8 6171.3 6172.9 6173.6 14748.6 14935.6 15135.9 15248.5 15323.2 2391.8 2507.9 2581.9 2940.3 3018.6 10798.5 10936.0 11055.5 11097.2 11166.2 2093.0 2106.1 2106.8 2155.9 2165.3 56643.0 62997.0 66445.3 71128.0 80184.0 11199.0 12069.5 12183.9 12254.9 12363.4 17378.8 17405.8 17406.5 17411.3 17430.9 8678.7 8765.6 8839.7 8846.1 8862.5 8266.1 8295.1 8322.1 8531.8 8538.7 5118.9 5161.4 5208.2 5242.4 5253.3 2062.7 2102.7 2106.3 2132.0 2135.4 919.8 955.3 1065.7 1068.6 1105.4 20088.4 20302.7 20402.2 20548.3 20658.2 958.9 982.6 993.7 1018.5 1018.9 10464.9 11106.8 11170.1 11200.2 11341.0 442688.0 443036.0 461029.0 471888.0 476234.0 55371.4 57745.4 74665.6 75678.2 96327.5 1019.6 1021.6 1025.8 1038.3 1044.4 13213.3 17333.6 18483.4 18518.6 18582.7 40225.4 40819.0 40997.0 41202.2 41805.0 51030.0 53841.7 54625.5 55094.4 56225.0 7120.0 7931.7 8858.2 8910.0 8979.6 12322.4 12401.1 12831.2 12848.6 12987.9 11325.9 11457.1 11483.4 11724.0 11760.3 5540.8 9657.8 10845.2 11178.1 11370.4 11771.3 11802.9 11854.3 11974.5 12083.3 8995.6 9057.3 9092.2 9113.2 9160.5 9084.7 11837.4 12063.8 12189.8 12220.8 22:10:28 INFO - PROCESS | 9446 | 22:10:28 INFO - PROCESS | 9446 | [#3] mootools.html Cycles:180 Average:6233.63 Median:488.26 stddev:3609.88 (739.3%) stddev-sans-first:3602.62 22:10:28 INFO - PROCESS | 9446 | Values: 1518.8 1539.9 1687.6 1777.1 1806.9 9109.7 9736.8 9758.5 9874.8 9879.2 8493.7 8751.9 8957.0 9219.3 9682.1 2508.1 2537.3 2537.4 2538.8 2541.0 2411.3 2491.7 2495.9 2497.8 2498.0 2450.2 2458.3 2534.8 2537.7 2538.9 2390.0 2391.6 2399.4 2446.7 2447.5 2364.5 2373.1 2382.0 2382.5 2424.4 9426.7 9630.4 9635.7 9700.0 9757.4 5619.9 5641.2 5646.7 5696.3 5760.0 3440.1 3540.4 3579.5 3595.4 3605.8 1202.6 1217.2 1235.3 1240.4 1271.2 13543.1 13558.2 13566.9 13570.9 13585.1 4897.7 4994.6 5097.1 5098.4 5196.4 11390.4 11393.0 11397.8 11398.8 11411.7 5764.5 5766.1 5767.5 5767.6 5770.9 4349.3 4379.8 5179.6 5240.2 5303.4 4280.3 4319.1 4395.2 4434.0 4435.1 1351.3 1395.6 1399.2 1399.3 1402.3 849.6 956.8 961.4 968.2 992.9 6203.7 6347.8 6440.6 6558.4 6644.8 464.1 478.5 484.8 487.9 488.6 4147.7 4219.3 4244.6 4268.4 4271.1 11080.3 11517.8 11523.6 11586.9 11601.0 11430.0 11456.3 11456.9 11471.2 11478.2 8419.9 8542.3 8683.7 8688.3 8949.3 6421.4 6495.1 6501.6 6579.8 6581.2 10908.6 10966.6 11207.1 11217.3 11362.3 10906.4 11163.2 11237.3 11326.7 11328.3 7404.3 7638.5 8405.3 8421.2 8579.8 9298.4 9523.4 9544.1 9547.0 9553.7 8494.5 8503.2 8539.4 8589.1 8684.2 7772.4 7990.4 8092.8 8136.6 8196.8 7302.3 7363.4 7368.3 7385.2 7480.6 5393.2 5457.4 5601.4 5602.9 5832.8 5483.6 5501.7 5553.2 5609.6 5619.4 22:10:28 INFO - PROCESS | 9446 | 22:10:28 INFO - PROCESS | 9446 | [#4] prototype.html Cycles:180 Average:4794.04 Median:5312.38 stddev:1359.79 (25.6%) stddev-sans-first:1322.25 22:10:28 INFO - PROCESS | 9446 | Values: 359.7 359.7 366.3 372.4 375.0 5441.9 5596.7 5605.6 5628.1 5643.3 5325.8 5498.5 5514.7 5523.3 5523.4 4366.2 4377.2 4383.6 4389.3 4393.6 4238.6 4341.3 4375.8 4389.3 4417.9 4307.1 4324.5 4333.8 4336.5 4340.9 4331.4 4331.5 4337.4 4342.4 4373.8 3827.3 3923.9 3935.5 3953.1 3959.6 5419.3 5421.0 5423.1 5423.2 5452.0 5061.4 5074.3 5078.5 5084.5 5095.7 5582.5 5821.7 5850.6 5852.6 5875.0 4400.3 4404.9 4407.2 4415.8 4433.0 5985.6 6085.8 6099.9 6121.7 6135.3 4492.8 4506.8 4511.2 4523.6 4530.2 4571.8 4572.3 4580.7 4587.8 4590.7 4970.6 5023.3 5098.3 5118.4 5125.3 5551.9 5868.9 5876.7 5877.7 5886.9 1484.6 1486.7 1514.4 1520.1 1532.4 1077.8 1102.3 1112.5 1122.5 1126.4 5648.6 5649.5 5651.6 5665.8 5674.5 5968.7 5977.5 5984.7 5987.6 6006.9 5451.2 5631.2 5660.6 5667.4 5674.5 2782.7 2807.5 2811.2 2811.7 2839.9 5138.7 5329.1 5335.4 5345.1 5399.7 5154.2 5180.9 5330.9 5372.3 5402.9 5394.2 5397.2 5402.5 5412.5 5417.6 4998.3 5191.3 5222.6 5242.0 5298.9 5205.2 5218.2 5220.3 5228.3 5244.5 5346.9 5349.1 5352.9 5362.4 5374.8 3833.4 3959.5 3983.9 4058.6 4079.2 5174.0 5193.1 5239.3 5734.8 5876.5 5722.7 5864.9 5879.8 5879.9 5902.7 5868.0 5882.0 5888.8 5890.9 5891.3 5631.2 5779.4 5832.0 5835.0 5857.5 5889.6 5917.8 5921.2 5925.4 5932.2 5625.3 5734.8 5762.5 5769.7 5770.4 22:10:28 INFO - PROCESS | 9446 | 22:10:28 INFO - PROCESS | 9446 | [#5] yui.html Cycles:180 Average:22530.50 Median:3968.15 stddev:32539.81 (820.0%) stddev-sans-first:32590.16 22:10:28 INFO - PROCESS | 9446 | Values: 794.4 830.8 842.4 851.0 923.3 15339.5 16232.4 17397.7 17416.7 17441.3 15398.4 15438.2 15503.7 15585.1 15688.2 676.5 689.1 806.9 828.1 839.0 844.5 847.2 848.3 851.8 856.5 900.7 902.1 903.1 903.2 904.3 902.0 903.8 903.8 904.1 904.6 663.9 664.4 665.4 666.4 666.6 16156.3 16262.0 16303.8 16304.6 16326.0 15729.4 16577.3 16661.8 17182.7 17664.4 11339.9 11461.7 11715.9 11959.8 12137.3 3983.1 4118.5 4144.1 4156.3 4247.8 71891.0 75696.0 76114.0 83111.6 85176.0 12437.9 12674.6 12760.7 12966.2 13098.6 22342.1 22454.9 22491.4 22611.3 22613.0 8961.5 9077.9 9173.6 9186.2 9247.0 4373.2 4690.9 4736.2 4820.2 5006.8 3864.4 3953.2 4003.7 4010.3 4046.9 656.0 657.7 663.4 679.6 701.8 652.8 744.6 778.4 791.7 814.1 9780.3 10109.7 10199.8 10265.2 10652.8 746.5 768.4 781.4 781.5 787.8 4687.7 4997.7 5067.0 5192.4 5463.3 127064.0 127789.0 129730.4 130145.0 132925.3 66648.7 68053.0 77637.2 98948.0 110428.0 98925.0 100102.5 102980.5 104597.5 104634.2 10508.3 10974.4 11005.0 11099.8 11526.3 59610.7 60308.7 61462.0 63007.7 63154.7 81271.0 83558.6 91666.5 92039.5 94798.0 13940.0 13944.9 13994.3 14691.4 15124.4 14841.6 14997.4 15339.2 15629.1 15854.3 14857.4 15240.2 15925.8 16359.1 16476.6 13980.7 14119.4 14176.9 14235.6 14865.1 14091.3 14157.2 14242.1 14572.3 14957.9 11577.8 11936.0 12230.9 12294.1 12377.8 11656.8 12479.3 12565.7 12720.9 12862.4 22:10:28 INFO - PROCESS | 9446 | -------- Summary: end -------- 22:10:28 INFO - PROCESS | 9446 | 22:10:29 INFO - TEST-INFO | 9446: exit 0 22:10:29 INFO - TEST-OK | dromaeo_css | took 1113429ms 22:10:29 INFO - TEST-START | kraken 22:10:29 INFO - operating with platform_type : linux_ 22:10:29 INFO - Initialising browser for kraken test... 22:10:29 INFO - TEST-INFO | started process 9761 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmeOaUW/profile http://localhost:49230/getInfo.html) 22:10:33 INFO - PROCESS | 9761 | __metrics Screen width/height:1600/1200 22:10:33 INFO - PROCESS | 9761 | colorDepth:24 22:10:33 INFO - PROCESS | 9761 | Browser inner width/height: 1024/697 22:10:33 INFO - PROCESS | 9761 | __metrics 22:10:34 INFO - PROCESS | 9761 | 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" 22:10:34 INFO - PROCESS | 9761 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:10:34 INFO - PROCESS | 9761 | console.error: PushService: 22:10:34 INFO - PROCESS | 9761 | stateChangeProcessEnqueue: Error transitioning state 22:10:34 INFO - PROCESS | 9761 | UnknownError 22:10:35 INFO - TEST-INFO | 9761: exit 0 22:10:35 INFO - Browser initialized. 22:10:35 INFO - Running cycle 1/1 for kraken test... 22:10:35 INFO - TEST-INFO | started process 9856 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmeOaUW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:10:47 INFO - PROCESS | 9856 | RSS: Main: 143745024 22:10:47 INFO - PROCESS | 9856 | 22:10:49 INFO - PROCESS | 9856 | Cycle 1(1): loaded http://localhost:49230/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49230/tests/kraken/driver.html?testName=audio-beat-detection) 22:10:50 INFO - PROCESS | 9856 | RSS: Main: 186359808 22:10:50 INFO - PROCESS | 9856 | 22:10:53 INFO - PROCESS | 9856 | Cycle 1(1): loaded http://localhost:49230/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49230/tests/kraken/driver.html?testName=audio-dft) 22:10:53 INFO - PROCESS | 9856 | RSS: Main: 174587904 22:10:53 INFO - PROCESS | 9856 | 22:10:56 INFO - PROCESS | 9856 | Cycle 1(1): loaded http://localhost:49230/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49230/tests/kraken/driver.html?testName=audio-fft) 22:10:57 INFO - PROCESS | 9856 | RSS: Main: 266153984 22:10:57 INFO - PROCESS | 9856 | 22:10:59 INFO - PROCESS | 9856 | Cycle 1(1): loaded http://localhost:49230/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49230/tests/kraken/driver.html?testName=audio-oscillator) 22:10:59 INFO - PROCESS | 9856 | RSS: Main: 172421120 22:10:59 INFO - PROCESS | 9856 | 22:11:01 INFO - PROCESS | 9856 | Cycle 1(1): loaded http://localhost:49230/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49230/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:11:02 INFO - PROCESS | 9856 | RSS: Main: 174592000 22:11:02 INFO - PROCESS | 9856 | 22:11:05 INFO - PROCESS | 9856 | Cycle 1(1): loaded http://localhost:49230/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49230/tests/kraken/driver.html?testName=imaging-darkroom) 22:11:05 INFO - PROCESS | 9856 | RSS: Main: 210964480 22:11:05 INFO - PROCESS | 9856 | 22:11:09 INFO - PROCESS | 9856 | Cycle 1(1): loaded http://localhost:49230/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49230/tests/kraken/driver.html?testName=imaging-desaturate) 22:11:09 INFO - PROCESS | 9856 | RSS: Main: 209981440 22:11:09 INFO - PROCESS | 9856 | 22:11:12 INFO - PROCESS | 9856 | Cycle 1(1): loaded http://localhost:49230/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49230/tests/kraken/driver.html?testName=json-parse-financial) 22:11:13 INFO - PROCESS | 9856 | RSS: Main: 208752640 22:11:13 INFO - PROCESS | 9856 | 22:11:14 INFO - PROCESS | 9856 | Cycle 1(1): loaded http://localhost:49230/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49230/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:11:15 INFO - PROCESS | 9856 | RSS: Main: 170971136 22:11:15 INFO - PROCESS | 9856 | 22:11:16 INFO - PROCESS | 9856 | Cycle 1(1): loaded http://localhost:49230/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49230/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:11:17 INFO - PROCESS | 9856 | RSS: Main: 178200576 22:11:17 INFO - PROCESS | 9856 | 22:11:19 INFO - PROCESS | 9856 | Cycle 1(1): loaded http://localhost:49230/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49230/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:11:20 INFO - PROCESS | 9856 | RSS: Main: 187752448 22:11:20 INFO - PROCESS | 9856 | 22:11:22 INFO - PROCESS | 9856 | Cycle 1(1): loaded http://localhost:49230/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49230/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:11:23 INFO - PROCESS | 9856 | RSS: Main: 196333568 22:11:23 INFO - PROCESS | 9856 | 22:11:25 INFO - PROCESS | 9856 | Cycle 1(1): loaded http://localhost:49230/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49230/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:11:26 INFO - PROCESS | 9856 | RSS: Main: 192901120 22:11:26 INFO - PROCESS | 9856 | 22:11:28 INFO - PROCESS | 9856 | Cycle 1(1): loaded http://localhost:49230/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49230/tests/kraken/driver.html?testName=ai-astar) 22:11:28 INFO - PROCESS | 9856 | RSS: Main: 245010432 22:11:28 INFO - PROCESS | 9856 | 22:11:28 INFO - PROCESS | 9856 | __start_tp_report 22:11:28 INFO - PROCESS | 9856 | _x_x_mozilla_page_load 22:11:28 INFO - PROCESS | 9856 | _x_x_mozilla_page_load_details 22:11:28 INFO - PROCESS | 9856 | |i|pagename|runs| 22:11:28 INFO - PROCESS | 9856 | |0;ai-astar;112;109;111;109;112;109;109;110;109;112 22:11:28 INFO - PROCESS | 9856 | |1;audio-beat-detection;146;116;123;150;122;118;122;121;152;118 22:11:28 INFO - PROCESS | 9856 | |2;audio-dft;161;161;161;161;161;160;159;161;161;161 22:11:28 INFO - PROCESS | 9856 | |3;audio-fft;75;75;77;107;76;77;77;76;109;76 22:11:28 INFO - PROCESS | 9856 | |4;audio-oscillator;81;81;107;81;82;82;110;82;82;114 22:11:28 INFO - PROCESS | 9856 | |5;imaging-gaussian-blur;117;117;117;116;117;116;117;117;116;116 22:11:28 INFO - PROCESS | 9856 | |6;imaging-darkroom;147;146;145;146;147;147;146;146;145;146 22:11:28 INFO - PROCESS | 9856 | |7;imaging-desaturate;95;96;95;95;95;94;94;95;95;95 22:11:28 INFO - PROCESS | 9856 | |8;json-parse-financial;50;50;48;49;49;50;50;48;48;49 22:11:28 INFO - PROCESS | 9856 | |9;json-stringify-tinderbox;60;59;59;61;60;60;59;59;58;58 22:11:28 INFO - PROCESS | 9856 | |10;stanford-crypto-aes;73;73;79;73;73;72;73;81;74;73 22:11:28 INFO - PROCESS | 9856 | |11;stanford-crypto-ccm;127;124;136;122;121;118;129;118;176;119 22:11:28 INFO - PROCESS | 9856 | |12;stanford-crypto-pbkdf2;153;157;157;154;155;157;157;159;155;154 22:11:28 INFO - PROCESS | 9856 | |13;stanford-crypto-sha256-iterative;63;65;66;62;62;63;66;63;63;63 22:11:28 INFO - PROCESS | 9856 | __end_tp_report 22:11:28 INFO - PROCESS | 9856 | __start_cc_report 22:11:28 INFO - PROCESS | 9856 | _x_x_mozilla_cycle_collect,1554 22:11:28 INFO - PROCESS | 9856 | __end_cc_report 22:11:28 INFO - PROCESS | 9856 | __startTimestamp1482387088436__endTimestamp 22:11:28 INFO - PROCESS | 9856 | 22:11:28 INFO - PROCESS | 9856 | ------- Summary: start ------- 22:11:28 INFO - PROCESS | 9856 | Number of tests: 14 22:11:28 INFO - PROCESS | 9856 | 22:11:28 INFO - PROCESS | 9856 | [#0] ai-astar Cycles:10 Average:110.20 Median:110.50 stddev:1.40 (1.3%) stddev-sans-first:1.32 22:11:28 INFO - PROCESS | 9856 | Values: 112.0 109.0 111.0 109.0 112.0 109.0 109.0 110.0 109.0 112.0 22:11:28 INFO - PROCESS | 9856 | 22:11:28 INFO - PROCESS | 9856 | [#1] audio-beat-detection Cycles:10 Average:128.80 Median:122.50 stddev:14.41 (11.8%) stddev-sans-first:13.87 22:11:28 INFO - PROCESS | 9856 | Values: 146.0 116.0 123.0 150.0 122.0 118.0 122.0 121.0 152.0 118.0 22:11:28 INFO - PROCESS | 9856 | 22:11:28 INFO - PROCESS | 9856 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:0.67 (0.4%) stddev-sans-first:0.71 22:11:28 INFO - PROCESS | 9856 | Values: 161.0 161.0 161.0 161.0 161.0 160.0 159.0 161.0 161.0 161.0 22:11:28 INFO - PROCESS | 9856 | 22:11:28 INFO - PROCESS | 9856 | [#3] audio-fft Cycles:10 Average:82.50 Median:76.00 stddev:13.47 (17.7%) stddev-sans-first:14.01 22:11:28 INFO - PROCESS | 9856 | Values: 75.0 75.0 77.0 107.0 76.0 77.0 77.0 76.0 109.0 76.0 22:11:28 INFO - PROCESS | 9856 | 22:11:28 INFO - PROCESS | 9856 | [#4] audio-oscillator Cycles:10 Average:90.20 Median:81.50 stddev:14.00 (17.2%) stddev-sans-first:14.45 22:11:28 INFO - PROCESS | 9856 | Values: 81.0 81.0 107.0 81.0 82.0 82.0 110.0 82.0 82.0 114.0 22:11:28 INFO - PROCESS | 9856 | 22:11:28 INFO - PROCESS | 9856 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 22:11:28 INFO - PROCESS | 9856 | Values: 117.0 117.0 117.0 116.0 117.0 116.0 117.0 117.0 116.0 116.0 22:11:28 INFO - PROCESS | 9856 | 22:11:28 INFO - PROCESS | 9856 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 22:11:28 INFO - PROCESS | 9856 | Values: 147.0 146.0 145.0 146.0 147.0 147.0 146.0 146.0 145.0 146.0 22:11:28 INFO - PROCESS | 9856 | 22:11:28 INFO - PROCESS | 9856 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 22:11:28 INFO - PROCESS | 9856 | Values: 95.0 96.0 95.0 95.0 95.0 94.0 94.0 95.0 95.0 95.0 22:11:28 INFO - PROCESS | 9856 | 22:11:28 INFO - PROCESS | 9856 | [#8] json-parse-financial Cycles:10 Average:49.10 Median:49.50 stddev:0.88 (1.8%) stddev-sans-first:0.87 22:11:28 INFO - PROCESS | 9856 | Values: 50.0 50.0 48.0 49.0 49.0 50.0 50.0 48.0 48.0 49.0 22:11:28 INFO - PROCESS | 9856 | 22:11:28 INFO - PROCESS | 9856 | [#9] json-stringify-tinderbox Cycles:10 Average:59.30 Median:59.50 stddev:0.95 (1.6%) stddev-sans-first:0.97 22:11:28 INFO - PROCESS | 9856 | Values: 60.0 59.0 59.0 61.0 60.0 60.0 59.0 59.0 58.0 58.0 22:11:28 INFO - PROCESS | 9856 | 22:11:28 INFO - PROCESS | 9856 | [#10] stanford-crypto-aes Cycles:10 Average:74.40 Median:73.00 stddev:3.03 (4.1%) stddev-sans-first:3.17 22:11:28 INFO - PROCESS | 9856 | Values: 73.0 73.0 79.0 73.0 73.0 72.0 73.0 81.0 74.0 73.0 22:11:28 INFO - PROCESS | 9856 | 22:11:28 INFO - PROCESS | 9856 | [#11] stanford-crypto-ccm Cycles:10 Average:129.00 Median:125.50 stddev:17.45 (13.9%) stddev-sans-first:18.50 22:11:28 INFO - PROCESS | 9856 | Values: 127.0 124.0 136.0 122.0 121.0 118.0 129.0 118.0 176.0 119.0 22:11:28 INFO - PROCESS | 9856 | 22:11:28 INFO - PROCESS | 9856 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.80 Median:157.00 stddev:1.87 (1.2%) stddev-sans-first:1.69 22:11:28 INFO - PROCESS | 9856 | Values: 153.0 157.0 157.0 154.0 155.0 157.0 157.0 159.0 155.0 154.0 22:11:28 INFO - PROCESS | 9856 | 22:11:28 INFO - PROCESS | 9856 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.60 Median:63.00 stddev:1.51 (2.4%) stddev-sans-first:1.58 22:11:28 INFO - PROCESS | 9856 | Values: 63.0 65.0 66.0 62.0 62.0 63.0 66.0 63.0 63.0 63.0 22:11:28 INFO - PROCESS | 9856 | -------- Summary: end -------- 22:11:28 INFO - PROCESS | 9856 | 22:11:29 INFO - TEST-INFO | 9856: exit 0 22:11:29 INFO - TEST-OK | kraken | took 59926ms 22:11:29 INFO - SUITE-END | took 1173s 22:11:30 INFO - Completed test suite (00:19:33) 22:11:30 INFO - javascript benchmark 22:11:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3143.7485001199907, 3186.888458903939, 3199.4241036613416, 3207.3905957867987, 3225.5484232207496, 5652.717364131792, 5758.913616295759, 5774.740136693848, 5778.335491418477, 5785.103308987113, 5707.514861236789, 5763.164341170528, 5771.769129234836, 5771.826845194651, 5773.220615216945, 5133.974330128344, 5177.585793136559, 5179.352580927384, 5240.816571420001, 5250.947490525104, 5085.084684756743, 5253.395859476152, 5266.868328291805, 5267.341582302212, 5267.683938963655, 5068.366454193226, 5110.565601923841, 5124.4106927703415, 5130.153524668425, 5156.20078887773, 5178.0679477694, 5188.507091826271, 5196.220566914955, 5279.947200527984, 5300.708461034642, 5144.0, 5161.483851614846, 5239.79040838366, 5248.527632513092, 5299.73501324936, 5483.150111732688, 5495.258140151109, 5584.301962254718, 5607.943920560783, 5645.661260324394, 5989.730462129215, 6027.517798576104, 6032.879342413127, 6169.136320915076, 6173.351798061184, 6192.535559832985, 6193.442590166862, 6194.318624951252, 6202.28673702521, 6210.565260431772, 5497.670139791585, 5560.582956278255, 5608.4111168327145, 5659.830205093854, 5676.631018983835, 6223.253209614784, 6252.437280644764, 6252.781152659726, 6260.655663938527, 6260.968695156495, 5963.552733544915, 5967.075103358986, 5969.731362088716, 5972.193753843262, 6011.579189456784, 5829.358770535237, 5880.059190529495, 5955.612885162537, 6020.217371741645, 6062.636241825505, 6058.303295121029, 6067.180930574405, 6071.51427885768, 6094.634321940609, 6108.816735497942, 6023.849403764941, 6044.697765111727, 6085.36103709113, 6091.269047714302, 6115.266168059861, 4512.3908272382805, 4543.750093744809, 4578.633709303248, 4638.1883170445035, 4642.280446530793, 4110.0752330725345, 4125.1131006833675, 4126.442930204444, 4145.7719825409895, 4172.165566886635, 5819.883602328015, 5827.679477628686, 5831.125331200354, 5836.88326233473, 5856.531477481792, 5988.760449581968, 6102.877942441215, 6105.114758360101, 6131.724072416663, 6148.0, 5787.479126878601, 5795.13073039039, 5795.710214489343, 5888.852778680482, 5926.911096333559, 5306.575473962073, 5331.5201631853315, 5342.2253773202665, 5343.412224655285, 5346.224797404355, 6084.269887613515, 6346.143270658495, 6391.296957334689, 6407.199100112486, 6413.935860641427, 5964.731587078679, 6086.087086936995, 6120.264288666237, 6128.992047069418, 6175.2589689237575, 6371.776987805404, 6375.043743438521, 6383.457406120532, 6385.042243663488, 6386.233651961795, 6063.848403789941, 6083.239595050619, 6083.939160608337, 6089.0, 6091.116788065794, 5871.823845284648, 5990.910136348046, 6052.606580572248, 6090.330063692902, 6103.633781973096, 5985.132155837467, 5993.70031498432, 5995.5803093783015, 5996.640201587918, 6001.609895356788, 6000.819975400745, 6005.819825405245, 6009.729562169626, 6013.128096426081, 6013.729382177725, 5757.050086735641, 5875.148103525051, 5883.146943693226, 5921.911171332519, 5950.256217972754, 6025.276966764016, 6101.572889897842, 6113.083037544404, 6116.724747386467, 6119.908201376894, 5865.149553314831, 5925.1704761332585, 5933.465988061095, 5936.940630593639, 5950.2264705587995], "value": 5622.2915491850845, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [589.5460495418528, 605.8848818724442, 631.9684015799212, 633.4109278371113, 633.5913335898344, 34600.48099278513, 37891.24217515655, 37896.81051594745, 37901.43147852785, 37968.0, 46710.29934550985, 48214.75892620541, 48319.75840120803, 51964.480355196436, 52024.479755202534, 9270.953645231764, 9410.058994100604, 9413.0, 9423.34036617437, 9425.151736343727, 8227.712030078948, 8434.746957591251, 9325.253979681609, 9418.529073546295, 9425.952870235638, 11093.611723589676, 11279.323240605549, 11375.146863985194, 11744.295342279447, 11755.294682319089, 11197.328160310366, 11224.719382015433, 11279.548818047268, 11283.605073822377, 11289.717757056058, 11004.779904401947, 11064.0, 11068.944655276753, 11083.50124244411, 11085.445727713583, 46963.76518117422, 47188.76405617984, 47229.76385118087, 47304.76347618274, 47382.76308618469, 3726.441033844918, 3823.2353529293973, 3982.4424580558743, 4034.8789536313957, 4393.956060439386, 31501.52747708786, 34191.31617367639, 34631.13422164441, 34983.82508087469, 35477.82261088704, 4611.1930412177735, 4725.1730947084125, 4735.928961065587, 4750.501197374295, 4778.784954677048, 364361.0, 365618.0, 367849.0, 369255.0, 369282.0, 66379.0, 66590.66704666543, 66601.33398666048, 66812.33187668158, 66989.66505167443, 40853.0, 71951.0, 72097.55804883978, 72120.63939680268, 72163.63918180375, 18007.54981125456, 18760.0, 18778.906105469385, 18780.06099695037, 18788.154533046047, 13693.315334233248, 13710.588682339347, 13710.725785484234, 13716.314184290746, 13760.449582016607, 18843.05784710759, 19051.809481905282, 20158.596828063357, 21350.0, 21533.353999380044, 7131.465140114512, 7277.672504737299, 7416.629168541659, 7528.661210245552, 7694.653740581575, 894.181823631383, 964.71058682395, 1036.212478516333, 1068.7541865371008, 1071.892810718922, 34215.31569368599, 34385.140371490415, 34691.13272168166, 34730.13174670653, 34826.20121981435, 1083.1659622090947, 1112.3203962017412, 1114.4984756859283, 1134.3987686526154, 1172.9706757331135, 17295.65408691819, 18017.639647206983, 18140.546486337684, 18170.45488635343, 18233.544161395806, 525579.0, 525679.0, 527592.0, 529776.0, 530338.0, 63812.36187638157, 64301.0, 64314.6784266085, 64457.355426446076, 64630.0, 1294.3463550906731, 1321.5704895908868, 1334.4595438847282, 1359.8436179839446, 1364.249662685519, 32290.0, 33868.3988476537, 33963.3207335847, 33967.83016084904, 34045.319093617494, 56461.0, 56711.43288567061, 56822.43177568171, 56926.0, 56958.14562781645, 416235.0, 416876.0, 418035.0, 418506.0, 418952.0, 26999.59500607453, 28372.57441138426, 29055.273618159714, 32248.35503289968, 32813.17967050843, 46831.0, 48352.5164748348, 51776.22335665044, 51816.0, 51869.48130518646, 42781.57218427776, 42885.57114428816, 44001.77999110112, 44323.0, 45715.54284457113, 43146.35280470733, 44441.88895277644, 45102.0, 45365.54634453613, 45411.54588454205, 44216.55783442124, 44773.776131119135, 44802.10395792131, 45134.32298515459, 45141.32288015616, 36323.0, 39463.42146314115, 39745.626397486005, 40196.19607607773, 40284.0, 30370.544441833834, 30414.54378184373, 30504.84747576248, 30506.237344066576, 30579.54130688086], "value": 21561.76137260194, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [396.2570180910792, 436.75105190041677, 439.85484790019296, 441.9176245686338, 448.4148186616464, 16604.252808623613, 20315.39053828384, 20341.186352545898, 20352.084156212968, 21253.787462125376, 20095.899520502415, 20344.59310813783, 20354.59290814183, 20371.898140509278, 20594.897025514852, 5941.346451890288, 5975.804839032189, 6111.572189946705, 6134.018557030876, 6143.631382117065, 5947.0, 6081.695915204245, 6152.107944348067, 6166.4450199482035, 6166.568340216187, 6064.332923378425, 6100.054491553794, 6104.4200800923845, 6106.206193194901, 6114.908276375858, 5890.469857712784, 6097.0, 6105.389461053904, 6106.572539922185, 6157.384261573851, 6094.969525152346, 6162.7534898604, 6171.321154672983, 6172.9074063889075, 6173.629582225036, 14748.557543273719, 14935.626609334744, 15135.924320378437, 15248.542543723706, 15323.157226352547, 2391.8086553075714, 2507.862067586282, 2581.9414040243596, 2940.309322139778, 3018.5773991641186, 10798.51406686701, 10936.0, 11055.502502387411, 11097.223194376396, 11166.162537809696, 2092.9581408371746, 2106.09437941685, 2106.7787882272296, 2155.91376344946, 2165.2854557995825, 56643.0, 62997.0, 66445.33554664488, 71127.99999999948, 80184.0, 11199.0, 12069.456874440672, 12183.878161218452, 12254.877451225551, 12363.381830908418, 17378.82621173772, 17405.825941740673, 17406.47780566585, 17411.303547857944, 17430.91284543569, 8678.6528538859, 8765.561721914006, 8839.69061082859, 8846.115388461103, 8862.512561809162, 8266.13205613414, 8295.129011453831, 8322.126176751475, 8531.829363412697, 8538.658453661908, 5118.923216151761, 5161.38063432383, 5208.218767184952, 5242.423333433319, 5253.317068781111, 2062.7215325930806, 2102.7056212130315, 2106.252280440452, 2131.9893400532897, 2135.4341099608614, 919.8114386550741, 955.2883102088988, 1065.6749691344214, 1068.615298492542, 1105.4417519152776, 20088.39734807929, 20302.69545956812, 20402.18391264333, 20548.32069933077, 20658.17367305321, 958.8993155718689, 982.597135174575, 993.7118235711707, 1018.4907546226887, 1018.8930162332997, 10464.925004860079, 11106.833397499044, 11170.106391488662, 11200.159988000933, 11341.0, 442688.0, 443036.0, 461029.0, 471888.0, 476234.0, 55371.44628553744, 57745.42254577485, 74665.62667186737, 75678.24321756711, 96327.51836240914, 1019.5972590826582, 1021.6066814276558, 1025.7640742629087, 1038.3354653022072, 1044.383813550009, 13213.339333033502, 17333.56666083358, 18483.353082642043, 18518.57404880749, 18582.721259180853, 40225.39661905015, 40819.0, 40997.0, 41202.1759564801, 41804.95487612834, 51030.0, 53841.653958651346, 54625.45374546362, 55094.44905550893, 56225.0, 7120.0387947626405, 7931.722389716563, 8858.158474945129, 8909.955450222707, 8979.595918183566, 12322.383880805744, 12401.13192076546, 12831.165974211646, 12848.614541563767, 12987.870121298665, 11325.862000079867, 11457.140714446616, 11483.425828708365, 11724.0, 11760.300373469523, 5540.833774986757, 9657.758556035875, 10845.24083314192, 11178.105751539695, 11370.374629395463, 11771.293722376684, 11802.937735603837, 11854.348010859485, 11974.46114924813, 12083.320839205559, 8995.550222488719, 9057.320700947586, 9092.223113844608, 9113.225375843127, 9160.450372977642, 9084.743057772124, 11837.408129593658, 12063.75872482563, 12189.817152742538, 12220.816687749513], "value": 9289.42321778879, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1518.7949626800382, 1539.9307031183596, 1687.5696697342175, 1777.0848013273176, 1806.918688659011, 9109.681161159353, 9736.756581085467, 9758.512074396287, 9874.802503949935, 9879.209663226942, 8493.66025358985, 8751.86872196916, 8957.0, 9219.262459003281, 9682.080202380763, 2508.059477695864, 2537.3022418834876, 2537.391026153719, 2538.7588179122954, 2541.009006487471, 2411.3127758588807, 2491.676082109323, 2495.8752062396898, 2497.8126640501946, 2497.987510062447, 2450.1791899713617, 2458.323960910746, 2534.8479091254585, 2537.733537978513, 2538.8730563471754, 2389.95220095598, 2391.6053851114543, 2399.4121440247163, 2446.7063952325657, 2447.5104979004273, 2364.4679947011955, 2373.050779688121, 2381.9642705359433, 2382.5115851250453, 2424.35754525051, 9426.717198484057, 9630.374025688308, 9635.662751803724, 9700.0, 9757.365771224848, 5619.915701264485, 5641.182028605829, 5646.745896434671, 5696.3449203341315, 5760.0, 3440.122768693967, 3540.4335306351118, 3579.534660494145, 3595.3708101082207, 3605.7656252343777, 1202.597129961464, 1217.2392254840724, 1235.2773627427966, 1240.4046057892263, 1271.230905302288, 13543.119697219649, 13558.186508809504, 13566.864331356757, 13570.93214533931, 13585.116967397087, 4897.657163998557, 4994.625403094782, 5097.08252514551, 5098.439171691111, 5196.428392876781, 11390.37352945596, 11393.03159231458, 11397.772044559062, 11398.829017564743, 11411.657650270505, 5764.538836893039, 5766.135079738073, 5767.452092051249, 5767.567432442584, 5770.855728606818, 4349.3041113421705, 4379.781010949439, 5179.559737422362, 5240.187770895441, 5303.416624171338, 4280.293751531025, 4319.136172765459, 4395.1868904252815, 4434.046679963823, 4435.090806384684, 1351.2770667692737, 1395.5813256023152, 1399.230423267199, 1399.3213291553589, 1402.2708191740237, 849.634657097454, 956.8373376526007, 961.423146112327, 968.1915600473543, 992.9404235745734, 6203.6587987660205, 6347.841303967438, 6440.645764482999, 6558.376954189344, 6644.767433139817, 464.13670572734685, 478.50474758624654, 484.8424262114827, 487.91705410080374, 488.6066716293418, 4147.730397524151, 4219.282721937278, 4244.596763307481, 4268.423762791983, 4271.10306835568, 11080.279781814317, 11517.769644607228, 11523.596674116534, 11586.942065289619, 11601.0, 11430.0, 11456.255343402652, 11456.885431145582, 11471.197016208785, 11478.196526243082, 8419.873701894354, 8542.273906717874, 8683.739487815375, 8688.348373871859, 8949.284057275272, 6421.357864213542, 6495.123158373559, 6501.577397469149, 6579.835504112435, 6581.177352830896, 10908.61819836302, 10966.616168434066, 11207.10343172528, 11217.27087739327, 11362.261453005529, 10906.400147991937, 11163.162762792661, 11237.3257604544, 11326.660200194008, 11328.263662861887, 7404.296591823768, 7638.541687498768, 8405.327573794204, 8421.15788421153, 8579.785505362166, 9298.395604285699, 9523.428594284365, 9544.093311135432, 9547.0, 9553.665621703207, 8494.53280069602, 8503.23470887623, 8539.444936079135, 8589.14108589136, 8684.175003374668, 7772.417068719756, 7990.360771138178, 8092.79768005781, 8136.633851476816, 8196.754097377088, 7302.306280903305, 7363.447741419523, 7368.263173682589, 7385.224551422023, 7480.551166930001, 5393.191021346829, 5457.399686034453, 5601.411851755507, 5602.887942241214, 5832.766689332549, 5483.561315094703, 5501.724913754377, 5553.222548843084, 5609.635373700697, 5619.438056194348], "value": 4875.077736093943, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [359.71762166699136, 359.7337969902273, 366.251016670908, 372.3929994109601, 374.9568799588045, 5441.863953401167, 5596.692181929992, 5605.635633683818, 5628.127640215763, 5643.294588176478, 5325.840224793253, 5498.4501549845, 5514.724263786815, 5523.25436066131, 5523.420040895709, 4366.1922544329245, 4377.190219809329, 4383.605475507204, 4389.341598760179, 4393.648508119359, 4238.5840071159455, 4341.2836881914445, 4375.8249670013165, 4389.275769498029, 4417.911641767163, 4307.138572285539, 4324.481062272532, 4333.804978775946, 4336.48223121908, 4340.893072266567, 4331.393604895317, 4331.501877284106, 4337.436133302682, 4342.416262323913, 4373.785267828143, 3827.27281816454, 3923.941140882889, 3935.5206220081163, 3953.1105501261986, 3959.6238357356006, 5419.34967803866, 5421.0, 5423.101914329993, 5423.186522021689, 5452.0, 5061.392632884041, 5074.31496747938, 5078.542931136216, 5084.51697088776, 5095.719735414551, 5582.49757521825, 5821.650700957956, 5850.561207909382, 5852.648841069549, 5875.0, 4400.295952647593, 4404.933925991113, 4407.184670835905, 4415.779211039435, 4433.002574420761, 5985.5810093293485, 6085.8353656099025, 6099.908501372527, 6121.66330851803, 6135.32511423743, 4492.820287188541, 4506.774661266989, 4511.210538155809, 4523.615492683159, 4530.207213737583, 4571.839985600488, 4572.337011133367, 4580.679352445363, 4587.839425620087, 4590.67865249436, 4970.552650261494, 5023.346964894614, 5098.286239926413, 5118.360204974379, 5125.333706618116, 5551.861203469945, 5868.853278667982, 5876.7355469004, 5877.735501902424, 5886.852828679232, 1484.5917372722372, 1486.695227478386, 1514.4018112845586, 1520.1259275916393, 1532.4176812811284, 1077.7628921637227, 1102.2669924500278, 1112.4604566785104, 1122.5117074072805, 1126.4367816091954, 5648.63283886546, 5649.548036157097, 5651.6043876928225, 5665.830025099253, 5674.460926212003, 5968.671723055187, 5977.521798256129, 5984.700764961822, 5987.5808693391045, 6006.939930600725, 5451.1569343612655, 5631.1980166346375, 5660.575456840754, 5667.4332566743, 5674.517665998436, 2782.692134696689, 2807.540079158826, 2811.2128603990914, 2811.676657184409, 2839.914802555885, 5138.717370544581, 5329.122273972089, 5335.413104558495, 5345.1447768356875, 5399.70301633414, 5154.221793481243, 5180.948190518046, 5330.853866418739, 5372.328458942632, 5402.891942161214, 5394.2448057272795, 5397.218917757131, 5402.459754024566, 5412.458754124635, 5417.566594672417, 4998.250262460515, 5191.29917461153, 5222.55608273301, 5241.9737901310245, 5298.920516192183, 5205.245239440335, 5218.165093585008, 5220.347456567929, 5228.268042474133, 5244.501772331622, 5346.919796203138, 5349.144136938071, 5352.866178345573, 5362.436944120811, 5374.7581358839725, 3833.4058220975794, 3959.4852669152824, 3983.8605648802154, 4058.573849745734, 4079.2453396121814, 5174.016936781999, 5193.143131383431, 5239.318888544617, 5734.770609175586, 5876.471117599436, 5722.6852523109965, 5864.912026319524, 5879.823605291848, 5879.911801322898, 5902.675352855634, 5868.0, 5882.0, 5888.823335299948, 5890.941090589039, 5891.293044834647, 5631.183478395692, 5779.393163717749, 5831.970840145772, 5835.0, 5857.531397488276, 5889.617174883619, 5917.792877249276, 5921.230240068936, 5925.40745925404, 5932.228810254639, 5625.268715067179, 5734.799282025109, 5762.538996880324, 5769.68266745333, 5770.422957704364], "value": 4375.1560896424235, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [794.3883209928355, 830.7715378270979, 842.3766412854486, 850.987235191472, 923.3029063057388, 15339.539813805604, 16232.350705971761, 17397.739033914502, 17416.651666966653, 17441.302347906083, 15398.384064637401, 15438.228088595553, 15503.689926201498, 15585.064896106242, 15688.215589220521, 676.4520738202048, 689.1420181873574, 806.8870358149863, 828.1387357148558, 839.0434904209206, 844.5186243841013, 847.2036285891273, 848.2832006954114, 851.8296340731847, 856.4861083349971, 900.6982660808637, 902.1474706402453, 903.0563061600643, 903.2006674093442, 904.3172404834373, 902.0122965352928, 903.8237543678986, 903.8418276801566, 904.0868722590199, 904.5612877754284, 663.9236487803917, 664.4219529009744, 665.4310564467407, 666.3935818405228, 666.5700623098074, 16156.27296771648, 16262.0, 16303.755443668355, 16304.592385190346, 16326.0, 15729.37082516698, 16577.254023568967, 16661.750073748903, 17182.74225886613, 17664.381746638806, 11339.886601133965, 11461.656150315504, 11715.882841171564, 11959.760804783942, 12137.332446715427, 3983.1260658402434, 4118.5263694675195, 4144.109016561423, 4156.251874662559, 4247.8088486018205, 71891.0, 75696.0, 76114.0, 83111.584442078, 85176.0, 12437.875621243853, 12674.619761407173, 12760.6809829755, 12966.157199781985, 13098.607041788762, 22342.106315747515, 22454.887725561595, 22491.43771405728, 22611.321660350215, 22613.0, 8961.507117108622, 9077.863832042392, 9173.58718857653, 9186.219171370374, 9247.0, 4373.234683930299, 4690.882727931829, 4736.194846876039, 4820.180569303227, 5006.799728010911, 3864.381698928214, 3953.169834334822, 4003.6997225208224, 4010.3382941814275, 4046.9392959105635, 655.9737610495526, 657.6580178307349, 663.3598577372762, 679.5582871133803, 701.7508784381573, 652.7552167937024, 744.6351287868905, 778.4473024152802, 791.701609360649, 814.0882211922566, 9780.266480014028, 10109.747256318651, 10199.847002294971, 10265.178785697126, 10652.786944261072, 746.4625469661835, 768.3891306411416, 781.3631890009624, 781.4607920534813, 787.830616417473, 4687.67186296956, 4997.675151115166, 5066.974665126724, 5192.446087798084, 5463.344398672185, 127064.0, 127789.0, 129730.35134824454, 130145.0, 132925.3353733225, 66648.66675666688, 68053.0, 77637.223627763, 98948.0, 110428.0, 98925.0, 100102.4994875021, 102980.48509757403, 104597.47701261444, 104634.24511651932, 10508.264421490423, 10974.396408197626, 11005.0, 11099.833502497308, 11526.308421494738, 59610.70194648999, 60308.69845650744, 61462.0, 63007.6849615749, 63154.684226578574, 81271.0, 83558.58220708858, 91666.54166729124, 92039.47763134234, 94798.0, 13940.0, 13944.860551394357, 13994.300284985913, 14691.412343506567, 15124.39502419891, 14841.554753357417, 14997.400103995718, 15339.233038347815, 15629.14039727826, 15854.286557104728, 14857.405703771728, 15240.237988100773, 15925.761113583074, 16359.100249486393, 16476.588085297484, 13980.650483737987, 14119.364628591533, 14176.929115354356, 14235.572932812032, 14865.108093514424, 14091.295435227992, 14157.150570965776, 14242.07426517273, 14572.271386430424, 14957.925210373878, 11577.778438779578, 11936.0, 12230.87769122333, 12294.077944154045, 12377.752444951231, 11656.776038515834, 12479.25124492497, 12565.685857853261, 12720.936395317964, 12862.421191046613], "value": 8134.559746875647, "unit": "score"}], "name": "dromaeo_css", "value": 7617.688605671335, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 109.0, 111.0, 109.0, 112.0, 109.0, 109.0, 110.0, 109.0, 112.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 116.0, 123.0, 150.0, 122.0, 118.0, 122.0, 121.0, 152.0, 118.0], "value": 128.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 161.0, 161.0, 160.0, 159.0, 161.0, 161.0, 161.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 77.0, 107.0, 76.0, 77.0, 77.0, 76.0, 109.0, 76.0], "value": 82.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 107.0, 81.0, 82.0, 82.0, 110.0, 82.0, 82.0, 114.0], "value": 90.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 116.0, 116.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, 147.0, 146.0, 146.0, 145.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 94.0, 94.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 50.0, 48.0, 49.0, 49.0, 50.0, 50.0, 48.0, 48.0, 49.0], "value": 49.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 59.0, 59.0, 61.0, 60.0, 60.0, 59.0, 59.0, 58.0, 58.0], "value": 59.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 79.0, 73.0, 73.0, 72.0, 73.0, 81.0, 74.0, 73.0], "value": 74.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 124.0, 136.0, 122.0, 121.0, 118.0, 129.0, 118.0, 176.0, 119.0], "value": 129.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 157.0, 157.0, 154.0, 155.0, 157.0, 157.0, 159.0, 155.0, 154.0], "value": 155.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 66.0, 62.0, 62.0, 63.0, 66.0, 63.0, 63.0, 63.0], "value": 63.6, "unit": "score"}], "name": "kraken", "value": 1461.2, "alertThreshold": 2.0}]} 22:11:30 INFO - Return code: 0 22:11:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:11:30 INFO - # TBPL SUCCESS # 22:11:30 INFO - Running post-action listener: _resource_record_post_action 22:11:30 INFO - [mozharness: 2016-12-22 06:11:30.234461Z] Finished run-tests step (success) 22:11:30 INFO - Running post-run listener: _resource_record_post_run 22:11:30 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 318197760; Read time: 16; Write time: 240412 22:11:30 INFO - TinderboxPrint: CPU usage
13.0% 22:11:30 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 22:11:30 INFO - TinderboxPrint: I/O write bytes / time
318,197,760 / 240,412 22:11:30 INFO - TinderboxPrint: CPU idle
8,252.7 (87.0%) 22:11:30 INFO - TinderboxPrint: CPU user
1,186.5 (12.5%) 22:11:30 INFO - TinderboxPrint: Swap in / out
0 / 0 22:11:30 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 100294656; Read time: 0; Write time: 122364 22:11:30 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 217903104; Read time: 16; Write time: 118048 22:11:30 INFO - Running post-run listener: _upload_blobber_files 22:11:30 INFO - Blob upload gear active. 22:11:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:11:30 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 22:11:30 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-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:11:30 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-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:11:31 INFO - (blobuploader) - INFO - Open directory for files ... 22:11:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:11:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:11:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:11:34 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:11:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:11:34 INFO - (blobuploader) - INFO - Done attempting. 22:11:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 22:11:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:11:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:11:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:11:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:11:35 INFO - (blobuploader) - INFO - Done attempting. 22:11:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:11:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:11:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:11:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:11:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:11:36 INFO - (blobuploader) - INFO - Done attempting. 22:11:36 INFO - (blobuploader) - INFO - Iteration through files over. 22:11:36 INFO - Return code: 0 22:11:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:11:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:11:36 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/85ce89e0ac78dadea37a91e84ead37041f34ec47e1a1e756de5ffec229bbf5c014e71a646d43bb9ae62b2c6f91200d3654795456105fafda3ef1f2ac86960e5f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ec1cb03762e6606d93597305204ff466a516379ba1e1b254aceb0018a6249cc96a897beafe6d72b20d441154c54856980ac22aa0af39143385c5bf84e9b76580", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/deecf68c1b074e36f112bda216e4d5cbc0fd18e7429cd99fc1efbc4480eb0ce928c019b009595e26239460a756b68de935e21bd69cac1b044c52778f9b11ebac"} 22:11:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:11:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:11:36 INFO - Contents: 22:11:36 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/85ce89e0ac78dadea37a91e84ead37041f34ec47e1a1e756de5ffec229bbf5c014e71a646d43bb9ae62b2c6f91200d3654795456105fafda3ef1f2ac86960e5f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ec1cb03762e6606d93597305204ff466a516379ba1e1b254aceb0018a6249cc96a897beafe6d72b20d441154c54856980ac22aa0af39143385c5bf84e9b76580", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/deecf68c1b074e36f112bda216e4d5cbc0fd18e7429cd99fc1efbc4480eb0ce928c019b009595e26239460a756b68de935e21bd69cac1b044c52778f9b11ebac"} 22:11:36 INFO - Running post-run listener: copy_logs_to_upload_dir 22:11:36 INFO - Copying logs to upload dir... 22:11:36 INFO - mkdir: /builds/slave/test/build/upload/logs 22:11:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.395129 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-12-21 22:11:35.479817) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-21 22:11:35.482878) ========= 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=fa44defc139c4ba8574fe040000001db-1482384360.637384-427996043 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-Beta/sha512/85ce89e0ac78dadea37a91e84ead37041f34ec47e1a1e756de5ffec229bbf5c014e71a646d43bb9ae62b2c6f91200d3654795456105fafda3ef1f2ac86960e5f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ec1cb03762e6606d93597305204ff466a516379ba1e1b254aceb0018a6249cc96a897beafe6d72b20d441154c54856980ac22aa0af39143385c5bf84e9b76580", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/deecf68c1b074e36f112bda216e4d5cbc0fd18e7429cd99fc1efbc4480eb0ce928c019b009595e26239460a756b68de935e21bd69cac1b044c52778f9b11ebac"} build_url:https://queue.taskcluster.net/v1/task/Vz4sCykWS5mpqFB9fwS0eQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011901 build_url: 'https://queue.taskcluster.net/v1/task/Vz4sCykWS5mpqFB9fwS0eQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/85ce89e0ac78dadea37a91e84ead37041f34ec47e1a1e756de5ffec229bbf5c014e71a646d43bb9ae62b2c6f91200d3654795456105fafda3ef1f2ac86960e5f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ec1cb03762e6606d93597305204ff466a516379ba1e1b254aceb0018a6249cc96a897beafe6d72b20d441154c54856980ac22aa0af39143385c5bf84e9b76580", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/deecf68c1b074e36f112bda216e4d5cbc0fd18e7429cd99fc1efbc4480eb0ce928c019b009595e26239460a756b68de935e21bd69cac1b044c52778f9b11ebac"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-21 22:11:35.507764) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 22:11:35.508047) ========= 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=fa44defc139c4ba8574fe040000001db-1482384360.637384-427996043 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004512 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 22:11:35.592147) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-21 22:11:35.592444) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-21 22:11:35.592726) ========= ========= Total master_lag: 0.15 =========