builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-014 starttime: 1475728208.32 results: success (0) buildid: 20161005184400 builduid: 76c680573edf4375bb984bf392c9ec28 revision: cf433f64c1ae9959df46d94e4d10ac6b025f0294 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-05 21:30:08.318099) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-05 21:30:08.318507) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-05 21:30:08.318805) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-05 21:30:08.333998) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 21:30:08.334260) ========= 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=31acecf42b6a79ec49471d4a000001bb-1475711479.15035-895528920 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-05 21:30:08-- 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: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.3M=0s 2016-10-05 21:30:08 (46.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.091584 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 21:30:08.440099) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 21:30:08.440392) ========= 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=31acecf42b6a79ec49471d4a000001bb-1475711479.15035-895528920 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018726 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 21:30:08.519028) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 21:30:08.520101) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev cf433f64c1ae9959df46d94e4d10ac6b025f0294 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev cf433f64c1ae9959df46d94e4d10ac6b025f0294 --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=31acecf42b6a79ec49471d4a000001bb-1475711479.15035-895528920 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-05 21:30:09,063 truncating revision to first 12 chars 2016-10-05 21:30:09,063 Setting DEBUG logging. 2016-10-05 21:30:09,063 attempt 1/10 2016-10-05 21:30:09,063 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/cf433f64c1ae?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-05 21:30:09,516 unpacking tar archive at: mozilla-aurora-cf433f64c1ae/testing/mozharness/ program finished with exit code 0 elapsedTime=0.782869 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 21:30:09.317451) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-05 21:30:09.317748) ========= script_repo_revision: cf433f64c1ae9959df46d94e4d10ac6b025f0294 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-05 21:30:09.318233) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-05 21:30:09.318523) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-05 21:30:09.333290) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-10-05 21:30:09.333709) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=31acecf42b6a79ec49471d4a000001bb-1475711479.15035-895528920 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:30:09 INFO - MultiFileLogger online at 20161005 21:30:09 in /builds/slave/test 21:30:09 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 21:30:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:30:09 INFO - {'append_to_log': False, 21:30:09 INFO - 'base_work_dir': '/builds/slave/test', 21:30:09 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 21:30:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:30:09 INFO - 'branch': 'Mozilla-Aurora', 21:30:09 INFO - 'buildbot_json_path': 'buildprops.json', 21:30:09 INFO - 'config_files': ('talos/linux_config.py',), 21:30:09 INFO - 'default_actions': ('clobber', 21:30:09 INFO - 'read-buildbot-config', 21:30:09 INFO - 'download-and-extract', 21:30:09 INFO - 'populate-webroot', 21:30:09 INFO - 'create-virtualenv', 21:30:09 INFO - 'install', 21:30:09 INFO - 'run-tests'), 21:30:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:30:09 INFO - 'download_minidump_stackwalk': True, 21:30:09 INFO - 'download_symbols': 'ondemand', 21:30:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:30:09 INFO - 'tooltool.py': '/tools/tooltool.py', 21:30:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:30:09 INFO - '/tools/misc-python/virtualenv.py')}, 21:30:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:30:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:30:09 INFO - 'installer_path': 'installer.exe', 21:30:09 INFO - 'log_level': 'info', 21:30:09 INFO - 'log_name': 'talos', 21:30:09 INFO - 'log_to_console': True, 21:30:09 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:30:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:30:09 INFO - 'opt_config_files': (), 21:30:09 INFO - 'pip_index': False, 21:30:09 INFO - 'sps_profile': False, 21:30:09 INFO - 'sps_profile_interval': 0, 21:30:09 INFO - 'suite': 'dromaeojs', 21:30:09 INFO - 'system_bits': '32', 21:30:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:30:09 INFO - 'title': 'talos-linux64-ix-014', 21:30:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:30:09 INFO - 'use_talos_json': True, 21:30:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:30:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:30:09 INFO - 'work_dir': 'build'} 21:30:09 INFO - [mozharness: 2016-10-06 04:30:09.967361Z] Running clobber step. 21:30:09 INFO - Running pre-action listener: _resource_record_pre_action 21:30:09 INFO - Running main action method: clobber 21:30:09 INFO - rmtree: /builds/slave/test/build 21:30:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:30:10 INFO - Running post-action listener: _resource_record_post_action 21:30:10 INFO - [mozharness: 2016-10-06 04:30:10.425450Z] Finished clobber step (success) 21:30:10 INFO - [mozharness: 2016-10-06 04:30:10.425554Z] Running read-buildbot-config step. 21:30:10 INFO - Running pre-action listener: _resource_record_pre_action 21:30:10 INFO - Running main action method: read_buildbot_config 21:30:10 INFO - Using buildbot properties: 21:30:10 INFO - { 21:30:10 INFO - "project": "", 21:30:10 INFO - "product": "firefox", 21:30:10 INFO - "script_repo_revision": "production", 21:30:10 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 21:30:10 INFO - "repository": "", 21:30:10 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 21:30:10 INFO - "buildid": "20161005184400", 21:30:10 INFO - "pgo_build": "True", 21:30:10 INFO - "basedir": "/builds/slave/test", 21:30:10 INFO - "buildnumber": 553, 21:30:10 INFO - "slavename": "talos-linux64-ix-014", 21:30:10 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 21:30:10 INFO - "platform": "ubuntu64_hw", 21:30:10 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 21:30:10 INFO - "branch": "mozilla-aurora", 21:30:10 INFO - "repo_path": "releases/mozilla-aurora", 21:30:10 INFO - "revision": "cf433f64c1ae9959df46d94e4d10ac6b025f0294", 21:30:10 INFO - "stage_platform": "linux64-pgo", 21:30:10 INFO - "builduid": "76c680573edf4375bb984bf392c9ec28", 21:30:10 INFO - "slavebuilddir": "test" 21:30:10 INFO - } 21:30:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/RdMDDJ6eRW6MSbdExDBGZQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2. 21:30:10 INFO - Running post-action listener: _resource_record_post_action 21:30:10 INFO - [mozharness: 2016-10-06 04:30:10.428002Z] Finished read-buildbot-config step (success) 21:30:10 INFO - [mozharness: 2016-10-06 04:30:10.428093Z] Running download-and-extract step. 21:30:10 INFO - Running pre-action listener: _resource_record_pre_action 21:30:10 INFO - Running main action method: download_and_extract 21:30:10 INFO - mkdir: /builds/slave/test/build/tests 21:30:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:30:10 INFO - trying https://queue.taskcluster.net/v1/task/RdMDDJ6eRW6MSbdExDBGZQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 21:30:10 INFO - Downloading https://queue.taskcluster.net/v1/task/RdMDDJ6eRW6MSbdExDBGZQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 21:30:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RdMDDJ6eRW6MSbdExDBGZQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 21:30:10 INFO - Downloaded 1361 bytes. 21:30:10 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 21:30:10 INFO - Using the following test package requirements: 21:30:10 INFO - {u'common': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 21:30:10 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 21:30:10 INFO - u'firefox-51.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 21:30:10 INFO - u'gtest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 21:30:10 INFO - u'firefox-51.0a2.en-US.linux-x86_64.gtest.tests.zip'], 21:30:10 INFO - u'jittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 21:30:10 INFO - u'jsshell-linux-x86_64.zip'], 21:30:10 INFO - u'mochitest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 21:30:10 INFO - u'firefox-51.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 21:30:10 INFO - u'mozbase': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 21:30:10 INFO - u'reftest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 21:30:10 INFO - u'firefox-51.0a2.en-US.linux-x86_64.reftest.tests.zip'], 21:30:10 INFO - u'talos': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 21:30:10 INFO - u'firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'], 21:30:10 INFO - u'web-platform': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 21:30:10 INFO - u'firefox-51.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 21:30:10 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 21:30:10 INFO - u'firefox-51.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 21:30:10 INFO - Downloading packages: [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:30:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RdMDDJ6eRW6MSbdExDBGZQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 21:30:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RdMDDJ6eRW6MSbdExDBGZQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:30:10 INFO - Fetch https://queue.taskcluster.net/v1/task/RdMDDJ6eRW6MSbdExDBGZQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 21:30:11 INFO - Expected file size: 21906965 21:30:16 INFO - Downloading packages: [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 21:30:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RdMDDJ6eRW6MSbdExDBGZQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 21:30:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RdMDDJ6eRW6MSbdExDBGZQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:30:16 INFO - Fetch https://queue.taskcluster.net/v1/task/RdMDDJ6eRW6MSbdExDBGZQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 21:30:16 INFO - Expected file size: 21906965 21:30:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RdMDDJ6eRW6MSbdExDBGZQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip 21:30:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RdMDDJ6eRW6MSbdExDBGZQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 21:30:21 INFO - Fetch https://queue.taskcluster.net/v1/task/RdMDDJ6eRW6MSbdExDBGZQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip into memory 21:30:21 INFO - Expected file size: 14414059 21:30:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:30:22 INFO - trying https://queue.taskcluster.net/v1/task/RdMDDJ6eRW6MSbdExDBGZQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 21:30:22 INFO - Downloading https://queue.taskcluster.net/v1/task/RdMDDJ6eRW6MSbdExDBGZQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 21:30:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RdMDDJ6eRW6MSbdExDBGZQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 21:30:23 INFO - Downloaded 63953838 bytes. 21:30:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RdMDDJ6eRW6MSbdExDBGZQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 21:30:23 INFO - mkdir: /builds/slave/test/properties 21:30:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:30:23 INFO - Writing to file /builds/slave/test/properties/build_url 21:30:23 INFO - Contents: 21:30:23 INFO - build_url:https://queue.taskcluster.net/v1/task/RdMDDJ6eRW6MSbdExDBGZQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 21:30:24 INFO - Running post-action listener: _resource_record_post_action 21:30:24 INFO - Running post-action listener: set_extra_try_arguments 21:30:24 INFO - [mozharness: 2016-10-06 04:30:24.192556Z] Finished download-and-extract step (success) 21:30:24 INFO - [mozharness: 2016-10-06 04:30:24.192787Z] Running populate-webroot step. 21:30:24 INFO - Running pre-action listener: _resource_record_pre_action 21:30:24 INFO - Running main action method: populate_webroot 21:30:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:30:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:30:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:30:24 INFO - '--tppagecycles', 21:30:24 INFO - '7'], 21:30:24 INFO - 'tests': ['tsvgm']}}, 21:30:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:30:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:30:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:30:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:30:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:30:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:30:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:30:24 INFO - 'talos_options': ['--disable-e10s'], 21:30:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:30:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:30:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:30:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:30:24 INFO - 'talos_options': ['--disable-e10s'], 21:30:24 INFO - 'tests': ['damp', 'tps']}, 21:30:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:30:24 INFO - 'tests': ['damp', 'tps']}, 21:30:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:30:24 INFO - 'tests': ['dromaeo_dom']}, 21:30:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:30:24 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:30:24 INFO - 'tests': ['basic_compositor_video']}, 21:30:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:30:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:30:24 INFO - 'tests': ['a11yr', 21:30:24 INFO - 'ts_paint', 21:30:24 INFO - 'tpaint', 21:30:24 INFO - 'sessionrestore', 21:30:24 INFO - 'sessionrestore_no_auto_restore', 21:30:24 INFO - 'tabpaint']}, 21:30:24 INFO - 'other-e10s': {'tests': ['a11yr', 21:30:24 INFO - 'ts_paint', 21:30:24 INFO - 'tpaint', 21:30:24 INFO - 'sessionrestore', 21:30:24 INFO - 'sessionrestore_no_auto_restore', 21:30:24 INFO - 'tabpaint']}, 21:30:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:30:24 INFO - 'ts_paint', 21:30:24 INFO - 'tpaint', 21:30:24 INFO - 'sessionrestore', 21:30:24 INFO - 'sessionrestore_no_auto_restore', 21:30:24 INFO - 'tabpaint']}, 21:30:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:30:24 INFO - 'ts_paint', 21:30:24 INFO - 'tpaint', 21:30:24 INFO - 'sessionrestore', 21:30:24 INFO - 'sessionrestore_no_auto_restore', 21:30:24 INFO - 'tabpaint']}, 21:30:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:30:24 INFO - 'tests': ['a11yr', 21:30:24 INFO - 'ts_paint', 21:30:24 INFO - 'tpaint', 21:30:24 INFO - 'sessionrestore', 21:30:24 INFO - 'sessionrestore_no_auto_restore', 21:30:24 INFO - 'tabpaint']}, 21:30:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:30:24 INFO - 'tests': ['a11yr', 21:30:24 INFO - 'ts_paint', 21:30:24 INFO - 'tpaint', 21:30:24 INFO - 'sessionrestore', 21:30:24 INFO - 'sessionrestore_no_auto_restore', 21:30:24 INFO - 'tabpaint']}, 21:30:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:30:24 INFO - 'tests': ['tsvgx', 21:30:24 INFO - 'tsvgr_opacity', 21:30:24 INFO - 'tart', 21:30:24 INFO - 'tscrollx', 21:30:24 INFO - 'cart']}, 21:30:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:30:24 INFO - 'tsvgr_opacity', 21:30:24 INFO - 'tart', 21:30:24 INFO - 'tscrollx', 21:30:24 INFO - 'cart']}, 21:30:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:30:24 INFO - 'talos_options': ['--disable-e10s'], 21:30:24 INFO - 'tests': ['tp5o']}, 21:30:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:30:24 INFO - 'tests': ['tp5o']}, 21:30:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:30:24 INFO - 'talos_options': ['--disable-e10s', 21:30:24 INFO - '--xperf_path', 21:30:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:30:24 INFO - 'tests': ['tp5n']}, 21:30:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:30:24 INFO - 'talos_options': ['--xperf_path', 21:30:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:30:24 INFO - 'tests': ['tp5n']}}, 21:30:24 INFO - 'talos.zip': {'path': '', 21:30:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:30:24 INFO - Running post-action listener: _resource_record_post_action 21:30:24 INFO - [mozharness: 2016-10-06 04:30:24.208935Z] Finished populate-webroot step (success) 21:30:24 INFO - [mozharness: 2016-10-06 04:30:24.209043Z] Running create-virtualenv step. 21:30:24 INFO - Running pre-action listener: _resource_record_pre_action 21:30:24 INFO - Running main action method: create_virtualenv 21:30:24 INFO - Creating virtualenv /builds/slave/test/build/venv 21:30:24 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 21:30:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:30:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:30:24 INFO - Using real prefix '/usr' 21:30:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:30:24 INFO - Installing distribute.............................................................................................................................................................................................done. 21:30:26 INFO - Installing pip.................done. 21:30:26 INFO - Return code: 0 21:30:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:30:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:30:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:30:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:30:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:30:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7d59691f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc2f60>, '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 0x2bc3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc41d0>, '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': '31acecf42b6a79ec49471d4a000001bb-1475711479.15035-895528920', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:30:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 21:30:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 21:30:26 INFO - Using env: {'DISPLAY': ':0', 21:30:26 INFO - 'HOME': '/home/cltbld', 21:30:26 INFO - 'LANG': 'en_US.UTF-8', 21:30:26 INFO - 'LANGUAGE': 'en_US:en', 21:30:26 INFO - 'LOGNAME': 'cltbld', 21:30:26 INFO - 'MAIL': '/var/mail/cltbld', 21:30:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:30:26 INFO - 'MOZ_NO_REMOTE': '1', 21:30:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:30:26 INFO - 'NO_EM_RESTART': '1', 21:30:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:30:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:30:26 INFO - 'PWD': '/builds/slave/test', 21:30:26 INFO - 'SHELL': '/bin/bash', 21:30:26 INFO - 'SHLVL': '1', 21:30:26 INFO - 'TERM': 'linux', 21:30:26 INFO - 'TMOUT': '86400', 21:30:26 INFO - 'USER': 'cltbld', 21:30:26 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1475711479.15035-895528920', 21:30:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:30:26 INFO - '_': '/tools/buildbot/bin/python'} 21:30:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:30:26 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 21:30:26 INFO - Cleaning up... 21:30:27 INFO - Return code: 0 21:30:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:30:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:30:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:30:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:30:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:30:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7d59691f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc2f60>, '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 0x2bc3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc41d0>, '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': '31acecf42b6a79ec49471d4a000001bb-1475711479.15035-895528920', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:30:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 21:30:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 21:30:27 INFO - Using env: {'DISPLAY': ':0', 21:30:27 INFO - 'HOME': '/home/cltbld', 21:30:27 INFO - 'LANG': 'en_US.UTF-8', 21:30:27 INFO - 'LANGUAGE': 'en_US:en', 21:30:27 INFO - 'LOGNAME': 'cltbld', 21:30:27 INFO - 'MAIL': '/var/mail/cltbld', 21:30:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:30:27 INFO - 'MOZ_NO_REMOTE': '1', 21:30:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:30:27 INFO - 'NO_EM_RESTART': '1', 21:30:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:30:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:30:27 INFO - 'PWD': '/builds/slave/test', 21:30:27 INFO - 'SHELL': '/bin/bash', 21:30:27 INFO - 'SHLVL': '1', 21:30:27 INFO - 'TERM': 'linux', 21:30:27 INFO - 'TMOUT': '86400', 21:30:27 INFO - 'USER': 'cltbld', 21:30:27 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1475711479.15035-895528920', 21:30:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:30:27 INFO - '_': '/tools/buildbot/bin/python'} 21:30:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:30:27 INFO - Downloading/unpacking psutil>=3.1.1 21:30:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:30:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:30:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:30:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:30:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:30:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:30:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:30:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:30:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:30:29 INFO - Installing collected packages: psutil 21:30:29 INFO - Running setup.py install for psutil 21:30:29 INFO - building 'psutil._psutil_linux' extension 21:30:29 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 21:30:29 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 21:30:29 INFO - building 'psutil._psutil_posix' extension 21:30:29 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 21:30:29 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 21:30:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:30:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:30:29 INFO - Successfully installed psutil 21:30:29 INFO - Cleaning up... 21:30:29 INFO - Return code: 0 21:30:29 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:30:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:30:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:30:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:30:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:30:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7d59691f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc2f60>, '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 0x2bc3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc41d0>, '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': '31acecf42b6a79ec49471d4a000001bb-1475711479.15035-895528920', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:30:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 21:30:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 21:30:29 INFO - Using env: {'DISPLAY': ':0', 21:30:29 INFO - 'HOME': '/home/cltbld', 21:30:29 INFO - 'LANG': 'en_US.UTF-8', 21:30:29 INFO - 'LANGUAGE': 'en_US:en', 21:30:29 INFO - 'LOGNAME': 'cltbld', 21:30:29 INFO - 'MAIL': '/var/mail/cltbld', 21:30:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:30:29 INFO - 'MOZ_NO_REMOTE': '1', 21:30:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:30:29 INFO - 'NO_EM_RESTART': '1', 21:30:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:30:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:30:29 INFO - 'PWD': '/builds/slave/test', 21:30:29 INFO - 'SHELL': '/bin/bash', 21:30:29 INFO - 'SHLVL': '1', 21:30:29 INFO - 'TERM': 'linux', 21:30:29 INFO - 'TMOUT': '86400', 21:30:29 INFO - 'USER': 'cltbld', 21:30:29 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1475711479.15035-895528920', 21:30:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:30:29 INFO - '_': '/tools/buildbot/bin/python'} 21:30:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:30:29 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:30:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:30:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:30:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:30:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:30:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:30:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:30:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:30:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:30:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:30:31 INFO - Installing collected packages: mozsystemmonitor 21:30:31 INFO - Running setup.py install for mozsystemmonitor 21:30:32 INFO - Successfully installed mozsystemmonitor 21:30:32 INFO - Cleaning up... 21:30:32 INFO - Return code: 0 21:30:32 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:30:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:30:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:30:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:30:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:30:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7d59691f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc2f60>, '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 0x2bc3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc41d0>, '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': '31acecf42b6a79ec49471d4a000001bb-1475711479.15035-895528920', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:30:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 21:30:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 21:30:32 INFO - Using env: {'DISPLAY': ':0', 21:30:32 INFO - 'HOME': '/home/cltbld', 21:30:32 INFO - 'LANG': 'en_US.UTF-8', 21:30:32 INFO - 'LANGUAGE': 'en_US:en', 21:30:32 INFO - 'LOGNAME': 'cltbld', 21:30:32 INFO - 'MAIL': '/var/mail/cltbld', 21:30:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:30:32 INFO - 'MOZ_NO_REMOTE': '1', 21:30:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:30:32 INFO - 'NO_EM_RESTART': '1', 21:30:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:30:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:30:32 INFO - 'PWD': '/builds/slave/test', 21:30:32 INFO - 'SHELL': '/bin/bash', 21:30:32 INFO - 'SHLVL': '1', 21:30:32 INFO - 'TERM': 'linux', 21:30:32 INFO - 'TMOUT': '86400', 21:30:32 INFO - 'USER': 'cltbld', 21:30:32 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1475711479.15035-895528920', 21:30:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:30:32 INFO - '_': '/tools/buildbot/bin/python'} 21:30:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:30:32 INFO - Downloading/unpacking jsonschema==2.5.1 21:30:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:30:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:30:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:30:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:30:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:30:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:30:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:30:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:30:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:30:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:30:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:30:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:30:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:30:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:30:34 INFO - Downloading functools32-3.2.3-2.tar.gz 21:30:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:30:34 INFO - warning: no files found matching '*.txt' 21:30:34 INFO - no previously-included directories found matching 'build' 21:30:34 INFO - no previously-included directories found matching 'dist' 21:30:34 INFO - no previously-included directories found matching '.git*' 21:30:34 INFO - Installing collected packages: jsonschema, functools32 21:30:34 INFO - Running setup.py install for functools32 21:30:34 INFO - warning: no files found matching '*.txt' 21:30:34 INFO - no previously-included directories found matching 'build' 21:30:34 INFO - no previously-included directories found matching 'dist' 21:30:34 INFO - no previously-included directories found matching '.git*' 21:30:34 INFO - Successfully installed jsonschema functools32 21:30:34 INFO - Cleaning up... 21:30:34 INFO - Return code: 0 21:30:34 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:30:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:30:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:30:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:30:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:30:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30:34 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 0x7f7d59691f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc2f60>, '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 0x2bc3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc41d0>, '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': '31acecf42b6a79ec49471d4a000001bb-1475711479.15035-895528920', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:30:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 21:30:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 21:30:34 INFO - Using env: {'DISPLAY': ':0', 21:30:34 INFO - 'HOME': '/home/cltbld', 21:30:34 INFO - 'LANG': 'en_US.UTF-8', 21:30:34 INFO - 'LANGUAGE': 'en_US:en', 21:30:34 INFO - 'LOGNAME': 'cltbld', 21:30:34 INFO - 'MAIL': '/var/mail/cltbld', 21:30:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:30:34 INFO - 'MOZ_NO_REMOTE': '1', 21:30:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:30:34 INFO - 'NO_EM_RESTART': '1', 21:30:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:30:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:30:34 INFO - 'PWD': '/builds/slave/test', 21:30:34 INFO - 'SHELL': '/bin/bash', 21:30:34 INFO - 'SHLVL': '1', 21:30:34 INFO - 'TERM': 'linux', 21:30:34 INFO - 'TMOUT': '86400', 21:30:34 INFO - 'USER': 'cltbld', 21:30:34 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1475711479.15035-895528920', 21:30:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:30:34 INFO - '_': '/tools/buildbot/bin/python'} 21:30:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:30:34 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:30:34 INFO - Cleaning up... 21:30:34 INFO - Return code: 0 21:30:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:30:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:30:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:30:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:30:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:30:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30:34 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 0x7f7d59691f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc2f60>, '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 0x2bc3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc41d0>, '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': '31acecf42b6a79ec49471d4a000001bb-1475711479.15035-895528920', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:30:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 21:30:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 21:30:34 INFO - Using env: {'DISPLAY': ':0', 21:30:34 INFO - 'HOME': '/home/cltbld', 21:30:34 INFO - 'LANG': 'en_US.UTF-8', 21:30:34 INFO - 'LANGUAGE': 'en_US:en', 21:30:34 INFO - 'LOGNAME': 'cltbld', 21:30:34 INFO - 'MAIL': '/var/mail/cltbld', 21:30:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:30:34 INFO - 'MOZ_NO_REMOTE': '1', 21:30:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:30:34 INFO - 'NO_EM_RESTART': '1', 21:30:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:30:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:30:34 INFO - 'PWD': '/builds/slave/test', 21:30:34 INFO - 'SHELL': '/bin/bash', 21:30:34 INFO - 'SHLVL': '1', 21:30:34 INFO - 'TERM': 'linux', 21:30:34 INFO - 'TMOUT': '86400', 21:30:34 INFO - 'USER': 'cltbld', 21:30:34 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1475711479.15035-895528920', 21:30:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:30:34 INFO - '_': '/tools/buildbot/bin/python'} 21:30:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:30:35 INFO - Downloading/unpacking blobuploader==1.2.4 21:30:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:30:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:30:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:30:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:30:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:30:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:30:36 INFO - Downloading blobuploader-1.2.4.tar.gz 21:30:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:30:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:30:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:30:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:30:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:30:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:30:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:30:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:30:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:30:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:30:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:30:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:30:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:30:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:30:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:30:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:30:37 INFO - Downloading docopt-0.6.1.tar.gz 21:30:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:30:37 INFO - Installing collected packages: blobuploader, requests, docopt 21:30:37 INFO - Running setup.py install for blobuploader 21:30:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:30:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:30:37 INFO - Running setup.py install for requests 21:30:38 INFO - Running setup.py install for docopt 21:30:38 INFO - Successfully installed blobuploader requests docopt 21:30:38 INFO - Cleaning up... 21:30:38 INFO - Return code: 0 21:30:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:30:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:30:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:30:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:30:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:30:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7d59691f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc2f60>, '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 0x2bc3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc41d0>, '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': '31acecf42b6a79ec49471d4a000001bb-1475711479.15035-895528920', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:30:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 21:30:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:30:38 INFO - Using env: {'DISPLAY': ':0', 21:30:38 INFO - 'HOME': '/home/cltbld', 21:30:38 INFO - 'LANG': 'en_US.UTF-8', 21:30:38 INFO - 'LANGUAGE': 'en_US:en', 21:30:38 INFO - 'LOGNAME': 'cltbld', 21:30:38 INFO - 'MAIL': '/var/mail/cltbld', 21:30:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:30:38 INFO - 'MOZ_NO_REMOTE': '1', 21:30:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:30:38 INFO - 'NO_EM_RESTART': '1', 21:30:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:30:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:30:38 INFO - 'PWD': '/builds/slave/test', 21:30:38 INFO - 'SHELL': '/bin/bash', 21:30:38 INFO - 'SHLVL': '1', 21:30:38 INFO - 'TERM': 'linux', 21:30:38 INFO - 'TMOUT': '86400', 21:30:38 INFO - 'USER': 'cltbld', 21:30:38 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1475711479.15035-895528920', 21:30:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:30:38 INFO - '_': '/tools/buildbot/bin/python'} 21:30:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:30:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:30:38 INFO - Running setup.py (path:/tmp/pip-y0m7H7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:30:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:30:38 INFO - Running setup.py (path:/tmp/pip-h2qzl8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:30:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:30:38 INFO - Running setup.py (path:/tmp/pip-8eBCJI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:30:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:30:38 INFO - Running setup.py (path:/tmp/pip-UWSrkM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:30:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:30:38 INFO - Running setup.py (path:/tmp/pip-Nw2kZA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:30:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:30:38 INFO - Running setup.py (path:/tmp/pip-1eW5sT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:30:39 INFO - Running setup.py (path:/tmp/pip-NFkZJr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:30:39 INFO - Running setup.py (path:/tmp/pip-4EdCBT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:30:39 INFO - Running setup.py (path:/tmp/pip-F2C9oG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:30:39 INFO - Running setup.py (path:/tmp/pip-QV9TEU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:30:39 INFO - Running setup.py (path:/tmp/pip-oGPY3H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:30:39 INFO - Running setup.py (path:/tmp/pip-gTXauM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:30:39 INFO - Running setup.py (path:/tmp/pip-Ggn_s9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:30:39 INFO - Running setup.py (path:/tmp/pip-AqjLNs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:30:39 INFO - Running setup.py (path:/tmp/pip-9fzZJA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:30:39 INFO - Running setup.py (path:/tmp/pip-GEIWJx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:30:39 INFO - Running setup.py (path:/tmp/pip-VHg9Iv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:30:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:30:39 INFO - Running setup.py install for manifestparser 21:30:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:30:39 INFO - Running setup.py install for mozcrash 21:30:39 INFO - Running setup.py install for mozdebug 21:30:40 INFO - Running setup.py install for mozdevice 21:30:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:30:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:30:40 INFO - Running setup.py install for mozfile 21:30:40 INFO - Running setup.py install for mozhttpd 21:30:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:30:40 INFO - Running setup.py install for mozinfo 21:30:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:30:40 INFO - Running setup.py install for mozInstall 21:30:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:30:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:30:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:30:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:30:40 INFO - Running setup.py install for mozleak 21:30:40 INFO - Running setup.py install for mozlog 21:30:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:30:40 INFO - Running setup.py install for moznetwork 21:30:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:30:40 INFO - Running setup.py install for mozprocess 21:30:41 INFO - Running setup.py install for mozprofile 21:30:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:30:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:30:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:30:41 INFO - Running setup.py install for mozrunner 21:30:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:30:41 INFO - Running setup.py install for mozscreenshot 21:30:41 INFO - Running setup.py install for moztest 21:30:41 INFO - Running setup.py install for mozversion 21:30:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:30:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:30:41 INFO - Cleaning up... 21:30:41 INFO - Return code: 0 21:30:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:30:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:30:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:30:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:30:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:30:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30:41 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 0x7f7d59691f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc2f60>, '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 0x2bc3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc41d0>, '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': '31acecf42b6a79ec49471d4a000001bb-1475711479.15035-895528920', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:30:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 21:30:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:30:41 INFO - Using env: {'DISPLAY': ':0', 21:30:41 INFO - 'HOME': '/home/cltbld', 21:30:41 INFO - 'LANG': 'en_US.UTF-8', 21:30:41 INFO - 'LANGUAGE': 'en_US:en', 21:30:41 INFO - 'LOGNAME': 'cltbld', 21:30:41 INFO - 'MAIL': '/var/mail/cltbld', 21:30:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:30:41 INFO - 'MOZ_NO_REMOTE': '1', 21:30:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:30:41 INFO - 'NO_EM_RESTART': '1', 21:30:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:30:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:30:41 INFO - 'PWD': '/builds/slave/test', 21:30:41 INFO - 'SHELL': '/bin/bash', 21:30:41 INFO - 'SHLVL': '1', 21:30:41 INFO - 'TERM': 'linux', 21:30:41 INFO - 'TMOUT': '86400', 21:30:41 INFO - 'USER': 'cltbld', 21:30:41 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1475711479.15035-895528920', 21:30:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:30:41 INFO - '_': '/tools/buildbot/bin/python'} 21:30:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:30:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:30:41 INFO - Running setup.py (path:/tmp/pip-UAH2Qi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:30:41 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 21:30:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:30:41 INFO - Running setup.py (path:/tmp/pip-xpZuhi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:30:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:30:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:30:41 INFO - Running setup.py (path:/tmp/pip-ETAU5Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:30:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 21:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:30:42 INFO - Running setup.py (path:/tmp/pip-RoevcG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:30:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:30:42 INFO - Running setup.py (path:/tmp/pip-oOG9Sp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:30:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 21:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:30:42 INFO - Running setup.py (path:/tmp/pip-Und2dJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:30:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 21:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:30:42 INFO - Running setup.py (path:/tmp/pip-vSA7c9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:30:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 21:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:30:42 INFO - Running setup.py (path:/tmp/pip-NImVoU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:30:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 21:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:30:42 INFO - Running setup.py (path:/tmp/pip-woKSrz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:30:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 21:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:30:42 INFO - Running setup.py (path:/tmp/pip-myXLR8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:30:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:30:42 INFO - Running setup.py (path:/tmp/pip-bfmGsy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:30:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 21:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:30:42 INFO - Running setup.py (path:/tmp/pip-5rl7Tr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:30:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 21:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:30:42 INFO - Running setup.py (path:/tmp/pip-3L6Ib7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:30:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 21:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:30:42 INFO - Running setup.py (path:/tmp/pip-EBpsQP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:30:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 21:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:30:42 INFO - Running setup.py (path:/tmp/pip-THxAi1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:30:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 21:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:30:42 INFO - Running setup.py (path:/tmp/pip-ZSzuEc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:30:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 21:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:30:42 INFO - Running setup.py (path:/tmp/pip-DQhtih-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:30:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 21:30:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:30:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:30:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 21:30:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:30:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:30:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:30:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:30:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:30:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:30:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:30:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:30:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:30:44 INFO - Downloading blessings-1.6.tar.gz 21:30:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:30:45 INFO - Installing collected packages: blessings 21:30:45 INFO - Running setup.py install for blessings 21:30:45 INFO - Successfully installed blessings 21:30:45 INFO - Cleaning up... 21:30:45 INFO - Return code: 0 21:30:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:30:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:30:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:30:45 INFO - Reading from file tmpfile_stdout 21:30:45 INFO - Current package versions: 21:30:45 INFO - argparse == 1.2.1 21:30:45 INFO - blessings == 1.6 21:30:45 INFO - blobuploader == 1.2.4 21:30:45 INFO - docopt == 0.6.1 21:30:45 INFO - functools32 == 3.2.3-2 21:30:45 INFO - jsonschema == 2.5.1 21:30:45 INFO - manifestparser == 1.1 21:30:45 INFO - mozInstall == 1.12 21:30:45 INFO - mozcrash == 0.17 21:30:45 INFO - mozdebug == 0.1 21:30:45 INFO - mozdevice == 0.48 21:30:45 INFO - mozfile == 1.2 21:30:45 INFO - mozhttpd == 0.7 21:30:45 INFO - mozinfo == 0.9 21:30:45 INFO - mozleak == 0.1 21:30:45 INFO - mozlog == 3.4 21:30:45 INFO - moznetwork == 0.27 21:30:45 INFO - mozprocess == 0.23 21:30:45 INFO - mozprofile == 0.28 21:30:45 INFO - mozrunner == 6.12 21:30:45 INFO - mozscreenshot == 0.1 21:30:45 INFO - mozsystemmonitor == 0.3 21:30:45 INFO - moztest == 0.7 21:30:45 INFO - mozversion == 1.4 21:30:45 INFO - psutil == 3.1.1 21:30:45 INFO - requests == 1.2.3 21:30:45 INFO - wsgiref == 0.1.2 21:30:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:30:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:30:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:30:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:30:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:30:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30:45 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 0x7f7d59691f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc2f60>, '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 0x2bc3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc41d0>, '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': '31acecf42b6a79ec49471d4a000001bb-1475711479.15035-895528920', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:30:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 21:30:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:30:45 INFO - Using env: {'DISPLAY': ':0', 21:30:45 INFO - 'HOME': '/home/cltbld', 21:30:45 INFO - 'LANG': 'en_US.UTF-8', 21:30:45 INFO - 'LANGUAGE': 'en_US:en', 21:30:45 INFO - 'LOGNAME': 'cltbld', 21:30:45 INFO - 'MAIL': '/var/mail/cltbld', 21:30:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:30:45 INFO - 'MOZ_NO_REMOTE': '1', 21:30:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:30:45 INFO - 'NO_EM_RESTART': '1', 21:30:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:30:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:30:45 INFO - 'PWD': '/builds/slave/test', 21:30:45 INFO - 'SHELL': '/bin/bash', 21:30:45 INFO - 'SHLVL': '1', 21:30:45 INFO - 'TERM': 'linux', 21:30:45 INFO - 'TMOUT': '86400', 21:30:45 INFO - 'USER': 'cltbld', 21:30:45 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1475711479.15035-895528920', 21:30:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:30:45 INFO - '_': '/tools/buildbot/bin/python'} 21:30:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:30:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 21:30:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 21:30:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 21:30:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 21:30:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 21:30:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 21:30:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 21:30:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 21:30:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 21:30:45 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 21:30:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 21:30:45 INFO - Cleaning up... 21:30:45 INFO - Return code: 0 21:30:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:30:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:30:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:30:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:30:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:30:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30:45 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 0x7f7d59691f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc2f60>, '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 0x2bc3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc41d0>, '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': '31acecf42b6a79ec49471d4a000001bb-1475711479.15035-895528920', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:30:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 21:30:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 21:30:45 INFO - Using env: {'DISPLAY': ':0', 21:30:45 INFO - 'HOME': '/home/cltbld', 21:30:45 INFO - 'LANG': 'en_US.UTF-8', 21:30:45 INFO - 'LANGUAGE': 'en_US:en', 21:30:45 INFO - 'LOGNAME': 'cltbld', 21:30:45 INFO - 'MAIL': '/var/mail/cltbld', 21:30:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:30:45 INFO - 'MOZ_NO_REMOTE': '1', 21:30:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:30:45 INFO - 'NO_EM_RESTART': '1', 21:30:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:30:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:30:45 INFO - 'PWD': '/builds/slave/test', 21:30:45 INFO - 'SHELL': '/bin/bash', 21:30:45 INFO - 'SHLVL': '1', 21:30:45 INFO - 'TERM': 'linux', 21:30:45 INFO - 'TMOUT': '86400', 21:30:45 INFO - 'USER': 'cltbld', 21:30:45 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1475711479.15035-895528920', 21:30:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:30:45 INFO - '_': '/tools/buildbot/bin/python'} 21:30:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:30:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:30:45 INFO - Cleaning up... 21:30:45 INFO - Return code: 0 21:30:45 INFO - Running post-action listener: _resource_record_post_action 21:30:45 INFO - Running post-action listener: _start_resource_monitoring 21:30:45 INFO - Starting resource monitoring. 21:30:45 INFO - [mozharness: 2016-10-06 04:30:45.922199Z] Finished create-virtualenv step (success) 21:30:45 INFO - [mozharness: 2016-10-06 04:30:45.922704Z] Running install step. 21:30:45 INFO - Running pre-action listener: _resource_record_pre_action 21:30:45 INFO - Running main action method: install 21:30:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:30:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:30:46 INFO - Reading from file tmpfile_stdout 21:30:46 INFO - Detecting whether we're running mozinstall >=1.0... 21:30:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:30:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:30:46 INFO - Reading from file tmpfile_stdout 21:30:46 INFO - Output received: 21:30:46 INFO - Usage: mozinstall [options] installer 21:30:46 INFO - Options: 21:30:46 INFO - -h, --help show this help message and exit 21:30:46 INFO - -d DEST, --destination=DEST 21:30:46 INFO - Directory to install application into. [default: 21:30:46 INFO - "/builds/slave/test"] 21:30:46 INFO - --app=APP Application being installed. [default: firefox] 21:30:46 INFO - mkdir: /builds/slave/test/build/application 21:30:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 21:30:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 21:31:02 INFO - Reading from file tmpfile_stdout 21:31:02 INFO - Output received: 21:31:02 INFO - /builds/slave/test/build/application/firefox/firefox 21:31:02 INFO - Running post-action listener: _resource_record_post_action 21:31:02 INFO - [mozharness: 2016-10-06 04:31:02.155808Z] Finished install step (success) 21:31:02 INFO - [mozharness: 2016-10-06 04:31:02.156052Z] Running run-tests step. 21:31:02 INFO - Running pre-action listener: _resource_record_pre_action 21:31:02 INFO - Running main action method: run_tests 21:31:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:31:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:31:02 INFO - Python 2.7.3 21:31:02 INFO - Return code: 0 21:31:02 INFO - grabbing minidump binary from tooltool 21:31: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')]} 21:31:02 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 0x2bc2f60>, '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 0x2bc3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc41d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:31:02 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 21:31:02 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 21:31:02 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 21:31:02 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:31:02 INFO - Return code: 0 21:31:02 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:31:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:31:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:31:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:31:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:31:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RdMDDJ6eRW6MSbdExDBGZQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 21:31:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RdMDDJ6eRW6MSbdExDBGZQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-014 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 21:31:02 INFO - Using env: {'DISPLAY': ':0', 21:31:02 INFO - 'HOME': '/home/cltbld', 21:31:02 INFO - 'LANG': 'en_US.UTF-8', 21:31:02 INFO - 'LANGUAGE': 'en_US:en', 21:31:02 INFO - 'LOGNAME': 'cltbld', 21:31:02 INFO - 'MAIL': '/var/mail/cltbld', 21:31:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:31:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:31:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:31:02 INFO - 'MOZ_NO_REMOTE': '1', 21:31:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:31:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:31:02 INFO - 'NO_EM_RESTART': '1', 21:31:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:31:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:31:02 INFO - 'PWD': '/builds/slave/test', 21:31:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:31:02 INFO - 'SHELL': '/bin/bash', 21:31:02 INFO - 'SHLVL': '1', 21:31:02 INFO - 'TERM': 'linux', 21:31:02 INFO - 'TMOUT': '86400', 21:31:02 INFO - 'USER': 'cltbld', 21:31:02 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1475711479.15035-895528920', 21:31:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:31:02 INFO - '_': '/tools/buildbot/bin/python'} 21:31:02 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RdMDDJ6eRW6MSbdExDBGZQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 21:31:02 INFO - mozversion application_buildid: 20161005184400 21:31:02 INFO - mozversion application_changeset: cf433f64c1ae9959df46d94e4d10ac6b025f0294 21:31:02 INFO - mozversion application_display_name: FirefoxDeveloperEdition 21:31:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:31:02 INFO - mozversion application_name: Firefox 21:31:02 INFO - mozversion application_remotingname: firefox-dev 21:31:02 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 21:31:02 INFO - mozversion application_vendor: Mozilla 21:31:02 INFO - mozversion application_version: 51.0a2 21:31:02 INFO - mozversion platform_buildid: 20161005184400 21:31:02 INFO - mozversion platform_changeset: cf433f64c1ae9959df46d94e4d10ac6b025f0294 21:31:02 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 21:31:02 INFO - mozversion platform_version: 51.0a2 21:31:02 INFO - using testdate: 1475728262 21:31:02 INFO - actual date: 1475728262 21:31:02 INFO - starting webserver on 'localhost:33922' 21:31:02 INFO - SUITE-START | Running 2 tests 21:31:02 INFO - TEST-START | dromaeo_css 21:31:02 INFO - operating with platform_type : linux_ 21:31:02 INFO - Initialising browser for dromaeo_css test... 21:31:02 INFO - TEST-INFO | started process 25713 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3YwEZY/profile http://localhost:33922/getInfo.html) 21:31:06 INFO - PROCESS | 25713 | __metrics Screen width/height:1600/1200 21:31:06 INFO - PROCESS | 25713 | colorDepth:24 21:31:06 INFO - PROCESS | 25713 | Browser inner width/height: 1024/697 21:31:06 INFO - PROCESS | 25713 | __metrics 21:31:06 INFO - PROCESS | 25713 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:31:06 INFO - PROCESS | 25713 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:31:07 INFO - PROCESS | 25713 | console.error: PushService: 21:31:07 INFO - PROCESS | 25713 | stateChangeProcessEnqueue: Error transitioning state 21:31:07 INFO - PROCESS | 25713 | UnknownError 21:31:07 INFO - TEST-INFO | 25713: exit 0 21:31:07 INFO - Browser initialized. 21:31:07 INFO - Running cycle 1/1 for dromaeo_css test... 21:31:07 INFO - TEST-INFO | started process 25802 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3YwEZY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:31:19 INFO - PROCESS | 25802 | RSS: Main: 144584704 21:31:19 INFO - PROCESS | 25802 | 21:32:10 INFO - PROCESS | 25802 | 1475728330834 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 21:34:19 INFO - PROCESS | 25802 | Cycle 1(1): loaded http://localhost:33922/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33922/tests/dromaeo/cssquery-ext.html) 21:34:20 INFO - PROCESS | 25802 | RSS: Main: 229601280 21:34:20 INFO - PROCESS | 25802 | 21:37:23 INFO - PROCESS | 25802 | Cycle 1(1): loaded http://localhost:33922/tests/dromaeo/cssquery-ext.html (next: http://localhost:33922/tests/dromaeo/cssquery-jquery.html) 21:37:23 INFO - PROCESS | 25802 | RSS: Main: 226492416 21:37:23 INFO - PROCESS | 25802 | 21:40:25 INFO - PROCESS | 25802 | Cycle 1(1): loaded http://localhost:33922/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33922/tests/dromaeo/cssquery-mootools.html) 21:40:26 INFO - PROCESS | 25802 | RSS: Main: 175108096 21:40:26 INFO - PROCESS | 25802 | 21:43:28 INFO - PROCESS | 25802 | Cycle 1(1): loaded http://localhost:33922/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33922/tests/dromaeo/cssquery-prototype.html) 21:43:28 INFO - PROCESS | 25802 | RSS: Main: 218664960 21:43:28 INFO - PROCESS | 25802 | 21:46:31 INFO - PROCESS | 25802 | Cycle 1(1): loaded http://localhost:33922/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33922/tests/dromaeo/cssquery-yui.html) 21:46:32 INFO - PROCESS | 25802 | RSS: Main: 177844224 21:46:32 INFO - PROCESS | 25802 | 21:49:34 INFO - PROCESS | 25802 | Cycle 1(1): loaded http://localhost:33922/tests/dromaeo/cssquery-yui.html (next: http://localhost:33922/tests/dromaeo/cssquery-dojo.html) 21:49:34 INFO - PROCESS | 25802 | RSS: Main: 261324800 21:49:34 INFO - PROCESS | 25802 | 21:49:34 INFO - PROCESS | 25802 | __start_tp_report 21:49:34 INFO - PROCESS | 25802 | _x_x_mozilla_page_load 21:49:34 INFO - PROCESS | 25802 | _x_x_mozilla_page_load_details 21:49:34 INFO - PROCESS | 25802 | |i|pagename|runs| 21:49:34 INFO - PROCESS | 25802 | |0;dojo.html;3121.2821051158235;3162.20944763809;3165.5093460513613;3174.9047528574124;3202.103411044907;5546.91679624806;5619.719014049297;5629.183768353591;5633.859153521164;5643.746031428595;5626.409227031164;5660.009498337795;5662.518685911702;5676.347220069693;5698.715064246781;5112.897742045147;5134.0758663440565;5174.094533456649;5178.352705911761;5202.4277329493725;5129.179331306992;5194.792208311663;5221.164613661815;5221.425643179247;5223.477652234765;4995.850124496271;5070.72111033893;5095.770690318926;5106.69359838409;5108.795648174088;5027.717931927354;5063.493650634944;5067.214581739836;5163.044836705184;5206.401263854629;4992.525710057539;5062.987402519474;5109.208072748693;5121.411037730634;5122.078025955327;5491.066518691832;5504.669719816824;5542.972285138589;5574.331080270394;5635.718214089279;5899.115132730082;5924.348321684612;5929.9703501482645;6006.099085137221;6012.6392416455155;6046.093086037085;6048.909266361008;6057.878842423171;6059.878802423927;6060.090986352038;5568.136938774496;5569.777208911639;5610.046292130348;5617.578681598856;5619.381867994517;6145.139680444741;6180.81457556274;6182.010878259547;6182.443580077725;6184.567080304336;5905.645661260252;5914.0241860093465;5916.7337469813965;5919.6152250103605;5941.643501389931;5929.644221346733;5956.0768080946655;5978;6012.969935150384;6016.09758536223;6052.092186172022;6056;6059.454649081604;6088.1476593276975;6088.573799834057;6042.1843051187525;6057.909131363033;6061.242344706911;6076.179715738407;6082.726277317532;4615.861524154281;4654.16225079489;4684.180268453007;4692.554207350297;4704.270838020044;4104.8768536943935;4150.252954468165;4150.522689890641;4152.480939882515;4187.225363307798;5833.416658334218;5839.270091238595;5844.47399734026;5847.502962248256;5850.414958504116;5956.970215148896;6175.907361389583;6180.289266734383;6189.0097584386285;6190.628562286187;5720.713964301768;5747.597668163272;5801.970990145022;5803.970980145156;5887.087501437284;5288;5327.627066105335;5331.573474122061;5336.386315573681;5336.733163341895;6281.309056003836;6325.304216536178;6343.11196432509;6349.111124442582;6350.110984462179;5954.642721436728;6011.549133815069;6048.576599637983;6114.908276375769;6121.877562448815;6338.936610634019;6362.77730279438;6363.109164717036;6365.52258580599;6369.649669268235;6052.182955300978;6055.576109672281;6063.575549711478;6068.089786532056;6073.331933487225;5920.674362910081;5961.225040744675;5991.730372133352;6103.389661033861;6147.354527774519;5842.036064049385;5999.100134979613;5999.760009599567;6028.246469191351;6037.335893051849;5988.221531200916;5990.1913241713555;5994.730237139426;6001.729922153426;6004.8799024020145;5707.258056452634;5762.481376676119;5867.061270196748;5916.615419997686;5927.436893495111;5824.854378640568;5894.440028197314;5904.114382842608;5967.76128954837;5994.520438365008;5767;5799.130130480293;5804.100364443518;5809.8547536311935;5813.302403711413 21:49:34 INFO - PROCESS | 25802 | |1;ext.html;587.3216435017555;591.1546488521412;624.250898921294;631.8799428108656;634.4987459906674;35254.64745352549;38295.42556861646;46230.76884615576;46439.6068117957;46984;46445.30332045013;46846;46877;46920.765396172974;46926.29610555836;8369.83260334793;9152.176304132627;9294.953525232399;9302.53487325631;9303.441793492411;8302.667893284291;11038.613648522303;11289.887101128967;11291.887081129165;11295.378754168518;11107.278026928265;11169.49737261821;11172.329660220372;11181.944090279578;11183.217174797768;10964.122870170408;11010.614628487965;11023.283486573388;11032.44837758117;11037.668869933916;10812.891871081267;10978.945105274503;10990.065844403236;10991.285566438235;10991.505382257817;44796;45148;45204.09591808145;45268.3209751854;45271.54728452739;3720.665140137374;3723.7579557328686;3838.9424158637644;3850.921741912269;3929.1945151244213;34022.82988585041;34045.31909361824;34323.48514772281;34433.31133377343;34990.650093498996;4408.58118478744;4440.467143942716;4447.73313601185;4479.888002799924;4554.134714404253;360362;365075;365646;365992;366431;38250.426243606365;60316.698416507636;60707;60797;60812.39187608156;38308.616913830505;40168;40312.39531407031;40312.79843600822;40373.59626403757;17226.138693065546;17365.131743412778;17390.043547605004;17394.391196308068;17407;13599.388027538784;13831.930840345934;14276.428942842378;14365.353559089866;14462.638434039232;9423.575939082757;9452.10205030521;9462.43225406464;9531;9562.091601297865;3566.32239874423;3589.5692516897616;3627.4921510988484;3648.3980143276062;3717.7397582168987;1045.4041196517912;1047.6856942917095;1074.5057273654206;1111.0667039686703;1157.7279339355246;32937;34724;34983.65016349855;35022.47466288008;35204.29591408157;1170.6371024982113;1193.5225909636215;1234.5247079874134;1251.7496500699897;1257.7358754661623;18233;18370.265189392543;18439.72340414895;18495;18523.81476185221;652237;656111;658278;659473;659724;43660.345094823606;43972;44130.77934610307;44137;44213.77893110578;1325.827642406481;1368.7878378851094;1392.491740514725;1449.3477934929113;1465.5163795947312;32359.676403236608;35109.47335789914;35554.64445355617;36098.09754756047;36130.09674758152;52634;53116.73441632767;53165.20252196143;53166.20250696165;53232.73383633212;434807;435705;438381;438431;439094;30813.845930770203;32058.35883282368;32169.678303216668;33374.666253338124;33376.165595859326;52990.47009529855;53074.469255306954;53337;53345;53363.733181333846;43591;44384.334234987145;44397.77801110974;44973;46402.53597464117;42463.787681061396;43156.11141561688;43449.34825977676;44082.77958610187;45735.54264457313;43395.349069763346;43542.12915741731;44200.33699494446;44306.55693443024;44467.33299000582;37347;37987.43018854664;38741.61258387493;39686;39830.402543962446;29484.262893427836;29649.85175074111;29945;29974.70025299719;29978.4004319908 21:49:34 INFO - PROCESS | 25802 | |2;jquery.html;381.61647544218056;402.3622558245181;406.97354671946323;412.43702346297306;426.1285670803207;14684.486042988498;16628;20527.076281567308;20908.790912090873;21372.4656883578;20245.696314555295;20326.186952521883;20745.377638670827;20975;21038;5585.720713964306;5779.162021506879;5814.273215848019;5822.155787410823;6038.33578306386;3968.1865217630316;5771.797987070453;5821.767129314822;5821.912671309934;5825;4130.215259100776;5743.195952566644;5965.46310832025;5973.551983601225;6081.209442772455;5993.919212393206;6075.817725468243;6081.270247570298;6471.223453185601;6566.277709451956;5881.500072493843;5885.352611212763;5892.499137573312;5894.852628684274;5896.823095307148;13470.528531501448;13580.117292375964;13872.514461993882;13945.651358716012;13986.580402587939;2440.4752978109614;2513.962290565643;2595.701494328139;2604.5832666773226;2886.841223732694;10079.899201008042;10119.848202276971;10162.593496260215;10350.741231469197;10666.200034997328;2017.8486613504047;2036.8777873327647;2064.9793502064936;2075.0662202009157;2080.1887263967064;80906;83347;84834;85670.57164714136;87932.56033719791;11460.94269528647;11524.654260372203;11821.645350639494;11949.88050119505;12363.258204507758;16294.755578666329;16295;16323.347066117221;16330.346786128423;16344.673106537803;8786.956065219632;8826.691065812794;9049.547522623843;9197.448153110834;9264.258859291376;7918.960405198052;7938.722144724907;7985.361171106298;7994.5203287802915;8883.244924181388;4916.557509824133;4965.155923493015;4983.277424773388;4998.05037042968;5095.286659867622;1806.1781889240626;2053.9973525812215;2087.1755656515893;2147.7530084040222;2195.9231426899983;855.8673405622138;969.8836139663285;1002.2583288366702;1011.6307547745167;1056.528761336812;20229.49426264355;20404.693929591067;20580.176792928414;20610.484737881674;20679.8966005172;1020.4948550467418;1024.134606257711;1025.5436330832708;1039.4179259614489;1067.6583493282076;10679.679609611723;11345.432728363548;11433.485493152828;11472;11613.883861161281;500616;503047;518675;524446;526158;71161;96201;96646;99656.5017174924;99752;983.8130755156498;997.7854761226226;1015.4719545836124;1026.6252817721627;1038.1124138861317;17297.740533892254;17340.393086241922;17773.733393998842;18089.819101808815;18381;42240.577594223665;44991.77504112459;45433.31850022186;45692.31461528146;45802.77098614485;60592;61664.69167654133;62077.68961155165;62365.37634623596;64005.67997159984;7011.824704382431;7482.738104166328;8036.075851277178;8450.830983380176;8540.572971351283;12261.816072759095;13519.662008449868;13684.384202710702;13792.517261895786;13840.792388113985;11103.5558577656;11514.42427878586;12005.159638825198;12159.878401216229;12268.815967760313;11231.045361144068;11235.71910702239;11394.601188958346;11566.363849988331;11670.591529296435;10831.133509319077;11138.10895128404;11494.367809770543;11629.59296424621;12062.215955962834;7771.72798952034;7816.296533312029;7957.323627491496;8005.719799806979;8542.658293668184;10086.243531735003;11021.944890275498;11093.389863557259;11156.776864462827;11220.719482013015 21:49:34 INFO - PROCESS | 25802 | |3;mootools.html;1517.6737001544668;1563.2183908045977;1722.8880122792018;1788.8032316445197;1831.4414103698366;8141.837163256739;8678.956605216965;8713.215810577047;8723.302135829133;8733.257673097778;7576.96211518943;7787.571683557402;7796.649150788214;7967.561784101887;8542.231199192087;2246.168917500523;2338.8830558472096;2344.8475849069755;2353.52929414117;2354.6232602783557;2383.9642405363934;2389.569877422063;2398.9880050599722;2407.325948734357;2409.229046705046;2370.762923707624;2376.3346263046287;2380.8690522021284;2381.476075263448;2385.916492922748;2333.2533589251448;2336.030547322859;2336.1473062332298;2336.7312759032757;2340.438294809242;2289.4848659051745;2301.735300440454;2309.1225334373;2325.279163459333;2336.7896889280046;8503.914960850436;8642.783930401727;8653.870191947062;8658.696945606873;8659.783505412352;5150.871228219287;5280.947190528084;5283.656562323436;5288;5295.973520132413;3310.3096424786927;3338.8998330049894;3395.8641654333796;3457.6542345765474;3479.7912125272564;1167.6788883057143;1172.9296242225494;1174.665220412187;1187.1274613159321;1195.432169719385;11464.541418343257;11493.77012459746;11518.884811151866;11522.596709115225;11602.303861768236;4199.719085678837;4405.9559404405545;4416.602505774432;4504.684672072989;4521.253993091169;10014.49927503622;10031.398116113056;10033;10039.69880903574;10045.648402306031;5129.9483605860705;5130.615203859726;5130.769115389817;5134.897302053938;5139.22911563261;4084.9387259191135;4492.213862574036;4721.952780472151;4735.12400205963;4738.431388233365;3954.4661470701085;4032.7378720383667;4160.585400963687;4165.58344165581;4171;1260.4076084240392;1276.2215048820212;1294.5598496511043;1300.7268473620456;1303.387407918277;860.0281681699764;901.7925877048316;926.8887733471892;935.5836652689624;977.745786095606;5925.288965324189;5992.40075992406;6045.3652366501765;6220.315765265817;6253.6560489172625;1025.2054657640388;1056.1709058389129;1070.2454769387718;1147.2198904744853;1151.8214676725122;4076.3274059780397;4192.24539582878;4207.347861081537;4240.1731662326165;4289.506706728704;9622.615095396106;10342.638007669695;10412.219083568763;10418;10421.166306695597;9987;10281.537330819981;10307.226957978182;10307.690769276784;10326.432046237529;7974.920250797418;8184.713535026364;8188.14024527416;8193.46742461738;8226.095129535746;5738.598298119258;5840.766369345179;5863.17915491823;5912.67480288571;5987.970060149672;9787;9860.457674827954;9886.50567471609;9920.900790992286;9951.054649808257;9673.758156046155;10276.588936442458;10284.331518451278;10295.94852025735;10314.123299519624;6639.170103737033;6843.384095431236;7234.421246300178;7331.156916954618;7349.228331025379;8050.235227653364;8201.876971845308;8309.33525317961;8524.573771311534;8543.188397102265;7050.330218629222;7107.182673992557;7142.321479459443;7187.496875218684;7244.058272424551;6883.483738719716;7123.430125590044;7153.678084486107;7174.964125179341;7210.134783825974;6922.307769223037;6999.335063168991;7018.017477553249;7034.2965703429245;7078.539894906815;5136.922946155736;5170.43125256229;5208.869778255574;5234.712090835041;5244.606654501004;4976.527229913152;5069.619778516552;5125.128728116155;5181.5077567631015;5313.282706834528 21:49:34 INFO - PROCESS | 25802 | |4;prototype.html;293.734170575629;299.13400704959145;306.20539699479855;306.72394844639837;307.22885557251305;5403.486668766461;5538.7784488620455;5540.529055030317;5618.297712785902;5707.6290041147295;5384.730763461821;5504.862378440541;5529.170624406341;5537.252470916425;5598.356189038262;4278.465191851019;4284.207421626993;4286.363886209974;4308.82764689412;4311.6335111515555;4119.917601647965;4226.260404429228;4275.422817919588;4305.956940430603;4308.676849236304;4218.683598730107;4220.620144187023;4220.662347012231;4253.978730106345;4257.638100761439;4214.473190851144;4236.533981262059;4253.936515871017;4256.255155347832;4288.120935208275;3617.366960781853;3720.4233343831747;3726.1057346236707;3726.1802403471193;3729.086373838427;5325.547328477045;5348.84418193264;5364.068935183331;5428.154427494631;5436.374816896068;4797.592204662573;4821.4696383397795;4873.513578358599;4875.146849301394;4881.365422495089;5582.24639673647;5710.6611661056195;5734.623690314336;5747.770089196469;5759.769609215627;3991.5808840071954;4007.078371974433;4014.859479918218;4017.4174744662155;4020.638142567183;5929.288485381739;5955.821325360246;5963.28440587128;5969.671668058255;5984.281886173643;3951.3677811550015;4079.0822065035723;4082.7547597982307;4084.8774536763945;4095.9795201023803;4162.4598898407785;4189.329707246826;4200.180964711913;4214.578542145761;4222.704410691284;4844.370231869834;4850.539198776181;4850.927236091461;4857.251389499777;4865.294532292798;5549.72251387429;5809.215755872988;5851.444112809277;5858.213244960328;5861.853453663607;1424.1383962702623;1444.3428240150706;1454.7526920423554;1454.8181477315336;1454.9378953364103;885.7741275974714;898.2454738020094;911.3301723233418;919.8988111307751;922.082527884759;4970.701757894465;4983.700977941335;5004.724740139254;5024.974875125601;5030.522100400456;5245.606579506552;5249.580033597379;5259.289995850588;5262.368515778055;5267.815626453055;4803.807847686124;4918.483559226302;4946.3817022872145;4993.626752642979;5096.61775366849;2813.493571157211;2815;2827.628600128936;2829.278533973865;2844.288927768058;5391.705990562236;5397.2443857859935;5410.756515956791;5411.427343894403;5413.6736499557865;5101.285819985205;5302.734863256822;5360.383555891044;5363.942552744976;5380.2736630555155;5424.566034717213;5454.209139674725;5463.535599474089;5465.840992807819;5484.5063944246;5260.237265596544;5266.526012658879;5307.4427185145005;5313.760880760297;5316.8936621266585;4818.325434439252;5136.434992150786;5161.587073034073;5168.638195326442;5182.429932707475;5366.892662146814;5383.461653834585;5391.304347826087;5392.166663334328;5401.702906340189;3776.735628505978;3948.6051394860283;4029.2545879012478;4040.91918161641;4112.218678451085;5865.618734782225;5884.58807883444;5914.112883067574;5931.822045338647;5944.821655350346;5629.155626656035;5779.913301300568;5801.680907550125;5801.912971305349;5805.970970145122;5780.479756821906;5796.275465566804;5799.971000144972;5815.563832712648;5842.678652674143;5724.656520608777;5726.7709291629535;5729.968605651023;5739.942600574108;5751.971240143773;5587.53572784876;5782.826515204551;5812;5821.7089145543405;5824.650520968756;5668.914966275427;5671.262735844314;5679.6592204466215;5680.545556355564;5684.971575142264 21:49:34 INFO - PROCESS | 25802 | |5;yui.html;822.6590657228717;828.2793969246757;865.580193606101;874.1564390363299;891.8706787515806;16234.188290585467;16340.264688089035;16423.67152656949;16649.583760405996;17473.213705383256;16495.83504164958;16620.501384958472;16661.91669041656;16665.41671041514;16937.322507099732;715.1739740599603;739.8298391369962;852.4586887326561;878.5607196401799;882.2016075451694;878.2359347367799;878.6353663229752;881.0748713850463;881.8897637795276;882.4528792148876;944.9291303152256;945.952702364879;946.1342871272777;946.4794363100302;946.5030858799116;769.2691942654473;787.1459466478906;787.3858390455454;901.8692289617969;934.042606328512;689.6930865764737;692.2661978302965;692.7298353642084;693.0955103589813;693.2512886083018;14924.552263432006;14963.775543366859;14974;15011.849881501154;15013.774793378108;15348.616284592863;15384.769228461582;15412.460563880322;15517.224138793015;16100.838991610168;14459.132452052805;14521.927390363086;14548.854511454856;14575.635609109751;14595.270236488239;4561.1789877821975;4565.269556870918;4665.650076244296;4683.414573178353;4711.575958163748;69959;71815.64092179558;72083.27916720818;87512;87587.56206218927;11823.408829558659;12713.872861271453;12901.870981290067;13141.540046098531;13172.736545269232;22690.546189076125;22699.773002270096;22754.772452275265;22900.427489312566;22936.655950160763;9275.118863707938;9444.527773611291;9606.903930960601;9624.326297159132;9643;5048.5203905628905;5243.68537887728;5294.258803767476;5490.396056433789;5603.663780173202;3652.908677283036;3756.3426400379826;3785.432185172191;3785.4511095890944;3800.5059342285326;635.2345423764353;645.3997782062727;646.2600322630561;648.1347401219331;666.8732940741244;687.0450074396592;687.6286805125277;698.5005720909472;700.9334113259232;715.1025463043846;10231.488425578691;10645.89354106449;11101.666949991513;11130.109591232682;11167.776644467065;688.7761477519726;713.1834050012707;771.0593076446726;806.6652339279134;826.9167390718178;5055.216441451507;5095.8980820383385;5354.170103633943;5373.059714550016;5779.33537643168;71893;72538.63730681312;102993;122374;126960;105525.47237263764;106743;107403;110637;110843.44578277056;56824;64301;86981.56509217413;87594.56202718946;91953;10300.433476158883;10807.13542916549;10849.186311026862;10960.232783705063;11170.776584468427;52794.47205527896;53260.201096984354;53459;53463;54688.726556366964;68158;75089.87365189636;76538.23461765534;76900.61549692215;78489;13991.720165596835;14065.929670351583;14066.507672231422;14529.200893950512;14667.339969701176;15004.249787510798;15572;15752.291146898187;16878.071706056286;16878.240479178712;14851.183184924932;15223.391064357746;15317.234138292817;16111.597210069842;16470.09414482167;13347.66630834198;13617.25105119228;13651.931740341632;14093.436262549383;14658.267086645837;14294.142351458946;14307.71384572282;14680.632984175481;14791;15779.368825246862;11428.428578571204;11566.479508421973;11972.281663100242;12235.93882030584;12561;11747.941260293645;11750.11874109428;12143.119229663309;12245.571405000783;12325 21:49:34 INFO - PROCESS | 25802 | __end_tp_report 21:49:34 INFO - PROCESS | 25802 | __start_cc_report 21:49:34 INFO - PROCESS | 25802 | _x_x_mozilla_cycle_collect,829 21:49:34 INFO - PROCESS | 25802 | __end_cc_report 21:49:34 INFO - PROCESS | 25802 | __startTimestamp1475729374917__endTimestamp 21:49:34 INFO - PROCESS | 25802 | 21:49:34 INFO - PROCESS | 25802 | ------- Summary: start ------- 21:49:34 INFO - PROCESS | 25802 | Number of tests: 6 21:49:34 INFO - PROCESS | 25802 | 21:49:34 INFO - PROCESS | 25802 | [#0] dojo.html Cycles:165 Average:5627.32 Median:5850.41 stddev:655.60 (11.2%) stddev-sans-first:627.44 21:49:34 INFO - PROCESS | 25802 | Values: 3121.3 3162.2 3165.5 3174.9 3202.1 5546.9 5619.7 5629.2 5633.9 5643.7 5626.4 5660.0 5662.5 5676.3 5698.7 5112.9 5134.1 5174.1 5178.4 5202.4 5129.2 5194.8 5221.2 5221.4 5223.5 4995.9 5070.7 5095.8 5106.7 5108.8 5027.7 5063.5 5067.2 5163.0 5206.4 4992.5 5063.0 5109.2 5121.4 5122.1 5491.1 5504.7 5543.0 5574.3 5635.7 5899.1 5924.3 5930.0 6006.1 6012.6 6046.1 6048.9 6057.9 6059.9 6060.1 5568.1 5569.8 5610.0 5617.6 5619.4 6145.1 6180.8 6182.0 6182.4 6184.6 5905.6 5914.0 5916.7 5919.6 5941.6 5929.6 5956.1 5978.0 6013.0 6016.1 6052.1 6056.0 6059.5 6088.1 6088.6 6042.2 6057.9 6061.2 6076.2 6082.7 4615.9 4654.2 4684.2 4692.6 4704.3 4104.9 4150.3 4150.5 4152.5 4187.2 5833.4 5839.3 5844.5 5847.5 5850.4 5957.0 6175.9 6180.3 6189.0 6190.6 5720.7 5747.6 5802.0 5804.0 5887.1 5288.0 5327.6 5331.6 5336.4 5336.7 6281.3 6325.3 6343.1 6349.1 6350.1 5954.6 6011.5 6048.6 6114.9 6121.9 6338.9 6362.8 6363.1 6365.5 6369.6 6052.2 6055.6 6063.6 6068.1 6073.3 5920.7 5961.2 5991.7 6103.4 6147.4 5842.0 5999.1 5999.8 6028.2 6037.3 5988.2 5990.2 5994.7 6001.7 6004.9 5707.3 5762.5 5867.1 5916.6 5927.4 5824.9 5894.4 5904.1 5967.8 5994.5 5767.0 5799.1 5804.1 5809.9 5813.3 21:49:34 INFO - PROCESS | 25802 | 21:49:34 INFO - PROCESS | 25802 | [#1] ext.html Cycles:180 Average:64053.98 Median:38302.02 stddev:133844.10 (349.4%) stddev-sans-first:134134.74 21:49:34 INFO - PROCESS | 25802 | Values: 587.3 591.2 624.3 631.9 634.5 35254.6 38295.4 46230.8 46439.6 46984.0 46445.3 46846.0 46877.0 46920.8 46926.3 8369.8 9152.2 9295.0 9302.5 9303.4 8302.7 11038.6 11289.9 11291.9 11295.4 11107.3 11169.5 11172.3 11181.9 11183.2 10964.1 11010.6 11023.3 11032.4 11037.7 10812.9 10978.9 10990.1 10991.3 10991.5 44796.0 45148.0 45204.1 45268.3 45271.5 3720.7 3723.8 3838.9 3850.9 3929.2 34022.8 34045.3 34323.5 34433.3 34990.7 4408.6 4440.5 4447.7 4479.9 4554.1 360362.0 365075.0 365646.0 365992.0 366431.0 38250.4 60316.7 60707.0 60797.0 60812.4 38308.6 40168.0 40312.4 40312.8 40373.6 17226.1 17365.1 17390.0 17394.4 17407.0 13599.4 13831.9 14276.4 14365.4 14462.6 9423.6 9452.1 9462.4 9531.0 9562.1 3566.3 3589.6 3627.5 3648.4 3717.7 1045.4 1047.7 1074.5 1111.1 1157.7 32937.0 34724.0 34983.7 35022.5 35204.3 1170.6 1193.5 1234.5 1251.7 1257.7 18233.0 18370.3 18439.7 18495.0 18523.8 652237.0 656111.0 658278.0 659473.0 659724.0 43660.3 43972.0 44130.8 44137.0 44213.8 1325.8 1368.8 1392.5 1449.3 1465.5 32359.7 35109.5 35554.6 36098.1 36130.1 52634.0 53116.7 53165.2 53166.2 53232.7 434807.0 435705.0 438381.0 438431.0 439094.0 30813.8 32058.4 32169.7 33374.7 33376.2 52990.5 53074.5 53337.0 53345.0 53363.7 43591.0 44384.3 44397.8 44973.0 46402.5 42463.8 43156.1 43449.3 44082.8 45735.5 43395.3 43542.1 44200.3 44306.6 44467.3 37347.0 37987.4 38741.6 39686.0 39830.4 29484.3 29649.9 29945.0 29974.7 29978.4 21:49:34 INFO - PROCESS | 25802 | 21:49:34 INFO - PROCESS | 25802 | [#2] jquery.html Cycles:180 Average:29895.55 Median:2318.20 stddev:84895.55 (3662.1%) stddev-sans-first:85104.78 21:49:34 INFO - PROCESS | 25802 | Values: 381.6 402.4 407.0 412.4 426.1 14684.5 16628.0 20527.1 20908.8 21372.5 20245.7 20326.2 20745.4 20975.0 21038.0 5585.7 5779.2 5814.3 5822.2 6038.3 3968.2 5771.8 5821.8 5821.9 5825.0 4130.2 5743.2 5965.5 5973.6 6081.2 5993.9 6075.8 6081.3 6471.2 6566.3 5881.5 5885.4 5892.5 5894.9 5896.8 13470.5 13580.1 13872.5 13945.7 13986.6 2440.5 2514.0 2595.7 2604.6 2886.8 10079.9 10119.8 10162.6 10350.7 10666.2 2017.8 2036.9 2065.0 2075.1 2080.2 80906.0 83347.0 84834.0 85670.6 87932.6 11460.9 11524.7 11821.6 11949.9 12363.3 16294.8 16295.0 16323.3 16330.3 16344.7 8787.0 8826.7 9049.5 9197.4 9264.3 7919.0 7938.7 7985.4 7994.5 8883.2 4916.6 4965.2 4983.3 4998.1 5095.3 1806.2 2054.0 2087.2 2147.8 2195.9 855.9 969.9 1002.3 1011.6 1056.5 20229.5 20404.7 20580.2 20610.5 20679.9 1020.5 1024.1 1025.5 1039.4 1067.7 10679.7 11345.4 11433.5 11472.0 11613.9 500616.0 503047.0 518675.0 524446.0 526158.0 71161.0 96201.0 96646.0 99656.5 99752.0 983.8 997.8 1015.5 1026.6 1038.1 17297.7 17340.4 17773.7 18089.8 18381.0 42240.6 44991.8 45433.3 45692.3 45802.8 60592.0 61664.7 62077.7 62365.4 64005.7 7011.8 7482.7 8036.1 8450.8 8540.6 12261.8 13519.7 13684.4 13792.5 13840.8 11103.6 11514.4 12005.2 12159.9 12268.8 11231.0 11235.7 11394.6 11566.4 11670.6 10831.1 11138.1 11494.4 11629.6 12062.2 7771.7 7816.3 7957.3 8005.7 8542.7 10086.2 11021.9 11093.4 11156.8 11220.7 21:49:34 INFO - PROCESS | 25802 | 21:49:34 INFO - PROCESS | 25802 | [#3] mootools.html Cycles:180 Average:5647.92 Median:4736.78 stddev:3104.61 (65.5%) stddev-sans-first:3097.80 21:49:34 INFO - PROCESS | 25802 | Values: 1517.7 1563.2 1722.9 1788.8 1831.4 8141.8 8679.0 8713.2 8723.3 8733.3 7577.0 7787.6 7796.6 7967.6 8542.2 2246.2 2338.9 2344.8 2353.5 2354.6 2384.0 2389.6 2399.0 2407.3 2409.2 2370.8 2376.3 2380.9 2381.5 2385.9 2333.3 2336.0 2336.1 2336.7 2340.4 2289.5 2301.7 2309.1 2325.3 2336.8 8503.9 8642.8 8653.9 8658.7 8659.8 5150.9 5280.9 5283.7 5288.0 5296.0 3310.3 3338.9 3395.9 3457.7 3479.8 1167.7 1172.9 1174.7 1187.1 1195.4 11464.5 11493.8 11518.9 11522.6 11602.3 4199.7 4406.0 4416.6 4504.7 4521.3 10014.5 10031.4 10033.0 10039.7 10045.6 5129.9 5130.6 5130.8 5134.9 5139.2 4084.9 4492.2 4722.0 4735.1 4738.4 3954.5 4032.7 4160.6 4165.6 4171.0 1260.4 1276.2 1294.6 1300.7 1303.4 860.0 901.8 926.9 935.6 977.7 5925.3 5992.4 6045.4 6220.3 6253.7 1025.2 1056.2 1070.2 1147.2 1151.8 4076.3 4192.2 4207.3 4240.2 4289.5 9622.6 10342.6 10412.2 10418.0 10421.2 9987.0 10281.5 10307.2 10307.7 10326.4 7974.9 8184.7 8188.1 8193.5 8226.1 5738.6 5840.8 5863.2 5912.7 5988.0 9787.0 9860.5 9886.5 9920.9 9951.1 9673.8 10276.6 10284.3 10295.9 10314.1 6639.2 6843.4 7234.4 7331.2 7349.2 8050.2 8201.9 8309.3 8524.6 8543.2 7050.3 7107.2 7142.3 7187.5 7244.1 6883.5 7123.4 7153.7 7175.0 7210.1 6922.3 6999.3 7018.0 7034.3 7078.5 5136.9 5170.4 5208.9 5234.7 5244.6 4976.5 5069.6 5125.1 5181.5 5313.3 21:49:34 INFO - PROCESS | 25802 | 21:49:34 INFO - PROCESS | 25802 | [#4] prototype.html Cycles:180 Average:4663.26 Median:5264.45 stddev:1366.71 (26.0%) stddev-sans-first:1330.61 21:49:34 INFO - PROCESS | 25802 | Values: 293.7 299.1 306.2 306.7 307.2 5403.5 5538.8 5540.5 5618.3 5707.6 5384.7 5504.9 5529.2 5537.3 5598.4 4278.5 4284.2 4286.4 4308.8 4311.6 4119.9 4226.3 4275.4 4306.0 4308.7 4218.7 4220.6 4220.7 4254.0 4257.6 4214.5 4236.5 4253.9 4256.3 4288.1 3617.4 3720.4 3726.1 3726.2 3729.1 5325.5 5348.8 5364.1 5428.2 5436.4 4797.6 4821.5 4873.5 4875.1 4881.4 5582.2 5710.7 5734.6 5747.8 5759.8 3991.6 4007.1 4014.9 4017.4 4020.6 5929.3 5955.8 5963.3 5969.7 5984.3 3951.4 4079.1 4082.8 4084.9 4096.0 4162.5 4189.3 4200.2 4214.6 4222.7 4844.4 4850.5 4850.9 4857.3 4865.3 5549.7 5809.2 5851.4 5858.2 5861.9 1424.1 1444.3 1454.8 1454.8 1454.9 885.8 898.2 911.3 919.9 922.1 4970.7 4983.7 5004.7 5025.0 5030.5 5245.6 5249.6 5259.3 5262.4 5267.8 4803.8 4918.5 4946.4 4993.6 5096.6 2813.5 2815.0 2827.6 2829.3 2844.3 5391.7 5397.2 5410.8 5411.4 5413.7 5101.3 5302.7 5360.4 5363.9 5380.3 5424.6 5454.2 5463.5 5465.8 5484.5 5260.2 5266.5 5307.4 5313.8 5316.9 4818.3 5136.4 5161.6 5168.6 5182.4 5366.9 5383.5 5391.3 5392.2 5401.7 3776.7 3948.6 4029.3 4040.9 4112.2 5865.6 5884.6 5914.1 5931.8 5944.8 5629.2 5779.9 5801.7 5801.9 5806.0 5780.5 5796.3 5800.0 5815.6 5842.7 5724.7 5726.8 5730.0 5739.9 5752.0 5587.5 5782.8 5812.0 5821.7 5824.7 5668.9 5671.3 5679.7 5680.5 5685.0 21:49:34 INFO - PROCESS | 25802 | 21:49:34 INFO - PROCESS | 25802 | [#5] yui.html Cycles:180 Average:21146.98 Median:3785.44 stddev:29247.91 (772.6%) stddev-sans-first:29290.15 21:49:34 INFO - PROCESS | 25802 | Values: 822.7 828.3 865.6 874.2 891.9 16234.2 16340.3 16423.7 16649.6 17473.2 16495.8 16620.5 16661.9 16665.4 16937.3 715.2 739.8 852.5 878.6 882.2 878.2 878.6 881.1 881.9 882.5 944.9 946.0 946.1 946.5 946.5 769.3 787.1 787.4 901.9 934.0 689.7 692.3 692.7 693.1 693.3 14924.6 14963.8 14974.0 15011.8 15013.8 15348.6 15384.8 15412.5 15517.2 16100.8 14459.1 14521.9 14548.9 14575.6 14595.3 4561.2 4565.3 4665.7 4683.4 4711.6 69959.0 71815.6 72083.3 87512.0 87587.6 11823.4 12713.9 12901.9 13141.5 13172.7 22690.5 22699.8 22754.8 22900.4 22936.7 9275.1 9444.5 9606.9 9624.3 9643.0 5048.5 5243.7 5294.3 5490.4 5603.7 3652.9 3756.3 3785.4 3785.5 3800.5 635.2 645.4 646.3 648.1 666.9 687.0 687.6 698.5 700.9 715.1 10231.5 10645.9 11101.7 11130.1 11167.8 688.8 713.2 771.1 806.7 826.9 5055.2 5095.9 5354.2 5373.1 5779.3 71893.0 72538.6 102993.0 122374.0 126960.0 105525.5 106743.0 107403.0 110637.0 110843.4 56824.0 64301.0 86981.6 87594.6 91953.0 10300.4 10807.1 10849.2 10960.2 11170.8 52794.5 53260.2 53459.0 53463.0 54688.7 68158.0 75089.9 76538.2 76900.6 78489.0 13991.7 14065.9 14066.5 14529.2 14667.3 15004.2 15572.0 15752.3 16878.1 16878.2 14851.2 15223.4 15317.2 16111.6 16470.1 13347.7 13617.3 13651.9 14093.4 14658.3 14294.1 14307.7 14680.6 14791.0 15779.4 11428.4 11566.5 11972.3 12235.9 12561.0 11747.9 11750.1 12143.1 12245.6 12325.0 21:49:34 INFO - PROCESS | 25802 | -------- Summary: end -------- 21:49:34 INFO - PROCESS | 25802 | 21:49:35 INFO - TEST-INFO | 25802: exit 0 21:49:35 INFO - TEST-OK | dromaeo_css | took 1113243ms 21:49:35 INFO - TEST-START | kraken 21:49:35 INFO - operating with platform_type : linux_ 21:49:35 INFO - Initialising browser for kraken test... 21:49:35 INFO - TEST-INFO | started process 26120 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBskMUC/profile http://localhost:33922/getInfo.html) 21:49:39 INFO - PROCESS | 26120 | __metrics Screen width/height:1600/1200 21:49:39 INFO - PROCESS | 26120 | colorDepth:24 21:49:39 INFO - PROCESS | 26120 | Browser inner width/height: 1024/697 21:49:39 INFO - PROCESS | 26120 | __metrics 21:49:39 INFO - PROCESS | 26120 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:49:39 INFO - PROCESS | 26120 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:49:40 INFO - PROCESS | 26120 | console.error: PushService: 21:49:40 INFO - PROCESS | 26120 | stateChangeProcessEnqueue: Error transitioning state 21:49:40 INFO - PROCESS | 26120 | UnknownError 21:49:41 INFO - TEST-INFO | 26120: exit 0 21:49:41 INFO - Browser initialized. 21:49:41 INFO - Running cycle 1/1 for kraken test... 21:49:41 INFO - TEST-INFO | started process 26212 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBskMUC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:49:52 INFO - PROCESS | 26212 | RSS: Main: 144232448 21:49:52 INFO - PROCESS | 26212 | 21:49:55 INFO - PROCESS | 26212 | Cycle 1(1): loaded http://localhost:33922/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33922/tests/kraken/driver.html?testName=audio-beat-detection) 21:49:56 INFO - PROCESS | 26212 | RSS: Main: 185200640 21:49:56 INFO - PROCESS | 26212 | 21:49:58 INFO - PROCESS | 26212 | Cycle 1(1): loaded http://localhost:33922/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33922/tests/kraken/driver.html?testName=audio-dft) 21:49:59 INFO - PROCESS | 26212 | RSS: Main: 175042560 21:49:59 INFO - PROCESS | 26212 | 21:50:02 INFO - PROCESS | 26212 | Cycle 1(1): loaded http://localhost:33922/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33922/tests/kraken/driver.html?testName=audio-fft) 21:50:02 INFO - PROCESS | 26212 | RSS: Main: 267251712 21:50:02 INFO - PROCESS | 26212 | 21:50:04 INFO - PROCESS | 26212 | Cycle 1(1): loaded http://localhost:33922/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33922/tests/kraken/driver.html?testName=audio-oscillator) 21:50:05 INFO - PROCESS | 26212 | RSS: Main: 172892160 21:50:05 INFO - PROCESS | 26212 | 21:50:07 INFO - PROCESS | 26212 | Cycle 1(1): loaded http://localhost:33922/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33922/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:50:08 INFO - PROCESS | 26212 | RSS: Main: 174555136 21:50:08 INFO - PROCESS | 26212 | 21:50:11 INFO - PROCESS | 26212 | Cycle 1(1): loaded http://localhost:33922/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33922/tests/kraken/driver.html?testName=imaging-darkroom) 21:50:11 INFO - PROCESS | 26212 | RSS: Main: 210771968 21:50:11 INFO - PROCESS | 26212 | 21:50:15 INFO - PROCESS | 26212 | Cycle 1(1): loaded http://localhost:33922/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33922/tests/kraken/driver.html?testName=imaging-desaturate) 21:50:15 INFO - PROCESS | 26212 | RSS: Main: 209752064 21:50:15 INFO - PROCESS | 26212 | 21:50:18 INFO - PROCESS | 26212 | Cycle 1(1): loaded http://localhost:33922/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33922/tests/kraken/driver.html?testName=json-parse-financial) 21:50:18 INFO - PROCESS | 26212 | RSS: Main: 209100800 21:50:18 INFO - PROCESS | 26212 | 21:50:20 INFO - PROCESS | 26212 | Cycle 1(1): loaded http://localhost:33922/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33922/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:50:21 INFO - PROCESS | 26212 | RSS: Main: 171044864 21:50:21 INFO - PROCESS | 26212 | 21:50:22 INFO - PROCESS | 26212 | Cycle 1(1): loaded http://localhost:33922/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33922/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:50:23 INFO - PROCESS | 26212 | RSS: Main: 178417664 21:50:23 INFO - PROCESS | 26212 | 21:50:25 INFO - PROCESS | 26212 | Cycle 1(1): loaded http://localhost:33922/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33922/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:50:25 INFO - PROCESS | 26212 | RSS: Main: 187723776 21:50:25 INFO - PROCESS | 26212 | 21:50:28 INFO - PROCESS | 26212 | Cycle 1(1): loaded http://localhost:33922/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33922/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:50:29 INFO - PROCESS | 26212 | RSS: Main: 196931584 21:50:29 INFO - PROCESS | 26212 | 21:50:31 INFO - PROCESS | 26212 | Cycle 1(1): loaded http://localhost:33922/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33922/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:50:32 INFO - PROCESS | 26212 | RSS: Main: 193425408 21:50:32 INFO - PROCESS | 26212 | 21:50:33 INFO - PROCESS | 26212 | Cycle 1(1): loaded http://localhost:33922/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33922/tests/kraken/driver.html?testName=ai-astar) 21:50:34 INFO - PROCESS | 26212 | RSS: Main: 244928512 21:50:34 INFO - PROCESS | 26212 | 21:50:34 INFO - PROCESS | 26212 | __start_tp_report 21:50:34 INFO - PROCESS | 26212 | _x_x_mozilla_page_load 21:50:34 INFO - PROCESS | 26212 | _x_x_mozilla_page_load_details 21:50:34 INFO - PROCESS | 26212 | |i|pagename|runs| 21:50:34 INFO - PROCESS | 26212 | |0;ai-astar;109;112;112;110;111;112;111;118;111;111 21:50:34 INFO - PROCESS | 26212 | |1;audio-beat-detection;144;117;117;150;120;118;118;123;148;118 21:50:34 INFO - PROCESS | 26212 | |2;audio-dft;161;161;160;161;161;161;161;160;160;161 21:50:34 INFO - PROCESS | 26212 | |3;audio-fft;75;76;76;115;76;74;76;74;105;76 21:50:34 INFO - PROCESS | 26212 | |4;audio-oscillator;82;81;109;87;81;81;115;81;81;113 21:50:34 INFO - PROCESS | 26212 | |5;imaging-gaussian-blur;118;117;116;117;117;117;116;117;117;118 21:50:34 INFO - PROCESS | 26212 | |6;imaging-darkroom;146;147;147;147;147;146;145;146;145;146 21:50:34 INFO - PROCESS | 26212 | |7;imaging-desaturate;95;95;96;95;96;95;95;95;95;95 21:50:34 INFO - PROCESS | 26212 | |8;json-parse-financial;48;48;48;48;47;47;48;47;50;48 21:50:34 INFO - PROCESS | 26212 | |9;json-stringify-tinderbox;59;60;61;60;60;60;59;60;60;60 21:50:34 INFO - PROCESS | 26212 | |10;stanford-crypto-aes;80;73;74;75;76;73;87;73;74;79 21:50:34 INFO - PROCESS | 26212 | |11;stanford-crypto-ccm;121;120;119;123;121;118;117;118;166;119 21:50:34 INFO - PROCESS | 26212 | |12;stanford-crypto-pbkdf2;151;152;150;153;150;151;154;153;151;152 21:50:34 INFO - PROCESS | 26212 | |13;stanford-crypto-sha256-iterative;63;63;63;62;62;61;61;61;64;61 21:50:34 INFO - PROCESS | 26212 | __end_tp_report 21:50:34 INFO - PROCESS | 26212 | __start_cc_report 21:50:34 INFO - PROCESS | 26212 | _x_x_mozilla_cycle_collect,1561 21:50:34 INFO - PROCESS | 26212 | __end_cc_report 21:50:34 INFO - PROCESS | 26212 | __startTimestamp1475729434175__endTimestamp 21:50:34 INFO - PROCESS | 26212 | 21:50:34 INFO - PROCESS | 26212 | ------- Summary: start ------- 21:50:34 INFO - PROCESS | 26212 | Number of tests: 14 21:50:34 INFO - PROCESS | 26212 | 21:50:34 INFO - PROCESS | 26212 | [#0] ai-astar Cycles:10 Average:111.70 Median:111.50 stddev:2.41 (2.2%) stddev-sans-first:2.35 21:50:34 INFO - PROCESS | 26212 | Values: 109.0 112.0 112.0 110.0 111.0 112.0 111.0 118.0 111.0 111.0 21:50:34 INFO - PROCESS | 26212 | 21:50:34 INFO - PROCESS | 26212 | [#1] audio-beat-detection Cycles:10 Average:127.30 Median:121.50 stddev:14.01 (11.5%) stddev-sans-first:13.49 21:50:34 INFO - PROCESS | 26212 | Values: 144.0 117.0 117.0 150.0 120.0 118.0 118.0 123.0 148.0 118.0 21:50:34 INFO - PROCESS | 26212 | 21:50:34 INFO - PROCESS | 26212 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 21:50:34 INFO - PROCESS | 26212 | Values: 161.0 161.0 160.0 161.0 161.0 161.0 161.0 160.0 160.0 161.0 21:50:34 INFO - PROCESS | 26212 | 21:50:34 INFO - PROCESS | 26212 | [#3] audio-fft Cycles:10 Average:82.30 Median:76.00 stddev:14.81 (19.5%) stddev-sans-first:15.47 21:50:34 INFO - PROCESS | 26212 | Values: 75.0 76.0 76.0 115.0 76.0 74.0 76.0 74.0 105.0 76.0 21:50:34 INFO - PROCESS | 26212 | 21:50:34 INFO - PROCESS | 26212 | [#4] audio-oscillator Cycles:10 Average:91.10 Median:81.00 stddev:14.84 (18.3%) stddev-sans-first:15.37 21:50:34 INFO - PROCESS | 26212 | Values: 82.0 81.0 109.0 87.0 81.0 81.0 115.0 81.0 81.0 113.0 21:50:34 INFO - PROCESS | 26212 | 21:50:34 INFO - PROCESS | 26212 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.60 21:50:34 INFO - PROCESS | 26212 | Values: 118.0 117.0 116.0 117.0 117.0 117.0 116.0 117.0 117.0 118.0 21:50:34 INFO - PROCESS | 26212 | 21:50:34 INFO - PROCESS | 26212 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.50 stddev:0.79 (0.5%) stddev-sans-first:0.83 21:50:34 INFO - PROCESS | 26212 | Values: 146.0 147.0 147.0 147.0 147.0 146.0 145.0 146.0 145.0 146.0 21:50:34 INFO - PROCESS | 26212 | 21:50:34 INFO - PROCESS | 26212 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 21:50:34 INFO - PROCESS | 26212 | Values: 95.0 95.0 96.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 21:50:34 INFO - PROCESS | 26212 | 21:50:34 INFO - PROCESS | 26212 | [#8] json-parse-financial Cycles:10 Average:47.90 Median:48.00 stddev:0.88 (1.8%) stddev-sans-first:0.93 21:50:34 INFO - PROCESS | 26212 | Values: 48.0 48.0 48.0 48.0 47.0 47.0 48.0 47.0 50.0 48.0 21:50:34 INFO - PROCESS | 26212 | 21:50:34 INFO - PROCESS | 26212 | [#9] json-stringify-tinderbox Cycles:10 Average:59.90 Median:60.00 stddev:0.57 (0.9%) stddev-sans-first:0.50 21:50:34 INFO - PROCESS | 26212 | Values: 59.0 60.0 61.0 60.0 60.0 60.0 59.0 60.0 60.0 60.0 21:50:34 INFO - PROCESS | 26212 | 21:50:34 INFO - PROCESS | 26212 | [#10] stanford-crypto-aes Cycles:10 Average:76.40 Median:75.50 stddev:4.48 (5.9%) stddev-sans-first:4.56 21:50:34 INFO - PROCESS | 26212 | Values: 80.0 73.0 74.0 75.0 76.0 73.0 87.0 73.0 74.0 79.0 21:50:34 INFO - PROCESS | 26212 | 21:50:34 INFO - PROCESS | 26212 | [#11] stanford-crypto-ccm Cycles:10 Average:124.20 Median:120.50 stddev:14.79 (12.3%) stddev-sans-first:15.65 21:50:34 INFO - PROCESS | 26212 | Values: 121.0 120.0 119.0 123.0 121.0 118.0 117.0 118.0 166.0 119.0 21:50:34 INFO - PROCESS | 26212 | 21:50:34 INFO - PROCESS | 26212 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.70 Median:152.00 stddev:1.34 (0.9%) stddev-sans-first:1.39 21:50:34 INFO - PROCESS | 26212 | Values: 151.0 152.0 150.0 153.0 150.0 151.0 154.0 153.0 151.0 152.0 21:50:34 INFO - PROCESS | 26212 | 21:50:34 INFO - PROCESS | 26212 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.10 Median:62.50 stddev:1.10 (1.8%) stddev-sans-first:1.12 21:50:34 INFO - PROCESS | 26212 | Values: 63.0 63.0 63.0 62.0 62.0 61.0 61.0 61.0 64.0 61.0 21:50:34 INFO - PROCESS | 26212 | -------- Summary: end -------- 21:50:34 INFO - PROCESS | 26212 | 21:50:35 INFO - TEST-INFO | 26212: exit 0 21:50:35 INFO - TEST-OK | kraken | took 59469ms 21:50:35 INFO - SUITE-END | took 1172s 21:50:35 INFO - Completed test suite (00:19:32) 21:50:35 INFO - javascript benchmark 21:50:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3121.2821051158235, 3162.20944763809, 3165.5093460513613, 3174.9047528574124, 3202.103411044907, 5546.91679624806, 5619.719014049297, 5629.183768353591, 5633.859153521164, 5643.746031428595, 5626.409227031164, 5660.009498337795, 5662.518685911702, 5676.347220069693, 5698.715064246781, 5112.897742045147, 5134.0758663440565, 5174.094533456649, 5178.352705911761, 5202.4277329493725, 5129.179331306992, 5194.792208311663, 5221.164613661815, 5221.425643179247, 5223.477652234765, 4995.850124496271, 5070.72111033893, 5095.770690318926, 5106.69359838409, 5108.795648174088, 5027.717931927354, 5063.493650634944, 5067.214581739836, 5163.044836705184, 5206.401263854629, 4992.525710057539, 5062.987402519474, 5109.208072748693, 5121.411037730634, 5122.078025955327, 5491.066518691832, 5504.669719816824, 5542.972285138589, 5574.331080270394, 5635.718214089279, 5899.115132730082, 5924.348321684612, 5929.9703501482645, 6006.099085137221, 6012.6392416455155, 6046.093086037085, 6048.909266361008, 6057.878842423171, 6059.878802423927, 6060.090986352038, 5568.136938774496, 5569.777208911639, 5610.046292130348, 5617.578681598856, 5619.381867994517, 6145.139680444741, 6180.81457556274, 6182.010878259547, 6182.443580077725, 6184.567080304336, 5905.645661260252, 5914.0241860093465, 5916.7337469813965, 5919.6152250103605, 5941.643501389931, 5929.644221346733, 5956.0768080946655, 5978.0, 6012.969935150384, 6016.09758536223, 6052.092186172022, 6056.0, 6059.454649081604, 6088.1476593276975, 6088.573799834057, 6042.1843051187525, 6057.909131363033, 6061.242344706911, 6076.179715738407, 6082.726277317532, 4615.861524154281, 4654.16225079489, 4684.180268453007, 4692.554207350297, 4704.270838020044, 4104.8768536943935, 4150.252954468165, 4150.522689890641, 4152.480939882515, 4187.225363307798, 5833.416658334218, 5839.270091238595, 5844.47399734026, 5847.502962248256, 5850.414958504116, 5956.970215148896, 6175.907361389583, 6180.289266734383, 6189.0097584386285, 6190.628562286187, 5720.713964301768, 5747.597668163272, 5801.970990145022, 5803.970980145156, 5887.087501437284, 5288.0, 5327.627066105335, 5331.573474122061, 5336.386315573681, 5336.733163341895, 6281.309056003836, 6325.304216536178, 6343.11196432509, 6349.111124442582, 6350.110984462179, 5954.642721436728, 6011.549133815069, 6048.576599637983, 6114.908276375769, 6121.877562448815, 6338.936610634019, 6362.77730279438, 6363.109164717036, 6365.52258580599, 6369.649669268235, 6052.182955300978, 6055.576109672281, 6063.575549711478, 6068.089786532056, 6073.331933487225, 5920.674362910081, 5961.225040744675, 5991.730372133352, 6103.389661033861, 6147.354527774519, 5842.036064049385, 5999.100134979613, 5999.760009599567, 6028.246469191351, 6037.335893051849, 5988.221531200916, 5990.1913241713555, 5994.730237139426, 6001.729922153426, 6004.8799024020145, 5707.258056452634, 5762.481376676119, 5867.061270196748, 5916.615419997686, 5927.436893495111, 5824.854378640568, 5894.440028197314, 5904.114382842608, 5967.76128954837, 5994.520438365008, 5767.0, 5799.130130480293, 5804.100364443518, 5809.8547536311935, 5813.302403711413], "value": 5581.220175262228, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [587.3216435017555, 591.1546488521412, 624.250898921294, 631.8799428108656, 634.4987459906674, 35254.64745352549, 38295.42556861646, 46230.76884615576, 46439.6068117957, 46984.0, 46445.30332045013, 46846.0, 46877.0, 46920.765396172974, 46926.29610555836, 8369.83260334793, 9152.176304132627, 9294.953525232399, 9302.53487325631, 9303.441793492411, 8302.667893284291, 11038.613648522303, 11289.887101128967, 11291.887081129165, 11295.378754168518, 11107.278026928265, 11169.49737261821, 11172.329660220372, 11181.944090279578, 11183.217174797768, 10964.122870170408, 11010.614628487965, 11023.283486573388, 11032.44837758117, 11037.668869933916, 10812.891871081267, 10978.945105274503, 10990.065844403236, 10991.285566438235, 10991.505382257817, 44796.0, 45148.0, 45204.09591808145, 45268.3209751854, 45271.54728452739, 3720.665140137374, 3723.7579557328686, 3838.9424158637644, 3850.921741912269, 3929.1945151244213, 34022.82988585041, 34045.31909361824, 34323.48514772281, 34433.31133377343, 34990.650093498996, 4408.58118478744, 4440.467143942716, 4447.73313601185, 4479.888002799924, 4554.134714404253, 360362.0, 365075.0, 365646.0, 365992.0, 366431.0, 38250.426243606365, 60316.698416507636, 60707.0, 60797.0, 60812.39187608156, 38308.616913830505, 40168.0, 40312.39531407031, 40312.79843600822, 40373.59626403757, 17226.138693065546, 17365.131743412778, 17390.043547605004, 17394.391196308068, 17407.0, 13599.388027538784, 13831.930840345934, 14276.428942842378, 14365.353559089866, 14462.638434039232, 9423.575939082757, 9452.10205030521, 9462.43225406464, 9531.0, 9562.091601297865, 3566.32239874423, 3589.5692516897616, 3627.4921510988484, 3648.3980143276062, 3717.7397582168987, 1045.4041196517912, 1047.6856942917095, 1074.5057273654206, 1111.0667039686703, 1157.7279339355246, 32937.0, 34724.0, 34983.65016349855, 35022.47466288008, 35204.29591408157, 1170.6371024982113, 1193.5225909636215, 1234.5247079874134, 1251.7496500699897, 1257.7358754661623, 18233.0, 18370.265189392543, 18439.72340414895, 18495.0, 18523.81476185221, 652237.0, 656111.0, 658278.0, 659473.0, 659724.0, 43660.345094823606, 43972.0, 44130.77934610307, 44137.0, 44213.77893110578, 1325.827642406481, 1368.7878378851094, 1392.491740514725, 1449.3477934929113, 1465.5163795947312, 32359.676403236608, 35109.47335789914, 35554.64445355617, 36098.09754756047, 36130.09674758152, 52634.0, 53116.73441632767, 53165.20252196143, 53166.20250696165, 53232.73383633212, 434807.0, 435705.0, 438381.0, 438431.0, 439094.0, 30813.845930770203, 32058.35883282368, 32169.678303216668, 33374.666253338124, 33376.165595859326, 52990.47009529855, 53074.469255306954, 53337.0, 53345.0, 53363.733181333846, 43591.0, 44384.334234987145, 44397.77801110974, 44973.0, 46402.53597464117, 42463.787681061396, 43156.11141561688, 43449.34825977676, 44082.77958610187, 45735.54264457313, 43395.349069763346, 43542.12915741731, 44200.33699494446, 44306.55693443024, 44467.33299000582, 37347.0, 37987.43018854664, 38741.61258387493, 39686.0, 39830.402543962446, 29484.262893427836, 29649.85175074111, 29945.0, 29974.70025299719, 29978.4004319908], "value": 20395.65081419493, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [381.61647544218056, 402.3622558245181, 406.97354671946323, 412.43702346297306, 426.1285670803207, 14684.486042988498, 16628.0, 20527.076281567308, 20908.790912090873, 21372.4656883578, 20245.696314555295, 20326.186952521883, 20745.377638670827, 20975.0, 21038.0, 5585.720713964306, 5779.162021506879, 5814.273215848019, 5822.155787410823, 6038.33578306386, 3968.1865217630316, 5771.797987070453, 5821.767129314822, 5821.912671309934, 5825.0, 4130.215259100776, 5743.195952566644, 5965.46310832025, 5973.551983601225, 6081.209442772455, 5993.919212393206, 6075.817725468243, 6081.270247570298, 6471.223453185601, 6566.277709451956, 5881.500072493843, 5885.352611212763, 5892.499137573312, 5894.852628684274, 5896.823095307148, 13470.528531501448, 13580.117292375964, 13872.514461993882, 13945.651358716012, 13986.580402587939, 2440.4752978109614, 2513.962290565643, 2595.701494328139, 2604.5832666773226, 2886.841223732694, 10079.899201008042, 10119.848202276971, 10162.593496260215, 10350.741231469197, 10666.200034997328, 2017.8486613504047, 2036.8777873327647, 2064.9793502064936, 2075.0662202009157, 2080.1887263967064, 80906.0, 83347.0, 84834.0, 85670.57164714136, 87932.56033719791, 11460.94269528647, 11524.654260372203, 11821.645350639494, 11949.88050119505, 12363.258204507758, 16294.755578666329, 16295.0, 16323.347066117221, 16330.346786128423, 16344.673106537803, 8786.956065219632, 8826.691065812794, 9049.547522623843, 9197.448153110834, 9264.258859291376, 7918.960405198052, 7938.722144724907, 7985.361171106298, 7994.5203287802915, 8883.244924181388, 4916.557509824133, 4965.155923493015, 4983.277424773388, 4998.05037042968, 5095.286659867622, 1806.1781889240626, 2053.9973525812215, 2087.1755656515893, 2147.7530084040222, 2195.9231426899983, 855.8673405622138, 969.8836139663285, 1002.2583288366702, 1011.6307547745167, 1056.528761336812, 20229.49426264355, 20404.693929591067, 20580.176792928414, 20610.484737881674, 20679.8966005172, 1020.4948550467418, 1024.134606257711, 1025.5436330832708, 1039.4179259614489, 1067.6583493282076, 10679.679609611723, 11345.432728363548, 11433.485493152828, 11472.0, 11613.883861161281, 500616.0, 503047.0, 518675.0, 524446.0, 526158.0, 71161.0, 96201.0, 96646.0, 99656.5017174924, 99752.0, 983.8130755156498, 997.7854761226226, 1015.4719545836124, 1026.6252817721627, 1038.1124138861317, 17297.740533892254, 17340.393086241922, 17773.733393998842, 18089.819101808815, 18381.0, 42240.577594223665, 44991.77504112459, 45433.31850022186, 45692.31461528146, 45802.77098614485, 60592.0, 61664.69167654133, 62077.68961155165, 62365.37634623596, 64005.67997159984, 7011.824704382431, 7482.738104166328, 8036.075851277178, 8450.830983380176, 8540.572971351283, 12261.816072759095, 13519.662008449868, 13684.384202710702, 13792.517261895786, 13840.792388113985, 11103.5558577656, 11514.42427878586, 12005.159638825198, 12159.878401216229, 12268.815967760313, 11231.045361144068, 11235.71910702239, 11394.601188958346, 11566.363849988331, 11670.591529296435, 10831.133509319077, 11138.10895128404, 11494.367809770543, 11629.59296424621, 12062.215955962834, 7771.72798952034, 7816.296533312029, 7957.323627491496, 8005.719799806979, 8542.658293668184, 10086.243531735003, 11021.944890275498, 11093.389863557259, 11156.776864462827, 11220.719482013015], "value": 9313.657955429666, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1517.6737001544668, 1563.2183908045977, 1722.8880122792018, 1788.8032316445197, 1831.4414103698366, 8141.837163256739, 8678.956605216965, 8713.215810577047, 8723.302135829133, 8733.257673097778, 7576.96211518943, 7787.571683557402, 7796.649150788214, 7967.561784101887, 8542.231199192087, 2246.168917500523, 2338.8830558472096, 2344.8475849069755, 2353.52929414117, 2354.6232602783557, 2383.9642405363934, 2389.569877422063, 2398.9880050599722, 2407.325948734357, 2409.229046705046, 2370.762923707624, 2376.3346263046287, 2380.8690522021284, 2381.476075263448, 2385.916492922748, 2333.2533589251448, 2336.030547322859, 2336.1473062332298, 2336.7312759032757, 2340.438294809242, 2289.4848659051745, 2301.735300440454, 2309.1225334373, 2325.279163459333, 2336.7896889280046, 8503.914960850436, 8642.783930401727, 8653.870191947062, 8658.696945606873, 8659.783505412352, 5150.871228219287, 5280.947190528084, 5283.656562323436, 5288.0, 5295.973520132413, 3310.3096424786927, 3338.8998330049894, 3395.8641654333796, 3457.6542345765474, 3479.7912125272564, 1167.6788883057143, 1172.9296242225494, 1174.665220412187, 1187.1274613159321, 1195.432169719385, 11464.541418343257, 11493.77012459746, 11518.884811151866, 11522.596709115225, 11602.303861768236, 4199.719085678837, 4405.9559404405545, 4416.602505774432, 4504.684672072989, 4521.253993091169, 10014.49927503622, 10031.398116113056, 10033.0, 10039.69880903574, 10045.648402306031, 5129.9483605860705, 5130.615203859726, 5130.769115389817, 5134.897302053938, 5139.22911563261, 4084.9387259191135, 4492.213862574036, 4721.952780472151, 4735.12400205963, 4738.431388233365, 3954.4661470701085, 4032.7378720383667, 4160.585400963687, 4165.58344165581, 4171.0, 1260.4076084240392, 1276.2215048820212, 1294.5598496511043, 1300.7268473620456, 1303.387407918277, 860.0281681699764, 901.7925877048316, 926.8887733471892, 935.5836652689624, 977.745786095606, 5925.288965324189, 5992.40075992406, 6045.3652366501765, 6220.315765265817, 6253.6560489172625, 1025.2054657640388, 1056.1709058389129, 1070.2454769387718, 1147.2198904744853, 1151.8214676725122, 4076.3274059780397, 4192.24539582878, 4207.347861081537, 4240.1731662326165, 4289.506706728704, 9622.615095396106, 10342.638007669695, 10412.219083568763, 10418.0, 10421.166306695597, 9987.0, 10281.537330819981, 10307.226957978182, 10307.690769276784, 10326.432046237529, 7974.920250797418, 8184.713535026364, 8188.14024527416, 8193.46742461738, 8226.095129535746, 5738.598298119258, 5840.766369345179, 5863.17915491823, 5912.67480288571, 5987.970060149672, 9787.0, 9860.457674827954, 9886.50567471609, 9920.900790992286, 9951.054649808257, 9673.758156046155, 10276.588936442458, 10284.331518451278, 10295.94852025735, 10314.123299519624, 6639.170103737033, 6843.384095431236, 7234.421246300178, 7331.156916954618, 7349.228331025379, 8050.235227653364, 8201.876971845308, 8309.33525317961, 8524.573771311534, 8543.188397102265, 7050.330218629222, 7107.182673992557, 7142.321479459443, 7187.496875218684, 7244.058272424551, 6883.483738719716, 7123.430125590044, 7153.678084486107, 7174.964125179341, 7210.134783825974, 6922.307769223037, 6999.335063168991, 7018.017477553249, 7034.2965703429245, 7078.539894906815, 5136.922946155736, 5170.43125256229, 5208.869778255574, 5234.712090835041, 5244.606654501004, 4976.527229913152, 5069.619778516552, 5125.128728116155, 5181.5077567631015, 5313.282706834528], "value": 4592.979100013709, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [293.734170575629, 299.13400704959145, 306.20539699479855, 306.72394844639837, 307.22885557251305, 5403.486668766461, 5538.7784488620455, 5540.529055030317, 5618.297712785902, 5707.6290041147295, 5384.730763461821, 5504.862378440541, 5529.170624406341, 5537.252470916425, 5598.356189038262, 4278.465191851019, 4284.207421626993, 4286.363886209974, 4308.82764689412, 4311.6335111515555, 4119.917601647965, 4226.260404429228, 4275.422817919588, 4305.956940430603, 4308.676849236304, 4218.683598730107, 4220.620144187023, 4220.662347012231, 4253.978730106345, 4257.638100761439, 4214.473190851144, 4236.533981262059, 4253.936515871017, 4256.255155347832, 4288.120935208275, 3617.366960781853, 3720.4233343831747, 3726.1057346236707, 3726.1802403471193, 3729.086373838427, 5325.547328477045, 5348.84418193264, 5364.068935183331, 5428.154427494631, 5436.374816896068, 4797.592204662573, 4821.4696383397795, 4873.513578358599, 4875.146849301394, 4881.365422495089, 5582.24639673647, 5710.6611661056195, 5734.623690314336, 5747.770089196469, 5759.769609215627, 3991.5808840071954, 4007.078371974433, 4014.859479918218, 4017.4174744662155, 4020.638142567183, 5929.288485381739, 5955.821325360246, 5963.28440587128, 5969.671668058255, 5984.281886173643, 3951.3677811550015, 4079.0822065035723, 4082.7547597982307, 4084.8774536763945, 4095.9795201023803, 4162.4598898407785, 4189.329707246826, 4200.180964711913, 4214.578542145761, 4222.704410691284, 4844.370231869834, 4850.539198776181, 4850.927236091461, 4857.251389499777, 4865.294532292798, 5549.72251387429, 5809.215755872988, 5851.444112809277, 5858.213244960328, 5861.853453663607, 1424.1383962702623, 1444.3428240150706, 1454.7526920423554, 1454.8181477315336, 1454.9378953364103, 885.7741275974714, 898.2454738020094, 911.3301723233418, 919.8988111307751, 922.082527884759, 4970.701757894465, 4983.700977941335, 5004.724740139254, 5024.974875125601, 5030.522100400456, 5245.606579506552, 5249.580033597379, 5259.289995850588, 5262.368515778055, 5267.815626453055, 4803.807847686124, 4918.483559226302, 4946.3817022872145, 4993.626752642979, 5096.61775366849, 2813.493571157211, 2815.0, 2827.628600128936, 2829.278533973865, 2844.288927768058, 5391.705990562236, 5397.2443857859935, 5410.756515956791, 5411.427343894403, 5413.6736499557865, 5101.285819985205, 5302.734863256822, 5360.383555891044, 5363.942552744976, 5380.2736630555155, 5424.566034717213, 5454.209139674725, 5463.535599474089, 5465.840992807819, 5484.5063944246, 5260.237265596544, 5266.526012658879, 5307.4427185145005, 5313.760880760297, 5316.8936621266585, 4818.325434439252, 5136.434992150786, 5161.587073034073, 5168.638195326442, 5182.429932707475, 5366.892662146814, 5383.461653834585, 5391.304347826087, 5392.166663334328, 5401.702906340189, 3776.735628505978, 3948.6051394860283, 4029.2545879012478, 4040.91918161641, 4112.218678451085, 5865.618734782225, 5884.58807883444, 5914.112883067574, 5931.822045338647, 5944.821655350346, 5629.155626656035, 5779.913301300568, 5801.680907550125, 5801.912971305349, 5805.970970145122, 5780.479756821906, 5796.275465566804, 5799.971000144972, 5815.563832712648, 5842.678652674143, 5724.656520608777, 5726.7709291629535, 5729.968605651023, 5739.942600574108, 5751.971240143773, 5587.53572784876, 5782.826515204551, 5812.0, 5821.7089145543405, 5824.650520968756, 5668.914966275427, 5671.262735844314, 5679.6592204466215, 5680.545556355564, 5684.971575142264], "value": 4215.588171608495, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [822.6590657228717, 828.2793969246757, 865.580193606101, 874.1564390363299, 891.8706787515806, 16234.188290585467, 16340.264688089035, 16423.67152656949, 16649.583760405996, 17473.213705383256, 16495.83504164958, 16620.501384958472, 16661.91669041656, 16665.41671041514, 16937.322507099732, 715.1739740599603, 739.8298391369962, 852.4586887326561, 878.5607196401799, 882.2016075451694, 878.2359347367799, 878.6353663229752, 881.0748713850463, 881.8897637795276, 882.4528792148876, 944.9291303152256, 945.952702364879, 946.1342871272777, 946.4794363100302, 946.5030858799116, 769.2691942654473, 787.1459466478906, 787.3858390455454, 901.8692289617969, 934.042606328512, 689.6930865764737, 692.2661978302965, 692.7298353642084, 693.0955103589813, 693.2512886083018, 14924.552263432006, 14963.775543366859, 14974.0, 15011.849881501154, 15013.774793378108, 15348.616284592863, 15384.769228461582, 15412.460563880322, 15517.224138793015, 16100.838991610168, 14459.132452052805, 14521.927390363086, 14548.854511454856, 14575.635609109751, 14595.270236488239, 4561.1789877821975, 4565.269556870918, 4665.650076244296, 4683.414573178353, 4711.575958163748, 69959.0, 71815.64092179558, 72083.27916720818, 87512.0, 87587.56206218927, 11823.408829558659, 12713.872861271453, 12901.870981290067, 13141.540046098531, 13172.736545269232, 22690.546189076125, 22699.773002270096, 22754.772452275265, 22900.427489312566, 22936.655950160763, 9275.118863707938, 9444.527773611291, 9606.903930960601, 9624.326297159132, 9643.0, 5048.5203905628905, 5243.68537887728, 5294.258803767476, 5490.396056433789, 5603.663780173202, 3652.908677283036, 3756.3426400379826, 3785.432185172191, 3785.4511095890944, 3800.5059342285326, 635.2345423764353, 645.3997782062727, 646.2600322630561, 648.1347401219331, 666.8732940741244, 687.0450074396592, 687.6286805125277, 698.5005720909472, 700.9334113259232, 715.1025463043846, 10231.488425578691, 10645.89354106449, 11101.666949991513, 11130.109591232682, 11167.776644467065, 688.7761477519726, 713.1834050012707, 771.0593076446726, 806.6652339279134, 826.9167390718178, 5055.216441451507, 5095.8980820383385, 5354.170103633943, 5373.059714550016, 5779.33537643168, 71893.0, 72538.63730681312, 102993.0, 122374.0, 126960.0, 105525.47237263764, 106743.0, 107403.0, 110637.0, 110843.44578277056, 56824.0, 64301.0, 86981.56509217413, 87594.56202718946, 91953.0, 10300.433476158883, 10807.13542916549, 10849.186311026862, 10960.232783705063, 11170.776584468427, 52794.47205527896, 53260.201096984354, 53459.0, 53463.0, 54688.726556366964, 68158.0, 75089.87365189636, 76538.23461765534, 76900.61549692215, 78489.0, 13991.720165596835, 14065.929670351583, 14066.507672231422, 14529.200893950512, 14667.339969701176, 15004.249787510798, 15572.0, 15752.291146898187, 16878.071706056286, 16878.240479178712, 14851.183184924932, 15223.391064357746, 15317.234138292817, 16111.597210069842, 16470.09414482167, 13347.66630834198, 13617.25105119228, 13651.931740341632, 14093.436262549383, 14658.267086645837, 14294.142351458946, 14307.71384572282, 14680.632984175481, 14791.0, 15779.368825246862, 11428.428578571204, 11566.479508421973, 11972.281663100242, 12235.93882030584, 12561.0, 11747.941260293645, 11750.11874109428, 12143.119229663309, 12245.571405000783, 12325.0], "value": 8089.013872891069, "unit": "score"}], "name": "dromaeo_css", "value": 7413.901172854711, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 112.0, 112.0, 110.0, 111.0, 112.0, 111.0, 118.0, 111.0, 111.0], "value": 111.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 117.0, 117.0, 150.0, 120.0, 118.0, 118.0, 123.0, 148.0, 118.0], "value": 127.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 160.0, 161.0, 161.0, 161.0, 161.0, 160.0, 160.0, 161.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 115.0, 76.0, 74.0, 76.0, 74.0, 105.0, 76.0], "value": 82.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 109.0, 87.0, 81.0, 81.0, 115.0, 81.0, 81.0, 113.0], "value": 91.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 118.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 147.0, 147.0, 146.0, 145.0, 146.0, 145.0, 146.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [48.0, 48.0, 48.0, 48.0, 47.0, 47.0, 48.0, 47.0, 50.0, 48.0], "value": 47.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 61.0, 60.0, 60.0, 60.0, 59.0, 60.0, 60.0, 60.0], "value": 59.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 73.0, 74.0, 75.0, 76.0, 73.0, 87.0, 73.0, 74.0, 79.0], "value": 76.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 120.0, 119.0, 123.0, 121.0, 118.0, 117.0, 118.0, 166.0, 119.0], "value": 124.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 152.0, 150.0, 153.0, 150.0, 151.0, 154.0, 153.0, 151.0, 152.0], "value": 151.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 62.0, 62.0, 61.0, 61.0, 61.0, 64.0, 61.0], "value": 62.1, "unit": "score"}], "name": "kraken", "value": 1453.7, "alertThreshold": 2.0}]} 21:50:35 INFO - Return code: 0 21:50:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:50:35 INFO - # TBPL SUCCESS # 21:50:35 INFO - Running post-action listener: _resource_record_post_action 21:50:35 INFO - [mozharness: 2016-10-06 04:50:35.484750Z] Finished run-tests step (success) 21:50:35 INFO - Running post-run listener: _resource_record_post_run 21:50:35 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 370593792; Read time: 188; Write time: 270172 21:50:35 INFO - TinderboxPrint: CPU usage
13.0% 21:50:35 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 188 21:50:35 INFO - TinderboxPrint: I/O write bytes / time
370,593,792 / 270,172 21:50:35 INFO - TinderboxPrint: CPU idle
8,253.8 (87.0%) 21:50:35 INFO - TinderboxPrint: CPU user
1,191.4 (12.6%) 21:50:35 INFO - TinderboxPrint: Swap in / out
0 / 0 21:50:35 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 118837248; Read time: 0; Write time: 108436 21:50:35 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 250736640; Read time: 188; Write time: 161708 21:50:36 INFO - Running post-run listener: _upload_blobber_files 21:50:36 INFO - Blob upload gear active. 21:50:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:50:36 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 21:50:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:50:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:50:36 INFO - (blobuploader) - INFO - Open directory for files ... 21:50:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:50:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:50:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:50:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:50:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:50:37 INFO - (blobuploader) - INFO - Done attempting. 21:50:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:50:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:50:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:50:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:50:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:50:40 INFO - (blobuploader) - INFO - Done attempting. 21:50:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:50:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:50:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:50:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:50:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:50:41 INFO - (blobuploader) - INFO - Done attempting. 21:50:41 INFO - (blobuploader) - INFO - Iteration through files over. 21:50:41 INFO - Return code: 0 21:50:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:50:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:50:41 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8e975a3f7578325a260df5901883d6d1b493e5df2aa16798cbf48e7531e5049d349e4df13db61befe949134be261576b4cc11621f8fccabfb4904fe3f70a8ff9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/52dd7da98bc9c5ca34b3ca1f3d8f4e4531aa1dd7aae5703320fb192617a6c0a29fb54b136189d90f61441c914aa95cfc27c22a04b571d6b653dba84ea72fbecd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/85c5e51bea1149ab2b1d36735cb7c2a23d725ed973e179e9a068095e0bcc495789ed68a609717e1e2d3b73470fcf477d6ea3602e9cac21b7701f3ebb845ce0bc"} 21:50:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:50:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:50:41 INFO - Contents: 21:50:41 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8e975a3f7578325a260df5901883d6d1b493e5df2aa16798cbf48e7531e5049d349e4df13db61befe949134be261576b4cc11621f8fccabfb4904fe3f70a8ff9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/52dd7da98bc9c5ca34b3ca1f3d8f4e4531aa1dd7aae5703320fb192617a6c0a29fb54b136189d90f61441c914aa95cfc27c22a04b571d6b653dba84ea72fbecd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/85c5e51bea1149ab2b1d36735cb7c2a23d725ed973e179e9a068095e0bcc495789ed68a609717e1e2d3b73470fcf477d6ea3602e9cac21b7701f3ebb845ce0bc"} 21:50:41 INFO - Running post-run listener: copy_logs_to_upload_dir 21:50:41 INFO - Copying logs to upload dir... 21:50:41 INFO - mkdir: /builds/slave/test/build/upload/logs 21:50:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1231.478581 ========= master_lag: 0.95 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-10-05 21:50:41.766773) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-05 21:50:41.771141) ========= 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=31acecf42b6a79ec49471d4a000001bb-1475711479.15035-895528920 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8e975a3f7578325a260df5901883d6d1b493e5df2aa16798cbf48e7531e5049d349e4df13db61befe949134be261576b4cc11621f8fccabfb4904fe3f70a8ff9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/52dd7da98bc9c5ca34b3ca1f3d8f4e4531aa1dd7aae5703320fb192617a6c0a29fb54b136189d90f61441c914aa95cfc27c22a04b571d6b653dba84ea72fbecd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/85c5e51bea1149ab2b1d36735cb7c2a23d725ed973e179e9a068095e0bcc495789ed68a609717e1e2d3b73470fcf477d6ea3602e9cac21b7701f3ebb845ce0bc"} build_url:https://queue.taskcluster.net/v1/task/RdMDDJ6eRW6MSbdExDBGZQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011319 build_url: 'https://queue.taskcluster.net/v1/task/RdMDDJ6eRW6MSbdExDBGZQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8e975a3f7578325a260df5901883d6d1b493e5df2aa16798cbf48e7531e5049d349e4df13db61befe949134be261576b4cc11621f8fccabfb4904fe3f70a8ff9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/52dd7da98bc9c5ca34b3ca1f3d8f4e4531aa1dd7aae5703320fb192617a6c0a29fb54b136189d90f61441c914aa95cfc27c22a04b571d6b653dba84ea72fbecd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/85c5e51bea1149ab2b1d36735cb7c2a23d725ed973e179e9a068095e0bcc495789ed68a609717e1e2d3b73470fcf477d6ea3602e9cac21b7701f3ebb845ce0bc"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-05 21:50:41.804106) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 21:50:41.804459) ========= 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=31acecf42b6a79ec49471d4a000001bb-1475711479.15035-895528920 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004542 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 21:50:41.854453) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-05 21:50:41.857806) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-05 21:50:41.858100) ========= ========= Total master_lag: 1.11 =========