builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-009 starttime: 1477448324.94 results: success (0) buildid: 20161025163003 builduid: 8a8ed753cac34e148345eca02fbc4072 revision: b1b18f25c0ea69d9ee57c4198d577dfcd0129ce1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-25 19:18:44.942719) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-25 19:18:44.943232) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-25 19:18:44.943526) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-25 19:18:44.958804) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 19:18:44.959135) ========= 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=17051fcd5208b27b50bedfeb000001dd-1477447598.573229-1907932952 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-25 19:18:44-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 37.8M=0s 2016-10-25 19:18:45 (37.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.190887 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 19:18:45.167389) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 19:18:45.167700) ========= 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=17051fcd5208b27b50bedfeb000001dd-1477447598.573229-1907932952 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014183 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 19:18:45.219368) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-25 19:18:45.219727) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b1b18f25c0ea69d9ee57c4198d577dfcd0129ce1 --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 b1b18f25c0ea69d9ee57c4198d577dfcd0129ce1 --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=17051fcd5208b27b50bedfeb000001dd-1477447598.573229-1907932952 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-25 19:18:45,244 truncating revision to first 12 chars 2016-10-25 19:18:45,244 Setting DEBUG logging. 2016-10-25 19:18:45,244 attempt 1/10 2016-10-25 19:18:45,244 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b1b18f25c0ea?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-25 19:18:46,416 unpacking tar archive at: mozilla-central-b1b18f25c0ea/testing/mozharness/ program finished with exit code 0 elapsedTime=1.486963 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-25 19:18:46.720534) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-25 19:18:46.720891) ========= script_repo_revision: b1b18f25c0ea69d9ee57c4198d577dfcd0129ce1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-25 19:18:46.721473) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-25 19:18:46.721740) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-25 19:18:46.731529) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-10-25 19:18:46.731937) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=17051fcd5208b27b50bedfeb000001dd-1477447598.573229-1907932952 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:18:46 INFO - MultiFileLogger online at 20161025 19:18:46 in /builds/slave/test 19:18:46 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 19:18:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:18:46 INFO - {'append_to_log': False, 19:18:46 INFO - 'base_work_dir': '/builds/slave/test', 19:18:46 INFO - 'blob_upload_branch': 'Firefox', 19:18:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:18:46 INFO - 'branch': 'Firefox', 19:18:46 INFO - 'buildbot_json_path': 'buildprops.json', 19:18:46 INFO - 'config_files': ('talos/linux_config.py',), 19:18:46 INFO - 'default_actions': ('clobber', 19:18:46 INFO - 'read-buildbot-config', 19:18:46 INFO - 'download-and-extract', 19:18:46 INFO - 'populate-webroot', 19:18:46 INFO - 'create-virtualenv', 19:18:46 INFO - 'install', 19:18:46 INFO - 'run-tests'), 19:18:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:18:46 INFO - 'download_minidump_stackwalk': True, 19:18:46 INFO - 'download_symbols': 'ondemand', 19:18:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:18:46 INFO - 'tooltool.py': '/tools/tooltool.py', 19:18:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:18:46 INFO - '/tools/misc-python/virtualenv.py')}, 19:18:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:18:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:18:46 INFO - 'installer_path': 'installer.exe', 19:18:46 INFO - 'log_level': 'info', 19:18:46 INFO - 'log_name': 'talos', 19:18:46 INFO - 'log_to_console': True, 19:18:46 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:18:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:18:46 INFO - 'opt_config_files': (), 19:18:46 INFO - 'pip_index': False, 19:18:46 INFO - 'sps_profile': False, 19:18:46 INFO - 'sps_profile_interval': 0, 19:18:46 INFO - 'suite': 'dromaeojs', 19:18:46 INFO - 'system_bits': '32', 19:18:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:18:46 INFO - 'title': 'talos-linux64-ix-009', 19:18:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:18:46 INFO - 'use_talos_json': True, 19:18:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:18:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:18:46 INFO - 'work_dir': 'build'} 19:18:46 INFO - [mozharness: 2016-10-26 02:18:46.857008Z] Running clobber step. 19:18:46 INFO - Running pre-action listener: _resource_record_pre_action 19:18:46 INFO - Running main action method: clobber 19:18:46 INFO - rmtree: /builds/slave/test/build 19:18:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:18:47 INFO - Running post-action listener: _resource_record_post_action 19:18:47 INFO - [mozharness: 2016-10-26 02:18:47.819347Z] Finished clobber step (success) 19:18:47 INFO - [mozharness: 2016-10-26 02:18:47.819446Z] Running read-buildbot-config step. 19:18:47 INFO - Running pre-action listener: _resource_record_pre_action 19:18:47 INFO - Running main action method: read_buildbot_config 19:18:47 INFO - Using buildbot properties: 19:18:47 INFO - { 19:18:47 INFO - "project": "", 19:18:47 INFO - "product": "firefox", 19:18:47 INFO - "script_repo_revision": "production", 19:18:47 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 19:18:47 INFO - "repository": "", 19:18:47 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 19:18:47 INFO - "buildid": "20161025163003", 19:18:47 INFO - "pgo_build": "True", 19:18:47 INFO - "basedir": "/builds/slave/test", 19:18:47 INFO - "buildnumber": 34, 19:18:47 INFO - "slavename": "talos-linux64-ix-009", 19:18:47 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 19:18:47 INFO - "platform": "ubuntu64_hw", 19:18:47 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 19:18:47 INFO - "branch": "mozilla-central", 19:18:47 INFO - "repo_path": "mozilla-central", 19:18:47 INFO - "revision": "b1b18f25c0ea69d9ee57c4198d577dfcd0129ce1", 19:18:47 INFO - "stage_platform": "linux64-pgo", 19:18:47 INFO - "builduid": "8a8ed753cac34e148345eca02fbc4072", 19:18:47 INFO - "slavebuilddir": "test" 19:18:47 INFO - } 19:18:47 INFO - Found installer url https://queue.taskcluster.net/v1/task/bQ-IpGpZRZO_oq82AoOxaQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 19:18:47 INFO - Running post-action listener: _resource_record_post_action 19:18:47 INFO - [mozharness: 2016-10-26 02:18:47.821882Z] Finished read-buildbot-config step (success) 19:18:47 INFO - [mozharness: 2016-10-26 02:18:47.821970Z] Running download-and-extract step. 19:18:47 INFO - Running pre-action listener: _resource_record_pre_action 19:18:47 INFO - Running main action method: download_and_extract 19:18:47 INFO - mkdir: /builds/slave/test/build/tests 19:18:47 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')]} 19:18:47 INFO - trying https://queue.taskcluster.net/v1/task/bQ-IpGpZRZO_oq82AoOxaQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 19:18:47 INFO - Downloading https://queue.taskcluster.net/v1/task/bQ-IpGpZRZO_oq82AoOxaQ/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 19:18:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bQ-IpGpZRZO_oq82AoOxaQ/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 19:18:48 INFO - Downloaded 1361 bytes. 19:18:48 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 19:18:48 INFO - Using the following test package requirements: 19:18:48 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 19:18:48 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 19:18:48 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:18:48 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 19:18:48 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:18:48 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 19:18:48 INFO - u'jsshell-linux-x86_64.zip'], 19:18:48 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 19:18:48 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:18:48 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 19:18:48 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 19:18:48 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:18:48 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 19:18:48 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:18:48 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 19:18:48 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:18:48 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 19:18:48 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:18:48 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:18:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bQ-IpGpZRZO_oq82AoOxaQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 19:18:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bQ-IpGpZRZO_oq82AoOxaQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:18:48 INFO - Fetch https://queue.taskcluster.net/v1/task/bQ-IpGpZRZO_oq82AoOxaQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 19:18:48 INFO - Http code: 200 19:18:48 INFO - via: 1.1 ae162f6796e551002447afd7c07ec67a.cloudfront.net (CloudFront) 19:18:48 INFO - x-amz-cf-id: O3xxjAZglzdUkwM1uyl3aKiaFxEKpDnyVsWlMauab5NCAyo8a9Y__A== 19:18:48 INFO - x-amz-version-id: 9HcKmTXAok8cCmq.nbBM2tw112D9.Mh6 19:18:49 INFO - Expected file size: 22035978 19:18:49 INFO - Obtained file size: 22035978 19:18:53 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 19:18:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bQ-IpGpZRZO_oq82AoOxaQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 19:18:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bQ-IpGpZRZO_oq82AoOxaQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:18:53 INFO - Fetch https://queue.taskcluster.net/v1/task/bQ-IpGpZRZO_oq82AoOxaQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 19:18:54 INFO - Http code: 200 19:18:54 INFO - via: 1.1 37af14ee951b12568cf1cc160d08abe6.cloudfront.net (CloudFront) 19:18:54 INFO - x-amz-cf-id: xKXteRCbYqTVFToICNqpSu8iWQiLNzN-jZpLSuhgWl4McWZiR7xf4g== 19:18:54 INFO - x-amz-version-id: 9HcKmTXAok8cCmq.nbBM2tw112D9.Mh6 19:18:54 INFO - Expected file size: 22035978 19:18:54 INFO - Obtained file size: 22035978 19:18:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bQ-IpGpZRZO_oq82AoOxaQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 19:18:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bQ-IpGpZRZO_oq82AoOxaQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 19:18:58 INFO - Fetch https://queue.taskcluster.net/v1/task/bQ-IpGpZRZO_oq82AoOxaQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 19:18:59 INFO - Http code: 200 19:18:59 INFO - via: 1.1 bb8a7ff26b131d51953dc2d3e19a2751.cloudfront.net (CloudFront) 19:18:59 INFO - x-amz-cf-id: tI4nUlHu7DjGzdtwZe3bP0zzGyeRuh1Du2q_KtzXrClWBS7KncxviQ== 19:18:59 INFO - x-amz-version-id: uNBvjyDNtVMKp1.6odst8dLK3BPWsO44 19:18:59 INFO - Expected file size: 14409028 19:18:59 INFO - Obtained file size: 14409028 19:18:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:18:59 INFO - trying https://queue.taskcluster.net/v1/task/bQ-IpGpZRZO_oq82AoOxaQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 19:18:59 INFO - Downloading https://queue.taskcluster.net/v1/task/bQ-IpGpZRZO_oq82AoOxaQ/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 19:18:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bQ-IpGpZRZO_oq82AoOxaQ/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 19:19:02 INFO - Downloaded 59297921 bytes. 19:19:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bQ-IpGpZRZO_oq82AoOxaQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 19:19:02 INFO - mkdir: /builds/slave/test/properties 19:19:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:19:02 INFO - Writing to file /builds/slave/test/properties/build_url 19:19:02 INFO - Contents: 19:19:02 INFO - build_url:https://queue.taskcluster.net/v1/task/bQ-IpGpZRZO_oq82AoOxaQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 19:19:03 INFO - Running post-action listener: _resource_record_post_action 19:19:03 INFO - Running post-action listener: set_extra_try_arguments 19:19:03 INFO - [mozharness: 2016-10-26 02:19:03.411183Z] Finished download-and-extract step (success) 19:19:03 INFO - [mozharness: 2016-10-26 02:19:03.411409Z] Running populate-webroot step. 19:19:03 INFO - Running pre-action listener: _resource_record_pre_action 19:19:03 INFO - Running main action method: populate_webroot 19:19:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:19:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:19:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:19:03 INFO - '--tppagecycles', 19:19:03 INFO - '7'], 19:19:03 INFO - 'tests': ['tsvgm']}}, 19:19:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:19:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:19:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:19:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:19:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:19:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:19:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:19:03 INFO - 'talos_options': ['--disable-e10s'], 19:19:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:19:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:19:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:19:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:19:03 INFO - 'talos_options': ['--disable-e10s'], 19:19:03 INFO - 'tests': ['damp', 'tps']}, 19:19:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:19:03 INFO - 'tests': ['damp', 'tps']}, 19:19:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:19:03 INFO - 'tests': ['dromaeo_dom']}, 19:19:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:19:03 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:19:03 INFO - 'tests': ['basic_compositor_video']}, 19:19:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:19:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:19:03 INFO - 'tests': ['a11yr', 19:19:03 INFO - 'ts_paint', 19:19:03 INFO - 'tpaint', 19:19:03 INFO - 'sessionrestore', 19:19:03 INFO - 'sessionrestore_no_auto_restore', 19:19:03 INFO - 'tabpaint']}, 19:19:03 INFO - 'other-e10s': {'tests': ['a11yr', 19:19:03 INFO - 'ts_paint', 19:19:03 INFO - 'tpaint', 19:19:03 INFO - 'sessionrestore', 19:19:03 INFO - 'sessionrestore_no_auto_restore', 19:19:03 INFO - 'tabpaint']}, 19:19:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:19:03 INFO - 'ts_paint', 19:19:03 INFO - 'tpaint', 19:19:03 INFO - 'sessionrestore', 19:19:03 INFO - 'sessionrestore_no_auto_restore', 19:19:03 INFO - 'tabpaint']}, 19:19:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:19:03 INFO - 'ts_paint', 19:19:03 INFO - 'tpaint', 19:19:03 INFO - 'sessionrestore', 19:19:03 INFO - 'sessionrestore_no_auto_restore', 19:19:03 INFO - 'tabpaint']}, 19:19:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:19:03 INFO - 'tests': ['a11yr', 19:19:03 INFO - 'ts_paint', 19:19:03 INFO - 'tpaint', 19:19:03 INFO - 'sessionrestore', 19:19:03 INFO - 'sessionrestore_no_auto_restore', 19:19:03 INFO - 'tabpaint']}, 19:19:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:19:03 INFO - 'tests': ['a11yr', 19:19:03 INFO - 'ts_paint', 19:19:03 INFO - 'tpaint', 19:19:03 INFO - 'sessionrestore', 19:19:03 INFO - 'sessionrestore_no_auto_restore', 19:19:03 INFO - 'tabpaint']}, 19:19:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:19:03 INFO - 'tests': ['tsvgx', 19:19:03 INFO - 'tsvgr_opacity', 19:19:03 INFO - 'tart', 19:19:03 INFO - 'tscrollx', 19:19:03 INFO - 'cart']}, 19:19:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:19:03 INFO - 'tsvgr_opacity', 19:19:03 INFO - 'tart', 19:19:03 INFO - 'tscrollx', 19:19:03 INFO - 'cart']}, 19:19:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:19:03 INFO - 'talos_options': ['--disable-e10s'], 19:19:03 INFO - 'tests': ['tp5o']}, 19:19:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:19:03 INFO - 'tests': ['tp5o']}, 19:19:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:19:03 INFO - 'talos_options': ['--disable-e10s', 19:19:03 INFO - '--xperf_path', 19:19:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:19:03 INFO - 'tests': ['tp5n']}, 19:19:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:19:03 INFO - 'talos_options': ['--xperf_path', 19:19:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:19:03 INFO - 'tests': ['tp5n']}}, 19:19:03 INFO - 'talos.zip': {'path': '', 19:19:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:19:03 INFO - Running post-action listener: _resource_record_post_action 19:19:03 INFO - [mozharness: 2016-10-26 02:19:03.433580Z] Finished populate-webroot step (success) 19:19:03 INFO - [mozharness: 2016-10-26 02:19:03.433669Z] Running create-virtualenv step. 19:19:03 INFO - Running pre-action listener: _resource_record_pre_action 19:19:03 INFO - Running main action method: create_virtualenv 19:19:03 INFO - Creating virtualenv /builds/slave/test/build/venv 19:19:03 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 19:19:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:19:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:19:03 INFO - Using real prefix '/usr' 19:19:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:19:04 INFO - Installing distribute.............................................................................................................................................................................................done. 19:19:06 INFO - Installing pip.................done. 19:19:06 INFO - Return code: 0 19:19:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 19:19:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 19:19:06 INFO - Reading from file tmpfile_stdout 19:19:06 INFO - Output received: 19:19:06 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) 19:19:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:19:06 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')]} 19:19:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:19:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:19:06 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')]} 19:19:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:19:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:19:06 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 0x7f6ce3033f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27bc790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b9930>, '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 0x27ba830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27bacc0>, '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': '17051fcd5208b27b50bedfeb000001dd-1477447598.573229-1907932952', '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 19:19:06 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 19:19:06 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 19:19:06 INFO - Using env: {'DISPLAY': ':0', 19:19:06 INFO - 'HOME': '/home/cltbld', 19:19:06 INFO - 'LANG': 'en_US.UTF-8', 19:19:06 INFO - 'LANGUAGE': 'en_US:en', 19:19:06 INFO - 'LOGNAME': 'cltbld', 19:19:06 INFO - 'MAIL': '/var/mail/cltbld', 19:19:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:19:06 INFO - 'MOZ_NO_REMOTE': '1', 19:19:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:19:06 INFO - 'NO_EM_RESTART': '1', 19:19:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:19:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:19:06 INFO - 'PWD': '/builds/slave/test', 19:19:06 INFO - 'SHELL': '/bin/bash', 19:19:06 INFO - 'SHLVL': '1', 19:19:06 INFO - 'TERM': 'linux', 19:19:06 INFO - 'TMOUT': '86400', 19:19:06 INFO - 'USER': 'cltbld', 19:19:06 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1477447598.573229-1907932952', 19:19:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:19:06 INFO - '_': '/tools/buildbot/bin/python'} 19:19:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:19:06 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 19:19:06 INFO - Cleaning up... 19:19:06 INFO - Return code: 0 19:19:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:19:06 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')]} 19:19:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:19:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:19:06 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')]} 19:19:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:19:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:19:06 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 0x7f6ce3033f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27bc790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b9930>, '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 0x27ba830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27bacc0>, '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': '17051fcd5208b27b50bedfeb000001dd-1477447598.573229-1907932952', '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 19:19:06 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 19:19:06 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 19:19:06 INFO - Using env: {'DISPLAY': ':0', 19:19:06 INFO - 'HOME': '/home/cltbld', 19:19:06 INFO - 'LANG': 'en_US.UTF-8', 19:19:06 INFO - 'LANGUAGE': 'en_US:en', 19:19:06 INFO - 'LOGNAME': 'cltbld', 19:19:06 INFO - 'MAIL': '/var/mail/cltbld', 19:19:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:19:06 INFO - 'MOZ_NO_REMOTE': '1', 19:19:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:19:06 INFO - 'NO_EM_RESTART': '1', 19:19:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:19:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:19:06 INFO - 'PWD': '/builds/slave/test', 19:19:06 INFO - 'SHELL': '/bin/bash', 19:19:06 INFO - 'SHLVL': '1', 19:19:06 INFO - 'TERM': 'linux', 19:19:06 INFO - 'TMOUT': '86400', 19:19:06 INFO - 'USER': 'cltbld', 19:19:06 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1477447598.573229-1907932952', 19:19:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:19:06 INFO - '_': '/tools/buildbot/bin/python'} 19:19:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:19:06 INFO - Downloading/unpacking psutil>=3.1.1 19:19:06 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 19:19:06 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 19:19:06 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 19:19:06 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 19:19:06 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 19:19:06 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 19:19:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:19:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:19:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:19:08 INFO - Installing collected packages: psutil 19:19:08 INFO - Running setup.py install for psutil 19:19:08 INFO - building 'psutil._psutil_linux' extension 19:19:08 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 19:19:08 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 19:19:08 INFO - building 'psutil._psutil_posix' extension 19:19:08 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 19:19:09 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 19:19:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:19:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:19:09 INFO - Successfully installed psutil 19:19:09 INFO - Cleaning up... 19:19:09 INFO - Return code: 0 19:19:09 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:19:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:19:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:19:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:19:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:19:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:19:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:19:09 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 0x7f6ce3033f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27bc790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b9930>, '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 0x27ba830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27bacc0>, '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': '17051fcd5208b27b50bedfeb000001dd-1477447598.573229-1907932952', '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 19:19:09 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 19:19:09 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 19:19:09 INFO - Using env: {'DISPLAY': ':0', 19:19:09 INFO - 'HOME': '/home/cltbld', 19:19:09 INFO - 'LANG': 'en_US.UTF-8', 19:19:09 INFO - 'LANGUAGE': 'en_US:en', 19:19:09 INFO - 'LOGNAME': 'cltbld', 19:19:09 INFO - 'MAIL': '/var/mail/cltbld', 19:19:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:19:09 INFO - 'MOZ_NO_REMOTE': '1', 19:19:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:19:09 INFO - 'NO_EM_RESTART': '1', 19:19:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:19:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:19:09 INFO - 'PWD': '/builds/slave/test', 19:19:09 INFO - 'SHELL': '/bin/bash', 19:19:09 INFO - 'SHLVL': '1', 19:19:09 INFO - 'TERM': 'linux', 19:19:09 INFO - 'TMOUT': '86400', 19:19:09 INFO - 'USER': 'cltbld', 19:19:09 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1477447598.573229-1907932952', 19:19:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:19:09 INFO - '_': '/tools/buildbot/bin/python'} 19:19:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:19:09 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:19:09 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 19:19:09 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 19:19:09 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 19:19:09 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 19:19:09 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 19:19:09 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 19:19:11 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:19:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:19:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:19:11 INFO - Installing collected packages: mozsystemmonitor 19:19:11 INFO - Running setup.py install for mozsystemmonitor 19:19:11 INFO - Successfully installed mozsystemmonitor 19:19:11 INFO - Cleaning up... 19:19:11 INFO - Return code: 0 19:19:11 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:19:11 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')]} 19:19:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:19:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:19:11 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')]} 19:19:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:19:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:19:11 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 0x7f6ce3033f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27bc790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b9930>, '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 0x27ba830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27bacc0>, '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': '17051fcd5208b27b50bedfeb000001dd-1477447598.573229-1907932952', '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 19:19:11 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 19:19:11 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 19:19:11 INFO - Using env: {'DISPLAY': ':0', 19:19:11 INFO - 'HOME': '/home/cltbld', 19:19:11 INFO - 'LANG': 'en_US.UTF-8', 19:19:11 INFO - 'LANGUAGE': 'en_US:en', 19:19:11 INFO - 'LOGNAME': 'cltbld', 19:19:11 INFO - 'MAIL': '/var/mail/cltbld', 19:19:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:19:11 INFO - 'MOZ_NO_REMOTE': '1', 19:19:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:19:11 INFO - 'NO_EM_RESTART': '1', 19:19:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:19:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:19:11 INFO - 'PWD': '/builds/slave/test', 19:19:11 INFO - 'SHELL': '/bin/bash', 19:19:11 INFO - 'SHLVL': '1', 19:19:11 INFO - 'TERM': 'linux', 19:19:11 INFO - 'TMOUT': '86400', 19:19:11 INFO - 'USER': 'cltbld', 19:19:11 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1477447598.573229-1907932952', 19:19:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:19:11 INFO - '_': '/tools/buildbot/bin/python'} 19:19:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:19:11 INFO - Downloading/unpacking jsonschema==2.5.1 19:19:11 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 19:19:11 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 19:19:11 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 19:19:11 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 19:19:11 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 19:19:11 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 19:19:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:19:13 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:19:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:19:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:19:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:19:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:19:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:19:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:19:13 INFO - Downloading functools32-3.2.3-2.tar.gz 19:19:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:19:14 INFO - warning: no files found matching '*.txt' 19:19:14 INFO - no previously-included directories found matching 'build' 19:19:14 INFO - no previously-included directories found matching 'dist' 19:19:14 INFO - no previously-included directories found matching '.git*' 19:19:14 INFO - Installing collected packages: jsonschema, functools32 19:19:14 INFO - Running setup.py install for functools32 19:19:14 INFO - warning: no files found matching '*.txt' 19:19:14 INFO - no previously-included directories found matching 'build' 19:19:14 INFO - no previously-included directories found matching 'dist' 19:19:14 INFO - no previously-included directories found matching '.git*' 19:19:14 INFO - Successfully installed jsonschema functools32 19:19:14 INFO - Cleaning up... 19:19:14 INFO - Return code: 0 19:19:14 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:19:14 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')]} 19:19:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:19:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:19:14 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')]} 19:19:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:19:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:19:14 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 0x7f6ce3033f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27bc790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b9930>, '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 0x27ba830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27bacc0>, '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': '17051fcd5208b27b50bedfeb000001dd-1477447598.573229-1907932952', '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 19:19:14 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 19:19:14 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 19:19:14 INFO - Using env: {'DISPLAY': ':0', 19:19:14 INFO - 'HOME': '/home/cltbld', 19:19:14 INFO - 'LANG': 'en_US.UTF-8', 19:19:14 INFO - 'LANGUAGE': 'en_US:en', 19:19:14 INFO - 'LOGNAME': 'cltbld', 19:19:14 INFO - 'MAIL': '/var/mail/cltbld', 19:19:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:19:14 INFO - 'MOZ_NO_REMOTE': '1', 19:19:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:19:14 INFO - 'NO_EM_RESTART': '1', 19:19:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:19:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:19:14 INFO - 'PWD': '/builds/slave/test', 19:19:14 INFO - 'SHELL': '/bin/bash', 19:19:14 INFO - 'SHLVL': '1', 19:19:14 INFO - 'TERM': 'linux', 19:19:14 INFO - 'TMOUT': '86400', 19:19:14 INFO - 'USER': 'cltbld', 19:19:14 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1477447598.573229-1907932952', 19:19:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:19:14 INFO - '_': '/tools/buildbot/bin/python'} 19:19:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:19:14 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:19:14 INFO - Cleaning up... 19:19:14 INFO - Return code: 0 19:19:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:19:14 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')]} 19:19:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:19:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:19:14 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')]} 19:19:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:19:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:19:14 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 0x7f6ce3033f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27bc790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b9930>, '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 0x27ba830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27bacc0>, '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': '17051fcd5208b27b50bedfeb000001dd-1477447598.573229-1907932952', '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 19:19:14 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 19:19:14 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 19:19:14 INFO - Using env: {'DISPLAY': ':0', 19:19:14 INFO - 'HOME': '/home/cltbld', 19:19:14 INFO - 'LANG': 'en_US.UTF-8', 19:19:14 INFO - 'LANGUAGE': 'en_US:en', 19:19:14 INFO - 'LOGNAME': 'cltbld', 19:19:14 INFO - 'MAIL': '/var/mail/cltbld', 19:19:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:19:14 INFO - 'MOZ_NO_REMOTE': '1', 19:19:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:19:14 INFO - 'NO_EM_RESTART': '1', 19:19:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:19:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:19:14 INFO - 'PWD': '/builds/slave/test', 19:19:14 INFO - 'SHELL': '/bin/bash', 19:19:14 INFO - 'SHLVL': '1', 19:19:14 INFO - 'TERM': 'linux', 19:19:14 INFO - 'TMOUT': '86400', 19:19:14 INFO - 'USER': 'cltbld', 19:19:14 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1477447598.573229-1907932952', 19:19:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:19:14 INFO - '_': '/tools/buildbot/bin/python'} 19:19:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:19:14 INFO - Downloading/unpacking blobuploader==1.2.4 19:19:14 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 19:19:14 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 19:19:14 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 19:19:14 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 19:19:14 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 19:19:14 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 19:19:16 INFO - Downloading blobuploader-1.2.4.tar.gz 19:19:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:19:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:19:16 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 19:19:16 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 19:19:16 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 19:19:16 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 19:19:16 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 19:19:16 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 19:19:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:19:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:19:17 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 19:19:17 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 19:19:17 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 19:19:17 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 19:19:17 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 19:19:17 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 19:19:17 INFO - Downloading docopt-0.6.1.tar.gz 19:19:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:19:17 INFO - Installing collected packages: blobuploader, requests, docopt 19:19:17 INFO - Running setup.py install for blobuploader 19:19:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:19:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:19:17 INFO - Running setup.py install for requests 19:19:17 INFO - Running setup.py install for docopt 19:19:17 INFO - Successfully installed blobuploader requests docopt 19:19:17 INFO - Cleaning up... 19:19:17 INFO - Return code: 0 19:19:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:19:17 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')]} 19:19:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:19:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:19:17 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')]} 19:19:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:19:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:19:17 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 0x7f6ce3033f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27bc790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b9930>, '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 0x27ba830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27bacc0>, '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': '17051fcd5208b27b50bedfeb000001dd-1477447598.573229-1907932952', '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 19:19:17 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 19:19:17 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 19:19:17 INFO - Using env: {'DISPLAY': ':0', 19:19:17 INFO - 'HOME': '/home/cltbld', 19:19:17 INFO - 'LANG': 'en_US.UTF-8', 19:19:17 INFO - 'LANGUAGE': 'en_US:en', 19:19:17 INFO - 'LOGNAME': 'cltbld', 19:19:17 INFO - 'MAIL': '/var/mail/cltbld', 19:19:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:19:17 INFO - 'MOZ_NO_REMOTE': '1', 19:19:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:19:17 INFO - 'NO_EM_RESTART': '1', 19:19:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:19:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:19:17 INFO - 'PWD': '/builds/slave/test', 19:19:17 INFO - 'SHELL': '/bin/bash', 19:19:17 INFO - 'SHLVL': '1', 19:19:17 INFO - 'TERM': 'linux', 19:19:17 INFO - 'TMOUT': '86400', 19:19:17 INFO - 'USER': 'cltbld', 19:19:17 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1477447598.573229-1907932952', 19:19:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:19:17 INFO - '_': '/tools/buildbot/bin/python'} 19:19:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:19:18 INFO - Running setup.py (path:/tmp/pip-Imi2cG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:19:18 INFO - Running setup.py (path:/tmp/pip-ntXaAF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:19:18 INFO - Running setup.py (path:/tmp/pip-bZVnIN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:19:18 INFO - Running setup.py (path:/tmp/pip-Ec99ms-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:19:18 INFO - Running setup.py (path:/tmp/pip-Cb5diI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:19:18 INFO - Running setup.py (path:/tmp/pip-OAKwCE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:19:18 INFO - Running setup.py (path:/tmp/pip-tJrmqp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:19:18 INFO - Running setup.py (path:/tmp/pip-p0GdoF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:19:18 INFO - Running setup.py (path:/tmp/pip-7QauF2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:19:18 INFO - Running setup.py (path:/tmp/pip-iRR3jw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:19:18 INFO - Running setup.py (path:/tmp/pip-LDvdt5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:19:18 INFO - Running setup.py (path:/tmp/pip-Aif2Wq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:19:19 INFO - Running setup.py (path:/tmp/pip-zGzcHi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:19:19 INFO - Running setup.py (path:/tmp/pip-GKqe_j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:19:19 INFO - Running setup.py (path:/tmp/pip-wDtrIl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:19:19 INFO - Running setup.py (path:/tmp/pip-aXd2XT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:19:19 INFO - Running setup.py (path:/tmp/pip-NM2yMk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:19:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:19:19 INFO - Running setup.py install for manifestparser 19:19:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:19:19 INFO - Running setup.py install for mozcrash 19:19:19 INFO - Running setup.py install for mozdebug 19:19:19 INFO - Running setup.py install for mozdevice 19:19:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:19:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:19:19 INFO - Running setup.py install for mozfile 19:19:19 INFO - Running setup.py install for mozhttpd 19:19:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:19:20 INFO - Running setup.py install for mozinfo 19:19:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:19:20 INFO - Running setup.py install for mozInstall 19:19:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:19:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:19:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:19:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:19:20 INFO - Running setup.py install for mozleak 19:19:20 INFO - Running setup.py install for mozlog 19:19:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:19:20 INFO - Running setup.py install for moznetwork 19:19:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:19:20 INFO - Running setup.py install for mozprocess 19:19:20 INFO - Running setup.py install for mozprofile 19:19:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:19:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:19:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:19:20 INFO - Running setup.py install for mozrunner 19:19:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:19:20 INFO - Running setup.py install for mozscreenshot 19:19:20 INFO - Running setup.py install for moztest 19:19:21 INFO - Running setup.py install for mozversion 19:19:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:19:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:19:21 INFO - Cleaning up... 19:19:21 INFO - Return code: 0 19:19:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:19: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')]} 19:19:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:19:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:19: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')]} 19:19:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:19:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:19:21 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 0x7f6ce3033f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27bc790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b9930>, '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 0x27ba830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27bacc0>, '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': '17051fcd5208b27b50bedfeb000001dd-1477447598.573229-1907932952', '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 19:19:21 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 19:19:21 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 19:19:21 INFO - Using env: {'DISPLAY': ':0', 19:19:21 INFO - 'HOME': '/home/cltbld', 19:19:21 INFO - 'LANG': 'en_US.UTF-8', 19:19:21 INFO - 'LANGUAGE': 'en_US:en', 19:19:21 INFO - 'LOGNAME': 'cltbld', 19:19:21 INFO - 'MAIL': '/var/mail/cltbld', 19:19:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:19:21 INFO - 'MOZ_NO_REMOTE': '1', 19:19:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:19:21 INFO - 'NO_EM_RESTART': '1', 19:19:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:19:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:19:21 INFO - 'PWD': '/builds/slave/test', 19:19:21 INFO - 'SHELL': '/bin/bash', 19:19:21 INFO - 'SHLVL': '1', 19:19:21 INFO - 'TERM': 'linux', 19:19:21 INFO - 'TMOUT': '86400', 19:19:21 INFO - 'USER': 'cltbld', 19:19:21 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1477447598.573229-1907932952', 19:19:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:19:21 INFO - '_': '/tools/buildbot/bin/python'} 19:19:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:19:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:19:21 INFO - Running setup.py (path:/tmp/pip-Vigqic-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:19:21 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)) 19:19:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:19:21 INFO - Running setup.py (path:/tmp/pip-Up6aK4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:19:21 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)) 19:19:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:19:21 INFO - Running setup.py (path:/tmp/pip-jbQpB6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:19:21 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)) 19:19:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:19:21 INFO - Running setup.py (path:/tmp/pip-sYX9mZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:19:21 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)) 19:19:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:19:21 INFO - Running setup.py (path:/tmp/pip-yH7R1G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:19:21 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)) 19:19:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:19:21 INFO - Running setup.py (path:/tmp/pip-Wchws4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:19:21 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)) 19:19:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:19:21 INFO - Running setup.py (path:/tmp/pip-BgxIVe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:19:21 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)) 19:19:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:19:21 INFO - Running setup.py (path:/tmp/pip-TIiPsM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:19:21 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)) 19:19:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:19:22 INFO - Running setup.py (path:/tmp/pip-Bm4Oz4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:19:22 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)) 19:19:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:19:22 INFO - Running setup.py (path:/tmp/pip-9kL3DK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:19:22 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)) 19:19:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:19:22 INFO - Running setup.py (path:/tmp/pip-qJjHmm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:19:22 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)) 19:19:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:19:22 INFO - Running setup.py (path:/tmp/pip-JJuCr9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:19:22 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)) 19:19:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:19:22 INFO - Running setup.py (path:/tmp/pip-xPfH_i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:19:22 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)) 19:19:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:19:22 INFO - Running setup.py (path:/tmp/pip-EdTJDy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:19:22 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)) 19:19:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:19:22 INFO - Running setup.py (path:/tmp/pip-pS6xME-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:19:22 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)) 19:19:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:19:22 INFO - Running setup.py (path:/tmp/pip-KjROeO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:19:22 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)) 19:19:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:19:22 INFO - Running setup.py (path:/tmp/pip-2UqdQF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:19:22 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)) 19:19:22 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)) 19:19:22 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)) 19:19:22 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)) 19:19:22 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)) 19:19:22 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)) 19:19:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:19:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:19:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:19:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:19:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:19:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:19:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:19:24 INFO - Downloading blessings-1.6.tar.gz 19:19:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:19:24 INFO - Installing collected packages: blessings 19:19:24 INFO - Running setup.py install for blessings 19:19:24 INFO - Successfully installed blessings 19:19:24 INFO - Cleaning up... 19:19:25 INFO - Return code: 0 19:19:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:19:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:19:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:19:25 INFO - Reading from file tmpfile_stdout 19:19:25 INFO - Current package versions: 19:19:25 INFO - argparse == 1.2.1 19:19:25 INFO - blessings == 1.6 19:19:25 INFO - blobuploader == 1.2.4 19:19:25 INFO - docopt == 0.6.1 19:19:25 INFO - functools32 == 3.2.3-2 19:19:25 INFO - jsonschema == 2.5.1 19:19:25 INFO - manifestparser == 1.1 19:19:25 INFO - mozInstall == 1.12 19:19:25 INFO - mozcrash == 0.17 19:19:25 INFO - mozdebug == 0.1 19:19:25 INFO - mozdevice == 0.48 19:19:25 INFO - mozfile == 1.2 19:19:25 INFO - mozhttpd == 0.7 19:19:25 INFO - mozinfo == 0.9 19:19:25 INFO - mozleak == 0.1 19:19:25 INFO - mozlog == 3.4 19:19:25 INFO - moznetwork == 0.27 19:19:25 INFO - mozprocess == 0.23 19:19:25 INFO - mozprofile == 0.28 19:19:25 INFO - mozrunner == 6.12 19:19:25 INFO - mozscreenshot == 0.1 19:19:25 INFO - mozsystemmonitor == 0.3 19:19:25 INFO - moztest == 0.7 19:19:25 INFO - mozversion == 1.4 19:19:25 INFO - psutil == 3.1.1 19:19:25 INFO - requests == 1.2.3 19:19:25 INFO - wsgiref == 0.1.2 19:19:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:19:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:19:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:19:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:19:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:19:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:19:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:19:25 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 0x7f6ce3033f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27bc790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b9930>, '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 0x27ba830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27bacc0>, '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': '17051fcd5208b27b50bedfeb000001dd-1477447598.573229-1907932952', '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 19:19:25 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 19:19:25 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 19:19:25 INFO - Using env: {'DISPLAY': ':0', 19:19:25 INFO - 'HOME': '/home/cltbld', 19:19:25 INFO - 'LANG': 'en_US.UTF-8', 19:19:25 INFO - 'LANGUAGE': 'en_US:en', 19:19:25 INFO - 'LOGNAME': 'cltbld', 19:19:25 INFO - 'MAIL': '/var/mail/cltbld', 19:19:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:19:25 INFO - 'MOZ_NO_REMOTE': '1', 19:19:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:19:25 INFO - 'NO_EM_RESTART': '1', 19:19:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:19:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:19:25 INFO - 'PWD': '/builds/slave/test', 19:19:25 INFO - 'SHELL': '/bin/bash', 19:19:25 INFO - 'SHLVL': '1', 19:19:25 INFO - 'TERM': 'linux', 19:19:25 INFO - 'TMOUT': '86400', 19:19:25 INFO - 'USER': 'cltbld', 19:19:25 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1477447598.573229-1907932952', 19:19:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:19:25 INFO - '_': '/tools/buildbot/bin/python'} 19:19:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:19:25 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)) 19:19:25 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)) 19:19:25 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)) 19:19:25 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)) 19:19:25 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)) 19:19:25 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)) 19:19:25 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)) 19:19:25 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)) 19:19:25 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)) 19:19:25 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)) 19:19:25 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)) 19:19:25 INFO - Cleaning up... 19:19:25 INFO - Return code: 0 19:19:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:19:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:19:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:19:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:19:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:19:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:19:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:19:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6ce3033f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27bc790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b9930>, '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 0x27ba830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27bacc0>, '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': '17051fcd5208b27b50bedfeb000001dd-1477447598.573229-1907932952', '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 19:19:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 19:19:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:19:25 INFO - Using env: {'DISPLAY': ':0', 19:19:25 INFO - 'HOME': '/home/cltbld', 19:19:25 INFO - 'LANG': 'en_US.UTF-8', 19:19:25 INFO - 'LANGUAGE': 'en_US:en', 19:19:25 INFO - 'LOGNAME': 'cltbld', 19:19:25 INFO - 'MAIL': '/var/mail/cltbld', 19:19:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:19:25 INFO - 'MOZ_NO_REMOTE': '1', 19:19:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:19:25 INFO - 'NO_EM_RESTART': '1', 19:19:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:19:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:19:25 INFO - 'PWD': '/builds/slave/test', 19:19:25 INFO - 'SHELL': '/bin/bash', 19:19:25 INFO - 'SHLVL': '1', 19:19:25 INFO - 'TERM': 'linux', 19:19:25 INFO - 'TMOUT': '86400', 19:19:25 INFO - 'USER': 'cltbld', 19:19:25 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1477447598.573229-1907932952', 19:19:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:19:25 INFO - '_': '/tools/buildbot/bin/python'} 19:19:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:19:25 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:19:25 INFO - Cleaning up... 19:19:25 INFO - Return code: 0 19:19:25 INFO - Running post-action listener: _resource_record_post_action 19:19:25 INFO - Running post-action listener: _start_resource_monitoring 19:19:25 INFO - Starting resource monitoring. 19:19:25 INFO - [mozharness: 2016-10-26 02:19:25.751302Z] Finished create-virtualenv step (success) 19:19:25 INFO - [mozharness: 2016-10-26 02:19:25.751759Z] Running install step. 19:19:25 INFO - Running pre-action listener: _resource_record_pre_action 19:19:25 INFO - Running main action method: install 19:19:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:19:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:19:25 INFO - Reading from file tmpfile_stdout 19:19:25 INFO - Detecting whether we're running mozinstall >=1.0... 19:19:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:19:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:19:26 INFO - Reading from file tmpfile_stdout 19:19:26 INFO - Output received: 19:19:26 INFO - Usage: mozinstall [options] installer 19:19:26 INFO - Options: 19:19:26 INFO - -h, --help show this help message and exit 19:19:26 INFO - -d DEST, --destination=DEST 19:19:26 INFO - Directory to install application into. [default: 19:19:26 INFO - "/builds/slave/test"] 19:19:26 INFO - --app=APP Application being installed. [default: firefox] 19:19:26 INFO - mkdir: /builds/slave/test/build/application 19:19:26 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'] 19:19:26 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 19:19:43 INFO - Reading from file tmpfile_stdout 19:19:43 INFO - Output received: 19:19:43 INFO - /builds/slave/test/build/application/firefox/firefox 19:19:43 INFO - Running post-action listener: _resource_record_post_action 19:19:43 INFO - [mozharness: 2016-10-26 02:19:43.524977Z] Finished install step (success) 19:19:43 INFO - [mozharness: 2016-10-26 02:19:43.525219Z] Running run-tests step. 19:19:43 INFO - Running pre-action listener: _resource_record_pre_action 19:19:43 INFO - Running main action method: run_tests 19:19:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:19:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:19:43 INFO - Python 2.7.3 19:19:43 INFO - Return code: 0 19:19:43 INFO - grabbing minidump binary from tooltool 19:19:43 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')]} 19:19:43 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 0x27b9930>, '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 0x27ba830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27bacc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:19:43 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 19:19:43 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 19:19:43 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 19:19:43 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:19:43 INFO - Return code: 0 19:19:43 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:19:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:19:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:19:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:19:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:19:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bQ-IpGpZRZO_oq82AoOxaQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--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 19:19:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bQ-IpGpZRZO_oq82AoOxaQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-009 --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 19:19:43 INFO - Using env: {'DISPLAY': ':0', 19:19:43 INFO - 'HOME': '/home/cltbld', 19:19:43 INFO - 'LANG': 'en_US.UTF-8', 19:19:43 INFO - 'LANGUAGE': 'en_US:en', 19:19:43 INFO - 'LOGNAME': 'cltbld', 19:19:43 INFO - 'MAIL': '/var/mail/cltbld', 19:19:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:19:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:19:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:19:43 INFO - 'MOZ_NO_REMOTE': '1', 19:19:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:19:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:19:43 INFO - 'NO_EM_RESTART': '1', 19:19:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:19:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:19:43 INFO - 'PWD': '/builds/slave/test', 19:19:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:19:43 INFO - 'SHELL': '/bin/bash', 19:19:43 INFO - 'SHLVL': '1', 19:19:43 INFO - 'TERM': 'linux', 19:19:43 INFO - 'TMOUT': '86400', 19:19:43 INFO - 'USER': 'cltbld', 19:19:43 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1477447598.573229-1907932952', 19:19:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:19:43 INFO - '_': '/tools/buildbot/bin/python'} 19:19:43 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bQ-IpGpZRZO_oq82AoOxaQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--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 19:19:43 INFO - mozversion application_buildid: 20161025163003 19:19:43 INFO - mozversion application_changeset: b1b18f25c0ea69d9ee57c4198d577dfcd0129ce1 19:19:43 INFO - mozversion application_display_name: Nightly 19:19:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:19:43 INFO - mozversion application_name: Firefox 19:19:43 INFO - mozversion application_remotingname: firefox 19:19:43 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 19:19:43 INFO - mozversion application_vendor: Mozilla 19:19:43 INFO - mozversion application_version: 52.0a1 19:19:43 INFO - mozversion platform_buildid: 20161025163003 19:19:43 INFO - mozversion platform_changeset: b1b18f25c0ea69d9ee57c4198d577dfcd0129ce1 19:19:43 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 19:19:43 INFO - mozversion platform_version: 52.0a1 19:19:43 INFO - using testdate: 1477448383 19:19:43 INFO - actual date: 1477448383 19:19:43 INFO - starting webserver on 'localhost:46151' 19:19:43 INFO - SUITE-START | Running 2 tests 19:19:43 INFO - TEST-START | dromaeo_css 19:19:43 INFO - operating with platform_type : linux_ 19:19:43 INFO - Initialising browser for dromaeo_css test... 19:19:43 INFO - TEST-INFO | started process 23608 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPkmEx8/profile http://localhost:46151/getInfo.html) 19:19:47 INFO - PROCESS | 23608 | __metrics Screen width/height:1600/1200 19:19:47 INFO - PROCESS | 23608 | colorDepth:24 19:19:47 INFO - PROCESS | 23608 | Browser inner width/height: 1024/697 19:19:47 INFO - PROCESS | 23608 | __metrics 19:19:48 INFO - PROCESS | 23608 | 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" 19:19:48 INFO - PROCESS | 23608 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:19:49 INFO - TEST-INFO | 23608: exit 0 19:19:49 INFO - Browser initialized. 19:19:49 INFO - Running cycle 1/1 for dromaeo_css test... 19:19:49 INFO - TEST-INFO | started process 23691 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPkmEx8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:20:02 INFO - PROCESS | 23691 | RSS: Main: 171544576 19:20:02 INFO - PROCESS | 23691 | 19:20:53 INFO - PROCESS | 23691 | 1477448453481 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] 19:23:05 INFO - PROCESS | 23691 | Cycle 1(1): loaded http://localhost:46151/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46151/tests/dromaeo/cssquery-ext.html) 19:23:06 INFO - PROCESS | 23691 | RSS: Main: 308420608 19:23:06 INFO - PROCESS | 23691 | 19:26:09 INFO - PROCESS | 23691 | Cycle 1(1): loaded http://localhost:46151/tests/dromaeo/cssquery-ext.html (next: http://localhost:46151/tests/dromaeo/cssquery-jquery.html) 19:26:09 INFO - PROCESS | 23691 | RSS: Main: 281382912 19:26:09 INFO - PROCESS | 23691 | 19:29:11 INFO - PROCESS | 23691 | Cycle 1(1): loaded http://localhost:46151/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46151/tests/dromaeo/cssquery-mootools.html) 19:29:12 INFO - PROCESS | 23691 | RSS: Main: 216268800 19:29:12 INFO - PROCESS | 23691 | 19:32:14 INFO - PROCESS | 23691 | Cycle 1(1): loaded http://localhost:46151/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46151/tests/dromaeo/cssquery-prototype.html) 19:32:15 INFO - PROCESS | 23691 | RSS: Main: 258842624 19:32:15 INFO - PROCESS | 23691 | 19:35:17 INFO - PROCESS | 23691 | Cycle 1(1): loaded http://localhost:46151/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46151/tests/dromaeo/cssquery-yui.html) 19:35:18 INFO - PROCESS | 23691 | RSS: Main: 216772608 19:35:18 INFO - PROCESS | 23691 | 19:38:21 INFO - PROCESS | 23691 | Cycle 1(1): loaded http://localhost:46151/tests/dromaeo/cssquery-yui.html (next: http://localhost:46151/tests/dromaeo/cssquery-dojo.html) 19:38:21 INFO - PROCESS | 23691 | RSS: Main: 300814336 19:38:21 INFO - PROCESS | 23691 | 19:38:21 INFO - PROCESS | 23691 | __start_tp_report 19:38:21 INFO - PROCESS | 23691 | _x_x_mozilla_page_load 19:38:21 INFO - PROCESS | 23691 | _x_x_mozilla_page_load_details 19:38:21 INFO - PROCESS | 23691 | |i|pagename|runs| 19:38:21 INFO - PROCESS | 23691 | |0;dojo.html;3114.2058775012374;3146.9370612587736;3153.9526907096397;3187.617485901689;3200.839958002101;5232.790688372461;5350.678959262447;5370.489803468669;5443.755031023604;5446;5386.3536375634885;5387.595930305223;5396.703181325026;5399.757010934508;5401.135818269077;4844;4868.464468908417;4887.486813884527;4906.754662266891;4982.875428114308;4949.925751113737;5022.84931452057;5024.472430394792;5027.622928280375;5028.019536190444;4926.605871530287;4933.358663373757;4954.851354459372;4973.079980203655;5019.899602007976;4994.400671919357;5004.149294619887;5010.348654674869;5011.749412529359;5071.290019397287;4813.446453657839;4834.975825120887;4852.4662287148385;4920.065187614342;4927.334809800667;5320.441353657849;5322.0686379883755;5332.253484512172;5343.706096164709;5406.567474602022;5655.943440565583;5704.714764261812;5708.1437784332265;5710.885782284331;5717.285339332583;5704.600677952545;5759.510441612468;5799.797007104731;5813.389594092644;5863.237779088691;5337.01265265927;5372.677639341652;5399.2980912481125;5408.215808707755;5416.891662166735;5910.113482977502;5915.704214789243;5919.585629005928;5920.674362910081;5977.790777322773;5676.971615141981;5685.232493613309;5686;5687.374388817227;5694.857628559319;5639.3232812062;5651.943480565142;5655.575831812631;5699.145128230799;5769.711514424262;5699.031164702011;5755.510781583528;5758.280214973129;5762.250907382014;5765.913511297334;5619.522340601095;5625.437456254342;5643.463870932255;5774.076147816413;5788.623739456922;4378.978105109518;4380.299152135643;4380.496242932039;4425.579569940851;4434.889127771831;3912.9608703912595;3937.8031098445535;3943.8619648312747;3970.285348637215;3976.6023397660583;5380.811671591476;5393.379761327419;5417.539509141767;5433.510984011379;5435.347758268954;5793.188953546507;5840.415958404125;5851.707414629252;5903.734331955073;5904.232449781501;5453.318335208099;5490.80782172622;5500.312460942382;5502.394736578973;5502.807401741;4936.925946110811;4970;5049.192129259301;5058.3929928408825;5118.181091025418;5959.76160953557;6008.03871380577;6023.1868697726995;6046.213992181164;6122.020476723703;5851.034579294539;5862.765489380377;5863.296404431496;5868;5871.911921321098;5863.560232982458;6031.698415079316;6048.576599637983;6049.18336024631;6050.788222412194;5586.13414920688;5671.688057156731;5738.081906894877;5740.540756739534;5818.040023396092;5794.420557944172;5854.619449735754;5858.677772722541;5859.414058594107;5860.09168578871;5706.229658995982;5709.400512946081;5712.171735098304;5712.5429965601825;5716.171155182558;5498.725063746717;5508.504234618904;5510.1459273812625;5571.721413929368;5578.414266502121;5567.7494512747835;5583.050881350261;5597.3003374578175;5603.663780173202;5664.745086471036;5639.7744090237575;5640.294963129609;5640.520555752807;5642.774289028557;5644.068728659725;5395.946040539544;5413.350397952271;5464.043792336404;5525.585581081355;5581.74882130297 19:38:21 INFO - PROCESS | 23691 | |1;ext.html;549.8844101110233;577.5841394196179;610.9327973922867;621.3351713666376;641.0736485778052;31130.377392452167;42331.15337693248;42983.57016429835;43107.568924310784;46037.769811150894;44246;44736.776316118456;44742.32886506705;44768.77615611917;44848.77575612126;7948.682052717913;8852.734417967455;9015.098490150966;9022.954885225565;9026.23277021454;7893;10564.577416903314;10821.67534973952;10825.891741082607;11181.273217240894;10903.236773425824;10922.836157457645;10978.890211097867;10979.505922233519;10982.121430285599;10799.082078023339;10865.674029779118;10872.67381978542;10874.293170943864;10884.129269658448;10649;10708.732281692943;10729.517171727213;10732.839007414896;10734.892651073467;40890.59109408897;41123;41206;41313.38029929553;41427.7928610355;3641.4719865619336;3702.796346200958;3806.7335286529956;3937.7243592948507;4019.115794525229;31258.687413125805;31265.218369540944;32264.5160322593;32383.190420239447;33321.16697082568;4324.82700691972;4374.272162495797;4430.977845110786;4450.465944086698;4539.984846909217;225620;225969;226611;227840;228451.8577407119;30759.38481230363;31621.841890790398;31636.683633163375;55743;56104.719476403174;35997.46003809945;36205.45691814625;36248.81875590658;36383.636163638555;36461.81769091191;13551.25468099264;13648.24934628605;13656.453741850413;13657.112287701466;13657.385417656229;10668.519916603771;10749.462526873625;10836.187285953585;11087.889121108847;11169.944150279196;8067.072286686989;8119.3910456715985;8132.5933703314595;8198.057223419264;8246.134155913544;3181.6818318168;3214.5017522284083;3230.644629090798;3232.111169428426;3253.4957081652383;1007.2043085962008;1010.4177554789143;1013.1843865688045;1019.8623185869812;1119.082352470966;30383.544246836314;31727.682723172933;31877.20306992344;31877.362452750815;32503;1100.7688385438987;1111.0056499432962;1116.1182665694173;1117.5473933057124;1143.7083543696303;16258.349666013228;16674.33302667904;16678.499645010426;16680.49958501247;16926.83073169277;516817;521895;524663;525341;527562;57217.14174287389;58073.128903066485;58107;58129.128063079086;58144;1126.7802778458286;1192.9403529823473;1260.8802163794426;1264.5574049082932;1275.3686924972199;29896.103116906528;32106;32361.35277294488;34629;34902.65097348994;54225.45774542204;54726;54751.452485474634;54763.17855232095;54794.726026369615;423937;427069;427924;430592;431638;27274.318142046606;27620.585691214244;27878.58182127229;28251.57622635621;28269.15192544227;45549.31676024796;45828.81638673878;46742.298865517725;46972;47823.52176478191;38112.809435952644;39613.40579891246;39955.80022099871;40932;42125.1574968505;38567.228655426174;39004.80497597494;39533.604663954146;40165.397519036655;40621.18757624772;40109.39835902405;40142.799286003385;40147.197056059296;40961;41602.16795664009;32623.34753304968;34920;35406.645933540334;36203.456948146326;36299.09252268715;28267.85866070739;28590;28851.56722649204;28851.855740721163;28890.855545722137 19:38:21 INFO - PROCESS | 23691 | |2;jquery.html;364.4696965914593;369.9963000369999;376.3601876809424;377.9300829346571;393.8188433320672;14056.71886562268;18098.276068957242;18397.81602183978;18485.722714159263;19635;17560;18386.540336491562;19129.426117216506;19209.231630734754;19313.0343482826;5483.616146869721;5748.626339287933;5764.625299355528;5768.250127483442;5774.913376299359;5452.754626041818;5596.832095037135;5604.943950560483;5639;5704.8859022819515;5593.692346920918;5635.520980716644;5637.689927054011;5642.097264437691;5642.661440313574;5504.972475137639;5632.859178520529;5635.464630860082;5721.141828725683;5749.885002299972;5601.383847776741;5639.041362968264;5645.717714114319;5648.265725455705;5652.463016013472;13756.65608359789;13806.17162970225;14017.85982140186;14199.645008874757;14226.217558034305;2293.7362203346497;2383.749706280833;2459.9914035245642;2721.2516557946524;2816.746492815636;8989.190972812414;9333.833270841145;10608.09831164352;10610.62862799806;10680;1867.9066046697747;1920.6350793349218;1922.432882299725;1926.1139875657213;1955.1397385150487;76387.61806190989;79963.60018199871;81479.18520814835;83609;85453;10487.895121048692;10511.26421150512;10599.470026498644;10872.836907446395;10893.400862952614;14901.254937253094;14933.925330373497;14936.477223297132;14944.252787360589;14956.401743930339;7568.4323675723435;7681.500702454435;7827.25641064098;7844.254795794391;7886.132525422199;7189.388901943394;7202.20775714671;7242.420606351479;7390.22402647725;7436.256374362521;4541.137183935108;4541.909161816811;4588.862334129982;4653.95346046542;4709.222978208626;1895.848332133426;1920.5102698811993;1949.6100779844087;1956.735840661521;1988.860779745404;805.295366554265;930.3255140023429;970.7136394763562;977.8386566216636;987.4026214140486;18196;19070;19095;19117.522061948563;19312.71030934537;899.7705585075895;931.5575101826578;937.2267878999852;959.1176117971482;970.9805803883883;9893.406395616286;10580.312279701795;10585.788284234426;10637.255392122477;10716.678499645022;349439;353355;448085;449588;452714;90723;93774.53112734393;95151.52424237835;95859.52070239604;97266.51366743121;1006.1246715357686;1038.402918321968;1065.280935368623;1067.2635881241918;1077.8167711489066;17343;17640.15365326136;18146.45560633183;18191.727124093413;18284.908575457568;29035.305818000994;43501.12997739964;44159;44223.33664995092;45679.543204567526;58660.706696466244;58750;58903;61075.38924610697;61493;8158.3473322132895;8190.549519776469;8223.17768223173;8534.402591818513;8718.084601117045;9282.675106371245;12428.13003089775;12866.614001579968;13242.404091815699;13395.397207125898;11153.163512736415;11598.130140239684;11710.70723231926;11734.765304694029;11948.701282468008;10947.616833410792;10994.505247264053;11368.431578420881;11424.257423267461;11515.769684606094;11742.29546227195;11802.94098529502;11905.16663833558;11968.880311197125;12061.75876482483;8332.583370831313;8472.618732156945;8523.275521580736;8674.609642565974;8697.739067827975;10314.278000540191;11550.826737598774;11627.244229125079;11684.941575292069;12012.75974480488 19:38:21 INFO - PROCESS | 23691 | |3;mootools.html;1279.1941077121412;1447.2908274945278;1482.9258537073147;1577.8974366666166;1794.8025717171117;7424.4060475162;8308.2107199816;8500.872486912685;8529.573521323931;8832.867506987384;8599.91400085999;8628.050914399411;8674.306055515559;8691.217790398863;8700;2302.689136966509;2328.988355058231;2331.393837602219;2333.5449587330477;2337.3805941425535;2268.7164104486938;2307.0195167053935;2320.791128798408;2324.662923876037;2334.5914464968564;2273.863568185906;2290.393045842853;2295.150794206146;2323.9302820915314;2358.2453614843257;2207.128184367166;2236.206146817881;2239.484918468753;2241.8094461970754;2243.1588154442084;2195.5169862630196;2208.9558208835892;2214.2139540463063;2216.445888527868;2218.889055547232;8514;8593;8627.482351058956;8681.262092722127;8692.391532592721;5166.844994650167;5338.27933229013;5340;5366.221897824833;5367.704776237305;3296.126526470487;3411.8635254590035;3594.2991116732246;3639.5632524097014;3644.9817750911343;1119.7928383249125;1125.7861006408757;1127.8815724348908;1140.2930183286333;1152.2337645465755;11959.282443053444;12016.279023258632;12021.278723276631;12040.638780836589;12056.698582535506;4146.813393397304;4343.500497442771;4428.6678499112695;4436.6672499562665;4460.0633866887665;9431.009743976922;9452.10205030521;9454.24366050728;9463.242940564738;9467.526623668928;5223.973880130575;5225.686458812484;5225.895482090413;5230.92153617696;5236.423993360727;4096.528899176633;4103.117829666636;4162.292410290258;4380.518143004267;4897.995910838341;3539.2744487380023;3574.195805943694;3705.7776533408082;3710.3692372296773;3723.3298006359114;1128.1933417606451;1134.3704244144578;1135.5911871726173;1146.2434793036723;1172.5485688010178;814.5927036481759;860;930.7486978515898;935.2050756856618;957.3107362698846;5500.862478438071;5708.571857110734;5781.075027995585;5868.413158684098;5896.410358964069;864.9481031138151;898.9685361012333;930.3627015494408;940.6143481172824;987.3236832769576;3804.7146464014754;3890;3908.2378936107184;3931.410288456754;3941.467901833273;10616.681499555025;11002.724931876766;11018.889811101946;11030.613928512625;11034.062104721188;10880.292780969212;10920.726981825359;10921.399323037309;10929.398883061507;10932.508037138188;7701.191374905667;8012.0786109596975;8012.479188852706;8171.632276547451;8199.22107399796;5606.831795046155;5627.606067575231;5765.798197063083;5827.4172582741385;5903.173555702119;9890.703278901645;9928.305018648625;9936.354136981074;9943.453110079015;9947.552360143665;8884.911150888409;9150.313726470407;9482.620695172116;9856.260780441638;10035.799284014132;7549.773506794805;7662.923370766221;7699.461037727306;7715.961420192863;7828.5694286812495;8399.076101628938;8420.410571260198;8465.91534084676;8466.195711407407;8468.872966905377;7512.699492020258;7680.231976802275;7696.538207707556;7750.7674769756995;7917;7380.483366164317;7450.217727138573;7499;7547.924520754942;7660.923390766021;6613.074169616161;6750.459963202834;6761.932380676327;6762.188537375349;6763.492738044764;4778.211595086772;4813.15769740301;4894.755262236945;4978.4025916890205;5035.219540971156;4923.113839508779;5020.121478741133;5160.48395160481;5173.844784656466;5269.1569348903995 19:38:21 INFO - PROCESS | 23691 | |4;prototype.html;325.8582516605275;332.55271659617813;337.16551534950986;338.0534503390506;342.6333822809595;5105;5255.76349064292;5296.152615581508;5348.197770334447;5355.678659280446;5123.487651234875;5218.6953261684575;5242.18746094356;5247.973760131194;5265.842024739254;4166.291730405823;4170.374443833419;4173.373993900909;4175.394567787669;4184.518780340261;4005.1175947304864;4127.379114262435;4178.080822219122;4185.937210941838;4192.182524407742;4049.797510124482;4053.6351728344443;4062.2078694654556;4090.6931980101613;4099.405586190001;4042.9797851010703;4050.460824886539;4053.858114965962;4066.125782956649;4089.5705950875026;3615.493830863681;3619.94570081449;3628.76413033152;3629.800360980145;3636.327279453283;5009.899802003976;5100.872478188038;5110.770015349318;5133.974330128362;5183.159978207757;4641.257398816207;4649.860504184846;4657.836975705868;4668.276417155346;4669.976650116761;5440.591955603306;5445.863853403696;5455.536279416255;5468.37113731918;5492.231087647732;3735.7571757835653;3928.410738389236;3928.9214215715524;3946.940795888064;3953.7627742335553;5692.316921969349;5730.853829234128;5735.4551317624755;5741.598088133791;5751.482366587027;4046.251443482965;4047.838086476567;4065.6747460203114;4077.918441631151;4082.897927551835;3856.5179352580926;3999.960000399959;4003.979980100081;4037.2934736421007;4128.793560321972;4591.517890621503;4614.238650622609;4615.192341340252;4619.745913974696;4640.187967105743;5531.25328080712;5537.975474537224;5548.805791797267;5568.415316391802;5584.525315348241;1306.5753630070265;1310.4037662863375;1382.3710211853584;1397.6785339372002;1400.7603271105145;881.6914080072052;881.8368601808686;896.2919293757989;897.3583887520455;899.4288626722079;4655.604273636711;4679.204535229019;4715.104130215248;4719.669623126349;4724.189107481044;4951.603871690256;4955.40535135786;4961.305417241589;4981.2030075187795;5009.7244651544515;4499.3251012347755;4720.95279047212;4771.260454629538;4783.23468245086;4791.778096585348;2593.338698631837;2626.7898568114506;2636.762691357787;2642.894284228648;2649.026475275893;5035.136999310205;5044.571211446994;5072.721000344943;5075.365579302587;5081.3140226069745;5030.490852744162;5078.162103252996;5091.766728127665;5115.753924242869;5380.336733317034;5834.970825145847;5849.883002339844;5859.384764599741;5859.414058594191;5871.207387002785;5660.349059858005;5663.348714897839;5667.971660141673;5696.316442026983;5770;5526.861828454321;5585.776568937197;5648.23748793924;5649.519790817662;5736.913946290725;5825.912611310749;5837.3870743571315;5840.561957853093;5851.707414629337;5854;4060.6954478413645;4088.34586466164;4093.263212621757;4100.774457404752;4106.691998100095;5418.295621569171;5580.748866301107;5672.319321681424;5721.170430287501;5724.713764311685;5315.229291752751;5402.783888644411;5503.596582871342;5520.972395137998;5530.004599172187;5473.425290344457;5514.5864060194845;5517.282753242213;5525.917111243415;5554.694491802989;5224.555912747307;5432.619716619799;5459.890802183854;5476.507114359727;5494.450554944474;5533.944660553504;5549.139883318092;5560.97219513916;5562.2212890196215;5571.582131340085;5435;5438.293021907127;5438.428964958781;5463.7814487420055;5465.398806131402 19:38:21 INFO - PROCESS | 23691 | |5;yui.html;748.7940816275524;752.2139364364239;780.9765707028791;788.0385929166416;798.3413683710938;12338.938305308473;13147;13170.934145329284;13172.143810652313;13209.801852972188;14319.427222911097;14445.494407695733;14460.132392056485;14478.203698796562;14487.275636218174;799.73608709126;803.1005274093023;807.4953154278576;807.7213361390311;810.7648781853255;797.6889013284823;804.2440106300088;812.2405550810012;812.305478815613;812.6058861452191;849.889514363132;849.961751721174;850.1583432401909;850.3494826457764;850.6044689219511;839.4585492357395;839.5718183726283;840.8276303357796;841.0706169682474;842.3766412854504;625.6590158363703;626.495670984857;626.6240255846501;626.971786269619;627.7708636347746;13592.728145437135;13626.93186534061;13664.590062298146;13680.452781888813;13692.931535342359;12087.697807554794;12127.272363658121;12157.209781364183;12280.815787763191;13236.735265294641;10616.893831061669;10684.626038088629;10859.511321990529;10958.561657533768;11173.162012849069;3687.797171155585;3754.1740817020213;3855.4024126260474;3936.055346716796;3943.842246310144;62364.68817655928;63946.680266598836;64066.67966660137;64077;67515.3248467509;9649.903500965042;9668.516574171263;9751.414915105117;9810.215182785503;9987.350822196535;18647.533811654816;18882.90558547226;19109.426717198505;19155.425337239903;19245.615087698166;8189.181081891882;8201.42590018693;8310.626021829032;8367.916320836835;8421.326293896474;4526.162659907927;4779.641526885497;4801.927971080437;4871.3667223261455;4905.3132561441425;3431.330890476333;3535.4696795480368;3559.4482855157494;3564.697000754965;3568.839402226906;586.414077913564;587.0812178939946;599.3886236039302;611.5902345428574;611.9082137679384;539.5009616105166;625.3277726443999;765.6286700950035;771.594912670841;783.2050468774198;8835.823283534293;9795.510224488748;10039.498025098716;10160.796784064278;10218.795624087477;709.9609521476265;715.7459102018812;716.7598854383735;728.8214387475102;738.1179490508898;4485.596296333346;4859.392575928009;4877.975610121926;4886;4909.533594308535;82525;84387;87484;89342.55328723315;91179.54410228039;72662.27337726555;73676;75207;76401.23598764052;78946.6052669733;69014.16900816894;70317.64841175864;70458.64770676114;71307.6434617834;74315;9342.299327550325;9720.611175552898;9720.611175552898;9738.513074346112;9743.009181449559;46992;47833.52166478291;48987.75506122447;48989.2651610219;49042.75478622727;61484;62277.68861155665;67453.3254667447;68125.9781103274;69395.65302173457;11811;11863.228890122115;11925.403729813648;12254.080943929419;12360.938195308965;12768.170068945488;13043.869561304266;13164.802527961896;13172.275524845842;13390;12248.755024899274;12477.812832807696;13032.348382581024;13266.80099798523;13416.463341466231;11325.490352933974;11695.415229238333;11797.410129493663;11823.645290641294;11987.460564274454;12005.939970300093;12241.20432171906;12337.753244935231;12539.74920501603;12584.489861216713;9898;10161.847572286273;10524.842127368249;10745.516451759533;10964.122870170208;10135.341202821794;10276.434796085989;10375.481225938522;10413.687589372332;10504.317219380715 19:38:21 INFO - PROCESS | 23691 | __end_tp_report 19:38:21 INFO - PROCESS | 23691 | __start_cc_report 19:38:21 INFO - PROCESS | 23691 | _x_x_mozilla_cycle_collect,1269 19:38:21 INFO - PROCESS | 23691 | __end_cc_report 19:38:21 INFO - PROCESS | 23691 | __startTimestamp1477449501351__endTimestamp 19:38:21 INFO - PROCESS | 23691 | 19:38:21 INFO - PROCESS | 23691 | ------- Summary: start ------- 19:38:21 INFO - PROCESS | 23691 | Number of tests: 6 19:38:21 INFO - PROCESS | 23691 | 19:38:21 INFO - PROCESS | 23691 | [#0] dojo.html Cycles:165 Average:5369.68 Median:5567.75 stddev:602.89 (10.8%) stddev-sans-first:578.20 19:38:21 INFO - PROCESS | 23691 | Values: 3114.2 3146.9 3154.0 3187.6 3200.8 5232.8 5350.7 5370.5 5443.8 5446.0 5386.4 5387.6 5396.7 5399.8 5401.1 4844.0 4868.5 4887.5 4906.8 4982.9 4949.9 5022.8 5024.5 5027.6 5028.0 4926.6 4933.4 4954.9 4973.1 5019.9 4994.4 5004.1 5010.3 5011.7 5071.3 4813.4 4835.0 4852.5 4920.1 4927.3 5320.4 5322.1 5332.3 5343.7 5406.6 5655.9 5704.7 5708.1 5710.9 5717.3 5704.6 5759.5 5799.8 5813.4 5863.2 5337.0 5372.7 5399.3 5408.2 5416.9 5910.1 5915.7 5919.6 5920.7 5977.8 5677.0 5685.2 5686.0 5687.4 5694.9 5639.3 5651.9 5655.6 5699.1 5769.7 5699.0 5755.5 5758.3 5762.3 5765.9 5619.5 5625.4 5643.5 5774.1 5788.6 4379.0 4380.3 4380.5 4425.6 4434.9 3913.0 3937.8 3943.9 3970.3 3976.6 5380.8 5393.4 5417.5 5433.5 5435.3 5793.2 5840.4 5851.7 5903.7 5904.2 5453.3 5490.8 5500.3 5502.4 5502.8 4936.9 4970.0 5049.2 5058.4 5118.2 5959.8 6008.0 6023.2 6046.2 6122.0 5851.0 5862.8 5863.3 5868.0 5871.9 5863.6 6031.7 6048.6 6049.2 6050.8 5586.1 5671.7 5738.1 5740.5 5818.0 5794.4 5854.6 5858.7 5859.4 5860.1 5706.2 5709.4 5712.2 5712.5 5716.2 5498.7 5508.5 5510.1 5571.7 5578.4 5567.7 5583.1 5597.3 5603.7 5664.7 5639.8 5640.3 5640.5 5642.8 5644.1 5395.9 5413.4 5464.0 5525.6 5581.7 19:38:21 INFO - PROCESS | 23691 | 19:38:21 INFO - PROCESS | 23691 | [#1] ext.html Cycles:180 Average:54633.54 Median:35702.05 stddev:109635.82 (307.1%) stddev-sans-first:109868.18 19:38:21 INFO - PROCESS | 23691 | Values: 549.9 577.6 610.9 621.3 641.1 31130.4 42331.2 42983.6 43107.6 46037.8 44246.0 44736.8 44742.3 44768.8 44848.8 7948.7 8852.7 9015.1 9023.0 9026.2 7893.0 10564.6 10821.7 10825.9 11181.3 10903.2 10922.8 10978.9 10979.5 10982.1 10799.1 10865.7 10872.7 10874.3 10884.1 10649.0 10708.7 10729.5 10732.8 10734.9 40890.6 41123.0 41206.0 41313.4 41427.8 3641.5 3702.8 3806.7 3937.7 4019.1 31258.7 31265.2 32264.5 32383.2 33321.2 4324.8 4374.3 4431.0 4450.5 4540.0 225620.0 225969.0 226611.0 227840.0 228451.9 30759.4 31621.8 31636.7 55743.0 56104.7 35997.5 36205.5 36248.8 36383.6 36461.8 13551.3 13648.2 13656.5 13657.1 13657.4 10668.5 10749.5 10836.2 11087.9 11169.9 8067.1 8119.4 8132.6 8198.1 8246.1 3181.7 3214.5 3230.6 3232.1 3253.5 1007.2 1010.4 1013.2 1019.9 1119.1 30383.5 31727.7 31877.2 31877.4 32503.0 1100.8 1111.0 1116.1 1117.5 1143.7 16258.3 16674.3 16678.5 16680.5 16926.8 516817.0 521895.0 524663.0 525341.0 527562.0 57217.1 58073.1 58107.0 58129.1 58144.0 1126.8 1192.9 1260.9 1264.6 1275.4 29896.1 32106.0 32361.4 34629.0 34902.7 54225.5 54726.0 54751.5 54763.2 54794.7 423937.0 427069.0 427924.0 430592.0 431638.0 27274.3 27620.6 27878.6 28251.6 28269.2 45549.3 45828.8 46742.3 46972.0 47823.5 38112.8 39613.4 39955.8 40932.0 42125.2 38567.2 39004.8 39533.6 40165.4 40621.2 40109.4 40142.8 40147.2 40961.0 41602.2 32623.3 34920.0 35406.6 36203.5 36299.1 28267.9 28590.0 28851.6 28851.9 28890.9 19:38:21 INFO - PROCESS | 23691 | 19:38:21 INFO - PROCESS | 23691 | [#2] jquery.html Cycles:180 Average:26502.20 Median:373.18 stddev:68872.27 (18455.6%) stddev-sans-first:69037.51 19:38:21 INFO - PROCESS | 23691 | Values: 364.5 370.0 376.4 377.9 393.8 14056.7 18098.3 18397.8 18485.7 19635.0 17560.0 18386.5 19129.4 19209.2 19313.0 5483.6 5748.6 5764.6 5768.3 5774.9 5452.8 5596.8 5604.9 5639.0 5704.9 5593.7 5635.5 5637.7 5642.1 5642.7 5505.0 5632.9 5635.5 5721.1 5749.9 5601.4 5639.0 5645.7 5648.3 5652.5 13756.7 13806.2 14017.9 14199.6 14226.2 2293.7 2383.7 2460.0 2721.3 2816.7 8989.2 9333.8 10608.1 10610.6 10680.0 1867.9 1920.6 1922.4 1926.1 1955.1 76387.6 79963.6 81479.2 83609.0 85453.0 10487.9 10511.3 10599.5 10872.8 10893.4 14901.3 14933.9 14936.5 14944.3 14956.4 7568.4 7681.5 7827.3 7844.3 7886.1 7189.4 7202.2 7242.4 7390.2 7436.3 4541.1 4541.9 4588.9 4654.0 4709.2 1895.8 1920.5 1949.6 1956.7 1988.9 805.3 930.3 970.7 977.8 987.4 18196.0 19070.0 19095.0 19117.5 19312.7 899.8 931.6 937.2 959.1 971.0 9893.4 10580.3 10585.8 10637.3 10716.7 349439.0 353355.0 448085.0 449588.0 452714.0 90723.0 93774.5 95151.5 95859.5 97266.5 1006.1 1038.4 1065.3 1067.3 1077.8 17343.0 17640.2 18146.5 18191.7 18284.9 29035.3 43501.1 44159.0 44223.3 45679.5 58660.7 58750.0 58903.0 61075.4 61493.0 8158.3 8190.5 8223.2 8534.4 8718.1 9282.7 12428.1 12866.6 13242.4 13395.4 11153.2 11598.1 11710.7 11734.8 11948.7 10947.6 10994.5 11368.4 11424.3 11515.8 11742.3 11802.9 11905.2 11968.9 12061.8 8332.6 8472.6 8523.3 8674.6 8697.7 10314.3 11550.8 11627.2 11684.9 12012.8 19:38:21 INFO - PROCESS | 23691 | 19:38:21 INFO - PROCESS | 23691 | [#3] mootools.html Cycles:180 Average:5646.05 Median:5198.91 stddev:3222.26 (62.0%) stddev-sans-first:3214.59 19:38:21 INFO - PROCESS | 23691 | Values: 1279.2 1447.3 1482.9 1577.9 1794.8 7424.4 8308.2 8500.9 8529.6 8832.9 8599.9 8628.1 8674.3 8691.2 8700.0 2302.7 2329.0 2331.4 2333.5 2337.4 2268.7 2307.0 2320.8 2324.7 2334.6 2273.9 2290.4 2295.2 2323.9 2358.2 2207.1 2236.2 2239.5 2241.8 2243.2 2195.5 2209.0 2214.2 2216.4 2218.9 8514.0 8593.0 8627.5 8681.3 8692.4 5166.8 5338.3 5340.0 5366.2 5367.7 3296.1 3411.9 3594.3 3639.6 3645.0 1119.8 1125.8 1127.9 1140.3 1152.2 11959.3 12016.3 12021.3 12040.6 12056.7 4146.8 4343.5 4428.7 4436.7 4460.1 9431.0 9452.1 9454.2 9463.2 9467.5 5224.0 5225.7 5225.9 5230.9 5236.4 4096.5 4103.1 4162.3 4380.5 4898.0 3539.3 3574.2 3705.8 3710.4 3723.3 1128.2 1134.4 1135.6 1146.2 1172.5 814.6 860.0 930.7 935.2 957.3 5500.9 5708.6 5781.1 5868.4 5896.4 864.9 899.0 930.4 940.6 987.3 3804.7 3890.0 3908.2 3931.4 3941.5 10616.7 11002.7 11018.9 11030.6 11034.1 10880.3 10920.7 10921.4 10929.4 10932.5 7701.2 8012.1 8012.5 8171.6 8199.2 5606.8 5627.6 5765.8 5827.4 5903.2 9890.7 9928.3 9936.4 9943.5 9947.6 8884.9 9150.3 9482.6 9856.3 10035.8 7549.8 7662.9 7699.5 7716.0 7828.6 8399.1 8420.4 8465.9 8466.2 8468.9 7512.7 7680.2 7696.5 7750.8 7917.0 7380.5 7450.2 7499.0 7547.9 7660.9 6613.1 6750.5 6761.9 6762.2 6763.5 4778.2 4813.2 4894.8 4978.4 5035.2 4923.1 5020.1 5160.5 5173.8 5269.2 19:38:21 INFO - PROCESS | 23691 | 19:38:21 INFO - PROCESS | 23691 | [#4] prototype.html Cycles:180 Average:4543.92 Median:5076.76 stddev:1343.34 (26.5%) stddev-sans-first:1309.26 19:38:21 INFO - PROCESS | 23691 | Values: 325.9 332.6 337.2 338.1 342.6 5105.0 5255.8 5296.2 5348.2 5355.7 5123.5 5218.7 5242.2 5248.0 5265.8 4166.3 4170.4 4173.4 4175.4 4184.5 4005.1 4127.4 4178.1 4185.9 4192.2 4049.8 4053.6 4062.2 4090.7 4099.4 4043.0 4050.5 4053.9 4066.1 4089.6 3615.5 3619.9 3628.8 3629.8 3636.3 5009.9 5100.9 5110.8 5134.0 5183.2 4641.3 4649.9 4657.8 4668.3 4670.0 5440.6 5445.9 5455.5 5468.4 5492.2 3735.8 3928.4 3928.9 3946.9 3953.8 5692.3 5730.9 5735.5 5741.6 5751.5 4046.3 4047.8 4065.7 4077.9 4082.9 3856.5 4000.0 4004.0 4037.3 4128.8 4591.5 4614.2 4615.2 4619.7 4640.2 5531.3 5538.0 5548.8 5568.4 5584.5 1306.6 1310.4 1382.4 1397.7 1400.8 881.7 881.8 896.3 897.4 899.4 4655.6 4679.2 4715.1 4719.7 4724.2 4951.6 4955.4 4961.3 4981.2 5009.7 4499.3 4721.0 4771.3 4783.2 4791.8 2593.3 2626.8 2636.8 2642.9 2649.0 5035.1 5044.6 5072.7 5075.4 5081.3 5030.5 5078.2 5091.8 5115.8 5380.3 5835.0 5849.9 5859.4 5859.4 5871.2 5660.3 5663.3 5668.0 5696.3 5770.0 5526.9 5585.8 5648.2 5649.5 5736.9 5825.9 5837.4 5840.6 5851.7 5854.0 4060.7 4088.3 4093.3 4100.8 4106.7 5418.3 5580.7 5672.3 5721.2 5724.7 5315.2 5402.8 5503.6 5521.0 5530.0 5473.4 5514.6 5517.3 5525.9 5554.7 5224.6 5432.6 5459.9 5476.5 5494.5 5533.9 5549.1 5561.0 5562.2 5571.6 5435.0 5438.3 5438.4 5463.8 5465.4 19:38:21 INFO - PROCESS | 23691 | 19:38:21 INFO - PROCESS | 23691 | [#5] yui.html Cycles:180 Average:17761.39 Median:4907.42 stddev:23873.31 (486.5%) stddev-sans-first:23906.10 19:38:21 INFO - PROCESS | 23691 | Values: 748.8 752.2 781.0 788.0 798.3 12338.9 13147.0 13170.9 13172.1 13209.8 14319.4 14445.5 14460.1 14478.2 14487.3 799.7 803.1 807.5 807.7 810.8 797.7 804.2 812.2 812.3 812.6 849.9 850.0 850.2 850.3 850.6 839.5 839.6 840.8 841.1 842.4 625.7 626.5 626.6 627.0 627.8 13592.7 13626.9 13664.6 13680.5 13692.9 12087.7 12127.3 12157.2 12280.8 13236.7 10616.9 10684.6 10859.5 10958.6 11173.2 3687.8 3754.2 3855.4 3936.1 3943.8 62364.7 63946.7 64066.7 64077.0 67515.3 9649.9 9668.5 9751.4 9810.2 9987.4 18647.5 18882.9 19109.4 19155.4 19245.6 8189.2 8201.4 8310.6 8367.9 8421.3 4526.2 4779.6 4801.9 4871.4 4905.3 3431.3 3535.5 3559.4 3564.7 3568.8 586.4 587.1 599.4 611.6 611.9 539.5 625.3 765.6 771.6 783.2 8835.8 9795.5 10039.5 10160.8 10218.8 710.0 715.7 716.8 728.8 738.1 4485.6 4859.4 4878.0 4886.0 4909.5 82525.0 84387.0 87484.0 89342.6 91179.5 72662.3 73676.0 75207.0 76401.2 78946.6 69014.2 70317.6 70458.6 71307.6 74315.0 9342.3 9720.6 9720.6 9738.5 9743.0 46992.0 47833.5 48987.8 48989.3 49042.8 61484.0 62277.7 67453.3 68126.0 69395.7 11811.0 11863.2 11925.4 12254.1 12360.9 12768.2 13043.9 13164.8 13172.3 13390.0 12248.8 12477.8 13032.3 13266.8 13416.5 11325.5 11695.4 11797.4 11823.6 11987.5 12005.9 12241.2 12337.8 12539.7 12584.5 9898.0 10161.8 10524.8 10745.5 10964.1 10135.3 10276.4 10375.5 10413.7 10504.3 19:38:21 INFO - PROCESS | 23691 | -------- Summary: end -------- 19:38:21 INFO - PROCESS | 23691 | 19:38:22 INFO - TEST-INFO | 23691: exit 0 19:38:22 INFO - TEST-OK | dromaeo_css | took 1118503ms 19:38:22 INFO - TEST-START | kraken 19:38:22 INFO - operating with platform_type : linux_ 19:38:22 INFO - Initialising browser for kraken test... 19:38:22 INFO - TEST-INFO | started process 23998 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJaw50U/profile http://localhost:46151/getInfo.html) 19:38:26 INFO - PROCESS | 23998 | __metrics Screen width/height:1600/1200 19:38:26 INFO - PROCESS | 23998 | colorDepth:24 19:38:26 INFO - PROCESS | 23998 | Browser inner width/height: 1024/697 19:38:26 INFO - PROCESS | 23998 | __metrics 19:38:26 INFO - PROCESS | 23998 | 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" 19:38:26 INFO - PROCESS | 23998 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:38:27 INFO - PROCESS | 23998 | console.error: PushService: 19:38:27 INFO - PROCESS | 23998 | stateChangeProcessEnqueue: Error transitioning state 19:38:27 INFO - PROCESS | 23998 | UnknownError 19:38:28 INFO - TEST-INFO | 23998: exit 0 19:38:28 INFO - Browser initialized. 19:38:28 INFO - Running cycle 1/1 for kraken test... 19:38:28 INFO - TEST-INFO | started process 24085 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJaw50U/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:38:40 INFO - PROCESS | 24085 | RSS: Main: 172773376 19:38:40 INFO - PROCESS | 24085 | 19:38:42 INFO - PROCESS | 24085 | Cycle 1(1): loaded http://localhost:46151/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46151/tests/kraken/driver.html?testName=audio-beat-detection) 19:38:43 INFO - PROCESS | 24085 | RSS: Main: 228921344 19:38:43 INFO - PROCESS | 24085 | 19:38:46 INFO - PROCESS | 24085 | Cycle 1(1): loaded http://localhost:46151/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46151/tests/kraken/driver.html?testName=audio-dft) 19:38:46 INFO - PROCESS | 24085 | RSS: Main: 215683072 19:38:46 INFO - PROCESS | 24085 | 19:38:50 INFO - PROCESS | 24085 | Cycle 1(1): loaded http://localhost:46151/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46151/tests/kraken/driver.html?testName=audio-fft) 19:38:50 INFO - PROCESS | 24085 | RSS: Main: 297066496 19:38:50 INFO - PROCESS | 24085 | 19:38:52 INFO - PROCESS | 24085 | Cycle 1(1): loaded http://localhost:46151/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46151/tests/kraken/driver.html?testName=audio-oscillator) 19:38:53 INFO - PROCESS | 24085 | RSS: Main: 206057472 19:38:53 INFO - PROCESS | 24085 | 19:38:55 INFO - PROCESS | 24085 | Cycle 1(1): loaded http://localhost:46151/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46151/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:38:56 INFO - PROCESS | 24085 | RSS: Main: 211185664 19:38:56 INFO - PROCESS | 24085 | 19:38:59 INFO - PROCESS | 24085 | Cycle 1(1): loaded http://localhost:46151/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46151/tests/kraken/driver.html?testName=imaging-darkroom) 19:38:59 INFO - PROCESS | 24085 | RSS: Main: 247558144 19:38:59 INFO - PROCESS | 24085 | 19:39:03 INFO - PROCESS | 24085 | Cycle 1(1): loaded http://localhost:46151/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46151/tests/kraken/driver.html?testName=imaging-desaturate) 19:39:03 INFO - PROCESS | 24085 | RSS: Main: 246784000 19:39:03 INFO - PROCESS | 24085 | 19:39:06 INFO - PROCESS | 24085 | Cycle 1(1): loaded http://localhost:46151/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46151/tests/kraken/driver.html?testName=json-parse-financial) 19:39:06 INFO - PROCESS | 24085 | RSS: Main: 245981184 19:39:06 INFO - PROCESS | 24085 | 19:39:08 INFO - PROCESS | 24085 | Cycle 1(1): loaded http://localhost:46151/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46151/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:39:08 INFO - PROCESS | 24085 | RSS: Main: 208470016 19:39:08 INFO - PROCESS | 24085 | 19:39:10 INFO - PROCESS | 24085 | Cycle 1(1): loaded http://localhost:46151/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46151/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:39:11 INFO - PROCESS | 24085 | RSS: Main: 216129536 19:39:11 INFO - PROCESS | 24085 | 19:39:13 INFO - PROCESS | 24085 | Cycle 1(1): loaded http://localhost:46151/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46151/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:39:13 INFO - PROCESS | 24085 | RSS: Main: 225005568 19:39:13 INFO - PROCESS | 24085 | 19:39:16 INFO - PROCESS | 24085 | Cycle 1(1): loaded http://localhost:46151/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46151/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:39:17 INFO - PROCESS | 24085 | RSS: Main: 233193472 19:39:17 INFO - PROCESS | 24085 | 19:39:20 INFO - PROCESS | 24085 | Cycle 1(1): loaded http://localhost:46151/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46151/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:39:20 INFO - PROCESS | 24085 | RSS: Main: 230801408 19:39:20 INFO - PROCESS | 24085 | 19:39:22 INFO - PROCESS | 24085 | Cycle 1(1): loaded http://localhost:46151/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46151/tests/kraken/driver.html?testName=ai-astar) 19:39:22 INFO - PROCESS | 24085 | RSS: Main: 281755648 19:39:22 INFO - PROCESS | 24085 | 19:39:22 INFO - PROCESS | 24085 | __start_tp_report 19:39:22 INFO - PROCESS | 24085 | _x_x_mozilla_page_load 19:39:22 INFO - PROCESS | 24085 | _x_x_mozilla_page_load_details 19:39:22 INFO - PROCESS | 24085 | |i|pagename|runs| 19:39:22 INFO - PROCESS | 24085 | |0;ai-astar;103;111;109;110;112;111;109;110;110;110 19:39:22 INFO - PROCESS | 24085 | |1;audio-beat-detection;159;123;124;161;123;123;125;126;158;123 19:39:22 INFO - PROCESS | 24085 | |2;audio-dft;160;161;160;162;160;161;161;160;160;163 19:39:22 INFO - PROCESS | 24085 | |3;audio-fft;74;75;75;105;76;75;75;75;98;76 19:39:22 INFO - PROCESS | 24085 | |4;audio-oscillator;84;84;106;82;83;82;102;83;83;107 19:39:22 INFO - PROCESS | 24085 | |5;imaging-gaussian-blur;117;116;117;117;116;117;117;117;117;116 19:39:22 INFO - PROCESS | 24085 | |6;imaging-darkroom;148;148;147;147;148;148;148;148;149;148 19:39:22 INFO - PROCESS | 24085 | |7;imaging-desaturate;85;84;84;85;85;85;86;84;84;85 19:39:22 INFO - PROCESS | 24085 | |8;json-parse-financial;53;52;55;51;51;54;55;53;53;53 19:39:22 INFO - PROCESS | 24085 | |9;json-stringify-tinderbox;60;61;60;60;61;60;60;61;60;60 19:39:22 INFO - PROCESS | 24085 | |10;stanford-crypto-aes;79;80;80;79;79;80;80;79;79;78 19:39:22 INFO - PROCESS | 24085 | |11;stanford-crypto-ccm;132;132;128;131;131;136;138;141;171;132 19:39:22 INFO - PROCESS | 24085 | |12;stanford-crypto-pbkdf2;172;168;166;167;176;167;169;165;164;166 19:39:22 INFO - PROCESS | 24085 | |13;stanford-crypto-sha256-iterative;67;65;66;66;66;65;65;65;64;67 19:39:22 INFO - PROCESS | 24085 | __end_tp_report 19:39:22 INFO - PROCESS | 24085 | __start_cc_report 19:39:22 INFO - PROCESS | 24085 | _x_x_mozilla_cycle_collect,1647 19:39:22 INFO - PROCESS | 24085 | __end_cc_report 19:39:22 INFO - PROCESS | 24085 | __startTimestamp1477449562585__endTimestamp 19:39:22 INFO - PROCESS | 24085 | 19:39:22 INFO - PROCESS | 24085 | ------- Summary: start ------- 19:39:22 INFO - PROCESS | 24085 | Number of tests: 14 19:39:22 INFO - PROCESS | 24085 | 19:39:22 INFO - PROCESS | 24085 | [#0] ai-astar Cycles:10 Average:109.50 Median:110.00 stddev:2.46 (2.2%) stddev-sans-first:0.97 19:39:22 INFO - PROCESS | 24085 | Values: 103.0 111.0 109.0 110.0 112.0 111.0 109.0 110.0 110.0 110.0 19:39:22 INFO - PROCESS | 24085 | 19:39:22 INFO - PROCESS | 24085 | [#1] audio-beat-detection Cycles:10 Average:134.50 Median:125.50 stddev:17.18 (13.7%) stddev-sans-first:15.77 19:39:22 INFO - PROCESS | 24085 | Values: 159.0 123.0 124.0 161.0 123.0 123.0 125.0 126.0 158.0 123.0 19:39:22 INFO - PROCESS | 24085 | 19:39:22 INFO - PROCESS | 24085 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:1.03 (0.6%) stddev-sans-first:1.05 19:39:22 INFO - PROCESS | 24085 | Values: 160.0 161.0 160.0 162.0 160.0 161.0 161.0 160.0 160.0 163.0 19:39:22 INFO - PROCESS | 24085 | 19:39:22 INFO - PROCESS | 24085 | [#3] audio-fft Cycles:10 Average:80.40 Median:75.00 stddev:11.26 (15.0%) stddev-sans-first:11.70 19:39:22 INFO - PROCESS | 24085 | Values: 74.0 75.0 75.0 105.0 76.0 75.0 75.0 75.0 98.0 76.0 19:39:22 INFO - PROCESS | 24085 | 19:39:22 INFO - PROCESS | 24085 | [#4] audio-oscillator Cycles:10 Average:89.60 Median:83.00 stddev:10.72 (12.9%) stddev-sans-first:11.18 19:39:22 INFO - PROCESS | 24085 | Values: 84.0 84.0 106.0 82.0 83.0 82.0 102.0 83.0 83.0 107.0 19:39:22 INFO - PROCESS | 24085 | 19:39:22 INFO - PROCESS | 24085 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 19:39:22 INFO - PROCESS | 24085 | Values: 117.0 116.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 116.0 19:39:22 INFO - PROCESS | 24085 | 19:39:22 INFO - PROCESS | 24085 | [#6] imaging-darkroom Cycles:10 Average:147.90 Median:148.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 19:39:22 INFO - PROCESS | 24085 | Values: 148.0 148.0 147.0 147.0 148.0 148.0 148.0 148.0 149.0 148.0 19:39:22 INFO - PROCESS | 24085 | 19:39:22 INFO - PROCESS | 24085 | [#7] imaging-desaturate Cycles:10 Average:84.70 Median:85.00 stddev:0.67 (0.8%) stddev-sans-first:0.71 19:39:22 INFO - PROCESS | 24085 | Values: 85.0 84.0 84.0 85.0 85.0 85.0 86.0 84.0 84.0 85.0 19:39:22 INFO - PROCESS | 24085 | 19:39:22 INFO - PROCESS | 24085 | [#8] json-parse-financial Cycles:10 Average:53.00 Median:53.00 stddev:1.41 (2.7%) stddev-sans-first:1.50 19:39:22 INFO - PROCESS | 24085 | Values: 53.0 52.0 55.0 51.0 51.0 54.0 55.0 53.0 53.0 53.0 19:39:22 INFO - PROCESS | 24085 | 19:39:22 INFO - PROCESS | 24085 | [#9] json-stringify-tinderbox Cycles:10 Average:60.30 Median:60.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 19:39:22 INFO - PROCESS | 24085 | Values: 60.0 61.0 60.0 60.0 61.0 60.0 60.0 61.0 60.0 60.0 19:39:22 INFO - PROCESS | 24085 | 19:39:22 INFO - PROCESS | 24085 | [#10] stanford-crypto-aes Cycles:10 Average:79.30 Median:79.50 stddev:0.67 (0.8%) stddev-sans-first:0.71 19:39:22 INFO - PROCESS | 24085 | Values: 79.0 80.0 80.0 79.0 79.0 80.0 80.0 79.0 79.0 78.0 19:39:22 INFO - PROCESS | 24085 | 19:39:22 INFO - PROCESS | 24085 | [#11] stanford-crypto-ccm Cycles:10 Average:137.20 Median:134.00 stddev:12.48 (9.3%) stddev-sans-first:13.09 19:39:22 INFO - PROCESS | 24085 | Values: 132.0 132.0 128.0 131.0 131.0 136.0 138.0 141.0 171.0 132.0 19:39:22 INFO - PROCESS | 24085 | 19:39:22 INFO - PROCESS | 24085 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.00 Median:167.50 stddev:3.59 (2.1%) stddev-sans-first:3.50 19:39:22 INFO - PROCESS | 24085 | Values: 172.0 168.0 166.0 167.0 176.0 167.0 169.0 165.0 164.0 166.0 19:39:22 INFO - PROCESS | 24085 | 19:39:22 INFO - PROCESS | 24085 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.60 Median:66.00 stddev:0.97 (1.5%) stddev-sans-first:0.88 19:39:22 INFO - PROCESS | 24085 | Values: 67.0 65.0 66.0 66.0 66.0 65.0 65.0 65.0 64.0 67.0 19:39:22 INFO - PROCESS | 24085 | -------- Summary: end -------- 19:39:22 INFO - PROCESS | 24085 | 19:39:23 INFO - TEST-INFO | 24085: exit 0 19:39:23 INFO - TEST-OK | kraken | took 61512ms 19:39:23 INFO - SUITE-END | took 1180s 19:39:24 INFO - Completed test suite (00:19:40) 19:39:24 INFO - javascript benchmark 19:39:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3114.2058775012374, 3146.9370612587736, 3153.9526907096397, 3187.617485901689, 3200.839958002101, 5232.790688372461, 5350.678959262447, 5370.489803468669, 5443.755031023604, 5446.0, 5386.3536375634885, 5387.595930305223, 5396.703181325026, 5399.757010934508, 5401.135818269077, 4844.0, 4868.464468908417, 4887.486813884527, 4906.754662266891, 4982.875428114308, 4949.925751113737, 5022.84931452057, 5024.472430394792, 5027.622928280375, 5028.019536190444, 4926.605871530287, 4933.358663373757, 4954.851354459372, 4973.079980203655, 5019.899602007976, 4994.400671919357, 5004.149294619887, 5010.348654674869, 5011.749412529359, 5071.290019397287, 4813.446453657839, 4834.975825120887, 4852.4662287148385, 4920.065187614342, 4927.334809800667, 5320.441353657849, 5322.0686379883755, 5332.253484512172, 5343.706096164709, 5406.567474602022, 5655.943440565583, 5704.714764261812, 5708.1437784332265, 5710.885782284331, 5717.285339332583, 5704.600677952545, 5759.510441612468, 5799.797007104731, 5813.389594092644, 5863.237779088691, 5337.01265265927, 5372.677639341652, 5399.2980912481125, 5408.215808707755, 5416.891662166735, 5910.113482977502, 5915.704214789243, 5919.585629005928, 5920.674362910081, 5977.790777322773, 5676.971615141981, 5685.232493613309, 5686.0, 5687.374388817227, 5694.857628559319, 5639.3232812062, 5651.943480565142, 5655.575831812631, 5699.145128230799, 5769.711514424262, 5699.031164702011, 5755.510781583528, 5758.280214973129, 5762.250907382014, 5765.913511297334, 5619.522340601095, 5625.437456254342, 5643.463870932255, 5774.076147816413, 5788.623739456922, 4378.978105109518, 4380.299152135643, 4380.496242932039, 4425.579569940851, 4434.889127771831, 3912.9608703912595, 3937.8031098445535, 3943.8619648312747, 3970.285348637215, 3976.6023397660583, 5380.811671591476, 5393.379761327419, 5417.539509141767, 5433.510984011379, 5435.347758268954, 5793.188953546507, 5840.415958404125, 5851.707414629252, 5903.734331955073, 5904.232449781501, 5453.318335208099, 5490.80782172622, 5500.312460942382, 5502.394736578973, 5502.807401741, 4936.925946110811, 4970.0, 5049.192129259301, 5058.3929928408825, 5118.181091025418, 5959.76160953557, 6008.03871380577, 6023.1868697726995, 6046.213992181164, 6122.020476723703, 5851.034579294539, 5862.765489380377, 5863.296404431496, 5868.0, 5871.911921321098, 5863.560232982458, 6031.698415079316, 6048.576599637983, 6049.18336024631, 6050.788222412194, 5586.13414920688, 5671.688057156731, 5738.081906894877, 5740.540756739534, 5818.040023396092, 5794.420557944172, 5854.619449735754, 5858.677772722541, 5859.414058594107, 5860.09168578871, 5706.229658995982, 5709.400512946081, 5712.171735098304, 5712.5429965601825, 5716.171155182558, 5498.725063746717, 5508.504234618904, 5510.1459273812625, 5571.721413929368, 5578.414266502121, 5567.7494512747835, 5583.050881350261, 5597.3003374578175, 5603.663780173202, 5664.745086471036, 5639.7744090237575, 5640.294963129609, 5640.520555752807, 5642.774289028557, 5644.068728659725, 5395.946040539544, 5413.350397952271, 5464.043792336404, 5525.585581081355, 5581.74882130297], "value": 5329.5152157683715, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [549.8844101110233, 577.5841394196179, 610.9327973922867, 621.3351713666376, 641.0736485778052, 31130.377392452167, 42331.15337693248, 42983.57016429835, 43107.568924310784, 46037.769811150894, 44246.0, 44736.776316118456, 44742.32886506705, 44768.77615611917, 44848.77575612126, 7948.682052717913, 8852.734417967455, 9015.098490150966, 9022.954885225565, 9026.23277021454, 7893.0, 10564.577416903314, 10821.67534973952, 10825.891741082607, 11181.273217240894, 10903.236773425824, 10922.836157457645, 10978.890211097867, 10979.505922233519, 10982.121430285599, 10799.082078023339, 10865.674029779118, 10872.67381978542, 10874.293170943864, 10884.129269658448, 10649.0, 10708.732281692943, 10729.517171727213, 10732.839007414896, 10734.892651073467, 40890.59109408897, 41123.0, 41206.0, 41313.38029929553, 41427.7928610355, 3641.4719865619336, 3702.796346200958, 3806.7335286529956, 3937.7243592948507, 4019.115794525229, 31258.687413125805, 31265.218369540944, 32264.5160322593, 32383.190420239447, 33321.16697082568, 4324.82700691972, 4374.272162495797, 4430.977845110786, 4450.465944086698, 4539.984846909217, 225620.0, 225969.0, 226611.0, 227840.0, 228451.8577407119, 30759.38481230363, 31621.841890790398, 31636.683633163375, 55743.0, 56104.719476403174, 35997.46003809945, 36205.45691814625, 36248.81875590658, 36383.636163638555, 36461.81769091191, 13551.25468099264, 13648.24934628605, 13656.453741850413, 13657.112287701466, 13657.385417656229, 10668.519916603771, 10749.462526873625, 10836.187285953585, 11087.889121108847, 11169.944150279196, 8067.072286686989, 8119.3910456715985, 8132.5933703314595, 8198.057223419264, 8246.134155913544, 3181.6818318168, 3214.5017522284083, 3230.644629090798, 3232.111169428426, 3253.4957081652383, 1007.2043085962008, 1010.4177554789143, 1013.1843865688045, 1019.8623185869812, 1119.082352470966, 30383.544246836314, 31727.682723172933, 31877.20306992344, 31877.362452750815, 32503.0, 1100.7688385438987, 1111.0056499432962, 1116.1182665694173, 1117.5473933057124, 1143.7083543696303, 16258.349666013228, 16674.33302667904, 16678.499645010426, 16680.49958501247, 16926.83073169277, 516817.0, 521895.0, 524663.0, 525341.0, 527562.0, 57217.14174287389, 58073.128903066485, 58107.0, 58129.128063079086, 58144.0, 1126.7802778458286, 1192.9403529823473, 1260.8802163794426, 1264.5574049082932, 1275.3686924972199, 29896.103116906528, 32106.0, 32361.35277294488, 34629.0, 34902.65097348994, 54225.45774542204, 54726.0, 54751.452485474634, 54763.17855232095, 54794.726026369615, 423937.0, 427069.0, 427924.0, 430592.0, 431638.0, 27274.318142046606, 27620.585691214244, 27878.58182127229, 28251.57622635621, 28269.15192544227, 45549.31676024796, 45828.81638673878, 46742.298865517725, 46972.0, 47823.52176478191, 38112.809435952644, 39613.40579891246, 39955.80022099871, 40932.0, 42125.1574968505, 38567.228655426174, 39004.80497597494, 39533.604663954146, 40165.397519036655, 40621.18757624772, 40109.39835902405, 40142.799286003385, 40147.197056059296, 40961.0, 41602.16795664009, 32623.34753304968, 34920.0, 35406.645933540334, 36203.456948146326, 36299.09252268715, 28267.85866070739, 28590.0, 28851.56722649204, 28851.855740721163, 28890.855545722137], "value": 18643.93051316989, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [364.4696965914593, 369.9963000369999, 376.3601876809424, 377.9300829346571, 393.8188433320672, 14056.71886562268, 18098.276068957242, 18397.81602183978, 18485.722714159263, 19635.0, 17560.0, 18386.540336491562, 19129.426117216506, 19209.231630734754, 19313.0343482826, 5483.616146869721, 5748.626339287933, 5764.625299355528, 5768.250127483442, 5774.913376299359, 5452.754626041818, 5596.832095037135, 5604.943950560483, 5639.0, 5704.8859022819515, 5593.692346920918, 5635.520980716644, 5637.689927054011, 5642.097264437691, 5642.661440313574, 5504.972475137639, 5632.859178520529, 5635.464630860082, 5721.141828725683, 5749.885002299972, 5601.383847776741, 5639.041362968264, 5645.717714114319, 5648.265725455705, 5652.463016013472, 13756.65608359789, 13806.17162970225, 14017.85982140186, 14199.645008874757, 14226.217558034305, 2293.7362203346497, 2383.749706280833, 2459.9914035245642, 2721.2516557946524, 2816.746492815636, 8989.190972812414, 9333.833270841145, 10608.09831164352, 10610.62862799806, 10680.0, 1867.9066046697747, 1920.6350793349218, 1922.432882299725, 1926.1139875657213, 1955.1397385150487, 76387.61806190989, 79963.60018199871, 81479.18520814835, 83609.0, 85453.0, 10487.895121048692, 10511.26421150512, 10599.470026498644, 10872.836907446395, 10893.400862952614, 14901.254937253094, 14933.925330373497, 14936.477223297132, 14944.252787360589, 14956.401743930339, 7568.4323675723435, 7681.500702454435, 7827.25641064098, 7844.254795794391, 7886.132525422199, 7189.388901943394, 7202.20775714671, 7242.420606351479, 7390.22402647725, 7436.256374362521, 4541.137183935108, 4541.909161816811, 4588.862334129982, 4653.95346046542, 4709.222978208626, 1895.848332133426, 1920.5102698811993, 1949.6100779844087, 1956.735840661521, 1988.860779745404, 805.295366554265, 930.3255140023429, 970.7136394763562, 977.8386566216636, 987.4026214140486, 18196.0, 19070.0, 19095.0, 19117.522061948563, 19312.71030934537, 899.7705585075895, 931.5575101826578, 937.2267878999852, 959.1176117971482, 970.9805803883883, 9893.406395616286, 10580.312279701795, 10585.788284234426, 10637.255392122477, 10716.678499645022, 349439.0, 353355.0, 448085.0, 449588.0, 452714.0, 90723.0, 93774.53112734393, 95151.52424237835, 95859.52070239604, 97266.51366743121, 1006.1246715357686, 1038.402918321968, 1065.280935368623, 1067.2635881241918, 1077.8167711489066, 17343.0, 17640.15365326136, 18146.45560633183, 18191.727124093413, 18284.908575457568, 29035.305818000994, 43501.12997739964, 44159.0, 44223.33664995092, 45679.543204567526, 58660.706696466244, 58750.0, 58903.0, 61075.38924610697, 61493.0, 8158.3473322132895, 8190.549519776469, 8223.17768223173, 8534.402591818513, 8718.084601117045, 9282.675106371245, 12428.13003089775, 12866.614001579968, 13242.404091815699, 13395.397207125898, 11153.163512736415, 11598.130140239684, 11710.70723231926, 11734.765304694029, 11948.701282468008, 10947.616833410792, 10994.505247264053, 11368.431578420881, 11424.257423267461, 11515.769684606094, 11742.29546227195, 11802.94098529502, 11905.16663833558, 11968.880311197125, 12061.75876482483, 8332.583370831313, 8472.618732156945, 8523.275521580736, 8674.609642565974, 8697.739067827975, 10314.278000540191, 11550.826737598774, 11627.244229125079, 11684.941575292069, 12012.75974480488], "value": 8913.118525817476, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1279.1941077121412, 1447.2908274945278, 1482.9258537073147, 1577.8974366666166, 1794.8025717171117, 7424.4060475162, 8308.2107199816, 8500.872486912685, 8529.573521323931, 8832.867506987384, 8599.91400085999, 8628.050914399411, 8674.306055515559, 8691.217790398863, 8700.0, 2302.689136966509, 2328.988355058231, 2331.393837602219, 2333.5449587330477, 2337.3805941425535, 2268.7164104486938, 2307.0195167053935, 2320.791128798408, 2324.662923876037, 2334.5914464968564, 2273.863568185906, 2290.393045842853, 2295.150794206146, 2323.9302820915314, 2358.2453614843257, 2207.128184367166, 2236.206146817881, 2239.484918468753, 2241.8094461970754, 2243.1588154442084, 2195.5169862630196, 2208.9558208835892, 2214.2139540463063, 2216.445888527868, 2218.889055547232, 8514.0, 8593.0, 8627.482351058956, 8681.262092722127, 8692.391532592721, 5166.844994650167, 5338.27933229013, 5340.0, 5366.221897824833, 5367.704776237305, 3296.126526470487, 3411.8635254590035, 3594.2991116732246, 3639.5632524097014, 3644.9817750911343, 1119.7928383249125, 1125.7861006408757, 1127.8815724348908, 1140.2930183286333, 1152.2337645465755, 11959.282443053444, 12016.279023258632, 12021.278723276631, 12040.638780836589, 12056.698582535506, 4146.813393397304, 4343.500497442771, 4428.6678499112695, 4436.6672499562665, 4460.0633866887665, 9431.009743976922, 9452.10205030521, 9454.24366050728, 9463.242940564738, 9467.526623668928, 5223.973880130575, 5225.686458812484, 5225.895482090413, 5230.92153617696, 5236.423993360727, 4096.528899176633, 4103.117829666636, 4162.292410290258, 4380.518143004267, 4897.995910838341, 3539.2744487380023, 3574.195805943694, 3705.7776533408082, 3710.3692372296773, 3723.3298006359114, 1128.1933417606451, 1134.3704244144578, 1135.5911871726173, 1146.2434793036723, 1172.5485688010178, 814.5927036481759, 860.0, 930.7486978515898, 935.2050756856618, 957.3107362698846, 5500.862478438071, 5708.571857110734, 5781.075027995585, 5868.413158684098, 5896.410358964069, 864.9481031138151, 898.9685361012333, 930.3627015494408, 940.6143481172824, 987.3236832769576, 3804.7146464014754, 3890.0, 3908.2378936107184, 3931.410288456754, 3941.467901833273, 10616.681499555025, 11002.724931876766, 11018.889811101946, 11030.613928512625, 11034.062104721188, 10880.292780969212, 10920.726981825359, 10921.399323037309, 10929.398883061507, 10932.508037138188, 7701.191374905667, 8012.0786109596975, 8012.479188852706, 8171.632276547451, 8199.22107399796, 5606.831795046155, 5627.606067575231, 5765.798197063083, 5827.4172582741385, 5903.173555702119, 9890.703278901645, 9928.305018648625, 9936.354136981074, 9943.453110079015, 9947.552360143665, 8884.911150888409, 9150.313726470407, 9482.620695172116, 9856.260780441638, 10035.799284014132, 7549.773506794805, 7662.923370766221, 7699.461037727306, 7715.961420192863, 7828.5694286812495, 8399.076101628938, 8420.410571260198, 8465.91534084676, 8466.195711407407, 8468.872966905377, 7512.699492020258, 7680.231976802275, 7696.538207707556, 7750.7674769756995, 7917.0, 7380.483366164317, 7450.217727138573, 7499.0, 7547.924520754942, 7660.923390766021, 6613.074169616161, 6750.459963202834, 6761.932380676327, 6762.188537375349, 6763.492738044764, 4778.211595086772, 4813.15769740301, 4894.755262236945, 4978.4025916890205, 5035.219540971156, 4923.113839508779, 5020.121478741133, 5160.48395160481, 5173.844784656466, 5269.1569348903995], "value": 4508.653041269594, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [325.8582516605275, 332.55271659617813, 337.16551534950986, 338.0534503390506, 342.6333822809595, 5105.0, 5255.76349064292, 5296.152615581508, 5348.197770334447, 5355.678659280446, 5123.487651234875, 5218.6953261684575, 5242.18746094356, 5247.973760131194, 5265.842024739254, 4166.291730405823, 4170.374443833419, 4173.373993900909, 4175.394567787669, 4184.518780340261, 4005.1175947304864, 4127.379114262435, 4178.080822219122, 4185.937210941838, 4192.182524407742, 4049.797510124482, 4053.6351728344443, 4062.2078694654556, 4090.6931980101613, 4099.405586190001, 4042.9797851010703, 4050.460824886539, 4053.858114965962, 4066.125782956649, 4089.5705950875026, 3615.493830863681, 3619.94570081449, 3628.76413033152, 3629.800360980145, 3636.327279453283, 5009.899802003976, 5100.872478188038, 5110.770015349318, 5133.974330128362, 5183.159978207757, 4641.257398816207, 4649.860504184846, 4657.836975705868, 4668.276417155346, 4669.976650116761, 5440.591955603306, 5445.863853403696, 5455.536279416255, 5468.37113731918, 5492.231087647732, 3735.7571757835653, 3928.410738389236, 3928.9214215715524, 3946.940795888064, 3953.7627742335553, 5692.316921969349, 5730.853829234128, 5735.4551317624755, 5741.598088133791, 5751.482366587027, 4046.251443482965, 4047.838086476567, 4065.6747460203114, 4077.918441631151, 4082.897927551835, 3856.5179352580926, 3999.960000399959, 4003.979980100081, 4037.2934736421007, 4128.793560321972, 4591.517890621503, 4614.238650622609, 4615.192341340252, 4619.745913974696, 4640.187967105743, 5531.25328080712, 5537.975474537224, 5548.805791797267, 5568.415316391802, 5584.525315348241, 1306.5753630070265, 1310.4037662863375, 1382.3710211853584, 1397.6785339372002, 1400.7603271105145, 881.6914080072052, 881.8368601808686, 896.2919293757989, 897.3583887520455, 899.4288626722079, 4655.604273636711, 4679.204535229019, 4715.104130215248, 4719.669623126349, 4724.189107481044, 4951.603871690256, 4955.40535135786, 4961.305417241589, 4981.2030075187795, 5009.7244651544515, 4499.3251012347755, 4720.95279047212, 4771.260454629538, 4783.23468245086, 4791.778096585348, 2593.338698631837, 2626.7898568114506, 2636.762691357787, 2642.894284228648, 2649.026475275893, 5035.136999310205, 5044.571211446994, 5072.721000344943, 5075.365579302587, 5081.3140226069745, 5030.490852744162, 5078.162103252996, 5091.766728127665, 5115.753924242869, 5380.336733317034, 5834.970825145847, 5849.883002339844, 5859.384764599741, 5859.414058594191, 5871.207387002785, 5660.349059858005, 5663.348714897839, 5667.971660141673, 5696.316442026983, 5770.0, 5526.861828454321, 5585.776568937197, 5648.23748793924, 5649.519790817662, 5736.913946290725, 5825.912611310749, 5837.3870743571315, 5840.561957853093, 5851.707414629337, 5854.0, 4060.6954478413645, 4088.34586466164, 4093.263212621757, 4100.774457404752, 4106.691998100095, 5418.295621569171, 5580.748866301107, 5672.319321681424, 5721.170430287501, 5724.713764311685, 5315.229291752751, 5402.783888644411, 5503.596582871342, 5520.972395137998, 5530.004599172187, 5473.425290344457, 5514.5864060194845, 5517.282753242213, 5525.917111243415, 5554.694491802989, 5224.555912747307, 5432.619716619799, 5459.890802183854, 5476.507114359727, 5494.450554944474, 5533.944660553504, 5549.139883318092, 5560.97219513916, 5562.2212890196215, 5571.582131340085, 5435.0, 5438.293021907127, 5438.428964958781, 5463.7814487420055, 5465.398806131402], "value": 4115.644030570619, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [748.7940816275524, 752.2139364364239, 780.9765707028791, 788.0385929166416, 798.3413683710938, 12338.938305308473, 13147.0, 13170.934145329284, 13172.143810652313, 13209.801852972188, 14319.427222911097, 14445.494407695733, 14460.132392056485, 14478.203698796562, 14487.275636218174, 799.73608709126, 803.1005274093023, 807.4953154278576, 807.7213361390311, 810.7648781853255, 797.6889013284823, 804.2440106300088, 812.2405550810012, 812.305478815613, 812.6058861452191, 849.889514363132, 849.961751721174, 850.1583432401909, 850.3494826457764, 850.6044689219511, 839.4585492357395, 839.5718183726283, 840.8276303357796, 841.0706169682474, 842.3766412854504, 625.6590158363703, 626.495670984857, 626.6240255846501, 626.971786269619, 627.7708636347746, 13592.728145437135, 13626.93186534061, 13664.590062298146, 13680.452781888813, 13692.931535342359, 12087.697807554794, 12127.272363658121, 12157.209781364183, 12280.815787763191, 13236.735265294641, 10616.893831061669, 10684.626038088629, 10859.511321990529, 10958.561657533768, 11173.162012849069, 3687.797171155585, 3754.1740817020213, 3855.4024126260474, 3936.055346716796, 3943.842246310144, 62364.68817655928, 63946.680266598836, 64066.67966660137, 64077.0, 67515.3248467509, 9649.903500965042, 9668.516574171263, 9751.414915105117, 9810.215182785503, 9987.350822196535, 18647.533811654816, 18882.90558547226, 19109.426717198505, 19155.425337239903, 19245.615087698166, 8189.181081891882, 8201.42590018693, 8310.626021829032, 8367.916320836835, 8421.326293896474, 4526.162659907927, 4779.641526885497, 4801.927971080437, 4871.3667223261455, 4905.3132561441425, 3431.330890476333, 3535.4696795480368, 3559.4482855157494, 3564.697000754965, 3568.839402226906, 586.414077913564, 587.0812178939946, 599.3886236039302, 611.5902345428574, 611.9082137679384, 539.5009616105166, 625.3277726443999, 765.6286700950035, 771.594912670841, 783.2050468774198, 8835.823283534293, 9795.510224488748, 10039.498025098716, 10160.796784064278, 10218.795624087477, 709.9609521476265, 715.7459102018812, 716.7598854383735, 728.8214387475102, 738.1179490508898, 4485.596296333346, 4859.392575928009, 4877.975610121926, 4886.0, 4909.533594308535, 82525.0, 84387.0, 87484.0, 89342.55328723315, 91179.54410228039, 72662.27337726555, 73676.0, 75207.0, 76401.23598764052, 78946.6052669733, 69014.16900816894, 70317.64841175864, 70458.64770676114, 71307.6434617834, 74315.0, 9342.299327550325, 9720.611175552898, 9720.611175552898, 9738.513074346112, 9743.009181449559, 46992.0, 47833.52166478291, 48987.75506122447, 48989.2651610219, 49042.75478622727, 61484.0, 62277.68861155665, 67453.3254667447, 68125.9781103274, 69395.65302173457, 11811.0, 11863.228890122115, 11925.403729813648, 12254.080943929419, 12360.938195308965, 12768.170068945488, 13043.869561304266, 13164.802527961896, 13172.275524845842, 13390.0, 12248.755024899274, 12477.812832807696, 13032.348382581024, 13266.80099798523, 13416.463341466231, 11325.490352933974, 11695.415229238333, 11797.410129493663, 11823.645290641294, 11987.460564274454, 12005.939970300093, 12241.20432171906, 12337.753244935231, 12539.74920501603, 12584.489861216713, 9898.0, 10161.847572286273, 10524.842127368249, 10745.516451759533, 10964.122870170208, 10135.341202821794, 10276.434796085989, 10375.481225938522, 10413.687589372332, 10504.317219380715], "value": 7040.517018329219, "unit": "score"}], "name": "dromaeo_css", "value": 6980.683757970599, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 111.0, 109.0, 110.0, 112.0, 111.0, 109.0, 110.0, 110.0, 110.0], "value": 109.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 123.0, 124.0, 161.0, 123.0, 123.0, 125.0, 126.0, 158.0, 123.0], "value": 134.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 160.0, 162.0, 160.0, 161.0, 161.0, 160.0, 160.0, 163.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 105.0, 76.0, 75.0, 75.0, 75.0, 98.0, 76.0], "value": 80.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 106.0, 82.0, 83.0, 82.0, 102.0, 83.0, 83.0, 107.0], "value": 89.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 147.0, 147.0, 148.0, 148.0, 148.0, 148.0, 149.0, 148.0], "value": 147.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 84.0, 85.0, 85.0, 85.0, 86.0, 84.0, 84.0, 85.0], "value": 84.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 55.0, 51.0, 51.0, 54.0, 55.0, 53.0, 53.0, 53.0], "value": 53.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 60.0, 60.0, 61.0, 60.0, 60.0, 61.0, 60.0, 60.0], "value": 60.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 80.0, 79.0, 79.0, 80.0, 80.0, 79.0, 79.0, 78.0], "value": 79.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 132.0, 128.0, 131.0, 131.0, 136.0, 138.0, 141.0, 171.0, 132.0], "value": 137.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 168.0, 166.0, 167.0, 176.0, 167.0, 169.0, 165.0, 164.0, 166.0], "value": 168.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 66.0, 66.0, 66.0, 65.0, 65.0, 65.0, 64.0, 67.0], "value": 65.6, "unit": "score"}], "name": "kraken", "value": 1487.5, "alertThreshold": 2.0}]} 19:39:24 INFO - Return code: 0 19:39:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:39:24 INFO - # TBPL SUCCESS # 19:39:24 INFO - Running post-action listener: _resource_record_post_action 19:39:24 INFO - [mozharness: 2016-10-26 02:39:24.419778Z] Finished run-tests step (success) 19:39:24 INFO - Running post-run listener: _resource_record_post_run 19:39:24 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 393318400; Read time: 16; Write time: 308252 19:39:24 INFO - TinderboxPrint: CPU usage
13.0% 19:39:24 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 19:39:24 INFO - TinderboxPrint: I/O write bytes / time
393,318,400 / 308,252 19:39:24 INFO - TinderboxPrint: CPU idle
8,311.9 (87.0%) 19:39:24 INFO - TinderboxPrint: CPU user
1,194.4 (12.5%) 19:39:24 INFO - TinderboxPrint: Swap in / out
0 / 0 19:39:24 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 103391232; Read time: 0; Write time: 95552 19:39:24 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 4096; Write bytes: 289927168; Read time: 16; Write time: 212700 19:39:25 INFO - Running post-run listener: _upload_blobber_files 19:39:25 INFO - Blob upload gear active. 19:39:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:39:25 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 19:39:25 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:39:25 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:39:25 INFO - (blobuploader) - INFO - Open directory for files ... 19:39:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:39:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:39:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:39:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:39:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:39:26 INFO - (blobuploader) - INFO - Done attempting. 19:39:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:39:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:39:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:39:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:39:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:39:27 INFO - (blobuploader) - INFO - Done attempting. 19:39:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:39:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:39:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:39:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:39:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:39:30 INFO - (blobuploader) - INFO - Done attempting. 19:39:30 INFO - (blobuploader) - INFO - Iteration through files over. 19:39:30 INFO - Return code: 0 19:39:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:39:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:39:30 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1faadd206a91e6d2648ac960562086d41a5cd4b4dab4354cd1e4d21fc04a4c44c492303e15b5f672adba788c0b89c245d5796b963b169281fe96157b98379280", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5c6032c306f4c46bcf97e62da2fdfcaf0b086a652710f08d844a4151543e4abcc497af14869c2065d8bdaf7c842d5ceef9f69a9d4a6735caafe2262a48f7259a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/be5899ffbf6ccf59b1635c91dadba4add26573d70a959f81a8b9eb0bb4c2ad47cb0e64a4e1236a144518bc9a0c5d19b597920667067ff301b3bd8a27014614bc"} 19:39:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:39:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:39:30 INFO - Contents: 19:39:30 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1faadd206a91e6d2648ac960562086d41a5cd4b4dab4354cd1e4d21fc04a4c44c492303e15b5f672adba788c0b89c245d5796b963b169281fe96157b98379280", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5c6032c306f4c46bcf97e62da2fdfcaf0b086a652710f08d844a4151543e4abcc497af14869c2065d8bdaf7c842d5ceef9f69a9d4a6735caafe2262a48f7259a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/be5899ffbf6ccf59b1635c91dadba4add26573d70a959f81a8b9eb0bb4c2ad47cb0e64a4e1236a144518bc9a0c5d19b597920667067ff301b3bd8a27014614bc"} 19:39:30 INFO - Running post-run listener: copy_logs_to_upload_dir 19:39:30 INFO - Copying logs to upload dir... 19:39:30 INFO - mkdir: /builds/slave/test/build/upload/logs 19:39:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.712542 ========= master_lag: 0.49 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-10-25 19:39:30.938762) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-25 19:39:30.946783) ========= 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=17051fcd5208b27b50bedfeb000001dd-1477447598.573229-1907932952 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/sha512/1faadd206a91e6d2648ac960562086d41a5cd4b4dab4354cd1e4d21fc04a4c44c492303e15b5f672adba788c0b89c245d5796b963b169281fe96157b98379280", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5c6032c306f4c46bcf97e62da2fdfcaf0b086a652710f08d844a4151543e4abcc497af14869c2065d8bdaf7c842d5ceef9f69a9d4a6735caafe2262a48f7259a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/be5899ffbf6ccf59b1635c91dadba4add26573d70a959f81a8b9eb0bb4c2ad47cb0e64a4e1236a144518bc9a0c5d19b597920667067ff301b3bd8a27014614bc"} build_url:https://queue.taskcluster.net/v1/task/bQ-IpGpZRZO_oq82AoOxaQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010078 build_url: 'https://queue.taskcluster.net/v1/task/bQ-IpGpZRZO_oq82AoOxaQ/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/sha512/1faadd206a91e6d2648ac960562086d41a5cd4b4dab4354cd1e4d21fc04a4c44c492303e15b5f672adba788c0b89c245d5796b963b169281fe96157b98379280", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5c6032c306f4c46bcf97e62da2fdfcaf0b086a652710f08d844a4151543e4abcc497af14869c2065d8bdaf7c842d5ceef9f69a9d4a6735caafe2262a48f7259a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/be5899ffbf6ccf59b1635c91dadba4add26573d70a959f81a8b9eb0bb4c2ad47cb0e64a4e1236a144518bc9a0c5d19b597920667067ff301b3bd8a27014614bc"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-25 19:39:30.976842) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 19:39:30.977228) ========= 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=17051fcd5208b27b50bedfeb000001dd-1477447598.573229-1907932952 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004459 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 19:39:31.027065) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-25 19:39:31.030455) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-25 19:39:31.030822) ========= ========= Total master_lag: 0.63 =========