builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-068 starttime: 1474892398.81 results: success (0) buildid: 20160926033554 builduid: b7726ee8b4e5476b8fb5982fbe887b44 revision: c55bcb7c777ea09431b4d16903ed079ae5632648 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-26 05:19:58.806395) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-26 05:19:58.806836) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-26 05:19:58.807165) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-26 05:19:58.884014) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 05:19:58.884345) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1474887360.687250-2114229463 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-26 05:20:01-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.5M=0s 2016-09-26 05:20:01 (46.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.081610 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 05:19:58.999051) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 05:19:58.999388) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1474887360.687250-2114229463 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017531 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 05:19:59.084662) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 05:19:59.085005) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c55bcb7c777ea09431b4d16903ed079ae5632648 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev c55bcb7c777ea09431b4d16903ed079ae5632648 --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=97facb8ba2ac28944cc45e6b000001d4-1474887360.687250-2114229463 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-26 05:20:01,803 truncating revision to first 12 chars 2016-09-26 05:20:01,803 Setting DEBUG logging. 2016-09-26 05:20:01,803 attempt 1/10 2016-09-26 05:20:01,803 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c55bcb7c777e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-26 05:20:02,124 unpacking tar archive at: mozilla-central-c55bcb7c777e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.647526 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 05:19:59.748990) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-26 05:19:59.749326) ========= script_repo_revision: c55bcb7c777ea09431b4d16903ed079ae5632648 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-26 05:19:59.749748) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-26 05:19:59.750054) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-26 05:19:59.761004) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-09-26 05:19:59.761332) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=97facb8ba2ac28944cc45e6b000001d4-1474887360.687250-2114229463 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:20:02 INFO - MultiFileLogger online at 20160926 05:20:02 in /builds/slave/test 05:20:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 05:20:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:20:02 INFO - {'append_to_log': False, 05:20:02 INFO - 'base_work_dir': '/builds/slave/test', 05:20:02 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 05:20:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:20:02 INFO - 'branch': 'Firefox-Non-PGO', 05:20:02 INFO - 'buildbot_json_path': 'buildprops.json', 05:20:02 INFO - 'config_files': ('talos/linux_config.py',), 05:20:02 INFO - 'default_actions': ('clobber', 05:20:02 INFO - 'read-buildbot-config', 05:20:02 INFO - 'download-and-extract', 05:20:02 INFO - 'populate-webroot', 05:20:02 INFO - 'create-virtualenv', 05:20:02 INFO - 'install', 05:20:02 INFO - 'run-tests'), 05:20:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:20:02 INFO - 'download_minidump_stackwalk': True, 05:20:02 INFO - 'download_symbols': 'ondemand', 05:20:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:20:02 INFO - 'tooltool.py': '/tools/tooltool.py', 05:20:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:20:02 INFO - '/tools/misc-python/virtualenv.py')}, 05:20:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:20:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:20:02 INFO - 'installer_path': 'installer.exe', 05:20:02 INFO - 'log_level': 'info', 05:20:02 INFO - 'log_name': 'talos', 05:20:02 INFO - 'log_to_console': True, 05:20:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:20:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:20:02 INFO - 'opt_config_files': (), 05:20:02 INFO - 'pip_index': False, 05:20:02 INFO - 'sps_profile': False, 05:20:02 INFO - 'sps_profile_interval': 0, 05:20:02 INFO - 'suite': 'dromaeojs', 05:20:02 INFO - 'system_bits': '32', 05:20:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:20:02 INFO - 'title': 'talos-linux64-ix-068', 05:20:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:20:02 INFO - 'use_talos_json': True, 05:20:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:20:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:20:02 INFO - 'work_dir': 'build'} 05:20:02 INFO - [mozharness: 2016-09-26 12:20:02.575184Z] Running clobber step. 05:20:02 INFO - Running pre-action listener: _resource_record_pre_action 05:20:02 INFO - Running main action method: clobber 05:20:02 INFO - rmtree: /builds/slave/test/build 05:20:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:20:03 INFO - Running post-action listener: _resource_record_post_action 05:20:03 INFO - [mozharness: 2016-09-26 12:20:03.547420Z] Finished clobber step (success) 05:20:03 INFO - [mozharness: 2016-09-26 12:20:03.547521Z] Running read-buildbot-config step. 05:20:03 INFO - Running pre-action listener: _resource_record_pre_action 05:20:03 INFO - Running main action method: read_buildbot_config 05:20:03 INFO - Using buildbot properties: 05:20:03 INFO - { 05:20:03 INFO - "project": "", 05:20:03 INFO - "product": "firefox", 05:20:03 INFO - "script_repo_revision": "production", 05:20:03 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 05:20:03 INFO - "repository": "", 05:20:03 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 05:20:03 INFO - "buildid": "20160926033554", 05:20:03 INFO - "pgo_build": "False", 05:20:03 INFO - "basedir": "/builds/slave/test", 05:20:03 INFO - "buildnumber": 220, 05:20:03 INFO - "slavename": "talos-linux64-ix-068", 05:20:03 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:20:03 INFO - "platform": "ubuntu64_hw", 05:20:03 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 05:20:03 INFO - "branch": "mozilla-central", 05:20:03 INFO - "repo_path": "mozilla-central", 05:20:03 INFO - "revision": "c55bcb7c777ea09431b4d16903ed079ae5632648", 05:20:03 INFO - "stage_platform": "linux64", 05:20:03 INFO - "builduid": "b7726ee8b4e5476b8fb5982fbe887b44", 05:20:03 INFO - "slavebuilddir": "test" 05:20:03 INFO - } 05:20:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/UkAJNQORRd-j29yI5AvFDA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 05:20:03 INFO - Running post-action listener: _resource_record_post_action 05:20:03 INFO - [mozharness: 2016-09-26 12:20:03.549954Z] Finished read-buildbot-config step (success) 05:20:03 INFO - [mozharness: 2016-09-26 12:20:03.550041Z] Running download-and-extract step. 05:20:03 INFO - Running pre-action listener: _resource_record_pre_action 05:20:03 INFO - Running main action method: download_and_extract 05:20:03 INFO - mkdir: /builds/slave/test/build/tests 05:20:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:20:03 INFO - trying https://queue.taskcluster.net/v1/task/UkAJNQORRd-j29yI5AvFDA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 05:20:03 INFO - Downloading https://queue.taskcluster.net/v1/task/UkAJNQORRd-j29yI5AvFDA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 05:20:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UkAJNQORRd-j29yI5AvFDA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:20:04 INFO - Downloaded 1361 bytes. 05:20:04 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 05:20:04 INFO - Using the following test package requirements: 05:20:04 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 05:20:04 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:20:04 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:20:04 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:20:04 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:20:04 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:20:04 INFO - u'jsshell-linux-x86_64.zip'], 05:20:04 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:20:04 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:20:04 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 05:20:04 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:20:04 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:20:04 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:20:04 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:20:04 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:20:04 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:20:04 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:20:04 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:20:04 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:20:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UkAJNQORRd-j29yI5AvFDA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 05:20:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UkAJNQORRd-j29yI5AvFDA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:20:04 INFO - Fetch https://queue.taskcluster.net/v1/task/UkAJNQORRd-j29yI5AvFDA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 05:20:04 INFO - Expected file size: 20410336 05:20:09 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:20:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UkAJNQORRd-j29yI5AvFDA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 05:20:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UkAJNQORRd-j29yI5AvFDA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:20:09 INFO - Fetch https://queue.taskcluster.net/v1/task/UkAJNQORRd-j29yI5AvFDA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 05:20:09 INFO - Expected file size: 20410336 05:20:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UkAJNQORRd-j29yI5AvFDA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 05:20:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UkAJNQORRd-j29yI5AvFDA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:20:14 INFO - Fetch https://queue.taskcluster.net/v1/task/UkAJNQORRd-j29yI5AvFDA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 05:20:14 INFO - Expected file size: 14414057 05:20:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:20:15 INFO - trying https://queue.taskcluster.net/v1/task/UkAJNQORRd-j29yI5AvFDA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 05:20:15 INFO - Downloading https://queue.taskcluster.net/v1/task/UkAJNQORRd-j29yI5AvFDA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 05:20:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UkAJNQORRd-j29yI5AvFDA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:20:17 INFO - Downloaded 55740060 bytes. 05:20:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UkAJNQORRd-j29yI5AvFDA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 05:20:17 INFO - mkdir: /builds/slave/test/properties 05:20:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:20:17 INFO - Writing to file /builds/slave/test/properties/build_url 05:20:17 INFO - Contents: 05:20:17 INFO - build_url:https://queue.taskcluster.net/v1/task/UkAJNQORRd-j29yI5AvFDA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 05:20:18 INFO - Running post-action listener: _resource_record_post_action 05:20:18 INFO - Running post-action listener: set_extra_try_arguments 05:20:18 INFO - [mozharness: 2016-09-26 12:20:18.217218Z] Finished download-and-extract step (success) 05:20:18 INFO - [mozharness: 2016-09-26 12:20:18.217443Z] Running populate-webroot step. 05:20:18 INFO - Running pre-action listener: _resource_record_pre_action 05:20:18 INFO - Running main action method: populate_webroot 05:20:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:20:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:20:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:20:18 INFO - '--tppagecycles', 05:20:18 INFO - '7'], 05:20:18 INFO - 'tests': ['tsvgm']}}, 05:20:18 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:20:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:20:18 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:20:18 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:20:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:20:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:20:18 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:20:18 INFO - 'talos_options': ['--disable-e10s'], 05:20:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:20:18 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:20:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:20:18 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:20:18 INFO - 'talos_options': ['--disable-e10s'], 05:20:18 INFO - 'tests': ['damp', 'tps']}, 05:20:18 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:20:18 INFO - 'tests': ['damp', 'tps']}, 05:20:18 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:20:18 INFO - 'tests': ['dromaeo_dom']}, 05:20:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:20:18 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:20:18 INFO - 'tests': ['basic_compositor_video']}, 05:20:18 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:20:18 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:20:18 INFO - 'tests': ['a11yr', 05:20:18 INFO - 'ts_paint', 05:20:18 INFO - 'tpaint', 05:20:18 INFO - 'sessionrestore', 05:20:18 INFO - 'sessionrestore_no_auto_restore', 05:20:18 INFO - 'tabpaint']}, 05:20:18 INFO - 'other-e10s': {'tests': ['a11yr', 05:20:18 INFO - 'ts_paint', 05:20:18 INFO - 'tpaint', 05:20:18 INFO - 'sessionrestore', 05:20:18 INFO - 'sessionrestore_no_auto_restore', 05:20:18 INFO - 'tabpaint']}, 05:20:18 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:20:18 INFO - 'ts_paint', 05:20:18 INFO - 'tpaint', 05:20:18 INFO - 'sessionrestore', 05:20:18 INFO - 'sessionrestore_no_auto_restore', 05:20:18 INFO - 'tabpaint']}, 05:20:18 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:20:18 INFO - 'ts_paint', 05:20:18 INFO - 'tpaint', 05:20:18 INFO - 'sessionrestore', 05:20:18 INFO - 'sessionrestore_no_auto_restore', 05:20:18 INFO - 'tabpaint']}, 05:20:18 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:20:18 INFO - 'tests': ['a11yr', 05:20:18 INFO - 'ts_paint', 05:20:18 INFO - 'tpaint', 05:20:18 INFO - 'sessionrestore', 05:20:18 INFO - 'sessionrestore_no_auto_restore', 05:20:18 INFO - 'tabpaint']}, 05:20:18 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:20:18 INFO - 'tests': ['a11yr', 05:20:18 INFO - 'ts_paint', 05:20:18 INFO - 'tpaint', 05:20:18 INFO - 'sessionrestore', 05:20:18 INFO - 'sessionrestore_no_auto_restore', 05:20:18 INFO - 'tabpaint']}, 05:20:18 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:20:18 INFO - 'tests': ['tsvgx', 05:20:18 INFO - 'tsvgr_opacity', 05:20:18 INFO - 'tart', 05:20:18 INFO - 'tscrollx', 05:20:18 INFO - 'cart']}, 05:20:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:20:18 INFO - 'tsvgr_opacity', 05:20:18 INFO - 'tart', 05:20:18 INFO - 'tscrollx', 05:20:18 INFO - 'cart']}, 05:20:18 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:20:18 INFO - 'talos_options': ['--disable-e10s'], 05:20:18 INFO - 'tests': ['tp5o']}, 05:20:18 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:20:18 INFO - 'tests': ['tp5o']}, 05:20:18 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:20:18 INFO - 'talos_options': ['--disable-e10s', 05:20:18 INFO - '--xperf_path', 05:20:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:20:18 INFO - 'tests': ['tp5n']}, 05:20:18 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:20:18 INFO - 'talos_options': ['--xperf_path', 05:20:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:20:18 INFO - 'tests': ['tp5n']}}, 05:20:18 INFO - 'talos.zip': {'path': '', 05:20:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:20:18 INFO - Running post-action listener: _resource_record_post_action 05:20:18 INFO - [mozharness: 2016-09-26 12:20:18.239648Z] Finished populate-webroot step (success) 05:20:18 INFO - [mozharness: 2016-09-26 12:20:18.239745Z] Running create-virtualenv step. 05:20:18 INFO - Running pre-action listener: _resource_record_pre_action 05:20:18 INFO - Running main action method: create_virtualenv 05:20:18 INFO - Creating virtualenv /builds/slave/test/build/venv 05:20:18 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 05:20:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:20:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:20:18 INFO - Using real prefix '/usr' 05:20:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:20:18 INFO - Installing distribute.............................................................................................................................................................................................done. 05:20:20 INFO - Installing pip.................done. 05:20:20 INFO - Return code: 0 05:20:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:20:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:20:21 INFO - Reading from file tmpfile_stdout 05:20:21 INFO - Output received: 05:20:21 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 05:20:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:20:21 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')]} 05:20:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:20:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:21 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')]} 05:20:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:20:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:21 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 0x7fe74fe1cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d61ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5ef60>, '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 0x1d5fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d601d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1474887360.687250-2114229463', '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 05:20:21 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 05:20:21 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 05:20:21 INFO - Using env: {'DISPLAY': ':0', 05:20:21 INFO - 'HOME': '/home/cltbld', 05:20:21 INFO - 'LANG': 'en_US.UTF-8', 05:20:21 INFO - 'LANGUAGE': 'en_US:en', 05:20:21 INFO - 'LOGNAME': 'cltbld', 05:20:21 INFO - 'MAIL': '/var/mail/cltbld', 05:20:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:21 INFO - 'MOZ_NO_REMOTE': '1', 05:20:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:21 INFO - 'NO_EM_RESTART': '1', 05:20:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:21 INFO - 'PWD': '/builds/slave/test', 05:20:21 INFO - 'SHELL': '/bin/bash', 05:20:21 INFO - 'SHLVL': '1', 05:20:21 INFO - 'TERM': 'linux', 05:20:21 INFO - 'TMOUT': '86400', 05:20:21 INFO - 'USER': 'cltbld', 05:20:21 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1474887360.687250-2114229463', 05:20:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:21 INFO - '_': '/tools/buildbot/bin/python'} 05:20:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:20:21 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 05:20:21 INFO - Cleaning up... 05:20:21 INFO - Return code: 0 05:20:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:20:21 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')]} 05:20:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:20:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:21 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')]} 05:20:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:20:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:21 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 0x7fe74fe1cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d61ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5ef60>, '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 0x1d5fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d601d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1474887360.687250-2114229463', '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 05:20:21 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 05:20:21 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 05:20:21 INFO - Using env: {'DISPLAY': ':0', 05:20:21 INFO - 'HOME': '/home/cltbld', 05:20:21 INFO - 'LANG': 'en_US.UTF-8', 05:20:21 INFO - 'LANGUAGE': 'en_US:en', 05:20:21 INFO - 'LOGNAME': 'cltbld', 05:20:21 INFO - 'MAIL': '/var/mail/cltbld', 05:20:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:21 INFO - 'MOZ_NO_REMOTE': '1', 05:20:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:21 INFO - 'NO_EM_RESTART': '1', 05:20:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:21 INFO - 'PWD': '/builds/slave/test', 05:20:21 INFO - 'SHELL': '/bin/bash', 05:20:21 INFO - 'SHLVL': '1', 05:20:21 INFO - 'TERM': 'linux', 05:20:21 INFO - 'TMOUT': '86400', 05:20:21 INFO - 'USER': 'cltbld', 05:20:21 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1474887360.687250-2114229463', 05:20:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:21 INFO - '_': '/tools/buildbot/bin/python'} 05:20:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:20:21 INFO - Downloading/unpacking psutil>=3.1.1 05:20:21 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 05:20:21 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 05:20:21 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 05:20:21 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 05:20:21 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 05:20:21 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 05:20:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:20:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:20:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:20:23 INFO - Installing collected packages: psutil 05:20:23 INFO - Running setup.py install for psutil 05:20:23 INFO - building 'psutil._psutil_linux' extension 05:20:23 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 05:20:23 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 05:20:23 INFO - building 'psutil._psutil_posix' extension 05:20:23 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 05:20:23 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 05:20:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:20:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:20:23 INFO - Successfully installed psutil 05:20:23 INFO - Cleaning up... 05:20:24 INFO - Return code: 0 05:20:24 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:20:24 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')]} 05:20:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:20:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:24 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')]} 05:20:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:20:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:24 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 0x7fe74fe1cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d61ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5ef60>, '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 0x1d5fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d601d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1474887360.687250-2114229463', '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 05:20:24 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 05:20:24 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 05:20:24 INFO - Using env: {'DISPLAY': ':0', 05:20:24 INFO - 'HOME': '/home/cltbld', 05:20:24 INFO - 'LANG': 'en_US.UTF-8', 05:20:24 INFO - 'LANGUAGE': 'en_US:en', 05:20:24 INFO - 'LOGNAME': 'cltbld', 05:20:24 INFO - 'MAIL': '/var/mail/cltbld', 05:20:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:24 INFO - 'MOZ_NO_REMOTE': '1', 05:20:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:24 INFO - 'NO_EM_RESTART': '1', 05:20:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:24 INFO - 'PWD': '/builds/slave/test', 05:20:24 INFO - 'SHELL': '/bin/bash', 05:20:24 INFO - 'SHLVL': '1', 05:20:24 INFO - 'TERM': 'linux', 05:20:24 INFO - 'TMOUT': '86400', 05:20:24 INFO - 'USER': 'cltbld', 05:20:24 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1474887360.687250-2114229463', 05:20:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:24 INFO - '_': '/tools/buildbot/bin/python'} 05:20:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:20:24 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:20:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:26 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:20:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:20:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:20:26 INFO - Installing collected packages: mozsystemmonitor 05:20:26 INFO - Running setup.py install for mozsystemmonitor 05:20:26 INFO - Successfully installed mozsystemmonitor 05:20:26 INFO - Cleaning up... 05:20:26 INFO - Return code: 0 05:20:26 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:20: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')]} 05:20:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:20:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20: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')]} 05:20:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:20:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20: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', '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 0x7fe74fe1cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d61ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5ef60>, '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 0x1d5fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d601d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1474887360.687250-2114229463', '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 05:20: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:20: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 jsonschema==2.5.1 05:20:26 INFO - Using env: {'DISPLAY': ':0', 05:20:26 INFO - 'HOME': '/home/cltbld', 05:20:26 INFO - 'LANG': 'en_US.UTF-8', 05:20:26 INFO - 'LANGUAGE': 'en_US:en', 05:20:26 INFO - 'LOGNAME': 'cltbld', 05:20:26 INFO - 'MAIL': '/var/mail/cltbld', 05:20:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:26 INFO - 'MOZ_NO_REMOTE': '1', 05:20:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:26 INFO - 'NO_EM_RESTART': '1', 05:20:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:26 INFO - 'PWD': '/builds/slave/test', 05:20:26 INFO - 'SHELL': '/bin/bash', 05:20:26 INFO - 'SHLVL': '1', 05:20:26 INFO - 'TERM': 'linux', 05:20:26 INFO - 'TMOUT': '86400', 05:20:26 INFO - 'USER': 'cltbld', 05:20:26 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1474887360.687250-2114229463', 05:20:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:26 INFO - '_': '/tools/buildbot/bin/python'} 05:20:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:20:26 INFO - Downloading/unpacking jsonschema==2.5.1 05:20:26 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 05:20:26 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 05:20:26 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 05:20:26 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 05:20:26 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 05:20:26 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 05:20:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:20:28 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:20:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:28 INFO - Downloading functools32-3.2.3-2.tar.gz 05:20:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:20:28 INFO - warning: no files found matching '*.txt' 05:20:28 INFO - no previously-included directories found matching 'build' 05:20:28 INFO - no previously-included directories found matching 'dist' 05:20:28 INFO - no previously-included directories found matching '.git*' 05:20:28 INFO - Installing collected packages: jsonschema, functools32 05:20:28 INFO - Running setup.py install for functools32 05:20:28 INFO - warning: no files found matching '*.txt' 05:20:28 INFO - no previously-included directories found matching 'build' 05:20:28 INFO - no previously-included directories found matching 'dist' 05:20:28 INFO - no previously-included directories found matching '.git*' 05:20:28 INFO - Successfully installed jsonschema functools32 05:20:28 INFO - Cleaning up... 05:20:28 INFO - Return code: 0 05:20:28 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:20:28 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')]} 05:20:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:20:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:28 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')]} 05:20:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:20:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:28 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 0x7fe74fe1cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d61ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5ef60>, '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 0x1d5fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d601d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1474887360.687250-2114229463', '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 05:20:28 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 05:20:28 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 05:20:28 INFO - Using env: {'DISPLAY': ':0', 05:20:28 INFO - 'HOME': '/home/cltbld', 05:20:28 INFO - 'LANG': 'en_US.UTF-8', 05:20:28 INFO - 'LANGUAGE': 'en_US:en', 05:20:28 INFO - 'LOGNAME': 'cltbld', 05:20:28 INFO - 'MAIL': '/var/mail/cltbld', 05:20:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:28 INFO - 'MOZ_NO_REMOTE': '1', 05:20:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:28 INFO - 'NO_EM_RESTART': '1', 05:20:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:28 INFO - 'PWD': '/builds/slave/test', 05:20:28 INFO - 'SHELL': '/bin/bash', 05:20:28 INFO - 'SHLVL': '1', 05:20:28 INFO - 'TERM': 'linux', 05:20:28 INFO - 'TMOUT': '86400', 05:20:28 INFO - 'USER': 'cltbld', 05:20:28 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1474887360.687250-2114229463', 05:20:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:28 INFO - '_': '/tools/buildbot/bin/python'} 05:20:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:20:29 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:20:29 INFO - Cleaning up... 05:20:29 INFO - Return code: 0 05:20:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:20: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')]} 05:20:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:20:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20: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')]} 05:20:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:20:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20: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', '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 0x7fe74fe1cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d61ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5ef60>, '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 0x1d5fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d601d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1474887360.687250-2114229463', '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 05:20: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:20: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 blobuploader==1.2.4 05:20:29 INFO - Using env: {'DISPLAY': ':0', 05:20:29 INFO - 'HOME': '/home/cltbld', 05:20:29 INFO - 'LANG': 'en_US.UTF-8', 05:20:29 INFO - 'LANGUAGE': 'en_US:en', 05:20:29 INFO - 'LOGNAME': 'cltbld', 05:20:29 INFO - 'MAIL': '/var/mail/cltbld', 05:20:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:29 INFO - 'MOZ_NO_REMOTE': '1', 05:20:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:29 INFO - 'NO_EM_RESTART': '1', 05:20:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:29 INFO - 'PWD': '/builds/slave/test', 05:20:29 INFO - 'SHELL': '/bin/bash', 05:20:29 INFO - 'SHLVL': '1', 05:20:29 INFO - 'TERM': 'linux', 05:20:29 INFO - 'TMOUT': '86400', 05:20:29 INFO - 'USER': 'cltbld', 05:20:29 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1474887360.687250-2114229463', 05:20:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:29 INFO - '_': '/tools/buildbot/bin/python'} 05:20:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:20:29 INFO - Downloading/unpacking blobuploader==1.2.4 05:20: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 05:20: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 05:20: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 05:20: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 05:20: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 05:20: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 05:20:31 INFO - Downloading blobuploader-1.2.4.tar.gz 05:20:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:20:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:20:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:20:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:20:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:31 INFO - Downloading docopt-0.6.1.tar.gz 05:20:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:20:32 INFO - Installing collected packages: blobuploader, requests, docopt 05:20:32 INFO - Running setup.py install for blobuploader 05:20:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:20:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:20:32 INFO - Running setup.py install for requests 05:20:32 INFO - Running setup.py install for docopt 05:20:32 INFO - Successfully installed blobuploader requests docopt 05:20:32 INFO - Cleaning up... 05:20:32 INFO - Return code: 0 05:20:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:20: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')]} 05:20:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:20:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20: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')]} 05:20:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:20:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:32 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 0x7fe74fe1cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d61ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5ef60>, '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 0x1d5fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d601d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1474887360.687250-2114229463', '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 05:20:32 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 05:20:32 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 05:20:32 INFO - Using env: {'DISPLAY': ':0', 05:20:32 INFO - 'HOME': '/home/cltbld', 05:20:32 INFO - 'LANG': 'en_US.UTF-8', 05:20:32 INFO - 'LANGUAGE': 'en_US:en', 05:20:32 INFO - 'LOGNAME': 'cltbld', 05:20:32 INFO - 'MAIL': '/var/mail/cltbld', 05:20:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:32 INFO - 'MOZ_NO_REMOTE': '1', 05:20:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:32 INFO - 'NO_EM_RESTART': '1', 05:20:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:32 INFO - 'PWD': '/builds/slave/test', 05:20:32 INFO - 'SHELL': '/bin/bash', 05:20:32 INFO - 'SHLVL': '1', 05:20:32 INFO - 'TERM': 'linux', 05:20:32 INFO - 'TMOUT': '86400', 05:20:32 INFO - 'USER': 'cltbld', 05:20:32 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1474887360.687250-2114229463', 05:20:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:32 INFO - '_': '/tools/buildbot/bin/python'} 05:20:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:20:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:20:32 INFO - Running setup.py (path:/tmp/pip-Bp4Gr_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:20:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:20:32 INFO - Running setup.py (path:/tmp/pip-QXlqNj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:20:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:20:33 INFO - Running setup.py (path:/tmp/pip-KzFGlf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:20:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:20:33 INFO - Running setup.py (path:/tmp/pip-NCN1OR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:20:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:20:33 INFO - Running setup.py (path:/tmp/pip-iE6dMk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:20:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:20:33 INFO - Running setup.py (path:/tmp/pip-g3uo3L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:20:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:20:33 INFO - Running setup.py (path:/tmp/pip-NXpEse-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:20:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:20:33 INFO - Running setup.py (path:/tmp/pip-YwGsAm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:20:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:20:33 INFO - Running setup.py (path:/tmp/pip-fKsTxm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:20:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:20:33 INFO - Running setup.py (path:/tmp/pip-VX0ZZX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:20:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:20:33 INFO - Running setup.py (path:/tmp/pip-UndDIK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:20:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:20:33 INFO - Running setup.py (path:/tmp/pip-alDS1a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:20:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:20:33 INFO - Running setup.py (path:/tmp/pip-w1HO8a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:20:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:20:33 INFO - Running setup.py (path:/tmp/pip-pCl3mM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:20:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:20:33 INFO - Running setup.py (path:/tmp/pip-_pMIZb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:20:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:20:33 INFO - Running setup.py (path:/tmp/pip-VnBCjb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:20:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:20:34 INFO - Running setup.py (path:/tmp/pip-iqwRwp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:20:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:20:34 INFO - Running setup.py install for manifestparser 05:20:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:20:34 INFO - Running setup.py install for mozcrash 05:20:34 INFO - Running setup.py install for mozdebug 05:20:34 INFO - Running setup.py install for mozdevice 05:20:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:20:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:20:34 INFO - Running setup.py install for mozfile 05:20:34 INFO - Running setup.py install for mozhttpd 05:20:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:20:34 INFO - Running setup.py install for mozinfo 05:20:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:20:34 INFO - Running setup.py install for mozInstall 05:20:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:20:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:20:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:20:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:20:34 INFO - Running setup.py install for mozleak 05:20:35 INFO - Running setup.py install for mozlog 05:20:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:20:35 INFO - Running setup.py install for moznetwork 05:20:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:20:35 INFO - Running setup.py install for mozprocess 05:20:35 INFO - Running setup.py install for mozprofile 05:20:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:20:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:20:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:20:35 INFO - Running setup.py install for mozrunner 05:20:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:20:35 INFO - Running setup.py install for mozscreenshot 05:20:35 INFO - Running setup.py install for moztest 05:20:35 INFO - Running setup.py install for mozversion 05:20:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:20:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:20:35 INFO - Cleaning up... 05:20:35 INFO - Return code: 0 05:20:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:20:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:20:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:20:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:20:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:20:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:35 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 0x7fe74fe1cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d61ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5ef60>, '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 0x1d5fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d601d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1474887360.687250-2114229463', '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 05:20:35 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 05:20:35 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 05:20:35 INFO - Using env: {'DISPLAY': ':0', 05:20:35 INFO - 'HOME': '/home/cltbld', 05:20:35 INFO - 'LANG': 'en_US.UTF-8', 05:20:35 INFO - 'LANGUAGE': 'en_US:en', 05:20:35 INFO - 'LOGNAME': 'cltbld', 05:20:35 INFO - 'MAIL': '/var/mail/cltbld', 05:20:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:35 INFO - 'MOZ_NO_REMOTE': '1', 05:20:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:35 INFO - 'NO_EM_RESTART': '1', 05:20:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:35 INFO - 'PWD': '/builds/slave/test', 05:20:35 INFO - 'SHELL': '/bin/bash', 05:20:35 INFO - 'SHLVL': '1', 05:20:35 INFO - 'TERM': 'linux', 05:20:35 INFO - 'TMOUT': '86400', 05:20:35 INFO - 'USER': 'cltbld', 05:20:35 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1474887360.687250-2114229463', 05:20:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:35 INFO - '_': '/tools/buildbot/bin/python'} 05:20:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:20:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:20:36 INFO - Running setup.py (path:/tmp/pip-gR54ff-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:20:36 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)) 05:20:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:20:36 INFO - Running setup.py (path:/tmp/pip-6Qf5Zm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:20:36 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)) 05:20:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:20:36 INFO - Running setup.py (path:/tmp/pip-plFyIn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:20:36 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)) 05:20:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:20:36 INFO - Running setup.py (path:/tmp/pip-ySTj5E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:20:36 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)) 05:20:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:20:36 INFO - Running setup.py (path:/tmp/pip-_AyR_m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:20:36 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)) 05:20:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:20:36 INFO - Running setup.py (path:/tmp/pip-igrme1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:20:36 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)) 05:20:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:20:36 INFO - Running setup.py (path:/tmp/pip-3YDqbx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:20:36 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)) 05:20:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:20:36 INFO - Running setup.py (path:/tmp/pip-M2im8l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:20:36 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)) 05:20:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:20:36 INFO - Running setup.py (path:/tmp/pip-O2uE0b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:20:36 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)) 05:20:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:20:36 INFO - Running setup.py (path:/tmp/pip-XAOzJc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:20:36 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)) 05:20:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:20:36 INFO - Running setup.py (path:/tmp/pip-kNqQ5A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:20:36 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)) 05:20:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:20:36 INFO - Running setup.py (path:/tmp/pip-nnV56M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:20:37 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)) 05:20:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:20:37 INFO - Running setup.py (path:/tmp/pip-CoTjdI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:20:37 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)) 05:20:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:20:37 INFO - Running setup.py (path:/tmp/pip-hlC6Uq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:20:37 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)) 05:20:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:20:37 INFO - Running setup.py (path:/tmp/pip-IJJFfo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:20:37 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)) 05:20:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:20:37 INFO - Running setup.py (path:/tmp/pip-RAd2YZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:20:37 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)) 05:20:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:20:37 INFO - Running setup.py (path:/tmp/pip-gz1kxv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:20:37 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)) 05:20:37 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)) 05:20:37 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)) 05:20:37 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)) 05:20:37 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)) 05:20:37 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)) 05:20:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:20: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 05:20: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 05:20: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 05:20: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 05:20: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 05:20: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 05:20:39 INFO - Downloading blessings-1.6.tar.gz 05:20:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:20:39 INFO - Installing collected packages: blessings 05:20:39 INFO - Running setup.py install for blessings 05:20:39 INFO - Successfully installed blessings 05:20:39 INFO - Cleaning up... 05:20:39 INFO - Return code: 0 05:20:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:20:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:20:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:20:39 INFO - Reading from file tmpfile_stdout 05:20:39 INFO - Current package versions: 05:20:39 INFO - argparse == 1.2.1 05:20:39 INFO - blessings == 1.6 05:20:39 INFO - blobuploader == 1.2.4 05:20:39 INFO - docopt == 0.6.1 05:20:39 INFO - functools32 == 3.2.3-2 05:20:39 INFO - jsonschema == 2.5.1 05:20:39 INFO - manifestparser == 1.1 05:20:39 INFO - mozInstall == 1.12 05:20:39 INFO - mozcrash == 0.17 05:20:39 INFO - mozdebug == 0.1 05:20:39 INFO - mozdevice == 0.48 05:20:39 INFO - mozfile == 1.2 05:20:39 INFO - mozhttpd == 0.7 05:20:39 INFO - mozinfo == 0.9 05:20:39 INFO - mozleak == 0.1 05:20:39 INFO - mozlog == 3.4 05:20:39 INFO - moznetwork == 0.27 05:20:39 INFO - mozprocess == 0.23 05:20:39 INFO - mozprofile == 0.28 05:20:39 INFO - mozrunner == 6.12 05:20:39 INFO - mozscreenshot == 0.1 05:20:39 INFO - mozsystemmonitor == 0.3 05:20:39 INFO - moztest == 0.7 05:20:39 INFO - mozversion == 1.4 05:20:39 INFO - psutil == 3.1.1 05:20:39 INFO - requests == 1.2.3 05:20:39 INFO - wsgiref == 0.1.2 05:20:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:20:39 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')]} 05:20:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:20:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:39 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')]} 05:20:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:20:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:39 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 0x7fe74fe1cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d61ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5ef60>, '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 0x1d5fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d601d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1474887360.687250-2114229463', '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 05:20:39 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 05:20:39 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 05:20:39 INFO - Using env: {'DISPLAY': ':0', 05:20:39 INFO - 'HOME': '/home/cltbld', 05:20:39 INFO - 'LANG': 'en_US.UTF-8', 05:20:39 INFO - 'LANGUAGE': 'en_US:en', 05:20:39 INFO - 'LOGNAME': 'cltbld', 05:20:39 INFO - 'MAIL': '/var/mail/cltbld', 05:20:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:39 INFO - 'MOZ_NO_REMOTE': '1', 05:20:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:39 INFO - 'NO_EM_RESTART': '1', 05:20:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:39 INFO - 'PWD': '/builds/slave/test', 05:20:39 INFO - 'SHELL': '/bin/bash', 05:20:39 INFO - 'SHLVL': '1', 05:20:39 INFO - 'TERM': 'linux', 05:20:39 INFO - 'TMOUT': '86400', 05:20:39 INFO - 'USER': 'cltbld', 05:20:39 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1474887360.687250-2114229463', 05:20:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:39 INFO - '_': '/tools/buildbot/bin/python'} 05:20:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:20:39 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)) 05:20:39 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)) 05:20:39 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)) 05:20:39 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)) 05:20:39 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)) 05:20:39 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)) 05:20:39 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)) 05:20:39 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)) 05:20:39 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)) 05:20:39 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)) 05:20:39 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)) 05:20:39 INFO - Cleaning up... 05:20:39 INFO - Return code: 0 05:20:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:20:39 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')]} 05:20:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:20:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:39 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')]} 05:20:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:20:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:39 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 0x7fe74fe1cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d61ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5ef60>, '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 0x1d5fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d601d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1474887360.687250-2114229463', '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 05:20:39 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 05:20:39 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 05:20:39 INFO - Using env: {'DISPLAY': ':0', 05:20:39 INFO - 'HOME': '/home/cltbld', 05:20:39 INFO - 'LANG': 'en_US.UTF-8', 05:20:39 INFO - 'LANGUAGE': 'en_US:en', 05:20:39 INFO - 'LOGNAME': 'cltbld', 05:20:39 INFO - 'MAIL': '/var/mail/cltbld', 05:20:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:39 INFO - 'MOZ_NO_REMOTE': '1', 05:20:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:39 INFO - 'NO_EM_RESTART': '1', 05:20:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:40 INFO - 'PWD': '/builds/slave/test', 05:20:40 INFO - 'SHELL': '/bin/bash', 05:20:40 INFO - 'SHLVL': '1', 05:20:40 INFO - 'TERM': 'linux', 05:20:40 INFO - 'TMOUT': '86400', 05:20:40 INFO - 'USER': 'cltbld', 05:20:40 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1474887360.687250-2114229463', 05:20:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:40 INFO - '_': '/tools/buildbot/bin/python'} 05:20:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:20:40 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:20:40 INFO - Cleaning up... 05:20:40 INFO - Return code: 0 05:20:40 INFO - Running post-action listener: _resource_record_post_action 05:20:40 INFO - Running post-action listener: _start_resource_monitoring 05:20:40 INFO - Starting resource monitoring. 05:20:40 INFO - [mozharness: 2016-09-26 12:20:40.255191Z] Finished create-virtualenv step (success) 05:20:40 INFO - [mozharness: 2016-09-26 12:20:40.255648Z] Running install step. 05:20:40 INFO - Running pre-action listener: _resource_record_pre_action 05:20:40 INFO - Running main action method: install 05:20:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:20:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:20:40 INFO - Reading from file tmpfile_stdout 05:20:40 INFO - Detecting whether we're running mozinstall >=1.0... 05:20:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:20:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:20:40 INFO - Reading from file tmpfile_stdout 05:20:40 INFO - Output received: 05:20:40 INFO - Usage: mozinstall [options] installer 05:20:40 INFO - Options: 05:20:40 INFO - -h, --help show this help message and exit 05:20:40 INFO - -d DEST, --destination=DEST 05:20:40 INFO - Directory to install application into. [default: 05:20:40 INFO - "/builds/slave/test"] 05:20:40 INFO - --app=APP Application being installed. [default: firefox] 05:20:40 INFO - mkdir: /builds/slave/test/build/application 05:20:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:20:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:20:56 INFO - Reading from file tmpfile_stdout 05:20:56 INFO - Output received: 05:20:56 INFO - /builds/slave/test/build/application/firefox/firefox 05:20:56 INFO - Running post-action listener: _resource_record_post_action 05:20:56 INFO - [mozharness: 2016-09-26 12:20:56.691899Z] Finished install step (success) 05:20:56 INFO - [mozharness: 2016-09-26 12:20:56.692149Z] Running run-tests step. 05:20:56 INFO - Running pre-action listener: _resource_record_pre_action 05:20:56 INFO - Running main action method: run_tests 05:20:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:20:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:20:56 INFO - Python 2.7.3 05:20:56 INFO - Return code: 0 05:20:56 INFO - grabbing minidump binary from tooltool 05:20:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:20:56 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 0x1d5ef60>, '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 0x1d5fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d601d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:20:56 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 05:20:56 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 05:20:56 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 05:20:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:20:56 INFO - Return code: 0 05:20:56 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:20:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:20:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:20:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:20:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:20:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UkAJNQORRd-j29yI5AvFDA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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 05:20:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/UkAJNQORRd-j29yI5AvFDA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-068 --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 05:20:56 INFO - Using env: {'DISPLAY': ':0', 05:20:56 INFO - 'HOME': '/home/cltbld', 05:20:56 INFO - 'LANG': 'en_US.UTF-8', 05:20:56 INFO - 'LANGUAGE': 'en_US:en', 05:20:56 INFO - 'LOGNAME': 'cltbld', 05:20:56 INFO - 'MAIL': '/var/mail/cltbld', 05:20:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:20:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:20:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:56 INFO - 'MOZ_NO_REMOTE': '1', 05:20:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:20:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:56 INFO - 'NO_EM_RESTART': '1', 05:20:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:56 INFO - 'PWD': '/builds/slave/test', 05:20:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:20:56 INFO - 'SHELL': '/bin/bash', 05:20:56 INFO - 'SHLVL': '1', 05:20:56 INFO - 'TERM': 'linux', 05:20:56 INFO - 'TMOUT': '86400', 05:20:56 INFO - 'USER': 'cltbld', 05:20:56 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1474887360.687250-2114229463', 05:20:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:56 INFO - '_': '/tools/buildbot/bin/python'} 05:20:56 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UkAJNQORRd-j29yI5AvFDA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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 05:20:56 INFO - mozversion application_buildid: 20160926033554 05:20:56 INFO - mozversion application_changeset: c55bcb7c777ea09431b4d16903ed079ae5632648 05:20:56 INFO - mozversion application_display_name: Nightly 05:20:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:20:56 INFO - mozversion application_name: Firefox 05:20:56 INFO - mozversion application_remotingname: firefox 05:20:56 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:20:56 INFO - mozversion application_vendor: Mozilla 05:20:56 INFO - mozversion application_version: 52.0a1 05:20:56 INFO - mozversion platform_buildid: 20160926033554 05:20:56 INFO - mozversion platform_changeset: c55bcb7c777ea09431b4d16903ed079ae5632648 05:20:56 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:20:56 INFO - mozversion platform_version: 52.0a1 05:20:56 INFO - using testdate: 1474892456 05:20:56 INFO - actual date: 1474892456 05:20:56 INFO - starting webserver on 'localhost:37374' 05:20:56 INFO - SUITE-START | Running 2 tests 05:20:56 INFO - TEST-START | dromaeo_css 05:20:56 INFO - operating with platform_type : linux_ 05:20:56 INFO - Initialising browser for dromaeo_css test... 05:20:56 INFO - TEST-INFO | started process 25253 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptfCCnB/profile http://localhost:37374/getInfo.html) 05:21:01 INFO - PROCESS | 25253 | __metrics Screen width/height:1600/1200 05:21:01 INFO - PROCESS | 25253 | colorDepth:24 05:21:01 INFO - PROCESS | 25253 | Browser inner width/height: 1024/697 05:21:01 INFO - PROCESS | 25253 | __metrics 05:21:02 INFO - PROCESS | 25253 | 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" 05:21:02 INFO - PROCESS | 25253 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:21:02 INFO - PROCESS | 25253 | console.error: PushService: 05:21:02 INFO - PROCESS | 25253 | stateChangeProcessEnqueue: Error transitioning state 05:21:02 INFO - PROCESS | 25253 | UnknownError 05:21:03 INFO - TEST-INFO | 25253: exit 0 05:21:03 INFO - Browser initialized. 05:21:03 INFO - Running cycle 1/1 for dromaeo_css test... 05:21:03 INFO - TEST-INFO | started process 25338 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptfCCnB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:21:15 INFO - PROCESS | 25338 | RSS: Main: 175820800 05:21:15 INFO - PROCESS | 25338 | 05:22:07 INFO - PROCESS | 25338 | 1474892527467 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] 05:24:19 INFO - PROCESS | 25338 | Cycle 1(1): loaded http://localhost:37374/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37374/tests/dromaeo/cssquery-ext.html) 05:24:20 INFO - PROCESS | 25338 | RSS: Main: 304893952 05:24:20 INFO - PROCESS | 25338 | 05:27:23 INFO - PROCESS | 25338 | Cycle 1(1): loaded http://localhost:37374/tests/dromaeo/cssquery-ext.html (next: http://localhost:37374/tests/dromaeo/cssquery-jquery.html) 05:27:24 INFO - PROCESS | 25338 | RSS: Main: 276316160 05:27:24 INFO - PROCESS | 25338 | 05:30:26 INFO - PROCESS | 25338 | Cycle 1(1): loaded http://localhost:37374/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37374/tests/dromaeo/cssquery-mootools.html) 05:30:27 INFO - PROCESS | 25338 | RSS: Main: 219742208 05:30:27 INFO - PROCESS | 25338 | 05:33:29 INFO - PROCESS | 25338 | Cycle 1(1): loaded http://localhost:37374/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37374/tests/dromaeo/cssquery-prototype.html) 05:33:29 INFO - PROCESS | 25338 | RSS: Main: 220999680 05:33:29 INFO - PROCESS | 25338 | 05:36:33 INFO - PROCESS | 25338 | Cycle 1(1): loaded http://localhost:37374/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37374/tests/dromaeo/cssquery-yui.html) 05:36:33 INFO - PROCESS | 25338 | RSS: Main: 220545024 05:36:33 INFO - PROCESS | 25338 | 05:39:36 INFO - PROCESS | 25338 | Cycle 1(1): loaded http://localhost:37374/tests/dromaeo/cssquery-yui.html (next: http://localhost:37374/tests/dromaeo/cssquery-dojo.html) 05:39:36 INFO - PROCESS | 25338 | RSS: Main: 269307904 05:39:36 INFO - PROCESS | 25338 | 05:39:36 INFO - PROCESS | 25338 | __start_tp_report 05:39:36 INFO - PROCESS | 25338 | _x_x_mozilla_page_load 05:39:36 INFO - PROCESS | 25338 | _x_x_mozilla_page_load_details 05:39:36 INFO - PROCESS | 25338 | |i|pagename|runs| 05:39:36 INFO - PROCESS | 25338 | |0;dojo.html;2564.7178810330865;2592.4685439484906;2621.2005338371796;2623.75074367935;2635.789136869052;4486.663500237487;4544.681872268942;4633.9073218535605;4660.2776569631715;4677.929831052533;4591.88520286993;4649.6047835933905;4667.183242932481;4714.811407543702;4749.90500189996;4252.3621456781575;4288.63546598538;4322.13557288542;4342.283523218681;4359;4283.357496375537;4324;4345.826166953318;4353.216421044211;4392.165488557164;4324.481062272516;4330.112326972963;4366.803493842769;4370.956290437087;4372.759498227596;4178.227027999799;4192.035831758712;4207.43199668044;4238.894027649302;4262.190183865056;4219.324908014733;4222.683298752575;4250.872473825791;4326.0266440051055;4327.307630779061;4656.743879086649;4682.321063445781;4685.367475390813;4688.624910007191;4695.107929493385;4818.469968303484;4882;4959.876003099916;4975.154223781966;4975.601951843843;5051.419086805027;5071.391433028023;5076.771545280471;5082.695038297714;5126.71803050832;4723.433188017426;4733.171694953438;4734.366643507984;4736.265878788793;4750.382450281441;4940.036692844861;4987.650864439527;5054.54509094176;5175.120229560984;5255.737213139328;4875;4888;4907.9263811042865;4953.876153096201;4974.776135073858;4970.229614409773;4971.1549036663855;4979.3526841510375;4979.427365852901;5040.445550989388;4706;4751.738654374042;4928.531789479994;4935.3090567320605;4992.425871024806;4879.121758083508;4882.096812089704;4893.339399181136;4963.826266080742;4965.652404331734;4139.254934111888;4139.379093135994;4177.791110444466;4186.05813691923;4188.643965262987;3633.1280492681567;3657.835397407123;3666.4500324950936;3703.407454807218;3724.851005959731;4151.190517849051;4200.1179752252365;4225.239456897788;4305.6986010978935;4309.892252693708;4932.654714170046;4940.061388336205;4953.925691114636;4966.1061009018;5004.274380214849;4302.612764851178;4318.805653745589;4333.956660433355;4386.320120381346;4395.626371758436;4268.08236229206;4297.634701050383;4436.600705936481;4481.663875209372;4483.75339356332;4573.131105090022;4573.382593349856;4593.127305811885;4595.264757638762;4596.3105534170145;4905.092557876804;4912.066707325596;4915.680480768739;4921.803127874845;4922.606191504743;4623.791929363254;4654.604358629555;4660.044690838437;4661.627069834473;4680.765961701969;4871.610271178368;4875.585575226146;4920.434150072644;4924.9507504924495;4934.28452874324;4919.680220785637;4948.15881300187;4951.925721114114;4953.23224900141;5009.949900500948;4640.095181439722;4672.369230153886;4800.3759511263315;4807.134715751198;4867.756612169306;4786.138495070782;4810.302506136661;4815.975920120517;4823.986962737724;4889.535494128052;4756.738379389167;4760.285957106462;4779.06808172403;4784.832530861403;4829.589484893823;4705.270683044134;4751.40607424072;4866.197077482318;4877.6829506081995;4935.531124543163;4694.765261736968;4790.784414701417;4845.903081938412;4849.199882019428;4852.8544143675745 05:39:36 INFO - PROCESS | 25338 | |1;ext.html;568.5082403720781;575.5395683453239;580.6922331164483;581.7149596697617;588.9352171261163;28023.159305220826;39239.60760392395;40122.59877401225;40218.39672404916;43209.78395108028;40671.186576268454;41146.58853411465;41149;41230.17539649205;41246.58753412465;7620.809479763023;7762.573058481781;7767.883481747778;7768.495047821873;7775.533467991911;7274.854502909939;7428.517146385495;7437.776866694008;7592.620368981557;7622.199669034727;9841.360311579725;10129.088382045651;10131.088202061814;10388.53251603676;10466.790664186712;9955.352902061342;10031.799364012752;10032.147267482273;10037.447940363278;10042.046005629454;9822.01779822012;9880.061394167542;9895.554700038516;9896.90103098967;9903.702888913343;38062.809685951666;38257.617423825686;38306.80846595777;38428.80785596054;38429.23141537182;2919.4307110113537;3007.593974813394;3162.604674415698;3567.3757092508968;3634;27810.3047423814;28085.438291234266;28643;28694.713052869414;28837.134885953456;3330.5170750241323;3382.391169589473;3520.2959408118477;3521.9119522012156;3543.450765131409;245755;246446;247604;247859;249673.75163124249;32933;54180.72909635427;54495.72752136293;54503.45496545063;54661.45338546563;33659.32681346408;33774;33782.15544611404;33786;33827.66172338245;12574.874251257554;12638.2417054977;12745.49018039268;12789.744205116032;12790.936045319713;10328.638497652546;10396;10397.376157430579;10399;10404.427756473315;7250.456215783837;7465.589392583352;7511;7851.254130857559;7932.801679957932;3038.60498135241;3052.9542056869163;3099.5505651680833;3103.581016562735;3114.174743692923;844.3076677124699;859.2481578618708;913.6025828764509;930.916217540411;933.1974501928336;26336.473270534865;27629.171124866287;28117.57823632647;28127.156185314474;28153;940.3840484482674;948.6679662118204;954.179405711088;955.6894009446958;1033.679559336608;13767.38046787897;14795;14801.185934773475;15101.169435681142;15101.3204405802;358163;361198;361231;362246;362381;42431.575684242765;43452.3482147768;47563.28655070177;48620.756896215295;48852.511474885505;1149.9770004599861;1158.362900404791;1182.6097387861985;1185.2769810415812;1186.4720199511307;26885;27838.025669101484;28256.15231543057;28524.85737571299;29043.85478072596;41603;42139.7893010533;42146.7892660547;42194.156116878105;42197.789011055975;308838;309608;310474;310481;311040;24349.634755479037;24841;24861.751382485945;24869.751302486744;25032.123875664263;40932.38601421041;41034.58965410427;41108;41750;42215;35073;35264.82367588145;35660.28679426345;35670.28659426849;35739.82130089333;34756.30487390289;35282.647173527934;35348.82325588356;35446.645533545365;35452;34854;35056.47415288824;35092.12269693278;35392.29215415626;36008.4598731014;30054.24864378408;32260.677393225767;32301.838490808335;32662.673373266913;32880;24028.75971240265;24371.512569748862;24745;24837.379065523506;25178.62232066484 05:39:36 INFO - PROCESS | 25338 | |2;jquery.html;345.87029863801075;359.9766015209013;360.2578687902919;363.8890138507755;385.7280617164897;12478.81281780773;15647;15809.446669366589;16536.503904882844;17527.298908043664;14021.579352619412;14186.077904936172;16536;17123;17242.137893105326;4610.953890461086;5013.849584512462;5099.898002039957;5203.68777873327;5232.16285394337;4798.448178459469;5136.075506408845;5175.275461435402;5175.430702622709;5177.042247184264;4945.085159245533;5098.566621837148;5144.691318520882;5146.5625421839;5157.71632560209;5091.261767043777;5122.667026643257;5123.2315152727015;5129.17933130701;5130.23046543016;4465.062336909253;4476.597106260419;4594.035252596958;4594.977025114887;4602.769861506911;20123.496912577302;20504.794952050437;20548.58902821935;20681.896590517103;20820.687689684666;1805.341050516552;1876.5965317456812;2332.54515369503;2333.5099629077913;2343.8124950003958;13015.219086854724;13035.804462933063;13193.60419187426;13231.933840330737;13597.864021359857;1585.2470076713585;1591.2243974480748;1629.3889791328252;1634.3135882929198;1660.0537693514702;64026.35973640297;65492.67253663749;66651.66674166647;66749;67449.66275168642;9257.35198536096;9342.205912497378;9538;9566.499262923846;9798.902010979942;13303.667408314675;13316.933415333055;13319.667008324675;13332;13334.399952002183;6650.900236496456;6964.582125072512;7146.892231704094;7158.677859496335;7163.462740294499;6463.385978332051;6538.640374779433;6695.933040669628;6708.664566771642;6825.965870170618;5901.380355062743;6007.369226231182;6024.578279520391;6142.078688196806;6289.213848268966;1672.715638341485;1716.7596536484903;1743.1981288607128;1767.1870939367777;1767.7525146479504;684.3498676257575;881.4534988307163;898.2544488074882;902.2015516268019;902.4314681750456;16815.831841681673;16932.746008809878;17846.643067138844;17863.821361786475;18339.083045847656;869.6173683579204;879.1999280654574;920.4339331311195;921.1341339141186;941.5621735892843;9434.716958491255;10321.174306055498;10337.121344685786;10386.11718003978;10485.108765754996;364447;365652;365723;369687.15156424046;372947;77334.613326933;77939;77962.6101869487;78870.81693774599;80081.59959200167;907.8774365460711;927.9211267042242;929.2937367600672;933.5612262236738;933.9673111441067;15581.688366232838;15612.21938903073;15877;15944.282507287431;16108.27512761952;37596.2480750378;38397.23205535818;38624.613753863225;39326.60673393229;39773.40339894962;51822.222666659276;52080;52289.738551308525;53210.403687889426;55069.724651376484;6534.281229064894;7479.70081196746;7558.697652093854;7583.734569290048;7626.58053807046;9840.3603765755;10852.837207442053;12454.626361209179;12483.687907802014;12781.872181278068;10511.684649460529;10640.308379955279;10768.515416806105;10914.508847102059;11056.834147487632;4665.183592871302;7007.509474336747;9875.666784983936;10550.788984220426;10987.835182472429;10861.456927153453;10943.233973621771;10947.50736216888;11160.944195279297;11726.824097638371;7862.488938218998;7985;8051.677932882619;8086.959565202136;8258.132896046069;10393.42836143989;10550.947245263724;10804.729881753019;10856.620018299322;11207.383593902414 05:39:36 INFO - PROCESS | 25338 | |3;mootools.html;1367.2821768571496;1396.8114304568883;1456.7741999989998;1651.265186991789;1699.2183595546048;6765.763198288061;6975.093237879081;7110.964445177773;7614.352780013699;7651.693932242711;7194.6762395692185;7433.739819106332;7449.515781474201;7610.581418022007;7627.466077374586;2168.4145280774183;2199.14233448955;2204.261572373249;2206.5476577301615;2207.8012978831903;1861.8045105263955;1931.9613607727838;2089.947751306222;2106.9157233710635;2135.4874830040835;2093.633614117531;2136.8931553422344;2142.5607750411205;2151.376100930728;2158.0612433591436;2082.3856962196187;2091.4980404702915;2095.1095784291692;2097.2030628361126;2099.737532808399;2042.5710600773855;2050.9897450512653;2051.241040814893;2053.209514336976;2078.1064142418754;7641.656125474311;7646;7700.576468294297;7736.806579835493;7777.2222777722345;4490.10197960406;4627.768611569408;4629.8148074077;4633.513481084505;4640.559146881041;2767.1006922750184;2891.2482754483776;2930.780191485626;2943.3966036962584;2961.718636729507;885.9202671759508;909.6179604566098;929.0430856218106;931.6180366049887;938.5401153434836;10128.240381971382;10133.341332813343;10172.643957461527;10204.285700001003;10239.9488002561;3746.9812650937115;3988.980055099706;4109.712320137622;4216.451861258017;4228.1966426378885;8760.123987601317;8769.123087691307;8788;8810.86783698245;8832.64669413229;4651.906961860812;4663.556962088596;4665.813367465264;4681.274402467623;4692.366530518337;4125.834966601303;4207.873763787091;4220.219259436953;4222.366645003274;4230.767307798039;3569.411047177187;3662.6703596676425;3688.7642639715996;3690.5755838078426;3691.3724666806706;1035.0736091198335;1072.1904961753826;1131.4455916600807;1165.5745652836822;1233.5559198688466;796.016919104905;804.4368941740688;805.3677862877613;811.7686459359054;819.4304958054095;4950.232713929347;4966.801327946841;5120.052790233819;5131.56381707559;5204.583633309327;798.7044793426469;818.2104269380077;824.2581676491205;844.3287586368851;860.7030574451804;3164.620245570546;3260.136063943057;3296.208909861616;3319.7842140260805;3378.662133786651;8935.731928042169;9361.719148425558;9363.344565880323;9375.249980001583;9385.859212111824;9306.813863722824;9356.298277629205;9360.485173315534;9404.482753448627;9418.95290523543;6941.68762405693;6950.652467376611;6965.616891071039;7011.509194356346;7031.332023457763;4913.213885778258;4971.105201063843;4981.37732783402;5081.568066714222;5177.171652535576;8298.668053277801;8645.4812711235;8653.134686531297;8663.95668021656;8695.52174630376;8387.580620969049;8578.142185781371;8656.740297791077;8838.292936565187;8923.286137109146;6349.587276826992;6604.240512341143;6631.535792494479;6644.700988455627;6666.200055993312;7410.925890741024;7418.814529636802;7426.4058875288765;7438.293362130589;7503.962480187783;6311.90532142009;6365.745370185141;6486.772962946275;6514.315996820265;6811.046453496416;6418.967905160444;6567.704453299518;6569.211694596679;6572.7042283098335;6678.065070889982;5626.2685850839125;5699.458551437607;5709.885802284014;5710.428957104423;5711.029125048669;4501.864944051684;4506.324051392317;4584.106099310602;4602.171609110393;4620.815167393266;4431;4490.438695163105;4586.334981427741;4591.357209990537;4736.242201247784 05:39:36 INFO - PROCESS | 25338 | |4;prototype.html;282.8656388215599;284.0640090900483;288.84258079346756;292.61521099753827;298.72964966705126;4851.830185943489;4862.805487780493;4889.926651100236;4905.950940490594;4935.851924442272;4767.451743049551;4843.152448321547;4856.223004319309;4858.368412106422;4869.464358920524;3584.928301433963;3701.1672373715833;3717.312297225022;3725.4225595032676;3735.383661695817;3598.3882739934143;3716.702663786904;3729.4965179700666;3754.136548593825;3771.981140094296;3723.236736469017;3726.2920045191327;3727.683146932514;3757.5115235019407;3764;3576.159602493412;3735.73987737419;3746.19456816783;3749.531308586427;3752.8123593820337;3269.8065206199803;3272.8363581820813;3286.76992610515;3292.654271301503;3343.8160901150427;4652.651051171142;4686.2267725825195;4703.576678098988;4705.458872229703;4746.644001699852;4113.6297733203855;4224.112936283384;4237.470316210442;4261.659067274611;4309.267424537836;4944.802207911679;4948.7278199699;4973.5772459341;4981.1532039553;4982.900341993176;3564.6613571710645;3569.464580312948;3578.284343131384;3585.713142948584;3596.4425514045365;5159.69041857486;5234.345706786689;5242.816501422432;5319.414864364917;5342.16865061518;3655.5613326401003;3666.4683620874825;3674.118211629243;3683.889483315505;3684.9078773030888;3753.737238393286;3756.7933763642714;3756.8121593920196;3761.5298087739034;3764.3412402829395;4234.767087810138;4264.530901600821;4277.401163837066;4291.3777502262;4294.720843145185;4865.781039853215;5010;5011.724355160502;5016.498350164954;5057.216131499624;1266.208619612742;1291.4834066373337;1296.4749276543016;1297.7274772297735;1302.3293004102895;778.1518145221736;792.2157064506098;822.4243029879109;836.3142223376894;840.7940054686519;4244;4272.739541835166;4377.387165796791;4458.398116254264;4465.821367145343;5155.149400348975;5165.044466773659;5183.766730497136;5185.714785686748;5194.740262986911;4441.933370999438;4446.644268458515;4449.221386257392;4461.464624245046;4469.821207151743;2627.5927231279184;2702.7837772978114;2732.344237383014;2741.2050505353623;2742.657167854018;4868.342773725572;4872.975635121802;4875.7074575524875;4876.756162191876;4880.707157570557;5055.772490237948;5199.636025478256;5266.21006848968;5292.311999440049;5300.549453296436;4848.684835485682;4865.732384718804;4883.780229889735;4886.3403440535785;4887.706737595756;5112.923306150485;5142.97428512855;5163.148080566664;5167.58659307247;5200.6879587224885;4837.540433658797;5060.595152387874;5068.594512438923;5098.184290513648;5100.591952643706;4887.60899128076;4912.8771780705765;4923.704577725348;4926.187179115406;4927.852164435073;3669.798161101058;3687.741858070017;3694.131879008377;3717.7769333840056;3721.1255354991013;5070.188769796815;5270.73646317675;5281.287026251407;5288.788448462018;5293.708846013506;5007.39911210657;5053.36832895888;5062.265971434195;5062.936783275553;5066;5033.0688822567945;5047.394312682355;5069.3156423883775;5071.13790655582;5072.619553533574;4711.78796954131;5009.273655320031;5015.874603134951;5032.194848824171;5046.571041461517;4843.491433399583;4961.454240033666;5034.496550344937;5073.619478539051;5104.69371837691;4863.708177509361;4867.172580661367;4870.610351171968;4875.366202393666;4945.689392311112 05:39:36 INFO - PROCESS | 25338 | |5;yui.html;624.144921457603;648.9967550162252;656.4125108028314;663.9601623902569;675.7499725101713;12972;13852.307384630752;13875.306234688276;14003.439862405505;14020.018598698096;13107.54123605674;13233.404496797642;13277.867221327784;13285.667858303546;13311.201327920307;639.2584601861842;753.8718417868962;778.3850757901251;781.4764108047593;782.3936449251819;648.3646026893647;761.2387612387612;772.9381649468057;779.4504874063772;784.705735349244;820.5979070255562;823.6705317872869;825.2284114353099;826.7767702720262;827.4662842466605;660.3198705333514;681.1043477826643;818.55388813097;818.7298191596759;818.7502811642447;504.9747512624354;505.1110046318469;578.8408187748361;593.8188852400016;595.6128516464289;12953.28756918369;13005.609831705064;13011.21932684042;13020.674483137997;13022.348882555834;12668.80996785049;13094.345282735825;13223.933880330536;13320.400581973834;13689.247091409969;11775.528978840835;11902.940485297604;11915.582954596548;12156.419665443436;12272.140950133495;3888.572257051722;3979.5622481527007;4014.498187726534;4138.606832350922;4145.97927010363;60970.0854487183;61067.69466152685;61165.38834611686;61773;61899.69050154721;10279.383237005804;10511.316764410289;10555.947220264003;10588.788224235472;10620.362778233331;19098.331558395388;19172.13725382361;19181.136848841834;19281.903590481958;19342.903285483484;6610.96694516534;6641.269460359356;6683.064370988066;6872.553284036521;6917.169939607279;3420.401429749834;3456.4296891013205;3480.8781692640637;3536.7701099428455;3609.151849315409;2723.482538317713;2828.886844526196;2837.4750671125494;2842.0479139488502;2845.743883050494;493.29705170132416;501.45592032644987;508.51182864450544;512.9281900533928;513.8792383789806;402.3843519415299;450.5404487422876;456.678041980403;463.6638437133119;493.5163539731012;6654.534182607171;6706.664666766642;6749.460043196533;7113.359797618239;7117.3238542338395;392.5132835284227;428.39168380898576;458.59185325060724;463.57814388905933;470.4284294582099;3236.1100697307957;3258.1528802511516;3319.6348401675796;3344.7324214062814;3460.3598334308235;55224;65503.67248163729;99661;103083;103264;86111.96845846738;88535.55732221427;89740;89924.550377249;90720.5463972676;45544.54455455403;71616.92574611385;75412.62293688496;76011.61994189993;76611.61694191716;6173.753049878134;6180.536459765625;6290.559660823881;6484.935150648433;6522.15212022434;43870;44169.33745993749;45545.089098218516;45669.77165114286;46934.765326173154;59700.40299596948;63075.6846215766;63386;65075.67462162659;65899;8437.367197460339;8491.787705307417;8555.230029297392;8666.913330866611;8805;9473.194778443909;9542.713718588453;9597.520123993912;9707.077827606367;10036.498175091363;8257.793555160928;8345.374096942633;8489.151084891462;8696.78258043554;8774;9050.773730656787;9119.863202051842;9366.391184572982;9709.126178643955;9990.350627209207;8177.427580069338;8193.50838949641;8308.252257296872;8440.788980275542;8598.871016934625;7386.741464048732;7451.3666338361845;7470.178280389044;7575.659095340833;7691.923080769121;6932.341427564374;7168.354848063699;7178.676959536729;7336.497626779915;7471.663775130023 05:39:36 INFO - PROCESS | 25338 | __end_tp_report 05:39:36 INFO - PROCESS | 25338 | __start_cc_report 05:39:36 INFO - PROCESS | 25338 | _x_x_mozilla_cycle_collect,1088 05:39:36 INFO - PROCESS | 25338 | __end_cc_report 05:39:36 INFO - PROCESS | 25338 | __startTimestamp1474893576908__endTimestamp 05:39:36 INFO - PROCESS | 25338 | 05:39:36 INFO - PROCESS | 25338 | ------- Summary: start ------- 05:39:36 INFO - PROCESS | 25338 | Number of tests: 6 05:39:36 INFO - PROCESS | 25338 | 05:39:36 INFO - PROCESS | 25338 | [#0] dojo.html Cycles:165 Average:4586.84 Median:4706.00 stddev:477.39 (10.1%) stddev-sans-first:451.73 05:39:36 INFO - PROCESS | 25338 | Values: 2564.7 2592.5 2621.2 2623.8 2635.8 4486.7 4544.7 4633.9 4660.3 4677.9 4591.9 4649.6 4667.2 4714.8 4749.9 4252.4 4288.6 4322.1 4342.3 4359.0 4283.4 4324.0 4345.8 4353.2 4392.2 4324.5 4330.1 4366.8 4371.0 4372.8 4178.2 4192.0 4207.4 4238.9 4262.2 4219.3 4222.7 4250.9 4326.0 4327.3 4656.7 4682.3 4685.4 4688.6 4695.1 4818.5 4882.0 4959.9 4975.2 4975.6 5051.4 5071.4 5076.8 5082.7 5126.7 4723.4 4733.2 4734.4 4736.3 4750.4 4940.0 4987.7 5054.5 5175.1 5255.7 4875.0 4888.0 4907.9 4953.9 4974.8 4970.2 4971.2 4979.4 4979.4 5040.4 4706.0 4751.7 4928.5 4935.3 4992.4 4879.1 4882.1 4893.3 4963.8 4965.7 4139.3 4139.4 4177.8 4186.1 4188.6 3633.1 3657.8 3666.5 3703.4 3724.9 4151.2 4200.1 4225.2 4305.7 4309.9 4932.7 4940.1 4953.9 4966.1 5004.3 4302.6 4318.8 4334.0 4386.3 4395.6 4268.1 4297.6 4436.6 4481.7 4483.8 4573.1 4573.4 4593.1 4595.3 4596.3 4905.1 4912.1 4915.7 4921.8 4922.6 4623.8 4654.6 4660.0 4661.6 4680.8 4871.6 4875.6 4920.4 4925.0 4934.3 4919.7 4948.2 4951.9 4953.2 5009.9 4640.1 4672.4 4800.4 4807.1 4867.8 4786.1 4810.3 4816.0 4824.0 4889.5 4756.7 4760.3 4779.1 4784.8 4829.6 4705.3 4751.4 4866.2 4877.7 4935.5 4694.8 4790.8 4845.9 4849.2 4852.9 05:39:36 INFO - PROCESS | 25338 | 05:39:36 INFO - PROCESS | 25338 | [#1] ext.html Cycles:180 Average:45153.10 Median:19306.21 stddev:81485.05 (422.1%) stddev-sans-first:81644.88 05:39:36 INFO - PROCESS | 25338 | Values: 568.5 575.5 580.7 581.7 588.9 28023.2 39239.6 40122.6 40218.4 43209.8 40671.2 41146.6 41149.0 41230.2 41246.6 7620.8 7762.6 7767.9 7768.5 7775.5 7274.9 7428.5 7437.8 7592.6 7622.2 9841.4 10129.1 10131.1 10388.5 10466.8 9955.4 10031.8 10032.1 10037.4 10042.0 9822.0 9880.1 9895.6 9896.9 9903.7 38062.8 38257.6 38306.8 38428.8 38429.2 2919.4 3007.6 3162.6 3567.4 3634.0 27810.3 28085.4 28643.0 28694.7 28837.1 3330.5 3382.4 3520.3 3521.9 3543.5 245755.0 246446.0 247604.0 247859.0 249673.8 32933.0 54180.7 54495.7 54503.5 54661.5 33659.3 33774.0 33782.2 33786.0 33827.7 12574.9 12638.2 12745.5 12789.7 12790.9 10328.6 10396.0 10397.4 10399.0 10404.4 7250.5 7465.6 7511.0 7851.3 7932.8 3038.6 3053.0 3099.6 3103.6 3114.2 844.3 859.2 913.6 930.9 933.2 26336.5 27629.2 28117.6 28127.2 28153.0 940.4 948.7 954.2 955.7 1033.7 13767.4 14795.0 14801.2 15101.2 15101.3 358163.0 361198.0 361231.0 362246.0 362381.0 42431.6 43452.3 47563.3 48620.8 48852.5 1150.0 1158.4 1182.6 1185.3 1186.5 26885.0 27838.0 28256.2 28524.9 29043.9 41603.0 42139.8 42146.8 42194.2 42197.8 308838.0 309608.0 310474.0 310481.0 311040.0 24349.6 24841.0 24861.8 24869.8 25032.1 40932.4 41034.6 41108.0 41750.0 42215.0 35073.0 35264.8 35660.3 35670.3 35739.8 34756.3 35282.6 35348.8 35446.6 35452.0 34854.0 35056.5 35092.1 35392.3 36008.5 30054.2 32260.7 32301.8 32662.7 32880.0 24028.8 24371.5 24745.0 24837.4 25178.6 05:39:36 INFO - PROCESS | 25338 | 05:39:36 INFO - PROCESS | 25338 | [#2] jquery.html Cycles:180 Average:23804.28 Median:4470.83 stddev:60863.33 (1361.3%) stddev-sans-first:61008.58 05:39:36 INFO - PROCESS | 25338 | Values: 345.9 360.0 360.3 363.9 385.7 12478.8 15647.0 15809.4 16536.5 17527.3 14021.6 14186.1 16536.0 17123.0 17242.1 4611.0 5013.8 5099.9 5203.7 5232.2 4798.4 5136.1 5175.3 5175.4 5177.0 4945.1 5098.6 5144.7 5146.6 5157.7 5091.3 5122.7 5123.2 5129.2 5130.2 4465.1 4476.6 4594.0 4595.0 4602.8 20123.5 20504.8 20548.6 20681.9 20820.7 1805.3 1876.6 2332.5 2333.5 2343.8 13015.2 13035.8 13193.6 13231.9 13597.9 1585.2 1591.2 1629.4 1634.3 1660.1 64026.4 65492.7 66651.7 66749.0 67449.7 9257.4 9342.2 9538.0 9566.5 9798.9 13303.7 13316.9 13319.7 13332.0 13334.4 6650.9 6964.6 7146.9 7158.7 7163.5 6463.4 6538.6 6695.9 6708.7 6826.0 5901.4 6007.4 6024.6 6142.1 6289.2 1672.7 1716.8 1743.2 1767.2 1767.8 684.3 881.5 898.3 902.2 902.4 16815.8 16932.7 17846.6 17863.8 18339.1 869.6 879.2 920.4 921.1 941.6 9434.7 10321.2 10337.1 10386.1 10485.1 364447.0 365652.0 365723.0 369687.2 372947.0 77334.6 77939.0 77962.6 78870.8 80081.6 907.9 927.9 929.3 933.6 934.0 15581.7 15612.2 15877.0 15944.3 16108.3 37596.2 38397.2 38624.6 39326.6 39773.4 51822.2 52080.0 52289.7 53210.4 55069.7 6534.3 7479.7 7558.7 7583.7 7626.6 9840.4 10852.8 12454.6 12483.7 12781.9 10511.7 10640.3 10768.5 10914.5 11056.8 4665.2 7007.5 9875.7 10550.8 10987.8 10861.5 10943.2 10947.5 11160.9 11726.8 7862.5 7985.0 8051.7 8087.0 8258.1 10393.4 10550.9 10804.7 10856.6 11207.4 05:39:36 INFO - PROCESS | 25338 | 05:39:36 INFO - PROCESS | 25338 | [#3] mootools.html Cycles:180 Average:4981.65 Median:5100.81 stddev:2763.46 (54.2%) stddev-sans-first:2757.86 05:39:36 INFO - PROCESS | 25338 | Values: 1367.3 1396.8 1456.8 1651.3 1699.2 6765.8 6975.1 7111.0 7614.4 7651.7 7194.7 7433.7 7449.5 7610.6 7627.5 2168.4 2199.1 2204.3 2206.5 2207.8 1861.8 1932.0 2089.9 2106.9 2135.5 2093.6 2136.9 2142.6 2151.4 2158.1 2082.4 2091.5 2095.1 2097.2 2099.7 2042.6 2051.0 2051.2 2053.2 2078.1 7641.7 7646.0 7700.6 7736.8 7777.2 4490.1 4627.8 4629.8 4633.5 4640.6 2767.1 2891.2 2930.8 2943.4 2961.7 885.9 909.6 929.0 931.6 938.5 10128.2 10133.3 10172.6 10204.3 10239.9 3747.0 3989.0 4109.7 4216.5 4228.2 8760.1 8769.1 8788.0 8810.9 8832.6 4651.9 4663.6 4665.8 4681.3 4692.4 4125.8 4207.9 4220.2 4222.4 4230.8 3569.4 3662.7 3688.8 3690.6 3691.4 1035.1 1072.2 1131.4 1165.6 1233.6 796.0 804.4 805.4 811.8 819.4 4950.2 4966.8 5120.1 5131.6 5204.6 798.7 818.2 824.3 844.3 860.7 3164.6 3260.1 3296.2 3319.8 3378.7 8935.7 9361.7 9363.3 9375.2 9385.9 9306.8 9356.3 9360.5 9404.5 9419.0 6941.7 6950.7 6965.6 7011.5 7031.3 4913.2 4971.1 4981.4 5081.6 5177.2 8298.7 8645.5 8653.1 8664.0 8695.5 8387.6 8578.1 8656.7 8838.3 8923.3 6349.6 6604.2 6631.5 6644.7 6666.2 7410.9 7418.8 7426.4 7438.3 7504.0 6311.9 6365.7 6486.8 6514.3 6811.0 6419.0 6567.7 6569.2 6572.7 6678.1 5626.3 5699.5 5709.9 5710.4 5711.0 4501.9 4506.3 4584.1 4602.2 4620.8 4431.0 4490.4 4586.3 4591.4 4736.2 05:39:36 INFO - PROCESS | 25338 | 05:39:36 INFO - PROCESS | 25338 | [#4] prototype.html Cycles:180 Average:4177.37 Median:4850.26 stddev:1219.45 (25.1%) stddev-sans-first:1187.32 05:39:36 INFO - PROCESS | 25338 | Values: 282.9 284.1 288.8 292.6 298.7 4851.8 4862.8 4889.9 4906.0 4935.9 4767.5 4843.2 4856.2 4858.4 4869.5 3584.9 3701.2 3717.3 3725.4 3735.4 3598.4 3716.7 3729.5 3754.1 3772.0 3723.2 3726.3 3727.7 3757.5 3764.0 3576.2 3735.7 3746.2 3749.5 3752.8 3269.8 3272.8 3286.8 3292.7 3343.8 4652.7 4686.2 4703.6 4705.5 4746.6 4113.6 4224.1 4237.5 4261.7 4309.3 4944.8 4948.7 4973.6 4981.2 4982.9 3564.7 3569.5 3578.3 3585.7 3596.4 5159.7 5234.3 5242.8 5319.4 5342.2 3655.6 3666.5 3674.1 3683.9 3684.9 3753.7 3756.8 3756.8 3761.5 3764.3 4234.8 4264.5 4277.4 4291.4 4294.7 4865.8 5010.0 5011.7 5016.5 5057.2 1266.2 1291.5 1296.5 1297.7 1302.3 778.2 792.2 822.4 836.3 840.8 4244.0 4272.7 4377.4 4458.4 4465.8 5155.1 5165.0 5183.8 5185.7 5194.7 4441.9 4446.6 4449.2 4461.5 4469.8 2627.6 2702.8 2732.3 2741.2 2742.7 4868.3 4873.0 4875.7 4876.8 4880.7 5055.8 5199.6 5266.2 5292.3 5300.5 4848.7 4865.7 4883.8 4886.3 4887.7 5112.9 5143.0 5163.1 5167.6 5200.7 4837.5 5060.6 5068.6 5098.2 5100.6 4887.6 4912.9 4923.7 4926.2 4927.9 3669.8 3687.7 3694.1 3717.8 3721.1 5070.2 5270.7 5281.3 5288.8 5293.7 5007.4 5053.4 5062.3 5062.9 5066.0 5033.1 5047.4 5069.3 5071.1 5072.6 4711.8 5009.3 5015.9 5032.2 5046.6 4843.5 4961.5 5034.5 5073.6 5104.7 4863.7 4867.2 4870.6 4875.4 4945.7 05:39:36 INFO - PROCESS | 25338 | 05:39:36 INFO - PROCESS | 25338 | [#5] yui.html Cycles:180 Average:16860.07 Median:33976.77 stddev:24889.15 (73.3%) stddev-sans-first:24929.11 05:39:36 INFO - PROCESS | 25338 | Values: 624.1 649.0 656.4 664.0 675.7 12972.0 13852.3 13875.3 14003.4 14020.0 13107.5 13233.4 13277.9 13285.7 13311.2 639.3 753.9 778.4 781.5 782.4 648.4 761.2 772.9 779.5 784.7 820.6 823.7 825.2 826.8 827.5 660.3 681.1 818.6 818.7 818.8 505.0 505.1 578.8 593.8 595.6 12953.3 13005.6 13011.2 13020.7 13022.3 12668.8 13094.3 13223.9 13320.4 13689.2 11775.5 11902.9 11915.6 12156.4 12272.1 3888.6 3979.6 4014.5 4138.6 4146.0 60970.1 61067.7 61165.4 61773.0 61899.7 10279.4 10511.3 10555.9 10588.8 10620.4 19098.3 19172.1 19181.1 19281.9 19342.9 6611.0 6641.3 6683.1 6872.6 6917.2 3420.4 3456.4 3480.9 3536.8 3609.2 2723.5 2828.9 2837.5 2842.0 2845.7 493.3 501.5 508.5 512.9 513.9 402.4 450.5 456.7 463.7 493.5 6654.5 6706.7 6749.5 7113.4 7117.3 392.5 428.4 458.6 463.6 470.4 3236.1 3258.2 3319.6 3344.7 3460.4 55224.0 65503.7 99661.0 103083.0 103264.0 86112.0 88535.6 89740.0 89924.6 90720.5 45544.5 71616.9 75412.6 76011.6 76611.6 6173.8 6180.5 6290.6 6484.9 6522.2 43870.0 44169.3 45545.1 45669.8 46934.8 59700.4 63075.7 63386.0 65075.7 65899.0 8437.4 8491.8 8555.2 8666.9 8805.0 9473.2 9542.7 9597.5 9707.1 10036.5 8257.8 8345.4 8489.2 8696.8 8774.0 9050.8 9119.9 9366.4 9709.1 9990.4 8177.4 8193.5 8308.3 8440.8 8598.9 7386.7 7451.4 7470.2 7575.7 7691.9 6932.3 7168.4 7178.7 7336.5 7471.7 05:39:36 INFO - PROCESS | 25338 | -------- Summary: end -------- 05:39:36 INFO - PROCESS | 25338 | 05:39:37 INFO - TEST-INFO | 25338: exit 0 05:39:37 INFO - TEST-OK | dromaeo_css | took 1121014ms 05:39:37 INFO - TEST-START | kraken 05:39:37 INFO - operating with platform_type : linux_ 05:39:37 INFO - Initialising browser for kraken test... 05:39:37 INFO - TEST-INFO | started process 25641 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTUnglV/profile http://localhost:37374/getInfo.html) 05:39:42 INFO - PROCESS | 25641 | __metrics Screen width/height:1600/1200 05:39:42 INFO - PROCESS | 25641 | colorDepth:24 05:39:42 INFO - PROCESS | 25641 | Browser inner width/height: 1024/697 05:39:42 INFO - PROCESS | 25641 | __metrics 05:39:42 INFO - PROCESS | 25641 | 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" 05:39:42 INFO - PROCESS | 25641 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:39:43 INFO - PROCESS | 25641 | console.error: PushService: 05:39:43 INFO - PROCESS | 25641 | stateChangeProcessEnqueue: Error transitioning state 05:39:43 INFO - PROCESS | 25641 | UnknownError 05:39:44 INFO - TEST-INFO | 25641: exit 0 05:39:44 INFO - Browser initialized. 05:39:44 INFO - Running cycle 1/1 for kraken test... 05:39:44 INFO - TEST-INFO | started process 25725 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTUnglV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:39:56 INFO - PROCESS | 25725 | RSS: Main: 175173632 05:39:56 INFO - PROCESS | 25725 | 05:39:59 INFO - PROCESS | 25725 | Cycle 1(1): loaded http://localhost:37374/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37374/tests/kraken/driver.html?testName=audio-beat-detection) 05:40:00 INFO - PROCESS | 25725 | RSS: Main: 233803776 05:40:00 INFO - PROCESS | 25725 | 05:40:03 INFO - PROCESS | 25725 | Cycle 1(1): loaded http://localhost:37374/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37374/tests/kraken/driver.html?testName=audio-dft) 05:40:03 INFO - PROCESS | 25725 | RSS: Main: 218574848 05:40:03 INFO - PROCESS | 25725 | 05:40:06 INFO - PROCESS | 25725 | Cycle 1(1): loaded http://localhost:37374/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37374/tests/kraken/driver.html?testName=audio-fft) 05:40:07 INFO - PROCESS | 25725 | RSS: Main: 300490752 05:40:07 INFO - PROCESS | 25725 | 05:40:09 INFO - PROCESS | 25725 | Cycle 1(1): loaded http://localhost:37374/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37374/tests/kraken/driver.html?testName=audio-oscillator) 05:40:10 INFO - PROCESS | 25725 | RSS: Main: 210370560 05:40:10 INFO - PROCESS | 25725 | 05:40:12 INFO - PROCESS | 25725 | Cycle 1(1): loaded http://localhost:37374/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37374/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:40:13 INFO - PROCESS | 25725 | RSS: Main: 213782528 05:40:13 INFO - PROCESS | 25725 | 05:40:16 INFO - PROCESS | 25725 | Cycle 1(1): loaded http://localhost:37374/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37374/tests/kraken/driver.html?testName=imaging-darkroom) 05:40:17 INFO - PROCESS | 25725 | RSS: Main: 251228160 05:40:17 INFO - PROCESS | 25725 | 05:40:20 INFO - PROCESS | 25725 | Cycle 1(1): loaded http://localhost:37374/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37374/tests/kraken/driver.html?testName=imaging-desaturate) 05:40:21 INFO - PROCESS | 25725 | RSS: Main: 244850688 05:40:21 INFO - PROCESS | 25725 | 05:40:24 INFO - PROCESS | 25725 | Cycle 1(1): loaded http://localhost:37374/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37374/tests/kraken/driver.html?testName=json-parse-financial) 05:40:24 INFO - PROCESS | 25725 | RSS: Main: 247500800 05:40:24 INFO - PROCESS | 25725 | 05:40:26 INFO - PROCESS | 25725 | Cycle 1(1): loaded http://localhost:37374/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37374/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:40:27 INFO - PROCESS | 25725 | RSS: Main: 211263488 05:40:27 INFO - PROCESS | 25725 | 05:40:28 INFO - PROCESS | 25725 | Cycle 1(1): loaded http://localhost:37374/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37374/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:40:29 INFO - PROCESS | 25725 | RSS: Main: 218058752 05:40:29 INFO - PROCESS | 25725 | 05:40:31 INFO - PROCESS | 25725 | Cycle 1(1): loaded http://localhost:37374/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37374/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:40:32 INFO - PROCESS | 25725 | RSS: Main: 223399936 05:40:32 INFO - PROCESS | 25725 | 05:40:35 INFO - PROCESS | 25725 | Cycle 1(1): loaded http://localhost:37374/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37374/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:40:35 INFO - PROCESS | 25725 | RSS: Main: 224264192 05:40:35 INFO - PROCESS | 25725 | 05:40:38 INFO - PROCESS | 25725 | Cycle 1(1): loaded http://localhost:37374/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37374/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:40:39 INFO - PROCESS | 25725 | RSS: Main: 222134272 05:40:39 INFO - PROCESS | 25725 | 05:40:41 INFO - PROCESS | 25725 | Cycle 1(1): loaded http://localhost:37374/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37374/tests/kraken/driver.html?testName=ai-astar) 05:40:41 INFO - PROCESS | 25725 | RSS: Main: 273121280 05:40:41 INFO - PROCESS | 25725 | 05:40:41 INFO - PROCESS | 25725 | __start_tp_report 05:40:41 INFO - PROCESS | 25725 | _x_x_mozilla_page_load 05:40:41 INFO - PROCESS | 25725 | _x_x_mozilla_page_load_details 05:40:41 INFO - PROCESS | 25725 | |i|pagename|runs| 05:40:41 INFO - PROCESS | 25725 | |0;ai-astar;110;116;115;115;116;116;116;114;115;118 05:40:41 INFO - PROCESS | 25725 | |1;audio-beat-detection;156;130;125;163;133;131;133;127;161;126 05:40:41 INFO - PROCESS | 25725 | |2;audio-dft;161;166;161;165;163;162;165;162;161;161 05:40:41 INFO - PROCESS | 25725 | |3;audio-fft;78;77;76;119;76;75;77;76;106;76 05:40:41 INFO - PROCESS | 25725 | |4;audio-oscillator;86;85;125;85;84;84;118;83;84;120 05:40:41 INFO - PROCESS | 25725 | |5;imaging-gaussian-blur;118;117;119;118;117;117;117;116;119;120 05:40:41 INFO - PROCESS | 25725 | |6;imaging-darkroom;147;147;147;146;146;147;148;153;146;148 05:40:41 INFO - PROCESS | 25725 | |7;imaging-desaturate;96;96;95;95;96;95;96;96;95;96 05:40:41 INFO - PROCESS | 25725 | |8;json-parse-financial;64;63;63;63;69;63;64;64;63;64 05:40:41 INFO - PROCESS | 25725 | |9;json-stringify-tinderbox;67;67;67;66;67;67;67;67;67;66 05:40:41 INFO - PROCESS | 25725 | |10;stanford-crypto-aes;83;82;91;82;82;89;82;91;81;83 05:40:41 INFO - PROCESS | 25725 | |11;stanford-crypto-ccm;137;143;131;141;134;133;133;132;177;132 05:40:41 INFO - PROCESS | 25725 | |12;stanford-crypto-pbkdf2;175;173;175;176;175;176;173;172;172;171 05:40:41 INFO - PROCESS | 25725 | |13;stanford-crypto-sha256-iterative;69;72;69;69;69;70;68;68;70;67 05:40:41 INFO - PROCESS | 25725 | __end_tp_report 05:40:41 INFO - PROCESS | 25725 | __start_cc_report 05:40:41 INFO - PROCESS | 25725 | _x_x_mozilla_cycle_collect,1915 05:40:41 INFO - PROCESS | 25725 | __end_cc_report 05:40:41 INFO - PROCESS | 25725 | __startTimestamp1474893641496__endTimestamp 05:40:41 INFO - PROCESS | 25725 | 05:40:41 INFO - PROCESS | 25725 | ------- Summary: start ------- 05:40:41 INFO - PROCESS | 25725 | Number of tests: 14 05:40:41 INFO - PROCESS | 25725 | 05:40:41 INFO - PROCESS | 25725 | [#0] ai-astar Cycles:10 Average:115.10 Median:116.00 stddev:2.08 (1.8%) stddev-sans-first:1.12 05:40:41 INFO - PROCESS | 25725 | Values: 110.0 116.0 115.0 115.0 116.0 116.0 116.0 114.0 115.0 118.0 05:40:41 INFO - PROCESS | 25725 | 05:40:41 INFO - PROCESS | 25725 | [#1] audio-beat-detection Cycles:10 Average:138.50 Median:133.00 stddev:15.17 (11.4%) stddev-sans-first:14.71 05:40:41 INFO - PROCESS | 25725 | Values: 156.0 130.0 125.0 163.0 133.0 131.0 133.0 127.0 161.0 126.0 05:40:41 INFO - PROCESS | 25725 | 05:40:41 INFO - PROCESS | 25725 | [#2] audio-dft Cycles:10 Average:162.70 Median:162.50 stddev:1.95 (1.2%) stddev-sans-first:1.96 05:40:41 INFO - PROCESS | 25725 | Values: 161.0 166.0 161.0 165.0 163.0 162.0 165.0 162.0 161.0 161.0 05:40:41 INFO - PROCESS | 25725 | 05:40:41 INFO - PROCESS | 25725 | [#3] audio-fft Cycles:10 Average:83.60 Median:76.00 stddev:15.56 (20.5%) stddev-sans-first:16.37 05:40:41 INFO - PROCESS | 25725 | Values: 78.0 77.0 76.0 119.0 76.0 75.0 77.0 76.0 106.0 76.0 05:40:41 INFO - PROCESS | 25725 | 05:40:41 INFO - PROCESS | 25725 | [#4] audio-oscillator Cycles:10 Average:95.40 Median:84.00 stddev:17.77 (21.1%) stddev-sans-first:18.51 05:40:41 INFO - PROCESS | 25725 | Values: 86.0 85.0 125.0 85.0 84.0 84.0 118.0 83.0 84.0 120.0 05:40:41 INFO - PROCESS | 25725 | 05:40:41 INFO - PROCESS | 25725 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:1.23 (1.0%) stddev-sans-first:1.30 05:40:41 INFO - PROCESS | 25725 | Values: 118.0 117.0 119.0 118.0 117.0 117.0 117.0 116.0 119.0 120.0 05:40:41 INFO - PROCESS | 25725 | 05:40:41 INFO - PROCESS | 25725 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:147.00 stddev:2.07 (1.4%) stddev-sans-first:2.19 05:40:41 INFO - PROCESS | 25725 | Values: 147.0 147.0 147.0 146.0 146.0 147.0 148.0 153.0 146.0 148.0 05:40:41 INFO - PROCESS | 25725 | 05:40:41 INFO - PROCESS | 25725 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 05:40:41 INFO - PROCESS | 25725 | Values: 96.0 96.0 95.0 95.0 96.0 95.0 96.0 96.0 95.0 96.0 05:40:41 INFO - PROCESS | 25725 | 05:40:41 INFO - PROCESS | 25725 | [#8] json-parse-financial Cycles:10 Average:64.00 Median:64.00 stddev:1.83 (2.9%) stddev-sans-first:1.94 05:40:41 INFO - PROCESS | 25725 | Values: 64.0 63.0 63.0 63.0 69.0 63.0 64.0 64.0 63.0 64.0 05:40:41 INFO - PROCESS | 25725 | 05:40:41 INFO - PROCESS | 25725 | [#9] json-stringify-tinderbox Cycles:10 Average:66.80 Median:67.00 stddev:0.42 (0.6%) stddev-sans-first:0.44 05:40:41 INFO - PROCESS | 25725 | Values: 67.0 67.0 67.0 66.0 67.0 67.0 67.0 67.0 67.0 66.0 05:40:41 INFO - PROCESS | 25725 | 05:40:41 INFO - PROCESS | 25725 | [#10] stanford-crypto-aes Cycles:10 Average:84.60 Median:83.00 stddev:4.03 (4.9%) stddev-sans-first:4.24 05:40:41 INFO - PROCESS | 25725 | Values: 83.0 82.0 91.0 82.0 82.0 89.0 82.0 91.0 81.0 83.0 05:40:41 INFO - PROCESS | 25725 | 05:40:41 INFO - PROCESS | 25725 | [#11] stanford-crypto-ccm Cycles:10 Average:139.30 Median:135.50 stddev:13.85 (10.2%) stddev-sans-first:14.66 05:40:41 INFO - PROCESS | 25725 | Values: 137.0 143.0 131.0 141.0 134.0 133.0 133.0 132.0 177.0 132.0 05:40:41 INFO - PROCESS | 25725 | 05:40:41 INFO - PROCESS | 25725 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.80 Median:175.00 stddev:1.81 (1.0%) stddev-sans-first:1.87 05:40:41 INFO - PROCESS | 25725 | Values: 175.0 173.0 175.0 176.0 175.0 176.0 173.0 172.0 172.0 171.0 05:40:41 INFO - PROCESS | 25725 | 05:40:41 INFO - PROCESS | 25725 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.10 Median:69.00 stddev:1.37 (2.0%) stddev-sans-first:1.45 05:40:41 INFO - PROCESS | 25725 | Values: 69.0 72.0 69.0 69.0 69.0 70.0 68.0 68.0 70.0 67.0 05:40:41 INFO - PROCESS | 25725 | -------- Summary: end -------- 05:40:41 INFO - PROCESS | 25725 | 05:40:42 INFO - TEST-INFO | 25725: exit 0 05:40:42 INFO - TEST-OK | kraken | took 64894ms 05:40:42 INFO - SUITE-END | took 1185s 05:40:43 INFO - Completed test suite (00:19:46) 05:40:43 INFO - javascript benchmark 05:40:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2564.7178810330865, 2592.4685439484906, 2621.2005338371796, 2623.75074367935, 2635.789136869052, 4486.663500237487, 4544.681872268942, 4633.9073218535605, 4660.2776569631715, 4677.929831052533, 4591.88520286993, 4649.6047835933905, 4667.183242932481, 4714.811407543702, 4749.90500189996, 4252.3621456781575, 4288.63546598538, 4322.13557288542, 4342.283523218681, 4359.0, 4283.357496375537, 4324.0, 4345.826166953318, 4353.216421044211, 4392.165488557164, 4324.481062272516, 4330.112326972963, 4366.803493842769, 4370.956290437087, 4372.759498227596, 4178.227027999799, 4192.035831758712, 4207.43199668044, 4238.894027649302, 4262.190183865056, 4219.324908014733, 4222.683298752575, 4250.872473825791, 4326.0266440051055, 4327.307630779061, 4656.743879086649, 4682.321063445781, 4685.367475390813, 4688.624910007191, 4695.107929493385, 4818.469968303484, 4882.0, 4959.876003099916, 4975.154223781966, 4975.601951843843, 5051.419086805027, 5071.391433028023, 5076.771545280471, 5082.695038297714, 5126.71803050832, 4723.433188017426, 4733.171694953438, 4734.366643507984, 4736.265878788793, 4750.382450281441, 4940.036692844861, 4987.650864439527, 5054.54509094176, 5175.120229560984, 5255.737213139328, 4875.0, 4888.0, 4907.9263811042865, 4953.876153096201, 4974.776135073858, 4970.229614409773, 4971.1549036663855, 4979.3526841510375, 4979.427365852901, 5040.445550989388, 4706.0, 4751.738654374042, 4928.531789479994, 4935.3090567320605, 4992.425871024806, 4879.121758083508, 4882.096812089704, 4893.339399181136, 4963.826266080742, 4965.652404331734, 4139.254934111888, 4139.379093135994, 4177.791110444466, 4186.05813691923, 4188.643965262987, 3633.1280492681567, 3657.835397407123, 3666.4500324950936, 3703.407454807218, 3724.851005959731, 4151.190517849051, 4200.1179752252365, 4225.239456897788, 4305.6986010978935, 4309.892252693708, 4932.654714170046, 4940.061388336205, 4953.925691114636, 4966.1061009018, 5004.274380214849, 4302.612764851178, 4318.805653745589, 4333.956660433355, 4386.320120381346, 4395.626371758436, 4268.08236229206, 4297.634701050383, 4436.600705936481, 4481.663875209372, 4483.75339356332, 4573.131105090022, 4573.382593349856, 4593.127305811885, 4595.264757638762, 4596.3105534170145, 4905.092557876804, 4912.066707325596, 4915.680480768739, 4921.803127874845, 4922.606191504743, 4623.791929363254, 4654.604358629555, 4660.044690838437, 4661.627069834473, 4680.765961701969, 4871.610271178368, 4875.585575226146, 4920.434150072644, 4924.9507504924495, 4934.28452874324, 4919.680220785637, 4948.15881300187, 4951.925721114114, 4953.23224900141, 5009.949900500948, 4640.095181439722, 4672.369230153886, 4800.3759511263315, 4807.134715751198, 4867.756612169306, 4786.138495070782, 4810.302506136661, 4815.975920120517, 4823.986962737724, 4889.535494128052, 4756.738379389167, 4760.285957106462, 4779.06808172403, 4784.832530861403, 4829.589484893823, 4705.270683044134, 4751.40607424072, 4866.197077482318, 4877.6829506081995, 4935.531124543163, 4694.765261736968, 4790.784414701417, 4845.903081938412, 4849.199882019428, 4852.8544143675745], "value": 4556.706134495323, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [568.5082403720781, 575.5395683453239, 580.6922331164483, 581.7149596697617, 588.9352171261163, 28023.159305220826, 39239.60760392395, 40122.59877401225, 40218.39672404916, 43209.78395108028, 40671.186576268454, 41146.58853411465, 41149.0, 41230.17539649205, 41246.58753412465, 7620.809479763023, 7762.573058481781, 7767.883481747778, 7768.495047821873, 7775.533467991911, 7274.854502909939, 7428.517146385495, 7437.776866694008, 7592.620368981557, 7622.199669034727, 9841.360311579725, 10129.088382045651, 10131.088202061814, 10388.53251603676, 10466.790664186712, 9955.352902061342, 10031.799364012752, 10032.147267482273, 10037.447940363278, 10042.046005629454, 9822.01779822012, 9880.061394167542, 9895.554700038516, 9896.90103098967, 9903.702888913343, 38062.809685951666, 38257.617423825686, 38306.80846595777, 38428.80785596054, 38429.23141537182, 2919.4307110113537, 3007.593974813394, 3162.604674415698, 3567.3757092508968, 3634.0, 27810.3047423814, 28085.438291234266, 28643.0, 28694.713052869414, 28837.134885953456, 3330.5170750241323, 3382.391169589473, 3520.2959408118477, 3521.9119522012156, 3543.450765131409, 245755.0, 246446.0, 247604.0, 247859.0, 249673.75163124249, 32933.0, 54180.72909635427, 54495.72752136293, 54503.45496545063, 54661.45338546563, 33659.32681346408, 33774.0, 33782.15544611404, 33786.0, 33827.66172338245, 12574.874251257554, 12638.2417054977, 12745.49018039268, 12789.744205116032, 12790.936045319713, 10328.638497652546, 10396.0, 10397.376157430579, 10399.0, 10404.427756473315, 7250.456215783837, 7465.589392583352, 7511.0, 7851.254130857559, 7932.801679957932, 3038.60498135241, 3052.9542056869163, 3099.5505651680833, 3103.581016562735, 3114.174743692923, 844.3076677124699, 859.2481578618708, 913.6025828764509, 930.916217540411, 933.1974501928336, 26336.473270534865, 27629.171124866287, 28117.57823632647, 28127.156185314474, 28153.0, 940.3840484482674, 948.6679662118204, 954.179405711088, 955.6894009446958, 1033.679559336608, 13767.38046787897, 14795.0, 14801.185934773475, 15101.169435681142, 15101.3204405802, 358163.0, 361198.0, 361231.0, 362246.0, 362381.0, 42431.575684242765, 43452.3482147768, 47563.28655070177, 48620.756896215295, 48852.511474885505, 1149.9770004599861, 1158.362900404791, 1182.6097387861985, 1185.2769810415812, 1186.4720199511307, 26885.0, 27838.025669101484, 28256.15231543057, 28524.85737571299, 29043.85478072596, 41603.0, 42139.7893010533, 42146.7892660547, 42194.156116878105, 42197.789011055975, 308838.0, 309608.0, 310474.0, 310481.0, 311040.0, 24349.634755479037, 24841.0, 24861.751382485945, 24869.751302486744, 25032.123875664263, 40932.38601421041, 41034.58965410427, 41108.0, 41750.0, 42215.0, 35073.0, 35264.82367588145, 35660.28679426345, 35670.28659426849, 35739.82130089333, 34756.30487390289, 35282.647173527934, 35348.82325588356, 35446.645533545365, 35452.0, 34854.0, 35056.47415288824, 35092.12269693278, 35392.29215415626, 36008.4598731014, 30054.24864378408, 32260.677393225767, 32301.838490808335, 32662.673373266913, 32880.0, 24028.75971240265, 24371.512569748862, 24745.0, 24837.379065523506, 25178.62232066484], "value": 16557.0621217768, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.87029863801075, 359.9766015209013, 360.2578687902919, 363.8890138507755, 385.7280617164897, 12478.81281780773, 15647.0, 15809.446669366589, 16536.503904882844, 17527.298908043664, 14021.579352619412, 14186.077904936172, 16536.0, 17123.0, 17242.137893105326, 4610.953890461086, 5013.849584512462, 5099.898002039957, 5203.68777873327, 5232.16285394337, 4798.448178459469, 5136.075506408845, 5175.275461435402, 5175.430702622709, 5177.042247184264, 4945.085159245533, 5098.566621837148, 5144.691318520882, 5146.5625421839, 5157.71632560209, 5091.261767043777, 5122.667026643257, 5123.2315152727015, 5129.17933130701, 5130.23046543016, 4465.062336909253, 4476.597106260419, 4594.035252596958, 4594.977025114887, 4602.769861506911, 20123.496912577302, 20504.794952050437, 20548.58902821935, 20681.896590517103, 20820.687689684666, 1805.341050516552, 1876.5965317456812, 2332.54515369503, 2333.5099629077913, 2343.8124950003958, 13015.219086854724, 13035.804462933063, 13193.60419187426, 13231.933840330737, 13597.864021359857, 1585.2470076713585, 1591.2243974480748, 1629.3889791328252, 1634.3135882929198, 1660.0537693514702, 64026.35973640297, 65492.67253663749, 66651.66674166647, 66749.0, 67449.66275168642, 9257.35198536096, 9342.205912497378, 9538.0, 9566.499262923846, 9798.902010979942, 13303.667408314675, 13316.933415333055, 13319.667008324675, 13332.0, 13334.399952002183, 6650.900236496456, 6964.582125072512, 7146.892231704094, 7158.677859496335, 7163.462740294499, 6463.385978332051, 6538.640374779433, 6695.933040669628, 6708.664566771642, 6825.965870170618, 5901.380355062743, 6007.369226231182, 6024.578279520391, 6142.078688196806, 6289.213848268966, 1672.715638341485, 1716.7596536484903, 1743.1981288607128, 1767.1870939367777, 1767.7525146479504, 684.3498676257575, 881.4534988307163, 898.2544488074882, 902.2015516268019, 902.4314681750456, 16815.831841681673, 16932.746008809878, 17846.643067138844, 17863.821361786475, 18339.083045847656, 869.6173683579204, 879.1999280654574, 920.4339331311195, 921.1341339141186, 941.5621735892843, 9434.716958491255, 10321.174306055498, 10337.121344685786, 10386.11718003978, 10485.108765754996, 364447.0, 365652.0, 365723.0, 369687.15156424046, 372947.0, 77334.613326933, 77939.0, 77962.6101869487, 78870.81693774599, 80081.59959200167, 907.8774365460711, 927.9211267042242, 929.2937367600672, 933.5612262236738, 933.9673111441067, 15581.688366232838, 15612.21938903073, 15877.0, 15944.282507287431, 16108.27512761952, 37596.2480750378, 38397.23205535818, 38624.613753863225, 39326.60673393229, 39773.40339894962, 51822.222666659276, 52080.0, 52289.738551308525, 53210.403687889426, 55069.724651376484, 6534.281229064894, 7479.70081196746, 7558.697652093854, 7583.734569290048, 7626.58053807046, 9840.3603765755, 10852.837207442053, 12454.626361209179, 12483.687907802014, 12781.872181278068, 10511.684649460529, 10640.308379955279, 10768.515416806105, 10914.508847102059, 11056.834147487632, 4665.183592871302, 7007.509474336747, 9875.666784983936, 10550.788984220426, 10987.835182472429, 10861.456927153453, 10943.233973621771, 10947.50736216888, 11160.944195279297, 11726.824097638371, 7862.488938218998, 7985.0, 8051.677932882619, 8086.959565202136, 8258.132896046069, 10393.42836143989, 10550.947245263724, 10804.729881753019, 10856.620018299322, 11207.383593902414], "value": 8248.916288117669, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1367.2821768571496, 1396.8114304568883, 1456.7741999989998, 1651.265186991789, 1699.2183595546048, 6765.763198288061, 6975.093237879081, 7110.964445177773, 7614.352780013699, 7651.693932242711, 7194.6762395692185, 7433.739819106332, 7449.515781474201, 7610.581418022007, 7627.466077374586, 2168.4145280774183, 2199.14233448955, 2204.261572373249, 2206.5476577301615, 2207.8012978831903, 1861.8045105263955, 1931.9613607727838, 2089.947751306222, 2106.9157233710635, 2135.4874830040835, 2093.633614117531, 2136.8931553422344, 2142.5607750411205, 2151.376100930728, 2158.0612433591436, 2082.3856962196187, 2091.4980404702915, 2095.1095784291692, 2097.2030628361126, 2099.737532808399, 2042.5710600773855, 2050.9897450512653, 2051.241040814893, 2053.209514336976, 2078.1064142418754, 7641.656125474311, 7646.0, 7700.576468294297, 7736.806579835493, 7777.2222777722345, 4490.10197960406, 4627.768611569408, 4629.8148074077, 4633.513481084505, 4640.559146881041, 2767.1006922750184, 2891.2482754483776, 2930.780191485626, 2943.3966036962584, 2961.718636729507, 885.9202671759508, 909.6179604566098, 929.0430856218106, 931.6180366049887, 938.5401153434836, 10128.240381971382, 10133.341332813343, 10172.643957461527, 10204.285700001003, 10239.9488002561, 3746.9812650937115, 3988.980055099706, 4109.712320137622, 4216.451861258017, 4228.1966426378885, 8760.123987601317, 8769.123087691307, 8788.0, 8810.86783698245, 8832.64669413229, 4651.906961860812, 4663.556962088596, 4665.813367465264, 4681.274402467623, 4692.366530518337, 4125.834966601303, 4207.873763787091, 4220.219259436953, 4222.366645003274, 4230.767307798039, 3569.411047177187, 3662.6703596676425, 3688.7642639715996, 3690.5755838078426, 3691.3724666806706, 1035.0736091198335, 1072.1904961753826, 1131.4455916600807, 1165.5745652836822, 1233.5559198688466, 796.016919104905, 804.4368941740688, 805.3677862877613, 811.7686459359054, 819.4304958054095, 4950.232713929347, 4966.801327946841, 5120.052790233819, 5131.56381707559, 5204.583633309327, 798.7044793426469, 818.2104269380077, 824.2581676491205, 844.3287586368851, 860.7030574451804, 3164.620245570546, 3260.136063943057, 3296.208909861616, 3319.7842140260805, 3378.662133786651, 8935.731928042169, 9361.719148425558, 9363.344565880323, 9375.249980001583, 9385.859212111824, 9306.813863722824, 9356.298277629205, 9360.485173315534, 9404.482753448627, 9418.95290523543, 6941.68762405693, 6950.652467376611, 6965.616891071039, 7011.509194356346, 7031.332023457763, 4913.213885778258, 4971.105201063843, 4981.37732783402, 5081.568066714222, 5177.171652535576, 8298.668053277801, 8645.4812711235, 8653.134686531297, 8663.95668021656, 8695.52174630376, 8387.580620969049, 8578.142185781371, 8656.740297791077, 8838.292936565187, 8923.286137109146, 6349.587276826992, 6604.240512341143, 6631.535792494479, 6644.700988455627, 6666.200055993312, 7410.925890741024, 7418.814529636802, 7426.4058875288765, 7438.293362130589, 7503.962480187783, 6311.90532142009, 6365.745370185141, 6486.772962946275, 6514.315996820265, 6811.046453496416, 6418.967905160444, 6567.704453299518, 6569.211694596679, 6572.7042283098335, 6678.065070889982, 5626.2685850839125, 5699.458551437607, 5709.885802284014, 5710.428957104423, 5711.029125048669, 4501.864944051684, 4506.324051392317, 4584.106099310602, 4602.171609110393, 4620.815167393266, 4431.0, 4490.438695163105, 4586.334981427741, 4591.357209990537, 4736.242201247784], "value": 4023.746343669752, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [282.8656388215599, 284.0640090900483, 288.84258079346756, 292.61521099753827, 298.72964966705126, 4851.830185943489, 4862.805487780493, 4889.926651100236, 4905.950940490594, 4935.851924442272, 4767.451743049551, 4843.152448321547, 4856.223004319309, 4858.368412106422, 4869.464358920524, 3584.928301433963, 3701.1672373715833, 3717.312297225022, 3725.4225595032676, 3735.383661695817, 3598.3882739934143, 3716.702663786904, 3729.4965179700666, 3754.136548593825, 3771.981140094296, 3723.236736469017, 3726.2920045191327, 3727.683146932514, 3757.5115235019407, 3764.0, 3576.159602493412, 3735.73987737419, 3746.19456816783, 3749.531308586427, 3752.8123593820337, 3269.8065206199803, 3272.8363581820813, 3286.76992610515, 3292.654271301503, 3343.8160901150427, 4652.651051171142, 4686.2267725825195, 4703.576678098988, 4705.458872229703, 4746.644001699852, 4113.6297733203855, 4224.112936283384, 4237.470316210442, 4261.659067274611, 4309.267424537836, 4944.802207911679, 4948.7278199699, 4973.5772459341, 4981.1532039553, 4982.900341993176, 3564.6613571710645, 3569.464580312948, 3578.284343131384, 3585.713142948584, 3596.4425514045365, 5159.69041857486, 5234.345706786689, 5242.816501422432, 5319.414864364917, 5342.16865061518, 3655.5613326401003, 3666.4683620874825, 3674.118211629243, 3683.889483315505, 3684.9078773030888, 3753.737238393286, 3756.7933763642714, 3756.8121593920196, 3761.5298087739034, 3764.3412402829395, 4234.767087810138, 4264.530901600821, 4277.401163837066, 4291.3777502262, 4294.720843145185, 4865.781039853215, 5010.0, 5011.724355160502, 5016.498350164954, 5057.216131499624, 1266.208619612742, 1291.4834066373337, 1296.4749276543016, 1297.7274772297735, 1302.3293004102895, 778.1518145221736, 792.2157064506098, 822.4243029879109, 836.3142223376894, 840.7940054686519, 4244.0, 4272.739541835166, 4377.387165796791, 4458.398116254264, 4465.821367145343, 5155.149400348975, 5165.044466773659, 5183.766730497136, 5185.714785686748, 5194.740262986911, 4441.933370999438, 4446.644268458515, 4449.221386257392, 4461.464624245046, 4469.821207151743, 2627.5927231279184, 2702.7837772978114, 2732.344237383014, 2741.2050505353623, 2742.657167854018, 4868.342773725572, 4872.975635121802, 4875.7074575524875, 4876.756162191876, 4880.707157570557, 5055.772490237948, 5199.636025478256, 5266.21006848968, 5292.311999440049, 5300.549453296436, 4848.684835485682, 4865.732384718804, 4883.780229889735, 4886.3403440535785, 4887.706737595756, 5112.923306150485, 5142.97428512855, 5163.148080566664, 5167.58659307247, 5200.6879587224885, 4837.540433658797, 5060.595152387874, 5068.594512438923, 5098.184290513648, 5100.591952643706, 4887.60899128076, 4912.8771780705765, 4923.704577725348, 4926.187179115406, 4927.852164435073, 3669.798161101058, 3687.741858070017, 3694.131879008377, 3717.7769333840056, 3721.1255354991013, 5070.188769796815, 5270.73646317675, 5281.287026251407, 5288.788448462018, 5293.708846013506, 5007.39911210657, 5053.36832895888, 5062.265971434195, 5062.936783275553, 5066.0, 5033.0688822567945, 5047.394312682355, 5069.3156423883775, 5071.13790655582, 5072.619553533574, 4711.78796954131, 5009.273655320031, 5015.874603134951, 5032.194848824171, 5046.571041461517, 4843.491433399583, 4961.454240033666, 5034.496550344937, 5073.619478539051, 5104.69371837691, 4863.708177509361, 4867.172580661367, 4870.610351171968, 4875.366202393666, 4945.689392311112], "value": 3784.3383062813336, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [624.144921457603, 648.9967550162252, 656.4125108028314, 663.9601623902569, 675.7499725101713, 12972.0, 13852.307384630752, 13875.306234688276, 14003.439862405505, 14020.018598698096, 13107.54123605674, 13233.404496797642, 13277.867221327784, 13285.667858303546, 13311.201327920307, 639.2584601861842, 753.8718417868962, 778.3850757901251, 781.4764108047593, 782.3936449251819, 648.3646026893647, 761.2387612387612, 772.9381649468057, 779.4504874063772, 784.705735349244, 820.5979070255562, 823.6705317872869, 825.2284114353099, 826.7767702720262, 827.4662842466605, 660.3198705333514, 681.1043477826643, 818.55388813097, 818.7298191596759, 818.7502811642447, 504.9747512624354, 505.1110046318469, 578.8408187748361, 593.8188852400016, 595.6128516464289, 12953.28756918369, 13005.609831705064, 13011.21932684042, 13020.674483137997, 13022.348882555834, 12668.80996785049, 13094.345282735825, 13223.933880330536, 13320.400581973834, 13689.247091409969, 11775.528978840835, 11902.940485297604, 11915.582954596548, 12156.419665443436, 12272.140950133495, 3888.572257051722, 3979.5622481527007, 4014.498187726534, 4138.606832350922, 4145.97927010363, 60970.0854487183, 61067.69466152685, 61165.38834611686, 61773.0, 61899.69050154721, 10279.383237005804, 10511.316764410289, 10555.947220264003, 10588.788224235472, 10620.362778233331, 19098.331558395388, 19172.13725382361, 19181.136848841834, 19281.903590481958, 19342.903285483484, 6610.96694516534, 6641.269460359356, 6683.064370988066, 6872.553284036521, 6917.169939607279, 3420.401429749834, 3456.4296891013205, 3480.8781692640637, 3536.7701099428455, 3609.151849315409, 2723.482538317713, 2828.886844526196, 2837.4750671125494, 2842.0479139488502, 2845.743883050494, 493.29705170132416, 501.45592032644987, 508.51182864450544, 512.9281900533928, 513.8792383789806, 402.3843519415299, 450.5404487422876, 456.678041980403, 463.6638437133119, 493.5163539731012, 6654.534182607171, 6706.664666766642, 6749.460043196533, 7113.359797618239, 7117.3238542338395, 392.5132835284227, 428.39168380898576, 458.59185325060724, 463.57814388905933, 470.4284294582099, 3236.1100697307957, 3258.1528802511516, 3319.6348401675796, 3344.7324214062814, 3460.3598334308235, 55224.0, 65503.67248163729, 99661.0, 103083.0, 103264.0, 86111.96845846738, 88535.55732221427, 89740.0, 89924.550377249, 90720.5463972676, 45544.54455455403, 71616.92574611385, 75412.62293688496, 76011.61994189993, 76611.61694191716, 6173.753049878134, 6180.536459765625, 6290.559660823881, 6484.935150648433, 6522.15212022434, 43870.0, 44169.33745993749, 45545.089098218516, 45669.77165114286, 46934.765326173154, 59700.40299596948, 63075.6846215766, 63386.0, 65075.67462162659, 65899.0, 8437.367197460339, 8491.787705307417, 8555.230029297392, 8666.913330866611, 8805.0, 9473.194778443909, 9542.713718588453, 9597.520123993912, 9707.077827606367, 10036.498175091363, 8257.793555160928, 8345.374096942633, 8489.151084891462, 8696.78258043554, 8774.0, 9050.773730656787, 9119.863202051842, 9366.391184572982, 9709.126178643955, 9990.350627209207, 8177.427580069338, 8193.50838949641, 8308.252257296872, 8440.788980275542, 8598.871016934625, 7386.741464048732, 7451.3666338361845, 7470.178280389044, 7575.659095340833, 7691.923080769121, 6932.341427564374, 7168.354848063699, 7178.676959536729, 7336.497626779915, 7471.663775130023], "value": 6006.687639957035, "unit": "score"}], "name": "dromaeo_css", "value": 6202.345753478843, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 116.0, 115.0, 115.0, 116.0, 116.0, 116.0, 114.0, 115.0, 118.0], "value": 115.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 130.0, 125.0, 163.0, 133.0, 131.0, 133.0, 127.0, 161.0, 126.0], "value": 138.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 166.0, 161.0, 165.0, 163.0, 162.0, 165.0, 162.0, 161.0, 161.0], "value": 162.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 77.0, 76.0, 119.0, 76.0, 75.0, 77.0, 76.0, 106.0, 76.0], "value": 83.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 125.0, 85.0, 84.0, 84.0, 118.0, 83.0, 84.0, 120.0], "value": 95.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 119.0, 118.0, 117.0, 117.0, 117.0, 116.0, 119.0, 120.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 146.0, 146.0, 147.0, 148.0, 153.0, 146.0, 148.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 95.0, 96.0, 95.0, 96.0, 96.0, 95.0, 96.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 63.0, 63.0, 69.0, 63.0, 64.0, 64.0, 63.0, 64.0], "value": 64.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 67.0, 66.0, 67.0, 67.0, 67.0, 67.0, 67.0, 66.0], "value": 66.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 91.0, 82.0, 82.0, 89.0, 82.0, 91.0, 81.0, 83.0], "value": 84.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 143.0, 131.0, 141.0, 134.0, 133.0, 133.0, 132.0, 177.0, 132.0], "value": 139.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 173.0, 175.0, 176.0, 175.0, 176.0, 173.0, 172.0, 172.0, 171.0], "value": 173.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 72.0, 69.0, 69.0, 69.0, 70.0, 68.0, 68.0, 70.0, 67.0], "value": 69.1, "unit": "score"}], "name": "kraken", "value": 1553.7999999999997, "alertThreshold": 2.0}]} 05:40:43 INFO - Return code: 0 05:40:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:40:43 INFO - # TBPL SUCCESS # 05:40:43 INFO - Running post-action listener: _resource_record_post_action 05:40:43 INFO - [mozharness: 2016-09-26 12:40:43.294071Z] Finished run-tests step (success) 05:40:43 INFO - Running post-run listener: _resource_record_post_run 05:40:43 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 4096; Write bytes: 391077888; Read time: 20; Write time: 249928 05:40:43 INFO - TinderboxPrint: CPU usage
13.0% 05:40:43 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 05:40:43 INFO - TinderboxPrint: I/O write bytes / time
391,077,888 / 249,928 05:40:43 INFO - TinderboxPrint: CPU idle
8,343.3 (87.0%) 05:40:43 INFO - TinderboxPrint: CPU user
1,199.5 (12.5%) 05:40:43 INFO - TinderboxPrint: Swap in / out
0 / 0 05:40:43 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99123200; Read time: 0; Write time: 55396 05:40:43 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 291057664; Read time: 0; Write time: 194508 05:40:43 INFO - Running post-run listener: _upload_blobber_files 05:40:43 INFO - Blob upload gear active. 05:40:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:40:43 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 05:40:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:40:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:40:44 INFO - (blobuploader) - INFO - Open directory for files ... 05:40:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:40:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:40:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:40:49 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:40:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:40:49 INFO - (blobuploader) - INFO - Done attempting. 05:40:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:40:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:40:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:40:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:40:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:40:49 INFO - (blobuploader) - INFO - Done attempting. 05:40:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:40:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:40:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:40:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:40:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:40:50 INFO - (blobuploader) - INFO - Done attempting. 05:40:50 INFO - (blobuploader) - INFO - Iteration through files over. 05:40:50 INFO - Return code: 0 05:40:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:40:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:40:50 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c5495514067e87deba1b53cf754aed98bd18a1832672103388d3bfc431a9ae3d9810c23b3981c34ae3be214ff4fbef11bbe0a38a2d84ebf8c8e3fb8949e0c4c4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2db775480a1979d8ef2665ea5f2948ad17b5440864c880492fdb41323accdd6ab68c6bd2e3385bddc6126b24981f580c934a0175abb65649b36e8b3c9a544d79", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/54b34eb518c8bc97ec23e40a28fa0ad46898293d1c2affd583c7e14fb3d6f68b38a212096853322033a0ac286d911b737f705c8ec1e410004713840e16d27102"} 05:40:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:40:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:40:50 INFO - Contents: 05:40:50 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c5495514067e87deba1b53cf754aed98bd18a1832672103388d3bfc431a9ae3d9810c23b3981c34ae3be214ff4fbef11bbe0a38a2d84ebf8c8e3fb8949e0c4c4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2db775480a1979d8ef2665ea5f2948ad17b5440864c880492fdb41323accdd6ab68c6bd2e3385bddc6126b24981f580c934a0175abb65649b36e8b3c9a544d79", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/54b34eb518c8bc97ec23e40a28fa0ad46898293d1c2affd583c7e14fb3d6f68b38a212096853322033a0ac286d911b737f705c8ec1e410004713840e16d27102"} 05:40:50 INFO - Running post-run listener: copy_logs_to_upload_dir 05:40:50 INFO - Copying logs to upload dir... 05:40:50 INFO - mkdir: /builds/slave/test/build/upload/logs 05:40:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.331411 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-09-26 05:40:48.089786) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-26 05:40:48.093566) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1474887360.687250-2114229463 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c5495514067e87deba1b53cf754aed98bd18a1832672103388d3bfc431a9ae3d9810c23b3981c34ae3be214ff4fbef11bbe0a38a2d84ebf8c8e3fb8949e0c4c4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2db775480a1979d8ef2665ea5f2948ad17b5440864c880492fdb41323accdd6ab68c6bd2e3385bddc6126b24981f580c934a0175abb65649b36e8b3c9a544d79", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/54b34eb518c8bc97ec23e40a28fa0ad46898293d1c2affd583c7e14fb3d6f68b38a212096853322033a0ac286d911b737f705c8ec1e410004713840e16d27102"} build_url:https://queue.taskcluster.net/v1/task/UkAJNQORRd-j29yI5AvFDA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011399 build_url: 'https://queue.taskcluster.net/v1/task/UkAJNQORRd-j29yI5AvFDA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c5495514067e87deba1b53cf754aed98bd18a1832672103388d3bfc431a9ae3d9810c23b3981c34ae3be214ff4fbef11bbe0a38a2d84ebf8c8e3fb8949e0c4c4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2db775480a1979d8ef2665ea5f2948ad17b5440864c880492fdb41323accdd6ab68c6bd2e3385bddc6126b24981f580c934a0175abb65649b36e8b3c9a544d79", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/54b34eb518c8bc97ec23e40a28fa0ad46898293d1c2affd583c7e14fb3d6f68b38a212096853322033a0ac286d911b737f705c8ec1e410004713840e16d27102"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-26 05:40:48.122865) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 05:40:48.123233) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1474887360.687250-2114229463 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004491 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 05:40:48.209713) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-26 05:40:48.210433) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-26 05:40:48.211050) ========= ========= Total master_lag: 0.21 =========