builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-006 starttime: 1475695072.36 results: success (0) buildid: 20161005093122 builduid: 28a0f74e88d74e65b7df45fb5555decc revision: 4f41a594f88d17e25bbfd362f2e45e6dc891bfc6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-05 12:17:52.362891) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-05 12:17:52.363365) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-05 12:17:52.363718) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-05 12:17:52.381042) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 12:17:52.381369) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1475694158.600154-486825302 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-05 12:17:53-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 41.9M=0s 2016-10-05 12:17:53 (41.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.079762 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 12:17:52.475057) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 12:17:52.475403) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1475694158.600154-486825302 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015710 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 12:17:52.525457) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 12:17:52.525851) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 4f41a594f88d17e25bbfd362f2e45e6dc891bfc6 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 4f41a594f88d17e25bbfd362f2e45e6dc891bfc6 --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=e31afd3c0f0de4e86ebe4d94000001b5-1475694158.600154-486825302 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-05 12:17:53,547 truncating revision to first 12 chars 2016-10-05 12:17:53,547 Setting DEBUG logging. 2016-10-05 12:17:53,547 attempt 1/10 2016-10-05 12:17:53,547 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/4f41a594f88d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-05 12:17:53,846 unpacking tar archive at: fx-team-4f41a594f88d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.620392 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 12:17:53.161424) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-05 12:17:53.161806) ========= script_repo_revision: 4f41a594f88d17e25bbfd362f2e45e6dc891bfc6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-05 12:17:53.162300) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-05 12:17:53.162610) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-05 12:17:53.180910) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-10-05 12:17:53.181530) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=e31afd3c0f0de4e86ebe4d94000001b5-1475694158.600154-486825302 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:17:54 INFO - MultiFileLogger online at 20161005 12:17:54 in /builds/slave/test 12:17:54 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 12:17:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:17:54 INFO - {'append_to_log': False, 12:17:54 INFO - 'base_work_dir': '/builds/slave/test', 12:17:54 INFO - 'blob_upload_branch': 'Fx-Team', 12:17:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:17:54 INFO - 'branch': 'Fx-Team', 12:17:54 INFO - 'buildbot_json_path': 'buildprops.json', 12:17:54 INFO - 'config_files': ('talos/linux_config.py',), 12:17:54 INFO - 'default_actions': ('clobber', 12:17:54 INFO - 'read-buildbot-config', 12:17:54 INFO - 'download-and-extract', 12:17:54 INFO - 'populate-webroot', 12:17:54 INFO - 'create-virtualenv', 12:17:54 INFO - 'install', 12:17:54 INFO - 'run-tests'), 12:17:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:17:54 INFO - 'download_minidump_stackwalk': True, 12:17:54 INFO - 'download_symbols': 'ondemand', 12:17:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:17:54 INFO - 'tooltool.py': '/tools/tooltool.py', 12:17:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:17:54 INFO - '/tools/misc-python/virtualenv.py')}, 12:17:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:17:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:17:54 INFO - 'installer_path': 'installer.exe', 12:17:54 INFO - 'log_level': 'info', 12:17:54 INFO - 'log_name': 'talos', 12:17:54 INFO - 'log_to_console': True, 12:17:54 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:17:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:17:54 INFO - 'opt_config_files': (), 12:17:54 INFO - 'pip_index': False, 12:17:54 INFO - 'sps_profile': False, 12:17:54 INFO - 'sps_profile_interval': 0, 12:17:54 INFO - 'suite': 'dromaeojs', 12:17:54 INFO - 'system_bits': '32', 12:17:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:17:54 INFO - 'title': 'talos-linux64-ix-006', 12:17:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:17:54 INFO - 'use_talos_json': True, 12:17:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:17:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:17:54 INFO - 'work_dir': 'build'} 12:17:54 INFO - [mozharness: 2016-10-05 19:17:54.305018Z] Running clobber step. 12:17:54 INFO - Running pre-action listener: _resource_record_pre_action 12:17:54 INFO - Running main action method: clobber 12:17:54 INFO - rmtree: /builds/slave/test/build 12:17:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:17:55 INFO - Running post-action listener: _resource_record_post_action 12:17:55 INFO - [mozharness: 2016-10-05 19:17:55.287778Z] Finished clobber step (success) 12:17:55 INFO - [mozharness: 2016-10-05 19:17:55.287879Z] Running read-buildbot-config step. 12:17:55 INFO - Running pre-action listener: _resource_record_pre_action 12:17:55 INFO - Running main action method: read_buildbot_config 12:17:55 INFO - Using buildbot properties: 12:17:55 INFO - { 12:17:55 INFO - "project": "", 12:17:55 INFO - "product": "firefox", 12:17:55 INFO - "script_repo_revision": "production", 12:17:55 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 12:17:55 INFO - "repository": "", 12:17:55 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 12:17:55 INFO - "buildid": "20161005093122", 12:17:55 INFO - "pgo_build": "True", 12:17:55 INFO - "basedir": "/builds/slave/test", 12:17:55 INFO - "buildnumber": 1619, 12:17:55 INFO - "slavename": "talos-linux64-ix-006", 12:17:55 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 12:17:55 INFO - "platform": "ubuntu64_hw", 12:17:55 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 12:17:55 INFO - "branch": "fx-team", 12:17:55 INFO - "repo_path": "integration/fx-team", 12:17:55 INFO - "revision": "4f41a594f88d17e25bbfd362f2e45e6dc891bfc6", 12:17:55 INFO - "stage_platform": "linux64-pgo", 12:17:55 INFO - "builduid": "28a0f74e88d74e65b7df45fb5555decc", 12:17:55 INFO - "slavebuilddir": "test" 12:17:55 INFO - } 12:17:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/agED1cJfT4iwz9LEXK3Q3w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 12:17:55 INFO - Running post-action listener: _resource_record_post_action 12:17:55 INFO - [mozharness: 2016-10-05 19:17:55.290599Z] Finished read-buildbot-config step (success) 12:17:55 INFO - [mozharness: 2016-10-05 19:17:55.290687Z] Running download-and-extract step. 12:17:55 INFO - Running pre-action listener: _resource_record_pre_action 12:17:55 INFO - Running main action method: download_and_extract 12:17:55 INFO - mkdir: /builds/slave/test/build/tests 12:17:55 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')]} 12:17:55 INFO - trying https://queue.taskcluster.net/v1/task/agED1cJfT4iwz9LEXK3Q3w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 12:17:55 INFO - Downloading https://queue.taskcluster.net/v1/task/agED1cJfT4iwz9LEXK3Q3w/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 12:17:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/agED1cJfT4iwz9LEXK3Q3w/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 12:17:55 INFO - Downloaded 1361 bytes. 12:17:55 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 12:17:55 INFO - Using the following test package requirements: 12:17:55 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 12:17:55 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:17:55 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:17:55 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:17:55 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:17:55 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:17:55 INFO - u'jsshell-linux-x86_64.zip'], 12:17:55 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:17:55 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:17:55 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 12:17:55 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:17:55 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:17:55 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:17:55 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:17:55 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:17:55 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:17:55 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:17:55 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:17:55 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:17:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/agED1cJfT4iwz9LEXK3Q3w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 12:17:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/agED1cJfT4iwz9LEXK3Q3w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:17:55 INFO - Fetch https://queue.taskcluster.net/v1/task/agED1cJfT4iwz9LEXK3Q3w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 12:17:56 INFO - Http code: 200 12:17:56 INFO - via: 1.1 441811a054e8d055b893175754efd0c3.cloudfront.net (CloudFront) 12:17:56 INFO - x-amz-cf-id: t1Qzh8o9LsC9HYf3zrLMwIE_3Ek4GtFTZVVOwnM36MnUTEBDCil2OA== 12:17:56 INFO - x-amz-version-id: bl_ixfWmO4BGEt6._zEiJGVuUJNsYyZ5 12:17:56 INFO - Expected file size: 21993014 12:17:56 INFO - Obtained file size: 21993014 12:18:00 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 12:18:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/agED1cJfT4iwz9LEXK3Q3w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 12:18:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/agED1cJfT4iwz9LEXK3Q3w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:18:00 INFO - Fetch https://queue.taskcluster.net/v1/task/agED1cJfT4iwz9LEXK3Q3w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 12:18:01 INFO - Http code: 200 12:18:01 INFO - via: 1.1 e30ae5b3d9f6779a9b8bc992faad0b09.cloudfront.net (CloudFront) 12:18:01 INFO - x-amz-cf-id: vfl0z9MidpRUaIx5EEzR6TleJVTC9FogDSbB5nT57NoVOj5VU-2Njg== 12:18:01 INFO - x-amz-version-id: bl_ixfWmO4BGEt6._zEiJGVuUJNsYyZ5 12:18:01 INFO - Expected file size: 21993014 12:18:01 INFO - Obtained file size: 21993014 12:18:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/agED1cJfT4iwz9LEXK3Q3w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 12:18:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/agED1cJfT4iwz9LEXK3Q3w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:18:06 INFO - Fetch https://queue.taskcluster.net/v1/task/agED1cJfT4iwz9LEXK3Q3w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 12:18:06 INFO - Http code: 200 12:18:06 INFO - via: 1.1 23172d761378a3865feafcda78328053.cloudfront.net (CloudFront) 12:18:06 INFO - x-amz-cf-id: RhKlEO_zOcCPcQixkwEfMxPbGP_wyXTuiwiQJhjAXoEGVPd6cy7xYw== 12:18:06 INFO - x-amz-version-id: UP9cql64TdGkRzKn0IJUz3UctCG_UuL7 12:18:06 INFO - Expected file size: 14409006 12:18:06 INFO - Obtained file size: 14409006 12:18:07 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')]} 12:18:07 INFO - trying https://queue.taskcluster.net/v1/task/agED1cJfT4iwz9LEXK3Q3w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 12:18:07 INFO - Downloading https://queue.taskcluster.net/v1/task/agED1cJfT4iwz9LEXK3Q3w/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 12:18:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/agED1cJfT4iwz9LEXK3Q3w/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 12:18:08 INFO - Downloaded 59700662 bytes. 12:18:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/agED1cJfT4iwz9LEXK3Q3w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 12:18:08 INFO - mkdir: /builds/slave/test/properties 12:18:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:18:08 INFO - Writing to file /builds/slave/test/properties/build_url 12:18:08 INFO - Contents: 12:18:08 INFO - build_url:https://queue.taskcluster.net/v1/task/agED1cJfT4iwz9LEXK3Q3w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 12:18:08 INFO - Running post-action listener: _resource_record_post_action 12:18:08 INFO - Running post-action listener: set_extra_try_arguments 12:18:08 INFO - [mozharness: 2016-10-05 19:18:08.946826Z] Finished download-and-extract step (success) 12:18:08 INFO - [mozharness: 2016-10-05 19:18:08.947125Z] Running populate-webroot step. 12:18:08 INFO - Running pre-action listener: _resource_record_pre_action 12:18:08 INFO - Running main action method: populate_webroot 12:18:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:18:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:18:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:18:08 INFO - '--tppagecycles', 12:18:08 INFO - '7'], 12:18:08 INFO - 'tests': ['tsvgm']}}, 12:18:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:18:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:18:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:18:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:18:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:18:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:18:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:18:08 INFO - 'talos_options': ['--disable-e10s'], 12:18:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:18:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:18:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:18:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:18:08 INFO - 'talos_options': ['--disable-e10s'], 12:18:08 INFO - 'tests': ['damp', 'tps']}, 12:18:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:18:08 INFO - 'tests': ['damp', 'tps']}, 12:18:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:18:08 INFO - 'tests': ['dromaeo_dom']}, 12:18:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:18:08 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:18:08 INFO - 'tests': ['basic_compositor_video']}, 12:18:08 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:18:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:18:08 INFO - 'tests': ['a11yr', 12:18:08 INFO - 'ts_paint', 12:18:08 INFO - 'tpaint', 12:18:08 INFO - 'sessionrestore', 12:18:08 INFO - 'sessionrestore_no_auto_restore', 12:18:08 INFO - 'tabpaint']}, 12:18:08 INFO - 'other-e10s': {'tests': ['a11yr', 12:18:08 INFO - 'ts_paint', 12:18:08 INFO - 'tpaint', 12:18:08 INFO - 'sessionrestore', 12:18:08 INFO - 'sessionrestore_no_auto_restore', 12:18:08 INFO - 'tabpaint']}, 12:18:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:18:08 INFO - 'ts_paint', 12:18:08 INFO - 'tpaint', 12:18:08 INFO - 'sessionrestore', 12:18:08 INFO - 'sessionrestore_no_auto_restore', 12:18:08 INFO - 'tabpaint']}, 12:18:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:18:08 INFO - 'ts_paint', 12:18:08 INFO - 'tpaint', 12:18:08 INFO - 'sessionrestore', 12:18:08 INFO - 'sessionrestore_no_auto_restore', 12:18:08 INFO - 'tabpaint']}, 12:18:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:18:08 INFO - 'tests': ['a11yr', 12:18:08 INFO - 'ts_paint', 12:18:08 INFO - 'tpaint', 12:18:08 INFO - 'sessionrestore', 12:18:08 INFO - 'sessionrestore_no_auto_restore', 12:18:08 INFO - 'tabpaint']}, 12:18:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:18:08 INFO - 'tests': ['a11yr', 12:18:08 INFO - 'ts_paint', 12:18:08 INFO - 'tpaint', 12:18:08 INFO - 'sessionrestore', 12:18:08 INFO - 'sessionrestore_no_auto_restore', 12:18:08 INFO - 'tabpaint']}, 12:18:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:18:08 INFO - 'tests': ['tsvgx', 12:18:08 INFO - 'tsvgr_opacity', 12:18:08 INFO - 'tart', 12:18:08 INFO - 'tscrollx', 12:18:08 INFO - 'cart']}, 12:18:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:18:08 INFO - 'tsvgr_opacity', 12:18:08 INFO - 'tart', 12:18:08 INFO - 'tscrollx', 12:18:08 INFO - 'cart']}, 12:18:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:18:08 INFO - 'talos_options': ['--disable-e10s'], 12:18:08 INFO - 'tests': ['tp5o']}, 12:18:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:18:08 INFO - 'tests': ['tp5o']}, 12:18:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:18:08 INFO - 'talos_options': ['--disable-e10s', 12:18:08 INFO - '--xperf_path', 12:18:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:18:08 INFO - 'tests': ['tp5n']}, 12:18:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:18:08 INFO - 'talos_options': ['--xperf_path', 12:18:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:18:08 INFO - 'tests': ['tp5n']}}, 12:18:08 INFO - 'talos.zip': {'path': '', 12:18:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:18:08 INFO - Running post-action listener: _resource_record_post_action 12:18:08 INFO - [mozharness: 2016-10-05 19:18:08.966870Z] Finished populate-webroot step (success) 12:18:08 INFO - [mozharness: 2016-10-05 19:18:08.966962Z] Running create-virtualenv step. 12:18:08 INFO - Running pre-action listener: _resource_record_pre_action 12:18:08 INFO - Running main action method: create_virtualenv 12:18:08 INFO - Creating virtualenv /builds/slave/test/build/venv 12:18:08 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 12:18:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:18:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:18:09 INFO - Using real prefix '/usr' 12:18:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:18:09 INFO - Installing distribute.............................................................................................................................................................................................done. 12:18:11 INFO - Installing pip.................done. 12:18:11 INFO - Return code: 0 12:18:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:18:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:18:11 INFO - Reading from file tmpfile_stdout 12:18:11 INFO - Output received: 12:18:11 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) 12:18:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:18: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')]} 12:18:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:18:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18: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')]} 12:18:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:18:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc54b144f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdf5790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf2930>, '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 0xdf3830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdf3cc0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1475694158.600154-486825302', '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 12:18: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', 'pip>=1.5'] in /builds/slave/test/build 12:18: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 pip>=1.5 12:18:11 INFO - Using env: {'DISPLAY': ':0', 12:18:11 INFO - 'HOME': '/home/cltbld', 12:18:11 INFO - 'LANG': 'en_US.UTF-8', 12:18:11 INFO - 'LANGUAGE': 'en_US:en', 12:18:11 INFO - 'LOGNAME': 'cltbld', 12:18:11 INFO - 'MAIL': '/var/mail/cltbld', 12:18:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:18:11 INFO - 'MOZ_NO_REMOTE': '1', 12:18:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:18:11 INFO - 'NO_EM_RESTART': '1', 12:18:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:18:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:18:11 INFO - 'PWD': '/builds/slave/test', 12:18:11 INFO - 'SHELL': '/bin/bash', 12:18:11 INFO - 'SHLVL': '1', 12:18:11 INFO - 'TERM': 'linux', 12:18:11 INFO - 'TMOUT': '86400', 12:18:11 INFO - 'USER': 'cltbld', 12:18:11 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1475694158.600154-486825302', 12:18:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:18:11 INFO - '_': '/tools/buildbot/bin/python'} 12:18:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:18:11 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 12:18:11 INFO - Cleaning up... 12:18:11 INFO - Return code: 0 12:18:11 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:18: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')]} 12:18:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:18:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18: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')]} 12:18:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:18:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18: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', '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 0x7fc54b144f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdf5790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf2930>, '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 0xdf3830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdf3cc0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1475694158.600154-486825302', '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 12:18: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', 'psutil>=3.1.1'] in /builds/slave/test/build 12:18: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 psutil>=3.1.1 12:18:11 INFO - Using env: {'DISPLAY': ':0', 12:18:11 INFO - 'HOME': '/home/cltbld', 12:18:11 INFO - 'LANG': 'en_US.UTF-8', 12:18:11 INFO - 'LANGUAGE': 'en_US:en', 12:18:11 INFO - 'LOGNAME': 'cltbld', 12:18:11 INFO - 'MAIL': '/var/mail/cltbld', 12:18:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:18:11 INFO - 'MOZ_NO_REMOTE': '1', 12:18:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:18:11 INFO - 'NO_EM_RESTART': '1', 12:18:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:18:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:18:11 INFO - 'PWD': '/builds/slave/test', 12:18:11 INFO - 'SHELL': '/bin/bash', 12:18:11 INFO - 'SHLVL': '1', 12:18:11 INFO - 'TERM': 'linux', 12:18:11 INFO - 'TMOUT': '86400', 12:18:11 INFO - 'USER': 'cltbld', 12:18:11 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1475694158.600154-486825302', 12:18:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:18:11 INFO - '_': '/tools/buildbot/bin/python'} 12:18:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:18:12 INFO - Downloading/unpacking psutil>=3.1.1 12:18:12 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 12:18:12 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 12:18:12 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 12:18:12 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 12:18:12 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 12:18:12 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 12:18:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:18:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:18:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:18:14 INFO - Installing collected packages: psutil 12:18:14 INFO - Running setup.py install for psutil 12:18:14 INFO - building 'psutil._psutil_linux' extension 12:18:14 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 12:18:14 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 12:18:14 INFO - building 'psutil._psutil_posix' extension 12:18:14 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 12:18:14 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 12:18:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:18:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:18:14 INFO - Successfully installed psutil 12:18:14 INFO - Cleaning up... 12:18:14 INFO - Return code: 0 12:18:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:18: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')]} 12:18:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:18:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18: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')]} 12:18:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:18:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc54b144f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdf5790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf2930>, '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 0xdf3830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdf3cc0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1475694158.600154-486825302', '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 12:18: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 12:18: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 mozsystemmonitor==0.3 12:18:14 INFO - Using env: {'DISPLAY': ':0', 12:18:14 INFO - 'HOME': '/home/cltbld', 12:18:14 INFO - 'LANG': 'en_US.UTF-8', 12:18:14 INFO - 'LANGUAGE': 'en_US:en', 12:18:14 INFO - 'LOGNAME': 'cltbld', 12:18:14 INFO - 'MAIL': '/var/mail/cltbld', 12:18:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:18:14 INFO - 'MOZ_NO_REMOTE': '1', 12:18:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:18:14 INFO - 'NO_EM_RESTART': '1', 12:18:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:18:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:18:14 INFO - 'PWD': '/builds/slave/test', 12:18:14 INFO - 'SHELL': '/bin/bash', 12:18:14 INFO - 'SHLVL': '1', 12:18:14 INFO - 'TERM': 'linux', 12:18:14 INFO - 'TMOUT': '86400', 12:18:14 INFO - 'USER': 'cltbld', 12:18:14 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1475694158.600154-486825302', 12:18:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:18:14 INFO - '_': '/tools/buildbot/bin/python'} 12:18:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:18:14 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:18: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 12:18: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 12:18: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 12:18: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 12:18: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 12:18: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 12:18:16 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:18:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:18:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:18:16 INFO - Installing collected packages: mozsystemmonitor 12:18:16 INFO - Running setup.py install for mozsystemmonitor 12:18:16 INFO - Successfully installed mozsystemmonitor 12:18:16 INFO - Cleaning up... 12:18:17 INFO - Return code: 0 12:18:17 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:18: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')]} 12:18:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:18:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18: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')]} 12:18:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:18:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:17 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 0x7fc54b144f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdf5790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf2930>, '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 0xdf3830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdf3cc0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1475694158.600154-486825302', '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 12:18:17 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 12:18:17 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 12:18:17 INFO - Using env: {'DISPLAY': ':0', 12:18:17 INFO - 'HOME': '/home/cltbld', 12:18:17 INFO - 'LANG': 'en_US.UTF-8', 12:18:17 INFO - 'LANGUAGE': 'en_US:en', 12:18:17 INFO - 'LOGNAME': 'cltbld', 12:18:17 INFO - 'MAIL': '/var/mail/cltbld', 12:18:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:18:17 INFO - 'MOZ_NO_REMOTE': '1', 12:18:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:18:17 INFO - 'NO_EM_RESTART': '1', 12:18:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:18:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:18:17 INFO - 'PWD': '/builds/slave/test', 12:18:17 INFO - 'SHELL': '/bin/bash', 12:18:17 INFO - 'SHLVL': '1', 12:18:17 INFO - 'TERM': 'linux', 12:18:17 INFO - 'TMOUT': '86400', 12:18:17 INFO - 'USER': 'cltbld', 12:18:17 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1475694158.600154-486825302', 12:18:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:18:17 INFO - '_': '/tools/buildbot/bin/python'} 12:18:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:18:17 INFO - Downloading/unpacking jsonschema==2.5.1 12:18: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 12:18: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 12:18: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 12:18: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 12:18: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 12:18: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 12:18:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:18:19 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:18:19 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 12:18:19 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 12:18:19 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 12:18:19 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 12:18:19 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 12:18:19 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 12:18:19 INFO - Downloading functools32-3.2.3-2.tar.gz 12:18:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:18:19 INFO - warning: no files found matching '*.txt' 12:18:19 INFO - no previously-included directories found matching 'build' 12:18:19 INFO - no previously-included directories found matching 'dist' 12:18:19 INFO - no previously-included directories found matching '.git*' 12:18:19 INFO - Installing collected packages: jsonschema, functools32 12:18:19 INFO - Running setup.py install for functools32 12:18:19 INFO - warning: no files found matching '*.txt' 12:18:19 INFO - no previously-included directories found matching 'build' 12:18:19 INFO - no previously-included directories found matching 'dist' 12:18:19 INFO - no previously-included directories found matching '.git*' 12:18:19 INFO - Successfully installed jsonschema functools32 12:18:19 INFO - Cleaning up... 12:18:19 INFO - Return code: 0 12:18:19 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:18:19 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')]} 12:18:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:18:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:19 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')]} 12:18:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:18:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:19 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 0x7fc54b144f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdf5790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf2930>, '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 0xdf3830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdf3cc0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1475694158.600154-486825302', '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 12:18:19 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 12:18:19 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 12:18:19 INFO - Using env: {'DISPLAY': ':0', 12:18:19 INFO - 'HOME': '/home/cltbld', 12:18:19 INFO - 'LANG': 'en_US.UTF-8', 12:18:19 INFO - 'LANGUAGE': 'en_US:en', 12:18:19 INFO - 'LOGNAME': 'cltbld', 12:18:19 INFO - 'MAIL': '/var/mail/cltbld', 12:18:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:18:19 INFO - 'MOZ_NO_REMOTE': '1', 12:18:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:18:19 INFO - 'NO_EM_RESTART': '1', 12:18:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:18:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:18:19 INFO - 'PWD': '/builds/slave/test', 12:18:19 INFO - 'SHELL': '/bin/bash', 12:18:19 INFO - 'SHLVL': '1', 12:18:19 INFO - 'TERM': 'linux', 12:18:19 INFO - 'TMOUT': '86400', 12:18:19 INFO - 'USER': 'cltbld', 12:18:19 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1475694158.600154-486825302', 12:18:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:18:19 INFO - '_': '/tools/buildbot/bin/python'} 12:18:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:18:19 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:18:19 INFO - Cleaning up... 12:18:19 INFO - Return code: 0 12:18:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:18:19 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')]} 12:18:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:18:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:19 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')]} 12:18:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:18:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:19 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 0x7fc54b144f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdf5790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf2930>, '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 0xdf3830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdf3cc0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1475694158.600154-486825302', '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 12:18:19 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 12:18:19 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 12:18:19 INFO - Using env: {'DISPLAY': ':0', 12:18:19 INFO - 'HOME': '/home/cltbld', 12:18:19 INFO - 'LANG': 'en_US.UTF-8', 12:18:19 INFO - 'LANGUAGE': 'en_US:en', 12:18:19 INFO - 'LOGNAME': 'cltbld', 12:18:19 INFO - 'MAIL': '/var/mail/cltbld', 12:18:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:18:19 INFO - 'MOZ_NO_REMOTE': '1', 12:18:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:18:19 INFO - 'NO_EM_RESTART': '1', 12:18:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:18:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:18:19 INFO - 'PWD': '/builds/slave/test', 12:18:19 INFO - 'SHELL': '/bin/bash', 12:18:19 INFO - 'SHLVL': '1', 12:18:19 INFO - 'TERM': 'linux', 12:18:19 INFO - 'TMOUT': '86400', 12:18:19 INFO - 'USER': 'cltbld', 12:18:19 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1475694158.600154-486825302', 12:18:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:18:19 INFO - '_': '/tools/buildbot/bin/python'} 12:18:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:18:20 INFO - Downloading/unpacking blobuploader==1.2.4 12:18:20 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 12:18:20 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 12:18:20 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 12:18:20 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 12:18:20 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 12:18:20 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 12:18:21 INFO - Downloading blobuploader-1.2.4.tar.gz 12:18:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:18:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:18: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 12:18: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 12:18: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 12:18: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 12:18: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 12:18: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 12:18:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:18:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:18: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 12:18: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 12:18: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 12:18: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 12:18: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 12:18: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 12:18:22 INFO - Downloading docopt-0.6.1.tar.gz 12:18:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:18:22 INFO - Installing collected packages: blobuploader, requests, docopt 12:18:22 INFO - Running setup.py install for blobuploader 12:18:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:18:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:18:22 INFO - Running setup.py install for requests 12:18:23 INFO - Running setup.py install for docopt 12:18:23 INFO - Successfully installed blobuploader requests docopt 12:18:23 INFO - Cleaning up... 12:18:23 INFO - Return code: 0 12:18:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:18:23 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')]} 12:18:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:18:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:23 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')]} 12:18:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:18:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:23 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 0x7fc54b144f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdf5790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf2930>, '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 0xdf3830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdf3cc0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1475694158.600154-486825302', '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 12:18:23 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 12:18:23 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 12:18:23 INFO - Using env: {'DISPLAY': ':0', 12:18:23 INFO - 'HOME': '/home/cltbld', 12:18:23 INFO - 'LANG': 'en_US.UTF-8', 12:18:23 INFO - 'LANGUAGE': 'en_US:en', 12:18:23 INFO - 'LOGNAME': 'cltbld', 12:18:23 INFO - 'MAIL': '/var/mail/cltbld', 12:18:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:18:23 INFO - 'MOZ_NO_REMOTE': '1', 12:18:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:18:23 INFO - 'NO_EM_RESTART': '1', 12:18:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:18:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:18:23 INFO - 'PWD': '/builds/slave/test', 12:18:23 INFO - 'SHELL': '/bin/bash', 12:18:23 INFO - 'SHLVL': '1', 12:18:23 INFO - 'TERM': 'linux', 12:18:23 INFO - 'TMOUT': '86400', 12:18:23 INFO - 'USER': 'cltbld', 12:18:23 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1475694158.600154-486825302', 12:18:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:18:23 INFO - '_': '/tools/buildbot/bin/python'} 12:18:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:18:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:18:23 INFO - Running setup.py (path:/tmp/pip-Uy1oat-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:18:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:18:23 INFO - Running setup.py (path:/tmp/pip-gg_gwh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:18:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:18:23 INFO - Running setup.py (path:/tmp/pip-VXFbvG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:18:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:18:23 INFO - Running setup.py (path:/tmp/pip-BgrWOv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:18:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:18:23 INFO - Running setup.py (path:/tmp/pip-lnxojl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:18:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:18:23 INFO - Running setup.py (path:/tmp/pip-iLSNKi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:18:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:18:24 INFO - Running setup.py (path:/tmp/pip-rbD8xa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:18:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:18:24 INFO - Running setup.py (path:/tmp/pip-Wx2oh9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:18:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:18:24 INFO - Running setup.py (path:/tmp/pip-ZQF4Ar-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:18:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:18:24 INFO - Running setup.py (path:/tmp/pip-s0UIL5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:18:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:18:24 INFO - Running setup.py (path:/tmp/pip-1hD_pM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:18:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:18:24 INFO - Running setup.py (path:/tmp/pip-HUnhwB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:18:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:18:24 INFO - Running setup.py (path:/tmp/pip-97FXPX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:18:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:18:24 INFO - Running setup.py (path:/tmp/pip-htY6dM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:18:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:18:24 INFO - Running setup.py (path:/tmp/pip-XR9Mqn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:18:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:18:24 INFO - Running setup.py (path:/tmp/pip-2RS7yN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:18:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:18:24 INFO - Running setup.py (path:/tmp/pip-im2rf_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:18:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:18:24 INFO - Running setup.py install for manifestparser 12:18:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:18:24 INFO - Running setup.py install for mozcrash 12:18:25 INFO - Running setup.py install for mozdebug 12:18:25 INFO - Running setup.py install for mozdevice 12:18:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:18:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:18:25 INFO - Running setup.py install for mozfile 12:18:25 INFO - Running setup.py install for mozhttpd 12:18:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:18:25 INFO - Running setup.py install for mozinfo 12:18:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:18:25 INFO - Running setup.py install for mozInstall 12:18:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:18:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:18:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:18:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:18:25 INFO - Running setup.py install for mozleak 12:18:25 INFO - Running setup.py install for mozlog 12:18:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:18:25 INFO - Running setup.py install for moznetwork 12:18:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:18:25 INFO - Running setup.py install for mozprocess 12:18:26 INFO - Running setup.py install for mozprofile 12:18:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:18:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:18:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:18:26 INFO - Running setup.py install for mozrunner 12:18:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:18:26 INFO - Running setup.py install for mozscreenshot 12:18:26 INFO - Running setup.py install for moztest 12:18:26 INFO - Running setup.py install for mozversion 12:18:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:18:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:18:26 INFO - Cleaning up... 12:18:26 INFO - Return code: 0 12:18:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:18:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:18:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:18:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:18:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:18:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:26 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 0x7fc54b144f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdf5790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf2930>, '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 0xdf3830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdf3cc0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1475694158.600154-486825302', '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 12:18:26 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 12:18:26 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 12:18:26 INFO - Using env: {'DISPLAY': ':0', 12:18:26 INFO - 'HOME': '/home/cltbld', 12:18:26 INFO - 'LANG': 'en_US.UTF-8', 12:18:26 INFO - 'LANGUAGE': 'en_US:en', 12:18:26 INFO - 'LOGNAME': 'cltbld', 12:18:26 INFO - 'MAIL': '/var/mail/cltbld', 12:18:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:18:26 INFO - 'MOZ_NO_REMOTE': '1', 12:18:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:18:26 INFO - 'NO_EM_RESTART': '1', 12:18:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:18:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:18:26 INFO - 'PWD': '/builds/slave/test', 12:18:26 INFO - 'SHELL': '/bin/bash', 12:18:26 INFO - 'SHLVL': '1', 12:18:26 INFO - 'TERM': 'linux', 12:18:26 INFO - 'TMOUT': '86400', 12:18:26 INFO - 'USER': 'cltbld', 12:18:26 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1475694158.600154-486825302', 12:18:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:18:26 INFO - '_': '/tools/buildbot/bin/python'} 12:18:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:18:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:18:26 INFO - Running setup.py (path:/tmp/pip-acu4Td-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:18:26 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)) 12:18:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:18:26 INFO - Running setup.py (path:/tmp/pip-ZlRKZ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:18:27 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)) 12:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:18:27 INFO - Running setup.py (path:/tmp/pip-Xl_p32-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:18:27 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)) 12:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:18:27 INFO - Running setup.py (path:/tmp/pip-jQcnF4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:18:27 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)) 12:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:18:27 INFO - Running setup.py (path:/tmp/pip-irFQWo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:18:27 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)) 12:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:18:27 INFO - Running setup.py (path:/tmp/pip-dpgFjk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:18:27 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)) 12:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:18:27 INFO - Running setup.py (path:/tmp/pip-KhKxWm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:18:27 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)) 12:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:18:27 INFO - Running setup.py (path:/tmp/pip-UXfBeN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:18:27 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)) 12:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:18:27 INFO - Running setup.py (path:/tmp/pip-Nch06y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:18:27 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)) 12:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:18:27 INFO - Running setup.py (path:/tmp/pip-IHtv2k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:18:27 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)) 12:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:18:27 INFO - Running setup.py (path:/tmp/pip-V1Y4TO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:18:27 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)) 12:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:18:27 INFO - Running setup.py (path:/tmp/pip-Kmga_1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:18:27 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)) 12:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:18:27 INFO - Running setup.py (path:/tmp/pip-b3Sq6F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:18:27 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)) 12:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:18:27 INFO - Running setup.py (path:/tmp/pip-QW9p5H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:18:27 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)) 12:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:18:27 INFO - Running setup.py (path:/tmp/pip-Pe1MPV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:18:27 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)) 12:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:18:27 INFO - Running setup.py (path:/tmp/pip-vvuKh1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:18:28 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)) 12:18:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:18:28 INFO - Running setup.py (path:/tmp/pip-8Jr66B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:18:28 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)) 12:18:28 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)) 12:18:28 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)) 12:18:28 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)) 12:18:28 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)) 12:18:28 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)) 12:18:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:18:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:18:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:18:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:18:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:18:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:18:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:18:30 INFO - Downloading blessings-1.6.tar.gz 12:18:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:18:30 INFO - Installing collected packages: blessings 12:18:30 INFO - Running setup.py install for blessings 12:18:30 INFO - Successfully installed blessings 12:18:30 INFO - Cleaning up... 12:18:30 INFO - Return code: 0 12:18:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:18:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:18:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:18:30 INFO - Reading from file tmpfile_stdout 12:18:30 INFO - Current package versions: 12:18:30 INFO - argparse == 1.2.1 12:18:30 INFO - blessings == 1.6 12:18:30 INFO - blobuploader == 1.2.4 12:18:30 INFO - docopt == 0.6.1 12:18:30 INFO - functools32 == 3.2.3-2 12:18:30 INFO - jsonschema == 2.5.1 12:18:30 INFO - manifestparser == 1.1 12:18:30 INFO - mozInstall == 1.12 12:18:30 INFO - mozcrash == 0.17 12:18:30 INFO - mozdebug == 0.1 12:18:30 INFO - mozdevice == 0.48 12:18:30 INFO - mozfile == 1.2 12:18:30 INFO - mozhttpd == 0.7 12:18:30 INFO - mozinfo == 0.9 12:18:30 INFO - mozleak == 0.1 12:18:30 INFO - mozlog == 3.4 12:18:30 INFO - moznetwork == 0.27 12:18:30 INFO - mozprocess == 0.23 12:18:30 INFO - mozprofile == 0.28 12:18:30 INFO - mozrunner == 6.12 12:18:30 INFO - mozscreenshot == 0.1 12:18:30 INFO - mozsystemmonitor == 0.3 12:18:30 INFO - moztest == 0.7 12:18:30 INFO - mozversion == 1.4 12:18:30 INFO - psutil == 3.1.1 12:18:30 INFO - requests == 1.2.3 12:18:30 INFO - wsgiref == 0.1.2 12:18:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:18:30 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')]} 12:18:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:18:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:30 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')]} 12:18:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:18:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:30 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 0x7fc54b144f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdf5790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf2930>, '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 0xdf3830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdf3cc0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1475694158.600154-486825302', '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 12:18:30 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 12:18:30 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 12:18:30 INFO - Using env: {'DISPLAY': ':0', 12:18:30 INFO - 'HOME': '/home/cltbld', 12:18:30 INFO - 'LANG': 'en_US.UTF-8', 12:18:30 INFO - 'LANGUAGE': 'en_US:en', 12:18:30 INFO - 'LOGNAME': 'cltbld', 12:18:30 INFO - 'MAIL': '/var/mail/cltbld', 12:18:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:18:30 INFO - 'MOZ_NO_REMOTE': '1', 12:18:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:18:30 INFO - 'NO_EM_RESTART': '1', 12:18:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:18:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:18:30 INFO - 'PWD': '/builds/slave/test', 12:18:30 INFO - 'SHELL': '/bin/bash', 12:18:30 INFO - 'SHLVL': '1', 12:18:30 INFO - 'TERM': 'linux', 12:18:30 INFO - 'TMOUT': '86400', 12:18:30 INFO - 'USER': 'cltbld', 12:18:30 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1475694158.600154-486825302', 12:18:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:18:30 INFO - '_': '/tools/buildbot/bin/python'} 12:18:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:18:30 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)) 12:18:30 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)) 12:18:30 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)) 12:18:30 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)) 12:18:30 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)) 12:18:30 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)) 12:18:30 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)) 12:18:30 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)) 12:18:30 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)) 12:18:30 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)) 12:18:30 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)) 12:18:30 INFO - Cleaning up... 12:18:30 INFO - Return code: 0 12:18:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:18:30 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')]} 12:18:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:18:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:30 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')]} 12:18:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:18:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:30 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 0x7fc54b144f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdf5790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf2930>, '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 0xdf3830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdf3cc0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1475694158.600154-486825302', '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 12:18:30 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 12:18:30 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 12:18:30 INFO - Using env: {'DISPLAY': ':0', 12:18:30 INFO - 'HOME': '/home/cltbld', 12:18:30 INFO - 'LANG': 'en_US.UTF-8', 12:18:30 INFO - 'LANGUAGE': 'en_US:en', 12:18:30 INFO - 'LOGNAME': 'cltbld', 12:18:30 INFO - 'MAIL': '/var/mail/cltbld', 12:18:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:18:30 INFO - 'MOZ_NO_REMOTE': '1', 12:18:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:18:30 INFO - 'NO_EM_RESTART': '1', 12:18:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:18:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:18:30 INFO - 'PWD': '/builds/slave/test', 12:18:30 INFO - 'SHELL': '/bin/bash', 12:18:30 INFO - 'SHLVL': '1', 12:18:30 INFO - 'TERM': 'linux', 12:18:30 INFO - 'TMOUT': '86400', 12:18:30 INFO - 'USER': 'cltbld', 12:18:30 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1475694158.600154-486825302', 12:18:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:18:30 INFO - '_': '/tools/buildbot/bin/python'} 12:18:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:18:30 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:18:30 INFO - Cleaning up... 12:18:30 INFO - Return code: 0 12:18:30 INFO - Running post-action listener: _resource_record_post_action 12:18:30 INFO - Running post-action listener: _start_resource_monitoring 12:18:30 INFO - Starting resource monitoring. 12:18:30 INFO - [mozharness: 2016-10-05 19:18:30.989843Z] Finished create-virtualenv step (success) 12:18:30 INFO - [mozharness: 2016-10-05 19:18:30.990426Z] Running install step. 12:18:30 INFO - Running pre-action listener: _resource_record_pre_action 12:18:30 INFO - Running main action method: install 12:18:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:18:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:18:31 INFO - Reading from file tmpfile_stdout 12:18:31 INFO - Detecting whether we're running mozinstall >=1.0... 12:18:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:18:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:18:31 INFO - Reading from file tmpfile_stdout 12:18:31 INFO - Output received: 12:18:31 INFO - Usage: mozinstall [options] installer 12:18:31 INFO - Options: 12:18:31 INFO - -h, --help show this help message and exit 12:18:31 INFO - -d DEST, --destination=DEST 12:18:31 INFO - Directory to install application into. [default: 12:18:31 INFO - "/builds/slave/test"] 12:18:31 INFO - --app=APP Application being installed. [default: firefox] 12:18:31 INFO - mkdir: /builds/slave/test/build/application 12:18:31 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'] 12:18:31 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 12:18:48 INFO - Reading from file tmpfile_stdout 12:18:48 INFO - Output received: 12:18:48 INFO - /builds/slave/test/build/application/firefox/firefox 12:18:48 INFO - Running post-action listener: _resource_record_post_action 12:18:48 INFO - [mozharness: 2016-10-05 19:18:48.311991Z] Finished install step (success) 12:18:48 INFO - [mozharness: 2016-10-05 19:18:48.312237Z] Running run-tests step. 12:18:48 INFO - Running pre-action listener: _resource_record_pre_action 12:18:48 INFO - Running main action method: run_tests 12:18:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:18:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:18:48 INFO - Python 2.7.3 12:18:48 INFO - Return code: 0 12:18:48 INFO - grabbing minidump binary from tooltool 12:18:48 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')]} 12:18:48 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 0xdf2930>, '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 0xdf3830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdf3cc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:18:48 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 12:18:48 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 12:18:48 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 12:18:48 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:18:48 INFO - Return code: 0 12:18:48 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:18:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:18:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:18:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:18:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:18:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/agED1cJfT4iwz9LEXK3Q3w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--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 12:18:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/agED1cJfT4iwz9LEXK3Q3w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-006 --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 12:18:48 INFO - Using env: {'DISPLAY': ':0', 12:18:48 INFO - 'HOME': '/home/cltbld', 12:18:48 INFO - 'LANG': 'en_US.UTF-8', 12:18:48 INFO - 'LANGUAGE': 'en_US:en', 12:18:48 INFO - 'LOGNAME': 'cltbld', 12:18:48 INFO - 'MAIL': '/var/mail/cltbld', 12:18:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:18:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:18:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:18:48 INFO - 'MOZ_NO_REMOTE': '1', 12:18:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:18:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:18:48 INFO - 'NO_EM_RESTART': '1', 12:18:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:18:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:18:48 INFO - 'PWD': '/builds/slave/test', 12:18:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:18:48 INFO - 'SHELL': '/bin/bash', 12:18:48 INFO - 'SHLVL': '1', 12:18:48 INFO - 'TERM': 'linux', 12:18:48 INFO - 'TMOUT': '86400', 12:18:48 INFO - 'USER': 'cltbld', 12:18:48 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1475694158.600154-486825302', 12:18:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:18:48 INFO - '_': '/tools/buildbot/bin/python'} 12:18:48 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/agED1cJfT4iwz9LEXK3Q3w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--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 12:18:48 INFO - mozversion application_buildid: 20161005093122 12:18:48 INFO - mozversion application_changeset: 4f41a594f88d17e25bbfd362f2e45e6dc891bfc6 12:18:48 INFO - mozversion application_display_name: Nightly 12:18:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:18:48 INFO - mozversion application_name: Firefox 12:18:48 INFO - mozversion application_remotingname: firefox 12:18:48 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 12:18:48 INFO - mozversion application_vendor: Mozilla 12:18:48 INFO - mozversion application_version: 52.0a1 12:18:48 INFO - mozversion platform_buildid: 20161005093122 12:18:48 INFO - mozversion platform_changeset: 4f41a594f88d17e25bbfd362f2e45e6dc891bfc6 12:18:48 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 12:18:48 INFO - mozversion platform_version: 52.0a1 12:18:48 INFO - using testdate: 1475695128 12:18:48 INFO - actual date: 1475695128 12:18:48 INFO - starting webserver on 'localhost:53389' 12:18:48 INFO - SUITE-START | Running 2 tests 12:18:48 INFO - TEST-START | dromaeo_css 12:18:48 INFO - operating with platform_type : linux_ 12:18:48 INFO - Initialising browser for dromaeo_css test... 12:18:48 INFO - TEST-INFO | started process 9064 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpctplYY/profile http://localhost:53389/getInfo.html) 12:18:53 INFO - PROCESS | 9064 | __metrics Screen width/height:1600/1200 12:18:53 INFO - PROCESS | 9064 | colorDepth:24 12:18:53 INFO - PROCESS | 9064 | Browser inner width/height: 1024/697 12:18:53 INFO - PROCESS | 9064 | __metrics 12:18:53 INFO - PROCESS | 9064 | 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" 12:18:53 INFO - PROCESS | 9064 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:18:54 INFO - PROCESS | 9064 | console.error: PushService: 12:18:54 INFO - PROCESS | 9064 | stateChangeProcessEnqueue: Error transitioning state 12:18:54 INFO - PROCESS | 9064 | UnknownError 12:18:54 INFO - TEST-INFO | 9064: exit 0 12:18:54 INFO - Browser initialized. 12:18:54 INFO - Running cycle 1/1 for dromaeo_css test... 12:18:54 INFO - TEST-INFO | started process 9143 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpctplYY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:19:06 INFO - PROCESS | 9143 | RSS: Main: 173490176 12:19:06 INFO - PROCESS | 9143 | 12:19:58 INFO - PROCESS | 9143 | 1475695198187 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] 12:22:08 INFO - PROCESS | 9143 | Cycle 1(1): loaded http://localhost:53389/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53389/tests/dromaeo/cssquery-ext.html) 12:22:09 INFO - PROCESS | 9143 | RSS: Main: 304312320 12:22:09 INFO - PROCESS | 9143 | 12:25:12 INFO - PROCESS | 9143 | Cycle 1(1): loaded http://localhost:53389/tests/dromaeo/cssquery-ext.html (next: http://localhost:53389/tests/dromaeo/cssquery-jquery.html) 12:25:12 INFO - PROCESS | 9143 | RSS: Main: 269979648 12:25:12 INFO - PROCESS | 9143 | 12:28:14 INFO - PROCESS | 9143 | Cycle 1(1): loaded http://localhost:53389/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53389/tests/dromaeo/cssquery-mootools.html) 12:28:15 INFO - PROCESS | 9143 | RSS: Main: 215748608 12:28:15 INFO - PROCESS | 9143 | 12:31:17 INFO - PROCESS | 9143 | Cycle 1(1): loaded http://localhost:53389/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53389/tests/dromaeo/cssquery-prototype.html) 12:31:18 INFO - PROCESS | 9143 | RSS: Main: 214450176 12:31:18 INFO - PROCESS | 9143 | 12:34:20 INFO - PROCESS | 9143 | Cycle 1(1): loaded http://localhost:53389/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53389/tests/dromaeo/cssquery-yui.html) 12:34:21 INFO - PROCESS | 9143 | RSS: Main: 216858624 12:34:21 INFO - PROCESS | 9143 | 12:37:23 INFO - PROCESS | 9143 | Cycle 1(1): loaded http://localhost:53389/tests/dromaeo/cssquery-yui.html (next: http://localhost:53389/tests/dromaeo/cssquery-dojo.html) 12:37:24 INFO - PROCESS | 9143 | RSS: Main: 296579072 12:37:24 INFO - PROCESS | 9143 | 12:37:24 INFO - PROCESS | 9143 | __start_tp_report 12:37:24 INFO - PROCESS | 9143 | _x_x_mozilla_page_load 12:37:24 INFO - PROCESS | 9143 | _x_x_mozilla_page_load_details 12:37:24 INFO - PROCESS | 9143 | |i|pagename|runs| 12:37:24 INFO - PROCESS | 9143 | |0;dojo.html;2976.7172118648728;2990.237489440191;3008.037428023032;3029.030710172746;3052.1606558196495;5096.515830996059;5162.38051433828;5194;5199.116150254456;5247.763850626726;5165.328507294046;5206.505381988714;5209.374875014994;5264.184051472019;5297.364316282042;4725.291206319045;4758.809647614091;4776.665633405663;4785.545373189559;4846.151923413407;4876.463589005207;4909.140900342443;4911.975440122795;4925.3664350939725;4944;4638.605718513931;4684.3910291662205;4697.271922851964;4836.637252206098;4873.122837889178;4633.142868569325;4636.02643444877;4665.206914824488;4675.766211689402;4740.9288860666775;4596.563326483979;4597.7241365518175;4604.700694454883;4612.7924243409125;4657.441107067174;5042.647014708972;5047.848564543069;5052.8484145475695;5064.746762661852;5102.744862756847;5289.338832645919;5315;5369.275147855029;5379.408265090837;5455.1271796512765;5549.084401073818;5555.250041244421;5561.888762224773;5630.971845140748;5635.549156067505;5176.378834539842;5178.585713142939;5188.143956247215;5217.921731174036;5246.134387826042;5545.306836645419;5561.58288128392;5680.233168522279;5682;5686.3744988051285;5458.181272809031;5518.475744804237;5523.585731070186;5544;5615.550755939515;5578.219049333096;5612.803551875746;5626.381098079208;5629;5633.352164501053;5427.3215848019;5595.608307418442;5602.159676048544;5607.551395888319;5611.775528978795;5301.151815709468;5315.6013299002725;5330.600204984642;5412.621116521806;5467.589930755209;4099.487564054493;4100.323446631332;4103.363978583325;4149.688773341951;4150.896227594274;3657.140571965586;3662.7436079474714;3662.908427289339;3688.5389326334207;3694.538182727159;5166.147585648326;5170.663906846043;5178.715170665574;5219.243209734567;5240.423553409122;5566.832995010156;5599.860003499945;5603.915941260884;5606.6916319602;5681;5313.521783039468;5313.734313284321;5316.840494785085;5318.760655770499;5378.623496355296;4674.649401294849;4714.764261786897;4723.291506274087;4802.567768900815;4816.349792778;5821.970890145522;5839.532837373;5839.912401314069;5891.764329426861;5897.64614123154;5562.276904002616;5566.081596536526;5566.471185237396;5566.4990150886615;5569.944300557105;5407.810726624549;5515.972420137874;5809.30288365382;5811.389804070681;5821.155932389865;5444.455554444524;5498.670079795225;5517.531009864046;5521.944780552143;5592.720363981866;5596.076647353304;5608.887822243614;5617.578681598815;5617.775288988395;5621.7189140542;5436.809711660073;5445.319335083114;5447.400785913625;5450.345958485007;5512.614117011771;5121.8719532012;5153.742312884266;5261.842144735664;5313;5345.091334473227;5362.865928351823;5364.6512976656395;5364.678119312854;5368.194770784414;5410.350757908918;5348.812791552277;5402.486763757437;5406.324209473816;5407.215953686772;5429.294191755047;5086.54221120101;5139.074966506065;5184.300119483973;5244.921326180034;5267.209918512254 12:37:24 INFO - PROCESS | 9143 | |1;ext.html;561.6874189873914;584.643367545797;593.1814096546765;600.8317671052105;612.6752821004868;31447;32082.518762218555;34293.31413371731;34296.31407371851;34301.485477717855;42675.35986960198;44239.336409953874;44330.77834610822;48210.276845847344;48229.51770482303;8867.60095795689;8999;9006.504642244707;9008.414453060563;9010.819783604324;8888.466691998468;8976.775580610505;8981;8982.461052336848;8985.191332780048;8987.865182022275;9016.459012459241;9020.278377729766;9023.819523609523;9027.413218140833;8964.596593153325;9024.23294020009;9024.954875225581;9026.277897768163;9035.277177825757;8833.160849719266;8894.688685896028;8900.465972041633;8901.510416927067;8907.198352148338;42195;42529.149417011795;42547.57452425467;42568;42597.787011065055;3421.863125474978;3628.6915612172997;3691.243295124493;3885.320068987916;3894.5910679378826;31569.684303156904;31731.682683173105;31753.84123079393;31825.204369890707;32022.519662205086;4241.300185469394;4306.9541967565465;4344.087741574273;4459.464864216315;4528.343390208402;330061.3496932524;330254;331859;334302;334696;57695;57974.42025579775;58032.70983645055;58055.70972145197;58073.16012338365;60755;60796.27259638437;60865;60915.69542152261;60964.69517652472;15458.690826183414;15710.450134245246;15717.21413929299;15718.921405392899;15721.292541835644;11180;11192.664220073411;11196.38419886914;11205.60780372683;11205.831912521318;16078;17282.22229999628;17290;17318.913405432893;17437.21532531039;5797.8550536236935;5875.9118613220835;5904.202932604044;5991.910121348184;6063.605865618721;959.9520023998772;1042.2912419554775;1065.8774240962234;1077.8275475923815;1120.5125770289949;30904.69095309063;31466.528002079987;31489.055328340186;31782.2054448636;32068.679313207034;903.3541018172039;1073.6349641122056;1074.6507385099874;1076.6554702495282;1135.1713249328036;16090;17106.572335691708;17117.828821711624;17153.313867445162;17205.655886882192;483164;485240;485746;489126;489959;57130.71434642883;57402.7129864348;57462.13806792818;57466;57507;1181.1908842442954;1215.1858254969193;1269.1877198592908;1329.9202047877159;1333.7332533493145;28645.713542864305;32262.354752904343;32340;32482.675173247964;32725;43312.78343608262;43401.13197736091;43615.56384436115;43658.34512482379;43664.12671746484;353124;354315;356077;356671;357485;26918.73081269162;27873.721262787923;28035;29315.85342073276;39358.409623856234;45935.77032114818;46165;46224.537754622026;46684;47283;39247.21505569816;39371.803140985256;39499.60500394959;41053.589464104974;41149.382759259235;38877.222455551295;39180;39662.60337396589;39983.80008099941;41014.79492602518;39074.609253907096;39819.60180398159;40629.1874162521;40663.79668101641;40824.59175408208;31423.685763142992;35166.47250291299;35781;36319.27361452703;36396;26744.093071603045;26887;27582.86208568944;27688.446231075668;28727.281817954718 12:37:24 INFO - PROCESS | 9143 | |2;jquery.html;369.69500162366023;386.2506736930356;390.61524398467486;393.3018891467645;425.1878911279457;13421.597352079441;18649;18813;19907.402777916686;20075.899620501914;17159.656806863855;17325;17573;17599.296028158857;17915.73126403105;5417.187421886729;5696.202531645573;5700.714964251792;5705.030144875361;5706.400827913051;4010.4585880905997;4232.640225580814;4331.133773245348;5552.472515111058;5648.774049038034;4365.454318210223;6253;6297.685115744194;6306.905396419057;6335.429811316981;6063.878722425548;6194.380561943814;6233.096201050822;6287.402696743825;6302.275238347603;5548.77804887808;5554.111342185231;5556.72216389183;5557.3886872444;5559.27729395176;22119.557608847896;22437.32688019362;22823.77176228233;22869.885650571807;22994.885025574764;2401.1355911871888;2626.632271481994;3047.923801904948;3104.674009229044;3191.48936170214;12944.705529447074;13016.349182540835;13029;13153.736925261537;13417.396217170251;1592.8805339599576;1626.7315892877662;1633.1834082958521;1655.7599148123454;1657.5846906668962;72296;74257.6287118561;74501;74663;75055.24944750537;10126.645567405105;10326.380417174994;10452.529636166391;10473.581056757797;10707;14890.92554537242;14904.776428353583;14954;14981.101133932;14998.325075371635;7721.420893433015;7930.643121059451;7997.840043199103;8226;8333.041700204554;7615.16233214346;7663.386929045663;7680.807979800438;7845.686172553034;7916.525008499509;6330.873382532323;6437.485001199986;6473.546851720429;6578.473722102221;6649.734010639617;1866.216189200512;1868.588910439701;1917.5206198450387;1917.7027560728109;1982.692682634165;902.6118768929292;958.2190514730472;1006.6677996261217;1037.9377237365782;1057.8783439904355;17164.227609757592;18335.541611459554;18517.90741046286;18751.34370297033;19190.338850039272;983.3215081593678;1002.3584905660383;1007.9244056695777;1015.2334987084852;1041.8853926068127;7774.533527988338;10635.734106647242;10741.677749667522;10784.40685762275;10803.78392432147;428116;431933.571292881;453212.0952859434;454316;457776;89572.55213723889;89755.55122224477;90210;90217;90926.54536727275;1035.7048241251207;1106.4744246482855;1119.798436281477;1135.778523187987;1141.8458508101467;15222.695546089237;16780;17113.828861711223;17269.39557115495;17586.82413175852;42359.7882010588;42780;43532;43587;43739;52028.739856300475;53499.79001259937;56948.71525642345;57690.42309577019;58945.41054589399;10943.124550036136;11548.884511155116;11815.586454474053;11907.345096019802;12276.815847762113;12974.351282435651;13537.59387218385;13611.86388136106;13620.727585448434;13740.725185496434;11536.538538458368;11636.709082273012;11710.94144529272;11896.22674526153;12543.56097536582;10765.3540787553;11343.773124537298;11590.014848737614;11633.243839150427;11862.644120676394;11146.888531114586;11943.343116128697;11945.283283003047;12009.699757506132;12629.873701263237;11933;12260.632181034583;12283.263004219776;12297.56958506448;12680.239185648521;11810.291382517076;11919.702007449883;12116.221503573226;12138.635840924786;12543.435545400662 12:37:24 INFO - PROCESS | 9143 | |3;mootools.html;1364.965875853104;1400.9339559706473;1461.817272840895;1575.6769862178255;1792.8834625749316;7797.532148071113;8561.529115898631;8908.821823563541;8927.553622318883;9110.45337279762;8960.148785865333;8962.058983806688;9011.504367259799;9023.278137748981;9034.277257819374;2072.9481762955934;2120.056574824204;2122.649762789138;2126.9787302126933;2131.8187954023847;2065.287475820847;2090.4878304815343;2138.839587030971;2140.176032227596;2140.625390556654;2128.8190503807195;2148.11927109885;2154.881481518516;2159.7408311002623;2170.435686721456;2104.46336184272;2109.303929703194;2120.4380839077658;2124.5113623866596;2126.340834341359;2065.3700621310495;2120.0989579428833;2123.607132680459;2127.7340332458443;2131.6695912133646;8830.779230519289;8945.821083578358;8947.463152210823;8976.23701985332;9005;5034.899302013976;5177.456367081478;5180.041692286902;5181.4300426953005;5182.611304152204;3196.360727854438;3347.548081009057;3395.049386171876;3410.5225268462436;3416.906589891211;1070.6007150434182;1115.1357697784201;1117.9105671546256;1123.5000424810962;1124.7188202949262;11811.173217874752;11832.822507662306;11896.048316134775;11990.460429280703;12022.27866328023;4204.411382406465;4266.616004559604;4394.165763082794;4421.159979603865;4429.9778501107285;9448.102430269113;9450.102240287162;9461.668841590648;9463.337566370288;9467.147956683932;4946.282788995647;4961.156603377434;4964.801407943714;4964.950350496449;4970.826021089317;3935.3900145477496;4023.456833327522;4149.439825623502;4619.930701039487;4637.118947399983;3470.5661792275964;3862.633049860259;3871.1676989447406;3885.0675837798726;3931.346341219665;1134.6539305511733;1149.6491622343713;1151.4703236511132;1158.692946369213;1174.653477224221;947.9004704506066;950.8763860698065;956.153803883568;967.9419234845932;997.7356000659831;5819.70901454934;5900;5972.088931541864;6007.219061522062;6125.326214116443;436.4173827939736;439.1020363356879;439.91861505621563;440.5528388685487;442.047387879121;3969.801509924492;3991.6607088397814;4025.4364388985564;4050.635442810102;4057.91884162321;11001.559937602406;11234.662960111209;11361.261518001304;11366;11449.484773185226;11193.10455163585;11194.832077518844;11230.606928757454;11237.438128093727;11242.156838237;8388.958055209685;8451.070382258069;8467.32261419085;8471.449355791854;8473.110323416076;5678.4605462480995;5767.134929760569;5774.94225057744;5815.5929084963645;6001.379627500638;10012.39925604466;10322.896771032494;10324.638637647946;10343.327683700836;10516.57933682644;9199.356045077047;10592.735181620214;10615.575376984834;10623.309484883457;10624.734381640212;6853.314668533107;7116.50184487081;7238.203797582367;7354.889676654748;7504.774856754306;8431.19903609156;8447.281981031681;8474.237318641352;8523.105073967392;8567.657293708431;7512.474126811071;7544.207858174813;7605.543667379975;7620.5808680523105;7729.458937874295;7483.289087536676;7558.2441755823975;7642.006539149875;7787.10448298453;7897.368210543028;7079.43364530826;7083.858322833617;7106.5736055836815;7171.175314838861;7174.641267936687;5027.899442011212;5065.29085927963;5120.692758434506;5207.5833933286;5249.291345668438;4946.826861059845;5024;5127.462051184671;5294.073537130909;5294.973525132504 12:37:24 INFO - PROCESS | 9143 | |4;prototype.html;340.7086940665731;344.67944811325475;350.6703698523389;352.88707613563656;353.10487913140196;5111.15665915124;5152.665076770012;5155.639105262624;5158.561522270612;5184.559312458437;5049.091163590552;5049.661839612506;5061.519155680205;5064.772085256163;5071.543561079502;3963.365861462167;3992.8802135935825;4029.657479114279;4055.858044968427;4063.857764978219;4012.2978478766245;4025.9798701006453;4042;4053.229886321604;4061.0659548303906;3984.661303789167;3992.141689536749;4009.919801603981;4012.277789997799;4029.355303151496;3801.752886062411;3889.2221555688975;3913.3542965410675;3995.380715989026;4020.3969404589398;3557.3774589446743;3561.4123669594487;3569.01851990702;3573.8927832165077;3582.8208589570677;4902.142125128088;4925.507449255082;4945.802167913279;4949.109160351135;5006.299118123429;4379.934300985487;4509.774511274423;4521.101137522216;4599.05719327537;4613.5847773700525;5285.9207111892965;5292.417834038252;5292.417834038252;5297.337832770903;5300.648334674672;3941.921161576752;3944.3294639911283;3947.50656167979;3952.367621180626;3956.485656864618;5300.628955973083;5461.453854614547;5493.972530137324;5494.532964698005;5511.724413779295;4024.5572986971997;4032.395140728914;4032.4354590357375;4032.7983600819844;4038.6365227129113;4073.837046518106;4077.3068578341754;4077.510698716173;4079.224947260011;4088.5707000765087;4448.644108471314;4548.522405147478;4566.223741963874;4567.109413664303;4599.264117741145;5282.207668849626;5307.893842123213;5310.548603368679;5311.123664595376;5315.176147697113;1394.3028485757122;1413;1414.4554346576435;1415.1155527795129;1416.249387824434;898.2332856353553;935.5182081228173;940.1162906867522;947.8578213268065;956.8516879883629;4554.88612784683;4557.680962332671;4562.749048802348;4574.977125114353;4620.920585736365;4729.716217026989;4784.660295117303;4784.84200427716;4786.425628924551;4831.903361932812;4604.8388306409115;4607.654425918069;4607.677462577587;4608.516105808909;4847.345608342899;2554.961675574868;2861.1559589920607;2874.648915009942;2886.8123571967753;2887.812292201;5677.943220567824;5693.231413759089;5694;5702.7433765480655;5727.797162595902;5302.814401495929;5554.222408862763;5556.416576259516;5611.971940140274;5641.605087643908;5745.396733342939;5762.654240745569;5774.162746401832;5785.768569257267;5794.797182098607;5402.459754024566;5476.945230547643;5523.944760552343;5526.253955716088;5538.944610553843;5406.567474602101;5429.294191755204;5437.728113594226;5440.646357986719;5457.590680698884;5718.685472299064;5719.456651618089;5734.254546908875;5793.971030144991;5798.1302804579655;3798.316303065364;3986.063275130284;3990.5856956540874;4007.8396864126275;4010;5422.267993820941;5463.453654634504;5467.535259502828;5468.945310546844;5471.06991811401;5283.260343551829;5284.233786101071;5286.709230992333;5297.735113244399;5312.62811603184;5155.43290238066;5225.92161117576;5241.868953276046;5277.02375060615;5306.28365170697;5273.841784746463;5274.314339135888;5280.3663560373;5284.9735751320995;5285.920711189258;5314.601404894571;5315.255864178941;5320.600954928318;5322.760475778677;5329.280547126088;5032.798688052437;5177.223416487406;5178.203769964177;5203.453637368173;5220.869478263074 12:37:24 INFO - PROCESS | 9143 | |5;yui.html;734.8572969033152;736.6316841579211;746.6192241956601;787.7991112266371;816.1878930464187;12546.435410406531;15697.607559811011;15716.685666286681;15759.842401575981;15798.763018554702;13691;13782.793258101137;13786.17282963023;13788;13811.309434528259;775.0970119810414;796.2515235678444;799.54825523579;799.7161007842219;799.8880156778056;792.3146478296261;794.630496818979;795.6061749434039;795.9880601790949;796.1640277708383;832.8625776746829;837.4975014990987;840.3991146330372;840.7855996720858;841.1924552429675;837.9622916968751;840.3445312656138;840.8780726794641;840.9915900841005;841.0370126205491;617.2038070888549;624.0763669768768;624.4754406298731;624.8188025472607;625.3590070178104;12659.620211393672;12684.80972785409;12691.74616507674;12696.682582935407;12715.491380344774;12889.871101289054;12921.224726516346;13023.413946372437;13107.34463276842;13222.140560863609;10953.890461095367;10995.285306455055;11185.944070279596;11387.501936734943;11507.252028618113;3748.0629842539365;3771.4908487354132;3845.9807700961596;3991.501062367204;4030.6170913763144;75788;77957;78852;79739.20260797434;81194.59402703008;9500;9529.475878826592;9543.997880222616;9892.554835032297;10090.142337901214;20711.689324660143;20762.377128686163;21048.473788155112;21082;21095.15619375208;7937.682492700227;8170.264676179172;8218.753437396888;8231.42380033404;8499.447535910145;4355.825766969349;4390.121975604828;4565.794539245742;4577.450705915311;4592.402987611589;3860.3630400983525;4108.609682080258;4111.71218014742;4225.661947044229;4226.387173859773;688.6797639097844;714.4270730259211;722.1947528505679;735.871222536054;744.7132853851306;672.277301900459;684.4421796236052;689.4208864553799;706.3501578547748;707.1243774177123;9371.671991480265;9491.335606507617;9525.476098814494;9626.47054412014;9980.351277166961;678.718331892269;702.3047183288508;725.8911163325438;726.4696771356939;759.6695437484601;4576.97711511447;4969.925451118236;5091.8981620367385;5092.083424983464;5101.489851014943;65548;68138.1199726037;112409.43795280972;120750;122725;101147;102225.63772032117;103732;105261;107656.46171769091;90507.64238536428;91456.54271728732;92383;92813;95811;8966.820663586823;9316.34785565004;9379.390339627902;9500.524973751146;9622.278329125204;38075.80962095172;47233.291500628206;51422.485775143265;51766;52570.21144682756;49873.50126498689;53558.732206340275;62975.370246298786;64782;70579.64710176416;12572.371381431074;12654.177478463871;12683.492660293485;12769.680757981125;12994.48022079144;14095.295235238402;14665.780013300022;14888;15183.620409489851;15948.441804536786;13280.601581952556;13335.933320333725;13990.720185596434;14107;14114.717705645624;13461.394237259543;13943.442262309394;14267.357968891632;14349.282535873373;14780.556583302518;13176.40706168244;13273.274474318277;14270.143791372551;14800.259987000822;14814.407423703362;9840.360376575785;10169.542370593193;10289.691309260734;10354.17166626653;10666.146708263475;9568.234541236823;9628.566714498005;9664.468454234804;10613.257072004886;10991.120710342993 12:37:24 INFO - PROCESS | 9143 | __end_tp_report 12:37:24 INFO - PROCESS | 9143 | __start_cc_report 12:37:24 INFO - PROCESS | 9143 | _x_x_mozilla_cycle_collect,1183 12:37:24 INFO - PROCESS | 9143 | __end_cc_report 12:37:24 INFO - PROCESS | 9143 | __startTimestamp1475696244198__endTimestamp 12:37:24 INFO - PROCESS | 9143 | 12:37:24 INFO - PROCESS | 9143 | ------- Summary: start ------- 12:37:24 INFO - PROCESS | 9143 | Number of tests: 6 12:37:24 INFO - PROCESS | 9143 | 12:37:24 INFO - PROCESS | 9143 | [#0] dojo.html Cycles:165 Average:5140.06 Median:5313.73 stddev:599.09 (11.3%) stddev-sans-first:576.39 12:37:24 INFO - PROCESS | 9143 | Values: 2976.7 2990.2 3008.0 3029.0 3052.2 5096.5 5162.4 5194.0 5199.1 5247.8 5165.3 5206.5 5209.4 5264.2 5297.4 4725.3 4758.8 4776.7 4785.5 4846.2 4876.5 4909.1 4912.0 4925.4 4944.0 4638.6 4684.4 4697.3 4836.6 4873.1 4633.1 4636.0 4665.2 4675.8 4740.9 4596.6 4597.7 4604.7 4612.8 4657.4 5042.6 5047.8 5052.8 5064.7 5102.7 5289.3 5315.0 5369.3 5379.4 5455.1 5549.1 5555.3 5561.9 5631.0 5635.5 5176.4 5178.6 5188.1 5217.9 5246.1 5545.3 5561.6 5680.2 5682.0 5686.4 5458.2 5518.5 5523.6 5544.0 5615.6 5578.2 5612.8 5626.4 5629.0 5633.4 5427.3 5595.6 5602.2 5607.6 5611.8 5301.2 5315.6 5330.6 5412.6 5467.6 4099.5 4100.3 4103.4 4149.7 4150.9 3657.1 3662.7 3662.9 3688.5 3694.5 5166.1 5170.7 5178.7 5219.2 5240.4 5566.8 5599.9 5603.9 5606.7 5681.0 5313.5 5313.7 5316.8 5318.8 5378.6 4674.6 4714.8 4723.3 4802.6 4816.3 5822.0 5839.5 5839.9 5891.8 5897.6 5562.3 5566.1 5566.5 5566.5 5569.9 5407.8 5516.0 5809.3 5811.4 5821.2 5444.5 5498.7 5517.5 5521.9 5592.7 5596.1 5608.9 5617.6 5617.8 5621.7 5436.8 5445.3 5447.4 5450.3 5512.6 5121.9 5153.7 5261.8 5313.0 5345.1 5362.9 5364.7 5364.7 5368.2 5410.4 5348.8 5402.5 5406.3 5407.2 5429.3 5086.5 5139.1 5184.3 5244.9 5267.2 12:37:24 INFO - PROCESS | 9143 | 12:37:24 INFO - PROCESS | 9143 | [#1] ext.html Cycles:180 Average:55375.17 Median:39901.70 stddev:105014.31 (263.2%) stddev-sans-first:105228.26 12:37:24 INFO - PROCESS | 9143 | Values: 561.7 584.6 593.2 600.8 612.7 31447.0 32082.5 34293.3 34296.3 34301.5 42675.4 44239.3 44330.8 48210.3 48229.5 8867.6 8999.0 9006.5 9008.4 9010.8 8888.5 8976.8 8981.0 8982.5 8985.2 8987.9 9016.5 9020.3 9023.8 9027.4 8964.6 9024.2 9025.0 9026.3 9035.3 8833.2 8894.7 8900.5 8901.5 8907.2 42195.0 42529.1 42547.6 42568.0 42597.8 3421.9 3628.7 3691.2 3885.3 3894.6 31569.7 31731.7 31753.8 31825.2 32022.5 4241.3 4307.0 4344.1 4459.5 4528.3 330061.3 330254.0 331859.0 334302.0 334696.0 57695.0 57974.4 58032.7 58055.7 58073.2 60755.0 60796.3 60865.0 60915.7 60964.7 15458.7 15710.5 15717.2 15718.9 15721.3 11180.0 11192.7 11196.4 11205.6 11205.8 16078.0 17282.2 17290.0 17318.9 17437.2 5797.9 5875.9 5904.2 5991.9 6063.6 960.0 1042.3 1065.9 1077.8 1120.5 30904.7 31466.5 31489.1 31782.2 32068.7 903.4 1073.6 1074.7 1076.7 1135.2 16090.0 17106.6 17117.8 17153.3 17205.7 483164.0 485240.0 485746.0 489126.0 489959.0 57130.7 57402.7 57462.1 57466.0 57507.0 1181.2 1215.2 1269.2 1329.9 1333.7 28645.7 32262.4 32340.0 32482.7 32725.0 43312.8 43401.1 43615.6 43658.3 43664.1 353124.0 354315.0 356077.0 356671.0 357485.0 26918.7 27873.7 28035.0 29315.9 39358.4 45935.8 46165.0 46224.5 46684.0 47283.0 39247.2 39371.8 39499.6 41053.6 41149.4 38877.2 39180.0 39662.6 39983.8 41014.8 39074.6 39819.6 40629.2 40663.8 40824.6 31423.7 35166.5 35781.0 36319.3 36396.0 26744.1 26887.0 27582.9 27688.4 28727.3 12:37:24 INFO - PROCESS | 9143 | 12:37:24 INFO - PROCESS | 9143 | [#2] jquery.html Cycles:180 Average:27656.85 Median:1917.61 stddev:73439.59 (3829.7%) stddev-sans-first:73617.02 12:37:24 INFO - PROCESS | 9143 | Values: 369.7 386.3 390.6 393.3 425.2 13421.6 18649.0 18813.0 19907.4 20075.9 17159.7 17325.0 17573.0 17599.3 17915.7 5417.2 5696.2 5700.7 5705.0 5706.4 4010.5 4232.6 4331.1 5552.5 5648.8 4365.5 6253.0 6297.7 6306.9 6335.4 6063.9 6194.4 6233.1 6287.4 6302.3 5548.8 5554.1 5556.7 5557.4 5559.3 22119.6 22437.3 22823.8 22869.9 22994.9 2401.1 2626.6 3047.9 3104.7 3191.5 12944.7 13016.3 13029.0 13153.7 13417.4 1592.9 1626.7 1633.2 1655.8 1657.6 72296.0 74257.6 74501.0 74663.0 75055.2 10126.6 10326.4 10452.5 10473.6 10707.0 14890.9 14904.8 14954.0 14981.1 14998.3 7721.4 7930.6 7997.8 8226.0 8333.0 7615.2 7663.4 7680.8 7845.7 7916.5 6330.9 6437.5 6473.5 6578.5 6649.7 1866.2 1868.6 1917.5 1917.7 1982.7 902.6 958.2 1006.7 1037.9 1057.9 17164.2 18335.5 18517.9 18751.3 19190.3 983.3 1002.4 1007.9 1015.2 1041.9 7774.5 10635.7 10741.7 10784.4 10803.8 428116.0 431933.6 453212.1 454316.0 457776.0 89572.6 89755.6 90210.0 90217.0 90926.5 1035.7 1106.5 1119.8 1135.8 1141.8 15222.7 16780.0 17113.8 17269.4 17586.8 42359.8 42780.0 43532.0 43587.0 43739.0 52028.7 53499.8 56948.7 57690.4 58945.4 10943.1 11548.9 11815.6 11907.3 12276.8 12974.4 13537.6 13611.9 13620.7 13740.7 11536.5 11636.7 11710.9 11896.2 12543.6 10765.4 11343.8 11590.0 11633.2 11862.6 11146.9 11943.3 11945.3 12009.7 12629.9 11933.0 12260.6 12283.3 12297.6 12680.2 11810.3 11919.7 12116.2 12138.6 12543.4 12:37:24 INFO - PROCESS | 9143 | 12:37:24 INFO - PROCESS | 9143 | [#3] mootools.html Cycles:180 Average:5705.78 Median:4425.57 stddev:3367.02 (76.1%) stddev-sans-first:3360.66 12:37:24 INFO - PROCESS | 9143 | Values: 1365.0 1400.9 1461.8 1575.7 1792.9 7797.5 8561.5 8908.8 8927.6 9110.5 8960.1 8962.1 9011.5 9023.3 9034.3 2072.9 2120.1 2122.6 2127.0 2131.8 2065.3 2090.5 2138.8 2140.2 2140.6 2128.8 2148.1 2154.9 2159.7 2170.4 2104.5 2109.3 2120.4 2124.5 2126.3 2065.4 2120.1 2123.6 2127.7 2131.7 8830.8 8945.8 8947.5 8976.2 9005.0 5034.9 5177.5 5180.0 5181.4 5182.6 3196.4 3347.5 3395.0 3410.5 3416.9 1070.6 1115.1 1117.9 1123.5 1124.7 11811.2 11832.8 11896.0 11990.5 12022.3 4204.4 4266.6 4394.2 4421.2 4430.0 9448.1 9450.1 9461.7 9463.3 9467.1 4946.3 4961.2 4964.8 4965.0 4970.8 3935.4 4023.5 4149.4 4619.9 4637.1 3470.6 3862.6 3871.2 3885.1 3931.3 1134.7 1149.6 1151.5 1158.7 1174.7 947.9 950.9 956.2 967.9 997.7 5819.7 5900.0 5972.1 6007.2 6125.3 436.4 439.1 439.9 440.6 442.0 3969.8 3991.7 4025.4 4050.6 4057.9 11001.6 11234.7 11361.3 11366.0 11449.5 11193.1 11194.8 11230.6 11237.4 11242.2 8389.0 8451.1 8467.3 8471.4 8473.1 5678.5 5767.1 5774.9 5815.6 6001.4 10012.4 10322.9 10324.6 10343.3 10516.6 9199.4 10592.7 10615.6 10623.3 10624.7 6853.3 7116.5 7238.2 7354.9 7504.8 8431.2 8447.3 8474.2 8523.1 8567.7 7512.5 7544.2 7605.5 7620.6 7729.5 7483.3 7558.2 7642.0 7787.1 7897.4 7079.4 7083.9 7106.6 7171.2 7174.6 5027.9 5065.3 5120.7 5207.6 5249.3 4946.8 5024.0 5127.5 5294.1 5295.0 12:37:24 INFO - PROCESS | 9143 | 12:37:24 INFO - PROCESS | 9143 | [#4] prototype.html Cycles:180 Average:4467.21 Median:5040.94 stddev:1293.14 (25.7%) stddev-sans-first:1259.13 12:37:24 INFO - PROCESS | 9143 | Values: 340.7 344.7 350.7 352.9 353.1 5111.2 5152.7 5155.6 5158.6 5184.6 5049.1 5049.7 5061.5 5064.8 5071.5 3963.4 3992.9 4029.7 4055.9 4063.9 4012.3 4026.0 4042.0 4053.2 4061.1 3984.7 3992.1 4009.9 4012.3 4029.4 3801.8 3889.2 3913.4 3995.4 4020.4 3557.4 3561.4 3569.0 3573.9 3582.8 4902.1 4925.5 4945.8 4949.1 5006.3 4379.9 4509.8 4521.1 4599.1 4613.6 5285.9 5292.4 5292.4 5297.3 5300.6 3941.9 3944.3 3947.5 3952.4 3956.5 5300.6 5461.5 5494.0 5494.5 5511.7 4024.6 4032.4 4032.4 4032.8 4038.6 4073.8 4077.3 4077.5 4079.2 4088.6 4448.6 4548.5 4566.2 4567.1 4599.3 5282.2 5307.9 5310.5 5311.1 5315.2 1394.3 1413.0 1414.5 1415.1 1416.2 898.2 935.5 940.1 947.9 956.9 4554.9 4557.7 4562.7 4575.0 4620.9 4729.7 4784.7 4784.8 4786.4 4831.9 4604.8 4607.7 4607.7 4608.5 4847.3 2555.0 2861.2 2874.6 2886.8 2887.8 5677.9 5693.2 5694.0 5702.7 5727.8 5302.8 5554.2 5556.4 5612.0 5641.6 5745.4 5762.7 5774.2 5785.8 5794.8 5402.5 5476.9 5523.9 5526.3 5538.9 5406.6 5429.3 5437.7 5440.6 5457.6 5718.7 5719.5 5734.3 5794.0 5798.1 3798.3 3986.1 3990.6 4007.8 4010.0 5422.3 5463.5 5467.5 5468.9 5471.1 5283.3 5284.2 5286.7 5297.7 5312.6 5155.4 5225.9 5241.9 5277.0 5306.3 5273.8 5274.3 5280.4 5285.0 5285.9 5314.6 5315.3 5320.6 5322.8 5329.3 5032.8 5177.2 5178.2 5203.5 5220.9 12:37:24 INFO - PROCESS | 9143 | 12:37:24 INFO - PROCESS | 9143 | [#5] yui.html Cycles:180 Average:19991.24 Median:5091.99 stddev:29153.56 (572.5%) stddev-sans-first:29199.48 12:37:24 INFO - PROCESS | 9143 | Values: 734.9 736.6 746.6 787.8 816.2 12546.4 15697.6 15716.7 15759.8 15798.8 13691.0 13782.8 13786.2 13788.0 13811.3 775.1 796.3 799.5 799.7 799.9 792.3 794.6 795.6 796.0 796.2 832.9 837.5 840.4 840.8 841.2 838.0 840.3 840.9 841.0 841.0 617.2 624.1 624.5 624.8 625.4 12659.6 12684.8 12691.7 12696.7 12715.5 12889.9 12921.2 13023.4 13107.3 13222.1 10953.9 10995.3 11185.9 11387.5 11507.3 3748.1 3771.5 3846.0 3991.5 4030.6 75788.0 77957.0 78852.0 79739.2 81194.6 9500.0 9529.5 9544.0 9892.6 10090.1 20711.7 20762.4 21048.5 21082.0 21095.2 7937.7 8170.3 8218.8 8231.4 8499.4 4355.8 4390.1 4565.8 4577.5 4592.4 3860.4 4108.6 4111.7 4225.7 4226.4 688.7 714.4 722.2 735.9 744.7 672.3 684.4 689.4 706.4 707.1 9371.7 9491.3 9525.5 9626.5 9980.4 678.7 702.3 725.9 726.5 759.7 4577.0 4969.9 5091.9 5092.1 5101.5 65548.0 68138.1 112409.4 120750.0 122725.0 101147.0 102225.6 103732.0 105261.0 107656.5 90507.6 91456.5 92383.0 92813.0 95811.0 8966.8 9316.3 9379.4 9500.5 9622.3 38075.8 47233.3 51422.5 51766.0 52570.2 49873.5 53558.7 62975.4 64782.0 70579.6 12572.4 12654.2 12683.5 12769.7 12994.5 14095.3 14665.8 14888.0 15183.6 15948.4 13280.6 13335.9 13990.7 14107.0 14114.7 13461.4 13943.4 14267.4 14349.3 14780.6 13176.4 13273.3 14270.1 14800.3 14814.4 9840.4 10169.5 10289.7 10354.2 10666.1 9568.2 9628.6 9664.5 10613.3 10991.1 12:37:24 INFO - PROCESS | 9143 | -------- Summary: end -------- 12:37:24 INFO - PROCESS | 9143 | 12:37:25 INFO - TEST-INFO | 9143: exit 0 12:37:25 INFO - TEST-OK | dromaeo_css | took 1116567ms 12:37:25 INFO - TEST-START | kraken 12:37:25 INFO - operating with platform_type : linux_ 12:37:25 INFO - Initialising browser for kraken test... 12:37:25 INFO - TEST-INFO | started process 9452 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpm_lkFM/profile http://localhost:53389/getInfo.html) 12:37:29 INFO - PROCESS | 9452 | __metrics Screen width/height:1600/1200 12:37:29 INFO - PROCESS | 9452 | colorDepth:24 12:37:29 INFO - PROCESS | 9452 | Browser inner width/height: 1024/697 12:37:29 INFO - PROCESS | 9452 | __metrics 12:37:30 INFO - PROCESS | 9452 | 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" 12:37:30 INFO - PROCESS | 9452 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:37:30 INFO - PROCESS | 9452 | console.error: PushService: 12:37:30 INFO - PROCESS | 9452 | stateChangeProcessEnqueue: Error transitioning state 12:37:30 INFO - PROCESS | 9452 | UnknownError 12:37:31 INFO - TEST-INFO | 9452: exit 0 12:37:31 INFO - Browser initialized. 12:37:31 INFO - Running cycle 1/1 for kraken test... 12:37:31 INFO - TEST-INFO | started process 9536 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpm_lkFM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:37:43 INFO - PROCESS | 9536 | RSS: Main: 173596672 12:37:43 INFO - PROCESS | 9536 | 12:37:45 INFO - PROCESS | 9536 | Cycle 1(1): loaded http://localhost:53389/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53389/tests/kraken/driver.html?testName=audio-beat-detection) 12:37:46 INFO - PROCESS | 9536 | RSS: Main: 232488960 12:37:46 INFO - PROCESS | 9536 | 12:37:49 INFO - PROCESS | 9536 | Cycle 1(1): loaded http://localhost:53389/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53389/tests/kraken/driver.html?testName=audio-dft) 12:37:49 INFO - PROCESS | 9536 | RSS: Main: 218005504 12:37:49 INFO - PROCESS | 9536 | 12:37:53 INFO - PROCESS | 9536 | Cycle 1(1): loaded http://localhost:53389/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53389/tests/kraken/driver.html?testName=audio-fft) 12:37:53 INFO - PROCESS | 9536 | RSS: Main: 299810816 12:37:53 INFO - PROCESS | 9536 | 12:37:55 INFO - PROCESS | 9536 | Cycle 1(1): loaded http://localhost:53389/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53389/tests/kraken/driver.html?testName=audio-oscillator) 12:37:56 INFO - PROCESS | 9536 | RSS: Main: 208510976 12:37:56 INFO - PROCESS | 9536 | 12:37:58 INFO - PROCESS | 9536 | Cycle 1(1): loaded http://localhost:53389/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53389/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:37:59 INFO - PROCESS | 9536 | RSS: Main: 213610496 12:37:59 INFO - PROCESS | 9536 | 12:38:02 INFO - PROCESS | 9536 | Cycle 1(1): loaded http://localhost:53389/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53389/tests/kraken/driver.html?testName=imaging-darkroom) 12:38:02 INFO - PROCESS | 9536 | RSS: Main: 250056704 12:38:02 INFO - PROCESS | 9536 | 12:38:05 INFO - PROCESS | 9536 | Cycle 1(1): loaded http://localhost:53389/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53389/tests/kraken/driver.html?testName=imaging-desaturate) 12:38:06 INFO - PROCESS | 9536 | RSS: Main: 249270272 12:38:06 INFO - PROCESS | 9536 | 12:38:09 INFO - PROCESS | 9536 | Cycle 1(1): loaded http://localhost:53389/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53389/tests/kraken/driver.html?testName=json-parse-financial) 12:38:10 INFO - PROCESS | 9536 | RSS: Main: 248942592 12:38:10 INFO - PROCESS | 9536 | 12:38:11 INFO - PROCESS | 9536 | Cycle 1(1): loaded http://localhost:53389/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53389/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:38:12 INFO - PROCESS | 9536 | RSS: Main: 210866176 12:38:12 INFO - PROCESS | 9536 | 12:38:13 INFO - PROCESS | 9536 | Cycle 1(1): loaded http://localhost:53389/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53389/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:38:14 INFO - PROCESS | 9536 | RSS: Main: 219103232 12:38:14 INFO - PROCESS | 9536 | 12:38:16 INFO - PROCESS | 9536 | Cycle 1(1): loaded http://localhost:53389/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53389/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:38:17 INFO - PROCESS | 9536 | RSS: Main: 227631104 12:38:17 INFO - PROCESS | 9536 | 12:38:19 INFO - PROCESS | 9536 | Cycle 1(1): loaded http://localhost:53389/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53389/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:38:20 INFO - PROCESS | 9536 | RSS: Main: 236539904 12:38:20 INFO - PROCESS | 9536 | 12:38:23 INFO - PROCESS | 9536 | Cycle 1(1): loaded http://localhost:53389/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53389/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:38:24 INFO - PROCESS | 9536 | RSS: Main: 233095168 12:38:24 INFO - PROCESS | 9536 | 12:38:25 INFO - PROCESS | 9536 | Cycle 1(1): loaded http://localhost:53389/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53389/tests/kraken/driver.html?testName=ai-astar) 12:38:26 INFO - PROCESS | 9536 | RSS: Main: 282513408 12:38:26 INFO - PROCESS | 9536 | 12:38:26 INFO - PROCESS | 9536 | __start_tp_report 12:38:26 INFO - PROCESS | 9536 | _x_x_mozilla_page_load 12:38:26 INFO - PROCESS | 9536 | _x_x_mozilla_page_load_details 12:38:26 INFO - PROCESS | 9536 | |i|pagename|runs| 12:38:26 INFO - PROCESS | 9536 | |0;ai-astar;112;114;113;112;113;113;113;112;111;114 12:38:26 INFO - PROCESS | 9536 | |1;audio-beat-detection;153;127;124;171;131;127;124;122;150;121 12:38:26 INFO - PROCESS | 9536 | |2;audio-dft;162;161;160;160;160;161;160;160;160;159 12:38:26 INFO - PROCESS | 9536 | |3;audio-fft;74;75;75;115;76;77;75;76;101;76 12:38:26 INFO - PROCESS | 9536 | |4;audio-oscillator;80;81;114;81;81;81;100;80;81;104 12:38:26 INFO - PROCESS | 9536 | |5;imaging-gaussian-blur;118;117;116;116;116;116;117;116;117;116 12:38:26 INFO - PROCESS | 9536 | |6;imaging-darkroom;146;145;146;145;146;146;145;145;147;146 12:38:26 INFO - PROCESS | 9536 | |7;imaging-desaturate;95;95;96;96;96;95;95;94;95;94 12:38:26 INFO - PROCESS | 9536 | |8;json-parse-financial;52;51;51;50;50;56;53;53;52;52 12:38:26 INFO - PROCESS | 9536 | |9;json-stringify-tinderbox;61;63;62;62;63;63;63;62;62;62 12:38:26 INFO - PROCESS | 9536 | |10;stanford-crypto-aes;80;88;83;80;86;79;88;79;79;80 12:38:26 INFO - PROCESS | 9536 | |11;stanford-crypto-ccm;147;136;134;137;166;133;132;133;170;140 12:38:26 INFO - PROCESS | 9536 | |12;stanford-crypto-pbkdf2;166;168;179;171;168;170;167;171;173;172 12:38:26 INFO - PROCESS | 9536 | |13;stanford-crypto-sha256-iterative;65;69;69;73;67;65;68;65;66;67 12:38:26 INFO - PROCESS | 9536 | __end_tp_report 12:38:26 INFO - PROCESS | 9536 | __start_cc_report 12:38:26 INFO - PROCESS | 9536 | _x_x_mozilla_cycle_collect,1653 12:38:26 INFO - PROCESS | 9536 | __end_cc_report 12:38:26 INFO - PROCESS | 9536 | __startTimestamp1475696305999__endTimestamp 12:38:26 INFO - PROCESS | 9536 | 12:38:26 INFO - PROCESS | 9536 | ------- Summary: start ------- 12:38:26 INFO - PROCESS | 9536 | Number of tests: 14 12:38:26 INFO - PROCESS | 9536 | 12:38:26 INFO - PROCESS | 9536 | [#0] ai-astar Cycles:10 Average:112.70 Median:113.00 stddev:0.95 (0.8%) stddev-sans-first:0.97 12:38:26 INFO - PROCESS | 9536 | Values: 112.0 114.0 113.0 112.0 113.0 113.0 113.0 112.0 111.0 114.0 12:38:26 INFO - PROCESS | 9536 | 12:38:26 INFO - PROCESS | 9536 | [#1] audio-beat-detection Cycles:10 Average:135.00 Median:129.00 stddev:16.98 (13.2%) stddev-sans-first:16.72 12:38:26 INFO - PROCESS | 9536 | Values: 153.0 127.0 124.0 171.0 131.0 127.0 124.0 122.0 150.0 121.0 12:38:26 INFO - PROCESS | 9536 | 12:38:26 INFO - PROCESS | 9536 | [#2] audio-dft Cycles:10 Average:160.30 Median:160.00 stddev:0.82 (0.5%) stddev-sans-first:0.60 12:38:26 INFO - PROCESS | 9536 | Values: 162.0 161.0 160.0 160.0 160.0 161.0 160.0 160.0 160.0 159.0 12:38:26 INFO - PROCESS | 9536 | 12:38:26 INFO - PROCESS | 9536 | [#3] audio-fft Cycles:10 Average:82.00 Median:75.50 stddev:14.12 (18.7%) stddev-sans-first:14.68 12:38:26 INFO - PROCESS | 9536 | Values: 74.0 75.0 75.0 115.0 76.0 77.0 75.0 76.0 101.0 76.0 12:38:26 INFO - PROCESS | 9536 | 12:38:26 INFO - PROCESS | 9536 | [#4] audio-oscillator Cycles:10 Average:88.30 Median:81.00 stddev:12.68 (15.7%) stddev-sans-first:13.09 12:38:26 INFO - PROCESS | 9536 | Values: 80.0 81.0 114.0 81.0 81.0 81.0 100.0 80.0 81.0 104.0 12:38:26 INFO - PROCESS | 9536 | 12:38:26 INFO - PROCESS | 9536 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:116.50 stddev:0.71 (0.6%) stddev-sans-first:0.50 12:38:26 INFO - PROCESS | 9536 | Values: 118.0 117.0 116.0 116.0 116.0 116.0 117.0 116.0 117.0 116.0 12:38:26 INFO - PROCESS | 9536 | 12:38:26 INFO - PROCESS | 9536 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 12:38:26 INFO - PROCESS | 9536 | Values: 146.0 145.0 146.0 145.0 146.0 146.0 145.0 145.0 147.0 146.0 12:38:26 INFO - PROCESS | 9536 | 12:38:26 INFO - PROCESS | 9536 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.74 (0.8%) stddev-sans-first:0.78 12:38:26 INFO - PROCESS | 9536 | Values: 95.0 95.0 96.0 96.0 96.0 95.0 95.0 94.0 95.0 94.0 12:38:26 INFO - PROCESS | 9536 | 12:38:26 INFO - PROCESS | 9536 | [#8] json-parse-financial Cycles:10 Average:52.00 Median:52.00 stddev:1.76 (3.4%) stddev-sans-first:1.87 12:38:26 INFO - PROCESS | 9536 | Values: 52.0 51.0 51.0 50.0 50.0 56.0 53.0 53.0 52.0 52.0 12:38:26 INFO - PROCESS | 9536 | 12:38:26 INFO - PROCESS | 9536 | [#9] json-stringify-tinderbox Cycles:10 Average:62.30 Median:62.50 stddev:0.67 (1.1%) stddev-sans-first:0.53 12:38:26 INFO - PROCESS | 9536 | Values: 61.0 63.0 62.0 62.0 63.0 63.0 63.0 62.0 62.0 62.0 12:38:26 INFO - PROCESS | 9536 | 12:38:26 INFO - PROCESS | 9536 | [#10] stanford-crypto-aes Cycles:10 Average:82.20 Median:81.50 stddev:3.77 (4.6%) stddev-sans-first:3.91 12:38:26 INFO - PROCESS | 9536 | Values: 80.0 88.0 83.0 80.0 86.0 79.0 88.0 79.0 79.0 80.0 12:38:26 INFO - PROCESS | 9536 | 12:38:26 INFO - PROCESS | 9536 | [#11] stanford-crypto-ccm Cycles:10 Average:142.80 Median:138.50 stddev:14.02 (10.1%) stddev-sans-first:14.79 12:38:26 INFO - PROCESS | 9536 | Values: 147.0 136.0 134.0 137.0 166.0 133.0 132.0 133.0 170.0 140.0 12:38:26 INFO - PROCESS | 9536 | 12:38:26 INFO - PROCESS | 9536 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.50 Median:171.00 stddev:3.75 (2.2%) stddev-sans-first:3.61 12:38:26 INFO - PROCESS | 9536 | Values: 166.0 168.0 179.0 171.0 168.0 170.0 167.0 171.0 173.0 172.0 12:38:26 INFO - PROCESS | 9536 | 12:38:26 INFO - PROCESS | 9536 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.40 Median:67.50 stddev:2.50 (3.7%) stddev-sans-first:2.50 12:38:26 INFO - PROCESS | 9536 | Values: 65.0 69.0 69.0 73.0 67.0 65.0 68.0 65.0 66.0 67.0 12:38:26 INFO - PROCESS | 9536 | -------- Summary: end -------- 12:38:26 INFO - PROCESS | 9536 | 12:38:27 INFO - TEST-INFO | 9536: exit 0 12:38:27 INFO - TEST-OK | kraken | took 62055ms 12:38:27 INFO - SUITE-END | took 1178s 12:38:27 INFO - Completed test suite (00:19:39) 12:38:27 INFO - javascript benchmark 12:38:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2976.7172118648728, 2990.237489440191, 3008.037428023032, 3029.030710172746, 3052.1606558196495, 5096.515830996059, 5162.38051433828, 5194.0, 5199.116150254456, 5247.763850626726, 5165.328507294046, 5206.505381988714, 5209.374875014994, 5264.184051472019, 5297.364316282042, 4725.291206319045, 4758.809647614091, 4776.665633405663, 4785.545373189559, 4846.151923413407, 4876.463589005207, 4909.140900342443, 4911.975440122795, 4925.3664350939725, 4944.0, 4638.605718513931, 4684.3910291662205, 4697.271922851964, 4836.637252206098, 4873.122837889178, 4633.142868569325, 4636.02643444877, 4665.206914824488, 4675.766211689402, 4740.9288860666775, 4596.563326483979, 4597.7241365518175, 4604.700694454883, 4612.7924243409125, 4657.441107067174, 5042.647014708972, 5047.848564543069, 5052.8484145475695, 5064.746762661852, 5102.744862756847, 5289.338832645919, 5315.0, 5369.275147855029, 5379.408265090837, 5455.1271796512765, 5549.084401073818, 5555.250041244421, 5561.888762224773, 5630.971845140748, 5635.549156067505, 5176.378834539842, 5178.585713142939, 5188.143956247215, 5217.921731174036, 5246.134387826042, 5545.306836645419, 5561.58288128392, 5680.233168522279, 5682.0, 5686.3744988051285, 5458.181272809031, 5518.475744804237, 5523.585731070186, 5544.0, 5615.550755939515, 5578.219049333096, 5612.803551875746, 5626.381098079208, 5629.0, 5633.352164501053, 5427.3215848019, 5595.608307418442, 5602.159676048544, 5607.551395888319, 5611.775528978795, 5301.151815709468, 5315.6013299002725, 5330.600204984642, 5412.621116521806, 5467.589930755209, 4099.487564054493, 4100.323446631332, 4103.363978583325, 4149.688773341951, 4150.896227594274, 3657.140571965586, 3662.7436079474714, 3662.908427289339, 3688.5389326334207, 3694.538182727159, 5166.147585648326, 5170.663906846043, 5178.715170665574, 5219.243209734567, 5240.423553409122, 5566.832995010156, 5599.860003499945, 5603.915941260884, 5606.6916319602, 5681.0, 5313.521783039468, 5313.734313284321, 5316.840494785085, 5318.760655770499, 5378.623496355296, 4674.649401294849, 4714.764261786897, 4723.291506274087, 4802.567768900815, 4816.349792778, 5821.970890145522, 5839.532837373, 5839.912401314069, 5891.764329426861, 5897.64614123154, 5562.276904002616, 5566.081596536526, 5566.471185237396, 5566.4990150886615, 5569.944300557105, 5407.810726624549, 5515.972420137874, 5809.30288365382, 5811.389804070681, 5821.155932389865, 5444.455554444524, 5498.670079795225, 5517.531009864046, 5521.944780552143, 5592.720363981866, 5596.076647353304, 5608.887822243614, 5617.578681598815, 5617.775288988395, 5621.7189140542, 5436.809711660073, 5445.319335083114, 5447.400785913625, 5450.345958485007, 5512.614117011771, 5121.8719532012, 5153.742312884266, 5261.842144735664, 5313.0, 5345.091334473227, 5362.865928351823, 5364.6512976656395, 5364.678119312854, 5368.194770784414, 5410.350757908918, 5348.812791552277, 5402.486763757437, 5406.324209473816, 5407.215953686772, 5429.294191755047, 5086.54221120101, 5139.074966506065, 5184.300119483973, 5244.921326180034, 5267.209918512254], "value": 5098.708109752905, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [561.6874189873914, 584.643367545797, 593.1814096546765, 600.8317671052105, 612.6752821004868, 31447.0, 32082.518762218555, 34293.31413371731, 34296.31407371851, 34301.485477717855, 42675.35986960198, 44239.336409953874, 44330.77834610822, 48210.276845847344, 48229.51770482303, 8867.60095795689, 8999.0, 9006.504642244707, 9008.414453060563, 9010.819783604324, 8888.466691998468, 8976.775580610505, 8981.0, 8982.461052336848, 8985.191332780048, 8987.865182022275, 9016.459012459241, 9020.278377729766, 9023.819523609523, 9027.413218140833, 8964.596593153325, 9024.23294020009, 9024.954875225581, 9026.277897768163, 9035.277177825757, 8833.160849719266, 8894.688685896028, 8900.465972041633, 8901.510416927067, 8907.198352148338, 42195.0, 42529.149417011795, 42547.57452425467, 42568.0, 42597.787011065055, 3421.863125474978, 3628.6915612172997, 3691.243295124493, 3885.320068987916, 3894.5910679378826, 31569.684303156904, 31731.682683173105, 31753.84123079393, 31825.204369890707, 32022.519662205086, 4241.300185469394, 4306.9541967565465, 4344.087741574273, 4459.464864216315, 4528.343390208402, 330061.3496932524, 330254.0, 331859.0, 334302.0, 334696.0, 57695.0, 57974.42025579775, 58032.70983645055, 58055.70972145197, 58073.16012338365, 60755.0, 60796.27259638437, 60865.0, 60915.69542152261, 60964.69517652472, 15458.690826183414, 15710.450134245246, 15717.21413929299, 15718.921405392899, 15721.292541835644, 11180.0, 11192.664220073411, 11196.38419886914, 11205.60780372683, 11205.831912521318, 16078.0, 17282.22229999628, 17290.0, 17318.913405432893, 17437.21532531039, 5797.8550536236935, 5875.9118613220835, 5904.202932604044, 5991.910121348184, 6063.605865618721, 959.9520023998772, 1042.2912419554775, 1065.8774240962234, 1077.8275475923815, 1120.5125770289949, 30904.69095309063, 31466.528002079987, 31489.055328340186, 31782.2054448636, 32068.679313207034, 903.3541018172039, 1073.6349641122056, 1074.6507385099874, 1076.6554702495282, 1135.1713249328036, 16090.0, 17106.572335691708, 17117.828821711624, 17153.313867445162, 17205.655886882192, 483164.0, 485240.0, 485746.0, 489126.0, 489959.0, 57130.71434642883, 57402.7129864348, 57462.13806792818, 57466.0, 57507.0, 1181.1908842442954, 1215.1858254969193, 1269.1877198592908, 1329.9202047877159, 1333.7332533493145, 28645.713542864305, 32262.354752904343, 32340.0, 32482.675173247964, 32725.0, 43312.78343608262, 43401.13197736091, 43615.56384436115, 43658.34512482379, 43664.12671746484, 353124.0, 354315.0, 356077.0, 356671.0, 357485.0, 26918.73081269162, 27873.721262787923, 28035.0, 29315.85342073276, 39358.409623856234, 45935.77032114818, 46165.0, 46224.537754622026, 46684.0, 47283.0, 39247.21505569816, 39371.803140985256, 39499.60500394959, 41053.589464104974, 41149.382759259235, 38877.222455551295, 39180.0, 39662.60337396589, 39983.80008099941, 41014.79492602518, 39074.609253907096, 39819.60180398159, 40629.1874162521, 40663.79668101641, 40824.59175408208, 31423.685763142992, 35166.47250291299, 35781.0, 36319.27361452703, 36396.0, 26744.093071603045, 26887.0, 27582.86208568944, 27688.446231075668, 28727.281817954718], "value": 19358.156208961234, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [369.69500162366023, 386.2506736930356, 390.61524398467486, 393.3018891467645, 425.1878911279457, 13421.597352079441, 18649.0, 18813.0, 19907.402777916686, 20075.899620501914, 17159.656806863855, 17325.0, 17573.0, 17599.296028158857, 17915.73126403105, 5417.187421886729, 5696.202531645573, 5700.714964251792, 5705.030144875361, 5706.400827913051, 4010.4585880905997, 4232.640225580814, 4331.133773245348, 5552.472515111058, 5648.774049038034, 4365.454318210223, 6253.0, 6297.685115744194, 6306.905396419057, 6335.429811316981, 6063.878722425548, 6194.380561943814, 6233.096201050822, 6287.402696743825, 6302.275238347603, 5548.77804887808, 5554.111342185231, 5556.72216389183, 5557.3886872444, 5559.27729395176, 22119.557608847896, 22437.32688019362, 22823.77176228233, 22869.885650571807, 22994.885025574764, 2401.1355911871888, 2626.632271481994, 3047.923801904948, 3104.674009229044, 3191.48936170214, 12944.705529447074, 13016.349182540835, 13029.0, 13153.736925261537, 13417.396217170251, 1592.8805339599576, 1626.7315892877662, 1633.1834082958521, 1655.7599148123454, 1657.5846906668962, 72296.0, 74257.6287118561, 74501.0, 74663.0, 75055.24944750537, 10126.645567405105, 10326.380417174994, 10452.529636166391, 10473.581056757797, 10707.0, 14890.92554537242, 14904.776428353583, 14954.0, 14981.101133932, 14998.325075371635, 7721.420893433015, 7930.643121059451, 7997.840043199103, 8226.0, 8333.041700204554, 7615.16233214346, 7663.386929045663, 7680.807979800438, 7845.686172553034, 7916.525008499509, 6330.873382532323, 6437.485001199986, 6473.546851720429, 6578.473722102221, 6649.734010639617, 1866.216189200512, 1868.588910439701, 1917.5206198450387, 1917.7027560728109, 1982.692682634165, 902.6118768929292, 958.2190514730472, 1006.6677996261217, 1037.9377237365782, 1057.8783439904355, 17164.227609757592, 18335.541611459554, 18517.90741046286, 18751.34370297033, 19190.338850039272, 983.3215081593678, 1002.3584905660383, 1007.9244056695777, 1015.2334987084852, 1041.8853926068127, 7774.533527988338, 10635.734106647242, 10741.677749667522, 10784.40685762275, 10803.78392432147, 428116.0, 431933.571292881, 453212.0952859434, 454316.0, 457776.0, 89572.55213723889, 89755.55122224477, 90210.0, 90217.0, 90926.54536727275, 1035.7048241251207, 1106.4744246482855, 1119.798436281477, 1135.778523187987, 1141.8458508101467, 15222.695546089237, 16780.0, 17113.828861711223, 17269.39557115495, 17586.82413175852, 42359.7882010588, 42780.0, 43532.0, 43587.0, 43739.0, 52028.739856300475, 53499.79001259937, 56948.71525642345, 57690.42309577019, 58945.41054589399, 10943.124550036136, 11548.884511155116, 11815.586454474053, 11907.345096019802, 12276.815847762113, 12974.351282435651, 13537.59387218385, 13611.86388136106, 13620.727585448434, 13740.725185496434, 11536.538538458368, 11636.709082273012, 11710.94144529272, 11896.22674526153, 12543.56097536582, 10765.3540787553, 11343.773124537298, 11590.014848737614, 11633.243839150427, 11862.644120676394, 11146.888531114586, 11943.343116128697, 11945.283283003047, 12009.699757506132, 12629.873701263237, 11933.0, 12260.632181034583, 12283.263004219776, 12297.56958506448, 12680.239185648521, 11810.291382517076, 11919.702007449883, 12116.221503573226, 12138.635840924786, 12543.435545400662], "value": 9405.1087845767, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1364.965875853104, 1400.9339559706473, 1461.817272840895, 1575.6769862178255, 1792.8834625749316, 7797.532148071113, 8561.529115898631, 8908.821823563541, 8927.553622318883, 9110.45337279762, 8960.148785865333, 8962.058983806688, 9011.504367259799, 9023.278137748981, 9034.277257819374, 2072.9481762955934, 2120.056574824204, 2122.649762789138, 2126.9787302126933, 2131.8187954023847, 2065.287475820847, 2090.4878304815343, 2138.839587030971, 2140.176032227596, 2140.625390556654, 2128.8190503807195, 2148.11927109885, 2154.881481518516, 2159.7408311002623, 2170.435686721456, 2104.46336184272, 2109.303929703194, 2120.4380839077658, 2124.5113623866596, 2126.340834341359, 2065.3700621310495, 2120.0989579428833, 2123.607132680459, 2127.7340332458443, 2131.6695912133646, 8830.779230519289, 8945.821083578358, 8947.463152210823, 8976.23701985332, 9005.0, 5034.899302013976, 5177.456367081478, 5180.041692286902, 5181.4300426953005, 5182.611304152204, 3196.360727854438, 3347.548081009057, 3395.049386171876, 3410.5225268462436, 3416.906589891211, 1070.6007150434182, 1115.1357697784201, 1117.9105671546256, 1123.5000424810962, 1124.7188202949262, 11811.173217874752, 11832.822507662306, 11896.048316134775, 11990.460429280703, 12022.27866328023, 4204.411382406465, 4266.616004559604, 4394.165763082794, 4421.159979603865, 4429.9778501107285, 9448.102430269113, 9450.102240287162, 9461.668841590648, 9463.337566370288, 9467.147956683932, 4946.282788995647, 4961.156603377434, 4964.801407943714, 4964.950350496449, 4970.826021089317, 3935.3900145477496, 4023.456833327522, 4149.439825623502, 4619.930701039487, 4637.118947399983, 3470.5661792275964, 3862.633049860259, 3871.1676989447406, 3885.0675837798726, 3931.346341219665, 1134.6539305511733, 1149.6491622343713, 1151.4703236511132, 1158.692946369213, 1174.653477224221, 947.9004704506066, 950.8763860698065, 956.153803883568, 967.9419234845932, 997.7356000659831, 5819.70901454934, 5900.0, 5972.088931541864, 6007.219061522062, 6125.326214116443, 436.4173827939736, 439.1020363356879, 439.91861505621563, 440.5528388685487, 442.047387879121, 3969.801509924492, 3991.6607088397814, 4025.4364388985564, 4050.635442810102, 4057.91884162321, 11001.559937602406, 11234.662960111209, 11361.261518001304, 11366.0, 11449.484773185226, 11193.10455163585, 11194.832077518844, 11230.606928757454, 11237.438128093727, 11242.156838237, 8388.958055209685, 8451.070382258069, 8467.32261419085, 8471.449355791854, 8473.110323416076, 5678.4605462480995, 5767.134929760569, 5774.94225057744, 5815.5929084963645, 6001.379627500638, 10012.39925604466, 10322.896771032494, 10324.638637647946, 10343.327683700836, 10516.57933682644, 9199.356045077047, 10592.735181620214, 10615.575376984834, 10623.309484883457, 10624.734381640212, 6853.314668533107, 7116.50184487081, 7238.203797582367, 7354.889676654748, 7504.774856754306, 8431.19903609156, 8447.281981031681, 8474.237318641352, 8523.105073967392, 8567.657293708431, 7512.474126811071, 7544.207858174813, 7605.543667379975, 7620.5808680523105, 7729.458937874295, 7483.289087536676, 7558.2441755823975, 7642.006539149875, 7787.10448298453, 7897.368210543028, 7079.43364530826, 7083.858322833617, 7106.5736055836815, 7171.175314838861, 7174.641267936687, 5027.899442011212, 5065.29085927963, 5120.692758434506, 5207.5833933286, 5249.291345668438, 4946.826861059845, 5024.0, 5127.462051184671, 5294.073537130909, 5294.973525132504], "value": 4425.922689562347, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [340.7086940665731, 344.67944811325475, 350.6703698523389, 352.88707613563656, 353.10487913140196, 5111.15665915124, 5152.665076770012, 5155.639105262624, 5158.561522270612, 5184.559312458437, 5049.091163590552, 5049.661839612506, 5061.519155680205, 5064.772085256163, 5071.543561079502, 3963.365861462167, 3992.8802135935825, 4029.657479114279, 4055.858044968427, 4063.857764978219, 4012.2978478766245, 4025.9798701006453, 4042.0, 4053.229886321604, 4061.0659548303906, 3984.661303789167, 3992.141689536749, 4009.919801603981, 4012.277789997799, 4029.355303151496, 3801.752886062411, 3889.2221555688975, 3913.3542965410675, 3995.380715989026, 4020.3969404589398, 3557.3774589446743, 3561.4123669594487, 3569.01851990702, 3573.8927832165077, 3582.8208589570677, 4902.142125128088, 4925.507449255082, 4945.802167913279, 4949.109160351135, 5006.299118123429, 4379.934300985487, 4509.774511274423, 4521.101137522216, 4599.05719327537, 4613.5847773700525, 5285.9207111892965, 5292.417834038252, 5292.417834038252, 5297.337832770903, 5300.648334674672, 3941.921161576752, 3944.3294639911283, 3947.50656167979, 3952.367621180626, 3956.485656864618, 5300.628955973083, 5461.453854614547, 5493.972530137324, 5494.532964698005, 5511.724413779295, 4024.5572986971997, 4032.395140728914, 4032.4354590357375, 4032.7983600819844, 4038.6365227129113, 4073.837046518106, 4077.3068578341754, 4077.510698716173, 4079.224947260011, 4088.5707000765087, 4448.644108471314, 4548.522405147478, 4566.223741963874, 4567.109413664303, 4599.264117741145, 5282.207668849626, 5307.893842123213, 5310.548603368679, 5311.123664595376, 5315.176147697113, 1394.3028485757122, 1413.0, 1414.4554346576435, 1415.1155527795129, 1416.249387824434, 898.2332856353553, 935.5182081228173, 940.1162906867522, 947.8578213268065, 956.8516879883629, 4554.88612784683, 4557.680962332671, 4562.749048802348, 4574.977125114353, 4620.920585736365, 4729.716217026989, 4784.660295117303, 4784.84200427716, 4786.425628924551, 4831.903361932812, 4604.8388306409115, 4607.654425918069, 4607.677462577587, 4608.516105808909, 4847.345608342899, 2554.961675574868, 2861.1559589920607, 2874.648915009942, 2886.8123571967753, 2887.812292201, 5677.943220567824, 5693.231413759089, 5694.0, 5702.7433765480655, 5727.797162595902, 5302.814401495929, 5554.222408862763, 5556.416576259516, 5611.971940140274, 5641.605087643908, 5745.396733342939, 5762.654240745569, 5774.162746401832, 5785.768569257267, 5794.797182098607, 5402.459754024566, 5476.945230547643, 5523.944760552343, 5526.253955716088, 5538.944610553843, 5406.567474602101, 5429.294191755204, 5437.728113594226, 5440.646357986719, 5457.590680698884, 5718.685472299064, 5719.456651618089, 5734.254546908875, 5793.971030144991, 5798.1302804579655, 3798.316303065364, 3986.063275130284, 3990.5856956540874, 4007.8396864126275, 4010.0, 5422.267993820941, 5463.453654634504, 5467.535259502828, 5468.945310546844, 5471.06991811401, 5283.260343551829, 5284.233786101071, 5286.709230992333, 5297.735113244399, 5312.62811603184, 5155.43290238066, 5225.92161117576, 5241.868953276046, 5277.02375060615, 5306.28365170697, 5273.841784746463, 5274.314339135888, 5280.3663560373, 5284.9735751320995, 5285.920711189258, 5314.601404894571, 5315.255864178941, 5320.600954928318, 5322.760475778677, 5329.280547126088, 5032.798688052437, 5177.223416487406, 5178.203769964177, 5203.453637368173, 5220.869478263074], "value": 4067.577202670573, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [734.8572969033152, 736.6316841579211, 746.6192241956601, 787.7991112266371, 816.1878930464187, 12546.435410406531, 15697.607559811011, 15716.685666286681, 15759.842401575981, 15798.763018554702, 13691.0, 13782.793258101137, 13786.17282963023, 13788.0, 13811.309434528259, 775.0970119810414, 796.2515235678444, 799.54825523579, 799.7161007842219, 799.8880156778056, 792.3146478296261, 794.630496818979, 795.6061749434039, 795.9880601790949, 796.1640277708383, 832.8625776746829, 837.4975014990987, 840.3991146330372, 840.7855996720858, 841.1924552429675, 837.9622916968751, 840.3445312656138, 840.8780726794641, 840.9915900841005, 841.0370126205491, 617.2038070888549, 624.0763669768768, 624.4754406298731, 624.8188025472607, 625.3590070178104, 12659.620211393672, 12684.80972785409, 12691.74616507674, 12696.682582935407, 12715.491380344774, 12889.871101289054, 12921.224726516346, 13023.413946372437, 13107.34463276842, 13222.140560863609, 10953.890461095367, 10995.285306455055, 11185.944070279596, 11387.501936734943, 11507.252028618113, 3748.0629842539365, 3771.4908487354132, 3845.9807700961596, 3991.501062367204, 4030.6170913763144, 75788.0, 77957.0, 78852.0, 79739.20260797434, 81194.59402703008, 9500.0, 9529.475878826592, 9543.997880222616, 9892.554835032297, 10090.142337901214, 20711.689324660143, 20762.377128686163, 21048.473788155112, 21082.0, 21095.15619375208, 7937.682492700227, 8170.264676179172, 8218.753437396888, 8231.42380033404, 8499.447535910145, 4355.825766969349, 4390.121975604828, 4565.794539245742, 4577.450705915311, 4592.402987611589, 3860.3630400983525, 4108.609682080258, 4111.71218014742, 4225.661947044229, 4226.387173859773, 688.6797639097844, 714.4270730259211, 722.1947528505679, 735.871222536054, 744.7132853851306, 672.277301900459, 684.4421796236052, 689.4208864553799, 706.3501578547748, 707.1243774177123, 9371.671991480265, 9491.335606507617, 9525.476098814494, 9626.47054412014, 9980.351277166961, 678.718331892269, 702.3047183288508, 725.8911163325438, 726.4696771356939, 759.6695437484601, 4576.97711511447, 4969.925451118236, 5091.8981620367385, 5092.083424983464, 5101.489851014943, 65548.0, 68138.1199726037, 112409.43795280972, 120750.0, 122725.0, 101147.0, 102225.63772032117, 103732.0, 105261.0, 107656.46171769091, 90507.64238536428, 91456.54271728732, 92383.0, 92813.0, 95811.0, 8966.820663586823, 9316.34785565004, 9379.390339627902, 9500.524973751146, 9622.278329125204, 38075.80962095172, 47233.291500628206, 51422.485775143265, 51766.0, 52570.21144682756, 49873.50126498689, 53558.732206340275, 62975.370246298786, 64782.0, 70579.64710176416, 12572.371381431074, 12654.177478463871, 12683.492660293485, 12769.680757981125, 12994.48022079144, 14095.295235238402, 14665.780013300022, 14888.0, 15183.620409489851, 15948.441804536786, 13280.601581952556, 13335.933320333725, 13990.720185596434, 14107.0, 14114.717705645624, 13461.394237259543, 13943.442262309394, 14267.357968891632, 14349.282535873373, 14780.556583302518, 13176.40706168244, 13273.274474318277, 14270.143791372551, 14800.259987000822, 14814.407423703362, 9840.360376575785, 10169.542370593193, 10289.691309260734, 10354.17166626653, 10666.146708263475, 9568.234541236823, 9628.566714498005, 9664.468454234804, 10613.257072004886, 10991.120710342993], "value": 7387.27895711448, "unit": "score"}], "name": "dromaeo_css", "value": 7056.565552762491, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 114.0, 113.0, 112.0, 113.0, 113.0, 113.0, 112.0, 111.0, 114.0], "value": 112.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 127.0, 124.0, 171.0, 131.0, 127.0, 124.0, 122.0, 150.0, 121.0], "value": 135.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 160.0, 160.0, 160.0, 161.0, 160.0, 160.0, 160.0, 159.0], "value": 160.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 115.0, 76.0, 77.0, 75.0, 76.0, 101.0, 76.0], "value": 82.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 81.0, 114.0, 81.0, 81.0, 81.0, 100.0, 80.0, 81.0, 104.0], "value": 88.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 116.0, 116.0, 116.0, 116.0, 117.0, 116.0, 117.0, 116.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 145.0, 146.0, 146.0, 145.0, 145.0, 147.0, 146.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 96.0, 96.0, 95.0, 95.0, 94.0, 95.0, 94.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 51.0, 51.0, 50.0, 50.0, 56.0, 53.0, 53.0, 52.0, 52.0], "value": 52.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 63.0, 62.0, 62.0, 63.0, 63.0, 63.0, 62.0, 62.0, 62.0], "value": 62.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 88.0, 83.0, 80.0, 86.0, 79.0, 88.0, 79.0, 79.0, 80.0], "value": 82.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 136.0, 134.0, 137.0, 166.0, 133.0, 132.0, 133.0, 170.0, 140.0], "value": 142.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 168.0, 179.0, 171.0, 168.0, 170.0, 167.0, 171.0, 173.0, 172.0], "value": 170.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 69.0, 69.0, 73.0, 67.0, 65.0, 68.0, 65.0, 66.0, 67.0], "value": 67.4, "unit": "score"}], "name": "kraken", "value": 1512.8000000000002, "alertThreshold": 2.0}]} 12:38:27 INFO - Return code: 0 12:38:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:38:27 INFO - # TBPL SUCCESS # 12:38:27 INFO - Running post-action listener: _resource_record_post_action 12:38:27 INFO - [mozharness: 2016-10-05 19:38:27.809588Z] Finished run-tests step (success) 12:38:27 INFO - Running post-run listener: _resource_record_post_run 12:38:27 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 409923584; Read time: 16; Write time: 242696 12:38:27 INFO - TinderboxPrint: CPU usage
13.1% 12:38:27 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 12:38:27 INFO - TinderboxPrint: I/O write bytes / time
409,923,584 / 242,696 12:38:27 INFO - TinderboxPrint: CPU idle
8,295.9 (86.9%) 12:38:27 INFO - TinderboxPrint: CPU user
1,196.5 (12.5%) 12:38:27 INFO - TinderboxPrint: Swap in / out
0 / 0 12:38:27 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 119885824; Read time: 0; Write time: 59668 12:38:27 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 0; Write bytes: 289103872; Read time: 0; Write time: 183000 12:38:28 INFO - Running post-run listener: _upload_blobber_files 12:38:28 INFO - Blob upload gear active. 12:38:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:38:28 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 12:38:28 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:38:28 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:38:28 INFO - (blobuploader) - INFO - Open directory for files ... 12:38:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:38:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:38:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:38:32 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:38:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:38:32 INFO - (blobuploader) - INFO - Done attempting. 12:38:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:38:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:38:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:38:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:38:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:38:32 INFO - (blobuploader) - INFO - Done attempting. 12:38:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:38:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:38:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:38:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:38:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:38:33 INFO - (blobuploader) - INFO - Done attempting. 12:38:33 INFO - (blobuploader) - INFO - Iteration through files over. 12:38:33 INFO - Return code: 0 12:38:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:38:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:38:33 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5b6355d1d26eb2c3e538be28b0d7afa5a5adfcb635fcdcff2bd21786ac839474f1d3d735002400fb88bb03a951eeb0b4564f8614140ee83c724b9d6f985f1436", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a44090478a301e2cad3269ff4f40dfbc0d1abe70d8f0a53a8f2a23ba942f37acc2c443ffa39f7c4afa05cb0230627876ad395a2c80af1ecb281f6bad6ec14857", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bba78f13fd96a4fb909ce99bd0e2e51211abeeb74a0ea13d93d6ec229faa5fffe1cdc0f984bffd6493e9f050627919bdcad50b89ae3edacaa9b578a0f7928d76"} 12:38:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:38:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:38:33 INFO - Contents: 12:38:33 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5b6355d1d26eb2c3e538be28b0d7afa5a5adfcb635fcdcff2bd21786ac839474f1d3d735002400fb88bb03a951eeb0b4564f8614140ee83c724b9d6f985f1436", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a44090478a301e2cad3269ff4f40dfbc0d1abe70d8f0a53a8f2a23ba942f37acc2c443ffa39f7c4afa05cb0230627876ad395a2c80af1ecb281f6bad6ec14857", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bba78f13fd96a4fb909ce99bd0e2e51211abeeb74a0ea13d93d6ec229faa5fffe1cdc0f984bffd6493e9f050627919bdcad50b89ae3edacaa9b578a0f7928d76"} 12:38:33 INFO - Running post-run listener: copy_logs_to_upload_dir 12:38:33 INFO - Copying logs to upload dir... 12:38:33 INFO - mkdir: /builds/slave/test/build/upload/logs 12:38:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.688776 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-10-05 12:38:32.882968) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-05 12:38:32.886108) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1475694158.600154-486825302 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5b6355d1d26eb2c3e538be28b0d7afa5a5adfcb635fcdcff2bd21786ac839474f1d3d735002400fb88bb03a951eeb0b4564f8614140ee83c724b9d6f985f1436", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a44090478a301e2cad3269ff4f40dfbc0d1abe70d8f0a53a8f2a23ba942f37acc2c443ffa39f7c4afa05cb0230627876ad395a2c80af1ecb281f6bad6ec14857", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bba78f13fd96a4fb909ce99bd0e2e51211abeeb74a0ea13d93d6ec229faa5fffe1cdc0f984bffd6493e9f050627919bdcad50b89ae3edacaa9b578a0f7928d76"} build_url:https://queue.taskcluster.net/v1/task/agED1cJfT4iwz9LEXK3Q3w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011257 build_url: 'https://queue.taskcluster.net/v1/task/agED1cJfT4iwz9LEXK3Q3w/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/Fx-Team/sha512/5b6355d1d26eb2c3e538be28b0d7afa5a5adfcb635fcdcff2bd21786ac839474f1d3d735002400fb88bb03a951eeb0b4564f8614140ee83c724b9d6f985f1436", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a44090478a301e2cad3269ff4f40dfbc0d1abe70d8f0a53a8f2a23ba942f37acc2c443ffa39f7c4afa05cb0230627876ad395a2c80af1ecb281f6bad6ec14857", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bba78f13fd96a4fb909ce99bd0e2e51211abeeb74a0ea13d93d6ec229faa5fffe1cdc0f984bffd6493e9f050627919bdcad50b89ae3edacaa9b578a0f7928d76"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-05 12:38:32.911529) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 12:38:32.911865) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1475694158.600154-486825302 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004530 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 12:38:32.993515) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-05 12:38:32.993875) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-05 12:38:32.994239) ========= ========= Total master_lag: 0.17 =========