builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-035 starttime: 1482432666.72 results: success (0) buildid: 20161222091543 builduid: 222e095a560e487c8e2c4c50b2a85cb0 revision: 4103e1b2f12cc7e76477f6f78f1102abb21beb5a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-22 10:51:06.719934) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-22 10:51:06.720496) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-22 10:51:06.721009) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-22 10:51:06.739214) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 10:51:06.739967) ========= 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=ed14279e38b05397cf4aa391000001a4-1482432498.779553-1395043814 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-22 10:51:07-- 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% 70.1M=0s 2016-12-22 10:51:07 (70.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.116222 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 10:51:06.910758) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 10:51:06.911107) ========= 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=ed14279e38b05397cf4aa391000001a4-1482432498.779553-1395043814 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020593 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 10:51:06.947157) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 10:51:06.947980) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 4103e1b2f12cc7e76477f6f78f1102abb21beb5a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 4103e1b2f12cc7e76477f6f78f1102abb21beb5a --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=ed14279e38b05397cf4aa391000001a4-1482432498.779553-1395043814 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-22 10:51:07,751 truncating revision to first 12 chars 2016-12-22 10:51:07,751 Setting DEBUG logging. 2016-12-22 10:51:07,751 attempt 1/10 2016-12-22 10:51:07,751 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/4103e1b2f12c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-22 10:51:08,060 unpacking tar archive at: mozilla-inbound-4103e1b2f12c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.635483 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 10:51:07.598852) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-22 10:51:07.599212) ========= script_repo_revision: 4103e1b2f12cc7e76477f6f78f1102abb21beb5a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-22 10:51:07.600223) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-22 10:51:07.600926) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-22 10:51:07.613237) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-12-22 10:51:07.613952) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=ed14279e38b05397cf4aa391000001a4-1482432498.779553-1395043814 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:51:08 INFO - MultiFileLogger online at 20161222 10:51:08 in /builds/slave/test 10:51:08 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 10:51:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:51:08 INFO - {'append_to_log': False, 10:51:08 INFO - 'base_work_dir': '/builds/slave/test', 10:51:08 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 10:51:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:51:08 INFO - 'branch': 'Mozilla-Inbound', 10:51:08 INFO - 'buildbot_json_path': 'buildprops.json', 10:51:08 INFO - 'config_files': ('talos/linux_config.py',), 10:51:08 INFO - 'default_actions': ('clobber', 10:51:08 INFO - 'read-buildbot-config', 10:51:08 INFO - 'download-and-extract', 10:51:08 INFO - 'populate-webroot', 10:51:08 INFO - 'create-virtualenv', 10:51:08 INFO - 'install', 10:51:08 INFO - 'run-tests'), 10:51:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:51:08 INFO - 'download_minidump_stackwalk': True, 10:51:08 INFO - 'download_symbols': 'ondemand', 10:51:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:51:08 INFO - 'tooltool.py': '/tools/tooltool.py', 10:51:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:51:08 INFO - '/tools/misc-python/virtualenv.py')}, 10:51:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:51:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:51:08 INFO - 'installer_path': 'installer.exe', 10:51:08 INFO - 'log_level': 'info', 10:51:08 INFO - 'log_name': 'talos', 10:51:08 INFO - 'log_to_console': True, 10:51:08 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:51:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:51:08 INFO - 'opt_config_files': (), 10:51:08 INFO - 'pip_index': False, 10:51:08 INFO - 'sps_profile': False, 10:51:08 INFO - 'sps_profile_interval': 0, 10:51:08 INFO - 'suite': 'dromaeojs-e10s', 10:51:08 INFO - 'system_bits': '32', 10:51:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:51:08 INFO - 'title': 'talos-linux64-ix-035', 10:51:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:51:08 INFO - 'use_talos_json': True, 10:51:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:51:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:51:08 INFO - 'work_dir': 'build'} 10:51:08 INFO - [mozharness: 2016-12-22 18:51:08.513473Z] Running clobber step. 10:51:08 INFO - Running pre-action listener: _resource_record_pre_action 10:51:08 INFO - Running main action method: clobber 10:51:08 INFO - rmtree: /builds/slave/test/build 10:51:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:51:09 INFO - Running post-action listener: _resource_record_post_action 10:51:09 INFO - [mozharness: 2016-12-22 18:51:09.491914Z] Finished clobber step (success) 10:51:09 INFO - [mozharness: 2016-12-22 18:51:09.492014Z] Running read-buildbot-config step. 10:51:09 INFO - Running pre-action listener: _resource_record_pre_action 10:51:09 INFO - Running main action method: read_buildbot_config 10:51:09 INFO - Using buildbot properties: 10:51:09 INFO - { 10:51:09 INFO - "project": "", 10:51:09 INFO - "product": "firefox", 10:51:09 INFO - "script_repo_revision": "production", 10:51:09 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 10:51:09 INFO - "repository": "", 10:51:09 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 10:51:09 INFO - "buildid": "20161222091543", 10:51:09 INFO - "pgo_build": "True", 10:51:09 INFO - "basedir": "/builds/slave/test", 10:51:09 INFO - "buildnumber": 2345, 10:51:09 INFO - "slavename": "talos-linux64-ix-035", 10:51:09 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:51:09 INFO - "platform": "ubuntu64_hw", 10:51:09 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 10:51:09 INFO - "branch": "mozilla-inbound", 10:51:09 INFO - "repo_path": "integration/mozilla-inbound", 10:51:09 INFO - "revision": "4103e1b2f12cc7e76477f6f78f1102abb21beb5a", 10:51:09 INFO - "stage_platform": "linux64-pgo", 10:51:09 INFO - "builduid": "222e095a560e487c8e2c4c50b2a85cb0", 10:51:09 INFO - "slavebuilddir": "test" 10:51:09 INFO - } 10:51:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/U0aFhKocQV6ucuMXkQT56A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 10:51:09 INFO - Running post-action listener: _resource_record_post_action 10:51:09 INFO - [mozharness: 2016-12-22 18:51:09.494495Z] Finished read-buildbot-config step (success) 10:51:09 INFO - [mozharness: 2016-12-22 18:51:09.494585Z] Running download-and-extract step. 10:51:09 INFO - Running pre-action listener: _resource_record_pre_action 10:51:09 INFO - Running main action method: download_and_extract 10:51:09 INFO - mkdir: /builds/slave/test/build/tests 10:51:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:51:09 INFO - trying https://queue.taskcluster.net/v1/task/U0aFhKocQV6ucuMXkQT56A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 10:51:09 INFO - Downloading https://queue.taskcluster.net/v1/task/U0aFhKocQV6ucuMXkQT56A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 10:51:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/U0aFhKocQV6ucuMXkQT56A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 10:51:10 INFO - Downloaded 1361 bytes. 10:51:10 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 10:51:10 INFO - Using the following test package requirements: 10:51:10 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 10:51:10 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 10:51:10 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:51:10 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 10:51:10 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:51:10 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 10:51:10 INFO - u'jsshell-linux-x86_64.zip'], 10:51:10 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 10:51:10 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:51:10 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 10:51:10 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 10:51:10 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:51:10 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 10:51:10 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:51:10 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 10:51:10 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:51:10 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 10:51:10 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:51:10 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:51:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/U0aFhKocQV6ucuMXkQT56A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 10:51:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/U0aFhKocQV6ucuMXkQT56A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:51:10 INFO - Fetch https://queue.taskcluster.net/v1/task/U0aFhKocQV6ucuMXkQT56A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 10:51:10 INFO - Expected file size: 21825271 10:51:10 INFO - Obtained file size: 21825271 10:51:15 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:51:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/U0aFhKocQV6ucuMXkQT56A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 10:51:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/U0aFhKocQV6ucuMXkQT56A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:51:15 INFO - Fetch https://queue.taskcluster.net/v1/task/U0aFhKocQV6ucuMXkQT56A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 10:51:16 INFO - Expected file size: 21825271 10:51:16 INFO - Obtained file size: 21825271 10:51:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/U0aFhKocQV6ucuMXkQT56A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 10:51:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/U0aFhKocQV6ucuMXkQT56A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:51:20 INFO - Fetch https://queue.taskcluster.net/v1/task/U0aFhKocQV6ucuMXkQT56A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 10:51:22 INFO - Expected file size: 14409776 10:51:22 INFO - Obtained file size: 14409776 10: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')]} 10:51:22 INFO - trying https://queue.taskcluster.net/v1/task/U0aFhKocQV6ucuMXkQT56A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 10:51:22 INFO - Downloading https://queue.taskcluster.net/v1/task/U0aFhKocQV6ucuMXkQT56A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 10:51:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/U0aFhKocQV6ucuMXkQT56A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:51:23 INFO - Downloaded 61381358 bytes. 10:51:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/U0aFhKocQV6ucuMXkQT56A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 10:51:23 INFO - mkdir: /builds/slave/test/properties 10:51:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:51:23 INFO - Writing to file /builds/slave/test/properties/build_url 10:51:23 INFO - Contents: 10:51:23 INFO - build_url:https://queue.taskcluster.net/v1/task/U0aFhKocQV6ucuMXkQT56A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 10:51:24 INFO - Running post-action listener: _resource_record_post_action 10:51:24 INFO - Running post-action listener: set_extra_try_arguments 10:51:24 INFO - [mozharness: 2016-12-22 18:51:24.058281Z] Finished download-and-extract step (success) 10:51:24 INFO - [mozharness: 2016-12-22 18:51:24.058508Z] Running populate-webroot step. 10:51:24 INFO - Running pre-action listener: _resource_record_pre_action 10:51:24 INFO - Running main action method: populate_webroot 10:51:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:51:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:51:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:51:24 INFO - '--tppagecycles', 10:51:24 INFO - '7'], 10:51:24 INFO - 'tests': ['tsvgm']}}, 10:51:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:51:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:51:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:51:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:51:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:51:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:51:24 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 10:51:24 INFO - 'talos_options': ['--disable-e10s'], 10:51:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:51:24 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 10:51:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:51:24 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 10:51:24 INFO - 'talos_options': ['--disable-e10s'], 10:51:24 INFO - 'tests': ['damp', 'tps']}, 10:51:24 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 10:51:24 INFO - 'tests': ['damp', 'tps']}, 10:51:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:51:24 INFO - 'tests': ['dromaeo_dom']}, 10:51:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:51:24 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:51:24 INFO - 'tests': ['basic_compositor_video']}, 10:51:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:51:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:51:24 INFO - 'tests': ['a11yr', 10:51:24 INFO - 'ts_paint', 10:51:24 INFO - 'tpaint', 10:51:24 INFO - 'sessionrestore', 10:51:24 INFO - 'sessionrestore_no_auto_restore', 10:51:24 INFO - 'tabpaint']}, 10:51:24 INFO - 'other-e10s': {'tests': ['a11yr', 10:51:24 INFO - 'ts_paint', 10:51:24 INFO - 'tpaint', 10:51:24 INFO - 'sessionrestore', 10:51:24 INFO - 'sessionrestore_no_auto_restore', 10:51:24 INFO - 'tabpaint']}, 10:51:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:51:24 INFO - 'ts_paint', 10:51:24 INFO - 'tpaint', 10:51:24 INFO - 'sessionrestore', 10:51:24 INFO - 'sessionrestore_no_auto_restore', 10:51:24 INFO - 'tabpaint']}, 10:51:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:51:24 INFO - 'ts_paint', 10:51:24 INFO - 'tpaint', 10:51:24 INFO - 'sessionrestore', 10:51:24 INFO - 'sessionrestore_no_auto_restore', 10:51:24 INFO - 'tabpaint']}, 10:51:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:51:24 INFO - 'tests': ['a11yr', 10:51:24 INFO - 'ts_paint', 10:51:24 INFO - 'tpaint', 10:51:24 INFO - 'sessionrestore', 10:51:24 INFO - 'sessionrestore_no_auto_restore', 10:51:24 INFO - 'tabpaint']}, 10:51:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:51:24 INFO - 'tests': ['a11yr', 10:51:24 INFO - 'ts_paint', 10:51:24 INFO - 'tpaint', 10:51:24 INFO - 'sessionrestore', 10:51:24 INFO - 'sessionrestore_no_auto_restore', 10:51:24 INFO - 'tabpaint']}, 10:51:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:51:24 INFO - 'tests': ['tsvgx', 10:51:24 INFO - 'tsvgr_opacity', 10:51:24 INFO - 'tart', 10:51:24 INFO - 'tscrollx', 10:51:24 INFO - 'cart', 10:51:24 INFO - 'tsvg_static']}, 10:51:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:51:24 INFO - 'tsvgr_opacity', 10:51:24 INFO - 'tart', 10:51:24 INFO - 'tscrollx', 10:51:24 INFO - 'cart', 10:51:24 INFO - 'tsvg_static']}, 10:51:24 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 10:51:24 INFO - 'talos_options': ['--disable-e10s'], 10:51:24 INFO - 'tests': ['tp5o']}, 10:51:24 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 10:51:24 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 10:51:24 INFO - 'talos_options': ['--disable-e10s', 10:51:24 INFO - '--xperf_path', 10:51:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:51:24 INFO - 'tests': ['tp5n']}, 10:51:24 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 10:51:24 INFO - 'talos_options': ['--xperf_path', 10:51:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:51:24 INFO - 'tests': ['tp5n']}}, 10:51:24 INFO - 'talos.zip': {'path': '', 10:51:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:51:24 INFO - Running post-action listener: _resource_record_post_action 10:51:24 INFO - [mozharness: 2016-12-22 18:51:24.080615Z] Finished populate-webroot step (success) 10:51:24 INFO - [mozharness: 2016-12-22 18:51:24.080704Z] Running create-virtualenv step. 10:51:24 INFO - Running pre-action listener: _resource_record_pre_action 10:51:24 INFO - Running main action method: create_virtualenv 10:51:24 INFO - Creating virtualenv /builds/slave/test/build/venv 10:51:24 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 10:51:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:51:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:51:24 INFO - Using real prefix '/usr' 10:51:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:51:24 INFO - Installing distribute.............................................................................................................................................................................................done. 10:51:26 INFO - Installing pip.................done. 10:51:26 INFO - Return code: 0 10:51:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:51:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:51:26 INFO - Reading from file tmpfile_stdout 10:51:26 INFO - Output received: 10:51:26 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 10:51:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:51:26 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')]} 10:51:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:26 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')]} 10:51:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:26 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 0x1b171f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c28a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e89480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e86820>, '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 0x1e87520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e879b0>, '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': 'ed14279e38b05397cf4aa391000001a4-1482432498.779553-1395043814', '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 10:51:26 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 10:51:26 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 10:51:26 INFO - Using env: {'DISPLAY': ':0', 10:51:26 INFO - 'HOME': '/home/cltbld', 10:51:26 INFO - 'LANG': 'en_US.UTF-8', 10:51:26 INFO - 'LANGUAGE': 'en_US:en', 10:51:26 INFO - 'LOGNAME': 'cltbld', 10:51:26 INFO - 'MAIL': '/var/mail/cltbld', 10:51:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:26 INFO - 'MOZ_NO_REMOTE': '1', 10:51:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:51:26 INFO - 'NO_EM_RESTART': '1', 10:51:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:51:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:51:26 INFO - 'PWD': '/builds/slave/test', 10:51:26 INFO - 'SHELL': '/bin/bash', 10:51:26 INFO - 'SHLVL': '1', 10:51:26 INFO - 'TERM': 'linux', 10:51:26 INFO - 'TMOUT': '86400', 10:51:26 INFO - 'USER': 'cltbld', 10:51:26 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1482432498.779553-1395043814', 10:51:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:26 INFO - '_': '/tools/buildbot/bin/python'} 10:51:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:27 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 10:51:27 INFO - Cleaning up... 10:51:27 INFO - Return code: 0 10:51:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10: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')]} 10:51:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10: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')]} 10:51:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10: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', '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 0x1b171f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c28a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e89480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e86820>, '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 0x1e87520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e879b0>, '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': 'ed14279e38b05397cf4aa391000001a4-1482432498.779553-1395043814', '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 10: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', 'psutil>=3.1.1'] in /builds/slave/test/build 10: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 psutil>=3.1.1 10:51:27 INFO - Using env: {'DISPLAY': ':0', 10:51:27 INFO - 'HOME': '/home/cltbld', 10:51:27 INFO - 'LANG': 'en_US.UTF-8', 10:51:27 INFO - 'LANGUAGE': 'en_US:en', 10:51:27 INFO - 'LOGNAME': 'cltbld', 10:51:27 INFO - 'MAIL': '/var/mail/cltbld', 10:51:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:27 INFO - 'MOZ_NO_REMOTE': '1', 10:51:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:51:27 INFO - 'NO_EM_RESTART': '1', 10:51:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:51:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:51:27 INFO - 'PWD': '/builds/slave/test', 10:51:27 INFO - 'SHELL': '/bin/bash', 10:51:27 INFO - 'SHLVL': '1', 10:51:27 INFO - 'TERM': 'linux', 10:51:27 INFO - 'TMOUT': '86400', 10:51:27 INFO - 'USER': 'cltbld', 10:51:27 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1482432498.779553-1395043814', 10:51:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:27 INFO - '_': '/tools/buildbot/bin/python'} 10:51:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:27 INFO - Downloading/unpacking psutil>=3.1.1 10:51:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:51:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:51:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:51:29 INFO - Installing collected packages: psutil 10:51:29 INFO - Running setup.py install for psutil 10:51:29 INFO - building 'psutil._psutil_linux' extension 10:51:29 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 10:51:29 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 10:51:29 INFO - building 'psutil._psutil_posix' extension 10:51:29 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 10:51:29 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 10:51:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:51:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:51:29 INFO - Successfully installed psutil 10:51:29 INFO - Cleaning up... 10:51:29 INFO - Return code: 0 10:51:29 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:51:29 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')]} 10:51:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:29 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')]} 10:51:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:29 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 0x1b171f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c28a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e89480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e86820>, '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 0x1e87520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e879b0>, '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': 'ed14279e38b05397cf4aa391000001a4-1482432498.779553-1395043814', '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 10:51:29 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 10:51:29 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 10:51:29 INFO - Using env: {'DISPLAY': ':0', 10:51:29 INFO - 'HOME': '/home/cltbld', 10:51:29 INFO - 'LANG': 'en_US.UTF-8', 10:51:29 INFO - 'LANGUAGE': 'en_US:en', 10:51:29 INFO - 'LOGNAME': 'cltbld', 10:51:29 INFO - 'MAIL': '/var/mail/cltbld', 10:51:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:29 INFO - 'MOZ_NO_REMOTE': '1', 10:51:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:51:29 INFO - 'NO_EM_RESTART': '1', 10:51:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:51:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:51:29 INFO - 'PWD': '/builds/slave/test', 10:51:29 INFO - 'SHELL': '/bin/bash', 10:51:29 INFO - 'SHLVL': '1', 10:51:29 INFO - 'TERM': 'linux', 10:51:29 INFO - 'TMOUT': '86400', 10:51:29 INFO - 'USER': 'cltbld', 10:51:29 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1482432498.779553-1395043814', 10:51:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:29 INFO - '_': '/tools/buildbot/bin/python'} 10:51:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 10: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 10: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 10: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 10: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 10: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 10: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 10:51:32 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:51:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:51:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:51:32 INFO - Installing collected packages: mozsystemmonitor 10:51:32 INFO - Running setup.py install for mozsystemmonitor 10:51:32 INFO - Successfully installed mozsystemmonitor 10:51:32 INFO - Cleaning up... 10:51:32 INFO - Return code: 0 10:51:32 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:51:32 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')]} 10:51:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:32 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')]} 10:51:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:32 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 0x1b171f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c28a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e89480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e86820>, '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 0x1e87520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e879b0>, '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': 'ed14279e38b05397cf4aa391000001a4-1482432498.779553-1395043814', '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 10:51:32 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 10:51:32 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 10:51:32 INFO - Using env: {'DISPLAY': ':0', 10:51:32 INFO - 'HOME': '/home/cltbld', 10:51:32 INFO - 'LANG': 'en_US.UTF-8', 10:51:32 INFO - 'LANGUAGE': 'en_US:en', 10:51:32 INFO - 'LOGNAME': 'cltbld', 10:51:32 INFO - 'MAIL': '/var/mail/cltbld', 10:51:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:32 INFO - 'MOZ_NO_REMOTE': '1', 10:51:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:51:32 INFO - 'NO_EM_RESTART': '1', 10:51:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:51:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:51:32 INFO - 'PWD': '/builds/slave/test', 10:51:32 INFO - 'SHELL': '/bin/bash', 10:51:32 INFO - 'SHLVL': '1', 10:51:32 INFO - 'TERM': 'linux', 10:51:32 INFO - 'TMOUT': '86400', 10:51:32 INFO - 'USER': 'cltbld', 10:51:32 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1482432498.779553-1395043814', 10:51:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:32 INFO - '_': '/tools/buildbot/bin/python'} 10:51:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:32 INFO - Downloading/unpacking jsonschema==2.5.1 10:51:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:51:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:51:34 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 10:51:34 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 10:51:34 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 10:51:34 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 10:51:34 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 10:51:34 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 10:51:34 INFO - Downloading functools32-3.2.3-2.tar.gz 10:51:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:51:34 INFO - warning: no files found matching '*.txt' 10:51:34 INFO - no previously-included directories found matching 'build' 10:51:34 INFO - no previously-included directories found matching 'dist' 10:51:34 INFO - no previously-included directories found matching '.git*' 10:51:34 INFO - Installing collected packages: jsonschema, functools32 10:51:34 INFO - Running setup.py install for functools32 10:51:34 INFO - warning: no files found matching '*.txt' 10:51:34 INFO - no previously-included directories found matching 'build' 10:51:34 INFO - no previously-included directories found matching 'dist' 10:51:34 INFO - no previously-included directories found matching '.git*' 10:51:35 INFO - Successfully installed jsonschema functools32 10:51:35 INFO - Cleaning up... 10:51:35 INFO - Return code: 0 10:51:35 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:51:35 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')]} 10:51:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:35 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')]} 10:51:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:35 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 0x1b171f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c28a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e89480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e86820>, '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 0x1e87520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e879b0>, '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': 'ed14279e38b05397cf4aa391000001a4-1482432498.779553-1395043814', '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 10:51:35 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 10:51:35 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 10:51:35 INFO - Using env: {'DISPLAY': ':0', 10:51:35 INFO - 'HOME': '/home/cltbld', 10:51:35 INFO - 'LANG': 'en_US.UTF-8', 10:51:35 INFO - 'LANGUAGE': 'en_US:en', 10:51:35 INFO - 'LOGNAME': 'cltbld', 10:51:35 INFO - 'MAIL': '/var/mail/cltbld', 10:51:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:35 INFO - 'MOZ_NO_REMOTE': '1', 10:51:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:51:35 INFO - 'NO_EM_RESTART': '1', 10:51:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:51:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:51:35 INFO - 'PWD': '/builds/slave/test', 10:51:35 INFO - 'SHELL': '/bin/bash', 10:51:35 INFO - 'SHLVL': '1', 10:51:35 INFO - 'TERM': 'linux', 10:51:35 INFO - 'TMOUT': '86400', 10:51:35 INFO - 'USER': 'cltbld', 10:51:35 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1482432498.779553-1395043814', 10:51:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:35 INFO - '_': '/tools/buildbot/bin/python'} 10:51:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:35 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:51:35 INFO - Cleaning up... 10:51:35 INFO - Return code: 0 10:51:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:51:35 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')]} 10:51:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:35 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')]} 10:51:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:35 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 0x1b171f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c28a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e89480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e86820>, '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 0x1e87520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e879b0>, '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': 'ed14279e38b05397cf4aa391000001a4-1482432498.779553-1395043814', '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 10:51:35 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 10:51:35 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 10:51:35 INFO - Using env: {'DISPLAY': ':0', 10:51:35 INFO - 'HOME': '/home/cltbld', 10:51:35 INFO - 'LANG': 'en_US.UTF-8', 10:51:35 INFO - 'LANGUAGE': 'en_US:en', 10:51:35 INFO - 'LOGNAME': 'cltbld', 10:51:35 INFO - 'MAIL': '/var/mail/cltbld', 10:51:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:35 INFO - 'MOZ_NO_REMOTE': '1', 10:51:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:51:35 INFO - 'NO_EM_RESTART': '1', 10:51:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:51:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:51:35 INFO - 'PWD': '/builds/slave/test', 10:51:35 INFO - 'SHELL': '/bin/bash', 10:51:35 INFO - 'SHLVL': '1', 10:51:35 INFO - 'TERM': 'linux', 10:51:35 INFO - 'TMOUT': '86400', 10:51:35 INFO - 'USER': 'cltbld', 10:51:35 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1482432498.779553-1395043814', 10:51:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:35 INFO - '_': '/tools/buildbot/bin/python'} 10:51:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:35 INFO - Downloading/unpacking blobuploader==1.2.4 10:51:35 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 10:51:35 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 10:51:35 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 10:51:35 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 10:51:35 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 10:51:35 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 10:51:37 INFO - Downloading blobuploader-1.2.4.tar.gz 10:51:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:51:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:51:37 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 10:51:37 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 10:51:37 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 10:51:37 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 10:51:37 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 10:51:37 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 10:51:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:51:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:51:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:38 INFO - Downloading docopt-0.6.1.tar.gz 10:51:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:51:38 INFO - Installing collected packages: blobuploader, requests, docopt 10:51:38 INFO - Running setup.py install for blobuploader 10:51:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:51:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:51:38 INFO - Running setup.py install for requests 10:51:38 INFO - Running setup.py install for docopt 10:51:38 INFO - Successfully installed blobuploader requests docopt 10:51:38 INFO - Cleaning up... 10:51:38 INFO - Return code: 0 10:51:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:51:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:51:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:51:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:38 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 0x1b171f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c28a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e89480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e86820>, '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 0x1e87520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e879b0>, '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': 'ed14279e38b05397cf4aa391000001a4-1482432498.779553-1395043814', '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 10:51:38 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 10:51:38 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 10:51:38 INFO - Using env: {'DISPLAY': ':0', 10:51:38 INFO - 'HOME': '/home/cltbld', 10:51:38 INFO - 'LANG': 'en_US.UTF-8', 10:51:38 INFO - 'LANGUAGE': 'en_US:en', 10:51:38 INFO - 'LOGNAME': 'cltbld', 10:51:38 INFO - 'MAIL': '/var/mail/cltbld', 10:51:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:38 INFO - 'MOZ_NO_REMOTE': '1', 10:51:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:51:38 INFO - 'NO_EM_RESTART': '1', 10:51:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:51:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:51:38 INFO - 'PWD': '/builds/slave/test', 10:51:38 INFO - 'SHELL': '/bin/bash', 10:51:38 INFO - 'SHLVL': '1', 10:51:38 INFO - 'TERM': 'linux', 10:51:38 INFO - 'TMOUT': '86400', 10:51:38 INFO - 'USER': 'cltbld', 10:51:38 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1482432498.779553-1395043814', 10:51:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:38 INFO - '_': '/tools/buildbot/bin/python'} 10:51:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:51:39 INFO - Running setup.py (path:/tmp/pip-zd7RRV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:51:39 INFO - Running setup.py (path:/tmp/pip-BeNiri-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:51:39 INFO - Running setup.py (path:/tmp/pip-nEd9SK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:51:39 INFO - Running setup.py (path:/tmp/pip-4m8DmL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:51:39 INFO - Running setup.py (path:/tmp/pip-oOjwWM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:51:39 INFO - Running setup.py (path:/tmp/pip-WsO1lT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:51:39 INFO - Running setup.py (path:/tmp/pip-bqufSN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:51:39 INFO - Running setup.py (path:/tmp/pip-OEphGQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:51:39 INFO - Running setup.py (path:/tmp/pip-LD_hdV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:51:39 INFO - Running setup.py (path:/tmp/pip-jpnMj6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:51:39 INFO - Running setup.py (path:/tmp/pip-CXoxqy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:51:39 INFO - Running setup.py (path:/tmp/pip-rpKNbQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:51:40 INFO - Running setup.py (path:/tmp/pip-iAmplZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:51:40 INFO - Running setup.py (path:/tmp/pip-m0YzBh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:51:40 INFO - Running setup.py (path:/tmp/pip-Fac8Wi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:51:40 INFO - Running setup.py (path:/tmp/pip-3x7xJl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:51:40 INFO - Running setup.py (path:/tmp/pip-vI4u1a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:51:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:51:40 INFO - Running setup.py install for manifestparser 10:51:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:51:40 INFO - Running setup.py install for mozcrash 10:51:40 INFO - Running setup.py install for mozdebug 10:51:40 INFO - Running setup.py install for mozdevice 10:51:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:51:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:51:40 INFO - Running setup.py install for mozfile 10:51:40 INFO - Running setup.py install for mozhttpd 10:51:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:51:40 INFO - Running setup.py install for mozinfo 10:51:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:51:41 INFO - Running setup.py install for mozInstall 10:51:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:51:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:51:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:51:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:51:41 INFO - Running setup.py install for mozleak 10:51:41 INFO - Running setup.py install for mozlog 10:51:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:51:41 INFO - Running setup.py install for moznetwork 10:51:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:51:41 INFO - Running setup.py install for mozprocess 10:51:41 INFO - Running setup.py install for mozprofile 10:51:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:51:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:51:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:51:41 INFO - Running setup.py install for mozrunner 10:51:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:51:41 INFO - Running setup.py install for mozscreenshot 10:51:41 INFO - Running setup.py install for moztest 10:51:42 INFO - Running setup.py install for mozversion 10:51:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:51:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:51:42 INFO - Cleaning up... 10:51:42 INFO - Return code: 0 10:51:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:51:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:51:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:51:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:42 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 0x1b171f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c28a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e89480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e86820>, '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 0x1e87520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e879b0>, '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': 'ed14279e38b05397cf4aa391000001a4-1482432498.779553-1395043814', '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 10:51:42 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 10:51:42 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 10:51:42 INFO - Using env: {'DISPLAY': ':0', 10:51:42 INFO - 'HOME': '/home/cltbld', 10:51:42 INFO - 'LANG': 'en_US.UTF-8', 10:51:42 INFO - 'LANGUAGE': 'en_US:en', 10:51:42 INFO - 'LOGNAME': 'cltbld', 10:51:42 INFO - 'MAIL': '/var/mail/cltbld', 10:51:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:42 INFO - 'MOZ_NO_REMOTE': '1', 10:51:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:51:42 INFO - 'NO_EM_RESTART': '1', 10:51:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:51:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:51:42 INFO - 'PWD': '/builds/slave/test', 10:51:42 INFO - 'SHELL': '/bin/bash', 10:51:42 INFO - 'SHLVL': '1', 10:51:42 INFO - 'TERM': 'linux', 10:51:42 INFO - 'TMOUT': '86400', 10:51:42 INFO - 'USER': 'cltbld', 10:51:42 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1482432498.779553-1395043814', 10:51:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:42 INFO - '_': '/tools/buildbot/bin/python'} 10:51:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:51:42 INFO - Running setup.py (path:/tmp/pip-s6xjz7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:51:42 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)) 10:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:51:42 INFO - Running setup.py (path:/tmp/pip-9Owkjs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:51:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:51:42 INFO - Running setup.py (path:/tmp/pip-96YzFU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:51:42 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)) 10:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:51:42 INFO - Running setup.py (path:/tmp/pip-gi5Thh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:51:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:51:42 INFO - Running setup.py (path:/tmp/pip-wTPU6K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:51:42 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)) 10:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:51:42 INFO - Running setup.py (path:/tmp/pip-mKL4P5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:51:42 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)) 10:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:51:42 INFO - Running setup.py (path:/tmp/pip-E2e1sq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:51:42 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)) 10:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:51:42 INFO - Running setup.py (path:/tmp/pip-Rnhume-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:51:42 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)) 10:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:51:42 INFO - Running setup.py (path:/tmp/pip-KV2ydv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:51:43 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)) 10:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:51:43 INFO - Running setup.py (path:/tmp/pip-IWU_4q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:51:43 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)) 10:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:51:43 INFO - Running setup.py (path:/tmp/pip-UN9Bw2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:51:43 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)) 10:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:51:43 INFO - Running setup.py (path:/tmp/pip-8o1No9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:51:43 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)) 10:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:51:43 INFO - Running setup.py (path:/tmp/pip-kp2kLO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:51:43 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)) 10:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:51:43 INFO - Running setup.py (path:/tmp/pip-5QJnEH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:51:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:51:43 INFO - Running setup.py (path:/tmp/pip-ga7Pe6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:51:43 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)) 10:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:51:43 INFO - Running setup.py (path:/tmp/pip-73eRIW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:51:43 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)) 10:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:51:43 INFO - Running setup.py (path:/tmp/pip-LzB0oo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:51:43 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)) 10:51:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:51:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:51:43 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)) 10:51:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:51:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:51:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:51:43 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 10:51:43 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 10:51:43 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 10:51:43 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 10:51:43 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 10:51:43 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 10:51:45 INFO - Downloading blessings-1.6.tar.gz 10:51:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:51:45 INFO - Installing collected packages: blessings 10:51:45 INFO - Running setup.py install for blessings 10:51:45 INFO - Successfully installed blessings 10:51:45 INFO - Cleaning up... 10:51:45 INFO - Return code: 0 10:51:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:51:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:51:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:51:46 INFO - Reading from file tmpfile_stdout 10:51:46 INFO - Current package versions: 10:51:46 INFO - argparse == 1.2.1 10:51:46 INFO - blessings == 1.6 10:51:46 INFO - blobuploader == 1.2.4 10:51:46 INFO - docopt == 0.6.1 10:51:46 INFO - functools32 == 3.2.3-2 10:51:46 INFO - jsonschema == 2.5.1 10:51:46 INFO - manifestparser == 1.1 10:51:46 INFO - mozInstall == 1.12 10:51:46 INFO - mozcrash == 1.0 10:51:46 INFO - mozdebug == 0.1 10:51:46 INFO - mozdevice == 0.49 10:51:46 INFO - mozfile == 1.2 10:51:46 INFO - mozhttpd == 0.7 10:51:46 INFO - mozinfo == 0.9 10:51:46 INFO - mozleak == 0.1 10:51:46 INFO - mozlog == 3.4 10:51:46 INFO - moznetwork == 0.27 10:51:46 INFO - mozprocess == 0.23 10:51:46 INFO - mozprofile == 0.28 10:51:46 INFO - mozrunner == 6.13 10:51:46 INFO - mozscreenshot == 0.1 10:51:46 INFO - mozsystemmonitor == 0.3 10:51:46 INFO - moztest == 0.7 10:51:46 INFO - mozversion == 1.4 10:51:46 INFO - psutil == 3.1.1 10:51:46 INFO - requests == 1.2.3 10:51:46 INFO - wsgiref == 0.1.2 10:51:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:51:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:51:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:51:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:46 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 0x1b171f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c28a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e89480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e86820>, '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 0x1e87520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e879b0>, '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': 'ed14279e38b05397cf4aa391000001a4-1482432498.779553-1395043814', '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 10:51:46 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 10:51:46 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 10:51:46 INFO - Using env: {'DISPLAY': ':0', 10:51:46 INFO - 'HOME': '/home/cltbld', 10:51:46 INFO - 'LANG': 'en_US.UTF-8', 10:51:46 INFO - 'LANGUAGE': 'en_US:en', 10:51:46 INFO - 'LOGNAME': 'cltbld', 10:51:46 INFO - 'MAIL': '/var/mail/cltbld', 10:51:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:46 INFO - 'MOZ_NO_REMOTE': '1', 10:51:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:51:46 INFO - 'NO_EM_RESTART': '1', 10:51:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:51:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:51:46 INFO - 'PWD': '/builds/slave/test', 10:51:46 INFO - 'SHELL': '/bin/bash', 10:51:46 INFO - 'SHLVL': '1', 10:51:46 INFO - 'TERM': 'linux', 10:51:46 INFO - 'TMOUT': '86400', 10:51:46 INFO - 'USER': 'cltbld', 10:51:46 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1482432498.779553-1395043814', 10:51:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:46 INFO - '_': '/tools/buildbot/bin/python'} 10:51:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:46 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)) 10:51:46 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)) 10:51:46 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)) 10:51:46 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)) 10:51:46 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)) 10:51:46 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)) 10:51:46 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)) 10:51:46 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)) 10:51:46 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)) 10:51:46 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)) 10:51:46 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)) 10:51:46 INFO - Cleaning up... 10:51:46 INFO - Return code: 0 10:51:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:51:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:51:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:51:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b171f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c28a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e89480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e86820>, '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 0x1e87520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e879b0>, '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': 'ed14279e38b05397cf4aa391000001a4-1482432498.779553-1395043814', '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 10:51:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:51:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:51:46 INFO - Using env: {'DISPLAY': ':0', 10:51:46 INFO - 'HOME': '/home/cltbld', 10:51:46 INFO - 'LANG': 'en_US.UTF-8', 10:51:46 INFO - 'LANGUAGE': 'en_US:en', 10:51:46 INFO - 'LOGNAME': 'cltbld', 10:51:46 INFO - 'MAIL': '/var/mail/cltbld', 10:51:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:46 INFO - 'MOZ_NO_REMOTE': '1', 10:51:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:51:46 INFO - 'NO_EM_RESTART': '1', 10:51:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:51:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:51:46 INFO - 'PWD': '/builds/slave/test', 10:51:46 INFO - 'SHELL': '/bin/bash', 10:51:46 INFO - 'SHLVL': '1', 10:51:46 INFO - 'TERM': 'linux', 10:51:46 INFO - 'TMOUT': '86400', 10:51:46 INFO - 'USER': 'cltbld', 10:51:46 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1482432498.779553-1395043814', 10:51:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:46 INFO - '_': '/tools/buildbot/bin/python'} 10:51:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:51:46 INFO - Cleaning up... 10:51:46 INFO - Return code: 0 10:51:46 INFO - Running post-action listener: _resource_record_post_action 10:51:46 INFO - Running post-action listener: _start_resource_monitoring 10:51:46 INFO - Starting resource monitoring. 10:51:46 INFO - [mozharness: 2016-12-22 18:51:46.589500Z] Finished create-virtualenv step (success) 10:51:46 INFO - [mozharness: 2016-12-22 18:51:46.590027Z] Running install step. 10:51:46 INFO - Running pre-action listener: _resource_record_pre_action 10:51:46 INFO - Running main action method: install 10:51:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:51:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:51:46 INFO - Reading from file tmpfile_stdout 10:51:46 INFO - Detecting whether we're running mozinstall >=1.0... 10:51:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:51:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:51:46 INFO - Reading from file tmpfile_stdout 10:51:46 INFO - Output received: 10:51:46 INFO - Usage: mozinstall [options] installer 10:51:46 INFO - Options: 10:51:46 INFO - -h, --help show this help message and exit 10:51:46 INFO - -d DEST, --destination=DEST 10:51:46 INFO - Directory to install application into. [default: 10:51:46 INFO - "/builds/slave/test"] 10:51:46 INFO - --app=APP Application being installed. [default: firefox] 10:51:46 INFO - mkdir: /builds/slave/test/build/application 10:51:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:51:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 10:52:04 INFO - Reading from file tmpfile_stdout 10:52:04 INFO - Output received: 10:52:04 INFO - /builds/slave/test/build/application/firefox/firefox 10:52:04 INFO - Running post-action listener: _resource_record_post_action 10:52:04 INFO - [mozharness: 2016-12-22 18:52:04.562300Z] Finished install step (success) 10:52:04 INFO - [mozharness: 2016-12-22 18:52:04.562547Z] Running run-tests step. 10:52:04 INFO - Running pre-action listener: _resource_record_pre_action 10:52:04 INFO - Running main action method: run_tests 10:52:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:52:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:52:04 INFO - Python 2.7.3 10:52:04 INFO - Return code: 0 10:52:04 INFO - grabbing minidump binary from tooltool 10:52:04 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')]} 10:52:04 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 0x1e86820>, '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 0x1e87520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e879b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:52:04 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 10:52:04 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 10:52:04 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 10:52:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:52:04 INFO - Return code: 0 10:52:04 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:52:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:52:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:52:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:52:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:52:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/U0aFhKocQV6ucuMXkQT56A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 10:52:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/U0aFhKocQV6ucuMXkQT56A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-035 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 10:52:04 INFO - Using env: {'DISPLAY': ':0', 10:52:04 INFO - 'HOME': '/home/cltbld', 10:52:04 INFO - 'LANG': 'en_US.UTF-8', 10:52:04 INFO - 'LANGUAGE': 'en_US:en', 10:52:04 INFO - 'LOGNAME': 'cltbld', 10:52:04 INFO - 'MAIL': '/var/mail/cltbld', 10:52:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:52:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:52:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:04 INFO - 'MOZ_NO_REMOTE': '1', 10:52:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:52:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:52:04 INFO - 'NO_EM_RESTART': '1', 10:52:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:52:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:04 INFO - 'PWD': '/builds/slave/test', 10:52:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:52:04 INFO - 'SHELL': '/bin/bash', 10:52:04 INFO - 'SHLVL': '1', 10:52:04 INFO - 'TERM': 'linux', 10:52:04 INFO - 'TMOUT': '86400', 10:52:04 INFO - 'USER': 'cltbld', 10:52:04 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1482432498.779553-1395043814', 10:52:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:04 INFO - '_': '/tools/buildbot/bin/python'} 10:52:04 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/U0aFhKocQV6ucuMXkQT56A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 10:52:04 INFO - mozversion application_buildid: 20161222091543 10:52:04 INFO - mozversion application_changeset: 4103e1b2f12cc7e76477f6f78f1102abb21beb5a 10:52:04 INFO - mozversion application_display_name: Nightly 10:52:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:52:04 INFO - mozversion application_name: Firefox 10:52:04 INFO - mozversion application_remotingname: firefox 10:52:04 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 10:52:04 INFO - mozversion application_vendor: Mozilla 10:52:04 INFO - mozversion application_version: 53.0a1 10:52:04 INFO - mozversion platform_buildid: 20161222091543 10:52:04 INFO - mozversion platform_changeset: 4103e1b2f12cc7e76477f6f78f1102abb21beb5a 10:52:04 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 10:52:04 INFO - mozversion platform_version: 53.0a1 10:52:04 INFO - using testdate: 1482432724 10:52:04 INFO - actual date: 1482432724 10:52:04 INFO - starting webserver on 'localhost:43451' 10:52:04 INFO - SUITE-START | Running 2 tests 10:52:04 INFO - TEST-START | dromaeo_css 10:52:04 INFO - operating with platform_type : linux_ 10:52:04 INFO - Initialising browser for dromaeo_css test... 10:52:04 INFO - TEST-INFO | started process 18957 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpS2rZIK/profile http://localhost:43451/getInfo.html) 10:52:05 INFO - PROCESS | 18957 | 1482432725309 addons.xpi WARN Exception running bootstrap method install on shield-recipe-client@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getBoolPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js :: this.install :: line 38" data: no] Stack trace: this.install()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:38 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4979 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2097 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3825 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2829 < callProvider()@resource://gre/modules/AddonManager.jsm:264 < _startProvider()@resource://gre/modules/AddonManager.jsm:771 < startup()@resource://gre/modules/AddonManager.jsm:957 < startup()@resource://gre/modules/AddonManager.jsm:2923 < observe()@resource://gre/components/addonManager.js:65 10:52:08 INFO - PROCESS | 18957 | __metrics Screen width/height:1600/1200 10:52:08 INFO - PROCESS | 18957 | colorDepth:24 10:52:08 INFO - PROCESS | 18957 | Browser inner width/height: 1024/697 10:52:08 INFO - PROCESS | 18957 | __metrics 10:52:09 ERROR - PROCESS | 18957 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3247: TypeError: this.tabs is undefined 10:52:10 INFO - TEST-INFO | 18957: exit 0 10:52:10 INFO - Browser initialized. 10:52:10 INFO - Running cycle 1/1 for dromaeo_css test... 10:52:10 INFO - TEST-INFO | started process 19077 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpS2rZIK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:52:21 INFO - PROCESS | 19077 | RSS: Main: 154873856 10:52:21 INFO - PROCESS | 19077 | 10:53:11 INFO - PROCESS | 19077 | 1482432791551 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] 10:55:21 INFO - PROCESS | 19077 | Cycle 1(1): loaded http://localhost:43451/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43451/tests/dromaeo/cssquery-ext.html) 10:55:23 INFO - PROCESS | 19077 | RSS: Main: 162263040 10:55:23 INFO - PROCESS | 19077 | 10:57:10 INFO - PROCESS | 19077 | ************************* 10:57:10 INFO - PROCESS | 19077 | A coding exception was thrown and uncaught in a Task. 10:57:10 INFO - PROCESS | 19077 | 10:57:10 INFO - PROCESS | 19077 | Full message: ReferenceError: fetch is not defined 10:57:10 INFO - PROCESS | 19077 | Full stack: apiCall@resource://shield-recipe-client/lib/NormandyApi.jsm:37:5 10:57:10 INFO - PROCESS | 19077 | get@resource://shield-recipe-client/lib/NormandyApi.jsm:44:12 10:57:10 INFO - PROCESS | 19077 | this.NormandyApi.fetchRecipes<@resource://shield-recipe-client/lib/NormandyApi.jsm:52:34 10:57:10 INFO - PROCESS | 19077 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 10:57:10 INFO - PROCESS | 19077 | TaskImpl@resource://gre/modules/Task.jsm:277:3 10:57:10 INFO - PROCESS | 19077 | asyncFunction@resource://gre/modules/Task.jsm:252:14 10:57:10 INFO - PROCESS | 19077 | this.RecipeRunner.start<@resource://shield-recipe-client/lib/RecipeRunner.jsm:64:23 10:57:10 INFO - PROCESS | 19077 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 10:57:10 INFO - PROCESS | 19077 | TaskImpl@resource://gre/modules/Task.jsm:277:3 10:57:10 INFO - PROCESS | 19077 | asyncFunction@resource://gre/modules/Task.jsm:252:14 10:57:10 INFO - PROCESS | 19077 | setTimeout_timer@resource://gre/modules/Timer.jsm:30:5 10:57:10 INFO - PROCESS | 19077 | 10:57:10 INFO - PROCESS | 19077 | ************************* 10:58:25 INFO - PROCESS | 19077 | Cycle 1(1): loaded http://localhost:43451/tests/dromaeo/cssquery-ext.html (next: http://localhost:43451/tests/dromaeo/cssquery-jquery.html) 10:58:26 INFO - PROCESS | 19077 | RSS: Main: 160051200 10:58:26 INFO - PROCESS | 19077 | 11:01:27 INFO - PROCESS | 19077 | Cycle 1(1): loaded http://localhost:43451/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43451/tests/dromaeo/cssquery-mootools.html) 11:01:28 INFO - PROCESS | 19077 | RSS: Main: 165101568 11:01:28 INFO - PROCESS | 19077 | 11:04:30 INFO - PROCESS | 19077 | Cycle 1(1): loaded http://localhost:43451/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43451/tests/dromaeo/cssquery-prototype.html) 11:04:31 INFO - PROCESS | 19077 | RSS: Main: 160550912 11:04:31 INFO - PROCESS | 19077 | 11:07:33 INFO - PROCESS | 19077 | Cycle 1(1): loaded http://localhost:43451/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43451/tests/dromaeo/cssquery-yui.html) 11:07:34 INFO - PROCESS | 19077 | RSS: Main: 163741696 11:07:34 INFO - PROCESS | 19077 | 11:10:37 INFO - PROCESS | 19077 | Cycle 1(1): loaded http://localhost:43451/tests/dromaeo/cssquery-yui.html (next: http://localhost:43451/tests/dromaeo/cssquery-dojo.html) 11:10:37 INFO - PROCESS | 19077 | RSS: Main: 164122624 11:10:37 INFO - PROCESS | 19077 | 11:10:37 INFO - PROCESS | 19077 | __start_tp_report 11:10:37 INFO - PROCESS | 19077 | _x_x_mozilla_page_load 11:10:37 INFO - PROCESS | 19077 | _x_x_mozilla_page_load_details 11:10:37 INFO - PROCESS | 19077 | |i|pagename|runs| 11:10:37 INFO - PROCESS | 19077 | |0;dojo.html;3188.378266238082;3197.6642452542483;3205.150635081704;3210.0851257391632;3239.951400728988;5257.00116977774;5340.679559226449;5357.892842143155;5390.703511306877;5398.865028374293;5342.519173274404;5342.973285133578;5427.023135835548;5435.157550579656;5468.644538105021;4804.567588916997;4836.6856154350035;4870.512948705136;4965.726885021322;4978.900421991558;4881;4979.701217926936;5017.122003649365;5021.497850214968;5058.190689489682;4743.407074115736;4944.406671199479;4996.500349964993;5032.521910418541;5047.697138171721;4773.928391074137;4825.059113472874;4909.779059942275;4924.729139897304;5006.5744411725045;4905.4358748744;4905.583025442842;4918.311436398907;4934.629902757308;4951.950480495185;5393.379761327458;5406.378266499363;5420.13277875542;5421.647592906488;5428.240046393508;5550.833474995757;5582.441755824426;5696.088625819849;5737.311522617271;5740.54075673945;5814.941850581525;5830.7667693292215;5832.358440571534;5836.824895253149;5888.852778680567;5385.219143224211;5390.703511306877;5391.487808658171;5394.460553944653;5424.647397919122;5705.942940570541;5782.6819524925695;5882.823515294548;5894.498967587803;5935.406459354116;5754.712264386764;5760.769569217185;5763.077907534775;5786.537077033827;5815.127730840323;5798.5071268941765;5808.7095645218415;5861;5868.2664666916635;5869.941300586939;5591.608587398924;5647.548196144381;5744.827655170351;5804.854878627983;5810.389909059572;5801.564882633819;5844.912326315109;5854.619449735754;5861.296644402699;5898.498627616701;4360.302351623725;4361.738295702268;4369.300911854088;4373.103513779667;4408.074304396048;3817.2556351511744;3824.7896365700153;3832.9233415331537;3853.3064048470983;3907.531096268466;5498.477644623755;5558.360788509373;5594.300712410949;5643.097104463266;5655.264815573949;5808.448197421239;5821.650700957956;5828.504577110908;5828.94171058284;5859.912101318484;5402.540784033401;5439.156930675752;5497.5601951843755;5578.051731205624;5579.246801681802;4775.6657034007285;4776.5701086902345;4787.688800227974;4856.39295088114;4866.245731911559;6063.090536419572;6085.361037091042;6102.664353460514;6111.022236442148;6128.540359472968;5666.518345940476;5729.914051289151;5838.5621078418435;5840.065589505659;5844.47399734026;6016.548758843017;6064.757409703739;6064.787732429344;6101.51991978472;6117.766507567632;5708.400617935057;5723.227364305765;5735.254416925773;5761.654300741969;5783.826485205451;5616.971915140398;5871.941280587311;5886.381929897299;5887.116932460165;5890.14592884038;5486.341639003345;5639;5648.689322087161;5681.971590142023;5737.254156959569;5667.631603945731;5710.486056254957;5713.257276554022;5717.599768016199;5719.227904233042;5556.583256255716;5561.721913904369;5652.660840349592;5702.97346477638;5718.399568045462;5631.7184140793615;5719.342275638355;5731.312242530923;5773.769049237983;5809.302883653989;5571.331440227199;5610.382857885547;5618.381977982501;5620.718964051863;5622.718864056863 11:10:37 INFO - PROCESS | 19077 | |1;ext.html;526.3131613244715;547.1164070026907;548.0764911124753;589.1869220475743;593.5251798561153;39136.60863391365;42111.78944105283;42286.15427691448;45666.543334566646;45749.7712511437;45587.77206113965;45741.313880291826;45869;45878.77060614701;46192;8986.595603197838;9177.082291770836;9192.080791920787;9200.125988031126;10268.229882758786;10243.180545556375;10550.15598752098;10562.524686389132;10582.259241853073;10629.468526573679;10560.524776385042;10674.146068314516;10707.571697132105;10718.946405268001;10732.302400343953;10479.371237725762;10571.471426428649;10576.418296993663;10646.733831654194;10646.999999999962;10395.064444199983;10409.635662751767;10429.374237545771;10480.371177729361;10512.106470949979;37815.81092094549;38100.80949595262;38259.42610860839;38304.80847595772;38492;3418.6923176913947;3444.8622055117767;3449.862005519776;3602.2975519773654;3617.6382361763876;28918.42163156725;29598.556021659693;29620.555691664642;29741.256468588243;30354;4057.3508238681966;4092.202020605983;4132.5454200037975;4195.643370313527;4230.894227644303;345225;345786;348410;348838;351747;53838.46161538413;54270;54440.45559544354;54477;54561.45438545643;54678.72660636671;54853.257337132985;54947.72526137344;55070.72464637731;55447.168292475646;14887.404503819726;15277.083374997314;15342.769858452131;15353.385864565516;15362.385504579916;11414.88585114155;11668.824967625322;11688.240264382788;12237.082218833444;12241.755164896831;17003;17116.315347386215;17139.22873470697;17222.311107555808;17271.65456690859;6656.30108838565;6725.764598239136;6867.313268673092;6983.406410455168;6991.8601627967155;912.7900582865979;1045.9581616735245;1058.5924419098703;1076.1122074288744;1120.6694025262568;31487.37025259482;32077;32466.837665811992;32646;32814.34371312561;1088.5250485592067;1100.9889901101046;1137.0505627800715;1155.0470861539263;1175.1773758369177;16391;16822.579435513966;16946.152692365333;17002.829971700125;17046.46581807643;541276;544479;545101;547484;548487;60307.396926030175;61178.38821611816;61579;61612;62006.37993620006;1358.4701966233176;1377.538524594272;1382.67507135823;1394.8256467941508;1405.0866936491364;30252.54621180728;31309.686903131587;31714.365712686078;31820.204494887814;32158;52454;52812.735936320074;52837.735811320694;52877.735611321696;53001.734991324796;400680;407254;407637;408502;408716;25255.36861578475;25817.354566135247;26230.4753904917;27158.456830863666;27791.86104069467;42371.364429532965;42559.787201063795;42887.4968128342;43063.56936430596;43198.568014320714;35862.64137358697;35914;35933.281334372645;36047.81976090103;36124.91625251247;35912.84522928633;35980.820095899355;36132.27735445329;36183.63816361908;36244.27511449809;35696.28607427889;36294.27411451704;36846.26307473889;37003.62996370002;37036.81481592575;32219.677803221668;34330.65669343275;34441.655583444845;34482.82758586291;34596.82701586476;25375.36561585975;25566.10518631839;25625.615615765404;25954.740452595233;26271 11:10:37 INFO - PROCESS | 19077 | |2;jquery.html;377.5469436675986;382.86216961893695;402.30200601955613;405.74235360546055;419.99370009449865;16657.750133748003;16909.323627054902;17852.28590856366;19250.807491925076;19386.127624256926;11204.15968802339;11743.29540227587;11835.230710003843;11876.28742275464;12178.208416452946;5257.421683614809;5434.8913021739545;5438.320209973754;5444.265024221739;5445.292112025431;5178.326817513718;5291.28567643367;5336.6531175473665;5341.03861304965;5382.703951282678;5302.151655735083;5303.602229832759;5307.708076055816;5323.574114070865;5331.57347412208;5323.414424413311;5343.305370301855;5553.694546799924;5785.53715702747;5824.213731146283;5746.25298711169;5760.6255593386295;5767.2409914975915;5772.220750198753;5776.566757493205;13678.384472698654;13714;13834.377453014538;13843.377048032862;13861.792073118912;2178.346496051194;2234.821214302852;2400.951980960371;2471.888765005579;2788;10150.137238334677;10721.035106840422;10775.83836242457;12744.553940612033;14217.146971181659;1938.311899275765;1989.9403017909342;2030.9390718278476;2045.887476188809;2054.9486262843398;77142.61428692877;79474;79992;82156.17843821605;82816.17183828205;9244;9714.174295184846;9733.367331123454;9768.169705575106;11061.170412219115;13090.738185236241;13134;13214.537491187762;13245.602631921058;13255.536056237985;7235.7467488638695;7449.180590135081;7634.4655874088285;7657.387409007266;7676.884846727304;7205.89191162133;7222.638868056576;7228.096487939008;7401.888971665429;7496.662650180755;4014.6186112319283;4030.7581545107387;4042;4115.814788334532;4168.499780026416;1979.2478858033855;1979.416072258687;1984.583237520137;2002.8097330753556;2037.7045328427296;455.5649354866095;844.4089137603702;966.8549717542285;984.6652138273022;1012.8379459286479;11091.72270693223;11785.233959792757;11908.404579770977;11932.761344773056;12212.877871221352;461.50157829544685;463.5109958993227;471.4695967037083;478.1990166471147;482.2693619166965;6256.874862502725;6260.968695156495;6367.395097465734;6415.1981002374705;6677.332266773284;350410;356722;435358;439402;440962;86375;88202;90199;90416.54791725999;92021.53989230144;1038.813013657549;1045.2160879340495;1088.0588291128117;1090.8581884354983;1094.715374002765;17494.650106997535;17648.382306619205;18101.547461313574;18152.27390904349;18152.72770908464;39280.41079383869;40624.59375406208;40764.592354077264;40828.59171408248;42422.93942651335;54071.72964135154;54914.760250728374;55015;55560.9436631678;56530;8470;8556.646922096224;8568.443051201652;8597.26923211534;8683.261922736638;12698.174618649758;12760.808587871004;13155.473781049033;13177.736445271232;13286.734265314833;11026.44867756625;11317.151213658844;11454.599089031844;11600.361980090838;11660.708482288012;11137.83293250618;11215.66353009411;11303;11529;11757.412129393668;10891.183161263096;11397.487113079766;11752.823707644222;11907.583234587095;12477.688057798629;8188.590570471333;8229.753107406787;8272.37957153228;8422.020825105972;8769.473831570127;10026.298159128792;10904.400257985886;11299.774004519699;11412.714682133013;11967.940160299142 11:10:37 INFO - PROCESS | 19077 | |3;mootools.html;1463.04901813821;1464.7290251303507;1624.4801663467688;1771.3446024970763;1791.9731204031941;7387.926120738791;7504.549727016383;8015.198480151989;8478.788030299245;8529.744107676765;7806.960965195166;8065.233802788725;8081.959590202056;8171.877421838677;8224.753257402288;2301.436148143703;2351.7530659280787;2354.4702441950594;2356.858588484688;2357.033616217351;2323.384303159664;2363.161077817376;2372.54921564903;2373.193114341124;2379.2148590965026;2346.0146738369926;2364.47981444082;2370.727366352866;2389.259329607827;2398.1486572266854;2241.2491815241915;2258.1870526610405;2275.112706044644;2285.5086156476355;2298.9195378161853;2287.5310561334886;2307.273208939179;2312.90748370065;2315.455867871049;2315.80315673168;8191.672333106669;8242.505449673039;8275.710350137717;8359.373047021438;8400.41197116202;4877.219644856841;4993.650444468889;5003.949960500385;5004.949950500485;5007.524285192901;3293.440115180425;3392.2197894484407;3484.163800687842;3547.9290414191573;3556.8043757593323;990.8365119755232;1018.7249442650443;1048.7849990751877;1054.3673795722505;1063.0538820449729;11103.44482775866;11180.273282236629;11206.215564910459;11214.887851121384;11233.550657973672;4325.610695037399;4513.864584062483;4524.932126018112;4673.434399476146;4679.9532004680195;9461.810763784824;9532.475713835805;9532.952335238419;9539.046095390406;9576.521173941275;5148.073346797612;5161.27742116104;5163.561097306696;5173.508516690908;5175.171972484384;4638.1187574360765;4757.928631070467;4786.0667169901535;4881.658283920163;4884;3540;3685.1892583631557;3731.850725970931;3736.3274610569815;3805.961940380616;1173.096715529038;1174.5477990973366;1177.3465726521692;1180.8110702287593;1187.804012337972;771.9498232614974;972.8297547929084;976.62888102522;982.3565564555228;993.4436715439377;5496.31296087989;5507.0637991541535;5583.609147359727;5623;5799.971000144972;424.74303046656325;426.903946612016;431.24962565137065;441.0759458933529;444.0430871471983;3746.4193050077283;3778.8299526521373;3838.7696738195796;3871.070942973666;3920.627540383659;9657.565409556586;10048.547815348327;10146.44194569291;10186.337888037255;10243.795124097476;9500.95249523748;10122.291439599157;10131.949340253252;10155.46113471632;10156.4921753912;7431.108267007886;7718;7769.53382797034;7774.2614451627005;7788.766337009899;5287;5443.727813609383;5519.972400137974;5616.85957851057;5636.070048441961;8938.910610894069;9148;9217.400868943498;9223.815523689624;9313;9113.726588202364;9266.258699304175;9279.304052196247;9433.669821556212;9453.810923781348;7031.718731250898;7168.211496735251;7282.162551306667;7296.562206267428;7329.973803667384;8022.478538894953;8076.27313541784;8084.231997960184;8084.231997960184;8087.393445491729;7096.189377015343;7169.318914703095;7276.927230727837;7288.416926645961;7451.217622149813;6937.514373993772;6946.16646002483;6966.094407726963;7033.507654464139;7181.317774811385;6308.936910630835;6405;6440;6440.227172739301;6453.257875344396;4755.38180036593;4785.210440277316;4812.085703716282;4833.73414462208;4846.127697014571;4923.901521969469;4953.083679519301;4990.627577416094;5030.346055012825;5068.873278167928 11:10:37 INFO - PROCESS | 19077 | |4;prototype.html;384.3351002765216;399.1757021750086;401.2516656435747;409.43799405268913;411.89084892503473;5125.5653564556815;5272.288241087462;5296.788128474861;5328.653637513564;5383.434739352366;5160.961420239003;5264.368275806899;5317.415084340729;5325.467453254682;5365.919511207335;4261.2329780639475;4280.715785264409;4283.978580107103;4285.250081235771;4304.698671093025;3943.284671168051;4153.480814898137;4246.554111818261;4262;4275.935860962088;4128.380742888561;4137.9172416551655;4146.523149837777;4152.958470415302;4156.293430116887;4117.855875044374;4124.278251306025;4126.834926602933;4129.876103716893;4154.335306350969;3700.185959089023;3716.201016781405;3719.479272901796;3722.822149042813;3731.7574357666663;5042;5143;5147.459516750762;5148.4851514848215;5168.173092305213;4772.308015337791;4780.713157210544;4790.4969978152485;4798.952010479886;4829.275608658694;5410.810621628224;5538.0031594313;5550.222968784374;5553.389127196006;5561;3954.6440820326306;3992.6207010333974;4012.3981402789814;4017.734413659688;4030.234255491447;5706.686132262724;5736.512396446307;5764;5780.132980053026;5786.913196302059;4096.365063415175;4108.767369789051;4119.155573107506;4119.485064366954;4121.814518346621;3908.3160446921675;4112.773797441169;4153.771542565128;4164.7709375984;4184.895377615584;4705.1765940960195;4711.340412342275;4723.197056500403;4741.909360846956;4797.304390863305;5549.113301477436;5585.245991791056;5589.301337332833;5612.97193514038;5613.635113717595;1365.49476693624;1367.787992861108;1372.6842826150041;1386.535510603959;1387.6253411579019;943.9280778690708;957.368137029571;967.5404183013012;972.9464879431557;975.2198241406846;5258.158694608845;5260.842174734764;5264.736763161826;5328.893422131536;5331.680099193984;5433.320834895638;5536.75084621193;5554.3614633682355;5569.303837020372;5590;5099.36257967754;5175.896482070338;5258.684478931276;5321.920171197435;5500.669959802424;2930.2088436122126;2948.9262768430963;2960.6743258241577;2967.4955257606257;2982.209714425679;5847.573257098342;5852.648841069549;5862.570396318117;5898.528117750569;5924.407559244041;5470.234167216593;5666.631668941505;5685.232493613309;5687.40282270364;5705.286839145107;5811;5856;5872.94127058741;5882.588218824641;5894.823155305347;5342.75957581902;5503;5599.1724179289195;5646.9152962704775;5689.459501347365;5459.781608735765;5494.890102198014;5504.311961004874;5518.944810551843;5541.695206763667;5828.76684932598;5857.619254748428;5858.543459358828;5886.115803256459;5898.911516327173;3910.5698373178357;3950.585188555275;3990.86031988879;4007.3187558115774;4010.1779135276615;5578.497935185853;5600.971995139998;5610.859728506657;5619.218486849036;5622.297212848394;5636.802711905064;5643.915341269966;5658.377578466448;5666.433356664301;5671.602987790815;5618;5637.3235211774845;5643.3510146332055;5649.977262164723;5652.971735141298;5510.6969116698965;5612.045952188057;5617.859553511195;5619.887602247851;5666.34836993751;5642.379338272704;5656.490915817596;5660.632058916157;5662.575306852085;5676.262085928968;5343.465653434625;5491.313585801775;5509.614326997072;5512.200730894078;5517.034518959246 11:10:37 INFO - PROCESS | 19077 | |5;yui.html;731.8024133483958;742.6546655805051;743.4164181117824;760.0765070439415;836.5900708652762;15000.774988375184;15812.44656437025;16376.263068161932;16445.588860278498;16899.57751056224;15385.846141538581;15538.300776465057;15612.765808512853;15614.141222232773;15627.453039143633;777.0675189772296;806.8789681547756;810.6919370639149;822.0628483528782;822.5393779483509;798.8162722573811;802.8273921106961;803.3131672420085;811.6509900742678;814.6537721468382;882.3382463152635;883.0551310098198;885.1900511032397;886.6231851463135;888.404768804899;871.6382701179003;872.8036191856845;878.5870640798814;879.8284334554764;880.0451510111504;638.1512588257606;640.8718256348702;642.3961476212345;643.8326035230874;645.6255371884296;15113.54659360221;15195.544133676007;15251;16168.353265869351;16329.18354082303;14071.859281407158;14245.358958846877;14527.418903243857;14612.70774584513;14621.6344591385;11912.583059592873;12140;12214.511419543296;12228.816567751492;12303.261804291682;3718.3492888744363;3721.832517536717;3740.4950331705145;3811.2187001664593;3818.9045273868096;63976.36023639751;79809.60095199545;80295.19704802935;82078.58960705159;82200.58899705463;9929.553170107363;10006.749831254278;10011.79976400468;10171.135453486537;10258.333208341433;18540.536486587942;18557.814421855608;18861.905690471733;18975.71536426955;19235.711464328047;7914.802129946682;8134.796630084177;8204.179582041868;8268.669253229924;8508.361872859561;4475.1049790042125;4475.70907890986;4583.427071616048;4610.76946152691;4615;3631.1829838286176;3720.6279372062577;3726.5155529780955;3727.5154229950476;3732.8506859725308;602.5179856115178;627.6359711367396;640.5900223856736;647.582309410437;654.4273760459598;600.3126420248791;642.7300533775825;684.5858255755196;703.6165289917008;735.6170399648627;8910.55447227636;9503.192228660502;9632.72487354303;9815.558299876522;10001.549930253155;561.750021240544;621.0994058615026;621.8227805075531;644.8420137066355;716.6667499612705;4504.864854054384;4571;4597.103564804831;4597.678162528591;4655.301704744315;79881.60059199783;80418.59790701009;84492.15507844966;85245.57377213199;89381;71760.64119679369;74113.62943185249;74620;76599;77904.22095779084;65428;65563.67218163879;65966.34033659699;67628.98556521656;68891.31108689049;8365.539895305817;8389.454685445426;8393.24460798531;8434.662613495637;8600.39797214214;43551.78224108859;44499.33251001173;44524.55475445204;45236.32145517754;45309.54690453185;51303.486965131364;56292;61087;61501.69249153905;61972.38027619846;13041.543545975845;13643.79534307006;13687.11033782801;13994.230317332644;14020;14390.352434140279;15727.260918655926;16036.518904432885;16162.838371616133;16212.675746484769;14167.504137355143;14432.567022989328;14725.190114543375;14932.925335373688;15139.318730657367;13968.30158492051;14285.500007499688;14490.565283041526;14759.852401475848;14873.107613543221;14545.490907818175;14898.553043408716;14972.625684357978;15216;15905.284262207997;10791.56833726642;11118.722031949266;11202.607908723156;11247.943760281147;11819.704507387383;11740.295582265091;11854.123075540141;12006.63980080599;12294.631161065183;12295.815562766387 11:10:37 INFO - PROCESS | 19077 | __end_tp_report 11:10:37 INFO - PROCESS | 19077 | __start_cc_report 11:10:37 INFO - PROCESS | 19077 | _x_x_mozilla_cycle_collect,323 11:10:37 INFO - PROCESS | 19077 | __end_cc_report 11:10:37 INFO - PROCESS | 19077 | __startTimestamp1482433837324__endTimestamp 11:10:37 INFO - PROCESS | 19077 | 11:10:37 INFO - PROCESS | 19077 | ------- Summary: start ------- 11:10:37 INFO - PROCESS | 19077 | Number of tests: 6 11:10:37 INFO - PROCESS | 19077 | 11:10:37 INFO - PROCESS | 19077 | [#0] dojo.html Cycles:165 Average:5386.55 Median:5618.38 stddev:627.37 (11.2%) stddev-sans-first:605.13 11:10:37 INFO - PROCESS | 19077 | Values: 3188.4 3197.7 3205.2 3210.1 3240.0 5257.0 5340.7 5357.9 5390.7 5398.9 5342.5 5343.0 5427.0 5435.2 5468.6 4804.6 4836.7 4870.5 4965.7 4978.9 4881.0 4979.7 5017.1 5021.5 5058.2 4743.4 4944.4 4996.5 5032.5 5047.7 4773.9 4825.1 4909.8 4924.7 5006.6 4905.4 4905.6 4918.3 4934.6 4952.0 5393.4 5406.4 5420.1 5421.6 5428.2 5550.8 5582.4 5696.1 5737.3 5740.5 5814.9 5830.8 5832.4 5836.8 5888.9 5385.2 5390.7 5391.5 5394.5 5424.6 5705.9 5782.7 5882.8 5894.5 5935.4 5754.7 5760.8 5763.1 5786.5 5815.1 5798.5 5808.7 5861.0 5868.3 5869.9 5591.6 5647.5 5744.8 5804.9 5810.4 5801.6 5844.9 5854.6 5861.3 5898.5 4360.3 4361.7 4369.3 4373.1 4408.1 3817.3 3824.8 3832.9 3853.3 3907.5 5498.5 5558.4 5594.3 5643.1 5655.3 5808.4 5821.7 5828.5 5828.9 5859.9 5402.5 5439.2 5497.6 5578.1 5579.2 4775.7 4776.6 4787.7 4856.4 4866.2 6063.1 6085.4 6102.7 6111.0 6128.5 5666.5 5729.9 5838.6 5840.1 5844.5 6016.5 6064.8 6064.8 6101.5 6117.8 5708.4 5723.2 5735.3 5761.7 5783.8 5617.0 5871.9 5886.4 5887.1 5890.1 5486.3 5639.0 5648.7 5682.0 5737.3 5667.6 5710.5 5713.3 5717.6 5719.2 5556.6 5561.7 5652.7 5703.0 5718.4 5631.7 5719.3 5731.3 5773.8 5809.3 5571.3 5610.4 5618.4 5620.7 5622.7 11:10:37 INFO - PROCESS | 19077 | 11:10:37 INFO - PROCESS | 19077 | [#1] ext.html Cycles:180 Average:58688.26 Median:348624.00 stddev:117057.98 (33.6%) stddev-sans-first:117304.90 11:10:37 INFO - PROCESS | 19077 | Values: 526.3 547.1 548.1 589.2 593.5 39136.6 42111.8 42286.2 45666.5 45749.8 45587.8 45741.3 45869.0 45878.8 46192.0 8986.6 9177.1 9192.1 9200.1 10268.2 10243.2 10550.2 10562.5 10582.3 10629.5 10560.5 10674.1 10707.6 10718.9 10732.3 10479.4 10571.5 10576.4 10646.7 10647.0 10395.1 10409.6 10429.4 10480.4 10512.1 37815.8 38100.8 38259.4 38304.8 38492.0 3418.7 3444.9 3449.9 3602.3 3617.6 28918.4 29598.6 29620.6 29741.3 30354.0 4057.4 4092.2 4132.5 4195.6 4230.9 345225.0 345786.0 348410.0 348838.0 351747.0 53838.5 54270.0 54440.5 54477.0 54561.5 54678.7 54853.3 54947.7 55070.7 55447.2 14887.4 15277.1 15342.8 15353.4 15362.4 11414.9 11668.8 11688.2 12237.1 12241.8 17003.0 17116.3 17139.2 17222.3 17271.7 6656.3 6725.8 6867.3 6983.4 6991.9 912.8 1046.0 1058.6 1076.1 1120.7 31487.4 32077.0 32466.8 32646.0 32814.3 1088.5 1101.0 1137.1 1155.0 1175.2 16391.0 16822.6 16946.2 17002.8 17046.5 541276.0 544479.0 545101.0 547484.0 548487.0 60307.4 61178.4 61579.0 61612.0 62006.4 1358.5 1377.5 1382.7 1394.8 1405.1 30252.5 31309.7 31714.4 31820.2 32158.0 52454.0 52812.7 52837.7 52877.7 53001.7 400680.0 407254.0 407637.0 408502.0 408716.0 25255.4 25817.4 26230.5 27158.5 27791.9 42371.4 42559.8 42887.5 43063.6 43198.6 35862.6 35914.0 35933.3 36047.8 36124.9 35912.8 35980.8 36132.3 36183.6 36244.3 35696.3 36294.3 36846.3 37003.6 37036.8 32219.7 34330.7 34441.7 34482.8 34596.8 25375.4 25566.1 25625.6 25954.7 26271.0 11:10:37 INFO - PROCESS | 19077 | 11:10:37 INFO - PROCESS | 19077 | [#2] jquery.html Cycles:180 Average:25440.73 Median:2223.87 stddev:67680.23 (3043.4%) stddev-sans-first:67843.93 11:10:37 INFO - PROCESS | 19077 | Values: 377.5 382.9 402.3 405.7 420.0 16657.8 16909.3 17852.3 19250.8 19386.1 11204.2 11743.3 11835.2 11876.3 12178.2 5257.4 5434.9 5438.3 5444.3 5445.3 5178.3 5291.3 5336.7 5341.0 5382.7 5302.2 5303.6 5307.7 5323.6 5331.6 5323.4 5343.3 5553.7 5785.5 5824.2 5746.3 5760.6 5767.2 5772.2 5776.6 13678.4 13714.0 13834.4 13843.4 13861.8 2178.3 2234.8 2401.0 2471.9 2788.0 10150.1 10721.0 10775.8 12744.6 14217.1 1938.3 1989.9 2030.9 2045.9 2054.9 77142.6 79474.0 79992.0 82156.2 82816.2 9244.0 9714.2 9733.4 9768.2 11061.2 13090.7 13134.0 13214.5 13245.6 13255.5 7235.7 7449.2 7634.5 7657.4 7676.9 7205.9 7222.6 7228.1 7401.9 7496.7 4014.6 4030.8 4042.0 4115.8 4168.5 1979.2 1979.4 1984.6 2002.8 2037.7 455.6 844.4 966.9 984.7 1012.8 11091.7 11785.2 11908.4 11932.8 12212.9 461.5 463.5 471.5 478.2 482.3 6256.9 6261.0 6367.4 6415.2 6677.3 350410.0 356722.0 435358.0 439402.0 440962.0 86375.0 88202.0 90199.0 90416.5 92021.5 1038.8 1045.2 1088.1 1090.9 1094.7 17494.7 17648.4 18101.5 18152.3 18152.7 39280.4 40624.6 40764.6 40828.6 42422.9 54071.7 54914.8 55015.0 55560.9 56530.0 8470.0 8556.6 8568.4 8597.3 8683.3 12698.2 12760.8 13155.5 13177.7 13286.7 11026.4 11317.2 11454.6 11600.4 11660.7 11137.8 11215.7 11303.0 11529.0 11757.4 10891.2 11397.5 11752.8 11907.6 12477.7 8188.6 8229.8 8272.4 8422.0 8769.5 10026.3 10904.4 11299.8 11412.7 11967.9 11:10:37 INFO - PROCESS | 19077 | 11:10:37 INFO - PROCESS | 19077 | [#3] mootools.html Cycles:180 Average:5430.90 Median:4992.14 stddev:3000.49 (60.1%) stddev-sans-first:2994.09 11:10:37 INFO - PROCESS | 19077 | Values: 1463.0 1464.7 1624.5 1771.3 1792.0 7387.9 7504.5 8015.2 8478.8 8529.7 7807.0 8065.2 8082.0 8171.9 8224.8 2301.4 2351.8 2354.5 2356.9 2357.0 2323.4 2363.2 2372.5 2373.2 2379.2 2346.0 2364.5 2370.7 2389.3 2398.1 2241.2 2258.2 2275.1 2285.5 2298.9 2287.5 2307.3 2312.9 2315.5 2315.8 8191.7 8242.5 8275.7 8359.4 8400.4 4877.2 4993.7 5003.9 5004.9 5007.5 3293.4 3392.2 3484.2 3547.9 3556.8 990.8 1018.7 1048.8 1054.4 1063.1 11103.4 11180.3 11206.2 11214.9 11233.6 4325.6 4513.9 4524.9 4673.4 4680.0 9461.8 9532.5 9533.0 9539.0 9576.5 5148.1 5161.3 5163.6 5173.5 5175.2 4638.1 4757.9 4786.1 4881.7 4884.0 3540.0 3685.2 3731.9 3736.3 3806.0 1173.1 1174.5 1177.3 1180.8 1187.8 771.9 972.8 976.6 982.4 993.4 5496.3 5507.1 5583.6 5623.0 5800.0 424.7 426.9 431.2 441.1 444.0 3746.4 3778.8 3838.8 3871.1 3920.6 9657.6 10048.5 10146.4 10186.3 10243.8 9501.0 10122.3 10131.9 10155.5 10156.5 7431.1 7718.0 7769.5 7774.3 7788.8 5287.0 5443.7 5520.0 5616.9 5636.1 8938.9 9148.0 9217.4 9223.8 9313.0 9113.7 9266.3 9279.3 9433.7 9453.8 7031.7 7168.2 7282.2 7296.6 7330.0 8022.5 8076.3 8084.2 8084.2 8087.4 7096.2 7169.3 7276.9 7288.4 7451.2 6937.5 6946.2 6966.1 7033.5 7181.3 6308.9 6405.0 6440.0 6440.2 6453.3 4755.4 4785.2 4812.1 4833.7 4846.1 4923.9 4953.1 4990.6 5030.3 5068.9 11:10:37 INFO - PROCESS | 19077 | 11:10:37 INFO - PROCESS | 19077 | [#4] prototype.html Cycles:180 Average:4680.25 Median:5330.29 stddev:1363.28 (25.6%) stddev-sans-first:1328.43 11:10:37 INFO - PROCESS | 19077 | Values: 384.3 399.2 401.3 409.4 411.9 5125.6 5272.3 5296.8 5328.7 5383.4 5161.0 5264.4 5317.4 5325.5 5365.9 4261.2 4280.7 4284.0 4285.3 4304.7 3943.3 4153.5 4246.6 4262.0 4275.9 4128.4 4137.9 4146.5 4153.0 4156.3 4117.9 4124.3 4126.8 4129.9 4154.3 3700.2 3716.2 3719.5 3722.8 3731.8 5042.0 5143.0 5147.5 5148.5 5168.2 4772.3 4780.7 4790.5 4799.0 4829.3 5410.8 5538.0 5550.2 5553.4 5561.0 3954.6 3992.6 4012.4 4017.7 4030.2 5706.7 5736.5 5764.0 5780.1 5786.9 4096.4 4108.8 4119.2 4119.5 4121.8 3908.3 4112.8 4153.8 4164.8 4184.9 4705.2 4711.3 4723.2 4741.9 4797.3 5549.1 5585.2 5589.3 5613.0 5613.6 1365.5 1367.8 1372.7 1386.5 1387.6 943.9 957.4 967.5 972.9 975.2 5258.2 5260.8 5264.7 5328.9 5331.7 5433.3 5536.8 5554.4 5569.3 5590.0 5099.4 5175.9 5258.7 5321.9 5500.7 2930.2 2948.9 2960.7 2967.5 2982.2 5847.6 5852.6 5862.6 5898.5 5924.4 5470.2 5666.6 5685.2 5687.4 5705.3 5811.0 5856.0 5872.9 5882.6 5894.8 5342.8 5503.0 5599.2 5646.9 5689.5 5459.8 5494.9 5504.3 5518.9 5541.7 5828.8 5857.6 5858.5 5886.1 5898.9 3910.6 3950.6 3990.9 4007.3 4010.2 5578.5 5601.0 5610.9 5619.2 5622.3 5636.8 5643.9 5658.4 5666.4 5671.6 5618.0 5637.3 5643.4 5650.0 5653.0 5510.7 5612.0 5617.9 5619.9 5666.3 5642.4 5656.5 5660.6 5662.6 5676.3 5343.5 5491.3 5509.6 5512.2 5517.0 11:10:37 INFO - PROCESS | 19077 | 11:10:37 INFO - PROCESS | 19077 | [#5] yui.html Cycles:180 Average:18209.20 Median:4597.39 stddev:23587.10 (513.1%) stddev-sans-first:23616.76 11:10:37 INFO - PROCESS | 19077 | Values: 731.8 742.7 743.4 760.1 836.6 15000.8 15812.4 16376.3 16445.6 16899.6 15385.8 15538.3 15612.8 15614.1 15627.5 777.1 806.9 810.7 822.1 822.5 798.8 802.8 803.3 811.7 814.7 882.3 883.1 885.2 886.6 888.4 871.6 872.8 878.6 879.8 880.0 638.2 640.9 642.4 643.8 645.6 15113.5 15195.5 15251.0 16168.4 16329.2 14071.9 14245.4 14527.4 14612.7 14621.6 11912.6 12140.0 12214.5 12228.8 12303.3 3718.3 3721.8 3740.5 3811.2 3818.9 63976.4 79809.6 80295.2 82078.6 82200.6 9929.6 10006.7 10011.8 10171.1 10258.3 18540.5 18557.8 18861.9 18975.7 19235.7 7914.8 8134.8 8204.2 8268.7 8508.4 4475.1 4475.7 4583.4 4610.8 4615.0 3631.2 3720.6 3726.5 3727.5 3732.9 602.5 627.6 640.6 647.6 654.4 600.3 642.7 684.6 703.6 735.6 8910.6 9503.2 9632.7 9815.6 10001.5 561.8 621.1 621.8 644.8 716.7 4504.9 4571.0 4597.1 4597.7 4655.3 79881.6 80418.6 84492.2 85245.6 89381.0 71760.6 74113.6 74620.0 76599.0 77904.2 65428.0 65563.7 65966.3 67629.0 68891.3 8365.5 8389.5 8393.2 8434.7 8600.4 43551.8 44499.3 44524.6 45236.3 45309.5 51303.5 56292.0 61087.0 61501.7 61972.4 13041.5 13643.8 13687.1 13994.2 14020.0 14390.4 15727.3 16036.5 16162.8 16212.7 14167.5 14432.6 14725.2 14932.9 15139.3 13968.3 14285.5 14490.6 14759.9 14873.1 14545.5 14898.6 14972.6 15216.0 15905.3 10791.6 11118.7 11202.6 11247.9 11819.7 11740.3 11854.1 12006.6 12294.6 12295.8 11:10:37 INFO - PROCESS | 19077 | -------- Summary: end -------- 11:10:37 INFO - PROCESS | 19077 | 11:10:38 INFO - TEST-INFO | 19077: exit 0 11:10:38 INFO - TEST-OK | dromaeo_css | took 1113269ms 11:10:38 INFO - TEST-START | kraken 11:10:38 INFO - operating with platform_type : linux_ 11:10:38 INFO - Initialising browser for kraken test... 11:10:38 INFO - TEST-INFO | started process 19438 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpc2z32F/profile http://localhost:43451/getInfo.html) 11:10:38 INFO - PROCESS | 19438 | 1482433838559 addons.xpi WARN Exception running bootstrap method install on shield-recipe-client@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getBoolPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js :: this.install :: line 38" data: no] Stack trace: this.install()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:38 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4979 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2097 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3825 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2829 < callProvider()@resource://gre/modules/AddonManager.jsm:264 < _startProvider()@resource://gre/modules/AddonManager.jsm:771 < startup()@resource://gre/modules/AddonManager.jsm:957 < startup()@resource://gre/modules/AddonManager.jsm:2923 < observe()@resource://gre/components/addonManager.js:65 11:10:42 INFO - PROCESS | 19438 | __metrics Screen width/height:1600/1200 11:10:42 INFO - PROCESS | 19438 | colorDepth:24 11:10:42 INFO - PROCESS | 19438 | Browser inner width/height: 1024/697 11:10:42 INFO - PROCESS | 19438 | __metrics 11:10:42 ERROR - PROCESS | 19438 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3247: TypeError: this.tabs is undefined 11:10:43 INFO - TEST-INFO | 19438: exit 0 11:10:43 INFO - Browser initialized. 11:10:43 INFO - Running cycle 1/1 for kraken test... 11:10:43 INFO - TEST-INFO | started process 19560 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpc2z32F/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:10:55 INFO - PROCESS | 19560 | RSS: Main: 154791936 11:10:55 INFO - PROCESS | 19560 | 11:10:58 INFO - PROCESS | 19560 | Cycle 1(1): loaded http://localhost:43451/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43451/tests/kraken/driver.html?testName=audio-beat-detection) 11:10:58 INFO - PROCESS | 19560 | RSS: Main: 161251328 11:10:58 INFO - PROCESS | 19560 | 11:11:01 INFO - PROCESS | 19560 | Cycle 1(1): loaded http://localhost:43451/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43451/tests/kraken/driver.html?testName=audio-dft) 11:11:02 INFO - PROCESS | 19560 | RSS: Main: 159744000 11:11:02 INFO - PROCESS | 19560 | 11:11:04 INFO - PROCESS | 19560 | Cycle 1(1): loaded http://localhost:43451/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43451/tests/kraken/driver.html?testName=audio-fft) 11:11:05 INFO - PROCESS | 19560 | RSS: Main: 155643904 11:11:05 INFO - PROCESS | 19560 | 11:11:07 INFO - PROCESS | 19560 | Cycle 1(1): loaded http://localhost:43451/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43451/tests/kraken/driver.html?testName=audio-oscillator) 11:11:08 INFO - PROCESS | 19560 | RSS: Main: 157114368 11:11:08 INFO - PROCESS | 19560 | 11:11:10 INFO - PROCESS | 19560 | Cycle 1(1): loaded http://localhost:43451/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43451/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:11:11 INFO - PROCESS | 19560 | RSS: Main: 157048832 11:11:11 INFO - PROCESS | 19560 | 11:11:14 INFO - PROCESS | 19560 | Cycle 1(1): loaded http://localhost:43451/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43451/tests/kraken/driver.html?testName=imaging-darkroom) 11:11:14 INFO - PROCESS | 19560 | RSS: Main: 161587200 11:11:14 INFO - PROCESS | 19560 | 11:11:18 INFO - PROCESS | 19560 | Cycle 1(1): loaded http://localhost:43451/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43451/tests/kraken/driver.html?testName=imaging-desaturate) 11:11:18 INFO - PROCESS | 19560 | RSS: Main: 161828864 11:11:18 INFO - PROCESS | 19560 | 11:11:21 INFO - PROCESS | 19560 | Cycle 1(1): loaded http://localhost:43451/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43451/tests/kraken/driver.html?testName=json-parse-financial) 11:11:22 INFO - PROCESS | 19560 | RSS: Main: 161320960 11:11:22 INFO - PROCESS | 19560 | 11:11:23 INFO - PROCESS | 19560 | Cycle 1(1): loaded http://localhost:43451/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43451/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:11:24 INFO - PROCESS | 19560 | RSS: Main: 160555008 11:11:24 INFO - PROCESS | 19560 | 11:11:26 INFO - PROCESS | 19560 | Cycle 1(1): loaded http://localhost:43451/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43451/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:11:26 INFO - PROCESS | 19560 | RSS: Main: 160567296 11:11:26 INFO - PROCESS | 19560 | 11:11:29 INFO - PROCESS | 19560 | Cycle 1(1): loaded http://localhost:43451/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43451/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:11:29 INFO - PROCESS | 19560 | RSS: Main: 160800768 11:11:29 INFO - PROCESS | 19560 | 11:11:32 INFO - PROCESS | 19560 | Cycle 1(1): loaded http://localhost:43451/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43451/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:11:33 INFO - PROCESS | 19560 | RSS: Main: 160792576 11:11:33 INFO - PROCESS | 19560 | 11:11:35 INFO - PROCESS | 19560 | Cycle 1(1): loaded http://localhost:43451/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43451/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:11:36 INFO - PROCESS | 19560 | RSS: Main: 160927744 11:11:36 INFO - PROCESS | 19560 | 11:11:38 INFO - PROCESS | 19560 | Cycle 1(1): loaded http://localhost:43451/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43451/tests/kraken/driver.html?testName=ai-astar) 11:11:38 INFO - PROCESS | 19560 | RSS: Main: 162041856 11:11:38 INFO - PROCESS | 19560 | 11:11:38 INFO - PROCESS | 19560 | __start_tp_report 11:11:38 INFO - PROCESS | 19560 | _x_x_mozilla_page_load 11:11:38 INFO - PROCESS | 19560 | _x_x_mozilla_page_load_details 11:11:38 INFO - PROCESS | 19560 | |i|pagename|runs| 11:11:38 INFO - PROCESS | 19560 | |0;ai-astar;104;113;113;112;115;114;117;114;115;115 11:11:38 INFO - PROCESS | 19560 | |1;audio-beat-detection;147;121;121;168;124;122;120;121;139;126 11:11:38 INFO - PROCESS | 19560 | |2;audio-dft;163;161;164;163;163;165;168;161;162;162 11:11:38 INFO - PROCESS | 19560 | |3;audio-fft;76;76;77;117;77;77;77;78;91;79 11:11:38 INFO - PROCESS | 19560 | |4;audio-oscillator;87;84;111;85;86;85;104;86;84;115 11:11:38 INFO - PROCESS | 19560 | |5;imaging-gaussian-blur;118;117;117;117;118;117;117;118;119;121 11:11:38 INFO - PROCESS | 19560 | |6;imaging-darkroom;149;148;150;149;148;149;150;149;149;151 11:11:38 INFO - PROCESS | 19560 | |7;imaging-desaturate;96;101;95;95;95;96;96;96;96;96 11:11:38 INFO - PROCESS | 19560 | |8;json-parse-financial;53;54;53;56;55;55;61;54;55;54 11:11:38 INFO - PROCESS | 19560 | |9;json-stringify-tinderbox;65;64;65;65;65;67;65;65;65;65 11:11:38 INFO - PROCESS | 19560 | |10;stanford-crypto-aes;82;82;82;82;82;82;81;81;81;82 11:11:38 INFO - PROCESS | 19560 | |11;stanford-crypto-ccm;128;131;126;129;128;135;131;132;181;148 11:11:38 INFO - PROCESS | 19560 | |12;stanford-crypto-pbkdf2;166;168;165;168;162;166;163;172;170;171 11:11:38 INFO - PROCESS | 19560 | |13;stanford-crypto-sha256-iterative;63;65;66;64;63;63;69;61;68;62 11:11:38 INFO - PROCESS | 19560 | __end_tp_report 11:11:38 INFO - PROCESS | 19560 | __start_cc_report 11:11:38 INFO - PROCESS | 19560 | _x_x_mozilla_cycle_collect,717 11:11:38 INFO - PROCESS | 19560 | __end_cc_report 11:11:38 INFO - PROCESS | 19560 | __startTimestamp1482433898478__endTimestamp 11:11:38 INFO - PROCESS | 19560 | 11:11:38 INFO - PROCESS | 19560 | ------- Summary: start ------- 11:11:38 INFO - PROCESS | 19560 | Number of tests: 14 11:11:38 INFO - PROCESS | 19560 | 11:11:38 INFO - PROCESS | 19560 | [#0] ai-astar Cycles:10 Average:113.20 Median:114.50 stddev:3.52 (3.1%) stddev-sans-first:1.48 11:11:38 INFO - PROCESS | 19560 | Values: 104.0 113.0 113.0 112.0 115.0 114.0 117.0 114.0 115.0 115.0 11:11:38 INFO - PROCESS | 19560 | 11:11:38 INFO - PROCESS | 19560 | [#1] audio-beat-detection Cycles:10 Average:130.90 Median:125.00 stddev:15.86 (12.7%) stddev-sans-first:15.72 11:11:38 INFO - PROCESS | 19560 | Values: 147.0 121.0 121.0 168.0 124.0 122.0 120.0 121.0 139.0 126.0 11:11:38 INFO - PROCESS | 19560 | 11:11:38 INFO - PROCESS | 19560 | [#2] audio-dft Cycles:10 Average:163.20 Median:163.00 stddev:2.10 (1.3%) stddev-sans-first:2.22 11:11:38 INFO - PROCESS | 19560 | Values: 163.0 161.0 164.0 163.0 163.0 165.0 168.0 161.0 162.0 162.0 11:11:38 INFO - PROCESS | 19560 | 11:11:38 INFO - PROCESS | 19560 | [#3] audio-fft Cycles:10 Average:82.50 Median:77.00 stddev:12.91 (16.8%) stddev-sans-first:13.48 11:11:38 INFO - PROCESS | 19560 | Values: 76.0 76.0 77.0 117.0 77.0 77.0 77.0 78.0 91.0 79.0 11:11:38 INFO - PROCESS | 19560 | 11:11:38 INFO - PROCESS | 19560 | [#4] audio-oscillator Cycles:10 Average:92.70 Median:85.00 stddev:12.26 (14.4%) stddev-sans-first:12.83 11:11:38 INFO - PROCESS | 19560 | Values: 87.0 84.0 111.0 85.0 86.0 85.0 104.0 86.0 84.0 115.0 11:11:38 INFO - PROCESS | 19560 | 11:11:38 INFO - PROCESS | 19560 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:1.29 (1.1%) stddev-sans-first:1.36 11:11:38 INFO - PROCESS | 19560 | Values: 118.0 117.0 117.0 117.0 118.0 117.0 117.0 118.0 119.0 121.0 11:11:38 INFO - PROCESS | 19560 | 11:11:38 INFO - PROCESS | 19560 | [#6] imaging-darkroom Cycles:10 Average:149.20 Median:149.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 11:11:38 INFO - PROCESS | 19560 | Values: 149.0 148.0 150.0 149.0 148.0 149.0 150.0 149.0 149.0 151.0 11:11:38 INFO - PROCESS | 19560 | 11:11:38 INFO - PROCESS | 19560 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:1.75 (1.8%) stddev-sans-first:1.86 11:11:38 INFO - PROCESS | 19560 | Values: 96.0 101.0 95.0 95.0 95.0 96.0 96.0 96.0 96.0 96.0 11:11:38 INFO - PROCESS | 19560 | 11:11:38 INFO - PROCESS | 19560 | [#8] json-parse-financial Cycles:10 Average:55.00 Median:55.00 stddev:2.31 (4.2%) stddev-sans-first:2.33 11:11:38 INFO - PROCESS | 19560 | Values: 53.0 54.0 53.0 56.0 55.0 55.0 61.0 54.0 55.0 54.0 11:11:38 INFO - PROCESS | 19560 | 11:11:38 INFO - PROCESS | 19560 | [#9] json-stringify-tinderbox Cycles:10 Average:65.10 Median:65.00 stddev:0.74 (1.1%) stddev-sans-first:0.78 11:11:38 INFO - PROCESS | 19560 | Values: 65.0 64.0 65.0 65.0 65.0 67.0 65.0 65.0 65.0 65.0 11:11:38 INFO - PROCESS | 19560 | 11:11:38 INFO - PROCESS | 19560 | [#10] stanford-crypto-aes Cycles:10 Average:81.70 Median:82.00 stddev:0.48 (0.6%) stddev-sans-first:0.50 11:11:38 INFO - PROCESS | 19560 | Values: 82.0 82.0 82.0 82.0 82.0 82.0 81.0 81.0 81.0 82.0 11:11:38 INFO - PROCESS | 19560 | 11:11:38 INFO - PROCESS | 19560 | [#11] stanford-crypto-ccm Cycles:10 Average:136.90 Median:131.50 stddev:16.68 (12.7%) stddev-sans-first:17.38 11:11:38 INFO - PROCESS | 19560 | Values: 128.0 131.0 126.0 129.0 128.0 135.0 131.0 132.0 181.0 148.0 11:11:38 INFO - PROCESS | 19560 | 11:11:38 INFO - PROCESS | 19560 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.10 Median:168.00 stddev:3.31 (2.0%) stddev-sans-first:3.49 11:11:38 INFO - PROCESS | 19560 | Values: 166.0 168.0 165.0 168.0 162.0 166.0 163.0 172.0 170.0 171.0 11:11:38 INFO - PROCESS | 19560 | 11:11:38 INFO - PROCESS | 19560 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.40 Median:64.50 stddev:2.59 (4.0%) stddev-sans-first:2.70 11:11:38 INFO - PROCESS | 19560 | Values: 63.0 65.0 66.0 64.0 63.0 63.0 69.0 61.0 68.0 62.0 11:11:38 INFO - PROCESS | 19560 | -------- Summary: end -------- 11:11:38 INFO - PROCESS | 19560 | 11:11:39 INFO - TEST-INFO | 19560: exit 0 11:11:39 INFO - TEST-OK | kraken | took 61426ms 11:11:39 INFO - SUITE-END | took 1174s 11:11:39 INFO - Completed test suite (00:19:34) 11:11:39 INFO - javascript benchmark 11:11:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7005.480854947305, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3188.378266238082, 3197.6642452542483, 3205.150635081704, 3210.0851257391632, 3239.951400728988, 5257.00116977774, 5340.679559226449, 5357.892842143155, 5390.703511306877, 5398.865028374293, 5342.519173274404, 5342.973285133578, 5427.023135835548, 5435.157550579656, 5468.644538105021, 4804.567588916997, 4836.6856154350035, 4870.512948705136, 4965.726885021322, 4978.900421991558, 4881.0, 4979.701217926936, 5017.122003649365, 5021.497850214968, 5058.190689489682, 4743.407074115736, 4944.406671199479, 4996.500349964993, 5032.521910418541, 5047.697138171721, 4773.928391074137, 4825.059113472874, 4909.779059942275, 4924.729139897304, 5006.5744411725045, 4905.4358748744, 4905.583025442842, 4918.311436398907, 4934.629902757308, 4951.950480495185, 5393.379761327458, 5406.378266499363, 5420.13277875542, 5421.647592906488, 5428.240046393508, 5550.833474995757, 5582.441755824426, 5696.088625819849, 5737.311522617271, 5740.54075673945, 5814.941850581525, 5830.7667693292215, 5832.358440571534, 5836.824895253149, 5888.852778680567, 5385.219143224211, 5390.703511306877, 5391.487808658171, 5394.460553944653, 5424.647397919122, 5705.942940570541, 5782.6819524925695, 5882.823515294548, 5894.498967587803, 5935.406459354116, 5754.712264386764, 5760.769569217185, 5763.077907534775, 5786.537077033827, 5815.127730840323, 5798.5071268941765, 5808.7095645218415, 5861.0, 5868.2664666916635, 5869.941300586939, 5591.608587398924, 5647.548196144381, 5744.827655170351, 5804.854878627983, 5810.389909059572, 5801.564882633819, 5844.912326315109, 5854.619449735754, 5861.296644402699, 5898.498627616701, 4360.302351623725, 4361.738295702268, 4369.300911854088, 4373.103513779667, 4408.074304396048, 3817.2556351511744, 3824.7896365700153, 3832.9233415331537, 3853.3064048470983, 3907.531096268466, 5498.477644623755, 5558.360788509373, 5594.300712410949, 5643.097104463266, 5655.264815573949, 5808.448197421239, 5821.650700957956, 5828.504577110908, 5828.94171058284, 5859.912101318484, 5402.540784033401, 5439.156930675752, 5497.5601951843755, 5578.051731205624, 5579.246801681802, 4775.6657034007285, 4776.5701086902345, 4787.688800227974, 4856.39295088114, 4866.245731911559, 6063.090536419572, 6085.361037091042, 6102.664353460514, 6111.022236442148, 6128.540359472968, 5666.518345940476, 5729.914051289151, 5838.5621078418435, 5840.065589505659, 5844.47399734026, 6016.548758843017, 6064.757409703739, 6064.787732429344, 6101.51991978472, 6117.766507567632, 5708.400617935057, 5723.227364305765, 5735.254416925773, 5761.654300741969, 5783.826485205451, 5616.971915140398, 5871.941280587311, 5886.381929897299, 5887.116932460165, 5890.14592884038, 5486.341639003345, 5639.0, 5648.689322087161, 5681.971590142023, 5737.254156959569, 5667.631603945731, 5710.486056254957, 5713.257276554022, 5717.599768016199, 5719.227904233042, 5556.583256255716, 5561.721913904369, 5652.660840349592, 5702.97346477638, 5718.399568045462, 5631.7184140793615, 5719.342275638355, 5731.312242530923, 5773.769049237983, 5809.302883653989, 5571.331440227199, 5610.382857885547, 5618.381977982501, 5620.718964051863, 5622.718864056863], "value": 5343.699544299016, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [526.3131613244715, 547.1164070026907, 548.0764911124753, 589.1869220475743, 593.5251798561153, 39136.60863391365, 42111.78944105283, 42286.15427691448, 45666.543334566646, 45749.7712511437, 45587.77206113965, 45741.313880291826, 45869.0, 45878.77060614701, 46192.0, 8986.595603197838, 9177.082291770836, 9192.080791920787, 9200.125988031126, 10268.229882758786, 10243.180545556375, 10550.15598752098, 10562.524686389132, 10582.259241853073, 10629.468526573679, 10560.524776385042, 10674.146068314516, 10707.571697132105, 10718.946405268001, 10732.302400343953, 10479.371237725762, 10571.471426428649, 10576.418296993663, 10646.733831654194, 10646.999999999962, 10395.064444199983, 10409.635662751767, 10429.374237545771, 10480.371177729361, 10512.106470949979, 37815.81092094549, 38100.80949595262, 38259.42610860839, 38304.80847595772, 38492.0, 3418.6923176913947, 3444.8622055117767, 3449.862005519776, 3602.2975519773654, 3617.6382361763876, 28918.42163156725, 29598.556021659693, 29620.555691664642, 29741.256468588243, 30354.0, 4057.3508238681966, 4092.202020605983, 4132.5454200037975, 4195.643370313527, 4230.894227644303, 345225.0, 345786.0, 348410.0, 348838.0, 351747.0, 53838.46161538413, 54270.0, 54440.45559544354, 54477.0, 54561.45438545643, 54678.72660636671, 54853.257337132985, 54947.72526137344, 55070.72464637731, 55447.168292475646, 14887.404503819726, 15277.083374997314, 15342.769858452131, 15353.385864565516, 15362.385504579916, 11414.88585114155, 11668.824967625322, 11688.240264382788, 12237.082218833444, 12241.755164896831, 17003.0, 17116.315347386215, 17139.22873470697, 17222.311107555808, 17271.65456690859, 6656.30108838565, 6725.764598239136, 6867.313268673092, 6983.406410455168, 6991.8601627967155, 912.7900582865979, 1045.9581616735245, 1058.5924419098703, 1076.1122074288744, 1120.6694025262568, 31487.37025259482, 32077.0, 32466.837665811992, 32646.0, 32814.34371312561, 1088.5250485592067, 1100.9889901101046, 1137.0505627800715, 1155.0470861539263, 1175.1773758369177, 16391.0, 16822.579435513966, 16946.152692365333, 17002.829971700125, 17046.46581807643, 541276.0, 544479.0, 545101.0, 547484.0, 548487.0, 60307.396926030175, 61178.38821611816, 61579.0, 61612.0, 62006.37993620006, 1358.4701966233176, 1377.538524594272, 1382.67507135823, 1394.8256467941508, 1405.0866936491364, 30252.54621180728, 31309.686903131587, 31714.365712686078, 31820.204494887814, 32158.0, 52454.0, 52812.735936320074, 52837.735811320694, 52877.735611321696, 53001.734991324796, 400680.0, 407254.0, 407637.0, 408502.0, 408716.0, 25255.36861578475, 25817.354566135247, 26230.4753904917, 27158.456830863666, 27791.86104069467, 42371.364429532965, 42559.787201063795, 42887.4968128342, 43063.56936430596, 43198.568014320714, 35862.64137358697, 35914.0, 35933.281334372645, 36047.81976090103, 36124.91625251247, 35912.84522928633, 35980.820095899355, 36132.27735445329, 36183.63816361908, 36244.27511449809, 35696.28607427889, 36294.27411451704, 36846.26307473889, 37003.62996370002, 37036.81481592575, 32219.677803221668, 34330.65669343275, 34441.655583444845, 34482.82758586291, 34596.82701586476, 25375.36561585975, 25566.10518631839, 25625.615615765404, 25954.740452595233, 26271.0], "value": 19756.671725924345, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.5469436675986, 382.86216961893695, 402.30200601955613, 405.74235360546055, 419.99370009449865, 16657.750133748003, 16909.323627054902, 17852.28590856366, 19250.807491925076, 19386.127624256926, 11204.15968802339, 11743.29540227587, 11835.230710003843, 11876.28742275464, 12178.208416452946, 5257.421683614809, 5434.8913021739545, 5438.320209973754, 5444.265024221739, 5445.292112025431, 5178.326817513718, 5291.28567643367, 5336.6531175473665, 5341.03861304965, 5382.703951282678, 5302.151655735083, 5303.602229832759, 5307.708076055816, 5323.574114070865, 5331.57347412208, 5323.414424413311, 5343.305370301855, 5553.694546799924, 5785.53715702747, 5824.213731146283, 5746.25298711169, 5760.6255593386295, 5767.2409914975915, 5772.220750198753, 5776.566757493205, 13678.384472698654, 13714.0, 13834.377453014538, 13843.377048032862, 13861.792073118912, 2178.346496051194, 2234.821214302852, 2400.951980960371, 2471.888765005579, 2788.0, 10150.137238334677, 10721.035106840422, 10775.83836242457, 12744.553940612033, 14217.146971181659, 1938.311899275765, 1989.9403017909342, 2030.9390718278476, 2045.887476188809, 2054.9486262843398, 77142.61428692877, 79474.0, 79992.0, 82156.17843821605, 82816.17183828205, 9244.0, 9714.174295184846, 9733.367331123454, 9768.169705575106, 11061.170412219115, 13090.738185236241, 13134.0, 13214.537491187762, 13245.602631921058, 13255.536056237985, 7235.7467488638695, 7449.180590135081, 7634.4655874088285, 7657.387409007266, 7676.884846727304, 7205.89191162133, 7222.638868056576, 7228.096487939008, 7401.888971665429, 7496.662650180755, 4014.6186112319283, 4030.7581545107387, 4042.0, 4115.814788334532, 4168.499780026416, 1979.2478858033855, 1979.416072258687, 1984.583237520137, 2002.8097330753556, 2037.7045328427296, 455.5649354866095, 844.4089137603702, 966.8549717542285, 984.6652138273022, 1012.8379459286479, 11091.72270693223, 11785.233959792757, 11908.404579770977, 11932.761344773056, 12212.877871221352, 461.50157829544685, 463.5109958993227, 471.4695967037083, 478.1990166471147, 482.2693619166965, 6256.874862502725, 6260.968695156495, 6367.395097465734, 6415.1981002374705, 6677.332266773284, 350410.0, 356722.0, 435358.0, 439402.0, 440962.0, 86375.0, 88202.0, 90199.0, 90416.54791725999, 92021.53989230144, 1038.813013657549, 1045.2160879340495, 1088.0588291128117, 1090.8581884354983, 1094.715374002765, 17494.650106997535, 17648.382306619205, 18101.547461313574, 18152.27390904349, 18152.72770908464, 39280.41079383869, 40624.59375406208, 40764.592354077264, 40828.59171408248, 42422.93942651335, 54071.72964135154, 54914.760250728374, 55015.0, 55560.9436631678, 56530.0, 8470.0, 8556.646922096224, 8568.443051201652, 8597.26923211534, 8683.261922736638, 12698.174618649758, 12760.808587871004, 13155.473781049033, 13177.736445271232, 13286.734265314833, 11026.44867756625, 11317.151213658844, 11454.599089031844, 11600.361980090838, 11660.708482288012, 11137.83293250618, 11215.66353009411, 11303.0, 11529.0, 11757.412129393668, 10891.183161263096, 11397.487113079766, 11752.823707644222, 11907.583234587095, 12477.688057798629, 8188.590570471333, 8229.753107406787, 8272.37957153228, 8422.020825105972, 8769.473831570127, 10026.298159128792, 10904.400257985886, 11299.774004519699, 11412.714682133013, 11967.940160299142], "value": 8285.252166316817, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1463.04901813821, 1464.7290251303507, 1624.4801663467688, 1771.3446024970763, 1791.9731204031941, 7387.926120738791, 7504.549727016383, 8015.198480151989, 8478.788030299245, 8529.744107676765, 7806.960965195166, 8065.233802788725, 8081.959590202056, 8171.877421838677, 8224.753257402288, 2301.436148143703, 2351.7530659280787, 2354.4702441950594, 2356.858588484688, 2357.033616217351, 2323.384303159664, 2363.161077817376, 2372.54921564903, 2373.193114341124, 2379.2148590965026, 2346.0146738369926, 2364.47981444082, 2370.727366352866, 2389.259329607827, 2398.1486572266854, 2241.2491815241915, 2258.1870526610405, 2275.112706044644, 2285.5086156476355, 2298.9195378161853, 2287.5310561334886, 2307.273208939179, 2312.90748370065, 2315.455867871049, 2315.80315673168, 8191.672333106669, 8242.505449673039, 8275.710350137717, 8359.373047021438, 8400.41197116202, 4877.219644856841, 4993.650444468889, 5003.949960500385, 5004.949950500485, 5007.524285192901, 3293.440115180425, 3392.2197894484407, 3484.163800687842, 3547.9290414191573, 3556.8043757593323, 990.8365119755232, 1018.7249442650443, 1048.7849990751877, 1054.3673795722505, 1063.0538820449729, 11103.44482775866, 11180.273282236629, 11206.215564910459, 11214.887851121384, 11233.550657973672, 4325.610695037399, 4513.864584062483, 4524.932126018112, 4673.434399476146, 4679.9532004680195, 9461.810763784824, 9532.475713835805, 9532.952335238419, 9539.046095390406, 9576.521173941275, 5148.073346797612, 5161.27742116104, 5163.561097306696, 5173.508516690908, 5175.171972484384, 4638.1187574360765, 4757.928631070467, 4786.0667169901535, 4881.658283920163, 4884.0, 3540.0, 3685.1892583631557, 3731.850725970931, 3736.3274610569815, 3805.961940380616, 1173.096715529038, 1174.5477990973366, 1177.3465726521692, 1180.8110702287593, 1187.804012337972, 771.9498232614974, 972.8297547929084, 976.62888102522, 982.3565564555228, 993.4436715439377, 5496.31296087989, 5507.0637991541535, 5583.609147359727, 5623.0, 5799.971000144972, 424.74303046656325, 426.903946612016, 431.24962565137065, 441.0759458933529, 444.0430871471983, 3746.4193050077283, 3778.8299526521373, 3838.7696738195796, 3871.070942973666, 3920.627540383659, 9657.565409556586, 10048.547815348327, 10146.44194569291, 10186.337888037255, 10243.795124097476, 9500.95249523748, 10122.291439599157, 10131.949340253252, 10155.46113471632, 10156.4921753912, 7431.108267007886, 7718.0, 7769.53382797034, 7774.2614451627005, 7788.766337009899, 5287.0, 5443.727813609383, 5519.972400137974, 5616.85957851057, 5636.070048441961, 8938.910610894069, 9148.0, 9217.400868943498, 9223.815523689624, 9313.0, 9113.726588202364, 9266.258699304175, 9279.304052196247, 9433.669821556212, 9453.810923781348, 7031.718731250898, 7168.211496735251, 7282.162551306667, 7296.562206267428, 7329.973803667384, 8022.478538894953, 8076.27313541784, 8084.231997960184, 8084.231997960184, 8087.393445491729, 7096.189377015343, 7169.318914703095, 7276.927230727837, 7288.416926645961, 7451.217622149813, 6937.514373993772, 6946.16646002483, 6966.094407726963, 7033.507654464139, 7181.317774811385, 6308.936910630835, 6405.0, 6440.0, 6440.227172739301, 6453.257875344396, 4755.38180036593, 4785.210440277316, 4812.085703716282, 4833.73414462208, 4846.127697014571, 4923.901521969469, 4953.083679519301, 4990.627577416094, 5030.346055012825, 5068.873278167928], "value": 4328.600759049935, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.3351002765216, 399.1757021750086, 401.2516656435747, 409.43799405268913, 411.89084892503473, 5125.5653564556815, 5272.288241087462, 5296.788128474861, 5328.653637513564, 5383.434739352366, 5160.961420239003, 5264.368275806899, 5317.415084340729, 5325.467453254682, 5365.919511207335, 4261.2329780639475, 4280.715785264409, 4283.978580107103, 4285.250081235771, 4304.698671093025, 3943.284671168051, 4153.480814898137, 4246.554111818261, 4262.0, 4275.935860962088, 4128.380742888561, 4137.9172416551655, 4146.523149837777, 4152.958470415302, 4156.293430116887, 4117.855875044374, 4124.278251306025, 4126.834926602933, 4129.876103716893, 4154.335306350969, 3700.185959089023, 3716.201016781405, 3719.479272901796, 3722.822149042813, 3731.7574357666663, 5042.0, 5143.0, 5147.459516750762, 5148.4851514848215, 5168.173092305213, 4772.308015337791, 4780.713157210544, 4790.4969978152485, 4798.952010479886, 4829.275608658694, 5410.810621628224, 5538.0031594313, 5550.222968784374, 5553.389127196006, 5561.0, 3954.6440820326306, 3992.6207010333974, 4012.3981402789814, 4017.734413659688, 4030.234255491447, 5706.686132262724, 5736.512396446307, 5764.0, 5780.132980053026, 5786.913196302059, 4096.365063415175, 4108.767369789051, 4119.155573107506, 4119.485064366954, 4121.814518346621, 3908.3160446921675, 4112.773797441169, 4153.771542565128, 4164.7709375984, 4184.895377615584, 4705.1765940960195, 4711.340412342275, 4723.197056500403, 4741.909360846956, 4797.304390863305, 5549.113301477436, 5585.245991791056, 5589.301337332833, 5612.97193514038, 5613.635113717595, 1365.49476693624, 1367.787992861108, 1372.6842826150041, 1386.535510603959, 1387.6253411579019, 943.9280778690708, 957.368137029571, 967.5404183013012, 972.9464879431557, 975.2198241406846, 5258.158694608845, 5260.842174734764, 5264.736763161826, 5328.893422131536, 5331.680099193984, 5433.320834895638, 5536.75084621193, 5554.3614633682355, 5569.303837020372, 5590.0, 5099.36257967754, 5175.896482070338, 5258.684478931276, 5321.920171197435, 5500.669959802424, 2930.2088436122126, 2948.9262768430963, 2960.6743258241577, 2967.4955257606257, 2982.209714425679, 5847.573257098342, 5852.648841069549, 5862.570396318117, 5898.528117750569, 5924.407559244041, 5470.234167216593, 5666.631668941505, 5685.232493613309, 5687.40282270364, 5705.286839145107, 5811.0, 5856.0, 5872.94127058741, 5882.588218824641, 5894.823155305347, 5342.75957581902, 5503.0, 5599.1724179289195, 5646.9152962704775, 5689.459501347365, 5459.781608735765, 5494.890102198014, 5504.311961004874, 5518.944810551843, 5541.695206763667, 5828.76684932598, 5857.619254748428, 5858.543459358828, 5886.115803256459, 5898.911516327173, 3910.5698373178357, 3950.585188555275, 3990.86031988879, 4007.3187558115774, 4010.1779135276615, 5578.497935185853, 5600.971995139998, 5610.859728506657, 5619.218486849036, 5622.297212848394, 5636.802711905064, 5643.915341269966, 5658.377578466448, 5666.433356664301, 5671.602987790815, 5618.0, 5637.3235211774845, 5643.3510146332055, 5649.977262164723, 5652.971735141298, 5510.6969116698965, 5612.045952188057, 5617.859553511195, 5619.887602247851, 5666.34836993751, 5642.379338272704, 5656.490915817596, 5660.632058916157, 5662.575306852085, 5676.262085928968, 5343.465653434625, 5491.313585801775, 5509.614326997072, 5512.200730894078, 5517.034518959246], "value": 4262.60803655352, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [731.8024133483958, 742.6546655805051, 743.4164181117824, 760.0765070439415, 836.5900708652762, 15000.774988375184, 15812.44656437025, 16376.263068161932, 16445.588860278498, 16899.57751056224, 15385.846141538581, 15538.300776465057, 15612.765808512853, 15614.141222232773, 15627.453039143633, 777.0675189772296, 806.8789681547756, 810.6919370639149, 822.0628483528782, 822.5393779483509, 798.8162722573811, 802.8273921106961, 803.3131672420085, 811.6509900742678, 814.6537721468382, 882.3382463152635, 883.0551310098198, 885.1900511032397, 886.6231851463135, 888.404768804899, 871.6382701179003, 872.8036191856845, 878.5870640798814, 879.8284334554764, 880.0451510111504, 638.1512588257606, 640.8718256348702, 642.3961476212345, 643.8326035230874, 645.6255371884296, 15113.54659360221, 15195.544133676007, 15251.0, 16168.353265869351, 16329.18354082303, 14071.859281407158, 14245.358958846877, 14527.418903243857, 14612.70774584513, 14621.6344591385, 11912.583059592873, 12140.0, 12214.511419543296, 12228.816567751492, 12303.261804291682, 3718.3492888744363, 3721.832517536717, 3740.4950331705145, 3811.2187001664593, 3818.9045273868096, 63976.36023639751, 79809.60095199545, 80295.19704802935, 82078.58960705159, 82200.58899705463, 9929.553170107363, 10006.749831254278, 10011.79976400468, 10171.135453486537, 10258.333208341433, 18540.536486587942, 18557.814421855608, 18861.905690471733, 18975.71536426955, 19235.711464328047, 7914.802129946682, 8134.796630084177, 8204.179582041868, 8268.669253229924, 8508.361872859561, 4475.1049790042125, 4475.70907890986, 4583.427071616048, 4610.76946152691, 4615.0, 3631.1829838286176, 3720.6279372062577, 3726.5155529780955, 3727.5154229950476, 3732.8506859725308, 602.5179856115178, 627.6359711367396, 640.5900223856736, 647.582309410437, 654.4273760459598, 600.3126420248791, 642.7300533775825, 684.5858255755196, 703.6165289917008, 735.6170399648627, 8910.55447227636, 9503.192228660502, 9632.72487354303, 9815.558299876522, 10001.549930253155, 561.750021240544, 621.0994058615026, 621.8227805075531, 644.8420137066355, 716.6667499612705, 4504.864854054384, 4571.0, 4597.103564804831, 4597.678162528591, 4655.301704744315, 79881.60059199783, 80418.59790701009, 84492.15507844966, 85245.57377213199, 89381.0, 71760.64119679369, 74113.62943185249, 74620.0, 76599.0, 77904.22095779084, 65428.0, 65563.67218163879, 65966.34033659699, 67628.98556521656, 68891.31108689049, 8365.539895305817, 8389.454685445426, 8393.24460798531, 8434.662613495637, 8600.39797214214, 43551.78224108859, 44499.33251001173, 44524.55475445204, 45236.32145517754, 45309.54690453185, 51303.486965131364, 56292.0, 61087.0, 61501.69249153905, 61972.38027619846, 13041.543545975845, 13643.79534307006, 13687.11033782801, 13994.230317332644, 14020.0, 14390.352434140279, 15727.260918655926, 16036.518904432885, 16162.838371616133, 16212.675746484769, 14167.504137355143, 14432.567022989328, 14725.190114543375, 14932.925335373688, 15139.318730657367, 13968.30158492051, 14285.500007499688, 14490.565283041526, 14759.852401475848, 14873.107613543221, 14545.490907818175, 14898.553043408716, 14972.625684357978, 15216.0, 15905.284262207997, 10791.56833726642, 11118.722031949266, 11202.607908723156, 11247.943760281147, 11819.704507387383, 11740.295582265091, 11854.123075540141, 12006.63980080599, 12294.631161065183, 12295.815562766387], "value": 7323.1513072028465, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1516.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 113.0, 113.0, 112.0, 115.0, 114.0, 117.0, 114.0, 115.0, 115.0], "value": 113.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 121.0, 121.0, 168.0, 124.0, 122.0, 120.0, 121.0, 139.0, 126.0], "value": 130.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 164.0, 163.0, 163.0, 165.0, 168.0, 161.0, 162.0, 162.0], "value": 163.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 117.0, 77.0, 77.0, 77.0, 78.0, 91.0, 79.0], "value": 82.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 111.0, 85.0, 86.0, 85.0, 104.0, 86.0, 84.0, 115.0], "value": 92.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 118.0, 119.0, 121.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 150.0, 149.0, 148.0, 149.0, 150.0, 149.0, 149.0, 151.0], "value": 149.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 101.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0], "value": 96.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 53.0, 56.0, 55.0, 55.0, 61.0, 54.0, 55.0, 54.0], "value": 55.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 65.0, 65.0, 65.0, 67.0, 65.0, 65.0, 65.0, 65.0], "value": 65.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 82.0, 82.0, 82.0, 82.0, 81.0, 81.0, 81.0, 82.0], "value": 81.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 131.0, 126.0, 129.0, 128.0, 135.0, 131.0, 132.0, 181.0, 148.0], "value": 136.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 168.0, 165.0, 168.0, 162.0, 166.0, 163.0, 172.0, 170.0, 171.0], "value": 167.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 66.0, 64.0, 63.0, 63.0, 69.0, 61.0, 68.0, 62.0], "value": 64.4, "unit": "score"}]}]} 11:11:39 INFO - Return code: 0 11:11:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:11:39 ERROR - # TBPL SUCCESS # 11:11:39 INFO - Running post-action listener: _resource_record_post_action 11:11:39 INFO - [mozharness: 2016-12-22 19:11:39.800798Z] Finished run-tests step (success) 11:11:39 INFO - Running post-run listener: _resource_record_post_run 11:11:39 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 419430400; Read time: 44; Write time: 258548 11:11:39 INFO - TinderboxPrint: CPU usage
13.4% 11:11:39 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 44 11:11:39 INFO - TinderboxPrint: I/O write bytes / time
419,430,400 / 258,548 11:11:39 INFO - TinderboxPrint: CPU idle
8,238.3 (86.5%) 11:11:39 INFO - TinderboxPrint: CPU user
1,220.5 (12.8%) 11:11:39 INFO - TinderboxPrint: Swap in / out
0 / 0 11:11:39 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 106156032; Read time: 0; Write time: 83044 11:11:39 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 296538112; Read time: 44; Write time: 166428 11:11:40 INFO - Running post-run listener: _upload_blobber_files 11:11:40 INFO - Blob upload gear active. 11:11:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:11:40 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 11:11:40 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-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:11:40 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-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:11:40 INFO - (blobuploader) - INFO - Open directory for files ... 11:11:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:11:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:11:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:11:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:11:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:11:41 INFO - (blobuploader) - INFO - Done attempting. 11:11:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:11:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:11:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:11:46 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:11:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:11:46 INFO - (blobuploader) - INFO - Done attempting. 11:11:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:11:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:11:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:11:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:11:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:11:46 INFO - (blobuploader) - INFO - Done attempting. 11:11:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:11:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:11:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:11:47 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:11:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:11:47 INFO - (blobuploader) - INFO - Done attempting. 11:11:47 INFO - (blobuploader) - INFO - Iteration through files over. 11:11:47 INFO - Return code: 0 11:11:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:11:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:11:47 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/de903713f3fc43146b5e59a4ecf62014387d625aff1dcf8a39653340f66652864b83806c9b18fd76ee5bcaee410119ce5bd8041855b069f3e7cc84e4b05ca5f4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/41d0ef6aecaaa96db943dc75d5ba5a3817639f58a1d85e63b1d5b35cd1d20aecea21d2288a93a47268d0adc639de23bc134eab8a693755b39db9fd4736ae61d9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/48f2ec78374637a805372a9f1eface3da572166e3e15287c52de40e19f5d4c7e4c280b41c4d4105b8152654756c3e0ec7ea43c07d33e123cd058ef5a96949a3e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/714fec7ac8a3479ad3c58b2420638553cf2c20f7d7063c9194a7c1438145b336756c18f9124ea97883947af4cc1d1388f246219fa3988f14ca6035ed9e249d7f"} 11:11:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:11:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:11:47 INFO - Contents: 11:11:47 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/de903713f3fc43146b5e59a4ecf62014387d625aff1dcf8a39653340f66652864b83806c9b18fd76ee5bcaee410119ce5bd8041855b069f3e7cc84e4b05ca5f4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/41d0ef6aecaaa96db943dc75d5ba5a3817639f58a1d85e63b1d5b35cd1d20aecea21d2288a93a47268d0adc639de23bc134eab8a693755b39db9fd4736ae61d9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/48f2ec78374637a805372a9f1eface3da572166e3e15287c52de40e19f5d4c7e4c280b41c4d4105b8152654756c3e0ec7ea43c07d33e123cd058ef5a96949a3e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/714fec7ac8a3479ad3c58b2420638553cf2c20f7d7063c9194a7c1438145b336756c18f9124ea97883947af4cc1d1388f246219fa3988f14ca6035ed9e249d7f"} 11:11:47 INFO - Running post-run listener: copy_logs_to_upload_dir 11:11:47 INFO - Copying logs to upload dir... 11:11:47 INFO - mkdir: /builds/slave/test/build/upload/logs 11:11:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.529080 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-12-22 11:11:47.157575) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-22 11:11:47.160815) ========= 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=ed14279e38b05397cf4aa391000001a4-1482432498.779553-1395043814 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/de903713f3fc43146b5e59a4ecf62014387d625aff1dcf8a39653340f66652864b83806c9b18fd76ee5bcaee410119ce5bd8041855b069f3e7cc84e4b05ca5f4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/41d0ef6aecaaa96db943dc75d5ba5a3817639f58a1d85e63b1d5b35cd1d20aecea21d2288a93a47268d0adc639de23bc134eab8a693755b39db9fd4736ae61d9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/48f2ec78374637a805372a9f1eface3da572166e3e15287c52de40e19f5d4c7e4c280b41c4d4105b8152654756c3e0ec7ea43c07d33e123cd058ef5a96949a3e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/714fec7ac8a3479ad3c58b2420638553cf2c20f7d7063c9194a7c1438145b336756c18f9124ea97883947af4cc1d1388f246219fa3988f14ca6035ed9e249d7f"} build_url:https://queue.taskcluster.net/v1/task/U0aFhKocQV6ucuMXkQT56A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011180 build_url: 'https://queue.taskcluster.net/v1/task/U0aFhKocQV6ucuMXkQT56A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/de903713f3fc43146b5e59a4ecf62014387d625aff1dcf8a39653340f66652864b83806c9b18fd76ee5bcaee410119ce5bd8041855b069f3e7cc84e4b05ca5f4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/41d0ef6aecaaa96db943dc75d5ba5a3817639f58a1d85e63b1d5b35cd1d20aecea21d2288a93a47268d0adc639de23bc134eab8a693755b39db9fd4736ae61d9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/48f2ec78374637a805372a9f1eface3da572166e3e15287c52de40e19f5d4c7e4c280b41c4d4105b8152654756c3e0ec7ea43c07d33e123cd058ef5a96949a3e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/714fec7ac8a3479ad3c58b2420638553cf2c20f7d7063c9194a7c1438145b336756c18f9124ea97883947af4cc1d1388f246219fa3988f14ca6035ed9e249d7f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-22 11:11:47.195611) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 11:11:47.195992) ========= 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=ed14279e38b05397cf4aa391000001a4-1482432498.779553-1395043814 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004503 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 11:11:47.281296) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-22 11:11:47.281686) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-22 11:11:47.282053) ========= ========= Total master_lag: 0.20 =========