builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-025 starttime: 1486144611.25 results: success (0) buildid: 20170203075709 builduid: 800cee2a0ada4116adb8664e805f322a revision: ff56de0ee8dc01c99e4919b626f8a3c339aca01f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-03 09:56:51.251199) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-03 09:56:51.251683) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-03 09:56:51.251968) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-03 09:56:51.269534) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-03 09:56:51.270133) ========= 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=232498196343f89f466a4a9a000001c8-1486144611.263000-766323756 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-02-03 09:56:51-- 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: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.0M=0s 2017-02-03 09:56:51 (46.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.080020 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-03 09:56:51.364326) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-03 09:56:51.364678) ========= 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=232498196343f89f466a4a9a000001c8-1486144611.263000-766323756 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019669 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-03 09:56:51.416190) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-03 09:56:51.416782) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev ff56de0ee8dc01c99e4919b626f8a3c339aca01f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev ff56de0ee8dc01c99e4919b626f8a3c339aca01f --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=232498196343f89f466a4a9a000001c8-1486144611.263000-766323756 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-02-03 09:56:52,077 truncating revision to first 12 chars 2017-02-03 09:56:52,077 Setting DEBUG logging. 2017-02-03 09:56:52,077 attempt 1/10 2017-02-03 09:56:52,077 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/ff56de0ee8dc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-03 09:56:53,629 unpacking tar archive at: mozilla-beta-ff56de0ee8dc/testing/mozharness/ program finished with exit code 0 elapsedTime=1.838649 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-03 09:56:53.270555) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-03 09:56:53.271108) ========= script_repo_revision: ff56de0ee8dc01c99e4919b626f8a3c339aca01f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-03 09:56:53.271895) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-03 09:56:53.272414) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-03 09:56:53.283369) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2017-02-03 09:56:53.283708) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=232498196343f89f466a4a9a000001c8-1486144611.263000-766323756 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:56:54 INFO - MultiFileLogger online at 20170203 09:56:54 in /builds/slave/test 09:56:54 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 09:56:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:56:54 INFO - {'append_to_log': False, 09:56:54 INFO - 'base_work_dir': '/builds/slave/test', 09:56:54 INFO - 'blob_upload_branch': 'Mozilla-Beta', 09:56:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:56:54 INFO - 'branch': 'Mozilla-Beta', 09:56:54 INFO - 'buildbot_json_path': 'buildprops.json', 09:56:54 INFO - 'config_files': ('talos/linux_config.py',), 09:56:54 INFO - 'default_actions': ('clobber', 09:56:54 INFO - 'read-buildbot-config', 09:56:54 INFO - 'download-and-extract', 09:56:54 INFO - 'populate-webroot', 09:56:54 INFO - 'create-virtualenv', 09:56:54 INFO - 'install', 09:56:54 INFO - 'run-tests'), 09:56:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:56:54 INFO - 'download_minidump_stackwalk': True, 09:56:54 INFO - 'download_symbols': 'ondemand', 09:56:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:56:54 INFO - 'tooltool.py': '/tools/tooltool.py', 09:56:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:56:54 INFO - '/tools/misc-python/virtualenv.py')}, 09:56:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:56:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:56:54 INFO - 'installer_path': 'installer.exe', 09:56:54 INFO - 'log_level': 'info', 09:56:54 INFO - 'log_name': 'talos', 09:56:54 INFO - 'log_to_console': True, 09:56:54 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:56:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:56:54 INFO - 'opt_config_files': (), 09:56:54 INFO - 'pip_index': False, 09:56:54 INFO - 'sps_profile': False, 09:56:54 INFO - 'sps_profile_interval': 0, 09:56:54 INFO - 'suite': 'dromaeojs', 09:56:54 INFO - 'system_bits': '32', 09:56:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:56:54 INFO - 'title': 'talos-linux64-ix-025', 09:56:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:56:54 INFO - 'use_talos_json': True, 09:56:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:56:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:56:54 INFO - 'work_dir': 'build'} 09:56:54 INFO - [mozharness: 2017-02-03 17:56:54.039343Z] Running clobber step. 09:56:54 INFO - Running pre-action listener: _resource_record_pre_action 09:56:54 INFO - Running main action method: clobber 09:56:54 INFO - rmtree: /builds/slave/test/build 09:56:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:56:55 INFO - Running post-action listener: _resource_record_post_action 09:56:55 INFO - [mozharness: 2017-02-03 17:56:55.070913Z] Finished clobber step (success) 09:56:55 INFO - [mozharness: 2017-02-03 17:56:55.071013Z] Running read-buildbot-config step. 09:56:55 INFO - Running pre-action listener: _resource_record_pre_action 09:56:55 INFO - Running main action method: read_buildbot_config 09:56:55 INFO - Using buildbot properties: 09:56:55 INFO - { 09:56:55 INFO - "project": "", 09:56:55 INFO - "product": "firefox", 09:56:55 INFO - "script_repo_revision": "production", 09:56:55 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 09:56:55 INFO - "repository": "", 09:56:55 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 09:56:55 INFO - "buildid": "20170203075709", 09:56:55 INFO - "pgo_build": "True", 09:56:55 INFO - "basedir": "/builds/slave/test", 09:56:55 INFO - "buildnumber": 129, 09:56:55 INFO - "slavename": "talos-linux64-ix-025", 09:56:55 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:56:55 INFO - "platform": "ubuntu64_hw", 09:56:55 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 09:56:55 INFO - "branch": "mozilla-beta", 09:56:55 INFO - "repo_path": "releases/mozilla-beta", 09:56:55 INFO - "revision": "ff56de0ee8dc01c99e4919b626f8a3c339aca01f", 09:56:55 INFO - "stage_platform": "linux64-pgo", 09:56:55 INFO - "builduid": "800cee2a0ada4116adb8664e805f322a", 09:56:55 INFO - "slavebuilddir": "test" 09:56:55 INFO - } 09:56:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/FfvNzY4WR-agOnZ6r4AxJA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2. 09:56:55 INFO - Running post-action listener: _resource_record_post_action 09:56:55 INFO - [mozharness: 2017-02-03 17:56:55.073416Z] Finished read-buildbot-config step (success) 09:56:55 INFO - [mozharness: 2017-02-03 17:56:55.073504Z] Running download-and-extract step. 09:56:55 INFO - Running pre-action listener: _resource_record_pre_action 09:56:55 INFO - Running main action method: download_and_extract 09:56:55 INFO - mkdir: /builds/slave/test/build/tests 09:56: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')]} 09:56:55 INFO - trying https://queue.taskcluster.net/v1/task/FfvNzY4WR-agOnZ6r4AxJA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 09:56:55 INFO - Downloading https://queue.taskcluster.net/v1/task/FfvNzY4WR-agOnZ6r4AxJA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 09:56:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FfvNzY4WR-agOnZ6r4AxJA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:56:55 INFO - Downloaded 1327 bytes. 09:56:55 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 09:56:55 INFO - Using the following test package requirements: 09:56:55 INFO - {u'common': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 09:56:55 INFO - u'cppunittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 09:56:55 INFO - u'firefox-52.0.en-US.linux-x86_64.cppunittest.tests.zip'], 09:56:55 INFO - u'gtest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 09:56:55 INFO - u'firefox-52.0.en-US.linux-x86_64.gtest.tests.zip'], 09:56:55 INFO - u'jittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 09:56:55 INFO - u'jsshell-linux-x86_64.zip'], 09:56:55 INFO - u'mochitest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 09:56:55 INFO - u'firefox-52.0.en-US.linux-x86_64.mochitest.tests.zip'], 09:56:55 INFO - u'mozbase': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 09:56:55 INFO - u'reftest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 09:56:55 INFO - u'firefox-52.0.en-US.linux-x86_64.reftest.tests.zip'], 09:56:55 INFO - u'talos': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 09:56:55 INFO - u'firefox-52.0.en-US.linux-x86_64.talos.tests.zip'], 09:56:55 INFO - u'web-platform': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 09:56:55 INFO - u'firefox-52.0.en-US.linux-x86_64.web-platform.tests.zip'], 09:56:55 INFO - u'xpcshell': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 09:56:55 INFO - u'firefox-52.0.en-US.linux-x86_64.xpcshell.tests.zip']} 09:56:55 INFO - Downloading packages: [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:56:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FfvNzY4WR-agOnZ6r4AxJA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 09:56:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FfvNzY4WR-agOnZ6r4AxJA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:56:55 INFO - Fetch https://queue.taskcluster.net/v1/task/FfvNzY4WR-agOnZ6r4AxJA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 09:56:56 INFO - Http code: 200 09:56:56 INFO - via: 1.1 d2bd759914e30b1d5aee2929535c55f9.cloudfront.net (CloudFront) 09:56:56 INFO - x-amz-cf-id: gLaFoaMCfdMta6WDGaKpb4CAO1ujJWhkBbOgQ5w7P7i_FPLi3Gdq4g== 09:56:56 INFO - x-amz-version-id: JEUDG1B24VTDUCCZ0eBhZj9VqUJy.l6j 09:56:56 INFO - Expected file size: 21956354 09:56:56 INFO - Obtained file size: 21956354 09:57:00 INFO - Downloading packages: [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:57:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FfvNzY4WR-agOnZ6r4AxJA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 09:57:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FfvNzY4WR-agOnZ6r4AxJA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:57:00 INFO - Fetch https://queue.taskcluster.net/v1/task/FfvNzY4WR-agOnZ6r4AxJA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 09:57:01 INFO - Http code: 200 09:57:01 INFO - via: 1.1 d8f42fc9558e3e49ebfdf8834baeb756.cloudfront.net (CloudFront) 09:57:01 INFO - x-amz-cf-id: hMBAwNHhCsfFEjKO9J8yEgpWDHHxqLWbxPW9GPAX37jd5IZZJwpG7A== 09:57:01 INFO - x-amz-version-id: JEUDG1B24VTDUCCZ0eBhZj9VqUJy.l6j 09:57:01 INFO - Expected file size: 21956354 09:57:01 INFO - Obtained file size: 21956354 09:57:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FfvNzY4WR-agOnZ6r4AxJA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip 09:57:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FfvNzY4WR-agOnZ6r4AxJA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:57:05 INFO - Fetch https://queue.taskcluster.net/v1/task/FfvNzY4WR-agOnZ6r4AxJA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip into memory 09:57:06 INFO - Http code: 200 09:57:06 INFO - via: 1.1 66ed69e8b47ad05050331602c798132f.cloudfront.net (CloudFront) 09:57:06 INFO - x-amz-cf-id: TPBUUIVvBOMPHN79MWjA8iiM3Bxit-7PptsV1jSWk_8xBmbSSGSwmw== 09:57:06 INFO - x-amz-version-id: c3Iq3AWGK2mDEjhO3XAj8bg1d6t2FgyU 09:57:06 INFO - Expected file size: 14403005 09:57:06 INFO - Obtained file size: 14403005 09:57:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:57:06 INFO - trying https://queue.taskcluster.net/v1/task/FfvNzY4WR-agOnZ6r4AxJA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 09:57:06 INFO - Downloading https://queue.taskcluster.net/v1/task/FfvNzY4WR-agOnZ6r4AxJA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 09:57:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FfvNzY4WR-agOnZ6r4AxJA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:57:07 INFO - Downloaded 57715554 bytes. 09:57:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FfvNzY4WR-agOnZ6r4AxJA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 09:57:07 INFO - mkdir: /builds/slave/test/properties 09:57:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:57:07 INFO - Writing to file /builds/slave/test/properties/build_url 09:57:07 INFO - Contents: 09:57:07 INFO - build_url:https://queue.taskcluster.net/v1/task/FfvNzY4WR-agOnZ6r4AxJA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 09:57:08 INFO - Running post-action listener: _resource_record_post_action 09:57:08 INFO - Running post-action listener: set_extra_try_arguments 09:57:08 INFO - [mozharness: 2017-02-03 17:57:08.557768Z] Finished download-and-extract step (success) 09:57:08 INFO - [mozharness: 2017-02-03 17:57:08.557994Z] Running populate-webroot step. 09:57:08 INFO - Running pre-action listener: _resource_record_pre_action 09:57:08 INFO - Running main action method: populate_webroot 09:57:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:57:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:57:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:57:08 INFO - '--tppagecycles', 09:57:08 INFO - '7'], 09:57:08 INFO - 'tests': ['tsvgm']}}, 09:57:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:57:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:57:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:57:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:57:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:57:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:57:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:08 INFO - 'talos_options': ['--disable-e10s'], 09:57:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:57:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:57:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:08 INFO - 'talos_options': ['--disable-e10s'], 09:57:08 INFO - 'tests': ['damp', 'tps']}, 09:57:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:08 INFO - 'tests': ['damp', 'tps']}, 09:57:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:57:08 INFO - 'tests': ['dromaeo_dom']}, 09:57:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:57:08 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:57:08 INFO - 'tests': ['basic_compositor_video']}, 09:57:08 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:57:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:57:08 INFO - 'tests': ['a11yr', 09:57:08 INFO - 'ts_paint', 09:57:08 INFO - 'tpaint', 09:57:08 INFO - 'sessionrestore', 09:57:08 INFO - 'sessionrestore_no_auto_restore', 09:57:08 INFO - 'tabpaint']}, 09:57:08 INFO - 'other-e10s': {'tests': ['a11yr', 09:57:08 INFO - 'ts_paint', 09:57:08 INFO - 'tpaint', 09:57:08 INFO - 'sessionrestore', 09:57:08 INFO - 'sessionrestore_no_auto_restore', 09:57:08 INFO - 'tabpaint']}, 09:57:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:57:08 INFO - 'ts_paint', 09:57:08 INFO - 'tpaint', 09:57:08 INFO - 'sessionrestore', 09:57:08 INFO - 'sessionrestore_no_auto_restore', 09:57:08 INFO - 'tabpaint']}, 09:57:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:57:08 INFO - 'ts_paint', 09:57:08 INFO - 'tpaint', 09:57:08 INFO - 'sessionrestore', 09:57:08 INFO - 'sessionrestore_no_auto_restore', 09:57:08 INFO - 'tabpaint']}, 09:57:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:57:08 INFO - 'tests': ['a11yr', 09:57:08 INFO - 'ts_paint', 09:57:08 INFO - 'tpaint', 09:57:08 INFO - 'sessionrestore', 09:57:08 INFO - 'sessionrestore_no_auto_restore', 09:57:08 INFO - 'tabpaint']}, 09:57:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:57:08 INFO - 'tests': ['a11yr', 09:57:08 INFO - 'ts_paint', 09:57:08 INFO - 'tpaint', 09:57:08 INFO - 'sessionrestore', 09:57:08 INFO - 'sessionrestore_no_auto_restore', 09:57:08 INFO - 'tabpaint']}, 09:57:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:57:08 INFO - 'tests': ['tsvgx', 09:57:08 INFO - 'tsvgr_opacity', 09:57:08 INFO - 'tart', 09:57:08 INFO - 'tscrollx', 09:57:08 INFO - 'cart']}, 09:57:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:57:08 INFO - 'tsvgr_opacity', 09:57:08 INFO - 'tart', 09:57:08 INFO - 'tscrollx', 09:57:08 INFO - 'cart']}, 09:57:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:08 INFO - 'talos_options': ['--disable-e10s'], 09:57:08 INFO - 'tests': ['tp5o']}, 09:57:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:08 INFO - 'tests': ['tp5o']}, 09:57:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:08 INFO - 'talos_options': ['--disable-e10s', 09:57:08 INFO - '--xperf_path', 09:57:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:57:08 INFO - 'tests': ['tp5n']}, 09:57:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:08 INFO - 'talos_options': ['--xperf_path', 09:57:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:57:08 INFO - 'tests': ['tp5n']}}, 09:57:08 INFO - 'talos.zip': {'path': '', 09:57:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:57:08 INFO - Running post-action listener: _resource_record_post_action 09:57:08 INFO - [mozharness: 2017-02-03 17:57:08.576789Z] Finished populate-webroot step (success) 09:57:08 INFO - [mozharness: 2017-02-03 17:57:08.576876Z] Running create-virtualenv step. 09:57:08 INFO - Running pre-action listener: _resource_record_pre_action 09:57:08 INFO - Running main action method: create_virtualenv 09:57:08 INFO - Creating virtualenv /builds/slave/test/build/venv 09:57: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 09:57:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:57:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:57:08 INFO - Using real prefix '/usr' 09:57:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:57:09 INFO - Installing distribute.............................................................................................................................................................................................done. 09:57:11 INFO - Installing pip.................done. 09:57:11 INFO - Return code: 0 09:57:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:57:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:57:11 INFO - Reading from file tmpfile_stdout 09:57:11 INFO - Output received: 09:57: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) 09:57:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:57: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')]} 09:57:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57: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')]} 09:57:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57: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 0x7fe36733cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1274ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1271f60>, '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 0x1272d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12731d0>, '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': '232498196343f89f466a4a9a000001c8-1486144611.263000-766323756', '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 09:57: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 09:57: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 09:57:11 INFO - Using env: {'DISPLAY': ':0', 09:57:11 INFO - 'HOME': '/home/cltbld', 09:57:11 INFO - 'LANG': 'en_US.UTF-8', 09:57:11 INFO - 'LANGUAGE': 'en_US:en', 09:57:11 INFO - 'LOGNAME': 'cltbld', 09:57:11 INFO - 'MAIL': '/var/mail/cltbld', 09:57:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:11 INFO - 'MOZ_NO_REMOTE': '1', 09:57:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:57:11 INFO - 'NO_EM_RESTART': '1', 09:57:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:57:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:11 INFO - 'PWD': '/builds/slave/test', 09:57:11 INFO - 'SHELL': '/bin/bash', 09:57:11 INFO - 'SHLVL': '1', 09:57:11 INFO - 'TERM': 'linux', 09:57:11 INFO - 'TMOUT': '86400', 09:57:11 INFO - 'USER': 'cltbld', 09:57:11 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1486144611.263000-766323756', 09:57:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:11 INFO - '_': '/tools/buildbot/bin/python'} 09:57:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57: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 09:57:11 INFO - Cleaning up... 09:57:11 INFO - Return code: 0 09:57:11 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:57: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')]} 09:57:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57: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')]} 09:57:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57: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 0x7fe36733cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1274ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1271f60>, '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 0x1272d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12731d0>, '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': '232498196343f89f466a4a9a000001c8-1486144611.263000-766323756', '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 09:57: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 09:57: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 09:57:11 INFO - Using env: {'DISPLAY': ':0', 09:57:11 INFO - 'HOME': '/home/cltbld', 09:57:11 INFO - 'LANG': 'en_US.UTF-8', 09:57:11 INFO - 'LANGUAGE': 'en_US:en', 09:57:11 INFO - 'LOGNAME': 'cltbld', 09:57:11 INFO - 'MAIL': '/var/mail/cltbld', 09:57:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:11 INFO - 'MOZ_NO_REMOTE': '1', 09:57:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:57:11 INFO - 'NO_EM_RESTART': '1', 09:57:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:57:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:11 INFO - 'PWD': '/builds/slave/test', 09:57:11 INFO - 'SHELL': '/bin/bash', 09:57:11 INFO - 'SHLVL': '1', 09:57:11 INFO - 'TERM': 'linux', 09:57:11 INFO - 'TMOUT': '86400', 09:57:11 INFO - 'USER': 'cltbld', 09:57:11 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1486144611.263000-766323756', 09:57:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:11 INFO - '_': '/tools/buildbot/bin/python'} 09:57:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:11 INFO - Downloading/unpacking psutil>=3.1.1 09:57:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:57:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:57:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:57:13 INFO - Installing collected packages: psutil 09:57:13 INFO - Running setup.py install for psutil 09:57:13 INFO - building 'psutil._psutil_linux' extension 09:57:13 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 09:57: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 09:57:14 INFO - building 'psutil._psutil_posix' extension 09:57: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 09:57: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 09:57:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:57:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:57:14 INFO - Successfully installed psutil 09:57:14 INFO - Cleaning up... 09:57:14 INFO - Return code: 0 09:57:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:57: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')]} 09:57:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57: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')]} 09:57:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57: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 0x7fe36733cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1274ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1271f60>, '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 0x1272d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12731d0>, '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': '232498196343f89f466a4a9a000001c8-1486144611.263000-766323756', '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 09:57: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 09:57: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 09:57:14 INFO - Using env: {'DISPLAY': ':0', 09:57:14 INFO - 'HOME': '/home/cltbld', 09:57:14 INFO - 'LANG': 'en_US.UTF-8', 09:57:14 INFO - 'LANGUAGE': 'en_US:en', 09:57:14 INFO - 'LOGNAME': 'cltbld', 09:57:14 INFO - 'MAIL': '/var/mail/cltbld', 09:57:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:14 INFO - 'MOZ_NO_REMOTE': '1', 09:57:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:57:14 INFO - 'NO_EM_RESTART': '1', 09:57:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:57:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:14 INFO - 'PWD': '/builds/slave/test', 09:57:14 INFO - 'SHELL': '/bin/bash', 09:57:14 INFO - 'SHLVL': '1', 09:57:14 INFO - 'TERM': 'linux', 09:57:14 INFO - 'TMOUT': '86400', 09:57:14 INFO - 'USER': 'cltbld', 09:57:14 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1486144611.263000-766323756', 09:57:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:14 INFO - '_': '/tools/buildbot/bin/python'} 09:57:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:14 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:57: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 09:57: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 09:57: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 09:57: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 09:57: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 09:57: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 09:57:16 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:57:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:57:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:57:16 INFO - Installing collected packages: mozsystemmonitor 09:57:16 INFO - Running setup.py install for mozsystemmonitor 09:57:16 INFO - Successfully installed mozsystemmonitor 09:57:16 INFO - Cleaning up... 09:57:16 INFO - Return code: 0 09:57:16 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:57:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:57:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:57:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe36733cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1274ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1271f60>, '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 0x1272d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12731d0>, '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': '232498196343f89f466a4a9a000001c8-1486144611.263000-766323756', '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 09:57:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:57:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:57:16 INFO - Using env: {'DISPLAY': ':0', 09:57:16 INFO - 'HOME': '/home/cltbld', 09:57:16 INFO - 'LANG': 'en_US.UTF-8', 09:57:16 INFO - 'LANGUAGE': 'en_US:en', 09:57:16 INFO - 'LOGNAME': 'cltbld', 09:57:16 INFO - 'MAIL': '/var/mail/cltbld', 09:57:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:16 INFO - 'MOZ_NO_REMOTE': '1', 09:57:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:57:16 INFO - 'NO_EM_RESTART': '1', 09:57:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:57:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:16 INFO - 'PWD': '/builds/slave/test', 09:57:16 INFO - 'SHELL': '/bin/bash', 09:57:16 INFO - 'SHLVL': '1', 09:57:16 INFO - 'TERM': 'linux', 09:57:16 INFO - 'TMOUT': '86400', 09:57:16 INFO - 'USER': 'cltbld', 09:57:16 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1486144611.263000-766323756', 09:57:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:16 INFO - '_': '/tools/buildbot/bin/python'} 09:57:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:17 INFO - Downloading/unpacking jsonschema==2.5.1 09:57: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 09:57: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 09:57: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 09:57: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 09:57: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 09:57: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 09:57:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:57:19 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:57: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 09:57: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 09:57: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 09:57: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 09:57: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 09:57: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 09:57:19 INFO - Downloading functools32-3.2.3-2.tar.gz 09:57:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:57:19 INFO - warning: no files found matching '*.txt' 09:57:19 INFO - no previously-included directories found matching 'build' 09:57:19 INFO - no previously-included directories found matching 'dist' 09:57:19 INFO - no previously-included directories found matching '.git*' 09:57:19 INFO - Installing collected packages: jsonschema, functools32 09:57:19 INFO - Running setup.py install for functools32 09:57:19 INFO - warning: no files found matching '*.txt' 09:57:19 INFO - no previously-included directories found matching 'build' 09:57:19 INFO - no previously-included directories found matching 'dist' 09:57:19 INFO - no previously-included directories found matching '.git*' 09:57:19 INFO - Successfully installed jsonschema functools32 09:57:19 INFO - Cleaning up... 09:57:19 INFO - Return code: 0 09:57:19 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:57: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')]} 09:57:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57: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')]} 09:57:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57: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 0x7fe36733cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1274ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1271f60>, '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 0x1272d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12731d0>, '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': '232498196343f89f466a4a9a000001c8-1486144611.263000-766323756', '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 09:57: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 09:57: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 09:57:19 INFO - Using env: {'DISPLAY': ':0', 09:57:19 INFO - 'HOME': '/home/cltbld', 09:57:19 INFO - 'LANG': 'en_US.UTF-8', 09:57:19 INFO - 'LANGUAGE': 'en_US:en', 09:57:19 INFO - 'LOGNAME': 'cltbld', 09:57:19 INFO - 'MAIL': '/var/mail/cltbld', 09:57:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:19 INFO - 'MOZ_NO_REMOTE': '1', 09:57:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:57:19 INFO - 'NO_EM_RESTART': '1', 09:57:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:57:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:19 INFO - 'PWD': '/builds/slave/test', 09:57:19 INFO - 'SHELL': '/bin/bash', 09:57:19 INFO - 'SHLVL': '1', 09:57:19 INFO - 'TERM': 'linux', 09:57:19 INFO - 'TMOUT': '86400', 09:57:19 INFO - 'USER': 'cltbld', 09:57:19 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1486144611.263000-766323756', 09:57:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:19 INFO - '_': '/tools/buildbot/bin/python'} 09:57:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:19 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:57:19 INFO - Cleaning up... 09:57:19 INFO - Return code: 0 09:57:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:57: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')]} 09:57:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57: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')]} 09:57:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57: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 0x7fe36733cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1274ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1271f60>, '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 0x1272d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12731d0>, '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': '232498196343f89f466a4a9a000001c8-1486144611.263000-766323756', '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 09:57: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 09:57: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 09:57:19 INFO - Using env: {'DISPLAY': ':0', 09:57:19 INFO - 'HOME': '/home/cltbld', 09:57:19 INFO - 'LANG': 'en_US.UTF-8', 09:57:19 INFO - 'LANGUAGE': 'en_US:en', 09:57:19 INFO - 'LOGNAME': 'cltbld', 09:57:19 INFO - 'MAIL': '/var/mail/cltbld', 09:57:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:19 INFO - 'MOZ_NO_REMOTE': '1', 09:57:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:57:19 INFO - 'NO_EM_RESTART': '1', 09:57:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:57:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:19 INFO - 'PWD': '/builds/slave/test', 09:57:19 INFO - 'SHELL': '/bin/bash', 09:57:19 INFO - 'SHLVL': '1', 09:57:19 INFO - 'TERM': 'linux', 09:57:19 INFO - 'TMOUT': '86400', 09:57:19 INFO - 'USER': 'cltbld', 09:57:19 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1486144611.263000-766323756', 09:57:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:19 INFO - '_': '/tools/buildbot/bin/python'} 09:57:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:20 INFO - Downloading/unpacking blobuploader==1.2.4 09:57: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 09:57: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 09:57: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 09:57: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 09:57: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 09:57: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 09:57:22 INFO - Downloading blobuploader-1.2.4.tar.gz 09:57:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:57:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:57: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 09:57: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 09:57: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 09:57: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 09:57: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 09:57: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 09:57:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:57:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:57: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 09:57: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 09:57: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 09:57: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 09:57: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 09:57: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 09:57:22 INFO - Downloading docopt-0.6.1.tar.gz 09:57:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:57:22 INFO - Installing collected packages: blobuploader, requests, docopt 09:57:22 INFO - Running setup.py install for blobuploader 09:57:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:57:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:57:23 INFO - Running setup.py install for requests 09:57:23 INFO - Running setup.py install for docopt 09:57:23 INFO - Successfully installed blobuploader requests docopt 09:57:23 INFO - Cleaning up... 09:57:23 INFO - Return code: 0 09:57:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:57: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')]} 09:57:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57: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')]} 09:57:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57: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 0x7fe36733cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1274ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1271f60>, '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 0x1272d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12731d0>, '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': '232498196343f89f466a4a9a000001c8-1486144611.263000-766323756', '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 09:57: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 09:57: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 09:57:23 INFO - Using env: {'DISPLAY': ':0', 09:57:23 INFO - 'HOME': '/home/cltbld', 09:57:23 INFO - 'LANG': 'en_US.UTF-8', 09:57:23 INFO - 'LANGUAGE': 'en_US:en', 09:57:23 INFO - 'LOGNAME': 'cltbld', 09:57:23 INFO - 'MAIL': '/var/mail/cltbld', 09:57:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:23 INFO - 'MOZ_NO_REMOTE': '1', 09:57:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:57:23 INFO - 'NO_EM_RESTART': '1', 09:57:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:57:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:23 INFO - 'PWD': '/builds/slave/test', 09:57:23 INFO - 'SHELL': '/bin/bash', 09:57:23 INFO - 'SHLVL': '1', 09:57:23 INFO - 'TERM': 'linux', 09:57:23 INFO - 'TMOUT': '86400', 09:57:23 INFO - 'USER': 'cltbld', 09:57:23 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1486144611.263000-766323756', 09:57:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:23 INFO - '_': '/tools/buildbot/bin/python'} 09:57:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:57:23 INFO - Running setup.py (path:/tmp/pip-uN8mTR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:57:23 INFO - Running setup.py (path:/tmp/pip-6rHNQo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:57:23 INFO - Running setup.py (path:/tmp/pip-Uug92U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:57:24 INFO - Running setup.py (path:/tmp/pip-7B5sR4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:57:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:57:24 INFO - Running setup.py (path:/tmp/pip-LNfGq1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:57:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:57:24 INFO - Running setup.py (path:/tmp/pip-wwKMi6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:57:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:57:24 INFO - Running setup.py (path:/tmp/pip-FJbipo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:57:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:57:24 INFO - Running setup.py (path:/tmp/pip-_VLmz5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:57:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:57:24 INFO - Running setup.py (path:/tmp/pip-Y_7tkV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:57:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:57:24 INFO - Running setup.py (path:/tmp/pip-NPfq1w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:57:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:57:24 INFO - Running setup.py (path:/tmp/pip-jQZI4n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:57:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:57:24 INFO - Running setup.py (path:/tmp/pip-wQMRPw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:57:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:57:24 INFO - Running setup.py (path:/tmp/pip-UhuzVN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:57:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:57:24 INFO - Running setup.py (path:/tmp/pip-CFeS8S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:57:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:57:24 INFO - Running setup.py (path:/tmp/pip-ZyDLrZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:57:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:57:24 INFO - Running setup.py (path:/tmp/pip-nJQwmQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:57:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:57:24 INFO - Running setup.py (path:/tmp/pip-J1Xq_h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:57:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:57:24 INFO - Running setup.py install for manifestparser 09:57:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:57:25 INFO - Running setup.py install for mozcrash 09:57:25 INFO - Running setup.py install for mozdebug 09:57:25 INFO - Running setup.py install for mozdevice 09:57:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:57:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:57:25 INFO - Running setup.py install for mozfile 09:57:25 INFO - Running setup.py install for mozhttpd 09:57:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:57:25 INFO - Running setup.py install for mozinfo 09:57:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:57:25 INFO - Running setup.py install for mozInstall 09:57:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:57:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:57:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:57:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:57:25 INFO - Running setup.py install for mozleak 09:57:25 INFO - Running setup.py install for mozlog 09:57:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:57:26 INFO - Running setup.py install for moznetwork 09:57:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:57:26 INFO - Running setup.py install for mozprocess 09:57:26 INFO - Running setup.py install for mozprofile 09:57:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:57:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:57:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:57:26 INFO - Running setup.py install for mozrunner 09:57:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:57:26 INFO - Running setup.py install for mozscreenshot 09:57:26 INFO - Running setup.py install for moztest 09:57:26 INFO - Running setup.py install for mozversion 09:57:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:57:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:57:26 INFO - Cleaning up... 09:57:26 INFO - Return code: 0 09:57:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:57: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')]} 09:57:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57: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')]} 09:57:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57: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 0x7fe36733cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1274ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1271f60>, '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 0x1272d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12731d0>, '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': '232498196343f89f466a4a9a000001c8-1486144611.263000-766323756', '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 09:57: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 09:57: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 09:57:26 INFO - Using env: {'DISPLAY': ':0', 09:57:26 INFO - 'HOME': '/home/cltbld', 09:57:26 INFO - 'LANG': 'en_US.UTF-8', 09:57:26 INFO - 'LANGUAGE': 'en_US:en', 09:57:26 INFO - 'LOGNAME': 'cltbld', 09:57:26 INFO - 'MAIL': '/var/mail/cltbld', 09:57:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:26 INFO - 'MOZ_NO_REMOTE': '1', 09:57:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:57:26 INFO - 'NO_EM_RESTART': '1', 09:57:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:57:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:26 INFO - 'PWD': '/builds/slave/test', 09:57:26 INFO - 'SHELL': '/bin/bash', 09:57:26 INFO - 'SHLVL': '1', 09:57:26 INFO - 'TERM': 'linux', 09:57:26 INFO - 'TMOUT': '86400', 09:57:26 INFO - 'USER': 'cltbld', 09:57:26 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1486144611.263000-766323756', 09:57:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:26 INFO - '_': '/tools/buildbot/bin/python'} 09:57:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:57:27 INFO - Running setup.py (path:/tmp/pip-5uJxVf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:57:27 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)) 09:57:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:57:27 INFO - Running setup.py (path:/tmp/pip-BjLw4q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:57:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:57:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:57:27 INFO - Running setup.py (path:/tmp/pip-EYXhFn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:57: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)) 09:57:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:57:27 INFO - Running setup.py (path:/tmp/pip-4h6qbi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:57: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)) 09:57:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:57:27 INFO - Running setup.py (path:/tmp/pip-FBX23z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:57: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)) 09:57:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:57:27 INFO - Running setup.py (path:/tmp/pip-LiUqYN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:57: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)) 09:57:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:57:27 INFO - Running setup.py (path:/tmp/pip-_2ZRxW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:57: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)) 09:57:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:57:27 INFO - Running setup.py (path:/tmp/pip-tnduJv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:57: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)) 09:57:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:57:27 INFO - Running setup.py (path:/tmp/pip-kkxNXZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:57: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)) 09:57:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:57:27 INFO - Running setup.py (path:/tmp/pip-iAPTnL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:57: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)) 09:57:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:57:27 INFO - Running setup.py (path:/tmp/pip-LiVqL0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:57: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)) 09:57:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:57:27 INFO - Running setup.py (path:/tmp/pip-lqC6B5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:57: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)) 09:57:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:57:27 INFO - Running setup.py (path:/tmp/pip-UXcI6r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:57: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)) 09:57:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:57:27 INFO - Running setup.py (path:/tmp/pip-jZVLHS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:57:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:57:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:57:28 INFO - Running setup.py (path:/tmp/pip-utAX7x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:57:28 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)) 09:57:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:57:28 INFO - Running setup.py (path:/tmp/pip-87J1CD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:57:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:57:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:57:28 INFO - Running setup.py (path:/tmp/pip-3U3895-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:57: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)) 09:57: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==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:57: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==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:57: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)) 09:57: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)) 09:57: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)) 09:57:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:57: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 09:57: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 09:57: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 09:57: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 09:57: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 09:57: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 09:57:30 INFO - Downloading blessings-1.6.tar.gz 09:57:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:57:30 INFO - Installing collected packages: blessings 09:57:30 INFO - Running setup.py install for blessings 09:57:30 INFO - Successfully installed blessings 09:57:30 INFO - Cleaning up... 09:57:30 INFO - Return code: 0 09:57:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:57:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:57:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:57:30 INFO - Reading from file tmpfile_stdout 09:57:30 INFO - Current package versions: 09:57:30 INFO - argparse == 1.2.1 09:57:30 INFO - blessings == 1.6 09:57:30 INFO - blobuploader == 1.2.4 09:57:30 INFO - docopt == 0.6.1 09:57:30 INFO - functools32 == 3.2.3-2 09:57:30 INFO - jsonschema == 2.5.1 09:57:30 INFO - manifestparser == 1.1 09:57:30 INFO - mozInstall == 1.12 09:57:30 INFO - mozcrash == 1.0 09:57:30 INFO - mozdebug == 0.1 09:57:30 INFO - mozdevice == 0.48 09:57:30 INFO - mozfile == 1.2 09:57:30 INFO - mozhttpd == 0.7 09:57:30 INFO - mozinfo == 0.9 09:57:30 INFO - mozleak == 0.1 09:57:30 INFO - mozlog == 3.4 09:57:30 INFO - moznetwork == 0.27 09:57:30 INFO - mozprocess == 0.23 09:57:30 INFO - mozprofile == 0.28 09:57:30 INFO - mozrunner == 6.13 09:57:30 INFO - mozscreenshot == 0.1 09:57:30 INFO - mozsystemmonitor == 0.3 09:57:30 INFO - moztest == 0.8 09:57:30 INFO - mozversion == 1.4 09:57:30 INFO - psutil == 3.1.1 09:57:30 INFO - requests == 1.2.3 09:57:30 INFO - wsgiref == 0.1.2 09:57:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:57: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')]} 09:57:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57: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')]} 09:57:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57: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 0x7fe36733cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1274ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1271f60>, '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 0x1272d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12731d0>, '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': '232498196343f89f466a4a9a000001c8-1486144611.263000-766323756', '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 09:57: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 09:57: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 09:57:30 INFO - Using env: {'DISPLAY': ':0', 09:57:30 INFO - 'HOME': '/home/cltbld', 09:57:30 INFO - 'LANG': 'en_US.UTF-8', 09:57:30 INFO - 'LANGUAGE': 'en_US:en', 09:57:30 INFO - 'LOGNAME': 'cltbld', 09:57:30 INFO - 'MAIL': '/var/mail/cltbld', 09:57:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:30 INFO - 'MOZ_NO_REMOTE': '1', 09:57:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:57:30 INFO - 'NO_EM_RESTART': '1', 09:57:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:57:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:30 INFO - 'PWD': '/builds/slave/test', 09:57:30 INFO - 'SHELL': '/bin/bash', 09:57:30 INFO - 'SHLVL': '1', 09:57:30 INFO - 'TERM': 'linux', 09:57:30 INFO - 'TMOUT': '86400', 09:57:30 INFO - 'USER': 'cltbld', 09:57:30 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1486144611.263000-766323756', 09:57:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:30 INFO - '_': '/tools/buildbot/bin/python'} 09:57:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57: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)) 09:57: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)) 09:57: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)) 09:57: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)) 09:57: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)) 09:57: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)) 09:57: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)) 09:57: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)) 09:57: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)) 09:57: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)) 09:57: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)) 09:57:30 INFO - Cleaning up... 09:57:30 INFO - Return code: 0 09:57:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:57: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')]} 09:57:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57: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')]} 09:57:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57: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 0x7fe36733cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1274ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1271f60>, '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 0x1272d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12731d0>, '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': '232498196343f89f466a4a9a000001c8-1486144611.263000-766323756', '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 09:57: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 09:57: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 09:57:30 INFO - Using env: {'DISPLAY': ':0', 09:57:30 INFO - 'HOME': '/home/cltbld', 09:57:30 INFO - 'LANG': 'en_US.UTF-8', 09:57:30 INFO - 'LANGUAGE': 'en_US:en', 09:57:31 INFO - 'LOGNAME': 'cltbld', 09:57:31 INFO - 'MAIL': '/var/mail/cltbld', 09:57:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:31 INFO - 'MOZ_NO_REMOTE': '1', 09:57:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:57:31 INFO - 'NO_EM_RESTART': '1', 09:57:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:57:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:31 INFO - 'PWD': '/builds/slave/test', 09:57:31 INFO - 'SHELL': '/bin/bash', 09:57:31 INFO - 'SHLVL': '1', 09:57:31 INFO - 'TERM': 'linux', 09:57:31 INFO - 'TMOUT': '86400', 09:57:31 INFO - 'USER': 'cltbld', 09:57:31 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1486144611.263000-766323756', 09:57:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:31 INFO - '_': '/tools/buildbot/bin/python'} 09:57:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:31 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:57:31 INFO - Cleaning up... 09:57:31 INFO - Return code: 0 09:57:31 INFO - Running post-action listener: _resource_record_post_action 09:57:31 INFO - Running post-action listener: _start_resource_monitoring 09:57:31 INFO - Starting resource monitoring. 09:57:31 INFO - [mozharness: 2017-02-03 17:57:31.239743Z] Finished create-virtualenv step (success) 09:57:31 INFO - [mozharness: 2017-02-03 17:57:31.240207Z] Running install step. 09:57:31 INFO - Running pre-action listener: _resource_record_pre_action 09:57:31 INFO - Running main action method: install 09:57:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:57:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:57:31 INFO - Reading from file tmpfile_stdout 09:57:31 INFO - Detecting whether we're running mozinstall >=1.0... 09:57:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:57:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:57:31 INFO - Reading from file tmpfile_stdout 09:57:31 INFO - Output received: 09:57:31 INFO - Usage: mozinstall [options] installer 09:57:31 INFO - Options: 09:57:31 INFO - -h, --help show this help message and exit 09:57:31 INFO - -d DEST, --destination=DEST 09:57:31 INFO - Directory to install application into. [default: 09:57:31 INFO - "/builds/slave/test"] 09:57:31 INFO - --app=APP Application being installed. [default: firefox] 09:57:31 INFO - mkdir: /builds/slave/test/build/application 09:57:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:57:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:57:45 INFO - Reading from file tmpfile_stdout 09:57:45 INFO - Output received: 09:57:45 INFO - /builds/slave/test/build/application/firefox/firefox 09:57:45 INFO - Running post-action listener: _resource_record_post_action 09:57:45 INFO - [mozharness: 2017-02-03 17:57:45.179369Z] Finished install step (success) 09:57:45 INFO - [mozharness: 2017-02-03 17:57:45.179615Z] Running run-tests step. 09:57:45 INFO - Running pre-action listener: _resource_record_pre_action 09:57:45 INFO - Running main action method: run_tests 09:57:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:57:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:57:45 INFO - Python 2.7.3 09:57:45 INFO - Return code: 0 09:57:45 INFO - grabbing minidump binary from tooltool 09:57:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:57:45 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 0x1271f60>, '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 0x1272d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12731d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:57:45 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 09:57:45 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 09:57:45 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 09:57:45 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:57:45 INFO - Return code: 0 09:57:45 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:57:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:57:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:57:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:57:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:57:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FfvNzY4WR-agOnZ6r4AxJA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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 09:57:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FfvNzY4WR-agOnZ6r4AxJA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-025 --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 09:57:45 INFO - Using env: {'DISPLAY': ':0', 09:57:45 INFO - 'HOME': '/home/cltbld', 09:57:45 INFO - 'LANG': 'en_US.UTF-8', 09:57:45 INFO - 'LANGUAGE': 'en_US:en', 09:57:45 INFO - 'LOGNAME': 'cltbld', 09:57:45 INFO - 'MAIL': '/var/mail/cltbld', 09:57:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:57:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:57:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:45 INFO - 'MOZ_NO_REMOTE': '1', 09:57:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:57:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:57:45 INFO - 'NO_EM_RESTART': '1', 09:57:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:57:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:45 INFO - 'PWD': '/builds/slave/test', 09:57:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:57:45 INFO - 'SHELL': '/bin/bash', 09:57:45 INFO - 'SHLVL': '1', 09:57:45 INFO - 'TERM': 'linux', 09:57:45 INFO - 'TMOUT': '86400', 09:57:45 INFO - 'USER': 'cltbld', 09:57:45 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1486144611.263000-766323756', 09:57:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:45 INFO - '_': '/tools/buildbot/bin/python'} 09:57:45 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FfvNzY4WR-agOnZ6r4AxJA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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 09:57:45 INFO - mozversion application_buildid: 20170203075709 09:57:45 INFO - mozversion application_changeset: ff56de0ee8dc01c99e4919b626f8a3c339aca01f 09:57:45 INFO - mozversion application_display_name: Firefox 09:57:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:57:45 INFO - mozversion application_name: Firefox 09:57:45 INFO - mozversion application_remotingname: firefox 09:57:45 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 09:57:45 INFO - mozversion application_vendor: Mozilla 09:57:45 INFO - mozversion application_version: 52.0 09:57:45 INFO - mozversion platform_buildid: 20170203075709 09:57:45 INFO - mozversion platform_changeset: ff56de0ee8dc01c99e4919b626f8a3c339aca01f 09:57:45 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 09:57:45 INFO - mozversion platform_version: 52.0 09:57:45 INFO - using testdate: 1486144665 09:57:45 INFO - actual date: 1486144665 09:57:45 INFO - starting webserver on 'localhost:53558' 09:57:45 INFO - SUITE-START | Running 2 tests 09:57:45 INFO - TEST-START | dromaeo_css 09:57:45 INFO - operating with platform_type : linux_ 09:57:45 INFO - Initialising browser for dromaeo_css test... 09:57:45 INFO - TEST-INFO | started process 3937 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpr9t3QC/profile http://localhost:53558/getInfo.html) 09:57:49 INFO - PROCESS | 3937 | __metrics Screen width/height:1600/1200 09:57:49 INFO - PROCESS | 3937 | colorDepth:24 09:57:49 INFO - PROCESS | 3937 | Browser inner width/height: 1024/697 09:57:49 INFO - PROCESS | 3937 | __metrics 09:57:49 INFO - PROCESS | 3937 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:57:49 INFO - PROCESS | 3937 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:57:50 INFO - PROCESS | 3937 | console.error: PushService: 09:57:50 INFO - PROCESS | 3937 | stateChangeProcessEnqueue: Error transitioning state 09:57:50 INFO - PROCESS | 3937 | UnknownError 09:57:50 INFO - TEST-INFO | 3937: exit 0 09:57:50 INFO - Browser initialized. 09:57:50 INFO - Running cycle 1/1 for dromaeo_css test... 09:57:50 INFO - TEST-INFO | started process 4030 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpr9t3QC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:58:02 INFO - PROCESS | 4030 | RSS: Main: 141938688 09:58:02 INFO - PROCESS | 4030 | 10:01:04 INFO - PROCESS | 4030 | Cycle 1(1): loaded http://localhost:53558/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53558/tests/dromaeo/cssquery-ext.html) 10:01:05 INFO - PROCESS | 4030 | RSS: Main: 245403648 10:01:05 INFO - PROCESS | 4030 | 10:04:07 INFO - PROCESS | 4030 | Cycle 1(1): loaded http://localhost:53558/tests/dromaeo/cssquery-ext.html (next: http://localhost:53558/tests/dromaeo/cssquery-jquery.html) 10:04:08 INFO - PROCESS | 4030 | RSS: Main: 228618240 10:04:08 INFO - PROCESS | 4030 | 10:07:10 INFO - PROCESS | 4030 | Cycle 1(1): loaded http://localhost:53558/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53558/tests/dromaeo/cssquery-mootools.html) 10:07:10 INFO - PROCESS | 4030 | RSS: Main: 221700096 10:07:10 INFO - PROCESS | 4030 | 10:10:12 INFO - PROCESS | 4030 | Cycle 1(1): loaded http://localhost:53558/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53558/tests/dromaeo/cssquery-prototype.html) 10:10:13 INFO - PROCESS | 4030 | RSS: Main: 220401664 10:10:13 INFO - PROCESS | 4030 | 10:13:15 INFO - PROCESS | 4030 | Cycle 1(1): loaded http://localhost:53558/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53558/tests/dromaeo/cssquery-yui.html) 10:13:16 INFO - PROCESS | 4030 | RSS: Main: 176705536 10:13:16 INFO - PROCESS | 4030 | 10:16:18 INFO - PROCESS | 4030 | Cycle 1(1): loaded http://localhost:53558/tests/dromaeo/cssquery-yui.html (next: http://localhost:53558/tests/dromaeo/cssquery-dojo.html) 10:16:19 INFO - PROCESS | 4030 | RSS: Main: 261283840 10:16:19 INFO - PROCESS | 4030 | 10:16:19 INFO - PROCESS | 4030 | __start_tp_report 10:16:19 INFO - PROCESS | 4030 | _x_x_mozilla_page_load 10:16:19 INFO - PROCESS | 4030 | _x_x_mozilla_page_load_details 10:16:19 INFO - PROCESS | 4030 | |i|pagename|runs| 10:16:19 INFO - PROCESS | 4030 | |0;dojo.html;3183.8089714617126;3223.339215460831;3232.85452154653;3247.3018301065267;3262.0376988788307;5577.581681373898;5662.320521537416;5666.433356664332;5682.26130603021;5688.2889638795095;5673.886522269552;5763.164341170528;5769.076947688371;5774.942250577493;5802.825915222539;5151.562117220041;5165.483451654842;5179.249008893708;5206.140986737184;5259.710715910624;5092.108880945838;5100.464451232623;5272.762725677335;5280.049591073605;5298.894022119555;5083.389993200821;5111.642185047048;5125.718085505296;5129.307543481619;5134.358205224347;5171.818986335479;5181.533661970403;5237.3453318335205;5239.79040838366;5265.473452654742;4908.680935739166;5073.162928116856;5139.331886854685;5182.481751824787;5197.558207552363;5407.891842163174;5518.117101263779;5525.143602741581;5534;5537.889242215133;5947.494462970652;5958.106284057383;6064.514838812885;6070.2412198475195;6074.48366888815;5840.036393994986;6097.939020609826;6101.298350689639;6106.8778624427705;6117.908231376533;5499.257600223958;5602.859928501779;5679.261695979579;5684.744186511617;5708.885822283531;6311.179546658905;6314.463270621956;6318.936810631927;6324.873502529924;6328.367163283635;5730.054541000688;6044.184035155197;6045.153678485016;6047.395260473917;6048.0625503047095;5850.23946886902;5989.880202395928;6029.758809647653;6036.275646922398;6126.050462178369;6010.188624535632;6014.51883849291;6014.969925150346;6017.157597936205;6058.818235452944;6014.0678194879865;6040.939590604125;6069.36271691466;6074.392560743979;6095.268567771807;4552.271636538138;4593.517680643551;4637.095766325534;4671.065786842577;4682.765861706969;4183.309753890635;4183.518895327015;4191.958080419156;4197.727147735387;4207.789610519461;5799.449052340021;5801.767929282866;5811.302643682785;5812.070068788974;5813.680247586423;5842.970785146132;5905.852353691106;5992.520598352121;6035.547333949971;6153.476954458832;5787.189793428924;5803.593748437569;5808.303003639506;5818.4763371296785;5839.562032847553;5230.97384513075;5240;5241.0566098101945;5242.5281724644965;5243.108671525773;6050.878982420327;6090.36051214625;6104.053871649901;6293.402126797947;6339.904901426482;5964.701764911824;6038.064100064321;6040.637561746309;6065.484433822998;6075.483583895419;6213.61939832408;6243.8126856194385;6249.093881387083;6255.40573645503;6257.061440783918;5725.198472213977;5751.1373294006235;5904.202932604044;5913.225509008794;5954.940450595439;6065.969670151621;6100.206973093647;6120.632762034292;6171;6184.81445556634;5906.675132867734;5954.19618351517;5956.702164891824;5963.612365196248;5980.19267398913;5622.662640241599;5956.344802071682;5958.225430693982;5960.016597261403;5963.880722385615;5725.141228815544;5800.7099645018425;5822.94177058224;5852.94147058524;5951.345352011362;5890.823275301748;5891.49922256613;5896.498797602252;5897.056470964625;5902.026165682614;5530.889382212414;5575.804846830341;5649.71751412436;5779.711014449176;5779.8555036124435 10:16:19 INFO - PROCESS | 4030 | |1;ext.html;588.3087372337505;597.4592993341026;630.1430055125029;631.2015300644683;647.6923461355854;34793.30413391731;46299.76850115749;46977.76511117444;47155;47187.29219061717;48412.27381589279;48755.75622121884;48974;49097.50902490974;49133.75433122838;8444.324454043692;9004.189622933935;9151.633934642607;9156.359054866161;9157.862632060524;8673.956630216871;10879.83680244797;11101.55593776248;11155.944220278887;11375.658730238065;11075.50160242791;11140.888591114106;11141.610043648474;11151.996320331169;11152.888471115306;10997.890021099807;11038.834417483744;11046.392448415334;11049.834252486218;11051.336919784839;10947.507362168642;11024.944875275572;11028.117750580015;11033.062189713884;11037.282576632493;44560.3315950261;44765;44857.77571112156;44884.326735099;44911;3806.410006449005;3832.263841217723;3922.7646341219333;3941.2314598653275;4487.304467807462;33523.49714754256;33534.32931341384;33667.83166084178;33862.66137338644;33947;4608.8386906458445;4613.861584152481;4627.213373726475;4647.767611619405;4679.836205732783;242234;243064;244111;244242;244979;36367.27265454676;65151.34848651453;65163.674181629736;65208.673956629915;65297.34702653008;38700.22599547993;41048.79475602603;41167.1766564673;41197.58802411998;41199;17245.56886077858;17457.825421745874;17482.562935926704;17493.475195744148;17503.037332946555;13037.869621303855;13311.866881331256;14226;14453.78319325211;14524.491642792664;9615.56729947154;9698.224142068617;9748.610055597697;9774.657886974064;9814.65648702292;3618;3646.580643226063;3680.3191409589313;3707.536557930259;3759.3984962405884;1098;1099.312929419113;1149.7872893514727;1151.7351009267916;1180.9704757380962;33290.833545832116;34095.82952085224;34351.484727729105;34416.13959650978;34817.82591087079;1130.4630300607146;1150.9712257193637;1157.3808012713157;1196.1507329795943;1248.7252804383022;17707.73438398425;17870.28518859257;17904;18074.18666160026;18096.638067238582;513048;513778;515642;516419.50741477817;517896;61754.69122654448;61787;62171;62216.688916555126;62343.6882815583;1345.5021641992525;1389.909655872365;1403.1440821099122;1447.7176950494763;1487.3530014443752;30094.8587078302;34776.82611586926;35162.82418587993;35240.295194096485;35625.287494250486;52708.472915271894;53416;53418;53780.46219537754;54230.45769542412;388502;390388;391061;392181;392464;26697.733022669523;30485;30973.380532389678;31083.22291942629;32511.02466925996;50150.87477641201;50348.748256258485;50444.49555504398;51720;54860.451395485536;42021.78989105035;43013.78493107514;43865.78067109644;44893.55106448894;45636.543634563226;42993.3550996729;43341.3498797512;44077.33883991807;44487.55512444834;44657;43134.56865431306;44279;44378;44670.3299450502;44701.55298446974;37247.81376093102;39788.2042359157;39790.2041959165;40159.19681606293;40186.79906600565;28757.85621071881;29019.41961160807;29256.56115158317;29284.560731588615;29302.70697293085 10:16:19 INFO - PROCESS | 4030 | |2;jquery.html;374.5411870458687;378.98105094745256;412.2949755917383;421.136669826855;425.9765712885791;14440.494582689607;18701;19508.31720889769;20399.898000509995;20440.977951102443;20050.398488045383;20078.297259595918;20738.963051847422;20976.217021553148;20977.37067887966;5544.861378465551;5867.1492633568105;5906.26171728534;5908.793192238272;5915.88168236635;5846.853828654275;5925.377835327293;5927.555433342495;5940.138679891413;5940.673262970535;6121.173641558399;6285.528585356094;6294.307626161119;6295.370462953691;6296.8740625187465;6046.576739628228;6147.631142131487;6210.72051757672;6281.403266689657;6287.3712628736985;6028.96985515074;6050.2437195350585;6050.394960503959;6054.848628784272;6056;19383.612327753508;23485.295441136623;23901.163459278843;24089.7591024091;24285.514289714283;2335.5679199348174;2557.654716613252;2565.294544000396;2570.910018149356;2609.3737502999334;10499.317544359592;10988.780224395467;11149.108071354272;11239.775204495945;11536.538538458452;1899.1008991008991;2002.569447568765;2015.2342109998108;2024.625444292796;2088.04993727855;89474;90015.54992224996;90060.54969725109;90553.54723226342;90663.54668226682;11647.99999999983;11710;11974.760504789856;12141.392930353624;12288.569900053455;14486.492972745904;15416.306266218047;17051.914740426466;17180.570485737706;17191.1404429778;6492.415682588589;6625.3374662534325;8365.414420990472;8481.491110533389;8594.398392112616;8572.61423235956;8611.569421528899;8695.913040869511;8736.12638736134;8869.334799890034;4680.3915490985955;4691.483936766953;4704.858854234379;4717.551832575899;4783.330333753208;1994.5711671990591;2086.582683463283;2098.5697931924224;2122.3845084925506;2166.144372972667;929.5816882402946;1011.2314640872843;1086.125668836594;1126.79717650822;1137.243732917617;20043.799562004486;20074.297399590945;20135.49661258451;20143.798562014486;20177.39467815968;1007.3049595779036;1033.6227277043974;1037.5019990404649;1043.879953805307;1045.8535804987307;9407.43555386679;11084.00243978046;11109.611298587677;11148.331100134017;11259.155563332619;456816;473373;476128;479803;480125;92538;94068.52965735264;94269;96182.51908740411;96333.51833240788;1004.7839714461426;1027.9486025698834;1048.0672201740458;1063.5214153630898;1072.7479042425025;17449.56376090608;17548.21033053541;18035.458936231935;18070.186841591898;18384.540386490444;41719.58280417157;42387.788061059495;42632.36051459169;42819.785901070296;43319;57685.42314576801;58229.12656310074;59262.407375925686;59736.70131649314;59985;9115.316351273548;9150.679726209552;9161.77095572616;9319.347645664739;9476.668316608886;10287.757280830072;13819.447222111003;14000;14146.646333841736;14340.928295358457;12054.819177712518;12092.939535302266;12280.38598070075;12346.444410001752;12410.875891240972;11159.218854680095;11272.041876440595;11421.37182454973;11474.885251147716;11814.704632384259;11739;12329.383530823603;12382.938085309515;12444.813327800272;12541.874581254435;8907.153820387053;9216.95391523038;9257.537123143951;9424.717258482257;9459.10138536838;9643.83018774481;11785.116116291483;12285.877141228473;12316.81524777147;12783.61649150527 10:16:19 INFO - PROCESS | 4030 | |3;mootools.html;1455.16328111336;1556.5875043113576;1563.9374425023;1784.705523588608;1890.4895678166886;7391.445641576883;8324.33405327574;8673.915760529942;8679.826403471927;8899.68851090212;8680.001799793026;8766.342524310687;8766.386352955296;8770.649174033048;8780.297576193905;2485.117783186965;2512.7110382305996;2514.446821699223;2517;2518.992403038781;2387.510560335127;2482.2677310193535;2487.2413913756295;2487.6268559716004;2487.987560062197;2447.5839107351794;2454.7790698837102;2457.8033757299463;2466.9259922202273;2467.8889449974704;2356.858588484688;2371.2412028150998;2389.414593424605;2392.306231192952;2394.988025059872;2382.3805810489225;2413.758624137572;2414.1550457339968;2418.1294733895784;2418.5525677749674;8569.185927336894;8580.528070956096;8725.432846864933;8776.64893404263;8782.912170878273;5205.817796377109;5440.619156659035;5441.211024401479;5442;5442.782288708487;3343.0973637118086;3415.4023045966856;3454.3091381723502;3465.9653403465895;3515.1739341254784;1064.6007747094839;1067.2475904487317;1072.1851392941342;1106.4965440724532;1116.4417791104447;12259.141860069798;12347.876521234763;12356.814647780291;12393.690157746038;12413.751724965541;4335.501417336984;4586.610138138296;4666.4633567139535;4682.1103990241745;4690.085433340466;9839;9843.212542996544;9851.950740246253;9856.655017074512;9857.654982075594;5386.973065134649;5392.703401312887;5394.217838413408;5395.379531353945;5402.081646120169;4426.336049592587;4479.888002799891;4896.436909755353;5046.722430266297;5066.645334826527;3960.584138665456;4017.0961533654695;4055.797210139481;4114.0948991221885;4124.8556300529335;1232.4761976160096;1232.7904256276454;1233.112159245342;1241.5778635264053;1249.9187552809037;1022.1005515146624;1032.390889375272;1041.4116024446164;1047.209356935524;1060.984085238722;6080.361562036011;6106.908396374058;6202.162708034358;6202.937970620326;6293.968530157412;482.382550335571;498.6459613674259;500.8447381311732;501.17056271870115;502.9673071250357;3912;3949.940750888739;3953.1303113315025;3961.8811435656976;3999.9400008999887;10752.19358548112;11035.503402346914;11078.0583650389;11087.390193539433;11163.106951443864;10992.17558683086;11018.889811101786;11028.28316159447;11046.281991670516;11051.944740276247;7917.445778795544;8422.284105851071;8430.40987130895;8484.151584841466;8565.27195188416;6128.4790792783115;6292.842678933063;6299.055141728777;6334.208223972004;6385.904211436739;9898.356606820533;9945.552450139616;10026.398416095057;10082.04220599042;10098;10324.948375258076;10347.793044139225;10366.06705396518;10442.216833737348;10461.843072354073;7080.398166155935;7323.340899318874;7335.303146201102;7994.640241189277;8161.836763264582;8012.639431225725;8365.623546940524;8376.7905802353;8380.497170169809;8384;7449.44129190302;7601.0878694557005;7669.808254793675;7675.309222170032;7702.768916932501;7401.296876796696;7663.386929045774;7707.383409327353;7708.190639982721;7764.4953078052;7084.716611335489;7101.183363913216;7173.210946795744;7189.964050179716;7193.748218812317;5146.974265128651;5148.949983768982;5249.238860365302;5274.472552744848;5349.786008559614;5452.945470545244;5462.399136095106;5491.505764481216;5563.554915606823;5576.972115139399 10:16:19 INFO - PROCESS | 4030 | |4;prototype.html;333.8831409006848;335.50755385389635;347.8486858216675;349.77789103919;351.25008107690076;5419.972900135504;5434.945650543498;5497.340319161696;5507.339119305684;5510.641808282458;5143.691378517292;5255.527002569768;5263.236830659562;5340.25236466895;5410.323709536308;4262.573742625728;4264.445622069126;4272.572742725718;4278.165757677247;4305.138972205571;4239.40648309237;4255.106427650182;4277.721948073366;4288.185244803493;4308.418363520916;4103.199876024177;4244.97877510612;4245.830166793325;4268.871933841974;4274.380214868842;4259;4261.509926358462;4267.487901451815;4270.145970805851;4275.294576394922;3817.064819119306;3819.4079917612535;3821.0130732019193;3832.5209348831395;3841.750286231386;5060.2662613920775;5273.709945952971;5306.479422274428;5308.92036619451;5318.298144593731;4815.879603009917;4827.662063655545;4834.8791280218275;4841.337264504544;4862.44081930579;5657.462541058593;5675.858103547403;5681.886362272731;5696.544276457874;5713.514351280146;4068.4304197412384;4082.5509193988933;4157.729747566429;4169.854055108087;4180.205760905449;5798.057650687025;5850.957502098927;5851.882962340729;5866.618669786493;5900.409959004108;4209.284421648327;4218.878030257649;4232.217039847638;4239.51245606753;4266.994512579145;4115.135821477524;4248.936265956013;4338.891527711832;4344.174606824693;4346.131163599619;4855.368802055781;4864.586510146677;4865.7323847188745;4865.756712164378;4895.265710143436;5653.784436346205;5683.374828768832;5692.800751973661;5711.257536520226;5713.971430142823;1416.2847761880184;1426.7729752412918;1438.503716217903;1438.8201474815648;1441.2001339256813;980.4852452462515;999.6651121874108;1004.4023805835516;1006.8823605797559;1012.1700205831148;5219.321488206509;5312.67183204199;5312.973435132877;5323.733813309319;5326.547243484347;5628.634138780966;5679.801206957736;5691.743871525791;5695.686737229492;5698.800541981011;5140.59405940594;5254.500822421864;5268;5275.920861187085;5402.29942489396;2975.211568934234;2976.2113040044405;2996.4905965985836;3011.8192908425563;3023.8488075596133;5775.624584402;5826.951148793258;5839.5036421904615;5852.853678658068;5867.3839246879315;5442.945570544323;5662.103195429495;5687.829365119053;5697.857553561194;5792.739326730307;5734.426557344233;5760.8271751847515;5767.567432442584;5793.188953546507;5802.274715660543;5361.812336568358;5568.610197286151;5573.916391254215;5579.330480342385;5586.86032849182;5546.972265138648;5555.2778138841695;5570.916436253378;5577.6653400796085;5592.944070559405;5745.253117094751;5812.7674893003805;5822.854428639318;5830.53355731549;5844.211031510692;3990.7206495546193;4129.731567448106;4135.731177473454;4137.379393091061;4147.460830092069;5631.662100273997;5685.289338832646;5768.423157684366;5846.239988801429;5885.705714714161;5683.5737319700365;5685.204071430086;5698.914516282176;5699.888521738221;5706.972744905791;5470.8905821882545;5570.387257401601;5575.8884822304135;5653.1802888580105;5678.432156784454;5558.277423934863;5569.66582005081;5587.413321601173;5605.579581531483;5613.775448981995;5690.37405885344;5704.429557044263;5721.771129154788;5725.828225153252;5745.770169193185;5334.199870019528;5522.779088836563;5598.32820061579;5605.010221371517;5613.46672066153 10:16:19 INFO - PROCESS | 4030 | |5;yui.html;826.0211649195703;837.803116267677;848.9303477618199;871.4161511787102;901.4050726520497;14301.49944751934;15960.201989900488;16031.759523607156;16144;16230.756538651915;14683.63290917725;14935;15430.537083887473;15491;16033.518994430156;858.9656413743443;880.0847118996236;880.1858281089998;880.4409200157913;880.5861245214738;730.9305615966475;747.4767662636149;748.7416841189781;751.3913729878789;871.860502319629;891.1934699097295;913.8355096082703;921.272194965976;921.5898924978387;923.0769230769231;913.9717817455363;915.6017132547297;916.7708072981754;916.8808054952847;916.9037251088673;676.4081428749844;677.0453660338899;679.0968012543306;679.2562144451817;679.5888487465111;13721.45114195441;13891.513797017156;13904.930475347659;13910.86089139116;15121.848781512153;12294.692632684166;14384.71230575393;14468.56594302162;14556.927215363961;14962.47631332909;12208.962238209762;12307;12415.565455209115;12488.375581220993;12650.683732906658;3881.9805900970596;3899.317619416591;3911.3546264866263;3944.664703500206;3991.820368083443;69084.3091569088;70088.2991170092;71446.28553714449;71485.28514714839;71811;11728.354940478355;12003.339816310012;12071.758564828655;12175.208611440228;12410.255384676948;21040.15839366408;21046.78953210448;21052.368428947157;21058.684119738216;21059.789402105784;7432.3310902019075;7523.623818809147;7560.924390756132;7742.6902923883545;7823.687052517836;4858.951410485921;4997.175466048134;5013.348264725562;5025.824096156617;5049.318342023853;3509.701675357572;3613.457981302826;3633.8364773585254;3634.47300141478;3636.7636103653176;598.3298705449924;613.7637009751188;620.3176505843626;622.4522420270224;622.5082185073832;794.6652398363141;803.7749430159565;815.4291995602983;833.8499070167306;834.0616806093145;9302.720918372459;9651.662191823252;9684.176844968257;9739.366941148803;10218.386896786216;703.8873780195145;741.4365082537311;753.4876284126847;765.5865832450414;789.5302295134386;4549.7042692224895;4606.861794146181;4621.260598304255;4639.512851150648;4650.627949764011;90447.54776226077;90700;91196.54401727949;91504;91706;64161.35838641554;67265.32734672689;79348.60325698335;80322;80380.59809700915;64544.67727661425;68837;68842.65578672074;69098;69495.65252173707;9479.526023698649;9927.84361309043;10158.796824063626;10347.327423717434;10460.843087353847;44761.55238447574;46571.53428465672;47594;48035.03929921452;49152.75423622859;41735.16529669329;43260.134797304505;54160.187597185286;60122;63059.36940630718;12245.142840001114;12663.746725065632;12702.936485317514;12721.173123747298;12885.162464439782;14164.150150990974;14418.423263069779;14468.782968255695;14481.565553033426;14945.178015208832;13292.20246785196;13408.396622151831;13612.86387136116;14401.855981440052;14444.277786110863;11809.114316426474;12294.253966367693;12365;12536.247825130522;12852.678683032998;11767.823482647596;12258.570950016707;12877.549285774952;12918.806217906927;13061.673458163621;10261.179105671677;10746.73133171677;11209.55161793519;11243.887561124284;11329.773404532029;11203.215774896005;11290.435478225892;11446;11474.196806223485;11544.19190656646 10:16:19 INFO - PROCESS | 4030 | __end_tp_report 10:16:19 INFO - PROCESS | 4030 | __start_cc_report 10:16:19 INFO - PROCESS | 4030 | _x_x_mozilla_cycle_collect,979 10:16:19 INFO - PROCESS | 4030 | __end_cc_report 10:16:19 INFO - PROCESS | 4030 | __startTimestamp1486145779007__endTimestamp 10:16:19 INFO - PROCESS | 4030 | 10:16:19 INFO - PROCESS | 4030 | ------- Summary: start ------- 10:16:19 INFO - PROCESS | 4030 | Number of tests: 6 10:16:19 INFO - PROCESS | 4030 | 10:16:19 INFO - PROCESS | 4030 | [#0] dojo.html Cycles:165 Average:5618.77 Median:5812.07 stddev:636.06 (10.9%) stddev-sans-first:608.65 10:16:19 INFO - PROCESS | 4030 | Values: 3183.8 3223.3 3232.9 3247.3 3262.0 5577.6 5662.3 5666.4 5682.3 5688.3 5673.9 5763.2 5769.1 5774.9 5802.8 5151.6 5165.5 5179.2 5206.1 5259.7 5092.1 5100.5 5272.8 5280.0 5298.9 5083.4 5111.6 5125.7 5129.3 5134.4 5171.8 5181.5 5237.3 5239.8 5265.5 4908.7 5073.2 5139.3 5182.5 5197.6 5407.9 5518.1 5525.1 5534.0 5537.9 5947.5 5958.1 6064.5 6070.2 6074.5 5840.0 6097.9 6101.3 6106.9 6117.9 5499.3 5602.9 5679.3 5684.7 5708.9 6311.2 6314.5 6318.9 6324.9 6328.4 5730.1 6044.2 6045.2 6047.4 6048.1 5850.2 5989.9 6029.8 6036.3 6126.1 6010.2 6014.5 6015.0 6017.2 6058.8 6014.1 6040.9 6069.4 6074.4 6095.3 4552.3 4593.5 4637.1 4671.1 4682.8 4183.3 4183.5 4192.0 4197.7 4207.8 5799.4 5801.8 5811.3 5812.1 5813.7 5843.0 5905.9 5992.5 6035.5 6153.5 5787.2 5803.6 5808.3 5818.5 5839.6 5231.0 5240.0 5241.1 5242.5 5243.1 6050.9 6090.4 6104.1 6293.4 6339.9 5964.7 6038.1 6040.6 6065.5 6075.5 6213.6 6243.8 6249.1 6255.4 6257.1 5725.2 5751.1 5904.2 5913.2 5954.9 6066.0 6100.2 6120.6 6171.0 6184.8 5906.7 5954.2 5956.7 5963.6 5980.2 5622.7 5956.3 5958.2 5960.0 5963.9 5725.1 5800.7 5822.9 5852.9 5951.3 5890.8 5891.5 5896.5 5897.1 5902.0 5530.9 5575.8 5649.7 5779.7 5779.9 10:16:19 INFO - PROCESS | 4030 | 10:16:19 INFO - PROCESS | 4030 | [#1] ext.html Cycles:180 Average:56022.78 Median:389445.00 stddev:105712.85 (27.1%) stddev-sans-first:105927.47 10:16:19 INFO - PROCESS | 4030 | Values: 588.3 597.5 630.1 631.2 647.7 34793.3 46299.8 46977.8 47155.0 47187.3 48412.3 48755.8 48974.0 49097.5 49133.8 8444.3 9004.2 9151.6 9156.4 9157.9 8674.0 10879.8 11101.6 11155.9 11375.7 11075.5 11140.9 11141.6 11152.0 11152.9 10997.9 11038.8 11046.4 11049.8 11051.3 10947.5 11024.9 11028.1 11033.1 11037.3 44560.3 44765.0 44857.8 44884.3 44911.0 3806.4 3832.3 3922.8 3941.2 4487.3 33523.5 33534.3 33667.8 33862.7 33947.0 4608.8 4613.9 4627.2 4647.8 4679.8 242234.0 243064.0 244111.0 244242.0 244979.0 36367.3 65151.3 65163.7 65208.7 65297.3 38700.2 41048.8 41167.2 41197.6 41199.0 17245.6 17457.8 17482.6 17493.5 17503.0 13037.9 13311.9 14226.0 14453.8 14524.5 9615.6 9698.2 9748.6 9774.7 9814.7 3618.0 3646.6 3680.3 3707.5 3759.4 1098.0 1099.3 1149.8 1151.7 1181.0 33290.8 34095.8 34351.5 34416.1 34817.8 1130.5 1151.0 1157.4 1196.2 1248.7 17707.7 17870.3 17904.0 18074.2 18096.6 513048.0 513778.0 515642.0 516419.5 517896.0 61754.7 61787.0 62171.0 62216.7 62343.7 1345.5 1389.9 1403.1 1447.7 1487.4 30094.9 34776.8 35162.8 35240.3 35625.3 52708.5 53416.0 53418.0 53780.5 54230.5 388502.0 390388.0 391061.0 392181.0 392464.0 26697.7 30485.0 30973.4 31083.2 32511.0 50150.9 50348.7 50444.5 51720.0 54860.5 42021.8 43013.8 43865.8 44893.6 45636.5 42993.4 43341.3 44077.3 44487.6 44657.0 43134.6 44279.0 44378.0 44670.3 44701.6 37247.8 39788.2 39790.2 40159.2 40186.8 28757.9 29019.4 29256.6 29284.6 29302.7 10:16:19 INFO - PROCESS | 4030 | 10:16:19 INFO - PROCESS | 4030 | [#2] jquery.html Cycles:180 Average:29197.53 Median:23995.46 stddev:78338.45 (326.5%) stddev-sans-first:78528.32 10:16:19 INFO - PROCESS | 4030 | Values: 374.5 379.0 412.3 421.1 426.0 14440.5 18701.0 19508.3 20399.9 20441.0 20050.4 20078.3 20739.0 20976.2 20977.4 5544.9 5867.1 5906.3 5908.8 5915.9 5846.9 5925.4 5927.6 5940.1 5940.7 6121.2 6285.5 6294.3 6295.4 6296.9 6046.6 6147.6 6210.7 6281.4 6287.4 6029.0 6050.2 6050.4 6054.8 6056.0 19383.6 23485.3 23901.2 24089.8 24285.5 2335.6 2557.7 2565.3 2570.9 2609.4 10499.3 10988.8 11149.1 11239.8 11536.5 1899.1 2002.6 2015.2 2024.6 2088.0 89474.0 90015.5 90060.5 90553.5 90663.5 11648.0 11710.0 11974.8 12141.4 12288.6 14486.5 15416.3 17051.9 17180.6 17191.1 6492.4 6625.3 8365.4 8481.5 8594.4 8572.6 8611.6 8695.9 8736.1 8869.3 4680.4 4691.5 4704.9 4717.6 4783.3 1994.6 2086.6 2098.6 2122.4 2166.1 929.6 1011.2 1086.1 1126.8 1137.2 20043.8 20074.3 20135.5 20143.8 20177.4 1007.3 1033.6 1037.5 1043.9 1045.9 9407.4 11084.0 11109.6 11148.3 11259.2 456816.0 473373.0 476128.0 479803.0 480125.0 92538.0 94068.5 94269.0 96182.5 96333.5 1004.8 1027.9 1048.1 1063.5 1072.7 17449.6 17548.2 18035.5 18070.2 18384.5 41719.6 42387.8 42632.4 42819.8 43319.0 57685.4 58229.1 59262.4 59736.7 59985.0 9115.3 9150.7 9161.8 9319.3 9476.7 10287.8 13819.4 14000.0 14146.6 14340.9 12054.8 12092.9 12280.4 12346.4 12410.9 11159.2 11272.0 11421.4 11474.9 11814.7 11739.0 12329.4 12382.9 12444.8 12541.9 8907.2 9217.0 9257.5 9424.7 9459.1 9643.8 11785.1 12285.9 12316.8 12783.6 10:16:19 INFO - PROCESS | 4030 | 10:16:19 INFO - PROCESS | 4030 | [#3] mootools.html Cycles:180 Average:5825.27 Median:2689.41 stddev:3278.41 (121.9%) stddev-sans-first:3271.16 10:16:19 INFO - PROCESS | 4030 | Values: 1455.2 1556.6 1563.9 1784.7 1890.5 7391.4 8324.3 8673.9 8679.8 8899.7 8680.0 8766.3 8766.4 8770.6 8780.3 2485.1 2512.7 2514.4 2517.0 2519.0 2387.5 2482.3 2487.2 2487.6 2488.0 2447.6 2454.8 2457.8 2466.9 2467.9 2356.9 2371.2 2389.4 2392.3 2395.0 2382.4 2413.8 2414.2 2418.1 2418.6 8569.2 8580.5 8725.4 8776.6 8782.9 5205.8 5440.6 5441.2 5442.0 5442.8 3343.1 3415.4 3454.3 3466.0 3515.2 1064.6 1067.2 1072.2 1106.5 1116.4 12259.1 12347.9 12356.8 12393.7 12413.8 4335.5 4586.6 4666.5 4682.1 4690.1 9839.0 9843.2 9852.0 9856.7 9857.7 5387.0 5392.7 5394.2 5395.4 5402.1 4426.3 4479.9 4896.4 5046.7 5066.6 3960.6 4017.1 4055.8 4114.1 4124.9 1232.5 1232.8 1233.1 1241.6 1249.9 1022.1 1032.4 1041.4 1047.2 1061.0 6080.4 6106.9 6202.2 6202.9 6294.0 482.4 498.6 500.8 501.2 503.0 3912.0 3949.9 3953.1 3961.9 3999.9 10752.2 11035.5 11078.1 11087.4 11163.1 10992.2 11018.9 11028.3 11046.3 11051.9 7917.4 8422.3 8430.4 8484.2 8565.3 6128.5 6292.8 6299.1 6334.2 6385.9 9898.4 9945.6 10026.4 10082.0 10098.0 10324.9 10347.8 10366.1 10442.2 10461.8 7080.4 7323.3 7335.3 7994.6 8161.8 8012.6 8365.6 8376.8 8380.5 8384.0 7449.4 7601.1 7669.8 7675.3 7702.8 7401.3 7663.4 7707.4 7708.2 7764.5 7084.7 7101.2 7173.2 7190.0 7193.7 5147.0 5148.9 5249.2 5274.5 5349.8 5452.9 5462.4 5491.5 5563.6 5577.0 10:16:19 INFO - PROCESS | 4030 | 10:16:19 INFO - PROCESS | 4030 | [#4] prototype.html Cycles:180 Average:4740.29 Median:5337.23 stddev:1363.59 (25.5%) stddev-sans-first:1326.70 10:16:19 INFO - PROCESS | 4030 | Values: 333.9 335.5 347.8 349.8 351.3 5420.0 5434.9 5497.3 5507.3 5510.6 5143.7 5255.5 5263.2 5340.3 5410.3 4262.6 4264.4 4272.6 4278.2 4305.1 4239.4 4255.1 4277.7 4288.2 4308.4 4103.2 4245.0 4245.8 4268.9 4274.4 4259.0 4261.5 4267.5 4270.1 4275.3 3817.1 3819.4 3821.0 3832.5 3841.8 5060.3 5273.7 5306.5 5308.9 5318.3 4815.9 4827.7 4834.9 4841.3 4862.4 5657.5 5675.9 5681.9 5696.5 5713.5 4068.4 4082.6 4157.7 4169.9 4180.2 5798.1 5851.0 5851.9 5866.6 5900.4 4209.3 4218.9 4232.2 4239.5 4267.0 4115.1 4248.9 4338.9 4344.2 4346.1 4855.4 4864.6 4865.7 4865.8 4895.3 5653.8 5683.4 5692.8 5711.3 5714.0 1416.3 1426.8 1438.5 1438.8 1441.2 980.5 999.7 1004.4 1006.9 1012.2 5219.3 5312.7 5313.0 5323.7 5326.5 5628.6 5679.8 5691.7 5695.7 5698.8 5140.6 5254.5 5268.0 5275.9 5402.3 2975.2 2976.2 2996.5 3011.8 3023.8 5775.6 5827.0 5839.5 5852.9 5867.4 5442.9 5662.1 5687.8 5697.9 5792.7 5734.4 5760.8 5767.6 5793.2 5802.3 5361.8 5568.6 5573.9 5579.3 5586.9 5547.0 5555.3 5570.9 5577.7 5592.9 5745.3 5812.8 5822.9 5830.5 5844.2 3990.7 4129.7 4135.7 4137.4 4147.5 5631.7 5685.3 5768.4 5846.2 5885.7 5683.6 5685.2 5698.9 5699.9 5707.0 5470.9 5570.4 5575.9 5653.2 5678.4 5558.3 5569.7 5587.4 5605.6 5613.8 5690.4 5704.4 5721.8 5725.8 5745.8 5334.2 5522.8 5598.3 5605.0 5613.5 10:16:19 INFO - PROCESS | 4030 | 10:16:19 INFO - PROCESS | 4030 | [#5] yui.html Cycles:180 Average:18024.65 Median:4645.07 stddev:23624.23 (508.6%) stddev-sans-first:23655.20 10:16:19 INFO - PROCESS | 4030 | Values: 826.0 837.8 848.9 871.4 901.4 14301.5 15960.2 16031.8 16144.0 16230.8 14683.6 14935.0 15430.5 15491.0 16033.5 859.0 880.1 880.2 880.4 880.6 730.9 747.5 748.7 751.4 871.9 891.2 913.8 921.3 921.6 923.1 914.0 915.6 916.8 916.9 916.9 676.4 677.0 679.1 679.3 679.6 13721.5 13891.5 13904.9 13910.9 15121.8 12294.7 14384.7 14468.6 14556.9 14962.5 12209.0 12307.0 12415.6 12488.4 12650.7 3882.0 3899.3 3911.4 3944.7 3991.8 69084.3 70088.3 71446.3 71485.3 71811.0 11728.4 12003.3 12071.8 12175.2 12410.3 21040.2 21046.8 21052.4 21058.7 21059.8 7432.3 7523.6 7560.9 7742.7 7823.7 4859.0 4997.2 5013.3 5025.8 5049.3 3509.7 3613.5 3633.8 3634.5 3636.8 598.3 613.8 620.3 622.5 622.5 794.7 803.8 815.4 833.8 834.1 9302.7 9651.7 9684.2 9739.4 10218.4 703.9 741.4 753.5 765.6 789.5 4549.7 4606.9 4621.3 4639.5 4650.6 90447.5 90700.0 91196.5 91504.0 91706.0 64161.4 67265.3 79348.6 80322.0 80380.6 64544.7 68837.0 68842.7 69098.0 69495.7 9479.5 9927.8 10158.8 10347.3 10460.8 44761.6 46571.5 47594.0 48035.0 49152.8 41735.2 43260.1 54160.2 60122.0 63059.4 12245.1 12663.7 12702.9 12721.2 12885.2 14164.2 14418.4 14468.8 14481.6 14945.2 13292.2 13408.4 13612.9 14401.9 14444.3 11809.1 12294.3 12365.0 12536.2 12852.7 11767.8 12258.6 12877.5 12918.8 13061.7 10261.2 10746.7 11209.6 11243.9 11329.8 11203.2 11290.4 11446.0 11474.2 11544.2 10:16:19 INFO - PROCESS | 4030 | -------- Summary: end -------- 10:16:19 INFO - PROCESS | 4030 | 10:16:19 INFO - TEST-INFO | 4030: exit 0 10:16:19 INFO - TEST-OK | dromaeo_css | took 1114259ms 10:16:19 INFO - TEST-START | kraken 10:16:19 INFO - operating with platform_type : linux_ 10:16:19 INFO - Initialising browser for kraken test... 10:16:19 INFO - TEST-INFO | started process 4330 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp48olKd/profile http://localhost:53558/getInfo.html) 10:16:23 INFO - PROCESS | 4330 | __metrics Screen width/height:1600/1200 10:16:23 INFO - PROCESS | 4330 | colorDepth:24 10:16:23 INFO - PROCESS | 4330 | Browser inner width/height: 1024/697 10:16:23 INFO - PROCESS | 4330 | __metrics 10:16:23 INFO - PROCESS | 4330 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:16:23 INFO - PROCESS | 4330 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:16:24 INFO - PROCESS | 4330 | console.error: PushService: 10:16:24 INFO - PROCESS | 4330 | stateChangeProcessEnqueue: Error transitioning state 10:16:24 INFO - PROCESS | 4330 | UnknownError 10:16:24 INFO - TEST-INFO | 4330: exit 0 10:16:24 INFO - Browser initialized. 10:16:24 INFO - Running cycle 1/1 for kraken test... 10:16:24 INFO - TEST-INFO | started process 4421 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp48olKd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:16:36 INFO - PROCESS | 4421 | RSS: Main: 145567744 10:16:36 INFO - PROCESS | 4421 | 10:16:39 INFO - PROCESS | 4421 | Cycle 1(1): loaded http://localhost:53558/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53558/tests/kraken/driver.html?testName=audio-beat-detection) 10:16:40 INFO - PROCESS | 4421 | RSS: Main: 187092992 10:16:40 INFO - PROCESS | 4421 | 10:16:42 INFO - PROCESS | 4421 | Cycle 1(1): loaded http://localhost:53558/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53558/tests/kraken/driver.html?testName=audio-dft) 10:16:43 INFO - PROCESS | 4421 | RSS: Main: 176562176 10:16:43 INFO - PROCESS | 4421 | 10:16:45 INFO - PROCESS | 4421 | Cycle 1(1): loaded http://localhost:53558/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53558/tests/kraken/driver.html?testName=audio-fft) 10:16:46 INFO - PROCESS | 4421 | RSS: Main: 268095488 10:16:46 INFO - PROCESS | 4421 | 10:16:48 INFO - PROCESS | 4421 | Cycle 1(1): loaded http://localhost:53558/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53558/tests/kraken/driver.html?testName=audio-oscillator) 10:16:49 INFO - PROCESS | 4421 | RSS: Main: 174866432 10:16:49 INFO - PROCESS | 4421 | 10:16:51 INFO - PROCESS | 4421 | Cycle 1(1): loaded http://localhost:53558/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53558/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:16:52 INFO - PROCESS | 4421 | RSS: Main: 176889856 10:16:52 INFO - PROCESS | 4421 | 10:16:55 INFO - PROCESS | 4421 | Cycle 1(1): loaded http://localhost:53558/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53558/tests/kraken/driver.html?testName=imaging-darkroom) 10:16:55 INFO - PROCESS | 4421 | RSS: Main: 215154688 10:16:55 INFO - PROCESS | 4421 | 10:16:58 INFO - PROCESS | 4421 | Cycle 1(1): loaded http://localhost:53558/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53558/tests/kraken/driver.html?testName=imaging-desaturate) 10:16:59 INFO - PROCESS | 4421 | RSS: Main: 214011904 10:16:59 INFO - PROCESS | 4421 | 10:17:02 INFO - PROCESS | 4421 | Cycle 1(1): loaded http://localhost:53558/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53558/tests/kraken/driver.html?testName=json-parse-financial) 10:17:02 INFO - PROCESS | 4421 | RSS: Main: 212692992 10:17:02 INFO - PROCESS | 4421 | 10:17:04 INFO - PROCESS | 4421 | Cycle 1(1): loaded http://localhost:53558/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53558/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:17:04 INFO - PROCESS | 4421 | RSS: Main: 174465024 10:17:04 INFO - PROCESS | 4421 | 10:17:06 INFO - PROCESS | 4421 | Cycle 1(1): loaded http://localhost:53558/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53558/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:17:07 INFO - PROCESS | 4421 | RSS: Main: 181600256 10:17:07 INFO - PROCESS | 4421 | 10:17:09 INFO - PROCESS | 4421 | Cycle 1(1): loaded http://localhost:53558/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53558/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:17:09 INFO - PROCESS | 4421 | RSS: Main: 188678144 10:17:09 INFO - PROCESS | 4421 | 10:17:12 INFO - PROCESS | 4421 | Cycle 1(1): loaded http://localhost:53558/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53558/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:17:12 INFO - PROCESS | 4421 | RSS: Main: 197468160 10:17:12 INFO - PROCESS | 4421 | 10:17:15 INFO - PROCESS | 4421 | Cycle 1(1): loaded http://localhost:53558/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53558/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:17:16 INFO - PROCESS | 4421 | RSS: Main: 193630208 10:17:16 INFO - PROCESS | 4421 | 10:17:17 INFO - PROCESS | 4421 | Cycle 1(1): loaded http://localhost:53558/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53558/tests/kraken/driver.html?testName=ai-astar) 10:17:17 INFO - PROCESS | 4421 | RSS: Main: 245465088 10:17:17 INFO - PROCESS | 4421 | 10:17:17 INFO - PROCESS | 4421 | __start_tp_report 10:17:17 INFO - PROCESS | 4421 | _x_x_mozilla_page_load 10:17:17 INFO - PROCESS | 4421 | _x_x_mozilla_page_load_details 10:17:17 INFO - PROCESS | 4421 | |i|pagename|runs| 10:17:17 INFO - PROCESS | 4421 | |0;ai-astar;104;112;113;110;111;112;112;111;112;111 10:17:17 INFO - PROCESS | 4421 | |1;audio-beat-detection;147;116;117;152;122;122;120;115;143;118 10:17:17 INFO - PROCESS | 4421 | |2;audio-dft;160;161;160;161;160;160;161;160;161;160 10:17:17 INFO - PROCESS | 4421 | |3;audio-fft;75;78;76;117;75;75;76;76;110;76 10:17:17 INFO - PROCESS | 4421 | |4;audio-oscillator;82;80;119;82;83;82;106;81;82;104 10:17:17 INFO - PROCESS | 4421 | |5;imaging-gaussian-blur;117;117;125;117;117;116;117;116;117;117 10:17:17 INFO - PROCESS | 4421 | |6;imaging-darkroom;145;146;145;145;147;146;145;147;146;146 10:17:17 INFO - PROCESS | 4421 | |7;imaging-desaturate;84;84;84;85;84;85;86;84;85;84 10:17:17 INFO - PROCESS | 4421 | |8;json-parse-financial;49;51;50;49;49;49;49;49;50;51 10:17:17 INFO - PROCESS | 4421 | |9;json-stringify-tinderbox;58;60;58;58;60;58;59;58;58;59 10:17:17 INFO - PROCESS | 4421 | |10;stanford-crypto-aes;75;73;74;75;82;75;74;74;73;74 10:17:17 INFO - PROCESS | 4421 | |11;stanford-crypto-ccm;126;121;121;122;119;120;121;121;160;120 10:17:17 INFO - PROCESS | 4421 | |12;stanford-crypto-pbkdf2;154;152;151;158;152;154;154;153;152;153 10:17:17 INFO - PROCESS | 4421 | |13;stanford-crypto-sha256-iterative;64;64;62;62;62;62;64;61;62;61 10:17:17 INFO - PROCESS | 4421 | __end_tp_report 10:17:17 INFO - PROCESS | 4421 | __start_cc_report 10:17:17 INFO - PROCESS | 4421 | _x_x_mozilla_cycle_collect,1602 10:17:17 INFO - PROCESS | 4421 | __end_cc_report 10:17:17 INFO - PROCESS | 4421 | __startTimestamp1486145837959__endTimestamp 10:17:17 INFO - PROCESS | 4421 | 10:17:17 INFO - PROCESS | 4421 | ------- Summary: start ------- 10:17:17 INFO - PROCESS | 4421 | Number of tests: 14 10:17:17 INFO - PROCESS | 4421 | 10:17:17 INFO - PROCESS | 4421 | [#0] ai-astar Cycles:10 Average:110.80 Median:112.00 stddev:2.53 (2.3%) stddev-sans-first:0.88 10:17:17 INFO - PROCESS | 4421 | Values: 104.0 112.0 113.0 110.0 111.0 112.0 112.0 111.0 112.0 111.0 10:17:17 INFO - PROCESS | 4421 | 10:17:17 INFO - PROCESS | 4421 | [#1] audio-beat-detection Cycles:10 Average:127.20 Median:122.00 stddev:14.24 (11.7%) stddev-sans-first:13.18 10:17:17 INFO - PROCESS | 4421 | Values: 147.0 116.0 117.0 152.0 122.0 122.0 120.0 115.0 143.0 118.0 10:17:17 INFO - PROCESS | 4421 | 10:17:17 INFO - PROCESS | 4421 | [#2] audio-dft Cycles:10 Average:160.40 Median:160.50 stddev:0.52 (0.3%) stddev-sans-first:0.53 10:17:17 INFO - PROCESS | 4421 | Values: 160.0 161.0 160.0 161.0 160.0 160.0 161.0 160.0 161.0 160.0 10:17:17 INFO - PROCESS | 4421 | 10:17:17 INFO - PROCESS | 4421 | [#3] audio-fft Cycles:10 Average:83.40 Median:76.00 stddev:15.97 (21.0%) stddev-sans-first:16.65 10:17:17 INFO - PROCESS | 4421 | Values: 75.0 78.0 76.0 117.0 75.0 75.0 76.0 76.0 110.0 76.0 10:17:17 INFO - PROCESS | 4421 | 10:17:17 INFO - PROCESS | 4421 | [#4] audio-oscillator Cycles:10 Average:90.10 Median:82.00 stddev:14.06 (17.1%) stddev-sans-first:14.60 10:17:17 INFO - PROCESS | 4421 | Values: 82.0 80.0 119.0 82.0 83.0 82.0 106.0 81.0 82.0 104.0 10:17:17 INFO - PROCESS | 4421 | 10:17:17 INFO - PROCESS | 4421 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:117.00 stddev:2.63 (2.3%) stddev-sans-first:2.78 10:17:17 INFO - PROCESS | 4421 | Values: 117.0 117.0 125.0 117.0 117.0 116.0 117.0 116.0 117.0 117.0 10:17:17 INFO - PROCESS | 4421 | 10:17:17 INFO - PROCESS | 4421 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.79 (0.5%) stddev-sans-first:0.78 10:17:17 INFO - PROCESS | 4421 | Values: 145.0 146.0 145.0 145.0 147.0 146.0 145.0 147.0 146.0 146.0 10:17:17 INFO - PROCESS | 4421 | 10:17:17 INFO - PROCESS | 4421 | [#7] imaging-desaturate Cycles:10 Average:84.50 Median:84.50 stddev:0.71 (0.8%) stddev-sans-first:0.73 10:17:17 INFO - PROCESS | 4421 | Values: 84.0 84.0 84.0 85.0 84.0 85.0 86.0 84.0 85.0 84.0 10:17:17 INFO - PROCESS | 4421 | 10:17:17 INFO - PROCESS | 4421 | [#8] json-parse-financial Cycles:10 Average:49.60 Median:49.50 stddev:0.84 (1.7%) stddev-sans-first:0.87 10:17:17 INFO - PROCESS | 4421 | Values: 49.0 51.0 50.0 49.0 49.0 49.0 49.0 49.0 50.0 51.0 10:17:17 INFO - PROCESS | 4421 | 10:17:17 INFO - PROCESS | 4421 | [#9] json-stringify-tinderbox Cycles:10 Average:58.60 Median:58.50 stddev:0.84 (1.4%) stddev-sans-first:0.87 10:17:17 INFO - PROCESS | 4421 | Values: 58.0 60.0 58.0 58.0 60.0 58.0 59.0 58.0 58.0 59.0 10:17:17 INFO - PROCESS | 4421 | 10:17:17 INFO - PROCESS | 4421 | [#10] stanford-crypto-aes Cycles:10 Average:74.90 Median:74.50 stddev:2.60 (3.5%) stddev-sans-first:2.76 10:17:17 INFO - PROCESS | 4421 | Values: 75.0 73.0 74.0 75.0 82.0 75.0 74.0 74.0 73.0 74.0 10:17:17 INFO - PROCESS | 4421 | 10:17:17 INFO - PROCESS | 4421 | [#11] stanford-crypto-ccm Cycles:10 Average:125.10 Median:121.00 stddev:12.40 (10.3%) stddev-sans-first:13.15 10:17:17 INFO - PROCESS | 4421 | Values: 126.0 121.0 121.0 122.0 119.0 120.0 121.0 121.0 160.0 120.0 10:17:17 INFO - PROCESS | 4421 | 10:17:17 INFO - PROCESS | 4421 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.30 Median:153.50 stddev:1.95 (1.3%) stddev-sans-first:2.05 10:17:17 INFO - PROCESS | 4421 | Values: 154.0 152.0 151.0 158.0 152.0 154.0 154.0 153.0 152.0 153.0 10:17:17 INFO - PROCESS | 4421 | 10:17:17 INFO - PROCESS | 4421 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.40 Median:62.00 stddev:1.17 (1.9%) stddev-sans-first:1.09 10:17:17 INFO - PROCESS | 4421 | Values: 64.0 64.0 62.0 62.0 62.0 62.0 64.0 61.0 62.0 61.0 10:17:17 INFO - PROCESS | 4421 | -------- Summary: end -------- 10:17:17 INFO - PROCESS | 4421 | 10:17:18 INFO - TEST-INFO | 4421: exit 0 10:17:19 INFO - TEST-OK | kraken | took 59328ms 10:17:19 INFO - SUITE-END | took 1173s 10:17:19 INFO - Completed test suite (00:19:33) 10:17:19 INFO - javascript benchmark 10:17:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3183.8089714617126, 3223.339215460831, 3232.85452154653, 3247.3018301065267, 3262.0376988788307, 5577.581681373898, 5662.320521537416, 5666.433356664332, 5682.26130603021, 5688.2889638795095, 5673.886522269552, 5763.164341170528, 5769.076947688371, 5774.942250577493, 5802.825915222539, 5151.562117220041, 5165.483451654842, 5179.249008893708, 5206.140986737184, 5259.710715910624, 5092.108880945838, 5100.464451232623, 5272.762725677335, 5280.049591073605, 5298.894022119555, 5083.389993200821, 5111.642185047048, 5125.718085505296, 5129.307543481619, 5134.358205224347, 5171.818986335479, 5181.533661970403, 5237.3453318335205, 5239.79040838366, 5265.473452654742, 4908.680935739166, 5073.162928116856, 5139.331886854685, 5182.481751824787, 5197.558207552363, 5407.891842163174, 5518.117101263779, 5525.143602741581, 5534.0, 5537.889242215133, 5947.494462970652, 5958.106284057383, 6064.514838812885, 6070.2412198475195, 6074.48366888815, 5840.036393994986, 6097.939020609826, 6101.298350689639, 6106.8778624427705, 6117.908231376533, 5499.257600223958, 5602.859928501779, 5679.261695979579, 5684.744186511617, 5708.885822283531, 6311.179546658905, 6314.463270621956, 6318.936810631927, 6324.873502529924, 6328.367163283635, 5730.054541000688, 6044.184035155197, 6045.153678485016, 6047.395260473917, 6048.0625503047095, 5850.23946886902, 5989.880202395928, 6029.758809647653, 6036.275646922398, 6126.050462178369, 6010.188624535632, 6014.51883849291, 6014.969925150346, 6017.157597936205, 6058.818235452944, 6014.0678194879865, 6040.939590604125, 6069.36271691466, 6074.392560743979, 6095.268567771807, 4552.271636538138, 4593.517680643551, 4637.095766325534, 4671.065786842577, 4682.765861706969, 4183.309753890635, 4183.518895327015, 4191.958080419156, 4197.727147735387, 4207.789610519461, 5799.449052340021, 5801.767929282866, 5811.302643682785, 5812.070068788974, 5813.680247586423, 5842.970785146132, 5905.852353691106, 5992.520598352121, 6035.547333949971, 6153.476954458832, 5787.189793428924, 5803.593748437569, 5808.303003639506, 5818.4763371296785, 5839.562032847553, 5230.97384513075, 5240.0, 5241.0566098101945, 5242.5281724644965, 5243.108671525773, 6050.878982420327, 6090.36051214625, 6104.053871649901, 6293.402126797947, 6339.904901426482, 5964.701764911824, 6038.064100064321, 6040.637561746309, 6065.484433822998, 6075.483583895419, 6213.61939832408, 6243.8126856194385, 6249.093881387083, 6255.40573645503, 6257.061440783918, 5725.198472213977, 5751.1373294006235, 5904.202932604044, 5913.225509008794, 5954.940450595439, 6065.969670151621, 6100.206973093647, 6120.632762034292, 6171.0, 6184.81445556634, 5906.675132867734, 5954.19618351517, 5956.702164891824, 5963.612365196248, 5980.19267398913, 5622.662640241599, 5956.344802071682, 5958.225430693982, 5960.016597261403, 5963.880722385615, 5725.141228815544, 5800.7099645018425, 5822.94177058224, 5852.94147058524, 5951.345352011362, 5890.823275301748, 5891.49922256613, 5896.498797602252, 5897.056470964625, 5902.026165682614, 5530.889382212414, 5575.804846830341, 5649.71751412436, 5779.711014449176, 5779.8555036124435], "value": 5575.843280358252, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [588.3087372337505, 597.4592993341026, 630.1430055125029, 631.2015300644683, 647.6923461355854, 34793.30413391731, 46299.76850115749, 46977.76511117444, 47155.0, 47187.29219061717, 48412.27381589279, 48755.75622121884, 48974.0, 49097.50902490974, 49133.75433122838, 8444.324454043692, 9004.189622933935, 9151.633934642607, 9156.359054866161, 9157.862632060524, 8673.956630216871, 10879.83680244797, 11101.55593776248, 11155.944220278887, 11375.658730238065, 11075.50160242791, 11140.888591114106, 11141.610043648474, 11151.996320331169, 11152.888471115306, 10997.890021099807, 11038.834417483744, 11046.392448415334, 11049.834252486218, 11051.336919784839, 10947.507362168642, 11024.944875275572, 11028.117750580015, 11033.062189713884, 11037.282576632493, 44560.3315950261, 44765.0, 44857.77571112156, 44884.326735099, 44911.0, 3806.410006449005, 3832.263841217723, 3922.7646341219333, 3941.2314598653275, 4487.304467807462, 33523.49714754256, 33534.32931341384, 33667.83166084178, 33862.66137338644, 33947.0, 4608.8386906458445, 4613.861584152481, 4627.213373726475, 4647.767611619405, 4679.836205732783, 242234.0, 243064.0, 244111.0, 244242.0, 244979.0, 36367.27265454676, 65151.34848651453, 65163.674181629736, 65208.673956629915, 65297.34702653008, 38700.22599547993, 41048.79475602603, 41167.1766564673, 41197.58802411998, 41199.0, 17245.56886077858, 17457.825421745874, 17482.562935926704, 17493.475195744148, 17503.037332946555, 13037.869621303855, 13311.866881331256, 14226.0, 14453.78319325211, 14524.491642792664, 9615.56729947154, 9698.224142068617, 9748.610055597697, 9774.657886974064, 9814.65648702292, 3618.0, 3646.580643226063, 3680.3191409589313, 3707.536557930259, 3759.3984962405884, 1098.0, 1099.312929419113, 1149.7872893514727, 1151.7351009267916, 1180.9704757380962, 33290.833545832116, 34095.82952085224, 34351.484727729105, 34416.13959650978, 34817.82591087079, 1130.4630300607146, 1150.9712257193637, 1157.3808012713157, 1196.1507329795943, 1248.7252804383022, 17707.73438398425, 17870.28518859257, 17904.0, 18074.18666160026, 18096.638067238582, 513048.0, 513778.0, 515642.0, 516419.50741477817, 517896.0, 61754.69122654448, 61787.0, 62171.0, 62216.688916555126, 62343.6882815583, 1345.5021641992525, 1389.909655872365, 1403.1440821099122, 1447.7176950494763, 1487.3530014443752, 30094.8587078302, 34776.82611586926, 35162.82418587993, 35240.295194096485, 35625.287494250486, 52708.472915271894, 53416.0, 53418.0, 53780.46219537754, 54230.45769542412, 388502.0, 390388.0, 391061.0, 392181.0, 392464.0, 26697.733022669523, 30485.0, 30973.380532389678, 31083.22291942629, 32511.02466925996, 50150.87477641201, 50348.748256258485, 50444.49555504398, 51720.0, 54860.451395485536, 42021.78989105035, 43013.78493107514, 43865.78067109644, 44893.55106448894, 45636.543634563226, 42993.3550996729, 43341.3498797512, 44077.33883991807, 44487.55512444834, 44657.0, 43134.56865431306, 44279.0, 44378.0, 44670.3299450502, 44701.55298446974, 37247.81376093102, 39788.2042359157, 39790.2041959165, 40159.19681606293, 40186.79906600565, 28757.85621071881, 29019.41961160807, 29256.56115158317, 29284.560731588615, 29302.70697293085], "value": 20218.233799549726, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.5411870458687, 378.98105094745256, 412.2949755917383, 421.136669826855, 425.9765712885791, 14440.494582689607, 18701.0, 19508.31720889769, 20399.898000509995, 20440.977951102443, 20050.398488045383, 20078.297259595918, 20738.963051847422, 20976.217021553148, 20977.37067887966, 5544.861378465551, 5867.1492633568105, 5906.26171728534, 5908.793192238272, 5915.88168236635, 5846.853828654275, 5925.377835327293, 5927.555433342495, 5940.138679891413, 5940.673262970535, 6121.173641558399, 6285.528585356094, 6294.307626161119, 6295.370462953691, 6296.8740625187465, 6046.576739628228, 6147.631142131487, 6210.72051757672, 6281.403266689657, 6287.3712628736985, 6028.96985515074, 6050.2437195350585, 6050.394960503959, 6054.848628784272, 6056.0, 19383.612327753508, 23485.295441136623, 23901.163459278843, 24089.7591024091, 24285.514289714283, 2335.5679199348174, 2557.654716613252, 2565.294544000396, 2570.910018149356, 2609.3737502999334, 10499.317544359592, 10988.780224395467, 11149.108071354272, 11239.775204495945, 11536.538538458452, 1899.1008991008991, 2002.569447568765, 2015.2342109998108, 2024.625444292796, 2088.04993727855, 89474.0, 90015.54992224996, 90060.54969725109, 90553.54723226342, 90663.54668226682, 11647.99999999983, 11710.0, 11974.760504789856, 12141.392930353624, 12288.569900053455, 14486.492972745904, 15416.306266218047, 17051.914740426466, 17180.570485737706, 17191.1404429778, 6492.415682588589, 6625.3374662534325, 8365.414420990472, 8481.491110533389, 8594.398392112616, 8572.61423235956, 8611.569421528899, 8695.913040869511, 8736.12638736134, 8869.334799890034, 4680.3915490985955, 4691.483936766953, 4704.858854234379, 4717.551832575899, 4783.330333753208, 1994.5711671990591, 2086.582683463283, 2098.5697931924224, 2122.3845084925506, 2166.144372972667, 929.5816882402946, 1011.2314640872843, 1086.125668836594, 1126.79717650822, 1137.243732917617, 20043.799562004486, 20074.297399590945, 20135.49661258451, 20143.798562014486, 20177.39467815968, 1007.3049595779036, 1033.6227277043974, 1037.5019990404649, 1043.879953805307, 1045.8535804987307, 9407.43555386679, 11084.00243978046, 11109.611298587677, 11148.331100134017, 11259.155563332619, 456816.0, 473373.0, 476128.0, 479803.0, 480125.0, 92538.0, 94068.52965735264, 94269.0, 96182.51908740411, 96333.51833240788, 1004.7839714461426, 1027.9486025698834, 1048.0672201740458, 1063.5214153630898, 1072.7479042425025, 17449.56376090608, 17548.21033053541, 18035.458936231935, 18070.186841591898, 18384.540386490444, 41719.58280417157, 42387.788061059495, 42632.36051459169, 42819.785901070296, 43319.0, 57685.42314576801, 58229.12656310074, 59262.407375925686, 59736.70131649314, 59985.0, 9115.316351273548, 9150.679726209552, 9161.77095572616, 9319.347645664739, 9476.668316608886, 10287.757280830072, 13819.447222111003, 14000.0, 14146.646333841736, 14340.928295358457, 12054.819177712518, 12092.939535302266, 12280.38598070075, 12346.444410001752, 12410.875891240972, 11159.218854680095, 11272.041876440595, 11421.37182454973, 11474.885251147716, 11814.704632384259, 11739.0, 12329.383530823603, 12382.938085309515, 12444.813327800272, 12541.874581254435, 8907.153820387053, 9216.95391523038, 9257.537123143951, 9424.717258482257, 9459.10138536838, 9643.83018774481, 11785.116116291483, 12285.877141228473, 12316.81524777147, 12783.61649150527], "value": 9584.950480000192, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1455.16328111336, 1556.5875043113576, 1563.9374425023, 1784.705523588608, 1890.4895678166886, 7391.445641576883, 8324.33405327574, 8673.915760529942, 8679.826403471927, 8899.68851090212, 8680.001799793026, 8766.342524310687, 8766.386352955296, 8770.649174033048, 8780.297576193905, 2485.117783186965, 2512.7110382305996, 2514.446821699223, 2517.0, 2518.992403038781, 2387.510560335127, 2482.2677310193535, 2487.2413913756295, 2487.6268559716004, 2487.987560062197, 2447.5839107351794, 2454.7790698837102, 2457.8033757299463, 2466.9259922202273, 2467.8889449974704, 2356.858588484688, 2371.2412028150998, 2389.414593424605, 2392.306231192952, 2394.988025059872, 2382.3805810489225, 2413.758624137572, 2414.1550457339968, 2418.1294733895784, 2418.5525677749674, 8569.185927336894, 8580.528070956096, 8725.432846864933, 8776.64893404263, 8782.912170878273, 5205.817796377109, 5440.619156659035, 5441.211024401479, 5442.0, 5442.782288708487, 3343.0973637118086, 3415.4023045966856, 3454.3091381723502, 3465.9653403465895, 3515.1739341254784, 1064.6007747094839, 1067.2475904487317, 1072.1851392941342, 1106.4965440724532, 1116.4417791104447, 12259.141860069798, 12347.876521234763, 12356.814647780291, 12393.690157746038, 12413.751724965541, 4335.501417336984, 4586.610138138296, 4666.4633567139535, 4682.1103990241745, 4690.085433340466, 9839.0, 9843.212542996544, 9851.950740246253, 9856.655017074512, 9857.654982075594, 5386.973065134649, 5392.703401312887, 5394.217838413408, 5395.379531353945, 5402.081646120169, 4426.336049592587, 4479.888002799891, 4896.436909755353, 5046.722430266297, 5066.645334826527, 3960.584138665456, 4017.0961533654695, 4055.797210139481, 4114.0948991221885, 4124.8556300529335, 1232.4761976160096, 1232.7904256276454, 1233.112159245342, 1241.5778635264053, 1249.9187552809037, 1022.1005515146624, 1032.390889375272, 1041.4116024446164, 1047.209356935524, 1060.984085238722, 6080.361562036011, 6106.908396374058, 6202.162708034358, 6202.937970620326, 6293.968530157412, 482.382550335571, 498.6459613674259, 500.8447381311732, 501.17056271870115, 502.9673071250357, 3912.0, 3949.940750888739, 3953.1303113315025, 3961.8811435656976, 3999.9400008999887, 10752.19358548112, 11035.503402346914, 11078.0583650389, 11087.390193539433, 11163.106951443864, 10992.17558683086, 11018.889811101786, 11028.28316159447, 11046.281991670516, 11051.944740276247, 7917.445778795544, 8422.284105851071, 8430.40987130895, 8484.151584841466, 8565.27195188416, 6128.4790792783115, 6292.842678933063, 6299.055141728777, 6334.208223972004, 6385.904211436739, 9898.356606820533, 9945.552450139616, 10026.398416095057, 10082.04220599042, 10098.0, 10324.948375258076, 10347.793044139225, 10366.06705396518, 10442.216833737348, 10461.843072354073, 7080.398166155935, 7323.340899318874, 7335.303146201102, 7994.640241189277, 8161.836763264582, 8012.639431225725, 8365.623546940524, 8376.7905802353, 8380.497170169809, 8384.0, 7449.44129190302, 7601.0878694557005, 7669.808254793675, 7675.309222170032, 7702.768916932501, 7401.296876796696, 7663.386929045774, 7707.383409327353, 7708.190639982721, 7764.4953078052, 7084.716611335489, 7101.183363913216, 7173.210946795744, 7189.964050179716, 7193.748218812317, 5146.974265128651, 5148.949983768982, 5249.238860365302, 5274.472552744848, 5349.786008559614, 5452.945470545244, 5462.399136095106, 5491.505764481216, 5563.554915606823, 5576.972115139399], "value": 4621.398487933566, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [333.8831409006848, 335.50755385389635, 347.8486858216675, 349.77789103919, 351.25008107690076, 5419.972900135504, 5434.945650543498, 5497.340319161696, 5507.339119305684, 5510.641808282458, 5143.691378517292, 5255.527002569768, 5263.236830659562, 5340.25236466895, 5410.323709536308, 4262.573742625728, 4264.445622069126, 4272.572742725718, 4278.165757677247, 4305.138972205571, 4239.40648309237, 4255.106427650182, 4277.721948073366, 4288.185244803493, 4308.418363520916, 4103.199876024177, 4244.97877510612, 4245.830166793325, 4268.871933841974, 4274.380214868842, 4259.0, 4261.509926358462, 4267.487901451815, 4270.145970805851, 4275.294576394922, 3817.064819119306, 3819.4079917612535, 3821.0130732019193, 3832.5209348831395, 3841.750286231386, 5060.2662613920775, 5273.709945952971, 5306.479422274428, 5308.92036619451, 5318.298144593731, 4815.879603009917, 4827.662063655545, 4834.8791280218275, 4841.337264504544, 4862.44081930579, 5657.462541058593, 5675.858103547403, 5681.886362272731, 5696.544276457874, 5713.514351280146, 4068.4304197412384, 4082.5509193988933, 4157.729747566429, 4169.854055108087, 4180.205760905449, 5798.057650687025, 5850.957502098927, 5851.882962340729, 5866.618669786493, 5900.409959004108, 4209.284421648327, 4218.878030257649, 4232.217039847638, 4239.51245606753, 4266.994512579145, 4115.135821477524, 4248.936265956013, 4338.891527711832, 4344.174606824693, 4346.131163599619, 4855.368802055781, 4864.586510146677, 4865.7323847188745, 4865.756712164378, 4895.265710143436, 5653.784436346205, 5683.374828768832, 5692.800751973661, 5711.257536520226, 5713.971430142823, 1416.2847761880184, 1426.7729752412918, 1438.503716217903, 1438.8201474815648, 1441.2001339256813, 980.4852452462515, 999.6651121874108, 1004.4023805835516, 1006.8823605797559, 1012.1700205831148, 5219.321488206509, 5312.67183204199, 5312.973435132877, 5323.733813309319, 5326.547243484347, 5628.634138780966, 5679.801206957736, 5691.743871525791, 5695.686737229492, 5698.800541981011, 5140.59405940594, 5254.500822421864, 5268.0, 5275.920861187085, 5402.29942489396, 2975.211568934234, 2976.2113040044405, 2996.4905965985836, 3011.8192908425563, 3023.8488075596133, 5775.624584402, 5826.951148793258, 5839.5036421904615, 5852.853678658068, 5867.3839246879315, 5442.945570544323, 5662.103195429495, 5687.829365119053, 5697.857553561194, 5792.739326730307, 5734.426557344233, 5760.8271751847515, 5767.567432442584, 5793.188953546507, 5802.274715660543, 5361.812336568358, 5568.610197286151, 5573.916391254215, 5579.330480342385, 5586.86032849182, 5546.972265138648, 5555.2778138841695, 5570.916436253378, 5577.6653400796085, 5592.944070559405, 5745.253117094751, 5812.7674893003805, 5822.854428639318, 5830.53355731549, 5844.211031510692, 3990.7206495546193, 4129.731567448106, 4135.731177473454, 4137.379393091061, 4147.460830092069, 5631.662100273997, 5685.289338832646, 5768.423157684366, 5846.239988801429, 5885.705714714161, 5683.5737319700365, 5685.204071430086, 5698.914516282176, 5699.888521738221, 5706.972744905791, 5470.8905821882545, 5570.387257401601, 5575.8884822304135, 5653.1802888580105, 5678.432156784454, 5558.277423934863, 5569.66582005081, 5587.413321601173, 5605.579581531483, 5613.775448981995, 5690.37405885344, 5704.429557044263, 5721.771129154788, 5725.828225153252, 5745.770169193185, 5334.199870019528, 5522.779088836563, 5598.32820061579, 5605.010221371517, 5613.46672066153], "value": 4308.004107960756, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [826.0211649195703, 837.803116267677, 848.9303477618199, 871.4161511787102, 901.4050726520497, 14301.49944751934, 15960.201989900488, 16031.759523607156, 16144.0, 16230.756538651915, 14683.63290917725, 14935.0, 15430.537083887473, 15491.0, 16033.518994430156, 858.9656413743443, 880.0847118996236, 880.1858281089998, 880.4409200157913, 880.5861245214738, 730.9305615966475, 747.4767662636149, 748.7416841189781, 751.3913729878789, 871.860502319629, 891.1934699097295, 913.8355096082703, 921.272194965976, 921.5898924978387, 923.0769230769231, 913.9717817455363, 915.6017132547297, 916.7708072981754, 916.8808054952847, 916.9037251088673, 676.4081428749844, 677.0453660338899, 679.0968012543306, 679.2562144451817, 679.5888487465111, 13721.45114195441, 13891.513797017156, 13904.930475347659, 13910.86089139116, 15121.848781512153, 12294.692632684166, 14384.71230575393, 14468.56594302162, 14556.927215363961, 14962.47631332909, 12208.962238209762, 12307.0, 12415.565455209115, 12488.375581220993, 12650.683732906658, 3881.9805900970596, 3899.317619416591, 3911.3546264866263, 3944.664703500206, 3991.820368083443, 69084.3091569088, 70088.2991170092, 71446.28553714449, 71485.28514714839, 71811.0, 11728.354940478355, 12003.339816310012, 12071.758564828655, 12175.208611440228, 12410.255384676948, 21040.15839366408, 21046.78953210448, 21052.368428947157, 21058.684119738216, 21059.789402105784, 7432.3310902019075, 7523.623818809147, 7560.924390756132, 7742.6902923883545, 7823.687052517836, 4858.951410485921, 4997.175466048134, 5013.348264725562, 5025.824096156617, 5049.318342023853, 3509.701675357572, 3613.457981302826, 3633.8364773585254, 3634.47300141478, 3636.7636103653176, 598.3298705449924, 613.7637009751188, 620.3176505843626, 622.4522420270224, 622.5082185073832, 794.6652398363141, 803.7749430159565, 815.4291995602983, 833.8499070167306, 834.0616806093145, 9302.720918372459, 9651.662191823252, 9684.176844968257, 9739.366941148803, 10218.386896786216, 703.8873780195145, 741.4365082537311, 753.4876284126847, 765.5865832450414, 789.5302295134386, 4549.7042692224895, 4606.861794146181, 4621.260598304255, 4639.512851150648, 4650.627949764011, 90447.54776226077, 90700.0, 91196.54401727949, 91504.0, 91706.0, 64161.35838641554, 67265.32734672689, 79348.60325698335, 80322.0, 80380.59809700915, 64544.67727661425, 68837.0, 68842.65578672074, 69098.0, 69495.65252173707, 9479.526023698649, 9927.84361309043, 10158.796824063626, 10347.327423717434, 10460.843087353847, 44761.55238447574, 46571.53428465672, 47594.0, 48035.03929921452, 49152.75423622859, 41735.16529669329, 43260.134797304505, 54160.187597185286, 60122.0, 63059.36940630718, 12245.142840001114, 12663.746725065632, 12702.936485317514, 12721.173123747298, 12885.162464439782, 14164.150150990974, 14418.423263069779, 14468.782968255695, 14481.565553033426, 14945.178015208832, 13292.20246785196, 13408.396622151831, 13612.86387136116, 14401.855981440052, 14444.277786110863, 11809.114316426474, 12294.253966367693, 12365.0, 12536.247825130522, 12852.678683032998, 11767.823482647596, 12258.570950016707, 12877.549285774952, 12918.806217906927, 13061.673458163621, 10261.179105671677, 10746.73133171677, 11209.55161793519, 11243.887561124284, 11329.773404532029, 11203.215774896005, 11290.435478225892, 11446.0, 11474.196806223485, 11544.19190656646], "value": 7386.521089565971, "unit": "score"}], "name": "dromaeo_css", "value": 7359.746988503336, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 112.0, 113.0, 110.0, 111.0, 112.0, 112.0, 111.0, 112.0, 111.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 116.0, 117.0, 152.0, 122.0, 122.0, 120.0, 115.0, 143.0, 118.0], "value": 127.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 160.0, 161.0, 160.0, 160.0, 161.0, 160.0, 161.0, 160.0], "value": 160.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 78.0, 76.0, 117.0, 75.0, 75.0, 76.0, 76.0, 110.0, 76.0], "value": 83.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 80.0, 119.0, 82.0, 83.0, 82.0, 106.0, 81.0, 82.0, 104.0], "value": 90.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 125.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 145.0, 145.0, 147.0, 146.0, 145.0, 147.0, 146.0, 146.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 84.0, 85.0, 84.0, 85.0, 86.0, 84.0, 85.0, 84.0], "value": 84.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 51.0, 50.0, 49.0, 49.0, 49.0, 49.0, 49.0, 50.0, 51.0], "value": 49.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 60.0, 58.0, 58.0, 60.0, 58.0, 59.0, 58.0, 58.0, 59.0], "value": 58.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 73.0, 74.0, 75.0, 82.0, 75.0, 74.0, 74.0, 73.0, 74.0], "value": 74.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 121.0, 121.0, 122.0, 119.0, 120.0, 121.0, 121.0, 160.0, 120.0], "value": 125.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 152.0, 151.0, 158.0, 152.0, 154.0, 154.0, 153.0, 152.0, 153.0], "value": 153.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 62.0, 62.0, 62.0, 62.0, 64.0, 61.0, 62.0, 61.0], "value": 62.4, "unit": "score"}], "name": "kraken", "value": 1443.7, "alertThreshold": 2.0}]} 10:17:19 INFO - Return code: 0 10:17:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:17:19 INFO - # TBPL SUCCESS # 10:17:19 INFO - Running post-action listener: _resource_record_post_action 10:17:19 INFO - [mozharness: 2017-02-03 18:17:19.275522Z] Finished run-tests step (success) 10:17:19 INFO - Running post-run listener: _resource_record_post_run 10:17:19 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 310071296; Read time: 8; Write time: 203952 10:17:19 INFO - TinderboxPrint: CPU usage
13.0% 10:17:19 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 10:17:19 INFO - TinderboxPrint: I/O write bytes / time
310,071,296 / 203,952 10:17:19 INFO - TinderboxPrint: CPU idle
8,245.2 (87.0%) 10:17:19 INFO - TinderboxPrint: CPU user
1,189.1 (12.5%) 10:17:19 INFO - TinderboxPrint: Swap in / out
0 / 0 10:17:19 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 101130240; Read time: 0; Write time: 90664 10:17:19 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 208941056; Read time: 8; Write time: 113288 10:17:19 INFO - Running post-run listener: _upload_blobber_files 10:17:19 INFO - Blob upload gear active. 10:17:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:17:19 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 10:17:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:17:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:17:20 INFO - (blobuploader) - INFO - Open directory for files ... 10:17:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:17:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:17:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:17:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:17:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:17:21 INFO - (blobuploader) - INFO - Done attempting. 10:17:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:17:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:17:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:17:25 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:17:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:17:25 INFO - (blobuploader) - INFO - Done attempting. 10:17:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:17:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:17:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:17:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:17:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:17:26 INFO - (blobuploader) - INFO - Done attempting. 10:17:26 INFO - (blobuploader) - INFO - Iteration through files over. 10:17:26 INFO - Return code: 0 10:17:26 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:17:26 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:17:26 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e31b9c1c81899344f48677c238b4d38f73553e586db033b4cf878f7ae6e09402b44ade7a0ea0b500780f8108cff2e78d085eccf8144290e84dddde425ffe4588", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a56b604b9abf99ea402653303ab99a4bbb5a917996890892600979a2f1fcb3303ee5f3e4465caeedaed2644eded6ab4fcbd0809a9d0954c892b921d65ecea1be", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/96e4d86a48f4832f3d056f26ec1fca66345cd77c571967a21ec4d1c9fc23d1a4ef5de27d6f50d20b9ce93433a186655a20877f5ee2fc197c6b33ed6c6a6e9137"} 10:17:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:17:26 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:17:26 INFO - Contents: 10:17:26 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e31b9c1c81899344f48677c238b4d38f73553e586db033b4cf878f7ae6e09402b44ade7a0ea0b500780f8108cff2e78d085eccf8144290e84dddde425ffe4588", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a56b604b9abf99ea402653303ab99a4bbb5a917996890892600979a2f1fcb3303ee5f3e4465caeedaed2644eded6ab4fcbd0809a9d0954c892b921d65ecea1be", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/96e4d86a48f4832f3d056f26ec1fca66345cd77c571967a21ec4d1c9fc23d1a4ef5de27d6f50d20b9ce93433a186655a20877f5ee2fc197c6b33ed6c6a6e9137"} 10:17:26 INFO - Running post-run listener: copy_logs_to_upload_dir 10:17:26 INFO - Copying logs to upload dir... 10:17:26 INFO - mkdir: /builds/slave/test/build/upload/logs 10:17:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.199830 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2017-02-03 10:17:25.484903) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-03 10:17:25.489074) ========= 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=232498196343f89f466a4a9a000001c8-1486144611.263000-766323756 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e31b9c1c81899344f48677c238b4d38f73553e586db033b4cf878f7ae6e09402b44ade7a0ea0b500780f8108cff2e78d085eccf8144290e84dddde425ffe4588", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a56b604b9abf99ea402653303ab99a4bbb5a917996890892600979a2f1fcb3303ee5f3e4465caeedaed2644eded6ab4fcbd0809a9d0954c892b921d65ecea1be", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/96e4d86a48f4832f3d056f26ec1fca66345cd77c571967a21ec4d1c9fc23d1a4ef5de27d6f50d20b9ce93433a186655a20877f5ee2fc197c6b33ed6c6a6e9137"} build_url:https://queue.taskcluster.net/v1/task/FfvNzY4WR-agOnZ6r4AxJA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011262 build_url: 'https://queue.taskcluster.net/v1/task/FfvNzY4WR-agOnZ6r4AxJA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e31b9c1c81899344f48677c238b4d38f73553e586db033b4cf878f7ae6e09402b44ade7a0ea0b500780f8108cff2e78d085eccf8144290e84dddde425ffe4588", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a56b604b9abf99ea402653303ab99a4bbb5a917996890892600979a2f1fcb3303ee5f3e4465caeedaed2644eded6ab4fcbd0809a9d0954c892b921d65ecea1be", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/96e4d86a48f4832f3d056f26ec1fca66345cd77c571967a21ec4d1c9fc23d1a4ef5de27d6f50d20b9ce93433a186655a20877f5ee2fc197c6b33ed6c6a6e9137"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-03 10:17:25.517051) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-03 10:17:25.517635) ========= 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=232498196343f89f466a4a9a000001c8-1486144611.263000-766323756 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004520 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-03 10:17:25.599729) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-03 10:17:25.600063) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-03 10:17:25.600388) ========= ========= Total master_lag: 0.16 =========