builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-023 starttime: 1483114478.59 results: success (0) buildid: 20161230070523 builduid: afb0b5352b8f4566975fca5d1460a192 revision: 21dc2d95071cb7712af8552e3880ec325b1069f1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-30 08:14:38.592106) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-30 08:14:38.592590) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-30 08:14:38.592869) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-30 08:14:38.607382) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-30 08:14:38.607724) ========= 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=6d15e502d8e29d5d2676d664000001c3-1483114478.357940-448592723 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-30 08:14:39-- 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% 42.6M=0s 2016-12-30 08:14:39 (42.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.117608 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-30 08:14:38.739473) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-30 08:14:38.739808) ========= 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=6d15e502d8e29d5d2676d664000001c3-1483114478.357940-448592723 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017036 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-30 08:14:38.789485) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-30 08:14:38.789856) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 21dc2d95071cb7712af8552e3880ec325b1069f1 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 21dc2d95071cb7712af8552e3880ec325b1069f1 --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=6d15e502d8e29d5d2676d664000001c3-1483114478.357940-448592723 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-30 08:14:39,238 truncating revision to first 12 chars 2016-12-30 08:14:39,238 Setting DEBUG logging. 2016-12-30 08:14:39,238 attempt 1/10 2016-12-30 08:14:39,238 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/21dc2d95071c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-30 08:14:39,767 unpacking tar archive at: mozilla-central-21dc2d95071c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.925757 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-30 08:14:39.729033) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-30 08:14:39.729363) ========= script_repo_revision: 21dc2d95071cb7712af8552e3880ec325b1069f1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-30 08:14:39.729836) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-30 08:14:39.730109) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-30 08:14:39.738421) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-12-30 08:14:39.738710) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d15e502d8e29d5d2676d664000001c3-1483114478.357940-448592723 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:14:40 INFO - MultiFileLogger online at 20161230 08:14:40 in /builds/slave/test 08:14:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 08:14:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:14:40 INFO - {'append_to_log': False, 08:14:40 INFO - 'base_work_dir': '/builds/slave/test', 08:14:40 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 08:14:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:14:40 INFO - 'branch': 'Firefox-Non-PGO', 08:14:40 INFO - 'buildbot_json_path': 'buildprops.json', 08:14:40 INFO - 'config_files': ('talos/linux_config.py',), 08:14:40 INFO - 'default_actions': ('clobber', 08:14:40 INFO - 'read-buildbot-config', 08:14:40 INFO - 'download-and-extract', 08:14:40 INFO - 'populate-webroot', 08:14:40 INFO - 'create-virtualenv', 08:14:40 INFO - 'install', 08:14:40 INFO - 'run-tests'), 08:14:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:14:40 INFO - 'download_minidump_stackwalk': True, 08:14:40 INFO - 'download_symbols': 'ondemand', 08:14:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:14:40 INFO - 'tooltool.py': '/tools/tooltool.py', 08:14:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:14:40 INFO - '/tools/misc-python/virtualenv.py')}, 08:14:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:14:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:14:40 INFO - 'installer_path': 'installer.exe', 08:14:40 INFO - 'log_level': 'info', 08:14:40 INFO - 'log_name': 'talos', 08:14:40 INFO - 'log_to_console': True, 08:14:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:14:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:14:40 INFO - 'opt_config_files': (), 08:14:40 INFO - 'pip_index': False, 08:14:40 INFO - 'sps_profile': False, 08:14:40 INFO - 'sps_profile_interval': 0, 08:14:40 INFO - 'suite': 'dromaeojs-e10s', 08:14:40 INFO - 'system_bits': '32', 08:14:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:14:40 INFO - 'title': 'talos-linux64-ix-023', 08:14:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:14:40 INFO - 'use_talos_json': True, 08:14:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:14:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:14:40 INFO - 'work_dir': 'build'} 08:14:40 INFO - [mozharness: 2016-12-30 16:14:40.300260Z] Running clobber step. 08:14:40 INFO - Running pre-action listener: _resource_record_pre_action 08:14:40 INFO - Running main action method: clobber 08:14:40 INFO - rmtree: /builds/slave/test/build 08:14:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:14:40 INFO - Running post-action listener: _resource_record_post_action 08:14:40 INFO - [mozharness: 2016-12-30 16:14:40.775012Z] Finished clobber step (success) 08:14:40 INFO - [mozharness: 2016-12-30 16:14:40.775114Z] Running read-buildbot-config step. 08:14:40 INFO - Running pre-action listener: _resource_record_pre_action 08:14:40 INFO - Running main action method: read_buildbot_config 08:14:40 INFO - Using buildbot properties: 08:14:40 INFO - { 08:14:40 INFO - "project": "", 08:14:40 INFO - "product": "firefox", 08:14:40 INFO - "script_repo_revision": "production", 08:14:40 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 08:14:40 INFO - "repository": "", 08:14:40 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 08:14:40 INFO - "buildid": "20161230070523", 08:14:40 INFO - "pgo_build": "False", 08:14:40 INFO - "basedir": "/builds/slave/test", 08:14:40 INFO - "buildnumber": 591, 08:14:40 INFO - "slavename": "talos-linux64-ix-023", 08:14:40 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:14:40 INFO - "platform": "ubuntu64_hw", 08:14:40 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 08:14:40 INFO - "branch": "mozilla-central", 08:14:40 INFO - "repo_path": "mozilla-central", 08:14:40 INFO - "revision": "21dc2d95071cb7712af8552e3880ec325b1069f1", 08:14:40 INFO - "stage_platform": "linux64", 08:14:40 INFO - "builduid": "afb0b5352b8f4566975fca5d1460a192", 08:14:40 INFO - "slavebuilddir": "test" 08:14:40 INFO - } 08:14:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/KH9bo90sSqKbbnytyS9ZfQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 08:14:40 INFO - Running post-action listener: _resource_record_post_action 08:14:40 INFO - [mozharness: 2016-12-30 16:14:40.777567Z] Finished read-buildbot-config step (success) 08:14:40 INFO - [mozharness: 2016-12-30 16:14:40.777654Z] Running download-and-extract step. 08:14:40 INFO - Running pre-action listener: _resource_record_pre_action 08:14:40 INFO - Running main action method: download_and_extract 08:14:40 INFO - mkdir: /builds/slave/test/build/tests 08:14:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:40 INFO - trying https://queue.taskcluster.net/v1/task/KH9bo90sSqKbbnytyS9ZfQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 08:14:40 INFO - Downloading https://queue.taskcluster.net/v1/task/KH9bo90sSqKbbnytyS9ZfQ/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 08:14:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KH9bo90sSqKbbnytyS9ZfQ/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 08:14:41 INFO - Downloaded 1361 bytes. 08:14:41 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 08:14:41 INFO - Using the following test package requirements: 08:14:41 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 08:14:41 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:14:41 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:14:41 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:14:41 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:14:41 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:14:41 INFO - u'jsshell-linux-x86_64.zip'], 08:14:41 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:14:41 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:14:41 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 08:14:41 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:14:41 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:14:41 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:14:41 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:14:41 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:14:41 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:14:41 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:14:41 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:14:41 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:14:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KH9bo90sSqKbbnytyS9ZfQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 08:14:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KH9bo90sSqKbbnytyS9ZfQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:14:41 INFO - Fetch https://queue.taskcluster.net/v1/task/KH9bo90sSqKbbnytyS9ZfQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 08:14:42 INFO - Expected file size: 20246017 08:14:42 INFO - Obtained file size: 20246017 08:14:46 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 08:14:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KH9bo90sSqKbbnytyS9ZfQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 08:14:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KH9bo90sSqKbbnytyS9ZfQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:14:46 INFO - Fetch https://queue.taskcluster.net/v1/task/KH9bo90sSqKbbnytyS9ZfQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 08:14:46 INFO - Expected file size: 20246017 08:14:46 INFO - Obtained file size: 20246017 08:14:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KH9bo90sSqKbbnytyS9ZfQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 08:14:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KH9bo90sSqKbbnytyS9ZfQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:14:51 INFO - Fetch https://queue.taskcluster.net/v1/task/KH9bo90sSqKbbnytyS9ZfQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 08:14:52 INFO - Expected file size: 14409776 08:14:52 INFO - Obtained file size: 14409776 08:14:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:52 INFO - trying https://queue.taskcluster.net/v1/task/KH9bo90sSqKbbnytyS9ZfQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 08:14:52 INFO - Downloading https://queue.taskcluster.net/v1/task/KH9bo90sSqKbbnytyS9ZfQ/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 08:14:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KH9bo90sSqKbbnytyS9ZfQ/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 08:14:53 INFO - Downloaded 55908198 bytes. 08:14:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KH9bo90sSqKbbnytyS9ZfQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 08:14:53 INFO - mkdir: /builds/slave/test/properties 08:14:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:14:53 INFO - Writing to file /builds/slave/test/properties/build_url 08:14:53 INFO - Contents: 08:14:53 INFO - build_url:https://queue.taskcluster.net/v1/task/KH9bo90sSqKbbnytyS9ZfQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 08:14:54 INFO - Running post-action listener: _resource_record_post_action 08:14:54 INFO - Running post-action listener: set_extra_try_arguments 08:14:54 INFO - [mozharness: 2016-12-30 16:14:54.044027Z] Finished download-and-extract step (success) 08:14:54 INFO - [mozharness: 2016-12-30 16:14:54.044256Z] Running populate-webroot step. 08:14:54 INFO - Running pre-action listener: _resource_record_pre_action 08:14:54 INFO - Running main action method: populate_webroot 08:14:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:14:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:14:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:14:54 INFO - '--tppagecycles', 08:14:54 INFO - '7'], 08:14:54 INFO - 'tests': ['tsvgm']}}, 08:14:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:14:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:14:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:14:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:14:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:14:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:14:54 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:14:54 INFO - 'talos_options': ['--disable-e10s'], 08:14:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:14:54 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:14:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:14:54 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:14:54 INFO - 'talos_options': ['--disable-e10s'], 08:14:54 INFO - 'tests': ['damp', 'tps']}, 08:14:54 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:14:54 INFO - 'tests': ['damp', 'tps']}, 08:14:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:14:54 INFO - 'tests': ['dromaeo_dom']}, 08:14:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:14:54 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:14:54 INFO - 'tests': ['basic_compositor_video']}, 08:14:54 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:14:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:14:54 INFO - 'tests': ['a11yr', 08:14:54 INFO - 'ts_paint', 08:14:54 INFO - 'tpaint', 08:14:54 INFO - 'sessionrestore', 08:14:54 INFO - 'sessionrestore_no_auto_restore', 08:14:54 INFO - 'tabpaint']}, 08:14:54 INFO - 'other-e10s': {'tests': ['a11yr', 08:14:54 INFO - 'ts_paint', 08:14:54 INFO - 'tpaint', 08:14:54 INFO - 'sessionrestore', 08:14:54 INFO - 'sessionrestore_no_auto_restore', 08:14:54 INFO - 'tabpaint']}, 08:14:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:14:54 INFO - 'ts_paint', 08:14:54 INFO - 'tpaint', 08:14:54 INFO - 'sessionrestore', 08:14:54 INFO - 'sessionrestore_no_auto_restore', 08:14:54 INFO - 'tabpaint']}, 08:14:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:14:54 INFO - 'ts_paint', 08:14:54 INFO - 'tpaint', 08:14:54 INFO - 'sessionrestore', 08:14:54 INFO - 'sessionrestore_no_auto_restore', 08:14:54 INFO - 'tabpaint']}, 08:14:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:14:54 INFO - 'tests': ['a11yr', 08:14:54 INFO - 'ts_paint', 08:14:54 INFO - 'tpaint', 08:14:54 INFO - 'sessionrestore', 08:14:54 INFO - 'sessionrestore_no_auto_restore', 08:14:54 INFO - 'tabpaint']}, 08:14:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:14:54 INFO - 'tests': ['a11yr', 08:14:54 INFO - 'ts_paint', 08:14:54 INFO - 'tpaint', 08:14:54 INFO - 'sessionrestore', 08:14:54 INFO - 'sessionrestore_no_auto_restore', 08:14:54 INFO - 'tabpaint']}, 08:14:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:14:54 INFO - 'tests': ['tsvgx', 08:14:54 INFO - 'tsvgr_opacity', 08:14:54 INFO - 'tart', 08:14:54 INFO - 'tscrollx', 08:14:54 INFO - 'cart', 08:14:54 INFO - 'tsvg_static']}, 08:14:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:14:54 INFO - 'tsvgr_opacity', 08:14:54 INFO - 'tart', 08:14:54 INFO - 'tscrollx', 08:14:54 INFO - 'cart', 08:14:54 INFO - 'tsvg_static']}, 08:14:54 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:14:54 INFO - 'talos_options': ['--disable-e10s'], 08:14:54 INFO - 'tests': ['tp5o']}, 08:14:54 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:14:54 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:14:54 INFO - 'talos_options': ['--disable-e10s', 08:14:54 INFO - '--xperf_path', 08:14:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:14:54 INFO - 'tests': ['tp5n']}, 08:14:54 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:14:54 INFO - 'talos_options': ['--xperf_path', 08:14:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:14:54 INFO - 'tests': ['tp5n']}}, 08:14:54 INFO - 'talos.zip': {'path': '', 08:14:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:14:54 INFO - Running post-action listener: _resource_record_post_action 08:14:54 INFO - [mozharness: 2016-12-30 16:14:54.065678Z] Finished populate-webroot step (success) 08:14:54 INFO - [mozharness: 2016-12-30 16:14:54.065767Z] Running create-virtualenv step. 08:14:54 INFO - Running pre-action listener: _resource_record_pre_action 08:14:54 INFO - Running main action method: create_virtualenv 08:14:54 INFO - Creating virtualenv /builds/slave/test/build/venv 08:14:54 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:14:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:14:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:14:54 INFO - Using real prefix '/usr' 08:14:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:14:54 INFO - Installing distribute.............................................................................................................................................................................................done. 08:14:56 INFO - Installing pip.................done. 08:14:56 INFO - Return code: 0 08:14:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:14:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:14:56 INFO - Reading from file tmpfile_stdout 08:14:56 INFO - Output received: 08:14:56 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 08:14:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:14:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:56 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 0x21ea1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x255c480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2559820>, '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 0x255a520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255a9b0>, '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': '6d15e502d8e29d5d2676d664000001c3-1483114478.357940-448592723', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:14:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:14:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:14:56 INFO - Using env: {'DISPLAY': ':0', 08:14:56 INFO - 'HOME': '/home/cltbld', 08:14:56 INFO - 'LANG': 'en_US.UTF-8', 08:14:56 INFO - 'LANGUAGE': 'en_US:en', 08:14:56 INFO - 'LOGNAME': 'cltbld', 08:14:56 INFO - 'MAIL': '/var/mail/cltbld', 08:14:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:56 INFO - 'MOZ_NO_REMOTE': '1', 08:14:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:56 INFO - 'NO_EM_RESTART': '1', 08:14:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:56 INFO - 'PWD': '/builds/slave/test', 08:14:56 INFO - 'SHELL': '/bin/bash', 08:14:56 INFO - 'SHLVL': '1', 08:14:56 INFO - 'TERM': 'linux', 08:14:56 INFO - 'TMOUT': '86400', 08:14:56 INFO - 'USER': 'cltbld', 08:14:56 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1483114478.357940-448592723', 08:14:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:56 INFO - '_': '/tools/buildbot/bin/python'} 08:14:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:57 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:14:57 INFO - Cleaning up... 08:14:57 INFO - Return code: 0 08:14:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:14:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x21ea1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x255c480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2559820>, '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 0x255a520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255a9b0>, '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': '6d15e502d8e29d5d2676d664000001c3-1483114478.357940-448592723', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:14:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:14:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:14:57 INFO - Using env: {'DISPLAY': ':0', 08:14:57 INFO - 'HOME': '/home/cltbld', 08:14:57 INFO - 'LANG': 'en_US.UTF-8', 08:14:57 INFO - 'LANGUAGE': 'en_US:en', 08:14:57 INFO - 'LOGNAME': 'cltbld', 08:14:57 INFO - 'MAIL': '/var/mail/cltbld', 08:14:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:57 INFO - 'MOZ_NO_REMOTE': '1', 08:14:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:57 INFO - 'NO_EM_RESTART': '1', 08:14:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:57 INFO - 'PWD': '/builds/slave/test', 08:14:57 INFO - 'SHELL': '/bin/bash', 08:14:57 INFO - 'SHLVL': '1', 08:14:57 INFO - 'TERM': 'linux', 08:14:57 INFO - 'TMOUT': '86400', 08:14:57 INFO - 'USER': 'cltbld', 08:14:57 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1483114478.357940-448592723', 08:14:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:57 INFO - '_': '/tools/buildbot/bin/python'} 08:14:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:57 INFO - Downloading/unpacking psutil>=3.1.1 08:14:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:14:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:14:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:14:59 INFO - Installing collected packages: psutil 08:14:59 INFO - Running setup.py install for psutil 08:14:59 INFO - building 'psutil._psutil_linux' extension 08:14:59 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:14:59 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:14:59 INFO - building 'psutil._psutil_posix' extension 08:14:59 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:14:59 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:14:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:14:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:14:59 INFO - Successfully installed psutil 08:14:59 INFO - Cleaning up... 08:14:59 INFO - Return code: 0 08:14:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:14:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:00 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 0x21ea1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x255c480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2559820>, '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 0x255a520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255a9b0>, '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': '6d15e502d8e29d5d2676d664000001c3-1483114478.357940-448592723', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:15:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:15:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:15:00 INFO - Using env: {'DISPLAY': ':0', 08:15:00 INFO - 'HOME': '/home/cltbld', 08:15:00 INFO - 'LANG': 'en_US.UTF-8', 08:15:00 INFO - 'LANGUAGE': 'en_US:en', 08:15:00 INFO - 'LOGNAME': 'cltbld', 08:15:00 INFO - 'MAIL': '/var/mail/cltbld', 08:15:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:00 INFO - 'MOZ_NO_REMOTE': '1', 08:15:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:15:00 INFO - 'NO_EM_RESTART': '1', 08:15:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:15:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:00 INFO - 'PWD': '/builds/slave/test', 08:15:00 INFO - 'SHELL': '/bin/bash', 08:15:00 INFO - 'SHLVL': '1', 08:15:00 INFO - 'TERM': 'linux', 08:15:00 INFO - 'TMOUT': '86400', 08:15:00 INFO - 'USER': 'cltbld', 08:15:00 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1483114478.357940-448592723', 08:15:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:00 INFO - '_': '/tools/buildbot/bin/python'} 08:15:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:15:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:15:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:15:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:15:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:15:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:15:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:15:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:15:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:15:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:15:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:15:02 INFO - Installing collected packages: mozsystemmonitor 08:15:02 INFO - Running setup.py install for mozsystemmonitor 08:15:02 INFO - Successfully installed mozsystemmonitor 08:15:02 INFO - Cleaning up... 08:15:02 INFO - Return code: 0 08:15:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:15:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:15:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:15:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:15:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:15:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:02 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 0x21ea1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x255c480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2559820>, '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 0x255a520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255a9b0>, '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': '6d15e502d8e29d5d2676d664000001c3-1483114478.357940-448592723', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:15:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:15:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:15:02 INFO - Using env: {'DISPLAY': ':0', 08:15:02 INFO - 'HOME': '/home/cltbld', 08:15:02 INFO - 'LANG': 'en_US.UTF-8', 08:15:02 INFO - 'LANGUAGE': 'en_US:en', 08:15:02 INFO - 'LOGNAME': 'cltbld', 08:15:02 INFO - 'MAIL': '/var/mail/cltbld', 08:15:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:02 INFO - 'MOZ_NO_REMOTE': '1', 08:15:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:15:02 INFO - 'NO_EM_RESTART': '1', 08:15:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:15:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:02 INFO - 'PWD': '/builds/slave/test', 08:15:02 INFO - 'SHELL': '/bin/bash', 08:15:02 INFO - 'SHLVL': '1', 08:15:02 INFO - 'TERM': 'linux', 08:15:02 INFO - 'TMOUT': '86400', 08:15:02 INFO - 'USER': 'cltbld', 08:15:02 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1483114478.357940-448592723', 08:15:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:02 INFO - '_': '/tools/buildbot/bin/python'} 08:15:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:15:02 INFO - Downloading/unpacking jsonschema==2.5.1 08:15:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:15:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:15:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:15:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:15:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:15:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:15:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:15:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:15:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:15:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:15:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:15:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:15:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:15:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:15:04 INFO - Downloading functools32-3.2.3-2.tar.gz 08:15:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:15:04 INFO - warning: no files found matching '*.txt' 08:15:04 INFO - no previously-included directories found matching 'build' 08:15:04 INFO - no previously-included directories found matching 'dist' 08:15:04 INFO - no previously-included directories found matching '.git*' 08:15:04 INFO - Installing collected packages: jsonschema, functools32 08:15:04 INFO - Running setup.py install for functools32 08:15:05 INFO - warning: no files found matching '*.txt' 08:15:05 INFO - no previously-included directories found matching 'build' 08:15:05 INFO - no previously-included directories found matching 'dist' 08:15:05 INFO - no previously-included directories found matching '.git*' 08:15:05 INFO - Successfully installed jsonschema functools32 08:15:05 INFO - Cleaning up... 08:15:05 INFO - Return code: 0 08:15:05 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:15:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:15:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:15:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:15:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:15:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:05 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 0x21ea1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x255c480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2559820>, '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 0x255a520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255a9b0>, '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': '6d15e502d8e29d5d2676d664000001c3-1483114478.357940-448592723', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:15:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:15:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:15:05 INFO - Using env: {'DISPLAY': ':0', 08:15:05 INFO - 'HOME': '/home/cltbld', 08:15:05 INFO - 'LANG': 'en_US.UTF-8', 08:15:05 INFO - 'LANGUAGE': 'en_US:en', 08:15:05 INFO - 'LOGNAME': 'cltbld', 08:15:05 INFO - 'MAIL': '/var/mail/cltbld', 08:15:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:05 INFO - 'MOZ_NO_REMOTE': '1', 08:15:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:15:05 INFO - 'NO_EM_RESTART': '1', 08:15:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:15:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:05 INFO - 'PWD': '/builds/slave/test', 08:15:05 INFO - 'SHELL': '/bin/bash', 08:15:05 INFO - 'SHLVL': '1', 08:15:05 INFO - 'TERM': 'linux', 08:15:05 INFO - 'TMOUT': '86400', 08:15:05 INFO - 'USER': 'cltbld', 08:15:05 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1483114478.357940-448592723', 08:15:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:05 INFO - '_': '/tools/buildbot/bin/python'} 08:15:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:15:05 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:15:05 INFO - Cleaning up... 08:15:05 INFO - Return code: 0 08:15:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:15:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:15:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:15:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:15:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:15:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:05 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 0x21ea1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x255c480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2559820>, '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 0x255a520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255a9b0>, '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': '6d15e502d8e29d5d2676d664000001c3-1483114478.357940-448592723', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:15:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:15:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:15:05 INFO - Using env: {'DISPLAY': ':0', 08:15:05 INFO - 'HOME': '/home/cltbld', 08:15:05 INFO - 'LANG': 'en_US.UTF-8', 08:15:05 INFO - 'LANGUAGE': 'en_US:en', 08:15:05 INFO - 'LOGNAME': 'cltbld', 08:15:05 INFO - 'MAIL': '/var/mail/cltbld', 08:15:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:05 INFO - 'MOZ_NO_REMOTE': '1', 08:15:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:15:05 INFO - 'NO_EM_RESTART': '1', 08:15:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:15:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:05 INFO - 'PWD': '/builds/slave/test', 08:15:05 INFO - 'SHELL': '/bin/bash', 08:15:05 INFO - 'SHLVL': '1', 08:15:05 INFO - 'TERM': 'linux', 08:15:05 INFO - 'TMOUT': '86400', 08:15:05 INFO - 'USER': 'cltbld', 08:15:05 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1483114478.357940-448592723', 08:15:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:05 INFO - '_': '/tools/buildbot/bin/python'} 08:15:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:15:05 INFO - Downloading/unpacking blobuploader==1.2.4 08:15:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:15:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:15:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:15:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:15:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:15:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:15:07 INFO - Downloading blobuploader-1.2.4.tar.gz 08:15:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:15:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:15:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:15:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:15:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:15:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:15:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:15:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:15:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:15:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:15:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:15:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:15:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:15:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:15:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:15:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:15:08 INFO - Downloading docopt-0.6.1.tar.gz 08:15:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:15:08 INFO - Installing collected packages: blobuploader, requests, docopt 08:15:08 INFO - Running setup.py install for blobuploader 08:15:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:15:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:15:08 INFO - Running setup.py install for requests 08:15:08 INFO - Running setup.py install for docopt 08:15:08 INFO - Successfully installed blobuploader requests docopt 08:15:08 INFO - Cleaning up... 08:15:09 INFO - Return code: 0 08:15:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:15: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')]} 08:15:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:15:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15: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')]} 08:15:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:15:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:09 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 0x21ea1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x255c480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2559820>, '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 0x255a520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255a9b0>, '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': '6d15e502d8e29d5d2676d664000001c3-1483114478.357940-448592723', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:15:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:15:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:15:09 INFO - Using env: {'DISPLAY': ':0', 08:15:09 INFO - 'HOME': '/home/cltbld', 08:15:09 INFO - 'LANG': 'en_US.UTF-8', 08:15:09 INFO - 'LANGUAGE': 'en_US:en', 08:15:09 INFO - 'LOGNAME': 'cltbld', 08:15:09 INFO - 'MAIL': '/var/mail/cltbld', 08:15:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:09 INFO - 'MOZ_NO_REMOTE': '1', 08:15:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:15:09 INFO - 'NO_EM_RESTART': '1', 08:15:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:15:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:09 INFO - 'PWD': '/builds/slave/test', 08:15:09 INFO - 'SHELL': '/bin/bash', 08:15:09 INFO - 'SHLVL': '1', 08:15:09 INFO - 'TERM': 'linux', 08:15:09 INFO - 'TMOUT': '86400', 08:15:09 INFO - 'USER': 'cltbld', 08:15:09 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1483114478.357940-448592723', 08:15:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:09 INFO - '_': '/tools/buildbot/bin/python'} 08:15:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:15:09 INFO - Running setup.py (path:/tmp/pip-Zvf1T2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:15:09 INFO - Running setup.py (path:/tmp/pip-UZg8Aq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:15:09 INFO - Running setup.py (path:/tmp/pip-FXJgE2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:15:09 INFO - Running setup.py (path:/tmp/pip-WZ55LB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:15:09 INFO - Running setup.py (path:/tmp/pip-jeBlLC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:15:09 INFO - Running setup.py (path:/tmp/pip-r292vN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:15:09 INFO - Running setup.py (path:/tmp/pip-lOtnAg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:15:09 INFO - Running setup.py (path:/tmp/pip-uZzKgF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:15:09 INFO - Running setup.py (path:/tmp/pip-ebxm7g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:15:09 INFO - Running setup.py (path:/tmp/pip-I3lOg_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:15:09 INFO - Running setup.py (path:/tmp/pip-qZlkbl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:15:10 INFO - Running setup.py (path:/tmp/pip-4Yqb3I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:15:10 INFO - Running setup.py (path:/tmp/pip-CDK18H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:15:10 INFO - Running setup.py (path:/tmp/pip-VL4h_j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:15:10 INFO - Running setup.py (path:/tmp/pip-D5pBE2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:15:10 INFO - Running setup.py (path:/tmp/pip-yFpIJy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:15:10 INFO - Running setup.py (path:/tmp/pip-OIz5pg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:15:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:15:10 INFO - Running setup.py install for manifestparser 08:15:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:15:10 INFO - Running setup.py install for mozcrash 08:15:10 INFO - Running setup.py install for mozdebug 08:15:10 INFO - Running setup.py install for mozdevice 08:15:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:15:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:15:10 INFO - Running setup.py install for mozfile 08:15:10 INFO - Running setup.py install for mozhttpd 08:15:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:15:11 INFO - Running setup.py install for mozinfo 08:15:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:15:11 INFO - Running setup.py install for mozInstall 08:15:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:15:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:15:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:15:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:15:11 INFO - Running setup.py install for mozleak 08:15:11 INFO - Running setup.py install for mozlog 08:15:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:15:11 INFO - Running setup.py install for moznetwork 08:15:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:15:11 INFO - Running setup.py install for mozprocess 08:15:11 INFO - Running setup.py install for mozprofile 08:15:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:15:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:15:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:15:11 INFO - Running setup.py install for mozrunner 08:15:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:15:11 INFO - Running setup.py install for mozscreenshot 08:15:12 INFO - Running setup.py install for moztest 08:15:12 INFO - Running setup.py install for mozversion 08:15:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:15:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:15:12 INFO - Cleaning up... 08:15:12 INFO - Return code: 0 08:15:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:15:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:15:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:15:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:15:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:15:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:12 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 0x21ea1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x255c480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2559820>, '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 0x255a520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255a9b0>, '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': '6d15e502d8e29d5d2676d664000001c3-1483114478.357940-448592723', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:15:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:15:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:15:12 INFO - Using env: {'DISPLAY': ':0', 08:15:12 INFO - 'HOME': '/home/cltbld', 08:15:12 INFO - 'LANG': 'en_US.UTF-8', 08:15:12 INFO - 'LANGUAGE': 'en_US:en', 08:15:12 INFO - 'LOGNAME': 'cltbld', 08:15:12 INFO - 'MAIL': '/var/mail/cltbld', 08:15:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:12 INFO - 'MOZ_NO_REMOTE': '1', 08:15:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:15:12 INFO - 'NO_EM_RESTART': '1', 08:15:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:15:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:12 INFO - 'PWD': '/builds/slave/test', 08:15:12 INFO - 'SHELL': '/bin/bash', 08:15:12 INFO - 'SHLVL': '1', 08:15:12 INFO - 'TERM': 'linux', 08:15:12 INFO - 'TMOUT': '86400', 08:15:12 INFO - 'USER': 'cltbld', 08:15:12 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1483114478.357940-448592723', 08:15:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:12 INFO - '_': '/tools/buildbot/bin/python'} 08:15:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:15:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:15:12 INFO - Running setup.py (path:/tmp/pip-dANaPP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:15:12 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:15:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:15:12 INFO - Running setup.py (path:/tmp/pip-J8YKfY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:15:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:15:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:15:12 INFO - Running setup.py (path:/tmp/pip-_B2WVR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:15:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:15:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:15:12 INFO - Running setup.py (path:/tmp/pip-FqFlRz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:15:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:15:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:15:12 INFO - Running setup.py (path:/tmp/pip-dvPqWV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:15:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:15:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:15:12 INFO - Running setup.py (path:/tmp/pip-s0Q91m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:15:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:15:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:15:12 INFO - Running setup.py (path:/tmp/pip-CJy9vA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:15:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:15:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:15:12 INFO - Running setup.py (path:/tmp/pip-MvMAhd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:15:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:15:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:15:13 INFO - Running setup.py (path:/tmp/pip-HCvPBN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:15:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:15:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:15:13 INFO - Running setup.py (path:/tmp/pip-atDk0d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:15:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:15:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:15:13 INFO - Running setup.py (path:/tmp/pip-I_9ABX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:15:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:15:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:15:13 INFO - Running setup.py (path:/tmp/pip-1E7i2t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:15:13 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)) 08:15:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:15:13 INFO - Running setup.py (path:/tmp/pip-45lcw2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:15:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:15:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:15:13 INFO - Running setup.py (path:/tmp/pip-GqGpo1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:15:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:15:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:15:13 INFO - Running setup.py (path:/tmp/pip-YelFg6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:15:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:15:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:15:13 INFO - Running setup.py (path:/tmp/pip-DCjvfD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:15:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:15:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:15:13 INFO - Running setup.py (path:/tmp/pip-5LsM4m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:15:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:15:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:15:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:15:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:15:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:15:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:15:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:15:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:15:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:15:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:15:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:15:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:15:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:15:15 INFO - Downloading blessings-1.6.tar.gz 08:15:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:15:15 INFO - Installing collected packages: blessings 08:15:15 INFO - Running setup.py install for blessings 08:15:15 INFO - Successfully installed blessings 08:15:15 INFO - Cleaning up... 08:15:15 INFO - Return code: 0 08:15:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:15:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:15:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:15:16 INFO - Reading from file tmpfile_stdout 08:15:16 INFO - Current package versions: 08:15:16 INFO - argparse == 1.2.1 08:15:16 INFO - blessings == 1.6 08:15:16 INFO - blobuploader == 1.2.4 08:15:16 INFO - docopt == 0.6.1 08:15:16 INFO - functools32 == 3.2.3-2 08:15:16 INFO - jsonschema == 2.5.1 08:15:16 INFO - manifestparser == 1.1 08:15:16 INFO - mozInstall == 1.12 08:15:16 INFO - mozcrash == 1.0 08:15:16 INFO - mozdebug == 0.1 08:15:16 INFO - mozdevice == 0.49 08:15:16 INFO - mozfile == 1.2 08:15:16 INFO - mozhttpd == 0.7 08:15:16 INFO - mozinfo == 0.9 08:15:16 INFO - mozleak == 0.1 08:15:16 INFO - mozlog == 3.4 08:15:16 INFO - moznetwork == 0.27 08:15:16 INFO - mozprocess == 0.23 08:15:16 INFO - mozprofile == 0.28 08:15:16 INFO - mozrunner == 6.13 08:15:16 INFO - mozscreenshot == 0.1 08:15:16 INFO - mozsystemmonitor == 0.3 08:15:16 INFO - moztest == 0.8 08:15:16 INFO - mozversion == 1.4 08:15:16 INFO - psutil == 3.1.1 08:15:16 INFO - requests == 1.2.3 08:15:16 INFO - wsgiref == 0.1.2 08:15:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:15:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:15:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:15:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:15:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:15:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:16 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 0x21ea1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x255c480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2559820>, '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 0x255a520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255a9b0>, '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': '6d15e502d8e29d5d2676d664000001c3-1483114478.357940-448592723', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:15:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:15:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:15:16 INFO - Using env: {'DISPLAY': ':0', 08:15:16 INFO - 'HOME': '/home/cltbld', 08:15:16 INFO - 'LANG': 'en_US.UTF-8', 08:15:16 INFO - 'LANGUAGE': 'en_US:en', 08:15:16 INFO - 'LOGNAME': 'cltbld', 08:15:16 INFO - 'MAIL': '/var/mail/cltbld', 08:15:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:16 INFO - 'MOZ_NO_REMOTE': '1', 08:15:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:15:16 INFO - 'NO_EM_RESTART': '1', 08:15:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:15:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:16 INFO - 'PWD': '/builds/slave/test', 08:15:16 INFO - 'SHELL': '/bin/bash', 08:15:16 INFO - 'SHLVL': '1', 08:15:16 INFO - 'TERM': 'linux', 08:15:16 INFO - 'TMOUT': '86400', 08:15:16 INFO - 'USER': 'cltbld', 08:15:16 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1483114478.357940-448592723', 08:15:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:16 INFO - '_': '/tools/buildbot/bin/python'} 08:15:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:15:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:15:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:15:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:15:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:15:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:15:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:15:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:15:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:15:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:15:16 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:15:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:15:16 INFO - Cleaning up... 08:15:16 INFO - Return code: 0 08:15:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:15:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:15:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:15:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:15:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:15:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21ea1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x255c480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2559820>, '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 0x255a520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255a9b0>, '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': '6d15e502d8e29d5d2676d664000001c3-1483114478.357940-448592723', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:15:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:15:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:15:16 INFO - Using env: {'DISPLAY': ':0', 08:15:16 INFO - 'HOME': '/home/cltbld', 08:15:16 INFO - 'LANG': 'en_US.UTF-8', 08:15:16 INFO - 'LANGUAGE': 'en_US:en', 08:15:16 INFO - 'LOGNAME': 'cltbld', 08:15:16 INFO - 'MAIL': '/var/mail/cltbld', 08:15:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:16 INFO - 'MOZ_NO_REMOTE': '1', 08:15:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:15:16 INFO - 'NO_EM_RESTART': '1', 08:15:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:15:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:16 INFO - 'PWD': '/builds/slave/test', 08:15:16 INFO - 'SHELL': '/bin/bash', 08:15:16 INFO - 'SHLVL': '1', 08:15:16 INFO - 'TERM': 'linux', 08:15:16 INFO - 'TMOUT': '86400', 08:15:16 INFO - 'USER': 'cltbld', 08:15:16 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1483114478.357940-448592723', 08:15:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:16 INFO - '_': '/tools/buildbot/bin/python'} 08:15:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:15:16 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:15:16 INFO - Cleaning up... 08:15:16 INFO - Return code: 0 08:15:16 INFO - Running post-action listener: _resource_record_post_action 08:15:16 INFO - Running post-action listener: _start_resource_monitoring 08:15:16 INFO - Starting resource monitoring. 08:15:16 INFO - [mozharness: 2016-12-30 16:15:16.686612Z] Finished create-virtualenv step (success) 08:15:16 INFO - [mozharness: 2016-12-30 16:15:16.687121Z] Running install step. 08:15:16 INFO - Running pre-action listener: _resource_record_pre_action 08:15:16 INFO - Running main action method: install 08:15:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:15:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:15:16 INFO - Reading from file tmpfile_stdout 08:15:16 INFO - Detecting whether we're running mozinstall >=1.0... 08:15:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:15:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:15:16 INFO - Reading from file tmpfile_stdout 08:15:16 INFO - Output received: 08:15:16 INFO - Usage: mozinstall [options] installer 08:15:16 INFO - Options: 08:15:16 INFO - -h, --help show this help message and exit 08:15:16 INFO - -d DEST, --destination=DEST 08:15:16 INFO - Directory to install application into. [default: 08:15:16 INFO - "/builds/slave/test"] 08:15:16 INFO - --app=APP Application being installed. [default: firefox] 08:15:16 INFO - mkdir: /builds/slave/test/build/application 08:15:16 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'] 08:15:16 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 08:15:33 INFO - Reading from file tmpfile_stdout 08:15:33 INFO - Output received: 08:15:33 INFO - /builds/slave/test/build/application/firefox/firefox 08:15:33 INFO - Running post-action listener: _resource_record_post_action 08:15:33 INFO - [mozharness: 2016-12-30 16:15:33.096100Z] Finished install step (success) 08:15:33 INFO - [mozharness: 2016-12-30 16:15:33.096345Z] Running run-tests step. 08:15:33 INFO - Running pre-action listener: _resource_record_pre_action 08:15:33 INFO - Running main action method: run_tests 08:15:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:15:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:15:33 INFO - Python 2.7.3 08:15:33 INFO - Return code: 0 08:15:33 INFO - grabbing minidump binary from tooltool 08:15:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:15:33 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 0x2559820>, '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 0x255a520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255a9b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:15:33 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:15:33 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:15:33 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:15:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:15:33 INFO - Return code: 0 08:15:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:15:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:15:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:15:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:15:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:15:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KH9bo90sSqKbbnytyS9ZfQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 08:15:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/KH9bo90sSqKbbnytyS9ZfQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-023 --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 08:15:33 INFO - Using env: {'DISPLAY': ':0', 08:15:33 INFO - 'HOME': '/home/cltbld', 08:15:33 INFO - 'LANG': 'en_US.UTF-8', 08:15:33 INFO - 'LANGUAGE': 'en_US:en', 08:15:33 INFO - 'LOGNAME': 'cltbld', 08:15:33 INFO - 'MAIL': '/var/mail/cltbld', 08:15:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:15:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:15:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:33 INFO - 'MOZ_NO_REMOTE': '1', 08:15:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:15:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:15:33 INFO - 'NO_EM_RESTART': '1', 08:15:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:15:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:33 INFO - 'PWD': '/builds/slave/test', 08:15:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:15:33 INFO - 'SHELL': '/bin/bash', 08:15:33 INFO - 'SHLVL': '1', 08:15:33 INFO - 'TERM': 'linux', 08:15:33 INFO - 'TMOUT': '86400', 08:15:33 INFO - 'USER': 'cltbld', 08:15:33 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1483114478.357940-448592723', 08:15:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:33 INFO - '_': '/tools/buildbot/bin/python'} 08:15:33 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KH9bo90sSqKbbnytyS9ZfQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 08:15:33 INFO - mozversion application_buildid: 20161230070523 08:15:33 INFO - mozversion application_changeset: 21dc2d95071cb7712af8552e3880ec325b1069f1 08:15:33 INFO - mozversion application_display_name: Nightly 08:15:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:15:33 INFO - mozversion application_name: Firefox 08:15:33 INFO - mozversion application_remotingname: firefox 08:15:33 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:15:33 INFO - mozversion application_vendor: Mozilla 08:15:33 INFO - mozversion application_version: 53.0a1 08:15:33 INFO - mozversion platform_buildid: 20161230070523 08:15:33 INFO - mozversion platform_changeset: 21dc2d95071cb7712af8552e3880ec325b1069f1 08:15:33 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:15:33 INFO - mozversion platform_version: 53.0a1 08:15:33 INFO - using testdate: 1483114533 08:15:33 INFO - actual date: 1483114533 08:15:33 INFO - starting webserver on 'localhost:36430' 08:15:33 INFO - SUITE-START | Running 2 tests 08:15:33 INFO - TEST-START | dromaeo_css 08:15:33 INFO - operating with platform_type : linux_ 08:15:33 INFO - Initialising browser for dromaeo_css test... 08:15:33 INFO - TEST-INFO | started process 30256 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvp7MWM/profile http://localhost:36430/getInfo.html) 08:15:33 INFO - PROCESS | 30256 | 1483114533921 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:4986 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2097 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3827 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2831 < 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 08:15:38 INFO - PROCESS | 30256 | __metrics Screen width/height:1600/1200 08:15:38 INFO - PROCESS | 30256 | colorDepth:24 08:15:38 INFO - PROCESS | 30256 | Browser inner width/height: 1024/697 08:15:38 INFO - PROCESS | 30256 | __metrics 08:15:38 ERROR - PROCESS | 30256 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3256: TypeError: this.tabs is undefined 08:15:39 INFO - TEST-INFO | 30256: exit 0 08:15:39 INFO - Browser initialized. 08:15:39 INFO - Running cycle 1/1 for dromaeo_css test... 08:15:39 INFO - TEST-INFO | started process 30380 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvp7MWM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:15:52 INFO - PROCESS | 30380 | RSS: Main: 158715904 08:15:52 INFO - PROCESS | 30380 | 08:16:41 INFO - PROCESS | 30380 | 1483114601614 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] 08:18:55 INFO - PROCESS | 30380 | Cycle 1(1): loaded http://localhost:36430/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36430/tests/dromaeo/cssquery-ext.html) 08:18:56 INFO - PROCESS | 30380 | RSS: Main: 167288832 08:18:56 INFO - PROCESS | 30380 | 08:20:40 INFO - PROCESS | 30380 | ************************* 08:20:40 INFO - PROCESS | 30380 | A coding exception was thrown and uncaught in a Task. 08:20:40 INFO - PROCESS | 30380 | 08:20:40 INFO - PROCESS | 30380 | Full message: ReferenceError: fetch is not defined 08:20:40 INFO - PROCESS | 30380 | Full stack: apiCall@resource://shield-recipe-client/lib/NormandyApi.jsm:37:5 08:20:40 INFO - PROCESS | 30380 | get@resource://shield-recipe-client/lib/NormandyApi.jsm:44:12 08:20:40 INFO - PROCESS | 30380 | this.NormandyApi.fetchRecipes<@resource://shield-recipe-client/lib/NormandyApi.jsm:52:34 08:20:40 INFO - PROCESS | 30380 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 08:20:40 INFO - PROCESS | 30380 | TaskImpl@resource://gre/modules/Task.jsm:277:3 08:20:40 INFO - PROCESS | 30380 | asyncFunction@resource://gre/modules/Task.jsm:252:14 08:20:40 INFO - PROCESS | 30380 | this.RecipeRunner.start<@resource://shield-recipe-client/lib/RecipeRunner.jsm:64:23 08:20:40 INFO - PROCESS | 30380 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 08:20:40 INFO - PROCESS | 30380 | TaskImpl@resource://gre/modules/Task.jsm:277:3 08:20:40 INFO - PROCESS | 30380 | asyncFunction@resource://gre/modules/Task.jsm:252:14 08:20:40 INFO - PROCESS | 30380 | setTimeout_timer@resource://gre/modules/Timer.jsm:30:5 08:20:40 INFO - PROCESS | 30380 | 08:20:40 INFO - PROCESS | 30380 | ************************* 08:21:59 INFO - PROCESS | 30380 | Cycle 1(1): loaded http://localhost:36430/tests/dromaeo/cssquery-ext.html (next: http://localhost:36430/tests/dromaeo/cssquery-jquery.html) 08:21:59 INFO - PROCESS | 30380 | RSS: Main: 162824192 08:22:00 INFO - PROCESS | 30380 | 08:25:02 INFO - PROCESS | 30380 | Cycle 1(1): loaded http://localhost:36430/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36430/tests/dromaeo/cssquery-mootools.html) 08:25:02 INFO - PROCESS | 30380 | RSS: Main: 168083456 08:25:02 INFO - PROCESS | 30380 | 08:28:05 INFO - PROCESS | 30380 | Cycle 1(1): loaded http://localhost:36430/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36430/tests/dromaeo/cssquery-prototype.html) 08:28:05 INFO - PROCESS | 30380 | RSS: Main: 164356096 08:28:05 INFO - PROCESS | 30380 | 08:31:08 INFO - PROCESS | 30380 | Cycle 1(1): loaded http://localhost:36430/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36430/tests/dromaeo/cssquery-yui.html) 08:31:09 INFO - PROCESS | 30380 | RSS: Main: 166199296 08:31:09 INFO - PROCESS | 30380 | 08:34:12 INFO - PROCESS | 30380 | Cycle 1(1): loaded http://localhost:36430/tests/dromaeo/cssquery-yui.html (next: http://localhost:36430/tests/dromaeo/cssquery-dojo.html) 08:34:12 INFO - PROCESS | 30380 | RSS: Main: 166625280 08:34:12 INFO - PROCESS | 30380 | 08:34:12 INFO - PROCESS | 30380 | __start_tp_report 08:34:12 INFO - PROCESS | 30380 | _x_x_mozilla_page_load 08:34:12 INFO - PROCESS | 30380 | _x_x_mozilla_page_load_details 08:34:12 INFO - PROCESS | 30380 | |i|pagename|runs| 08:34:12 INFO - PROCESS | 30380 | |0;dojo.html;2610.3865591585977;2623.895044198232;2635.3806855388966;2652.681678198616;2668.0528412413605;4778.068276686047;4880.097182021329;4881.609471242301;4886.438059623144;4915.5821755150855;4770.0698363819065;4785.042991401725;4805.135075686375;4827.131116399047;4866.977934633731;4454.35411865281;4455.220336441118;4522.186006518842;4531.614812740921;4594.127115847995;4491.640668746492;4535.931961020588;4577.977110114445;4610.193216187171;4617.46899106602;4553.066621342617;4557.156925968707;4606.723596584199;4613.423322084739;4634.953650463486;4368.7815609219415;4388.5830846069575;4442.044960333512;4442.644588432918;4459.241928872099;4377.715448495869;4411.205982923073;4423.6903416760515;4447.599716025573;4478.507364189936;4742.928856067162;4743.241081426955;4780.402449693788;4789.928151077736;4821.927671084936;5047.64666473347;5083.085044691954;5091.134507133796;5141.126008578551;5191.662541934762;5221.112410890158;5228;5230.581553475751;5243.606729495303;5270.39390470097;4867.367242258484;4875.561199492063;4884.266085539653;4887.608991280689;4918.1884988977135;5183.403908550489;5235.712035838065;5346.449529636439;5352.437994010651;5354.277172581652;5035.093683137071;5063.012712521023;5070.645054846199;5109.463506331856;5156.819511317086;5162.74186290684;5170.741462926839;5175.120229560984;5180.663256888291;5188.610854185951;5025.874353141201;5087.567556757717;5128.615353848476;5139.074966506065;5191.091558977164;5090.77091530882;5143.459936706667;5151.7166555839785;5216.426193118754;5220.399654039834;4181.937270940938;4188.6230239278;4207.326827707613;4232.132412855357;4282.785860707015;3702.777833330009;3703.166787472851;3703.5740889798017;3714.0157858167067;3735.75717578362;4404.031113155101;4581.015081757439;4597.195490789165;4603.608693261111;4605.286180642006;5071.46749591295;5163.922541161885;5221.086309895829;5234.816781412708;5278.155495120763;4541.318802179633;4552.795124219418;4561.771911404417;4568.840090596813;4581.885452863638;4647.930281045787;4648.418947631546;4663.090697314059;4672.392588963481;4702.6473014524045;4795.520447955247;4827.106985207748;4855.150348688895;4855.174620314484;4864.978354545444;5173.0688476074665;5180.430152683277;5185.766640501111;5186.066508028591;5233.162693968947;4867.756612169448;4873.171560834738;4882.048000639841;4897;4935.062338155739;5017.598592112695;5018.42288136869;5058.772355243949;5080.771365288497;5091.1854103343285;5083.906960003617;5154.304168937296;5158.252053452304;5164.767585458589;5190.247414124855;4864.1001414736975;4931.675233077398;4948.604111671129;4949.901001980013;4980.576650984707;4876.4392094909535;4887.047025829929;4889.119958407378;4896.510348965075;5016.021875734197;4828.2998965150555;4828.903421931472;4830.3237546742785;4847.103285892122;4911.68074075184;4931.654784165074;4953.2570114483115;4965.627577931742;4970.3290055842;5022.874428139326;4803.543663351976;4822.855314340575;4829.66192366531;4845.224764037737;4864.464908860094 08:34:12 INFO - PROCESS | 30380 | |1;ext.html;514.1516497778665;519.0889988070936;523.4320761973258;531.5508395405881;536.9301990741205;36990.26019479612;38794;38943.415848762255;38950.610493895125;38998.220035599305;39319.80340098296;39536.209275814464;39567;39650.40524392136;39688;7591.8861217081785;7753.340966017867;7762.262585054411;9357.67248146315;9695.03049695032;9424.387414818015;9492.52537373132;9540.666076687317;9542.284328675378;9545.04549545047;9506.429614223169;9518.524073796318;9565.617375305013;9570.712878613618;9578.760530986747;9445.622175112987;9479.431234125974;9497.620095196218;9502.47736374499;9558.761030974212;9202.125798049176;9205.861912071325;9265.629374825;9282.860757088649;9287.58205880737;33145;33183.502247466306;33256.833715831504;33413.498797518056;33500.49749253763;3472.6700963408434;3477;3516.0682419158943;3524.8061356625376;3531.7527773055895;25703.357416064562;25825.741742582522;26180;26223.21330360092;26361.73638263612;3270.771046026779;3341.365140623274;3389.644087370815;3398.762086653935;3401.064707205538;236909.2318076151;237126;238355.80822095953;238932;239363;46495.767521162175;46553.53446465492;46837.76581117073;46924;46979;47754.5224547757;47872.521274787505;47893.5210647896;48112.518874810805;48291.51708482941;12969.675758105934;13180.406881690347;13229.669258268621;13256.867431325563;13257.07200495956;8969.327300452493;9148.72553823373;10689.732756681145;11045.723856903482;11069.778604427866;15311.234438278041;15343.92328038375;15379.154146521825;15507;15537.30082146306;6417.807465776034;6446.161998940202;6490.545661803723;6547.5416720830035;6640.9667951660895;769.3921801776534;782.8903953446522;790.2413682864515;802.1176705623767;808.4179390838586;27711;27876.581851272247;28178.85910570434;28416.289592760346;28545.28636784097;942.7548837302351;981.9705408837747;993.7714325705128;996.8604395384652;1004.2167109654481;14153.57800709067;14563.635909102146;14584;14778.778318325234;14836.480723174636;348166;351146;351276;352132;352356;49461.75269123631;49907.500924991014;50053;50117;50327.496725033016;1146.4439746722833;1196.8384268123866;1216.823560583728;1217.8843009914044;1218.3055658274875;25654.61518077193;26277.211683649522;27229;27652.44695106127;27707.307317317227;40315;41169.58830411777;41232.38151427671;41241.38137927873;41246;245044;245140;245224;245535;245750;22239;22901;24034;24344;24810.627840582045;40422.1915561693;40685;40783.1843363137;41701.58298416977;41953.79023104987;34451.310973780885;34699.30601388009;34787.30425391529;34822.30355392827;35026.299474010884;34284;34831.65168348284;34976.65023349734;35294.294114118085;35523.46714799228;33253;33836.661633384334;34310.82844585761;34383.31233375368;34689.30621387609;27197.144299849024;29787;30046.399072018;31786.810389998696;32228;22422.32733018012;22563.43591410228;22960.885195573916;23075.88462057679;23143.884280578488 08:34:12 INFO - PROCESS | 30380 | |2;jquery.html;363.69994754327683;364.2423758582149;375.7520036775729;383.8829157107081;384.5078299776287;15719.13544755038;16657.167141642916;16681.16594170291;16760.078195699232;16767.748483772724;16022.35910563579;16121.516354509384;16190.271437785299;16259.756103658454;16462;4832.106060378841;5156.664816786897;5169.30214421054;5170.586353091744;5177.430482646906;5017.573506251973;5087.974560127194;5317.202419637047;5342.171963345688;5446.101393270105;5418.83743487696;5419;5429.67421954684;5432.91850622241;5444.1561557958385;5346.492083252085;5381.058314794915;5476.0416927038;5490.6431081979745;5520.613557051008;5312.415634280226;5320.760565774511;5331.067063263952;5334.5732341412595;5338.733063346817;12039.63881083569;17845.821541784677;18305.7254141188;19837;19937.10283037252;2052.9486762831048;2094.3088780702333;2113.1019316790303;2143.164165975271;2174.3150907464096;8449.746507604781;8900.599473023729;9034.774130646721;9284.814303713956;9384.953075234649;1691.8139004709594;1726.8273172682757;1754.23690694547;1765.4527096600095;1784.9107544622848;63035.684821576055;63050;63193.368066319206;63642.36357636411;65076.67461662662;9954.751131221778;10070.676676696672;10135.64525241613;10193.745156371002;10241.84637230442;13638.931805341108;13640.65898352549;13732.107413018122;13734.381952812148;13763.587092387244;7106.644667766591;7144.571325720473;7261.128664560287;7336.193018767931;7344.596047217347;6704.229013663394;6756.560823546453;6801.795946121624;6982.581045137308;6990.930090699129;4291.656667466657;4326.762028088422;4370.453693288339;4378.146261478981;4501.459824820977;1554.6502037041575;1622.813376461722;1800.2438975630266;1846.1138653446421;1879.7086451600023;775.4649291988623;799.9800004999805;806.7136166660869;807.6486728273103;811.3995643223972;15733.68532629341;15789;15990.440334588233;16010.679786404207;16307.918460407622;816.3346872299057;825.6738588257605;853.8633818588996;854.786303424144;856.8928883889514;9046.321525885585;9057.77355566116;9126.81746365069;9152.588133534007;9226.90773092274;342813;344062;346356;352894;355717;76139.61930190313;76812.61593691996;76872;77169.61415193;77522;411.80233487925364;430.4683715611218;431.5231669005766;432.8831215571715;436.9388285640013;9177.311701622539;14161.787573186617;14818.555443336718;15128.621784455476;15510.84489155139;34928.30143397067;35345.823270883484;35889.46165807567;35974;36199.45700814542;46307.76846115748;46362.76818615885;46441.303380449994;46517.302240465746;48783.268250975554;6988.475864310299;7097.680604372919;7129.429645628234;7374.705011799682;7933.206679332021;10641.680749577525;11069.114470842153;11123.165762567678;11128.939028522635;11211.271267367594;9574.90425095768;9719.562619682272;9801.411915285105;9937.850932236166;10072.244581656552;8908.510031948046;9664.516774161124;9672.77526168999;9821.705348839547;10157.9492102539;9787.706368808947;9855.556499957376;10007.399556026661;10145.54345054489;10153.238507112144;7276.563406195645;7305.379042781423;7367.042284503194;7373.668184931798;7388.408927285912;9088.545572721205;9732.12410883024;9783.217342612716;9850.852237216592;10143.239257055899 08:34:12 INFO - PROCESS | 30380 | |3;mootools.html;1283.6149155253422;1320.1023304153177;1325.7149712811743;1330.3148878327663;1337.0707358385919;6598.472122230222;6848.96575517123;6862.656867156641;7246.710131594737;7269.055022847036;7154.892676609855;7300.7079716811395;7343;7478.326950574447;7517.812054698636;2055.188200660738;2105.978940210601;2107.399391173516;2108.156737305075;2109.651907435279;2024.8886311252875;2074.1081335025933;2102.054075665949;2104.1793700456833;2156.1159924430985;2130.8614940028924;2153.5800518898823;2156.892155392232;2161.502854343502;2164.751053628837;2031.5632139090167;2050.76416212136;2053.8048885355865;2054.075665950321;2060.042080432606;2020.6261841559358;2021.777604463508;2051.323063389078;2054.311805545144;2058.6706127019606;7359.963200184018;7397.2602739726135;7485.925140748632;7494.250574942516;7505.399568034544;4406.867793966187;4530.501644819067;4531.093781243764;4531.3203019547;4539.977300113512;2733.289344770354;2927.634045744282;2965.8665360058635;3006.068118883153;3009.4432529982023;1140.8591408591408;1149.002208471776;1159.09590519395;1159.9536018559247;1178.3872386359046;9646.276529260334;9795.21638268944;9828.754281142958;9897.4556399398;9920.603175872957;3851.980740096282;4030.7581545107387;4037.6164264394833;4102.733322334038;4125.64931980785;7283.344498995116;7470.4770666052855;8308.5430301334;8345.54099524532;8347.373946954003;4305.892352691145;4446.5331140230455;4452.5547445255215;4458;4460.531644177379;4144.5026596808575;4147.0461793787;4148.170365926827;4149.8340066397;4150.3566947123245;3206.551082848403;3241.222106694376;3258.446064169097;3296.8021918684954;3327.05179023977;1036.3988886445843;1037.8598889149869;1051.2903789941759;1053.214800912446;1057.1120258982492;768.1972338905857;779.0806847919396;785.1873311123074;787.2167193642363;793.3375631347889;4442.400275962704;4468.597826195658;4504.864854054384;4784.952150478521;4816.54242846929;784.5407541971928;813.3493205435627;821.195228675889;827.6234313387515;828.0436096308773;2914.7668186545025;2945.73488386042;3035.6964303569466;3116.7194952453933;3179.8410079495934;8555.957220213859;8831.116888311117;8837.64649414029;8880.8667869982;8896.686861415948;8819.29445644347;8827.029026807046;8838.690645827364;8849.955750221336;8853.601587928559;6570.277269500351;6663.6001839888795;6703.430208432241;6713.865722685519;6721.966390168018;4544.954550454453;4548.954510454985;4588.9541104588525;4654.975905300828;4662.160811054043;7849.332806711265;7999.280064794197;8014.158513356014;8113.797155071171;8155.347572194091;8114.675412983414;8186.836263274582;8227.300679442074;8240.958795206225;8257.669693212445;6169.537284703755;6290.370962903856;6294.8111556653375;6688.063671086149;6897.068895699016;6812.65936703153;7128.643567821692;7129.3583577478275;7134.536255143399;7137.10786151731;6082.60463069899;6358.936410635834;6381.138546296376;6435.4529864962005;6457.3865482779065;6073.180120683651;6172.506199503939;6208.286047104641;6317.115603815378;6414.711337989895;5117.565006974449;5188;5192.948070519397;5371.892562148657;5459.69971651563;4078.490188726409;4088.713790034669;4120.793960301913;4182.832686692498;4219.6202341789385;4062.720243123407;4078.1843631274455;4108.383742438658;4161.10536234711;4266.104118135227 08:34:12 INFO - PROCESS | 30380 | |4;prototype.html;321.67832167832165;340.8789879592743;346.4076429305885;349.8773446985653;351.9243362677025;4833.589144922686;4881.341018962439;4940.975295123524;5029.119904016796;5036.370453693288;4788.233882578788;4867.780949857256;4879.341288925994;4908.852734417973;4928.482509336522;3901.7463864848837;3907.433422153786;3922.7450215735957;3933.4689816874784;3940.3104456720102;3870.3033453978273;3927.4108883667536;3960.4455376247347;3967.2660557796758;3983.8406463741417;3891.3773796192613;3903.2193561287713;3904.4338570907203;3907.9839241797195;3908.3160446921815;3879.3405121129476;3887.7364856421777;3893.4549163117185;3896.2597106549665;3916.2559113768293;3488.4418493040994;3493.3013397320383;3495.755297129202;3500.6149323574386;3503.7197024238;4638.188317044537;4764.737939413331;4796.184648609745;4820.542048505386;4835.975820120877;4426.800793964279;4444.422225110748;4449.888752781174;4460.8661740147845;4463.076684771479;5155.871103222449;5158.0199762045095;5165.431802501722;5188.844334669966;5203.412959047489;3718.4236443351324;3724.571674257468;3758.624137586247;3762.3415902217275;3786.5077539919635;5349.839504814861;5360.463953604647;5364.651297665679;5383.2194331821665;5386.569074474072;3851.8844434667003;3864.845406183721;3872.6901847852105;3877.5540812806325;3893.5133108361456;3924.274009308287;3932.980335098306;3943.3493473576536;3946.5856085111222;3947.8420863165725;4333.523312435629;4389.18800021997;4417.425734654538;4431.224535706238;4449.555044495524;5121.308623335876;5167.767450464738;5183.81856635016;5192.221166825007;5195.168772996378;1216.5073145376136;1227.8281040654315;1235.1292338901053;1369.9931500342434;1387.5837248825312;852.8422241885271;860.5009094725044;876.145757886056;882.849915514364;886.8093359927517;4403.4495688039;4441.644668426518;4491.258942274553;4504.166729155117;4511.593956543927;5122.232829673757;5125.897482050338;5131.461196574381;5145.147746811145;5149.2276158576515;4473.575010374009;4473.6868419211;4497;4506.571875671806;4524.5701658342405;2628.7108418073994;2658.3752818087733;2678.598210268475;2706.9458610827674;2720.1975417251956;4759.428868535798;4772.809087636456;4796.9760151199025;4863.513648635179;4889.58202121388;5067.239914012927;5192.324997750268;5261.4738526147075;5289.920651190235;5301.708406037705;4821.228603423366;4822.00922045681;4831.565159135695;4836.46798852126;4848.3757941089425;5119.692818430906;5125.846224613268;5127.897502036931;5135.972805439002;5170.224466330081;4930.5069493050405;5044.913718383112;5091.490850915027;5127.667016439195;5129.076766181974;4845.5881250092725;4867.14824905633;4880.6583539153335;4897.8285759998225;4911.778969946289;3576.088097535216;3611.9097022573596;3614.6023937366344;3672.614375490642;3675.632436756303;4990.50094990498;5131.717755523482;5140.3831540215415;5141.38303403594;5161.66449180802;5084.2627818966785;5120.231965205249;5123.692578445305;5145.305383773143;5150.175971844487;5127.6410651254055;5133.332666753298;5145.202493613496;5149.2276158576515;5189.974050129726;4894.241392584155;5046.243063540498;5070.8225212117395;5085.542301192911;5090.41460232078;5136.203888397305;5138.409082955508;5140.922886156636;5144.382674078985;5156.587473002076;5030.522100400456;5033.169527028;5034.043531728959;5035.748212589429;5052.747362631927 08:34:12 INFO - PROCESS | 30380 | |5;yui.html;647.9125318082057;668.7024274197978;720.1502227371702;744.9292317229863;761.7105499910033;12555.686107847298;13659.248741319223;13696.657583560416;13797.37911793968;13870.861291387084;12523;12527.123101382907;12533.310667913283;12541.247525148474;12912.354382280895;799.3165843204049;813.2396209544095;813.3290035720554;819.1562690428838;820.2535692519808;816.6080281464871;819.6803246733779;820.5815034332473;825.1212458731462;825.686239229092;851.2551517422255;856.3791251342789;856.824351008045;856.9100244474334;858.8368210040072;852.9829403411959;855.0210009539043;855.0338117926734;855.6149732620346;855.8716192571102;626.9686515674243;627.5575719118057;628.8207860759708;628.9088082228051;629.0878226571444;10902.345859248391;11031.669049928514;11045.447727613588;12407;12820.23078615286;12388.513378394651;12838.871611283954;12922.935385323013;13018.86981130186;13080.607581772561;10166.13587845034;10394.896051039468;10431;10690.198235132397;10693.893061069368;3192.8563214655396;3237.75716821237;3249.723773479257;3251.64231934487;3257.5276584895296;47741.761291193325;47750.28374574384;61081;61094;62914.37085629131;9013.864792028126;9154.267658587298;9307.953460232791;9394.248460123174;9524.188890437897;17397.739033914502;17434.56413589645;17435.389761358547;17481.912590436965;17574.38489652856;6301.180846489927;6341.682915854189;6523.934760652332;6641.535092543572;6653.168353955755;3342.565466489341;3374.9493757593655;3482.529858469125;3514.5958214805114;3566.3402270580027;2824.5480723084206;2900.6084178635615;2904.8547572621283;2918.8248705077763;2945.558166275076;485.43204450792655;486.37986567127194;491.0792264504055;491.1723745488863;497.37330962986175;628.5694299404922;643.3887806583764;646.802725168828;650.2067477677226;651.6839332923528;7871.842563148705;8075.704759394715;8460.788480288042;8468.153184681483;8551.444156129832;456.0764451984691;463.7797046402932;470.61409644091515;476.3022172517279;480.0686667864332;3773.603771603997;3822.2164456286396;3838.8848334550007;3909.8045097745;4008.3386241270446;65000;65913.34086659168;67824;68589;69408;47193.5280647196;57938.420615794144;58360;59017.704911475164;59380;51249.23126153111;51288;51925.22112168321;52980.47019529832;54155.72922135364;7585.962070189614;7597.88603170964;7621.275978782007;7690.115636701851;7806.41451891099;36798.26403471862;37281.440778387805;38376.616233838424;39124.82625521239;39518.802405987786;42748;45264;46068;46553.30170047384;47176;9510.09654082861;9556.259509615402;9607.51962401891;9672.468014259282;9966.950165249127;10530.631427899987;10801.783964320512;10875.619353322596;10941.671749847517;11137.83293250618;10009.74975625586;10543.841842372523;10614.73463163427;11103.888961110286;11107.777844442904;9861.704148875546;10028.348157369748;10054.798904022025;10066.29535932507;10135.391876487434;9243.815123697354;9435.245180385415;9461.432314061178;9475.715728528156;9502.334836561375;8794.164554367326;8932;9064.138906803842;9066.959934015058;9103.726888193365;8523.360747944052;8724.607392667218;8732.476051436934;8795.47227166372;8845.380823342304 08:34:12 INFO - PROCESS | 30380 | __end_tp_report 08:34:12 INFO - PROCESS | 30380 | __start_cc_report 08:34:12 INFO - PROCESS | 30380 | _x_x_mozilla_cycle_collect,339 08:34:12 INFO - PROCESS | 30380 | __end_cc_report 08:34:12 INFO - PROCESS | 30380 | __startTimestamp1483115652261__endTimestamp 08:34:12 INFO - PROCESS | 30380 | 08:34:12 INFO - PROCESS | 30380 | ------- Summary: start ------- 08:34:12 INFO - PROCESS | 30380 | Number of tests: 6 08:34:12 INFO - PROCESS | 30380 | 08:34:12 INFO - PROCESS | 30380 | [#0] dojo.html Cycles:165 Average:4764.25 Median:4867.76 stddev:505.23 (10.4%) stddev-sans-first:477.69 08:34:12 INFO - PROCESS | 30380 | Values: 2610.4 2623.9 2635.4 2652.7 2668.1 4778.1 4880.1 4881.6 4886.4 4915.6 4770.1 4785.0 4805.1 4827.1 4867.0 4454.4 4455.2 4522.2 4531.6 4594.1 4491.6 4535.9 4578.0 4610.2 4617.5 4553.1 4557.2 4606.7 4613.4 4635.0 4368.8 4388.6 4442.0 4442.6 4459.2 4377.7 4411.2 4423.7 4447.6 4478.5 4742.9 4743.2 4780.4 4789.9 4821.9 5047.6 5083.1 5091.1 5141.1 5191.7 5221.1 5228.0 5230.6 5243.6 5270.4 4867.4 4875.6 4884.3 4887.6 4918.2 5183.4 5235.7 5346.4 5352.4 5354.3 5035.1 5063.0 5070.6 5109.5 5156.8 5162.7 5170.7 5175.1 5180.7 5188.6 5025.9 5087.6 5128.6 5139.1 5191.1 5090.8 5143.5 5151.7 5216.4 5220.4 4181.9 4188.6 4207.3 4232.1 4282.8 3702.8 3703.2 3703.6 3714.0 3735.8 4404.0 4581.0 4597.2 4603.6 4605.3 5071.5 5163.9 5221.1 5234.8 5278.2 4541.3 4552.8 4561.8 4568.8 4581.9 4647.9 4648.4 4663.1 4672.4 4702.6 4795.5 4827.1 4855.2 4855.2 4865.0 5173.1 5180.4 5185.8 5186.1 5233.2 4867.8 4873.2 4882.0 4897.0 4935.1 5017.6 5018.4 5058.8 5080.8 5091.2 5083.9 5154.3 5158.3 5164.8 5190.2 4864.1 4931.7 4948.6 4949.9 4980.6 4876.4 4887.0 4889.1 4896.5 5016.0 4828.3 4828.9 4830.3 4847.1 4911.7 4931.7 4953.3 4965.6 4970.3 5022.9 4803.5 4822.9 4829.7 4845.2 4864.5 08:34:12 INFO - PROCESS | 30380 | 08:34:12 INFO - PROCESS | 30380 | [#1] ext.html Cycles:180 Average:43079.57 Median:351211.00 stddev:74150.81 (21.1%) stddev-sans-first:74289.95 08:34:12 INFO - PROCESS | 30380 | Values: 514.2 519.1 523.4 531.6 536.9 36990.3 38794.0 38943.4 38950.6 38998.2 39319.8 39536.2 39567.0 39650.4 39688.0 7591.9 7753.3 7762.3 9357.7 9695.0 9424.4 9492.5 9540.7 9542.3 9545.0 9506.4 9518.5 9565.6 9570.7 9578.8 9445.6 9479.4 9497.6 9502.5 9558.8 9202.1 9205.9 9265.6 9282.9 9287.6 33145.0 33183.5 33256.8 33413.5 33500.5 3472.7 3477.0 3516.1 3524.8 3531.8 25703.4 25825.7 26180.0 26223.2 26361.7 3270.8 3341.4 3389.6 3398.8 3401.1 236909.2 237126.0 238355.8 238932.0 239363.0 46495.8 46553.5 46837.8 46924.0 46979.0 47754.5 47872.5 47893.5 48112.5 48291.5 12969.7 13180.4 13229.7 13256.9 13257.1 8969.3 9148.7 10689.7 11045.7 11069.8 15311.2 15343.9 15379.2 15507.0 15537.3 6417.8 6446.2 6490.5 6547.5 6641.0 769.4 782.9 790.2 802.1 808.4 27711.0 27876.6 28178.9 28416.3 28545.3 942.8 982.0 993.8 996.9 1004.2 14153.6 14563.6 14584.0 14778.8 14836.5 348166.0 351146.0 351276.0 352132.0 352356.0 49461.8 49907.5 50053.0 50117.0 50327.5 1146.4 1196.8 1216.8 1217.9 1218.3 25654.6 26277.2 27229.0 27652.4 27707.3 40315.0 41169.6 41232.4 41241.4 41246.0 245044.0 245140.0 245224.0 245535.0 245750.0 22239.0 22901.0 24034.0 24344.0 24810.6 40422.2 40685.0 40783.2 41701.6 41953.8 34451.3 34699.3 34787.3 34822.3 35026.3 34284.0 34831.7 34976.7 35294.3 35523.5 33253.0 33836.7 34310.8 34383.3 34689.3 27197.1 29787.0 30046.4 31786.8 32228.0 22422.3 22563.4 22960.9 23075.9 23143.9 08:34:12 INFO - PROCESS | 30380 | 08:34:12 INFO - PROCESS | 30380 | [#2] jquery.html Cycles:180 Average:22536.89 Median:5052.77 stddev:57696.83 (1141.9%) stddev-sans-first:57834.67 08:34:12 INFO - PROCESS | 30380 | Values: 363.7 364.2 375.8 383.9 384.5 15719.1 16657.2 16681.2 16760.1 16767.7 16022.4 16121.5 16190.3 16259.8 16462.0 4832.1 5156.7 5169.3 5170.6 5177.4 5017.6 5088.0 5317.2 5342.2 5446.1 5418.8 5419.0 5429.7 5432.9 5444.2 5346.5 5381.1 5476.0 5490.6 5520.6 5312.4 5320.8 5331.1 5334.6 5338.7 12039.6 17845.8 18305.7 19837.0 19937.1 2052.9 2094.3 2113.1 2143.2 2174.3 8449.7 8900.6 9034.8 9284.8 9385.0 1691.8 1726.8 1754.2 1765.5 1784.9 63035.7 63050.0 63193.4 63642.4 65076.7 9954.8 10070.7 10135.6 10193.7 10241.8 13638.9 13640.7 13732.1 13734.4 13763.6 7106.6 7144.6 7261.1 7336.2 7344.6 6704.2 6756.6 6801.8 6982.6 6990.9 4291.7 4326.8 4370.5 4378.1 4501.5 1554.7 1622.8 1800.2 1846.1 1879.7 775.5 800.0 806.7 807.6 811.4 15733.7 15789.0 15990.4 16010.7 16307.9 816.3 825.7 853.9 854.8 856.9 9046.3 9057.8 9126.8 9152.6 9226.9 342813.0 344062.0 346356.0 352894.0 355717.0 76139.6 76812.6 76872.0 77169.6 77522.0 411.8 430.5 431.5 432.9 436.9 9177.3 14161.8 14818.6 15128.6 15510.8 34928.3 35345.8 35889.5 35974.0 36199.5 46307.8 46362.8 46441.3 46517.3 48783.3 6988.5 7097.7 7129.4 7374.7 7933.2 10641.7 11069.1 11123.2 11128.9 11211.3 9574.9 9719.6 9801.4 9937.9 10072.2 8908.5 9664.5 9672.8 9821.7 10157.9 9787.7 9855.6 10007.4 10145.5 10153.2 7276.6 7305.4 7367.0 7373.7 7388.4 9088.5 9732.1 9783.2 9850.9 10143.2 08:34:12 INFO - PROCESS | 30380 | 08:34:12 INFO - PROCESS | 30380 | [#3] mootools.html Cycles:180 Average:4745.70 Median:4621.97 stddev:2609.10 (56.4%) stddev-sans-first:2603.44 08:34:12 INFO - PROCESS | 30380 | Values: 1283.6 1320.1 1325.7 1330.3 1337.1 6598.5 6849.0 6862.7 7246.7 7269.1 7154.9 7300.7 7343.0 7478.3 7517.8 2055.2 2106.0 2107.4 2108.2 2109.7 2024.9 2074.1 2102.1 2104.2 2156.1 2130.9 2153.6 2156.9 2161.5 2164.8 2031.6 2050.8 2053.8 2054.1 2060.0 2020.6 2021.8 2051.3 2054.3 2058.7 7360.0 7397.3 7485.9 7494.3 7505.4 4406.9 4530.5 4531.1 4531.3 4540.0 2733.3 2927.6 2965.9 3006.1 3009.4 1140.9 1149.0 1159.1 1160.0 1178.4 9646.3 9795.2 9828.8 9897.5 9920.6 3852.0 4030.8 4037.6 4102.7 4125.6 7283.3 7470.5 8308.5 8345.5 8347.4 4305.9 4446.5 4452.6 4458.0 4460.5 4144.5 4147.0 4148.2 4149.8 4150.4 3206.6 3241.2 3258.4 3296.8 3327.1 1036.4 1037.9 1051.3 1053.2 1057.1 768.2 779.1 785.2 787.2 793.3 4442.4 4468.6 4504.9 4785.0 4816.5 784.5 813.3 821.2 827.6 828.0 2914.8 2945.7 3035.7 3116.7 3179.8 8556.0 8831.1 8837.6 8880.9 8896.7 8819.3 8827.0 8838.7 8850.0 8853.6 6570.3 6663.6 6703.4 6713.9 6722.0 4545.0 4549.0 4589.0 4655.0 4662.2 7849.3 7999.3 8014.2 8113.8 8155.3 8114.7 8186.8 8227.3 8241.0 8257.7 6169.5 6290.4 6294.8 6688.1 6897.1 6812.7 7128.6 7129.4 7134.5 7137.1 6082.6 6358.9 6381.1 6435.5 6457.4 6073.2 6172.5 6208.3 6317.1 6414.7 5117.6 5188.0 5192.9 5371.9 5459.7 4078.5 4088.7 4120.8 4182.8 4219.6 4062.7 4078.2 4108.4 4161.1 4266.1 08:34:12 INFO - PROCESS | 30380 | 08:34:12 INFO - PROCESS | 30380 | [#4] prototype.html Cycles:180 Average:4259.56 Median:4832.58 stddev:1213.73 (25.1%) stddev-sans-first:1180.59 08:34:12 INFO - PROCESS | 30380 | Values: 321.7 340.9 346.4 349.9 351.9 4833.6 4881.3 4941.0 5029.1 5036.4 4788.2 4867.8 4879.3 4908.9 4928.5 3901.7 3907.4 3922.7 3933.5 3940.3 3870.3 3927.4 3960.4 3967.3 3983.8 3891.4 3903.2 3904.4 3908.0 3908.3 3879.3 3887.7 3893.5 3896.3 3916.3 3488.4 3493.3 3495.8 3500.6 3503.7 4638.2 4764.7 4796.2 4820.5 4836.0 4426.8 4444.4 4449.9 4460.9 4463.1 5155.9 5158.0 5165.4 5188.8 5203.4 3718.4 3724.6 3758.6 3762.3 3786.5 5349.8 5360.5 5364.7 5383.2 5386.6 3851.9 3864.8 3872.7 3877.6 3893.5 3924.3 3933.0 3943.3 3946.6 3947.8 4333.5 4389.2 4417.4 4431.2 4449.6 5121.3 5167.8 5183.8 5192.2 5195.2 1216.5 1227.8 1235.1 1370.0 1387.6 852.8 860.5 876.1 882.8 886.8 4403.4 4441.6 4491.3 4504.2 4511.6 5122.2 5125.9 5131.5 5145.1 5149.2 4473.6 4473.7 4497.0 4506.6 4524.6 2628.7 2658.4 2678.6 2706.9 2720.2 4759.4 4772.8 4797.0 4863.5 4889.6 5067.2 5192.3 5261.5 5289.9 5301.7 4821.2 4822.0 4831.6 4836.5 4848.4 5119.7 5125.8 5127.9 5136.0 5170.2 4930.5 5044.9 5091.5 5127.7 5129.1 4845.6 4867.1 4880.7 4897.8 4911.8 3576.1 3611.9 3614.6 3672.6 3675.6 4990.5 5131.7 5140.4 5141.4 5161.7 5084.3 5120.2 5123.7 5145.3 5150.2 5127.6 5133.3 5145.2 5149.2 5190.0 4894.2 5046.2 5070.8 5085.5 5090.4 5136.2 5138.4 5140.9 5144.4 5156.6 5030.5 5033.2 5034.0 5035.7 5052.7 08:34:12 INFO - PROCESS | 30380 | 08:34:12 INFO - PROCESS | 30380 | [#5] yui.html Cycles:180 Average:14286.94 Median:53568.10 stddev:18232.54 (34.0%) stddev-sans-first:18254.92 08:34:12 INFO - PROCESS | 30380 | Values: 647.9 668.7 720.2 744.9 761.7 12555.7 13659.2 13696.7 13797.4 13870.9 12523.0 12527.1 12533.3 12541.2 12912.4 799.3 813.2 813.3 819.2 820.3 816.6 819.7 820.6 825.1 825.7 851.3 856.4 856.8 856.9 858.8 853.0 855.0 855.0 855.6 855.9 627.0 627.6 628.8 628.9 629.1 10902.3 11031.7 11045.4 12407.0 12820.2 12388.5 12838.9 12922.9 13018.9 13080.6 10166.1 10394.9 10431.0 10690.2 10693.9 3192.9 3237.8 3249.7 3251.6 3257.5 47741.8 47750.3 61081.0 61094.0 62914.4 9013.9 9154.3 9308.0 9394.2 9524.2 17397.7 17434.6 17435.4 17481.9 17574.4 6301.2 6341.7 6523.9 6641.5 6653.2 3342.6 3374.9 3482.5 3514.6 3566.3 2824.5 2900.6 2904.9 2918.8 2945.6 485.4 486.4 491.1 491.2 497.4 628.6 643.4 646.8 650.2 651.7 7871.8 8075.7 8460.8 8468.2 8551.4 456.1 463.8 470.6 476.3 480.1 3773.6 3822.2 3838.9 3909.8 4008.3 65000.0 65913.3 67824.0 68589.0 69408.0 47193.5 57938.4 58360.0 59017.7 59380.0 51249.2 51288.0 51925.2 52980.5 54155.7 7586.0 7597.9 7621.3 7690.1 7806.4 36798.3 37281.4 38376.6 39124.8 39518.8 42748.0 45264.0 46068.0 46553.3 47176.0 9510.1 9556.3 9607.5 9672.5 9967.0 10530.6 10801.8 10875.6 10941.7 11137.8 10009.7 10543.8 10614.7 11103.9 11107.8 9861.7 10028.3 10054.8 10066.3 10135.4 9243.8 9435.2 9461.4 9475.7 9502.3 8794.2 8932.0 9064.1 9067.0 9103.7 8523.4 8724.6 8732.5 8795.5 8845.4 08:34:12 INFO - PROCESS | 30380 | -------- Summary: end -------- 08:34:12 INFO - PROCESS | 30380 | 08:34:13 INFO - TEST-INFO | 30380: exit 0 08:34:13 INFO - TEST-OK | dromaeo_css | took 1119802ms 08:34:13 INFO - TEST-START | kraken 08:34:13 INFO - operating with platform_type : linux_ 08:34:13 INFO - Initialising browser for kraken test... 08:34:13 INFO - TEST-INFO | started process 30729 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgxycbZ/profile http://localhost:36430/getInfo.html) 08:34:13 INFO - PROCESS | 30729 | 1483115653669 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:4986 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2097 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3827 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2831 < 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 08:34:17 INFO - PROCESS | 30729 | __metrics Screen width/height:1600/1200 08:34:17 INFO - PROCESS | 30729 | colorDepth:24 08:34:17 INFO - PROCESS | 30729 | Browser inner width/height: 1024/697 08:34:17 INFO - PROCESS | 30729 | __metrics 08:34:18 ERROR - PROCESS | 30729 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3256: TypeError: this.tabs is undefined 08:34:19 INFO - TEST-INFO | 30729: exit 0 08:34:19 INFO - Browser initialized. 08:34:19 INFO - Running cycle 1/1 for kraken test... 08:34:19 INFO - TEST-INFO | started process 30849 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgxycbZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:34:31 INFO - PROCESS | 30849 | RSS: Main: 158703616 08:34:31 INFO - PROCESS | 30849 | 08:34:33 INFO - PROCESS | 30849 | Cycle 1(1): loaded http://localhost:36430/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36430/tests/kraken/driver.html?testName=audio-beat-detection) 08:34:34 INFO - PROCESS | 30849 | RSS: Main: 164712448 08:34:34 INFO - PROCESS | 30849 | 08:34:37 INFO - PROCESS | 30849 | Cycle 1(1): loaded http://localhost:36430/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36430/tests/kraken/driver.html?testName=audio-dft) 08:34:38 INFO - PROCESS | 30849 | RSS: Main: 163074048 08:34:38 INFO - PROCESS | 30849 | 08:34:41 INFO - PROCESS | 30849 | Cycle 1(1): loaded http://localhost:36430/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36430/tests/kraken/driver.html?testName=audio-fft) 08:34:41 INFO - PROCESS | 30849 | RSS: Main: 159383552 08:34:41 INFO - PROCESS | 30849 | 08:34:43 INFO - PROCESS | 30849 | Cycle 1(1): loaded http://localhost:36430/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36430/tests/kraken/driver.html?testName=audio-oscillator) 08:34:44 INFO - PROCESS | 30849 | RSS: Main: 160301056 08:34:44 INFO - PROCESS | 30849 | 08:34:46 INFO - PROCESS | 30849 | Cycle 1(1): loaded http://localhost:36430/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36430/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:34:47 INFO - PROCESS | 30849 | RSS: Main: 160751616 08:34:47 INFO - PROCESS | 30849 | 08:34:50 INFO - PROCESS | 30849 | Cycle 1(1): loaded http://localhost:36430/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36430/tests/kraken/driver.html?testName=imaging-darkroom) 08:34:51 INFO - PROCESS | 30849 | RSS: Main: 164995072 08:34:51 INFO - PROCESS | 30849 | 08:34:54 INFO - PROCESS | 30849 | Cycle 1(1): loaded http://localhost:36430/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36430/tests/kraken/driver.html?testName=imaging-desaturate) 08:34:55 INFO - PROCESS | 30849 | RSS: Main: 162054144 08:34:55 INFO - PROCESS | 30849 | 08:34:58 INFO - PROCESS | 30849 | Cycle 1(1): loaded http://localhost:36430/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36430/tests/kraken/driver.html?testName=json-parse-financial) 08:34:58 INFO - PROCESS | 30849 | RSS: Main: 163233792 08:34:58 INFO - PROCESS | 30849 | 08:35:00 INFO - PROCESS | 30849 | Cycle 1(1): loaded http://localhost:36430/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36430/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:35:01 INFO - PROCESS | 30849 | RSS: Main: 163438592 08:35:01 INFO - PROCESS | 30849 | 08:35:03 INFO - PROCESS | 30849 | Cycle 1(1): loaded http://localhost:36430/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36430/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:35:03 INFO - PROCESS | 30849 | RSS: Main: 163213312 08:35:03 INFO - PROCESS | 30849 | 08:35:06 INFO - PROCESS | 30849 | Cycle 1(1): loaded http://localhost:36430/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36430/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:35:06 INFO - PROCESS | 30849 | RSS: Main: 163962880 08:35:06 INFO - PROCESS | 30849 | 08:35:09 INFO - PROCESS | 30849 | Cycle 1(1): loaded http://localhost:36430/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36430/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:35:10 INFO - PROCESS | 30849 | RSS: Main: 164405248 08:35:10 INFO - PROCESS | 30849 | 08:35:13 INFO - PROCESS | 30849 | Cycle 1(1): loaded http://localhost:36430/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36430/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:35:13 INFO - PROCESS | 30849 | RSS: Main: 163995648 08:35:13 INFO - PROCESS | 30849 | 08:35:15 INFO - PROCESS | 30849 | Cycle 1(1): loaded http://localhost:36430/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36430/tests/kraken/driver.html?testName=ai-astar) 08:35:15 INFO - PROCESS | 30849 | RSS: Main: 165732352 08:35:15 INFO - PROCESS | 30849 | 08:35:15 INFO - PROCESS | 30849 | __start_tp_report 08:35:15 INFO - PROCESS | 30849 | _x_x_mozilla_page_load 08:35:15 INFO - PROCESS | 30849 | _x_x_mozilla_page_load_details 08:35:15 INFO - PROCESS | 30849 | |i|pagename|runs| 08:35:15 INFO - PROCESS | 30849 | |0;ai-astar;111;116;117;118;116;115;116;117;116;115 08:35:15 INFO - PROCESS | 30849 | |1;audio-beat-detection;151;127;133;173;131;131;129;130;153;128 08:35:15 INFO - PROCESS | 30849 | |2;audio-dft;163;162;166;177;164;162;162;165;165;164 08:35:15 INFO - PROCESS | 30849 | |3;audio-fft;77;78;78;106;78;79;77;77;94;79 08:35:15 INFO - PROCESS | 30849 | |4;audio-oscillator;86;86;109;85;85;88;100;85;87;105 08:35:15 INFO - PROCESS | 30849 | |5;imaging-gaussian-blur;118;119;118;120;118;118;119;118;118;118 08:35:15 INFO - PROCESS | 30849 | |6;imaging-darkroom;152;151;151;150;151;153;153;151;152;150 08:35:15 INFO - PROCESS | 30849 | |7;imaging-desaturate;96;96;96;97;96;96;97;96;97;96 08:35:15 INFO - PROCESS | 30849 | |8;json-parse-financial;71;70;71;73;73;71;72;72;71;73 08:35:15 INFO - PROCESS | 30849 | |9;json-stringify-tinderbox;69;67;67;68;68;68;68;67;68;68 08:35:15 INFO - PROCESS | 30849 | |10;stanford-crypto-aes;87;87;86;95;89;93;87;85;85;85 08:35:15 INFO - PROCESS | 30849 | |11;stanford-crypto-ccm;140;148;144;133;136;134;142;143;190;149 08:35:15 INFO - PROCESS | 30849 | |12;stanford-crypto-pbkdf2;176;184;181;179;181;184;178;182;176;176 08:35:15 INFO - PROCESS | 30849 | |13;stanford-crypto-sha256-iterative;70;71;70;70;79;70;70;72;69;74 08:35:15 INFO - PROCESS | 30849 | __end_tp_report 08:35:15 INFO - PROCESS | 30849 | __start_cc_report 08:35:15 INFO - PROCESS | 30849 | _x_x_mozilla_cycle_collect,805 08:35:15 INFO - PROCESS | 30849 | __end_cc_report 08:35:15 INFO - PROCESS | 30849 | __startTimestamp1483115715937__endTimestamp 08:35:15 INFO - PROCESS | 30849 | 08:35:15 INFO - PROCESS | 30849 | ------- Summary: start ------- 08:35:15 INFO - PROCESS | 30849 | Number of tests: 14 08:35:15 INFO - PROCESS | 30849 | 08:35:15 INFO - PROCESS | 30849 | [#0] ai-astar Cycles:10 Average:115.70 Median:116.00 stddev:1.89 (1.6%) stddev-sans-first:0.97 08:35:15 INFO - PROCESS | 30849 | Values: 111.0 116.0 117.0 118.0 116.0 115.0 116.0 117.0 116.0 115.0 08:35:15 INFO - PROCESS | 30849 | 08:35:15 INFO - PROCESS | 30849 | [#1] audio-beat-detection Cycles:10 Average:138.60 Median:132.00 stddev:15.29 (11.6%) stddev-sans-first:15.55 08:35:15 INFO - PROCESS | 30849 | Values: 151.0 127.0 133.0 173.0 131.0 131.0 129.0 130.0 153.0 128.0 08:35:15 INFO - PROCESS | 30849 | 08:35:15 INFO - PROCESS | 30849 | [#2] audio-dft Cycles:10 Average:165.00 Median:164.50 stddev:4.45 (2.7%) stddev-sans-first:4.66 08:35:15 INFO - PROCESS | 30849 | Values: 163.0 162.0 166.0 177.0 164.0 162.0 162.0 165.0 165.0 164.0 08:35:15 INFO - PROCESS | 30849 | 08:35:15 INFO - PROCESS | 30849 | [#3] audio-fft Cycles:10 Average:82.30 Median:78.00 stddev:9.78 (12.5%) stddev-sans-first:10.18 08:35:15 INFO - PROCESS | 30849 | Values: 77.0 78.0 78.0 106.0 78.0 79.0 77.0 77.0 94.0 79.0 08:35:15 INFO - PROCESS | 30849 | 08:35:15 INFO - PROCESS | 30849 | [#4] audio-oscillator Cycles:10 Average:91.60 Median:85.50 stddev:9.31 (10.9%) stddev-sans-first:9.65 08:35:15 INFO - PROCESS | 30849 | Values: 86.0 86.0 109.0 85.0 85.0 88.0 100.0 85.0 87.0 105.0 08:35:15 INFO - PROCESS | 30849 | 08:35:15 INFO - PROCESS | 30849 | [#5] imaging-gaussian-blur Cycles:10 Average:118.40 Median:118.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 08:35:15 INFO - PROCESS | 30849 | Values: 118.0 119.0 118.0 120.0 118.0 118.0 119.0 118.0 118.0 118.0 08:35:15 INFO - PROCESS | 30849 | 08:35:15 INFO - PROCESS | 30849 | [#6] imaging-darkroom Cycles:10 Average:151.40 Median:151.50 stddev:1.07 (0.7%) stddev-sans-first:1.12 08:35:15 INFO - PROCESS | 30849 | Values: 152.0 151.0 151.0 150.0 151.0 153.0 153.0 151.0 152.0 150.0 08:35:15 INFO - PROCESS | 30849 | 08:35:15 INFO - PROCESS | 30849 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 08:35:15 INFO - PROCESS | 30849 | Values: 96.0 96.0 96.0 97.0 96.0 96.0 97.0 96.0 97.0 96.0 08:35:15 INFO - PROCESS | 30849 | 08:35:15 INFO - PROCESS | 30849 | [#8] json-parse-financial Cycles:10 Average:71.70 Median:72.00 stddev:1.06 (1.5%) stddev-sans-first:1.09 08:35:15 INFO - PROCESS | 30849 | Values: 71.0 70.0 71.0 73.0 73.0 71.0 72.0 72.0 71.0 73.0 08:35:15 INFO - PROCESS | 30849 | 08:35:15 INFO - PROCESS | 30849 | [#9] json-stringify-tinderbox Cycles:10 Average:67.80 Median:68.00 stddev:0.63 (0.9%) stddev-sans-first:0.50 08:35:15 INFO - PROCESS | 30849 | Values: 69.0 67.0 67.0 68.0 68.0 68.0 68.0 67.0 68.0 68.0 08:35:15 INFO - PROCESS | 30849 | 08:35:15 INFO - PROCESS | 30849 | [#10] stanford-crypto-aes Cycles:10 Average:87.90 Median:87.00 stddev:3.48 (4.0%) stddev-sans-first:3.67 08:35:15 INFO - PROCESS | 30849 | Values: 87.0 87.0 86.0 95.0 89.0 93.0 87.0 85.0 85.0 85.0 08:35:15 INFO - PROCESS | 30849 | 08:35:15 INFO - PROCESS | 30849 | [#11] stanford-crypto-ccm Cycles:10 Average:145.90 Median:143.50 stddev:16.42 (11.4%) stddev-sans-first:17.28 08:35:15 INFO - PROCESS | 30849 | Values: 140.0 148.0 144.0 133.0 136.0 134.0 142.0 143.0 190.0 149.0 08:35:15 INFO - PROCESS | 30849 | 08:35:15 INFO - PROCESS | 30849 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.70 Median:181.00 stddev:3.16 (1.7%) stddev-sans-first:3.06 08:35:15 INFO - PROCESS | 30849 | Values: 176.0 184.0 181.0 179.0 181.0 184.0 178.0 182.0 176.0 176.0 08:35:15 INFO - PROCESS | 30849 | 08:35:15 INFO - PROCESS | 30849 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.50 Median:70.50 stddev:2.99 (4.2%) stddev-sans-first:3.12 08:35:15 INFO - PROCESS | 30849 | Values: 70.0 71.0 70.0 70.0 79.0 70.0 70.0 72.0 69.0 74.0 08:35:15 INFO - PROCESS | 30849 | -------- Summary: end -------- 08:35:15 INFO - PROCESS | 30849 | 08:35:17 INFO - TEST-INFO | 30849: exit 0 08:35:17 INFO - TEST-OK | kraken | took 63962ms 08:35:17 INFO - SUITE-END | took 1183s 08:35:17 INFO - Completed test suite (00:19:44) 08:35:17 INFO - javascript benchmark 08:35:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6195.250034362566, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2610.3865591585977, 2623.895044198232, 2635.3806855388966, 2652.681678198616, 2668.0528412413605, 4778.068276686047, 4880.097182021329, 4881.609471242301, 4886.438059623144, 4915.5821755150855, 4770.0698363819065, 4785.042991401725, 4805.135075686375, 4827.131116399047, 4866.977934633731, 4454.35411865281, 4455.220336441118, 4522.186006518842, 4531.614812740921, 4594.127115847995, 4491.640668746492, 4535.931961020588, 4577.977110114445, 4610.193216187171, 4617.46899106602, 4553.066621342617, 4557.156925968707, 4606.723596584199, 4613.423322084739, 4634.953650463486, 4368.7815609219415, 4388.5830846069575, 4442.044960333512, 4442.644588432918, 4459.241928872099, 4377.715448495869, 4411.205982923073, 4423.6903416760515, 4447.599716025573, 4478.507364189936, 4742.928856067162, 4743.241081426955, 4780.402449693788, 4789.928151077736, 4821.927671084936, 5047.64666473347, 5083.085044691954, 5091.134507133796, 5141.126008578551, 5191.662541934762, 5221.112410890158, 5228.0, 5230.581553475751, 5243.606729495303, 5270.39390470097, 4867.367242258484, 4875.561199492063, 4884.266085539653, 4887.608991280689, 4918.1884988977135, 5183.403908550489, 5235.712035838065, 5346.449529636439, 5352.437994010651, 5354.277172581652, 5035.093683137071, 5063.012712521023, 5070.645054846199, 5109.463506331856, 5156.819511317086, 5162.74186290684, 5170.741462926839, 5175.120229560984, 5180.663256888291, 5188.610854185951, 5025.874353141201, 5087.567556757717, 5128.615353848476, 5139.074966506065, 5191.091558977164, 5090.77091530882, 5143.459936706667, 5151.7166555839785, 5216.426193118754, 5220.399654039834, 4181.937270940938, 4188.6230239278, 4207.326827707613, 4232.132412855357, 4282.785860707015, 3702.777833330009, 3703.166787472851, 3703.5740889798017, 3714.0157858167067, 3735.75717578362, 4404.031113155101, 4581.015081757439, 4597.195490789165, 4603.608693261111, 4605.286180642006, 5071.46749591295, 5163.922541161885, 5221.086309895829, 5234.816781412708, 5278.155495120763, 4541.318802179633, 4552.795124219418, 4561.771911404417, 4568.840090596813, 4581.885452863638, 4647.930281045787, 4648.418947631546, 4663.090697314059, 4672.392588963481, 4702.6473014524045, 4795.520447955247, 4827.106985207748, 4855.150348688895, 4855.174620314484, 4864.978354545444, 5173.0688476074665, 5180.430152683277, 5185.766640501111, 5186.066508028591, 5233.162693968947, 4867.756612169448, 4873.171560834738, 4882.048000639841, 4897.0, 4935.062338155739, 5017.598592112695, 5018.42288136869, 5058.772355243949, 5080.771365288497, 5091.1854103343285, 5083.906960003617, 5154.304168937296, 5158.252053452304, 5164.767585458589, 5190.247414124855, 4864.1001414736975, 4931.675233077398, 4948.604111671129, 4949.901001980013, 4980.576650984707, 4876.4392094909535, 4887.047025829929, 4889.119958407378, 4896.510348965075, 5016.021875734197, 4828.2998965150555, 4828.903421931472, 4830.3237546742785, 4847.103285892122, 4911.68074075184, 4931.654784165074, 4953.2570114483115, 4965.627577931742, 4970.3290055842, 5022.874428139326, 4803.543663351976, 4822.855314340575, 4829.66192366531, 4845.224764037737, 4864.464908860094], "value": 4730.94920659091, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [514.1516497778665, 519.0889988070936, 523.4320761973258, 531.5508395405881, 536.9301990741205, 36990.26019479612, 38794.0, 38943.415848762255, 38950.610493895125, 38998.220035599305, 39319.80340098296, 39536.209275814464, 39567.0, 39650.40524392136, 39688.0, 7591.8861217081785, 7753.340966017867, 7762.262585054411, 9357.67248146315, 9695.03049695032, 9424.387414818015, 9492.52537373132, 9540.666076687317, 9542.284328675378, 9545.04549545047, 9506.429614223169, 9518.524073796318, 9565.617375305013, 9570.712878613618, 9578.760530986747, 9445.622175112987, 9479.431234125974, 9497.620095196218, 9502.47736374499, 9558.761030974212, 9202.125798049176, 9205.861912071325, 9265.629374825, 9282.860757088649, 9287.58205880737, 33145.0, 33183.502247466306, 33256.833715831504, 33413.498797518056, 33500.49749253763, 3472.6700963408434, 3477.0, 3516.0682419158943, 3524.8061356625376, 3531.7527773055895, 25703.357416064562, 25825.741742582522, 26180.0, 26223.21330360092, 26361.73638263612, 3270.771046026779, 3341.365140623274, 3389.644087370815, 3398.762086653935, 3401.064707205538, 236909.2318076151, 237126.0, 238355.80822095953, 238932.0, 239363.0, 46495.767521162175, 46553.53446465492, 46837.76581117073, 46924.0, 46979.0, 47754.5224547757, 47872.521274787505, 47893.5210647896, 48112.518874810805, 48291.51708482941, 12969.675758105934, 13180.406881690347, 13229.669258268621, 13256.867431325563, 13257.07200495956, 8969.327300452493, 9148.72553823373, 10689.732756681145, 11045.723856903482, 11069.778604427866, 15311.234438278041, 15343.92328038375, 15379.154146521825, 15507.0, 15537.30082146306, 6417.807465776034, 6446.161998940202, 6490.545661803723, 6547.5416720830035, 6640.9667951660895, 769.3921801776534, 782.8903953446522, 790.2413682864515, 802.1176705623767, 808.4179390838586, 27711.0, 27876.581851272247, 28178.85910570434, 28416.289592760346, 28545.28636784097, 942.7548837302351, 981.9705408837747, 993.7714325705128, 996.8604395384652, 1004.2167109654481, 14153.57800709067, 14563.635909102146, 14584.0, 14778.778318325234, 14836.480723174636, 348166.0, 351146.0, 351276.0, 352132.0, 352356.0, 49461.75269123631, 49907.500924991014, 50053.0, 50117.0, 50327.496725033016, 1146.4439746722833, 1196.8384268123866, 1216.823560583728, 1217.8843009914044, 1218.3055658274875, 25654.61518077193, 26277.211683649522, 27229.0, 27652.44695106127, 27707.307317317227, 40315.0, 41169.58830411777, 41232.38151427671, 41241.38137927873, 41246.0, 245044.0, 245140.0, 245224.0, 245535.0, 245750.0, 22239.0, 22901.0, 24034.0, 24344.0, 24810.627840582045, 40422.1915561693, 40685.0, 40783.1843363137, 41701.58298416977, 41953.79023104987, 34451.310973780885, 34699.30601388009, 34787.30425391529, 34822.30355392827, 35026.299474010884, 34284.0, 34831.65168348284, 34976.65023349734, 35294.294114118085, 35523.46714799228, 33253.0, 33836.661633384334, 34310.82844585761, 34383.31233375368, 34689.30621387609, 27197.144299849024, 29787.0, 30046.399072018, 31786.810389998696, 32228.0, 22422.32733018012, 22563.43591410228, 22960.885195573916, 23075.88462057679, 23143.884280578488], "value": 17008.304084983272, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [363.69994754327683, 364.2423758582149, 375.7520036775729, 383.8829157107081, 384.5078299776287, 15719.13544755038, 16657.167141642916, 16681.16594170291, 16760.078195699232, 16767.748483772724, 16022.35910563579, 16121.516354509384, 16190.271437785299, 16259.756103658454, 16462.0, 4832.106060378841, 5156.664816786897, 5169.30214421054, 5170.586353091744, 5177.430482646906, 5017.573506251973, 5087.974560127194, 5317.202419637047, 5342.171963345688, 5446.101393270105, 5418.83743487696, 5419.0, 5429.67421954684, 5432.91850622241, 5444.1561557958385, 5346.492083252085, 5381.058314794915, 5476.0416927038, 5490.6431081979745, 5520.613557051008, 5312.415634280226, 5320.760565774511, 5331.067063263952, 5334.5732341412595, 5338.733063346817, 12039.63881083569, 17845.821541784677, 18305.7254141188, 19837.0, 19937.10283037252, 2052.9486762831048, 2094.3088780702333, 2113.1019316790303, 2143.164165975271, 2174.3150907464096, 8449.746507604781, 8900.599473023729, 9034.774130646721, 9284.814303713956, 9384.953075234649, 1691.8139004709594, 1726.8273172682757, 1754.23690694547, 1765.4527096600095, 1784.9107544622848, 63035.684821576055, 63050.0, 63193.368066319206, 63642.36357636411, 65076.67461662662, 9954.751131221778, 10070.676676696672, 10135.64525241613, 10193.745156371002, 10241.84637230442, 13638.931805341108, 13640.65898352549, 13732.107413018122, 13734.381952812148, 13763.587092387244, 7106.644667766591, 7144.571325720473, 7261.128664560287, 7336.193018767931, 7344.596047217347, 6704.229013663394, 6756.560823546453, 6801.795946121624, 6982.581045137308, 6990.930090699129, 4291.656667466657, 4326.762028088422, 4370.453693288339, 4378.146261478981, 4501.459824820977, 1554.6502037041575, 1622.813376461722, 1800.2438975630266, 1846.1138653446421, 1879.7086451600023, 775.4649291988623, 799.9800004999805, 806.7136166660869, 807.6486728273103, 811.3995643223972, 15733.68532629341, 15789.0, 15990.440334588233, 16010.679786404207, 16307.918460407622, 816.3346872299057, 825.6738588257605, 853.8633818588996, 854.786303424144, 856.8928883889514, 9046.321525885585, 9057.77355566116, 9126.81746365069, 9152.588133534007, 9226.90773092274, 342813.0, 344062.0, 346356.0, 352894.0, 355717.0, 76139.61930190313, 76812.61593691996, 76872.0, 77169.61415193, 77522.0, 411.80233487925364, 430.4683715611218, 431.5231669005766, 432.8831215571715, 436.9388285640013, 9177.311701622539, 14161.787573186617, 14818.555443336718, 15128.621784455476, 15510.84489155139, 34928.30143397067, 35345.823270883484, 35889.46165807567, 35974.0, 36199.45700814542, 46307.76846115748, 46362.76818615885, 46441.303380449994, 46517.302240465746, 48783.268250975554, 6988.475864310299, 7097.680604372919, 7129.429645628234, 7374.705011799682, 7933.206679332021, 10641.680749577525, 11069.114470842153, 11123.165762567678, 11128.939028522635, 11211.271267367594, 9574.90425095768, 9719.562619682272, 9801.411915285105, 9937.850932236166, 10072.244581656552, 8908.510031948046, 9664.516774161124, 9672.77526168999, 9821.705348839547, 10157.9492102539, 9787.706368808947, 9855.556499957376, 10007.399556026661, 10145.54345054489, 10153.238507112144, 7276.563406195645, 7305.379042781423, 7367.042284503194, 7373.668184931798, 7388.408927285912, 9088.545572721205, 9732.12410883024, 9783.217342612716, 9850.852237216592, 10143.239257055899], "value": 7776.123105723946, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1283.6149155253422, 1320.1023304153177, 1325.7149712811743, 1330.3148878327663, 1337.0707358385919, 6598.472122230222, 6848.96575517123, 6862.656867156641, 7246.710131594737, 7269.055022847036, 7154.892676609855, 7300.7079716811395, 7343.0, 7478.326950574447, 7517.812054698636, 2055.188200660738, 2105.978940210601, 2107.399391173516, 2108.156737305075, 2109.651907435279, 2024.8886311252875, 2074.1081335025933, 2102.054075665949, 2104.1793700456833, 2156.1159924430985, 2130.8614940028924, 2153.5800518898823, 2156.892155392232, 2161.502854343502, 2164.751053628837, 2031.5632139090167, 2050.76416212136, 2053.8048885355865, 2054.075665950321, 2060.042080432606, 2020.6261841559358, 2021.777604463508, 2051.323063389078, 2054.311805545144, 2058.6706127019606, 7359.963200184018, 7397.2602739726135, 7485.925140748632, 7494.250574942516, 7505.399568034544, 4406.867793966187, 4530.501644819067, 4531.093781243764, 4531.3203019547, 4539.977300113512, 2733.289344770354, 2927.634045744282, 2965.8665360058635, 3006.068118883153, 3009.4432529982023, 1140.8591408591408, 1149.002208471776, 1159.09590519395, 1159.9536018559247, 1178.3872386359046, 9646.276529260334, 9795.21638268944, 9828.754281142958, 9897.4556399398, 9920.603175872957, 3851.980740096282, 4030.7581545107387, 4037.6164264394833, 4102.733322334038, 4125.64931980785, 7283.344498995116, 7470.4770666052855, 8308.5430301334, 8345.54099524532, 8347.373946954003, 4305.892352691145, 4446.5331140230455, 4452.5547445255215, 4458.0, 4460.531644177379, 4144.5026596808575, 4147.0461793787, 4148.170365926827, 4149.8340066397, 4150.3566947123245, 3206.551082848403, 3241.222106694376, 3258.446064169097, 3296.8021918684954, 3327.05179023977, 1036.3988886445843, 1037.8598889149869, 1051.2903789941759, 1053.214800912446, 1057.1120258982492, 768.1972338905857, 779.0806847919396, 785.1873311123074, 787.2167193642363, 793.3375631347889, 4442.400275962704, 4468.597826195658, 4504.864854054384, 4784.952150478521, 4816.54242846929, 784.5407541971928, 813.3493205435627, 821.195228675889, 827.6234313387515, 828.0436096308773, 2914.7668186545025, 2945.73488386042, 3035.6964303569466, 3116.7194952453933, 3179.8410079495934, 8555.957220213859, 8831.116888311117, 8837.64649414029, 8880.8667869982, 8896.686861415948, 8819.29445644347, 8827.029026807046, 8838.690645827364, 8849.955750221336, 8853.601587928559, 6570.277269500351, 6663.6001839888795, 6703.430208432241, 6713.865722685519, 6721.966390168018, 4544.954550454453, 4548.954510454985, 4588.9541104588525, 4654.975905300828, 4662.160811054043, 7849.332806711265, 7999.280064794197, 8014.158513356014, 8113.797155071171, 8155.347572194091, 8114.675412983414, 8186.836263274582, 8227.300679442074, 8240.958795206225, 8257.669693212445, 6169.537284703755, 6290.370962903856, 6294.8111556653375, 6688.063671086149, 6897.068895699016, 6812.65936703153, 7128.643567821692, 7129.3583577478275, 7134.536255143399, 7137.10786151731, 6082.60463069899, 6358.936410635834, 6381.138546296376, 6435.4529864962005, 6457.3865482779065, 6073.180120683651, 6172.506199503939, 6208.286047104641, 6317.115603815378, 6414.711337989895, 5117.565006974449, 5188.0, 5192.948070519397, 5371.892562148657, 5459.69971651563, 4078.490188726409, 4088.713790034669, 4120.793960301913, 4182.832686692498, 4219.6202341789385, 4062.720243123407, 4078.1843631274455, 4108.383742438658, 4161.10536234711, 4266.104118135227], "value": 3865.513870718819, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [321.67832167832165, 340.8789879592743, 346.4076429305885, 349.8773446985653, 351.9243362677025, 4833.589144922686, 4881.341018962439, 4940.975295123524, 5029.119904016796, 5036.370453693288, 4788.233882578788, 4867.780949857256, 4879.341288925994, 4908.852734417973, 4928.482509336522, 3901.7463864848837, 3907.433422153786, 3922.7450215735957, 3933.4689816874784, 3940.3104456720102, 3870.3033453978273, 3927.4108883667536, 3960.4455376247347, 3967.2660557796758, 3983.8406463741417, 3891.3773796192613, 3903.2193561287713, 3904.4338570907203, 3907.9839241797195, 3908.3160446921815, 3879.3405121129476, 3887.7364856421777, 3893.4549163117185, 3896.2597106549665, 3916.2559113768293, 3488.4418493040994, 3493.3013397320383, 3495.755297129202, 3500.6149323574386, 3503.7197024238, 4638.188317044537, 4764.737939413331, 4796.184648609745, 4820.542048505386, 4835.975820120877, 4426.800793964279, 4444.422225110748, 4449.888752781174, 4460.8661740147845, 4463.076684771479, 5155.871103222449, 5158.0199762045095, 5165.431802501722, 5188.844334669966, 5203.412959047489, 3718.4236443351324, 3724.571674257468, 3758.624137586247, 3762.3415902217275, 3786.5077539919635, 5349.839504814861, 5360.463953604647, 5364.651297665679, 5383.2194331821665, 5386.569074474072, 3851.8844434667003, 3864.845406183721, 3872.6901847852105, 3877.5540812806325, 3893.5133108361456, 3924.274009308287, 3932.980335098306, 3943.3493473576536, 3946.5856085111222, 3947.8420863165725, 4333.523312435629, 4389.18800021997, 4417.425734654538, 4431.224535706238, 4449.555044495524, 5121.308623335876, 5167.767450464738, 5183.81856635016, 5192.221166825007, 5195.168772996378, 1216.5073145376136, 1227.8281040654315, 1235.1292338901053, 1369.9931500342434, 1387.5837248825312, 852.8422241885271, 860.5009094725044, 876.145757886056, 882.849915514364, 886.8093359927517, 4403.4495688039, 4441.644668426518, 4491.258942274553, 4504.166729155117, 4511.593956543927, 5122.232829673757, 5125.897482050338, 5131.461196574381, 5145.147746811145, 5149.2276158576515, 4473.575010374009, 4473.6868419211, 4497.0, 4506.571875671806, 4524.5701658342405, 2628.7108418073994, 2658.3752818087733, 2678.598210268475, 2706.9458610827674, 2720.1975417251956, 4759.428868535798, 4772.809087636456, 4796.9760151199025, 4863.513648635179, 4889.58202121388, 5067.239914012927, 5192.324997750268, 5261.4738526147075, 5289.920651190235, 5301.708406037705, 4821.228603423366, 4822.00922045681, 4831.565159135695, 4836.46798852126, 4848.3757941089425, 5119.692818430906, 5125.846224613268, 5127.897502036931, 5135.972805439002, 5170.224466330081, 4930.5069493050405, 5044.913718383112, 5091.490850915027, 5127.667016439195, 5129.076766181974, 4845.5881250092725, 4867.14824905633, 4880.6583539153335, 4897.8285759998225, 4911.778969946289, 3576.088097535216, 3611.9097022573596, 3614.6023937366344, 3672.614375490642, 3675.632436756303, 4990.50094990498, 5131.717755523482, 5140.3831540215415, 5141.38303403594, 5161.66449180802, 5084.2627818966785, 5120.231965205249, 5123.692578445305, 5145.305383773143, 5150.175971844487, 5127.6410651254055, 5133.332666753298, 5145.202493613496, 5149.2276158576515, 5189.974050129726, 4894.241392584155, 5046.243063540498, 5070.8225212117395, 5085.542301192911, 5090.41460232078, 5136.203888397305, 5138.409082955508, 5140.922886156636, 5144.382674078985, 5156.587473002076, 5030.522100400456, 5033.169527028, 5034.043531728959, 5035.748212589429, 5052.747362631927], "value": 3881.3478751458797, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [647.9125318082057, 668.7024274197978, 720.1502227371702, 744.9292317229863, 761.7105499910033, 12555.686107847298, 13659.248741319223, 13696.657583560416, 13797.37911793968, 13870.861291387084, 12523.0, 12527.123101382907, 12533.310667913283, 12541.247525148474, 12912.354382280895, 799.3165843204049, 813.2396209544095, 813.3290035720554, 819.1562690428838, 820.2535692519808, 816.6080281464871, 819.6803246733779, 820.5815034332473, 825.1212458731462, 825.686239229092, 851.2551517422255, 856.3791251342789, 856.824351008045, 856.9100244474334, 858.8368210040072, 852.9829403411959, 855.0210009539043, 855.0338117926734, 855.6149732620346, 855.8716192571102, 626.9686515674243, 627.5575719118057, 628.8207860759708, 628.9088082228051, 629.0878226571444, 10902.345859248391, 11031.669049928514, 11045.447727613588, 12407.0, 12820.23078615286, 12388.513378394651, 12838.871611283954, 12922.935385323013, 13018.86981130186, 13080.607581772561, 10166.13587845034, 10394.896051039468, 10431.0, 10690.198235132397, 10693.893061069368, 3192.8563214655396, 3237.75716821237, 3249.723773479257, 3251.64231934487, 3257.5276584895296, 47741.761291193325, 47750.28374574384, 61081.0, 61094.0, 62914.37085629131, 9013.864792028126, 9154.267658587298, 9307.953460232791, 9394.248460123174, 9524.188890437897, 17397.739033914502, 17434.56413589645, 17435.389761358547, 17481.912590436965, 17574.38489652856, 6301.180846489927, 6341.682915854189, 6523.934760652332, 6641.535092543572, 6653.168353955755, 3342.565466489341, 3374.9493757593655, 3482.529858469125, 3514.5958214805114, 3566.3402270580027, 2824.5480723084206, 2900.6084178635615, 2904.8547572621283, 2918.8248705077763, 2945.558166275076, 485.43204450792655, 486.37986567127194, 491.0792264504055, 491.1723745488863, 497.37330962986175, 628.5694299404922, 643.3887806583764, 646.802725168828, 650.2067477677226, 651.6839332923528, 7871.842563148705, 8075.704759394715, 8460.788480288042, 8468.153184681483, 8551.444156129832, 456.0764451984691, 463.7797046402932, 470.61409644091515, 476.3022172517279, 480.0686667864332, 3773.603771603997, 3822.2164456286396, 3838.8848334550007, 3909.8045097745, 4008.3386241270446, 65000.0, 65913.34086659168, 67824.0, 68589.0, 69408.0, 47193.5280647196, 57938.420615794144, 58360.0, 59017.704911475164, 59380.0, 51249.23126153111, 51288.0, 51925.22112168321, 52980.47019529832, 54155.72922135364, 7585.962070189614, 7597.88603170964, 7621.275978782007, 7690.115636701851, 7806.41451891099, 36798.26403471862, 37281.440778387805, 38376.616233838424, 39124.82625521239, 39518.802405987786, 42748.0, 45264.0, 46068.0, 46553.30170047384, 47176.0, 9510.09654082861, 9556.259509615402, 9607.51962401891, 9672.468014259282, 9966.950165249127, 10530.631427899987, 10801.783964320512, 10875.619353322596, 10941.671749847517, 11137.83293250618, 10009.74975625586, 10543.841842372523, 10614.73463163427, 11103.888961110286, 11107.777844442904, 9861.704148875546, 10028.348157369748, 10054.798904022025, 10066.29535932507, 10135.391876487434, 9243.815123697354, 9435.245180385415, 9461.432314061178, 9475.715728528156, 9502.334836561375, 8794.164554367326, 8932.0, 9064.138906803842, 9066.959934015058, 9103.726888193365, 8523.360747944052, 8724.607392667218, 8732.476051436934, 8795.47227166372, 8845.380823342304], "value": 6022.0156672544235, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1583.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 116.0, 117.0, 118.0, 116.0, 115.0, 116.0, 117.0, 116.0, 115.0], "value": 115.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 127.0, 133.0, 173.0, 131.0, 131.0, 129.0, 130.0, 153.0, 128.0], "value": 138.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 166.0, 177.0, 164.0, 162.0, 162.0, 165.0, 165.0, 164.0], "value": 165.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 78.0, 106.0, 78.0, 79.0, 77.0, 77.0, 94.0, 79.0], "value": 82.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 109.0, 85.0, 85.0, 88.0, 100.0, 85.0, 87.0, 105.0], "value": 91.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 119.0, 118.0, 120.0, 118.0, 118.0, 119.0, 118.0, 118.0, 118.0], "value": 118.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 151.0, 151.0, 150.0, 151.0, 153.0, 153.0, 151.0, 152.0, 150.0], "value": 151.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 97.0, 96.0, 96.0, 97.0, 96.0, 97.0, 96.0], "value": 96.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 70.0, 71.0, 73.0, 73.0, 71.0, 72.0, 72.0, 71.0, 73.0], "value": 71.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 67.0, 68.0, 68.0, 68.0, 68.0, 67.0, 68.0, 68.0], "value": 67.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 86.0, 95.0, 89.0, 93.0, 87.0, 85.0, 85.0, 85.0], "value": 87.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 148.0, 144.0, 133.0, 136.0, 134.0, 142.0, 143.0, 190.0, 149.0], "value": 145.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 184.0, 181.0, 179.0, 181.0, 184.0, 178.0, 182.0, 176.0, 176.0], "value": 179.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 71.0, 70.0, 70.0, 79.0, 70.0, 70.0, 72.0, 69.0, 74.0], "value": 71.5, "unit": "score"}]}]} 08:35:17 INFO - Return code: 0 08:35:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:35:17 ERROR - # TBPL SUCCESS # 08:35:17 INFO - Running post-action listener: _resource_record_post_action 08:35:17 INFO - [mozharness: 2016-12-30 16:35:17.748373Z] Finished run-tests step (success) 08:35:17 INFO - Running post-run listener: _resource_record_post_run 08:35:17 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 4096; Write bytes: 383664128; Read time: 8; Write time: 418556 08:35:17 INFO - TinderboxPrint: CPU usage
13.5% 08:35:17 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 08:35:17 INFO - TinderboxPrint: I/O write bytes / time
383,664,128 / 418,556 08:35:17 INFO - TinderboxPrint: CPU idle
8,279.9 (86.5%) 08:35:17 INFO - TinderboxPrint: CPU user
1,234.4 (12.9%) 08:35:17 INFO - TinderboxPrint: Swap in / out
0 / 0 08:35:17 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99491840; Read time: 0; Write time: 85728 08:35:17 INFO - run-tests - Wall time: 1185s; CPU: 14.0%; Read bytes: 0; Write bytes: 284172288; Read time: 0; Write time: 332828 08:35:18 INFO - Running post-run listener: _upload_blobber_files 08:35:18 INFO - Blob upload gear active. 08:35:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:35:18 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:35:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:35:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:35:18 INFO - (blobuploader) - INFO - Open directory for files ... 08:35:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:35:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:35:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:35:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:35:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:35:19 INFO - (blobuploader) - INFO - Done attempting. 08:35:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:35:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:35:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:35:20 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:35:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:35:20 INFO - (blobuploader) - INFO - Done attempting. 08:35:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:35:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:35:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:35:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:35:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:35:21 INFO - (blobuploader) - INFO - Done attempting. 08:35:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:35:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:35:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:35:24 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:35:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:35:24 INFO - (blobuploader) - INFO - Done attempting. 08:35:24 INFO - (blobuploader) - INFO - Iteration through files over. 08:35:24 INFO - Return code: 0 08:35:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:35:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:35:24 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2237d137c74d78108137e075a27edcaf8f46b0de1a6b1386f74a823d78af453afd49a36aac543fa034b85120f2ae1aa0197a404c8d51bd8075f3168903f290fb", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/97e08b4ea4d6bd18a01d8b9c3b14d61b2a79f97334c807d2aa211da085ce7e2074fe14d970eae0cb544a1be9bf66a7c5bd596eac36a14774d65c1264a08be29d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/050080577b402f95b9578d1ccf8321d52f665ac9b0dcfb3d21865638acdfb80f956a55d22405349b5e7abc8a3d6fef910f3f560ab42fd1b4f7423f68f6e64bbe", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ecc46af7a9e7ffd0e47e6447a179bb27464a0725c94d0f40aa328b65ac6da99d790d6b37eae19725fcf6db53c9886ba42cc85102cd95694e8d137b068d4d61f1"} 08:35:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:35:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:35:24 INFO - Contents: 08:35:24 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2237d137c74d78108137e075a27edcaf8f46b0de1a6b1386f74a823d78af453afd49a36aac543fa034b85120f2ae1aa0197a404c8d51bd8075f3168903f290fb", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/97e08b4ea4d6bd18a01d8b9c3b14d61b2a79f97334c807d2aa211da085ce7e2074fe14d970eae0cb544a1be9bf66a7c5bd596eac36a14774d65c1264a08be29d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/050080577b402f95b9578d1ccf8321d52f665ac9b0dcfb3d21865638acdfb80f956a55d22405349b5e7abc8a3d6fef910f3f560ab42fd1b4f7423f68f6e64bbe", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ecc46af7a9e7ffd0e47e6447a179bb27464a0725c94d0f40aa328b65ac6da99d790d6b37eae19725fcf6db53c9886ba42cc85102cd95694e8d137b068d4d61f1"} 08:35:24 INFO - Running post-run listener: copy_logs_to_upload_dir 08:35:24 INFO - Copying logs to upload dir... 08:35:24 INFO - mkdir: /builds/slave/test/build/upload/logs 08:35:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.749918 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-12-30 08:35:24.509598) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-30 08:35:24.513029) ========= 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=6d15e502d8e29d5d2676d664000001c3-1483114478.357940-448592723 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/Firefox-Non-PGO/sha512/2237d137c74d78108137e075a27edcaf8f46b0de1a6b1386f74a823d78af453afd49a36aac543fa034b85120f2ae1aa0197a404c8d51bd8075f3168903f290fb", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/97e08b4ea4d6bd18a01d8b9c3b14d61b2a79f97334c807d2aa211da085ce7e2074fe14d970eae0cb544a1be9bf66a7c5bd596eac36a14774d65c1264a08be29d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/050080577b402f95b9578d1ccf8321d52f665ac9b0dcfb3d21865638acdfb80f956a55d22405349b5e7abc8a3d6fef910f3f560ab42fd1b4f7423f68f6e64bbe", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ecc46af7a9e7ffd0e47e6447a179bb27464a0725c94d0f40aa328b65ac6da99d790d6b37eae19725fcf6db53c9886ba42cc85102cd95694e8d137b068d4d61f1"} build_url:https://queue.taskcluster.net/v1/task/KH9bo90sSqKbbnytyS9ZfQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011328 build_url: 'https://queue.taskcluster.net/v1/task/KH9bo90sSqKbbnytyS9ZfQ/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/Firefox-Non-PGO/sha512/2237d137c74d78108137e075a27edcaf8f46b0de1a6b1386f74a823d78af453afd49a36aac543fa034b85120f2ae1aa0197a404c8d51bd8075f3168903f290fb", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/97e08b4ea4d6bd18a01d8b9c3b14d61b2a79f97334c807d2aa211da085ce7e2074fe14d970eae0cb544a1be9bf66a7c5bd596eac36a14774d65c1264a08be29d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/050080577b402f95b9578d1ccf8321d52f665ac9b0dcfb3d21865638acdfb80f956a55d22405349b5e7abc8a3d6fef910f3f560ab42fd1b4f7423f68f6e64bbe", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ecc46af7a9e7ffd0e47e6447a179bb27464a0725c94d0f40aa328b65ac6da99d790d6b37eae19725fcf6db53c9886ba42cc85102cd95694e8d137b068d4d61f1"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-30 08:35:24.540477) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-30 08:35:24.541083) ========= 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=6d15e502d8e29d5d2676d664000001c3-1483114478.357940-448592723 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004557 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-30 08:35:24.623898) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-30 08:35:24.624237) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-30 08:35:24.624652) ========= ========= Total master_lag: 0.18 =========