builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-041 starttime: 1475151709.64 results: success (0) buildid: 20160929033005 builduid: 271d871d628044ec9433ed359ca106e7 revision: dc21ccd6a304df32cdec43a71f01bdf80288ee98 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-29 05:21:49.641133) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-29 05:21:49.642269) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-29 05:21:49.643034) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-29 05:21:49.658952) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 05:21:49.659527) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1475151709.170193-1264048112 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-29 05:21:49-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.3M=0s 2016-09-29 05:21:50 (46.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.133327 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 05:21:49.811974) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 05:21:49.812786) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1475151709.170193-1264048112 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015208 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 05:21:49.866182) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 05:21:49.867035) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev dc21ccd6a304df32cdec43a71f01bdf80288ee98 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev dc21ccd6a304df32cdec43a71f01bdf80288ee98 --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=8c6b6742ce8f6f39ef4ce27d000001f1-1475151709.170193-1264048112 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-29 05:21:50,201 truncating revision to first 12 chars 2016-09-29 05:21:50,201 Setting DEBUG logging. 2016-09-29 05:21:50,201 attempt 1/10 2016-09-29 05:21:50,201 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/dc21ccd6a304?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-29 05:21:50,523 unpacking tar archive at: fx-team-dc21ccd6a304/testing/mozharness/ program finished with exit code 0 elapsedTime=0.682775 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 05:21:50.569326) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-29 05:21:50.570152) ========= script_repo_revision: dc21ccd6a304df32cdec43a71f01bdf80288ee98 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-29 05:21:50.571185) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-29 05:21:50.571922) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-29 05:21:50.583861) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-09-29 05:21:50.584175) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c6b6742ce8f6f39ef4ce27d000001f1-1475151709.170193-1264048112 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:21:51 INFO - MultiFileLogger online at 20160929 05:21:51 in /builds/slave/test 05:21:51 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 05:21:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:21:51 INFO - {'append_to_log': False, 05:21:51 INFO - 'base_work_dir': '/builds/slave/test', 05:21:51 INFO - 'blob_upload_branch': 'Fx-Team', 05:21:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:21:51 INFO - 'branch': 'Fx-Team', 05:21:51 INFO - 'buildbot_json_path': 'buildprops.json', 05:21:51 INFO - 'config_files': ('talos/linux_config.py',), 05:21:51 INFO - 'default_actions': ('clobber', 05:21:51 INFO - 'read-buildbot-config', 05:21:51 INFO - 'download-and-extract', 05:21:51 INFO - 'populate-webroot', 05:21:51 INFO - 'create-virtualenv', 05:21:51 INFO - 'install', 05:21:51 INFO - 'run-tests'), 05:21:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:21:51 INFO - 'download_minidump_stackwalk': True, 05:21:51 INFO - 'download_symbols': 'ondemand', 05:21:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:21:51 INFO - 'tooltool.py': '/tools/tooltool.py', 05:21:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:21:51 INFO - '/tools/misc-python/virtualenv.py')}, 05:21:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:21:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:21:51 INFO - 'installer_path': 'installer.exe', 05:21:51 INFO - 'log_level': 'info', 05:21:51 INFO - 'log_name': 'talos', 05:21:51 INFO - 'log_to_console': True, 05:21:51 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:21:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:21:51 INFO - 'opt_config_files': (), 05:21:51 INFO - 'pip_index': False, 05:21:51 INFO - 'sps_profile': False, 05:21:51 INFO - 'sps_profile_interval': 0, 05:21:51 INFO - 'suite': 'dromaeojs', 05:21:51 INFO - 'system_bits': '32', 05:21:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:21:51 INFO - 'title': 'talos-linux64-ix-041', 05:21:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:21:51 INFO - 'use_talos_json': True, 05:21:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:21:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:21:51 INFO - 'work_dir': 'build'} 05:21:51 INFO - [mozharness: 2016-09-29 12:21:51.020810Z] Running clobber step. 05:21:51 INFO - Running pre-action listener: _resource_record_pre_action 05:21:51 INFO - Running main action method: clobber 05:21:51 INFO - rmtree: /builds/slave/test/build 05:21:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:21:52 INFO - Running post-action listener: _resource_record_post_action 05:21:52 INFO - [mozharness: 2016-09-29 12:21:52.002648Z] Finished clobber step (success) 05:21:52 INFO - [mozharness: 2016-09-29 12:21:52.002748Z] Running read-buildbot-config step. 05:21:52 INFO - Running pre-action listener: _resource_record_pre_action 05:21:52 INFO - Running main action method: read_buildbot_config 05:21:52 INFO - Using buildbot properties: 05:21:52 INFO - { 05:21:52 INFO - "project": "", 05:21:52 INFO - "product": "firefox", 05:21:52 INFO - "script_repo_revision": "production", 05:21:52 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 05:21:52 INFO - "repository": "", 05:21:52 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 05:21:52 INFO - "buildid": "20160929033005", 05:21:52 INFO - "pgo_build": "True", 05:21:52 INFO - "basedir": "/builds/slave/test", 05:21:52 INFO - "buildnumber": 1090, 05:21:52 INFO - "slavename": "talos-linux64-ix-041", 05:21:52 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:21:52 INFO - "platform": "ubuntu64_hw", 05:21:52 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 05:21:52 INFO - "branch": "fx-team", 05:21:52 INFO - "repo_path": "integration/fx-team", 05:21:52 INFO - "revision": "dc21ccd6a304df32cdec43a71f01bdf80288ee98", 05:21:52 INFO - "stage_platform": "linux64-pgo", 05:21:52 INFO - "builduid": "271d871d628044ec9433ed359ca106e7", 05:21:52 INFO - "slavebuilddir": "test" 05:21:52 INFO - } 05:21:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/dOINvdzmQSiPXjrLriUKXQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 05:21:52 INFO - Running post-action listener: _resource_record_post_action 05:21:52 INFO - [mozharness: 2016-09-29 12:21:52.005184Z] Finished read-buildbot-config step (success) 05:21:52 INFO - [mozharness: 2016-09-29 12:21:52.005273Z] Running download-and-extract step. 05:21:52 INFO - Running pre-action listener: _resource_record_pre_action 05:21:52 INFO - Running main action method: download_and_extract 05:21:52 INFO - mkdir: /builds/slave/test/build/tests 05:21:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:21:52 INFO - trying https://queue.taskcluster.net/v1/task/dOINvdzmQSiPXjrLriUKXQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 05:21:52 INFO - Downloading https://queue.taskcluster.net/v1/task/dOINvdzmQSiPXjrLriUKXQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 05:21:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dOINvdzmQSiPXjrLriUKXQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:21:52 INFO - Downloaded 1361 bytes. 05:21:52 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 05:21:52 INFO - Using the following test package requirements: 05:21:52 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 05:21:52 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:21:52 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:21:52 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:21:52 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:21:52 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:21:52 INFO - u'jsshell-linux-x86_64.zip'], 05:21:52 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:21:52 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:21:52 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 05:21:52 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:21:52 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:21:52 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:21:52 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:21:52 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:21:52 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:21:52 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:21:52 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:21:52 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:21:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dOINvdzmQSiPXjrLriUKXQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 05:21:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dOINvdzmQSiPXjrLriUKXQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:21:52 INFO - Fetch https://queue.taskcluster.net/v1/task/dOINvdzmQSiPXjrLriUKXQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 05:21:53 INFO - Http code: 200 05:21:53 INFO - Content-Encoding: None 05:21:53 INFO - Content-Type: application/zip 05:21:53 INFO - via: 1.1 96255a5b0caf50bcafcd101c1ff13691.cloudfront.net (CloudFront) 05:21:53 INFO - x-amz-cf-id: cWXwh11vKTL_hdfNu3ZyEz7GgLi3Wiadl3q9-AjmYj1ETo7ya2mUIA== 05:21:53 INFO - x-amz-version-id: 7QhR1RPQbhS007dzbxpiMqUTo_NM1N5R 05:21:53 INFO - x-cache: Hit from cloudfront 05:21:53 INFO - Expected file size: 21988956 05:21:53 INFO - Obtained file size: 21988956 05:21:57 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:21:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dOINvdzmQSiPXjrLriUKXQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 05:21:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dOINvdzmQSiPXjrLriUKXQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:21:57 INFO - Fetch https://queue.taskcluster.net/v1/task/dOINvdzmQSiPXjrLriUKXQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 05:21:58 INFO - Http code: 200 05:21:58 INFO - Content-Encoding: None 05:21:58 INFO - Content-Type: application/zip 05:21:58 INFO - via: 1.1 373880a309382d9266a9313233b86d25.cloudfront.net (CloudFront) 05:21:58 INFO - x-amz-cf-id: IX98sk8S1YCISQbftRNtTd8fmhL4rlfF3tZ_ADXEyiNdtX0dFEScZg== 05:21:58 INFO - x-amz-version-id: 7QhR1RPQbhS007dzbxpiMqUTo_NM1N5R 05:21:58 INFO - x-cache: Hit from cloudfront 05:21:59 INFO - Expected file size: 21988956 05:21:59 INFO - Obtained file size: 21988956 05:22:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dOINvdzmQSiPXjrLriUKXQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 05:22:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dOINvdzmQSiPXjrLriUKXQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:22:03 INFO - Fetch https://queue.taskcluster.net/v1/task/dOINvdzmQSiPXjrLriUKXQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 05:22:04 INFO - Http code: 200 05:22:04 INFO - Content-Encoding: None 05:22:04 INFO - Content-Type: application/zip 05:22:04 INFO - via: 1.1 88972e3933cc06dd11a6fa704a208631.cloudfront.net (CloudFront) 05:22:04 INFO - x-amz-cf-id: Kygw76VyfPXqgQQr_htmcJ0NmmhezqdJ5WGc5Bl5-NdTQJIL-2ISrQ== 05:22:04 INFO - x-amz-version-id: 92X4XRAb.hW7aznKtbpB.x_oAzXiPAv_ 05:22:04 INFO - x-cache: Hit from cloudfront 05:22:04 INFO - Expected file size: 14414067 05:22:04 INFO - Obtained file size: 14414067 05:22:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:22:04 INFO - trying https://queue.taskcluster.net/v1/task/dOINvdzmQSiPXjrLriUKXQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 05:22:04 INFO - Downloading https://queue.taskcluster.net/v1/task/dOINvdzmQSiPXjrLriUKXQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 05:22:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dOINvdzmQSiPXjrLriUKXQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:22:06 INFO - Downloaded 59710862 bytes. 05:22:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dOINvdzmQSiPXjrLriUKXQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 05:22:06 INFO - mkdir: /builds/slave/test/properties 05:22:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:22:06 INFO - Writing to file /builds/slave/test/properties/build_url 05:22:06 INFO - Contents: 05:22:06 INFO - build_url:https://queue.taskcluster.net/v1/task/dOINvdzmQSiPXjrLriUKXQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 05:22:06 INFO - Running post-action listener: _resource_record_post_action 05:22:06 INFO - Running post-action listener: set_extra_try_arguments 05:22:06 INFO - [mozharness: 2016-09-29 12:22:06.830277Z] Finished download-and-extract step (success) 05:22:06 INFO - [mozharness: 2016-09-29 12:22:06.830506Z] Running populate-webroot step. 05:22:06 INFO - Running pre-action listener: _resource_record_pre_action 05:22:06 INFO - Running main action method: populate_webroot 05:22:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:22:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:22:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:22:06 INFO - '--tppagecycles', 05:22:06 INFO - '7'], 05:22:06 INFO - 'tests': ['tsvgm']}}, 05:22:06 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:22:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:22:06 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:22:06 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:22:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:22:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:22:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:22:06 INFO - 'talos_options': ['--disable-e10s'], 05:22:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:22:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:22:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:22:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:22:06 INFO - 'talos_options': ['--disable-e10s'], 05:22:06 INFO - 'tests': ['damp', 'tps']}, 05:22:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:22:06 INFO - 'tests': ['damp', 'tps']}, 05:22:06 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:22:06 INFO - 'tests': ['dromaeo_dom']}, 05:22:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:22:06 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:22:06 INFO - 'tests': ['basic_compositor_video']}, 05:22:06 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:22:06 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:22:06 INFO - 'tests': ['a11yr', 05:22:06 INFO - 'ts_paint', 05:22:06 INFO - 'tpaint', 05:22:06 INFO - 'sessionrestore', 05:22:06 INFO - 'sessionrestore_no_auto_restore', 05:22:06 INFO - 'tabpaint']}, 05:22:06 INFO - 'other-e10s': {'tests': ['a11yr', 05:22:06 INFO - 'ts_paint', 05:22:06 INFO - 'tpaint', 05:22:06 INFO - 'sessionrestore', 05:22:06 INFO - 'sessionrestore_no_auto_restore', 05:22:06 INFO - 'tabpaint']}, 05:22:06 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:22:06 INFO - 'ts_paint', 05:22:06 INFO - 'tpaint', 05:22:06 INFO - 'sessionrestore', 05:22:06 INFO - 'sessionrestore_no_auto_restore', 05:22:06 INFO - 'tabpaint']}, 05:22:06 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:22:06 INFO - 'ts_paint', 05:22:06 INFO - 'tpaint', 05:22:06 INFO - 'sessionrestore', 05:22:06 INFO - 'sessionrestore_no_auto_restore', 05:22:06 INFO - 'tabpaint']}, 05:22:06 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:22:06 INFO - 'tests': ['a11yr', 05:22:06 INFO - 'ts_paint', 05:22:06 INFO - 'tpaint', 05:22:06 INFO - 'sessionrestore', 05:22:06 INFO - 'sessionrestore_no_auto_restore', 05:22:06 INFO - 'tabpaint']}, 05:22:06 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:22:06 INFO - 'tests': ['a11yr', 05:22:06 INFO - 'ts_paint', 05:22:06 INFO - 'tpaint', 05:22:06 INFO - 'sessionrestore', 05:22:06 INFO - 'sessionrestore_no_auto_restore', 05:22:06 INFO - 'tabpaint']}, 05:22:06 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:22:06 INFO - 'tests': ['tsvgx', 05:22:06 INFO - 'tsvgr_opacity', 05:22:06 INFO - 'tart', 05:22:06 INFO - 'tscrollx', 05:22:06 INFO - 'cart']}, 05:22:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:22:06 INFO - 'tsvgr_opacity', 05:22:06 INFO - 'tart', 05:22:06 INFO - 'tscrollx', 05:22:06 INFO - 'cart']}, 05:22:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:22:06 INFO - 'talos_options': ['--disable-e10s'], 05:22:06 INFO - 'tests': ['tp5o']}, 05:22:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:22:06 INFO - 'tests': ['tp5o']}, 05:22:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:22:06 INFO - 'talos_options': ['--disable-e10s', 05:22:06 INFO - '--xperf_path', 05:22:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:22:06 INFO - 'tests': ['tp5n']}, 05:22:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:22:06 INFO - 'talos_options': ['--xperf_path', 05:22:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:22:06 INFO - 'tests': ['tp5n']}}, 05:22:06 INFO - 'talos.zip': {'path': '', 05:22:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:22:06 INFO - Running post-action listener: _resource_record_post_action 05:22:06 INFO - [mozharness: 2016-09-29 12:22:06.845698Z] Finished populate-webroot step (success) 05:22:06 INFO - [mozharness: 2016-09-29 12:22:06.845787Z] Running create-virtualenv step. 05:22:06 INFO - Running pre-action listener: _resource_record_pre_action 05:22:06 INFO - Running main action method: create_virtualenv 05:22:06 INFO - Creating virtualenv /builds/slave/test/build/venv 05:22:06 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:22:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:22:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:22:06 INFO - Using real prefix '/usr' 05:22:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:22:07 INFO - Installing distribute.............................................................................................................................................................................................done. 05:22:09 INFO - Installing pip.................done. 05:22:09 INFO - Return code: 0 05:22:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:22:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:22:09 INFO - Reading from file tmpfile_stdout 05:22:09 INFO - Output received: 05:22:09 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 05:22:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:22:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:22:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:22:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:22:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:22:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99c77bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2666790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2663930>, '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 0x2664830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2664cc0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1475151709.170193-1264048112', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:22:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:22:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:22:09 INFO - Using env: {'DISPLAY': ':0', 05:22:09 INFO - 'HOME': '/home/cltbld', 05:22:09 INFO - 'LANG': 'en_US.UTF-8', 05:22:09 INFO - 'LANGUAGE': 'en_US:en', 05:22:09 INFO - 'LOGNAME': 'cltbld', 05:22:09 INFO - 'MAIL': '/var/mail/cltbld', 05:22:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:22:09 INFO - 'MOZ_NO_REMOTE': '1', 05:22:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:22:09 INFO - 'NO_EM_RESTART': '1', 05:22:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:22:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:22:09 INFO - 'PWD': '/builds/slave/test', 05:22:09 INFO - 'SHELL': '/bin/bash', 05:22:09 INFO - 'SHLVL': '1', 05:22:09 INFO - 'TERM': 'linux', 05:22:09 INFO - 'TMOUT': '86400', 05:22:09 INFO - 'USER': 'cltbld', 05:22:09 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1475151709.170193-1264048112', 05:22:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:22:09 INFO - '_': '/tools/buildbot/bin/python'} 05:22:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:22:09 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:22:09 INFO - Cleaning up... 05:22:09 INFO - Return code: 0 05:22:09 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:22:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:22:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:22:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:22:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:22:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f99c77bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2666790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2663930>, '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 0x2664830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2664cc0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1475151709.170193-1264048112', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:22:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:22:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:22:09 INFO - Using env: {'DISPLAY': ':0', 05:22:09 INFO - 'HOME': '/home/cltbld', 05:22:09 INFO - 'LANG': 'en_US.UTF-8', 05:22:09 INFO - 'LANGUAGE': 'en_US:en', 05:22:09 INFO - 'LOGNAME': 'cltbld', 05:22:09 INFO - 'MAIL': '/var/mail/cltbld', 05:22:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:22:09 INFO - 'MOZ_NO_REMOTE': '1', 05:22:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:22:09 INFO - 'NO_EM_RESTART': '1', 05:22:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:22:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:22:09 INFO - 'PWD': '/builds/slave/test', 05:22:09 INFO - 'SHELL': '/bin/bash', 05:22:09 INFO - 'SHLVL': '1', 05:22:09 INFO - 'TERM': 'linux', 05:22:09 INFO - 'TMOUT': '86400', 05:22:09 INFO - 'USER': 'cltbld', 05:22:09 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1475151709.170193-1264048112', 05:22:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:22:09 INFO - '_': '/tools/buildbot/bin/python'} 05:22:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:22:10 INFO - Downloading/unpacking psutil>=3.1.1 05:22:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:22:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:22:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:22:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:22:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:22:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:22:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:22:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:22:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:22:12 INFO - Installing collected packages: psutil 05:22:12 INFO - Running setup.py install for psutil 05:22:12 INFO - building 'psutil._psutil_linux' extension 05:22:12 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:22:12 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:22:12 INFO - building 'psutil._psutil_posix' extension 05:22:12 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:22:12 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:22:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:22:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:22:12 INFO - Successfully installed psutil 05:22:12 INFO - Cleaning up... 05:22:12 INFO - Return code: 0 05:22:12 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:22:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:22:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:22:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:22:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:22:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:12 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 0x7f99c77bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2666790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2663930>, '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 0x2664830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2664cc0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1475151709.170193-1264048112', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:22:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:22:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:22:12 INFO - Using env: {'DISPLAY': ':0', 05:22:12 INFO - 'HOME': '/home/cltbld', 05:22:12 INFO - 'LANG': 'en_US.UTF-8', 05:22:12 INFO - 'LANGUAGE': 'en_US:en', 05:22:12 INFO - 'LOGNAME': 'cltbld', 05:22:12 INFO - 'MAIL': '/var/mail/cltbld', 05:22:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:22:12 INFO - 'MOZ_NO_REMOTE': '1', 05:22:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:22:12 INFO - 'NO_EM_RESTART': '1', 05:22:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:22:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:22:12 INFO - 'PWD': '/builds/slave/test', 05:22:12 INFO - 'SHELL': '/bin/bash', 05:22:12 INFO - 'SHLVL': '1', 05:22:12 INFO - 'TERM': 'linux', 05:22:12 INFO - 'TMOUT': '86400', 05:22:12 INFO - 'USER': 'cltbld', 05:22:12 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1475151709.170193-1264048112', 05:22:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:22:12 INFO - '_': '/tools/buildbot/bin/python'} 05:22:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:22:12 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:22:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:22:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:22:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:22:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:22:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:22:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:22:14 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:22:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:22:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:22:14 INFO - Installing collected packages: mozsystemmonitor 05:22:14 INFO - Running setup.py install for mozsystemmonitor 05:22:15 INFO - Successfully installed mozsystemmonitor 05:22:15 INFO - Cleaning up... 05:22:15 INFO - Return code: 0 05:22:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:22:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:22:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:22:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:22:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:22:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:15 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 0x7f99c77bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2666790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2663930>, '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 0x2664830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2664cc0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1475151709.170193-1264048112', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:22:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:22:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:22:15 INFO - Using env: {'DISPLAY': ':0', 05:22:15 INFO - 'HOME': '/home/cltbld', 05:22:15 INFO - 'LANG': 'en_US.UTF-8', 05:22:15 INFO - 'LANGUAGE': 'en_US:en', 05:22:15 INFO - 'LOGNAME': 'cltbld', 05:22:15 INFO - 'MAIL': '/var/mail/cltbld', 05:22:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:22:15 INFO - 'MOZ_NO_REMOTE': '1', 05:22:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:22:15 INFO - 'NO_EM_RESTART': '1', 05:22:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:22:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:22:15 INFO - 'PWD': '/builds/slave/test', 05:22:15 INFO - 'SHELL': '/bin/bash', 05:22:15 INFO - 'SHLVL': '1', 05:22:15 INFO - 'TERM': 'linux', 05:22:15 INFO - 'TMOUT': '86400', 05:22:15 INFO - 'USER': 'cltbld', 05:22:15 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1475151709.170193-1264048112', 05:22:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:22:15 INFO - '_': '/tools/buildbot/bin/python'} 05:22:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:22:15 INFO - Downloading/unpacking jsonschema==2.5.1 05:22:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:22:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:22:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:22:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:22:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:22:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:22:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:22:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:22: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 05:22: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 05:22: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 05:22: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 05:22: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 05:22: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 05:22:17 INFO - Downloading functools32-3.2.3-2.tar.gz 05:22:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:22:17 INFO - warning: no files found matching '*.txt' 05:22:17 INFO - no previously-included directories found matching 'build' 05:22:17 INFO - no previously-included directories found matching 'dist' 05:22:17 INFO - no previously-included directories found matching '.git*' 05:22:17 INFO - Installing collected packages: jsonschema, functools32 05:22:17 INFO - Running setup.py install for functools32 05:22:17 INFO - warning: no files found matching '*.txt' 05:22:17 INFO - no previously-included directories found matching 'build' 05:22:17 INFO - no previously-included directories found matching 'dist' 05:22:17 INFO - no previously-included directories found matching '.git*' 05:22:17 INFO - Successfully installed jsonschema functools32 05:22:17 INFO - Cleaning up... 05:22:17 INFO - Return code: 0 05:22:17 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:22:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:22:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:22:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:22:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:22:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f99c77bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2666790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2663930>, '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 0x2664830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2664cc0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1475151709.170193-1264048112', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:22:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:22:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 05:22:17 INFO - Using env: {'DISPLAY': ':0', 05:22:17 INFO - 'HOME': '/home/cltbld', 05:22:17 INFO - 'LANG': 'en_US.UTF-8', 05:22:17 INFO - 'LANGUAGE': 'en_US:en', 05:22:17 INFO - 'LOGNAME': 'cltbld', 05:22:17 INFO - 'MAIL': '/var/mail/cltbld', 05:22:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:22:17 INFO - 'MOZ_NO_REMOTE': '1', 05:22:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:22:17 INFO - 'NO_EM_RESTART': '1', 05:22:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:22:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:22:17 INFO - 'PWD': '/builds/slave/test', 05:22:17 INFO - 'SHELL': '/bin/bash', 05:22:17 INFO - 'SHLVL': '1', 05:22:17 INFO - 'TERM': 'linux', 05:22:17 INFO - 'TMOUT': '86400', 05:22:17 INFO - 'USER': 'cltbld', 05:22:17 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1475151709.170193-1264048112', 05:22:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:22:17 INFO - '_': '/tools/buildbot/bin/python'} 05:22:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:22:17 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:22:17 INFO - Cleaning up... 05:22:17 INFO - Return code: 0 05:22:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:22:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:22:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:22:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:22:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:22:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f99c77bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2666790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2663930>, '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 0x2664830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2664cc0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1475151709.170193-1264048112', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:22:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:22:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:22:17 INFO - Using env: {'DISPLAY': ':0', 05:22:17 INFO - 'HOME': '/home/cltbld', 05:22:17 INFO - 'LANG': 'en_US.UTF-8', 05:22:17 INFO - 'LANGUAGE': 'en_US:en', 05:22:17 INFO - 'LOGNAME': 'cltbld', 05:22:17 INFO - 'MAIL': '/var/mail/cltbld', 05:22:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:22:17 INFO - 'MOZ_NO_REMOTE': '1', 05:22:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:22:17 INFO - 'NO_EM_RESTART': '1', 05:22:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:22:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:22:17 INFO - 'PWD': '/builds/slave/test', 05:22:17 INFO - 'SHELL': '/bin/bash', 05:22:17 INFO - 'SHLVL': '1', 05:22:17 INFO - 'TERM': 'linux', 05:22:17 INFO - 'TMOUT': '86400', 05:22:17 INFO - 'USER': 'cltbld', 05:22:17 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1475151709.170193-1264048112', 05:22:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:22:17 INFO - '_': '/tools/buildbot/bin/python'} 05:22:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:22:18 INFO - Downloading/unpacking blobuploader==1.2.4 05:22:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:22:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:22:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:22:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:22:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:22:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:22:19 INFO - Downloading blobuploader-1.2.4.tar.gz 05:22:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:22:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:22: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 05:22: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 05:22: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 05:22: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 05:22: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 05:22: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 05:22:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:22:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:22: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 05:22: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 05:22: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 05:22: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 05:22: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 05:22: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 05:22:20 INFO - Downloading docopt-0.6.1.tar.gz 05:22:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:22:20 INFO - Installing collected packages: blobuploader, requests, docopt 05:22:20 INFO - Running setup.py install for blobuploader 05:22:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:22:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:22:20 INFO - Running setup.py install for requests 05:22:21 INFO - Running setup.py install for docopt 05:22:21 INFO - Successfully installed blobuploader requests docopt 05:22:21 INFO - Cleaning up... 05:22:21 INFO - Return code: 0 05:22:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:22:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:22:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:22:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:22:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:22:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:21 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 0x7f99c77bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2666790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2663930>, '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 0x2664830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2664cc0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1475151709.170193-1264048112', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:22:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:22:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:22:21 INFO - Using env: {'DISPLAY': ':0', 05:22:21 INFO - 'HOME': '/home/cltbld', 05:22:21 INFO - 'LANG': 'en_US.UTF-8', 05:22:21 INFO - 'LANGUAGE': 'en_US:en', 05:22:21 INFO - 'LOGNAME': 'cltbld', 05:22:21 INFO - 'MAIL': '/var/mail/cltbld', 05:22:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:22:21 INFO - 'MOZ_NO_REMOTE': '1', 05:22:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:22:21 INFO - 'NO_EM_RESTART': '1', 05:22:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:22:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:22:21 INFO - 'PWD': '/builds/slave/test', 05:22:21 INFO - 'SHELL': '/bin/bash', 05:22:21 INFO - 'SHLVL': '1', 05:22:21 INFO - 'TERM': 'linux', 05:22:21 INFO - 'TMOUT': '86400', 05:22:21 INFO - 'USER': 'cltbld', 05:22:21 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1475151709.170193-1264048112', 05:22:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:22:21 INFO - '_': '/tools/buildbot/bin/python'} 05:22:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:22:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:22:21 INFO - Running setup.py (path:/tmp/pip-b2sgQy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:22:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:22:21 INFO - Running setup.py (path:/tmp/pip-zG3Qjl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:22:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:22:21 INFO - Running setup.py (path:/tmp/pip-UThjg5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:22:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:22:21 INFO - Running setup.py (path:/tmp/pip-Yd0pZl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:22:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:22:21 INFO - Running setup.py (path:/tmp/pip-O7kXdW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:22:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:22:21 INFO - Running setup.py (path:/tmp/pip-CVIilT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:22:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:22:22 INFO - Running setup.py (path:/tmp/pip-T8vvTP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:22:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:22:22 INFO - Running setup.py (path:/tmp/pip-GUt1K0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:22:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:22:22 INFO - Running setup.py (path:/tmp/pip-4UA9tm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:22:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:22:22 INFO - Running setup.py (path:/tmp/pip-uzBLvw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:22:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:22:22 INFO - Running setup.py (path:/tmp/pip-ddvGm0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:22:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:22:22 INFO - Running setup.py (path:/tmp/pip-Bzyj3P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:22:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:22:22 INFO - Running setup.py (path:/tmp/pip-nhiliO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:22:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:22:22 INFO - Running setup.py (path:/tmp/pip-RLRTEZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:22:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:22:22 INFO - Running setup.py (path:/tmp/pip-q6X01S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:22:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:22:22 INFO - Running setup.py (path:/tmp/pip-nj2FAf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:22:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:22:22 INFO - Running setup.py (path:/tmp/pip-CHfgu4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:22:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:22:22 INFO - Running setup.py install for manifestparser 05:22:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:22:22 INFO - Running setup.py install for mozcrash 05:22:22 INFO - Running setup.py install for mozdebug 05:22:23 INFO - Running setup.py install for mozdevice 05:22:23 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:22:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:22:23 INFO - Running setup.py install for mozfile 05:22:23 INFO - Running setup.py install for mozhttpd 05:22:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:22:23 INFO - Running setup.py install for mozinfo 05:22:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:22:23 INFO - Running setup.py install for mozInstall 05:22:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:22:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:22:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:22:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:22:23 INFO - Running setup.py install for mozleak 05:22:23 INFO - Running setup.py install for mozlog 05:22:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:22:23 INFO - Running setup.py install for moznetwork 05:22:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:22:23 INFO - Running setup.py install for mozprocess 05:22:24 INFO - Running setup.py install for mozprofile 05:22:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:22:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:22:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:22:24 INFO - Running setup.py install for mozrunner 05:22:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:22:24 INFO - Running setup.py install for mozscreenshot 05:22:24 INFO - Running setup.py install for moztest 05:22:24 INFO - Running setup.py install for mozversion 05:22:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:22:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:22:24 INFO - Cleaning up... 05:22:24 INFO - Return code: 0 05:22:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:22:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:22:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:22:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:22:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:22:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:24 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 0x7f99c77bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2666790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2663930>, '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 0x2664830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2664cc0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1475151709.170193-1264048112', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:22:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:22:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:22:24 INFO - Using env: {'DISPLAY': ':0', 05:22:24 INFO - 'HOME': '/home/cltbld', 05:22:24 INFO - 'LANG': 'en_US.UTF-8', 05:22:24 INFO - 'LANGUAGE': 'en_US:en', 05:22:24 INFO - 'LOGNAME': 'cltbld', 05:22:24 INFO - 'MAIL': '/var/mail/cltbld', 05:22:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:22:24 INFO - 'MOZ_NO_REMOTE': '1', 05:22:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:22:24 INFO - 'NO_EM_RESTART': '1', 05:22:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:22:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:22:24 INFO - 'PWD': '/builds/slave/test', 05:22:24 INFO - 'SHELL': '/bin/bash', 05:22:24 INFO - 'SHLVL': '1', 05:22:24 INFO - 'TERM': 'linux', 05:22:24 INFO - 'TMOUT': '86400', 05:22:24 INFO - 'USER': 'cltbld', 05:22:24 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1475151709.170193-1264048112', 05:22:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:22:24 INFO - '_': '/tools/buildbot/bin/python'} 05:22:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:22:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:22:24 INFO - Running setup.py (path:/tmp/pip-5mHUQQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:22:24 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:22:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:22:24 INFO - Running setup.py (path:/tmp/pip-b_AS8x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:22:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:22:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:22:24 INFO - Running setup.py (path:/tmp/pip-aypoBZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:22:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:22:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:22:25 INFO - Running setup.py (path:/tmp/pip-TRnaTK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:22:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:22:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:22:25 INFO - Running setup.py (path:/tmp/pip-wXBxWN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:22:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:22:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:22:25 INFO - Running setup.py (path:/tmp/pip-KT6Gul-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:22:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:22:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:22:25 INFO - Running setup.py (path:/tmp/pip-2LT9wO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:22:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:22:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:22:25 INFO - Running setup.py (path:/tmp/pip-5FGajF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:22:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:22:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:22:25 INFO - Running setup.py (path:/tmp/pip-GKlgo4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:22:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:22:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:22:25 INFO - Running setup.py (path:/tmp/pip-KQOzTA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:22:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:22:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:22:25 INFO - Running setup.py (path:/tmp/pip-rjb4ZJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:22:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:22:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:22:25 INFO - Running setup.py (path:/tmp/pip-SurPsl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:22:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:22:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:22:25 INFO - Running setup.py (path:/tmp/pip-zYh1lG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:22:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:22:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:22:25 INFO - Running setup.py (path:/tmp/pip-7YUEiS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:22:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:22:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:22:25 INFO - Running setup.py (path:/tmp/pip-gO4rEL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:22:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:22:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:22:25 INFO - Running setup.py (path:/tmp/pip-anfU0T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:22:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:22:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:22:26 INFO - Running setup.py (path:/tmp/pip-OfLt2v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:22:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:22:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:22:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:22:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:22:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:22:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:22:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:22:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:22:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:22:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:22:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:22:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:22:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:22:27 INFO - Downloading blessings-1.6.tar.gz 05:22:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:22:28 INFO - Installing collected packages: blessings 05:22:28 INFO - Running setup.py install for blessings 05:22:28 INFO - Successfully installed blessings 05:22:28 INFO - Cleaning up... 05:22:28 INFO - Return code: 0 05:22:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:22:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:22:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:22:28 INFO - Reading from file tmpfile_stdout 05:22:28 INFO - Current package versions: 05:22:28 INFO - argparse == 1.2.1 05:22:28 INFO - blessings == 1.6 05:22:28 INFO - blobuploader == 1.2.4 05:22:28 INFO - docopt == 0.6.1 05:22:28 INFO - functools32 == 3.2.3-2 05:22:28 INFO - jsonschema == 2.5.1 05:22:28 INFO - manifestparser == 1.1 05:22:28 INFO - mozInstall == 1.12 05:22:28 INFO - mozcrash == 0.17 05:22:28 INFO - mozdebug == 0.1 05:22:28 INFO - mozdevice == 0.48 05:22:28 INFO - mozfile == 1.2 05:22:28 INFO - mozhttpd == 0.7 05:22:28 INFO - mozinfo == 0.9 05:22:28 INFO - mozleak == 0.1 05:22:28 INFO - mozlog == 3.4 05:22:28 INFO - moznetwork == 0.27 05:22:28 INFO - mozprocess == 0.23 05:22:28 INFO - mozprofile == 0.28 05:22:28 INFO - mozrunner == 6.12 05:22:28 INFO - mozscreenshot == 0.1 05:22:28 INFO - mozsystemmonitor == 0.3 05:22:28 INFO - moztest == 0.7 05:22:28 INFO - mozversion == 1.4 05:22:28 INFO - psutil == 3.1.1 05:22:28 INFO - requests == 1.2.3 05:22:28 INFO - wsgiref == 0.1.2 05:22:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:22:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:22:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:22:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:22:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:22:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:28 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 0x7f99c77bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2666790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2663930>, '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 0x2664830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2664cc0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1475151709.170193-1264048112', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:22:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:22:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:22:28 INFO - Using env: {'DISPLAY': ':0', 05:22:28 INFO - 'HOME': '/home/cltbld', 05:22:28 INFO - 'LANG': 'en_US.UTF-8', 05:22:28 INFO - 'LANGUAGE': 'en_US:en', 05:22:28 INFO - 'LOGNAME': 'cltbld', 05:22:28 INFO - 'MAIL': '/var/mail/cltbld', 05:22:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:22:28 INFO - 'MOZ_NO_REMOTE': '1', 05:22:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:22:28 INFO - 'NO_EM_RESTART': '1', 05:22:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:22:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:22:28 INFO - 'PWD': '/builds/slave/test', 05:22:28 INFO - 'SHELL': '/bin/bash', 05:22:28 INFO - 'SHLVL': '1', 05:22:28 INFO - 'TERM': 'linux', 05:22:28 INFO - 'TMOUT': '86400', 05:22:28 INFO - 'USER': 'cltbld', 05:22:28 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1475151709.170193-1264048112', 05:22:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:22:28 INFO - '_': '/tools/buildbot/bin/python'} 05:22:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:22:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:22:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:22:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:22:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:22:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:22:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:22:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:22:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:22:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:22:28 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:22:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:22:28 INFO - Cleaning up... 05:22:28 INFO - Return code: 0 05:22:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:22:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:22:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:22:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:22:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:22:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99c77bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2666790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2663930>, '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 0x2664830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2664cc0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1475151709.170193-1264048112', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:22:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:22:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:22:28 INFO - Using env: {'DISPLAY': ':0', 05:22:28 INFO - 'HOME': '/home/cltbld', 05:22:28 INFO - 'LANG': 'en_US.UTF-8', 05:22:28 INFO - 'LANGUAGE': 'en_US:en', 05:22:28 INFO - 'LOGNAME': 'cltbld', 05:22:28 INFO - 'MAIL': '/var/mail/cltbld', 05:22:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:22:28 INFO - 'MOZ_NO_REMOTE': '1', 05:22:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:22:28 INFO - 'NO_EM_RESTART': '1', 05:22:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:22:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:22:28 INFO - 'PWD': '/builds/slave/test', 05:22:28 INFO - 'SHELL': '/bin/bash', 05:22:28 INFO - 'SHLVL': '1', 05:22:28 INFO - 'TERM': 'linux', 05:22:28 INFO - 'TMOUT': '86400', 05:22:28 INFO - 'USER': 'cltbld', 05:22:28 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1475151709.170193-1264048112', 05:22:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:22:28 INFO - '_': '/tools/buildbot/bin/python'} 05:22:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:22:28 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:22:28 INFO - Cleaning up... 05:22:28 INFO - Return code: 0 05:22:28 INFO - Running post-action listener: _resource_record_post_action 05:22:28 INFO - Running post-action listener: _start_resource_monitoring 05:22:28 INFO - Starting resource monitoring. 05:22:28 INFO - [mozharness: 2016-09-29 12:22:28.960217Z] Finished create-virtualenv step (success) 05:22:28 INFO - [mozharness: 2016-09-29 12:22:28.960740Z] Running install step. 05:22:28 INFO - Running pre-action listener: _resource_record_pre_action 05:22:28 INFO - Running main action method: install 05:22:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:22:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:22:29 INFO - Reading from file tmpfile_stdout 05:22:29 INFO - Detecting whether we're running mozinstall >=1.0... 05:22:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:22:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:22:29 INFO - Reading from file tmpfile_stdout 05:22:29 INFO - Output received: 05:22:29 INFO - Usage: mozinstall [options] installer 05:22:29 INFO - Options: 05:22:29 INFO - -h, --help show this help message and exit 05:22:29 INFO - -d DEST, --destination=DEST 05:22:29 INFO - Directory to install application into. [default: 05:22:29 INFO - "/builds/slave/test"] 05:22:29 INFO - --app=APP Application being installed. [default: firefox] 05:22:29 INFO - mkdir: /builds/slave/test/build/application 05:22:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:22:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:22:46 INFO - Reading from file tmpfile_stdout 05:22:46 INFO - Output received: 05:22:46 INFO - /builds/slave/test/build/application/firefox/firefox 05:22:46 INFO - Running post-action listener: _resource_record_post_action 05:22:46 INFO - [mozharness: 2016-09-29 12:22:46.250763Z] Finished install step (success) 05:22:46 INFO - [mozharness: 2016-09-29 12:22:46.251010Z] Running run-tests step. 05:22:46 INFO - Running pre-action listener: _resource_record_pre_action 05:22:46 INFO - Running main action method: run_tests 05:22:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:22:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:22:46 INFO - Python 2.7.3 05:22:46 INFO - Return code: 0 05:22:46 INFO - grabbing minidump binary from tooltool 05:22:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:22:46 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 0x2663930>, '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 0x2664830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2664cc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:22:46 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:22:46 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:22:46 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 05:22:46 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:22:46 INFO - Return code: 0 05:22:46 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:22:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:22:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:22:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:22:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:22:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dOINvdzmQSiPXjrLriUKXQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 05:22:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dOINvdzmQSiPXjrLriUKXQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-041 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 05:22:46 INFO - Using env: {'DISPLAY': ':0', 05:22:46 INFO - 'HOME': '/home/cltbld', 05:22:46 INFO - 'LANG': 'en_US.UTF-8', 05:22:46 INFO - 'LANGUAGE': 'en_US:en', 05:22:46 INFO - 'LOGNAME': 'cltbld', 05:22:46 INFO - 'MAIL': '/var/mail/cltbld', 05:22:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:22:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:22:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:22:46 INFO - 'MOZ_NO_REMOTE': '1', 05:22:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:22:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:22:46 INFO - 'NO_EM_RESTART': '1', 05:22:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:22:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:22:46 INFO - 'PWD': '/builds/slave/test', 05:22:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:22:46 INFO - 'SHELL': '/bin/bash', 05:22:46 INFO - 'SHLVL': '1', 05:22:46 INFO - 'TERM': 'linux', 05:22:46 INFO - 'TMOUT': '86400', 05:22:46 INFO - 'USER': 'cltbld', 05:22:46 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1475151709.170193-1264048112', 05:22:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:22:46 INFO - '_': '/tools/buildbot/bin/python'} 05:22:46 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dOINvdzmQSiPXjrLriUKXQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:22:46 INFO - mozversion application_buildid: 20160929033005 05:22:46 INFO - mozversion application_changeset: dc21ccd6a304df32cdec43a71f01bdf80288ee98 05:22:46 INFO - mozversion application_display_name: Nightly 05:22:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:22:46 INFO - mozversion application_name: Firefox 05:22:46 INFO - mozversion application_remotingname: firefox 05:22:46 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:22:46 INFO - mozversion application_vendor: Mozilla 05:22:46 INFO - mozversion application_version: 52.0a1 05:22:46 INFO - mozversion platform_buildid: 20160929033005 05:22:46 INFO - mozversion platform_changeset: dc21ccd6a304df32cdec43a71f01bdf80288ee98 05:22:46 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:22:46 INFO - mozversion platform_version: 52.0a1 05:22:46 INFO - using testdate: 1475151766 05:22:46 INFO - actual date: 1475151766 05:22:46 INFO - starting webserver on 'localhost:34149' 05:22:46 INFO - SUITE-START | Running 2 tests 05:22:46 INFO - TEST-START | dromaeo_css 05:22:46 INFO - operating with platform_type : linux_ 05:22:46 INFO - Initialising browser for dromaeo_css test... 05:22:46 INFO - TEST-INFO | started process 22532 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpd4dVbC/profile http://localhost:34149/getInfo.html) 05:22:50 INFO - PROCESS | 22532 | __metrics Screen width/height:1600/1200 05:22:50 INFO - PROCESS | 22532 | colorDepth:24 05:22:50 INFO - PROCESS | 22532 | Browser inner width/height: 1024/697 05:22:50 INFO - PROCESS | 22532 | __metrics 05:22:51 INFO - PROCESS | 22532 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:22:51 INFO - PROCESS | 22532 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:22:52 INFO - PROCESS | 22532 | console.error: PushService: 05:22:52 INFO - PROCESS | 22532 | stateChangeProcessEnqueue: Error transitioning state 05:22:52 INFO - PROCESS | 22532 | UnknownError 05:22:52 INFO - TEST-INFO | 22532: exit 0 05:22:52 INFO - Browser initialized. 05:22:52 INFO - Running cycle 1/1 for dromaeo_css test... 05:22:52 INFO - TEST-INFO | started process 22614 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpd4dVbC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:23:04 INFO - PROCESS | 22614 | RSS: Main: 173592576 05:23:04 INFO - PROCESS | 22614 | 05:23:56 INFO - PROCESS | 22614 | 1475151836090 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:26:05 INFO - PROCESS | 22614 | Cycle 1(1): loaded http://localhost:34149/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34149/tests/dromaeo/cssquery-ext.html) 05:26:07 INFO - PROCESS | 22614 | RSS: Main: 292560896 05:26:07 INFO - PROCESS | 22614 | 05:29:09 INFO - PROCESS | 22614 | Cycle 1(1): loaded http://localhost:34149/tests/dromaeo/cssquery-ext.html (next: http://localhost:34149/tests/dromaeo/cssquery-jquery.html) 05:29:10 INFO - PROCESS | 22614 | RSS: Main: 272011264 05:29:10 INFO - PROCESS | 22614 | 05:32:12 INFO - PROCESS | 22614 | Cycle 1(1): loaded http://localhost:34149/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34149/tests/dromaeo/cssquery-mootools.html) 05:32:12 INFO - PROCESS | 22614 | RSS: Main: 215822336 05:32:12 INFO - PROCESS | 22614 | 05:35:14 INFO - PROCESS | 22614 | Cycle 1(1): loaded http://localhost:34149/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34149/tests/dromaeo/cssquery-prototype.html) 05:35:15 INFO - PROCESS | 22614 | RSS: Main: 216596480 05:35:15 INFO - PROCESS | 22614 | 05:38:18 INFO - PROCESS | 22614 | Cycle 1(1): loaded http://localhost:34149/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34149/tests/dromaeo/cssquery-yui.html) 05:38:18 INFO - PROCESS | 22614 | RSS: Main: 215592960 05:38:18 INFO - PROCESS | 22614 | 05:41:21 INFO - PROCESS | 22614 | Cycle 1(1): loaded http://localhost:34149/tests/dromaeo/cssquery-yui.html (next: http://localhost:34149/tests/dromaeo/cssquery-dojo.html) 05:41:21 INFO - PROCESS | 22614 | RSS: Main: 310484992 05:41:21 INFO - PROCESS | 22614 | 05:41:21 INFO - PROCESS | 22614 | __start_tp_report 05:41:21 INFO - PROCESS | 22614 | _x_x_mozilla_page_load 05:41:21 INFO - PROCESS | 22614 | _x_x_mozilla_page_load_details 05:41:21 INFO - PROCESS | 22614 | |i|pagename|runs| 05:41:21 INFO - PROCESS | 22614 | |0;dojo.html;3059.9235019124517;3084.6761090085524;3089.505679091345;3122.0477754284934;3137.2941088255147;5172.146595811687;5267.631265811395;5281.287026251455;5334.279872217249;5403.432639572848;5281.234221037957;5292.576593872491;5328;5411.080116380215;5448.809291674792;4842.249451335048;4856.635752318591;4874.731889746063;4876.853694389156;5013.473585273548;4913.877153071184;4921.753912304388;4922.187839006559;4928.975355123237;4934.730024188877;4800.519948005206;4839.612830973549;4850.199717046683;4950.851474455754;4975.203967365241;4873.439554451213;4878.487758785312;4891.755412229374;4893.437254715682;4896.779644915988;4809.374781278447;4858.125537403266;4873.853784386474;4874.390701162355;4876.317315575822;5174;5190.299309593194;5229.555487783543;5385.865353366158;5408.702521361323;5637.689927054011;5637.943620563783;5640.802571910004;5646.604737668365;5650.74571644277;5458.590605704588;5521.806736764194;5650.406707295757;5654.830355089312;5680.687562184078;5283.86790330241;5329.173978033411;5330.973345133289;5338.97330513345;5342.305500285016;5811.680357580289;5823.505002074787;5827.59206855516;5828.795992140254;5838.678872662044;5568.053430916754;5604.635698679573;5611.2144299798065;5612.747426365741;5635.718214089279;5554.472325129106;5617.606767526234;5625.46558076982;5658;5686.289213848269;5642.689652069175;5651.745671444794;5656.038473459522;5656.604037717402;5657.717114144276;5574.498295153456;5689.630174038757;5698.800541981011;5701.800436984769;5702.429757024347;4354.825806967686;4355.3684715716045;4373.868783936487;4394.978025109918;4398.934015989763;3880.708946828999;3881.3789793633446;3914.256291304643;3919.862804801818;3938.6061393860386;5345.679259244458;5383.892322153535;5384.138537833927;5413.2150838128255;5484.396716361197;5538.861528461821;5543.722813859291;5613.691246981373;5635.267415235993;5672.8865422691315;5346.331708536433;5353.946460535345;5372.946270537323;5407.513323800877;5432.103702889058;4931.309616653672;4940.283658869444;4941.184704523714;4944.554990050912;4997.5002499749735;5788.044972579477;5853.09277062056;5891.941080589139;5898.439648233411;5904.881902361929;5739.71301434935;5750.769969201185;5767.048437008015;5818.214541036906;5821.330546987151;5954.910676339771;5987.880242395215;5994.820155395345;6004.729787159501;6008.819735407945;5460.426655201147;5541.362743284412;5548.583856210719;5658.405867383865;5666.405027472056;5573.414791446839;5596.608237423341;5622.746976385991;5638.323401191883;5688.232088668143;5477.616566840283;5486.1222204447095;5491.478309560585;5500.862478438071;5501.284832971848;5438.428964958623;5477.096279113902;5484.177373394023;5487.341519017744;5544.611877168721;5353;5400.675959442446;5450.482204190595;5465.754041068241;5545.140503222007;5536.52939500147;5540.889182216414;5566.192902029264;5572.804951826666;5587.692676902647;5381.327334083239;5424.864378390414;5432.158015507603;5457.154141108134;5458.181272809111 05:41:21 INFO - PROCESS | 22614 | |1;ext.html;577.445652173913;615.1541630258395;624.1667374055636;637.14622405976;638.4030931079438;30894.227644308903;31556.842215788918;33946.98159055229;42082.579174208324;43300;43536;44239.55760442395;44242.33636495455;44252;47630.28554571675;8840.602172902234;8982.416142950688;8985;8987.415817971843;8990.190882820545;8137.552434616094;8303.211194936472;10443.895561044406;10655.413952232624;10699.251052426333;10882.836757448644;10972.506237219344;10991.560337586527;10991.835122473129;11000.339979601209;10795.78408431831;10827.783444331148;10832.566697332097;10845.620403285926;10865.239433239636;10525.36847789135;10582.894171058268;10589.629362972337;10599.62901298451;10601.628942986958;41041.79479102585;41164.58835411638;41444;41522;41524;3208.2139875730595;3302.884399046022;3317.834108294576;3596.7482276240676;3698.593154752975;30988.53517197244;31071.37857242865;31549;31965.360692786246;32772.34455310904;4251.108768719783;4341.5441378655105;4464.374987501752;4480.820767169309;4646.303054541846;325661;326171;326497.3675131633;326571;327262;54269;55134.72432637811;55162.448375515734;55167.72416137894;55233;57528;57566;57684;57711.42288577145;57949.42050579524;14485.565433037025;14757.262136893112;14835.516448355294;14944.626384340478;14955.401783928739;10643.201759868041;10648.680539583826;10748.731281717863;10753.301035432673;10754.247202695737;14560.126392416489;15069.246537673072;15069.397224111131;15254.313555890012;15282.847171528143;5486.979413836295;5752.309722833287;5802.692465294742;5826.388229235954;5894;934.7663084228943;1053.5575058475306;1062.2723434447428;1087.977301336741;1112.8275117356823;30963.225919352197;31466;31595.684043159734;32142.83928580342;32295;1029.7734498410339;1056.1234175634359;1071.405370019631;1088.733260351219;1104.4146602300793;16376.181190940406;16634.75047874283;17409.390671326444;17477.300907963538;18036.54908627295;493871;497857;499179;499213;503360;55540.444595554334;55864.72067639717;55869.16196257059;56032.439675603535;56129.43870561242;1261.501706825817;1309.7838856588555;1309.9345032748324;1318.643966129159;1328.1234385305652;29827;31187.84406077955;31678.36643267168;31834.224866270244;31976.52035219427;46736.29895551501;46985.76507117443;47079.52920470889;47082;47117.764411177726;429044;429843;430436;430783;434526;26548.336291592866;26693.866530667223;26773.330666733487;26880.027194968992;26937.86531067332;43306.13387732165;43563.56436435722;44524;45071.32393014042;45495.545044550454;37013.444798328586;37376.252474949804;37659;37789.4331585032;39152.41271380874;37518.24963500769;37566;37758.43362349622;37868;37909.81045094757;30714.539281911235;33610;38908.41637375498;38969.80515097406;39107;28215.858920705265;33710.83144584261;34213.144671383416;34448;34645.826770865984;26930;27052.72947270502;27077.593836092867;27102.186934392;27249.773760181237 05:41:21 INFO - PROCESS | 22614 | |2;jquery.html;372.1199363505311;379.510431543309;400.98596549120776;401.85332353690904;418.10597991100326;13376.365789197587;15208.391664333427;16250.268737906808;19210.90394548025;19726.210951561956;18574.535636609093;18626.068696565184;18778.43664690058;19344.226230950746;19379.806201937976;5517.586181036419;5715.628249220199;5718.7426565804435;5727.083666613343;5732.0542110551705;5559.305086864142;5709.31488221414;5727.169560413738;5798.275215598051;5823.3012038555435;5686.232358631594;5758.136279558058;5782;5848.970755146218;5875.970620146914;5863.208466856962;5900.350961394264;5975.073863551178;6000.879982400371;6052.152698622196;5617.859553511154;5818.883622327529;5831.533477321804;5865.677387743673;5920.763169473216;13408.061435699505;13543.754091560968;13666.11170273929;13692.452301907912;22045.448863778372;2181.7495705021943;2275.205241435619;2390.09176512924;2466.3834041489627;2663.4806212788512;9860.457674827881;9973.501324933797;10021.09810117093;10510.316829406063;10534.473276336152;1798.7481752554652;1898.2346417831411;1899.078946710844;1922.5578117033021;1932.849954277217;82254.17745822525;82928;83010.58494707488;83981.16018839795;84054.57972710159;8901.955490222508;9340.346175767767;9462.57418416173;9510.38182518134;10887.455627218607;13243.66890827737;13277.468901244036;13298.800517992238;13317.866821331856;13346;7282.563046217244;7384.446166537531;7400;7546.320831125225;7666.9616651917495;7296.416286697052;7336;7360.447966402541;7407.333339999426;7495.587742674096;3985.342418500915;4015.738976966488;4045.5058347702643;4089.3865920111625;4206.47419072616;1920.1455352368341;1937.1282922684566;1991.0940522062426;1993.182795054021;2017.939461816148;954.465499320369;981.6122631560494;988.6984469736656;991.375433476905;1014.1430491234895;19829.30597429083;19920.601587968158;20000;20010.499737506678;20217;909.9181073703398;936.2165075531124;946.0633972367444;973.532704301939;990.9792913299314;10465.68602941913;11056.447177641086;11085.113190944867;11257.380844053492;11265.436728163722;440572;441415;442760;443283;460954;89658.65512017325;91219;91366;93632.53183734037;93695;941.4116177389132;957.7222605444343;964.9179819715403;969.7575606098476;983.4050399508337;16568.254428550503;17400.82599174043;18040.09799509993;18286;18446.26214951387;41352.613571089874;42610.36084458797;42806.35790463208;42980.35529467123;43516.12967740564;56323.43676563182;58212.05197558255;59409.10886336795;60033.399666002784;60513.69743151256;6884.552504087218;7438.44211684115;7569;7629.694812207449;7841.960790196013;10242.385456872313;11849;12062.215955962834;12127.75744485123;12529.373531323216;10589.629362972259;10652.946735266583;10820.02619764225;10936.234463587472;10939.562417503528;10497;10588.735281618021;10648.414337211218;10719.142468602337;10811.6215932442;10671;10697.679069627924;10915.23593348458;11026.50380732885;11097;7406.555606663617;7506.812329691801;7514.624268786648;7566.092068951761;7610.353119984863;10111.89888101139;10805.783884322112;10936.398498082364;11041.447927603427;11267 05:41:21 INFO - PROCESS | 22614 | |3;mootools.html;1328.7674656935035;1479.1568805780703;1509.4565956255747;1654.4209526665668;1818.1091265280018;7629.580373079479;8741.650333986641;8991.23574496167;8996.235319997808;9221.95389023054;8903.37676362655;8905.4211476254;8914.73255802327;8916.15296546827;8916.91083089169;2382.6783384243167;2420.4553975355493;2421.007386971342;2423.4062654649633;2429.149797570845;2321.280403075052;2360.7757263060066;2384.511175209078;2393.44950661348;2400.7239167495786;2335.5562443135836;2342.941426464335;2371.4782747795457;2396.712394512661;2397.3407312988893;2302.435903203726;2324.9070037198494;2326.9185578504757;2327.5577640248384;2366.2428023032635;2319.1419174905395;2336.229044415356;2336.3925379401308;2342.8711420871846;2348.9295321140394;8680.69789531569;8695.652173913037;8778.780530486725;8797.7800554986;8829.867551986725;5243.580513558906;5332.2801421808335;5350.705711185883;5365.302510673627;5367.0339338918975;3414.334204830059;3466.9133271668156;3504.8072356020407;3564.0198945289994;3571.714262858965;1104.3484344236938;1109.3343993603853;2103.694964230178;2136.9679454808193;2174.358564223542;12585.685357866036;12632.30522321272;12635.178713383693;12641.051921105862;12643.49426022958;4494.685372023927;4580.26715725489;4737.8341758039;4763.928541071887;4765.046990601893;9826.115649591571;9847.261455390875;9850.261230407748;9863.950680246553;9949.154321882575;5160.92258616121;5183.974080129575;5185.9740701297005;5190.429052804188;5203.375594928632;4289.592488713567;4411.2721400968485;4615.838445654453;4694.577488026026;4815.133276010281;3757.511523501982;3803.391457366808;3862.729608927348;3876.612338766101;3954.4661470701085;1137.8862113788555;1141.9942900285446;1145.6963904565298;1159.2754528419737;1166.4925757295603;832.3258160889699;884.8628462588181;901.5672477210844;918.2699753695695;923.6259314977444;5845.386234445322;5902.763889444374;5974.2233509643465;5976.103584462366;5999.190109335271;469.1414711078718;481.3814248690416;485.0759303526787;487.4272729542773;488.6237597050322;3766.9434958475645;3988.920221595552;4037.6164264394833;4047.3321901886447;4080.0615858352153;10943.671689849318;10992.450377481095;11217;11357;11377.488013039267;11000.284981476178;11137.777244455065;11153.553857845758;11163.49764260594;11187.888121118847;8256.711015114442;8297.543635100006;8303.875441868377;8377;8388.370872184732;5774.56690748204;5785.27684039495;5847.970760146172;5975.193348897843;5981.641101533922;10082.29423940317;10102.24233182529;10149.695509134737;10170.644027459004;10349.793004140025;9969.750756231153;10293.279470437297;10700;10730.409827459565;10732.087772539422;6702.491939313615;6878.105846239957;6888.931110689029;7545.962270188614;7610.505317154367;8351.20663536963;8383.496990180609;8533.232009119209;8758.080401557745;8789.165029322205;7529.849403012018;7707.383409327128;7798.33714134305;7801.804954876174;7921.405894557816;7547.207543207884;7571.924280757342;7593.924060759543;7699;7699.3840492761565;7006.334398232159;7048.718051277891;7103.9289607103265;7107.147142342952;7110.537815042006;5101.69389836611;5164.406093299319;5185.377754669464;5233.450487698737;5420.159875219348;4966.726830024383;4978.576820970114;5067.342577406748;5106.948930510647;5207.635465517377 05:41:21 INFO - PROCESS | 22614 | |4;prototype.html;320.3145269124074;322.30543179448284;327.9996012162903;334.1162624857251;335.2523871765962;5240.873212259364;5281.551068159206;5286.550643195324;5288.545649946267;5300.204969254613;5191.351081114861;5223.973880130604;5248.816291429801;5263.34208223972;5268.262443257947;3924.4113382992564;4041.4139949707273;4074.5721699221453;4128.422020917074;4141.4409054777525;4116.732412393199;4122.917541649165;4133.462649855514;4143.606357396043;4145.854895078673;4084.97957510212;4086.5300490443683;4097.549269580344;4131.5248746394245;4144.357624568197;3900.835036554711;3906.902327441808;3985.5815139410233;4100.5489396166395;4126.66986641071;3642.344378011957;3644.5626524816926;3647.4528820676846;3655.214128962259;3661.8901432957055;5184.222366645034;5190.117679994372;5191.402988656315;5196.402413722432;5204.1673332266655;4431.581893793988;4636.744979026153;4665.183592871268;4702.576768090888;4763.214069678499;5409.6213265071465;5421.9457805421835;5425.511703946664;5428.782848686087;5464.426235245322;3942.329803933338;3945.4415505875304;3951.920961580752;3966.464527288808;3971.0469487323126;5537.1140617501005;5665.461781130827;5691.373948865621;5727.394035713782;5746.712664366765;4004.879853604338;4010.438538604598;4015.9196816063513;4020.155767288902;4029.274730548471;4037.1320166164414;4068.6948478864206;4070.063885306396;4085.4076158956786;4101.85643502476;4481.655503348982;4683.461401938821;4688.460827004938;4703.341532185496;4708.458527269339;5495.835124946258;5513.050517972865;5513.807016754395;5551.611387202938;5593.552515798727;1391.3321605629355;1407.7677183264852;1410.7249086428048;1411.484808045056;1412.4773833681604;837.4682076881103;905.1265528764774;910.349100393222;915.7939463620633;918.800964741006;5117.5394214520875;5185.599888030286;5275.4724527547705;5332.466753324714;5343.519083282523;5623.971880140573;5643.181738647873;5645.915311270334;5650.434956504317;5656.377798442168;5161.200013997836;5348.893022139613;5349.866253343697;5368.624196306221;5368.758405871745;2969.7624190064744;2998.7900846940506;3005.6844031376827;3013.608230930009;3014.1711029466633;5895.528357731371;5898.675572843535;5903.645781253139;5918.774268023937;5939.22790037301;5645.661260324394;5714.971425142848;5753.539716822645;5753.971230143822;5755.194272801811;5774.3070831499645;5801.476357784377;5802.47777700009;5821.679807610622;5838.591298609056;5344.839654810362;5579.944200557942;5584.553235741212;5589.524890384363;5657.519110875622;5511.862203444946;5557.5553955682635;5577.358603760457;5594.804181853616;5619.241402410786;5846.210761547137;5892.558058145571;5894.145348924296;5947.613405128653;5950.285965684146;3858.7877666727477;3970.788909382666;3974.2647610192207;3974.3243648579232;3977.622125898035;5635.380108188014;5655.066913959151;5663.858403539944;5665.546756259571;5681.409205422488;5541.251930989265;5547.421912866259;5559.665680236633;5562.694051827189;5564.33228012641;5313.973430132824;5427.375851777097;5431.212474191299;5448.373437054631;5451.4276001019325;5319.281896944018;5347.251384806208;5379.139337706105;5389.703566303734;5413;5268.076217699214;5293.7353132344;5413.945860541502;5454.509094181542;5521.874078479895;5380.973095134499;5396.298481197419;5400.891982160413;5404.135338346003;5451.882364115426 05:41:21 INFO - PROCESS | 22614 | |5;yui.html;691.9377256046955;700.5761514283859;705.5272967112031;717.3257138290004;755.9244075592442;15511.224438778072;16865.83134168658;16890.74663880043;16905.492835214933;16911.915440422796;12093.274403535794;12758.744825103493;15163.317650705718;15299.541013769576;15309;770.5415277909635;779.95710235937;785.7996210966196;785.8153333966513;788.8895554622358;761.0714927788117;766.0998326965821;766.3409467857638;766.7776344859984;772.1005029141044;823.0206054794775;823.5717426937989;828.3952714518375;829.3779665251062;832.629479881453;817.5912043978011;821.4291067707945;822.5722624235364;822.6339279020868;822.7161629237934;601.227422761749;606.305779882037;608.0969759906535;614.023702313324;614.9108379285024;14574.562763117017;14576.489822856149;14668;14971;14995.100293982396;13166.27585482798;13166.73666526664;13208.339583020907;13252.734945301136;13361;11670;11696;11962.521499140024;11990;12141.332226727527;3675.7059435245383;3684.7604905681046;3735.869244576427;3819.770813751156;3835.0412396900774;74864.25135748627;75366.62316688382;75460;75590.62204688997;83362.58318708428;10466;10575.629852955264;10594.31136976094;10641.787164256826;10751;22978.310650680505;23009.53980920372;23010.309690709306;23014.19450319231;23034.65448018281;8457.323414126855;8579.485230886166;8780.253678437277;8958.148975847414;8962.148595883511;4588.839390621312;4677.111348843709;4805;4955.4301255356095;4960.082384758831;3217.4530329843983;3515.648435156515;3642.0348607619003;3643.4534819777246;3649.7810131392202;566.9603127781098;571.1005166862209;582.484501216418;603.0351437699645;606.3784620763664;607.8510764862637;660.3297652882328;660.7984564707714;718.5904034700275;728.3008312020414;9296.581653825595;9503.904960950302;9684.370515916444;9816.852747208797;10045.748856278506;620.488097319713;696.4950410952019;700.6006576251488;711.1182134153715;711.210556282526;4362.869113926524;4590.8163673453355;4747.928781068286;4861.723089719123;4885.60915126789;72940.63529682424;77605.6119719409;127737.86490283409;128412;130492.3475382617;73983.26016739871;79464;107361;110730;112088.43955780331;60633.69683151644;61103.6944815282;88462.61523386731;92887;92896;8898.510581918057;8965.327600429864;8965.327600430124;9047.954760226157;9185.173334399937;52418.73790631023;52580.21129682981;53337.73331133319;54111;57804.71097644485;63154.36845631485;65224;65790.67104664446;75841;83763;12796.168249063781;13025.348732563523;13033.674158146123;13040.673983150118;13407.731845363232;14966;14970.550883473514;15079.54761357161;15153.54539363821;15192.924035379752;13104.344782760632;13228.470861165446;13848.307584620527;13936;14023.158610483404;13873.483319630428;13898.37457314403;14384.496542620958;14600.634984125058;14850.925745371203;13576.253306068262;13705.314734263446;13983.161010339412;14291.356888939814;14592.124472531683;11326.546938122383;11369.54521819118;11431.59989400367;11633.941830291133;11850.170488065753;10008.749781255236;11304.717382065186;11438.856114388494;11764.176507644383;12024.639260822189 05:41:21 INFO - PROCESS | 22614 | __end_tp_report 05:41:21 INFO - PROCESS | 22614 | __start_cc_report 05:41:21 INFO - PROCESS | 22614 | _x_x_mozilla_cycle_collect,980 05:41:21 INFO - PROCESS | 22614 | __end_cc_report 05:41:21 INFO - PROCESS | 22614 | __startTimestamp1475152881963__endTimestamp 05:41:21 INFO - PROCESS | 22614 | 05:41:21 INFO - PROCESS | 22614 | ------- Summary: start ------- 05:41:21 INFO - PROCESS | 22614 | Number of tests: 6 05:41:21 INFO - PROCESS | 22614 | 05:41:21 INFO - PROCESS | 22614 | [#0] dojo.html Cycles:165 Average:5281.27 Median:5458.18 stddev:581.97 (10.7%) stddev-sans-first:557.05 05:41:21 INFO - PROCESS | 22614 | Values: 3059.9 3084.7 3089.5 3122.0 3137.3 5172.1 5267.6 5281.3 5334.3 5403.4 5281.2 5292.6 5328.0 5411.1 5448.8 4842.2 4856.6 4874.7 4876.9 5013.5 4913.9 4921.8 4922.2 4929.0 4934.7 4800.5 4839.6 4850.2 4950.9 4975.2 4873.4 4878.5 4891.8 4893.4 4896.8 4809.4 4858.1 4873.9 4874.4 4876.3 5174.0 5190.3 5229.6 5385.9 5408.7 5637.7 5637.9 5640.8 5646.6 5650.7 5458.6 5521.8 5650.4 5654.8 5680.7 5283.9 5329.2 5331.0 5339.0 5342.3 5811.7 5823.5 5827.6 5828.8 5838.7 5568.1 5604.6 5611.2 5612.7 5635.7 5554.5 5617.6 5625.5 5658.0 5686.3 5642.7 5651.7 5656.0 5656.6 5657.7 5574.5 5689.6 5698.8 5701.8 5702.4 4354.8 4355.4 4373.9 4395.0 4398.9 3880.7 3881.4 3914.3 3919.9 3938.6 5345.7 5383.9 5384.1 5413.2 5484.4 5538.9 5543.7 5613.7 5635.3 5672.9 5346.3 5353.9 5372.9 5407.5 5432.1 4931.3 4940.3 4941.2 4944.6 4997.5 5788.0 5853.1 5891.9 5898.4 5904.9 5739.7 5750.8 5767.0 5818.2 5821.3 5954.9 5987.9 5994.8 6004.7 6008.8 5460.4 5541.4 5548.6 5658.4 5666.4 5573.4 5596.6 5622.7 5638.3 5688.2 5477.6 5486.1 5491.5 5500.9 5501.3 5438.4 5477.1 5484.2 5487.3 5544.6 5353.0 5400.7 5450.5 5465.8 5545.1 5536.5 5540.9 5566.2 5572.8 5587.7 5381.3 5424.9 5432.2 5457.2 5458.2 05:41:21 INFO - PROCESS | 22614 | 05:41:21 INFO - PROCESS | 22614 | [#1] ext.html Cycles:180 Average:57172.71 Median:33828.91 stddev:112510.65 (332.6%) stddev-sans-first:112746.03 05:41:21 INFO - PROCESS | 22614 | Values: 577.4 615.2 624.2 637.1 638.4 30894.2 31556.8 33947.0 42082.6 43300.0 43536.0 44239.6 44242.3 44252.0 47630.3 8840.6 8982.4 8985.0 8987.4 8990.2 8137.6 8303.2 10443.9 10655.4 10699.3 10882.8 10972.5 10991.6 10991.8 11000.3 10795.8 10827.8 10832.6 10845.6 10865.2 10525.4 10582.9 10589.6 10599.6 10601.6 41041.8 41164.6 41444.0 41522.0 41524.0 3208.2 3302.9 3317.8 3596.7 3698.6 30988.5 31071.4 31549.0 31965.4 32772.3 4251.1 4341.5 4464.4 4480.8 4646.3 325661.0 326171.0 326497.4 326571.0 327262.0 54269.0 55134.7 55162.4 55167.7 55233.0 57528.0 57566.0 57684.0 57711.4 57949.4 14485.6 14757.3 14835.5 14944.6 14955.4 10643.2 10648.7 10748.7 10753.3 10754.2 14560.1 15069.2 15069.4 15254.3 15282.8 5487.0 5752.3 5802.7 5826.4 5894.0 934.8 1053.6 1062.3 1088.0 1112.8 30963.2 31466.0 31595.7 32142.8 32295.0 1029.8 1056.1 1071.4 1088.7 1104.4 16376.2 16634.8 17409.4 17477.3 18036.5 493871.0 497857.0 499179.0 499213.0 503360.0 55540.4 55864.7 55869.2 56032.4 56129.4 1261.5 1309.8 1309.9 1318.6 1328.1 29827.0 31187.8 31678.4 31834.2 31976.5 46736.3 46985.8 47079.5 47082.0 47117.8 429044.0 429843.0 430436.0 430783.0 434526.0 26548.3 26693.9 26773.3 26880.0 26937.9 43306.1 43563.6 44524.0 45071.3 45495.5 37013.4 37376.3 37659.0 37789.4 39152.4 37518.2 37566.0 37758.4 37868.0 37909.8 30714.5 33610.0 38908.4 38969.8 39107.0 28215.9 33710.8 34213.1 34448.0 34645.8 26930.0 27052.7 27077.6 27102.2 27249.8 05:41:21 INFO - PROCESS | 22614 | 05:41:21 INFO - PROCESS | 22614 | [#2] jquery.html Cycles:180 Average:27296.49 Median:23408.42 stddev:73948.90 (315.9%) stddev-sans-first:74128.72 05:41:21 INFO - PROCESS | 22614 | Values: 372.1 379.5 401.0 401.9 418.1 13376.4 15208.4 16250.3 19210.9 19726.2 18574.5 18626.1 18778.4 19344.2 19379.8 5517.6 5715.6 5718.7 5727.1 5732.1 5559.3 5709.3 5727.2 5798.3 5823.3 5686.2 5758.1 5782.0 5849.0 5876.0 5863.2 5900.4 5975.1 6000.9 6052.2 5617.9 5818.9 5831.5 5865.7 5920.8 13408.1 13543.8 13666.1 13692.5 22045.4 2181.7 2275.2 2390.1 2466.4 2663.5 9860.5 9973.5 10021.1 10510.3 10534.5 1798.7 1898.2 1899.1 1922.6 1932.8 82254.2 82928.0 83010.6 83981.2 84054.6 8902.0 9340.3 9462.6 9510.4 10887.5 13243.7 13277.5 13298.8 13317.9 13346.0 7282.6 7384.4 7400.0 7546.3 7667.0 7296.4 7336.0 7360.4 7407.3 7495.6 3985.3 4015.7 4045.5 4089.4 4206.5 1920.1 1937.1 1991.1 1993.2 2017.9 954.5 981.6 988.7 991.4 1014.1 19829.3 19920.6 20000.0 20010.5 20217.0 909.9 936.2 946.1 973.5 991.0 10465.7 11056.4 11085.1 11257.4 11265.4 440572.0 441415.0 442760.0 443283.0 460954.0 89658.7 91219.0 91366.0 93632.5 93695.0 941.4 957.7 964.9 969.8 983.4 16568.3 17400.8 18040.1 18286.0 18446.3 41352.6 42610.4 42806.4 42980.4 43516.1 56323.4 58212.1 59409.1 60033.4 60513.7 6884.6 7438.4 7569.0 7629.7 7842.0 10242.4 11849.0 12062.2 12127.8 12529.4 10589.6 10652.9 10820.0 10936.2 10939.6 10497.0 10588.7 10648.4 10719.1 10811.6 10671.0 10697.7 10915.2 11026.5 11097.0 7406.6 7506.8 7514.6 7566.1 7610.4 10111.9 10805.8 10936.4 11041.4 11267.0 05:41:21 INFO - PROCESS | 22614 | 05:41:21 INFO - PROCESS | 22614 | [#3] mootools.html Cycles:180 Average:5808.98 Median:2650.10 stddev:3335.47 (125.9%) stddev-sans-first:3327.83 05:41:21 INFO - PROCESS | 22614 | Values: 1328.8 1479.2 1509.5 1654.4 1818.1 7629.6 8741.7 8991.2 8996.2 9222.0 8903.4 8905.4 8914.7 8916.2 8916.9 2382.7 2420.5 2421.0 2423.4 2429.1 2321.3 2360.8 2384.5 2393.4 2400.7 2335.6 2342.9 2371.5 2396.7 2397.3 2302.4 2324.9 2326.9 2327.6 2366.2 2319.1 2336.2 2336.4 2342.9 2348.9 8680.7 8695.7 8778.8 8797.8 8829.9 5243.6 5332.3 5350.7 5365.3 5367.0 3414.3 3466.9 3504.8 3564.0 3571.7 1104.3 1109.3 2103.7 2137.0 2174.4 12585.7 12632.3 12635.2 12641.1 12643.5 4494.7 4580.3 4737.8 4763.9 4765.0 9826.1 9847.3 9850.3 9864.0 9949.2 5160.9 5184.0 5186.0 5190.4 5203.4 4289.6 4411.3 4615.8 4694.6 4815.1 3757.5 3803.4 3862.7 3876.6 3954.5 1137.9 1142.0 1145.7 1159.3 1166.5 832.3 884.9 901.6 918.3 923.6 5845.4 5902.8 5974.2 5976.1 5999.2 469.1 481.4 485.1 487.4 488.6 3766.9 3988.9 4037.6 4047.3 4080.1 10943.7 10992.5 11217.0 11357.0 11377.5 11000.3 11137.8 11153.6 11163.5 11187.9 8256.7 8297.5 8303.9 8377.0 8388.4 5774.6 5785.3 5848.0 5975.2 5981.6 10082.3 10102.2 10149.7 10170.6 10349.8 9969.8 10293.3 10700.0 10730.4 10732.1 6702.5 6878.1 6888.9 7546.0 7610.5 8351.2 8383.5 8533.2 8758.1 8789.2 7529.8 7707.4 7798.3 7801.8 7921.4 7547.2 7571.9 7593.9 7699.0 7699.4 7006.3 7048.7 7103.9 7107.1 7110.5 5101.7 5164.4 5185.4 5233.5 5420.2 4966.7 4978.6 5067.3 5106.9 5207.6 05:41:21 INFO - PROCESS | 22614 | 05:41:21 INFO - PROCESS | 22614 | [#4] prototype.html Cycles:180 Average:4630.90 Median:5307.09 stddev:1365.70 (25.7%) stddev-sans-first:1330.65 05:41:21 INFO - PROCESS | 22614 | Values: 320.3 322.3 328.0 334.1 335.3 5240.9 5281.6 5286.6 5288.5 5300.2 5191.4 5224.0 5248.8 5263.3 5268.3 3924.4 4041.4 4074.6 4128.4 4141.4 4116.7 4122.9 4133.5 4143.6 4145.9 4085.0 4086.5 4097.5 4131.5 4144.4 3900.8 3906.9 3985.6 4100.5 4126.7 3642.3 3644.6 3647.5 3655.2 3661.9 5184.2 5190.1 5191.4 5196.4 5204.2 4431.6 4636.7 4665.2 4702.6 4763.2 5409.6 5421.9 5425.5 5428.8 5464.4 3942.3 3945.4 3951.9 3966.5 3971.0 5537.1 5665.5 5691.4 5727.4 5746.7 4004.9 4010.4 4015.9 4020.2 4029.3 4037.1 4068.7 4070.1 4085.4 4101.9 4481.7 4683.5 4688.5 4703.3 4708.5 5495.8 5513.1 5513.8 5551.6 5593.6 1391.3 1407.8 1410.7 1411.5 1412.5 837.5 905.1 910.3 915.8 918.8 5117.5 5185.6 5275.5 5332.5 5343.5 5624.0 5643.2 5645.9 5650.4 5656.4 5161.2 5348.9 5349.9 5368.6 5368.8 2969.8 2998.8 3005.7 3013.6 3014.2 5895.5 5898.7 5903.6 5918.8 5939.2 5645.7 5715.0 5753.5 5754.0 5755.2 5774.3 5801.5 5802.5 5821.7 5838.6 5344.8 5579.9 5584.6 5589.5 5657.5 5511.9 5557.6 5577.4 5594.8 5619.2 5846.2 5892.6 5894.1 5947.6 5950.3 3858.8 3970.8 3974.3 3974.3 3977.6 5635.4 5655.1 5663.9 5665.5 5681.4 5541.3 5547.4 5559.7 5562.7 5564.3 5314.0 5427.4 5431.2 5448.4 5451.4 5319.3 5347.3 5379.1 5389.7 5413.0 5268.1 5293.7 5413.9 5454.5 5521.9 5381.0 5396.3 5400.9 5404.1 5451.9 05:41:21 INFO - PROCESS | 22614 | 05:41:21 INFO - PROCESS | 22614 | [#5] yui.html Cycles:180 Average:20359.55 Median:4712.52 stddev:29231.45 (620.3%) stddev-sans-first:29276.14 05:41:21 INFO - PROCESS | 22614 | Values: 691.9 700.6 705.5 717.3 755.9 15511.2 16865.8 16890.7 16905.5 16911.9 12093.3 12758.7 15163.3 15299.5 15309.0 770.5 780.0 785.8 785.8 788.9 761.1 766.1 766.3 766.8 772.1 823.0 823.6 828.4 829.4 832.6 817.6 821.4 822.6 822.6 822.7 601.2 606.3 608.1 614.0 614.9 14574.6 14576.5 14668.0 14971.0 14995.1 13166.3 13166.7 13208.3 13252.7 13361.0 11670.0 11696.0 11962.5 11990.0 12141.3 3675.7 3684.8 3735.9 3819.8 3835.0 74864.3 75366.6 75460.0 75590.6 83362.6 10466.0 10575.6 10594.3 10641.8 10751.0 22978.3 23009.5 23010.3 23014.2 23034.7 8457.3 8579.5 8780.3 8958.1 8962.1 4588.8 4677.1 4805.0 4955.4 4960.1 3217.5 3515.6 3642.0 3643.5 3649.8 567.0 571.1 582.5 603.0 606.4 607.9 660.3 660.8 718.6 728.3 9296.6 9503.9 9684.4 9816.9 10045.7 620.5 696.5 700.6 711.1 711.2 4362.9 4590.8 4747.9 4861.7 4885.6 72940.6 77605.6 127737.9 128412.0 130492.3 73983.3 79464.0 107361.0 110730.0 112088.4 60633.7 61103.7 88462.6 92887.0 92896.0 8898.5 8965.3 8965.3 9048.0 9185.2 52418.7 52580.2 53337.7 54111.0 57804.7 63154.4 65224.0 65790.7 75841.0 83763.0 12796.2 13025.3 13033.7 13040.7 13407.7 14966.0 14970.6 15079.5 15153.5 15192.9 13104.3 13228.5 13848.3 13936.0 14023.2 13873.5 13898.4 14384.5 14600.6 14850.9 13576.3 13705.3 13983.2 14291.4 14592.1 11326.5 11369.5 11431.6 11633.9 11850.2 10008.7 11304.7 11438.9 11764.2 12024.6 05:41:21 INFO - PROCESS | 22614 | -------- Summary: end -------- 05:41:21 INFO - PROCESS | 22614 | 05:41:22 INFO - TEST-INFO | 22614: exit 0 05:41:22 INFO - TEST-OK | dromaeo_css | took 1116436ms 05:41:22 INFO - TEST-START | kraken 05:41:22 INFO - operating with platform_type : linux_ 05:41:22 INFO - Initialising browser for kraken test... 05:41:22 INFO - TEST-INFO | started process 22921 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnmUbxK/profile http://localhost:34149/getInfo.html) 05:41:27 INFO - PROCESS | 22921 | __metrics Screen width/height:1600/1200 05:41:27 INFO - PROCESS | 22921 | colorDepth:24 05:41:27 INFO - PROCESS | 22921 | Browser inner width/height: 1024/697 05:41:27 INFO - PROCESS | 22921 | __metrics 05:41:27 INFO - PROCESS | 22921 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:41:27 INFO - PROCESS | 22921 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:41:28 INFO - PROCESS | 22921 | console.error: PushService: 05:41:28 INFO - PROCESS | 22921 | stateChangeProcessEnqueue: Error transitioning state 05:41:28 INFO - PROCESS | 22921 | UnknownError 05:41:29 INFO - TEST-INFO | 22921: exit 0 05:41:29 INFO - Browser initialized. 05:41:29 INFO - Running cycle 1/1 for kraken test... 05:41:29 INFO - TEST-INFO | started process 23007 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnmUbxK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:41:41 INFO - PROCESS | 23007 | RSS: Main: 173359104 05:41:41 INFO - PROCESS | 23007 | 05:41:43 INFO - PROCESS | 23007 | Cycle 1(1): loaded http://localhost:34149/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34149/tests/kraken/driver.html?testName=audio-beat-detection) 05:41:44 INFO - PROCESS | 23007 | RSS: Main: 233324544 05:41:44 INFO - PROCESS | 23007 | 05:41:47 INFO - PROCESS | 23007 | Cycle 1(1): loaded http://localhost:34149/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34149/tests/kraken/driver.html?testName=audio-dft) 05:41:47 INFO - PROCESS | 23007 | RSS: Main: 217219072 05:41:47 INFO - PROCESS | 23007 | 05:41:50 INFO - PROCESS | 23007 | Cycle 1(1): loaded http://localhost:34149/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34149/tests/kraken/driver.html?testName=audio-fft) 05:41:51 INFO - PROCESS | 23007 | RSS: Main: 298156032 05:41:51 INFO - PROCESS | 23007 | 05:41:53 INFO - PROCESS | 23007 | Cycle 1(1): loaded http://localhost:34149/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34149/tests/kraken/driver.html?testName=audio-oscillator) 05:41:54 INFO - PROCESS | 23007 | RSS: Main: 209068032 05:41:54 INFO - PROCESS | 23007 | 05:41:56 INFO - PROCESS | 23007 | Cycle 1(1): loaded http://localhost:34149/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34149/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:41:56 INFO - PROCESS | 23007 | RSS: Main: 213426176 05:41:56 INFO - PROCESS | 23007 | 05:42:00 INFO - PROCESS | 23007 | Cycle 1(1): loaded http://localhost:34149/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34149/tests/kraken/driver.html?testName=imaging-darkroom) 05:42:00 INFO - PROCESS | 23007 | RSS: Main: 249511936 05:42:00 INFO - PROCESS | 23007 | 05:42:03 INFO - PROCESS | 23007 | Cycle 1(1): loaded http://localhost:34149/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34149/tests/kraken/driver.html?testName=imaging-desaturate) 05:42:04 INFO - PROCESS | 23007 | RSS: Main: 248565760 05:42:04 INFO - PROCESS | 23007 | 05:42:07 INFO - PROCESS | 23007 | Cycle 1(1): loaded http://localhost:34149/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34149/tests/kraken/driver.html?testName=json-parse-financial) 05:42:07 INFO - PROCESS | 23007 | RSS: Main: 248668160 05:42:07 INFO - PROCESS | 23007 | 05:42:09 INFO - PROCESS | 23007 | Cycle 1(1): loaded http://localhost:34149/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34149/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:42:10 INFO - PROCESS | 23007 | RSS: Main: 210673664 05:42:10 INFO - PROCESS | 23007 | 05:42:11 INFO - PROCESS | 23007 | Cycle 1(1): loaded http://localhost:34149/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34149/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:42:12 INFO - PROCESS | 23007 | RSS: Main: 218419200 05:42:12 INFO - PROCESS | 23007 | 05:42:14 INFO - PROCESS | 23007 | Cycle 1(1): loaded http://localhost:34149/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34149/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:42:15 INFO - PROCESS | 23007 | RSS: Main: 222609408 05:42:15 INFO - PROCESS | 23007 | 05:42:17 INFO - PROCESS | 23007 | Cycle 1(1): loaded http://localhost:34149/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34149/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:42:18 INFO - PROCESS | 23007 | RSS: Main: 224247808 05:42:18 INFO - PROCESS | 23007 | 05:42:21 INFO - PROCESS | 23007 | Cycle 1(1): loaded http://localhost:34149/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34149/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:42:21 INFO - PROCESS | 23007 | RSS: Main: 221642752 05:42:21 INFO - PROCESS | 23007 | 05:42:23 INFO - PROCESS | 23007 | Cycle 1(1): loaded http://localhost:34149/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34149/tests/kraken/driver.html?testName=ai-astar) 05:42:23 INFO - PROCESS | 23007 | RSS: Main: 273313792 05:42:23 INFO - PROCESS | 23007 | 05:42:23 INFO - PROCESS | 23007 | __start_tp_report 05:42:23 INFO - PROCESS | 23007 | _x_x_mozilla_page_load 05:42:23 INFO - PROCESS | 23007 | _x_x_mozilla_page_load_details 05:42:23 INFO - PROCESS | 23007 | |i|pagename|runs| 05:42:23 INFO - PROCESS | 23007 | |0;ai-astar;108;110;110;111;111;110;110;109;109;109 05:42:23 INFO - PROCESS | 23007 | |1;audio-beat-detection;143;118;119;169;118;119;123;117;147;116 05:42:23 INFO - PROCESS | 23007 | |2;audio-dft;160;161;162;161;160;161;162;161;163;163 05:42:23 INFO - PROCESS | 23007 | |3;audio-fft;77;76;78;110;77;78;76;75;101;75 05:42:23 INFO - PROCESS | 23007 | |4;audio-oscillator;84;82;113;84;84;84;102;83;83;116 05:42:23 INFO - PROCESS | 23007 | |5;imaging-gaussian-blur;118;117;117;117;118;118;117;118;117;117 05:42:23 INFO - PROCESS | 23007 | |6;imaging-darkroom;146;146;147;146;145;146;146;146;145;145 05:42:23 INFO - PROCESS | 23007 | |7;imaging-desaturate;95;95;95;95;95;94;94;95;96;95 05:42:23 INFO - PROCESS | 23007 | |8;json-parse-financial;51;55;51;50;50;50;52;52;51;51 05:42:23 INFO - PROCESS | 23007 | |9;json-stringify-tinderbox;59;60;60;60;60;59;59;60;61;64 05:42:23 INFO - PROCESS | 23007 | |10;stanford-crypto-aes;88;81;78;79;79;87;79;78;79;87 05:42:23 INFO - PROCESS | 23007 | |11;stanford-crypto-ccm;125;123;129;129;133;129;132;137;177;124 05:42:23 INFO - PROCESS | 23007 | |12;stanford-crypto-pbkdf2;160;158;160;162;171;163;167;161;161;166 05:42:23 INFO - PROCESS | 23007 | |13;stanford-crypto-sha256-iterative;66;64;65;63;69;63;66;67;69;63 05:42:23 INFO - PROCESS | 23007 | __end_tp_report 05:42:23 INFO - PROCESS | 23007 | __start_cc_report 05:42:23 INFO - PROCESS | 23007 | _x_x_mozilla_cycle_collect,1683 05:42:23 INFO - PROCESS | 23007 | __end_cc_report 05:42:23 INFO - PROCESS | 23007 | __startTimestamp1475152943590__endTimestamp 05:42:23 INFO - PROCESS | 23007 | 05:42:23 INFO - PROCESS | 23007 | ------- Summary: start ------- 05:42:23 INFO - PROCESS | 23007 | Number of tests: 14 05:42:23 INFO - PROCESS | 23007 | 05:42:23 INFO - PROCESS | 23007 | [#0] ai-astar Cycles:10 Average:109.70 Median:110.00 stddev:0.95 (0.9%) stddev-sans-first:0.78 05:42:23 INFO - PROCESS | 23007 | Values: 108.0 110.0 110.0 111.0 111.0 110.0 110.0 109.0 109.0 109.0 05:42:23 INFO - PROCESS | 23007 | 05:42:23 INFO - PROCESS | 23007 | [#1] audio-beat-detection Cycles:10 Average:128.90 Median:121.00 stddev:17.98 (14.9%) stddev-sans-first:18.34 05:42:23 INFO - PROCESS | 23007 | Values: 143.0 118.0 119.0 169.0 118.0 119.0 123.0 117.0 147.0 116.0 05:42:23 INFO - PROCESS | 23007 | 05:42:23 INFO - PROCESS | 23007 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:1.07 (0.7%) stddev-sans-first:1.01 05:42:23 INFO - PROCESS | 23007 | Values: 160.0 161.0 162.0 161.0 160.0 161.0 162.0 161.0 163.0 163.0 05:42:23 INFO - PROCESS | 23007 | 05:42:23 INFO - PROCESS | 23007 | [#3] audio-fft Cycles:10 Average:82.30 Median:76.50 stddev:12.45 (16.3%) stddev-sans-first:13.06 05:42:23 INFO - PROCESS | 23007 | Values: 77.0 76.0 78.0 110.0 77.0 78.0 76.0 75.0 101.0 75.0 05:42:23 INFO - PROCESS | 23007 | 05:42:23 INFO - PROCESS | 23007 | [#4] audio-oscillator Cycles:10 Average:91.50 Median:83.50 stddev:13.47 (16.1%) stddev-sans-first:14.01 05:42:23 INFO - PROCESS | 23007 | Values: 84.0 82.0 113.0 84.0 84.0 84.0 102.0 83.0 83.0 116.0 05:42:23 INFO - PROCESS | 23007 | 05:42:23 INFO - PROCESS | 23007 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 05:42:23 INFO - PROCESS | 23007 | Values: 118.0 117.0 117.0 117.0 118.0 118.0 117.0 118.0 117.0 117.0 05:42:23 INFO - PROCESS | 23007 | 05:42:23 INFO - PROCESS | 23007 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 05:42:23 INFO - PROCESS | 23007 | Values: 146.0 146.0 147.0 146.0 145.0 146.0 146.0 146.0 145.0 145.0 05:42:23 INFO - PROCESS | 23007 | 05:42:23 INFO - PROCESS | 23007 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 05:42:23 INFO - PROCESS | 23007 | Values: 95.0 95.0 95.0 95.0 95.0 94.0 94.0 95.0 96.0 95.0 05:42:23 INFO - PROCESS | 23007 | 05:42:23 INFO - PROCESS | 23007 | [#8] json-parse-financial Cycles:10 Average:51.30 Median:51.00 stddev:1.49 (2.9%) stddev-sans-first:1.58 05:42:23 INFO - PROCESS | 23007 | Values: 51.0 55.0 51.0 50.0 50.0 50.0 52.0 52.0 51.0 51.0 05:42:23 INFO - PROCESS | 23007 | 05:42:23 INFO - PROCESS | 23007 | [#9] json-stringify-tinderbox Cycles:10 Average:60.20 Median:60.00 stddev:1.48 (2.5%) stddev-sans-first:1.50 05:42:23 INFO - PROCESS | 23007 | Values: 59.0 60.0 60.0 60.0 60.0 59.0 59.0 60.0 61.0 64.0 05:42:23 INFO - PROCESS | 23007 | 05:42:23 INFO - PROCESS | 23007 | [#10] stanford-crypto-aes Cycles:10 Average:81.50 Median:80.00 stddev:4.12 (5.1%) stddev-sans-first:3.63 05:42:23 INFO - PROCESS | 23007 | Values: 88.0 81.0 78.0 79.0 79.0 87.0 79.0 78.0 79.0 87.0 05:42:23 INFO - PROCESS | 23007 | 05:42:23 INFO - PROCESS | 23007 | [#11] stanford-crypto-ccm Cycles:10 Average:133.80 Median:130.50 stddev:15.77 (12.1%) stddev-sans-first:16.41 05:42:23 INFO - PROCESS | 23007 | Values: 125.0 123.0 129.0 129.0 133.0 129.0 132.0 137.0 177.0 124.0 05:42:23 INFO - PROCESS | 23007 | 05:42:23 INFO - PROCESS | 23007 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.90 Median:162.50 stddev:3.96 (2.4%) stddev-sans-first:4.06 05:42:23 INFO - PROCESS | 23007 | Values: 160.0 158.0 160.0 162.0 171.0 163.0 167.0 161.0 161.0 166.0 05:42:23 INFO - PROCESS | 23007 | 05:42:23 INFO - PROCESS | 23007 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.50 Median:66.00 stddev:2.32 (3.5%) stddev-sans-first:2.46 05:42:23 INFO - PROCESS | 23007 | Values: 66.0 64.0 65.0 63.0 69.0 63.0 66.0 67.0 69.0 63.0 05:42:23 INFO - PROCESS | 23007 | -------- Summary: end -------- 05:42:23 INFO - PROCESS | 23007 | 05:42:24 INFO - TEST-INFO | 23007: exit 0 05:42:24 INFO - TEST-OK | kraken | took 61866ms 05:42:24 INFO - SUITE-END | took 1178s 05:42:25 INFO - Completed test suite (00:19:38) 05:42:25 INFO - javascript benchmark 05:42:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3059.9235019124517, 3084.6761090085524, 3089.505679091345, 3122.0477754284934, 3137.2941088255147, 5172.146595811687, 5267.631265811395, 5281.287026251455, 5334.279872217249, 5403.432639572848, 5281.234221037957, 5292.576593872491, 5328.0, 5411.080116380215, 5448.809291674792, 4842.249451335048, 4856.635752318591, 4874.731889746063, 4876.853694389156, 5013.473585273548, 4913.877153071184, 4921.753912304388, 4922.187839006559, 4928.975355123237, 4934.730024188877, 4800.519948005206, 4839.612830973549, 4850.199717046683, 4950.851474455754, 4975.203967365241, 4873.439554451213, 4878.487758785312, 4891.755412229374, 4893.437254715682, 4896.779644915988, 4809.374781278447, 4858.125537403266, 4873.853784386474, 4874.390701162355, 4876.317315575822, 5174.0, 5190.299309593194, 5229.555487783543, 5385.865353366158, 5408.702521361323, 5637.689927054011, 5637.943620563783, 5640.802571910004, 5646.604737668365, 5650.74571644277, 5458.590605704588, 5521.806736764194, 5650.406707295757, 5654.830355089312, 5680.687562184078, 5283.86790330241, 5329.173978033411, 5330.973345133289, 5338.97330513345, 5342.305500285016, 5811.680357580289, 5823.505002074787, 5827.59206855516, 5828.795992140254, 5838.678872662044, 5568.053430916754, 5604.635698679573, 5611.2144299798065, 5612.747426365741, 5635.718214089279, 5554.472325129106, 5617.606767526234, 5625.46558076982, 5658.0, 5686.289213848269, 5642.689652069175, 5651.745671444794, 5656.038473459522, 5656.604037717402, 5657.717114144276, 5574.498295153456, 5689.630174038757, 5698.800541981011, 5701.800436984769, 5702.429757024347, 4354.825806967686, 4355.3684715716045, 4373.868783936487, 4394.978025109918, 4398.934015989763, 3880.708946828999, 3881.3789793633446, 3914.256291304643, 3919.862804801818, 3938.6061393860386, 5345.679259244458, 5383.892322153535, 5384.138537833927, 5413.2150838128255, 5484.396716361197, 5538.861528461821, 5543.722813859291, 5613.691246981373, 5635.267415235993, 5672.8865422691315, 5346.331708536433, 5353.946460535345, 5372.946270537323, 5407.513323800877, 5432.103702889058, 4931.309616653672, 4940.283658869444, 4941.184704523714, 4944.554990050912, 4997.5002499749735, 5788.044972579477, 5853.09277062056, 5891.941080589139, 5898.439648233411, 5904.881902361929, 5739.71301434935, 5750.769969201185, 5767.048437008015, 5818.214541036906, 5821.330546987151, 5954.910676339771, 5987.880242395215, 5994.820155395345, 6004.729787159501, 6008.819735407945, 5460.426655201147, 5541.362743284412, 5548.583856210719, 5658.405867383865, 5666.405027472056, 5573.414791446839, 5596.608237423341, 5622.746976385991, 5638.323401191883, 5688.232088668143, 5477.616566840283, 5486.1222204447095, 5491.478309560585, 5500.862478438071, 5501.284832971848, 5438.428964958623, 5477.096279113902, 5484.177373394023, 5487.341519017744, 5544.611877168721, 5353.0, 5400.675959442446, 5450.482204190595, 5465.754041068241, 5545.140503222007, 5536.52939500147, 5540.889182216414, 5566.192902029264, 5572.804951826666, 5587.692676902647, 5381.327334083239, 5424.864378390414, 5432.158015507603, 5457.154141108134, 5458.181272809111], "value": 5243.028101478698, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [577.445652173913, 615.1541630258395, 624.1667374055636, 637.14622405976, 638.4030931079438, 30894.227644308903, 31556.842215788918, 33946.98159055229, 42082.579174208324, 43300.0, 43536.0, 44239.55760442395, 44242.33636495455, 44252.0, 47630.28554571675, 8840.602172902234, 8982.416142950688, 8985.0, 8987.415817971843, 8990.190882820545, 8137.552434616094, 8303.211194936472, 10443.895561044406, 10655.413952232624, 10699.251052426333, 10882.836757448644, 10972.506237219344, 10991.560337586527, 10991.835122473129, 11000.339979601209, 10795.78408431831, 10827.783444331148, 10832.566697332097, 10845.620403285926, 10865.239433239636, 10525.36847789135, 10582.894171058268, 10589.629362972337, 10599.62901298451, 10601.628942986958, 41041.79479102585, 41164.58835411638, 41444.0, 41522.0, 41524.0, 3208.2139875730595, 3302.884399046022, 3317.834108294576, 3596.7482276240676, 3698.593154752975, 30988.53517197244, 31071.37857242865, 31549.0, 31965.360692786246, 32772.34455310904, 4251.108768719783, 4341.5441378655105, 4464.374987501752, 4480.820767169309, 4646.303054541846, 325661.0, 326171.0, 326497.3675131633, 326571.0, 327262.0, 54269.0, 55134.72432637811, 55162.448375515734, 55167.72416137894, 55233.0, 57528.0, 57566.0, 57684.0, 57711.42288577145, 57949.42050579524, 14485.565433037025, 14757.262136893112, 14835.516448355294, 14944.626384340478, 14955.401783928739, 10643.201759868041, 10648.680539583826, 10748.731281717863, 10753.301035432673, 10754.247202695737, 14560.126392416489, 15069.246537673072, 15069.397224111131, 15254.313555890012, 15282.847171528143, 5486.979413836295, 5752.309722833287, 5802.692465294742, 5826.388229235954, 5894.0, 934.7663084228943, 1053.5575058475306, 1062.2723434447428, 1087.977301336741, 1112.8275117356823, 30963.225919352197, 31466.0, 31595.684043159734, 32142.83928580342, 32295.0, 1029.7734498410339, 1056.1234175634359, 1071.405370019631, 1088.733260351219, 1104.4146602300793, 16376.181190940406, 16634.75047874283, 17409.390671326444, 17477.300907963538, 18036.54908627295, 493871.0, 497857.0, 499179.0, 499213.0, 503360.0, 55540.444595554334, 55864.72067639717, 55869.16196257059, 56032.439675603535, 56129.43870561242, 1261.501706825817, 1309.7838856588555, 1309.9345032748324, 1318.643966129159, 1328.1234385305652, 29827.0, 31187.84406077955, 31678.36643267168, 31834.224866270244, 31976.52035219427, 46736.29895551501, 46985.76507117443, 47079.52920470889, 47082.0, 47117.764411177726, 429044.0, 429843.0, 430436.0, 430783.0, 434526.0, 26548.336291592866, 26693.866530667223, 26773.330666733487, 26880.027194968992, 26937.86531067332, 43306.13387732165, 43563.56436435722, 44524.0, 45071.32393014042, 45495.545044550454, 37013.444798328586, 37376.252474949804, 37659.0, 37789.4331585032, 39152.41271380874, 37518.24963500769, 37566.0, 37758.43362349622, 37868.0, 37909.81045094757, 30714.539281911235, 33610.0, 38908.41637375498, 38969.80515097406, 39107.0, 28215.858920705265, 33710.83144584261, 34213.144671383416, 34448.0, 34645.826770865984, 26930.0, 27052.72947270502, 27077.593836092867, 27102.186934392, 27249.773760181237], "value": 19426.371785200376, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [372.1199363505311, 379.510431543309, 400.98596549120776, 401.85332353690904, 418.10597991100326, 13376.365789197587, 15208.391664333427, 16250.268737906808, 19210.90394548025, 19726.210951561956, 18574.535636609093, 18626.068696565184, 18778.43664690058, 19344.226230950746, 19379.806201937976, 5517.586181036419, 5715.628249220199, 5718.7426565804435, 5727.083666613343, 5732.0542110551705, 5559.305086864142, 5709.31488221414, 5727.169560413738, 5798.275215598051, 5823.3012038555435, 5686.232358631594, 5758.136279558058, 5782.0, 5848.970755146218, 5875.970620146914, 5863.208466856962, 5900.350961394264, 5975.073863551178, 6000.879982400371, 6052.152698622196, 5617.859553511154, 5818.883622327529, 5831.533477321804, 5865.677387743673, 5920.763169473216, 13408.061435699505, 13543.754091560968, 13666.11170273929, 13692.452301907912, 22045.448863778372, 2181.7495705021943, 2275.205241435619, 2390.09176512924, 2466.3834041489627, 2663.4806212788512, 9860.457674827881, 9973.501324933797, 10021.09810117093, 10510.316829406063, 10534.473276336152, 1798.7481752554652, 1898.2346417831411, 1899.078946710844, 1922.5578117033021, 1932.849954277217, 82254.17745822525, 82928.0, 83010.58494707488, 83981.16018839795, 84054.57972710159, 8901.955490222508, 9340.346175767767, 9462.57418416173, 9510.38182518134, 10887.455627218607, 13243.66890827737, 13277.468901244036, 13298.800517992238, 13317.866821331856, 13346.0, 7282.563046217244, 7384.446166537531, 7400.0, 7546.320831125225, 7666.9616651917495, 7296.416286697052, 7336.0, 7360.447966402541, 7407.333339999426, 7495.587742674096, 3985.342418500915, 4015.738976966488, 4045.5058347702643, 4089.3865920111625, 4206.47419072616, 1920.1455352368341, 1937.1282922684566, 1991.0940522062426, 1993.182795054021, 2017.939461816148, 954.465499320369, 981.6122631560494, 988.6984469736656, 991.375433476905, 1014.1430491234895, 19829.30597429083, 19920.601587968158, 20000.0, 20010.499737506678, 20217.0, 909.9181073703398, 936.2165075531124, 946.0633972367444, 973.532704301939, 990.9792913299314, 10465.68602941913, 11056.447177641086, 11085.113190944867, 11257.380844053492, 11265.436728163722, 440572.0, 441415.0, 442760.0, 443283.0, 460954.0, 89658.65512017325, 91219.0, 91366.0, 93632.53183734037, 93695.0, 941.4116177389132, 957.7222605444343, 964.9179819715403, 969.7575606098476, 983.4050399508337, 16568.254428550503, 17400.82599174043, 18040.09799509993, 18286.0, 18446.26214951387, 41352.613571089874, 42610.36084458797, 42806.35790463208, 42980.35529467123, 43516.12967740564, 56323.43676563182, 58212.05197558255, 59409.10886336795, 60033.399666002784, 60513.69743151256, 6884.552504087218, 7438.44211684115, 7569.0, 7629.694812207449, 7841.960790196013, 10242.385456872313, 11849.0, 12062.215955962834, 12127.75744485123, 12529.373531323216, 10589.629362972259, 10652.946735266583, 10820.02619764225, 10936.234463587472, 10939.562417503528, 10497.0, 10588.735281618021, 10648.414337211218, 10719.142468602337, 10811.6215932442, 10671.0, 10697.679069627924, 10915.23593348458, 11026.50380732885, 11097.0, 7406.555606663617, 7506.812329691801, 7514.624268786648, 7566.092068951761, 7610.353119984863, 10111.89888101139, 10805.783884322112, 10936.398498082364, 11041.447927603427, 11267.0], "value": 8769.568023739808, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1328.7674656935035, 1479.1568805780703, 1509.4565956255747, 1654.4209526665668, 1818.1091265280018, 7629.580373079479, 8741.650333986641, 8991.23574496167, 8996.235319997808, 9221.95389023054, 8903.37676362655, 8905.4211476254, 8914.73255802327, 8916.15296546827, 8916.91083089169, 2382.6783384243167, 2420.4553975355493, 2421.007386971342, 2423.4062654649633, 2429.149797570845, 2321.280403075052, 2360.7757263060066, 2384.511175209078, 2393.44950661348, 2400.7239167495786, 2335.5562443135836, 2342.941426464335, 2371.4782747795457, 2396.712394512661, 2397.3407312988893, 2302.435903203726, 2324.9070037198494, 2326.9185578504757, 2327.5577640248384, 2366.2428023032635, 2319.1419174905395, 2336.229044415356, 2336.3925379401308, 2342.8711420871846, 2348.9295321140394, 8680.69789531569, 8695.652173913037, 8778.780530486725, 8797.7800554986, 8829.867551986725, 5243.580513558906, 5332.2801421808335, 5350.705711185883, 5365.302510673627, 5367.0339338918975, 3414.334204830059, 3466.9133271668156, 3504.8072356020407, 3564.0198945289994, 3571.714262858965, 1104.3484344236938, 1109.3343993603853, 2103.694964230178, 2136.9679454808193, 2174.358564223542, 12585.685357866036, 12632.30522321272, 12635.178713383693, 12641.051921105862, 12643.49426022958, 4494.685372023927, 4580.26715725489, 4737.8341758039, 4763.928541071887, 4765.046990601893, 9826.115649591571, 9847.261455390875, 9850.261230407748, 9863.950680246553, 9949.154321882575, 5160.92258616121, 5183.974080129575, 5185.9740701297005, 5190.429052804188, 5203.375594928632, 4289.592488713567, 4411.2721400968485, 4615.838445654453, 4694.577488026026, 4815.133276010281, 3757.511523501982, 3803.391457366808, 3862.729608927348, 3876.612338766101, 3954.4661470701085, 1137.8862113788555, 1141.9942900285446, 1145.6963904565298, 1159.2754528419737, 1166.4925757295603, 832.3258160889699, 884.8628462588181, 901.5672477210844, 918.2699753695695, 923.6259314977444, 5845.386234445322, 5902.763889444374, 5974.2233509643465, 5976.103584462366, 5999.190109335271, 469.1414711078718, 481.3814248690416, 485.0759303526787, 487.4272729542773, 488.6237597050322, 3766.9434958475645, 3988.920221595552, 4037.6164264394833, 4047.3321901886447, 4080.0615858352153, 10943.671689849318, 10992.450377481095, 11217.0, 11357.0, 11377.488013039267, 11000.284981476178, 11137.777244455065, 11153.553857845758, 11163.49764260594, 11187.888121118847, 8256.711015114442, 8297.543635100006, 8303.875441868377, 8377.0, 8388.370872184732, 5774.56690748204, 5785.27684039495, 5847.970760146172, 5975.193348897843, 5981.641101533922, 10082.29423940317, 10102.24233182529, 10149.695509134737, 10170.644027459004, 10349.793004140025, 9969.750756231153, 10293.279470437297, 10700.0, 10730.409827459565, 10732.087772539422, 6702.491939313615, 6878.105846239957, 6888.931110689029, 7545.962270188614, 7610.505317154367, 8351.20663536963, 8383.496990180609, 8533.232009119209, 8758.080401557745, 8789.165029322205, 7529.849403012018, 7707.383409327128, 7798.33714134305, 7801.804954876174, 7921.405894557816, 7547.207543207884, 7571.924280757342, 7593.924060759543, 7699.0, 7699.3840492761565, 7006.334398232159, 7048.718051277891, 7103.9289607103265, 7107.147142342952, 7110.537815042006, 5101.69389836611, 5164.406093299319, 5185.377754669464, 5233.450487698737, 5420.159875219348, 4966.726830024383, 4978.576820970114, 5067.342577406748, 5106.948930510647, 5207.635465517377], "value": 4593.685011593565, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [320.3145269124074, 322.30543179448284, 327.9996012162903, 334.1162624857251, 335.2523871765962, 5240.873212259364, 5281.551068159206, 5286.550643195324, 5288.545649946267, 5300.204969254613, 5191.351081114861, 5223.973880130604, 5248.816291429801, 5263.34208223972, 5268.262443257947, 3924.4113382992564, 4041.4139949707273, 4074.5721699221453, 4128.422020917074, 4141.4409054777525, 4116.732412393199, 4122.917541649165, 4133.462649855514, 4143.606357396043, 4145.854895078673, 4084.97957510212, 4086.5300490443683, 4097.549269580344, 4131.5248746394245, 4144.357624568197, 3900.835036554711, 3906.902327441808, 3985.5815139410233, 4100.5489396166395, 4126.66986641071, 3642.344378011957, 3644.5626524816926, 3647.4528820676846, 3655.214128962259, 3661.8901432957055, 5184.222366645034, 5190.117679994372, 5191.402988656315, 5196.402413722432, 5204.1673332266655, 4431.581893793988, 4636.744979026153, 4665.183592871268, 4702.576768090888, 4763.214069678499, 5409.6213265071465, 5421.9457805421835, 5425.511703946664, 5428.782848686087, 5464.426235245322, 3942.329803933338, 3945.4415505875304, 3951.920961580752, 3966.464527288808, 3971.0469487323126, 5537.1140617501005, 5665.461781130827, 5691.373948865621, 5727.394035713782, 5746.712664366765, 4004.879853604338, 4010.438538604598, 4015.9196816063513, 4020.155767288902, 4029.274730548471, 4037.1320166164414, 4068.6948478864206, 4070.063885306396, 4085.4076158956786, 4101.85643502476, 4481.655503348982, 4683.461401938821, 4688.460827004938, 4703.341532185496, 4708.458527269339, 5495.835124946258, 5513.050517972865, 5513.807016754395, 5551.611387202938, 5593.552515798727, 1391.3321605629355, 1407.7677183264852, 1410.7249086428048, 1411.484808045056, 1412.4773833681604, 837.4682076881103, 905.1265528764774, 910.349100393222, 915.7939463620633, 918.800964741006, 5117.5394214520875, 5185.599888030286, 5275.4724527547705, 5332.466753324714, 5343.519083282523, 5623.971880140573, 5643.181738647873, 5645.915311270334, 5650.434956504317, 5656.377798442168, 5161.200013997836, 5348.893022139613, 5349.866253343697, 5368.624196306221, 5368.758405871745, 2969.7624190064744, 2998.7900846940506, 3005.6844031376827, 3013.608230930009, 3014.1711029466633, 5895.528357731371, 5898.675572843535, 5903.645781253139, 5918.774268023937, 5939.22790037301, 5645.661260324394, 5714.971425142848, 5753.539716822645, 5753.971230143822, 5755.194272801811, 5774.3070831499645, 5801.476357784377, 5802.47777700009, 5821.679807610622, 5838.591298609056, 5344.839654810362, 5579.944200557942, 5584.553235741212, 5589.524890384363, 5657.519110875622, 5511.862203444946, 5557.5553955682635, 5577.358603760457, 5594.804181853616, 5619.241402410786, 5846.210761547137, 5892.558058145571, 5894.145348924296, 5947.613405128653, 5950.285965684146, 3858.7877666727477, 3970.788909382666, 3974.2647610192207, 3974.3243648579232, 3977.622125898035, 5635.380108188014, 5655.066913959151, 5663.858403539944, 5665.546756259571, 5681.409205422488, 5541.251930989265, 5547.421912866259, 5559.665680236633, 5562.694051827189, 5564.33228012641, 5313.973430132824, 5427.375851777097, 5431.212474191299, 5448.373437054631, 5451.4276001019325, 5319.281896944018, 5347.251384806208, 5379.139337706105, 5389.703566303734, 5413.0, 5268.076217699214, 5293.7353132344, 5413.945860541502, 5454.509094181542, 5521.874078479895, 5380.973095134499, 5396.298481197419, 5400.891982160413, 5404.135338346003, 5451.882364115426], "value": 4192.341187955819, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [691.9377256046955, 700.5761514283859, 705.5272967112031, 717.3257138290004, 755.9244075592442, 15511.224438778072, 16865.83134168658, 16890.74663880043, 16905.492835214933, 16911.915440422796, 12093.274403535794, 12758.744825103493, 15163.317650705718, 15299.541013769576, 15309.0, 770.5415277909635, 779.95710235937, 785.7996210966196, 785.8153333966513, 788.8895554622358, 761.0714927788117, 766.0998326965821, 766.3409467857638, 766.7776344859984, 772.1005029141044, 823.0206054794775, 823.5717426937989, 828.3952714518375, 829.3779665251062, 832.629479881453, 817.5912043978011, 821.4291067707945, 822.5722624235364, 822.6339279020868, 822.7161629237934, 601.227422761749, 606.305779882037, 608.0969759906535, 614.023702313324, 614.9108379285024, 14574.562763117017, 14576.489822856149, 14668.0, 14971.0, 14995.100293982396, 13166.27585482798, 13166.73666526664, 13208.339583020907, 13252.734945301136, 13361.0, 11670.0, 11696.0, 11962.521499140024, 11990.0, 12141.332226727527, 3675.7059435245383, 3684.7604905681046, 3735.869244576427, 3819.770813751156, 3835.0412396900774, 74864.25135748627, 75366.62316688382, 75460.0, 75590.62204688997, 83362.58318708428, 10466.0, 10575.629852955264, 10594.31136976094, 10641.787164256826, 10751.0, 22978.310650680505, 23009.53980920372, 23010.309690709306, 23014.19450319231, 23034.65448018281, 8457.323414126855, 8579.485230886166, 8780.253678437277, 8958.148975847414, 8962.148595883511, 4588.839390621312, 4677.111348843709, 4805.0, 4955.4301255356095, 4960.082384758831, 3217.4530329843983, 3515.648435156515, 3642.0348607619003, 3643.4534819777246, 3649.7810131392202, 566.9603127781098, 571.1005166862209, 582.484501216418, 603.0351437699645, 606.3784620763664, 607.8510764862637, 660.3297652882328, 660.7984564707714, 718.5904034700275, 728.3008312020414, 9296.581653825595, 9503.904960950302, 9684.370515916444, 9816.852747208797, 10045.748856278506, 620.488097319713, 696.4950410952019, 700.6006576251488, 711.1182134153715, 711.210556282526, 4362.869113926524, 4590.8163673453355, 4747.928781068286, 4861.723089719123, 4885.60915126789, 72940.63529682424, 77605.6119719409, 127737.86490283409, 128412.0, 130492.3475382617, 73983.26016739871, 79464.0, 107361.0, 110730.0, 112088.43955780331, 60633.69683151644, 61103.6944815282, 88462.61523386731, 92887.0, 92896.0, 8898.510581918057, 8965.327600429864, 8965.327600430124, 9047.954760226157, 9185.173334399937, 52418.73790631023, 52580.21129682981, 53337.73331133319, 54111.0, 57804.71097644485, 63154.36845631485, 65224.0, 65790.67104664446, 75841.0, 83763.0, 12796.168249063781, 13025.348732563523, 13033.674158146123, 13040.673983150118, 13407.731845363232, 14966.0, 14970.550883473514, 15079.54761357161, 15153.54539363821, 15192.924035379752, 13104.344782760632, 13228.470861165446, 13848.307584620527, 13936.0, 14023.158610483404, 13873.483319630428, 13898.37457314403, 14384.496542620958, 14600.634984125058, 14850.925745371203, 13576.253306068262, 13705.314734263446, 13983.161010339412, 14291.356888939814, 14592.124472531683, 11326.546938122383, 11369.54521819118, 11431.59989400367, 11633.941830291133, 11850.170488065753, 10008.749781255236, 11304.717382065186, 11438.856114388494, 11764.176507644383, 12024.639260822189], "value": 7450.573993217835, "unit": "score"}], "name": "dromaeo_css", "value": 7100.691309376503, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 110.0, 110.0, 111.0, 111.0, 110.0, 110.0, 109.0, 109.0, 109.0], "value": 109.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 118.0, 119.0, 169.0, 118.0, 119.0, 123.0, 117.0, 147.0, 116.0], "value": 128.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 162.0, 161.0, 160.0, 161.0, 162.0, 161.0, 163.0, 163.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 78.0, 110.0, 77.0, 78.0, 76.0, 75.0, 101.0, 75.0], "value": 82.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 113.0, 84.0, 84.0, 84.0, 102.0, 83.0, 83.0, 116.0], "value": 91.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 118.0, 118.0, 117.0, 118.0, 117.0, 117.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 146.0, 145.0, 146.0, 146.0, 146.0, 145.0, 145.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 94.0, 95.0, 96.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 55.0, 51.0, 50.0, 50.0, 50.0, 52.0, 52.0, 51.0, 51.0], "value": 51.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 60.0, 60.0, 60.0, 59.0, 59.0, 60.0, 61.0, 64.0], "value": 60.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 81.0, 78.0, 79.0, 79.0, 87.0, 79.0, 78.0, 79.0, 87.0], "value": 81.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 123.0, 129.0, 129.0, 133.0, 129.0, 132.0, 137.0, 177.0, 124.0], "value": 133.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 158.0, 160.0, 162.0, 171.0, 163.0, 167.0, 161.0, 161.0, 166.0], "value": 162.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 65.0, 63.0, 69.0, 63.0, 66.0, 67.0, 69.0, 63.0], "value": 65.5, "unit": "score"}], "name": "kraken", "value": 1487.1, "alertThreshold": 2.0}]} 05:42:25 INFO - Return code: 0 05:42:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:42:25 INFO - # TBPL SUCCESS # 05:42:25 INFO - Running post-action listener: _resource_record_post_action 05:42:25 INFO - [mozharness: 2016-09-29 12:42:25.392496Z] Finished run-tests step (success) 05:42:25 INFO - Running post-run listener: _resource_record_post_run 05:42:25 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 393228288; Read time: 16; Write time: 340468 05:42:25 INFO - TinderboxPrint: CPU usage
13.0% 05:42:25 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 05:42:25 INFO - TinderboxPrint: I/O write bytes / time
393,228,288 / 340,468 05:42:25 INFO - TinderboxPrint: CPU idle
8,296.8 (86.9%) 05:42:25 INFO - TinderboxPrint: CPU user
1,195.4 (12.5%) 05:42:25 INFO - TinderboxPrint: Swap in / out
0 / 0 05:42:25 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103071744; Read time: 0; Write time: 85988 05:42:25 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 0; Write bytes: 287444992; Read time: 0; Write time: 254248 05:42:26 INFO - Running post-run listener: _upload_blobber_files 05:42:26 INFO - Blob upload gear active. 05:42:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:42:26 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:42:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:42:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:42:26 INFO - (blobuploader) - INFO - Open directory for files ... 05:42:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:42:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:42:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:42:29 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:42:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:42:29 INFO - (blobuploader) - INFO - Done attempting. 05:42:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:42:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:42:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:42:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:42:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:42:30 INFO - (blobuploader) - INFO - Done attempting. 05:42:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:42:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:42:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:42:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:42:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:42:31 INFO - (blobuploader) - INFO - Done attempting. 05:42:31 INFO - (blobuploader) - INFO - Iteration through files over. 05:42:31 INFO - Return code: 0 05:42:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:42:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:42:31 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/392dd43bc63694eb00c7da9f48daa1b801a79d4425c677bc4b10eef30f16aabd8bcaaac84cc606eb845db8e00f482f27d8a90612a5535c017ac9298998c1a773", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9e91ec93d6532a81e41ac8f3a6355e3976d63c70421c4fad74eada877caae648677c8330162df78fd28315b0cfe6129e1a8be0bf592d89340b60196a94ac211c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/73e5e1f89b4687571a418be6a319ad349ee39cd87d8f75eb0143b6f0e0e8f7367b9b50ebd71ae41597e5d8e54816d8815ccf97e55ce7f26e8df8070a41d8d63f"} 05:42:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:42:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:42:31 INFO - Contents: 05:42:31 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/392dd43bc63694eb00c7da9f48daa1b801a79d4425c677bc4b10eef30f16aabd8bcaaac84cc606eb845db8e00f482f27d8a90612a5535c017ac9298998c1a773", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9e91ec93d6532a81e41ac8f3a6355e3976d63c70421c4fad74eada877caae648677c8330162df78fd28315b0cfe6129e1a8be0bf592d89340b60196a94ac211c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/73e5e1f89b4687571a418be6a319ad349ee39cd87d8f75eb0143b6f0e0e8f7367b9b50ebd71ae41597e5d8e54816d8815ccf97e55ce7f26e8df8070a41d8d63f"} 05:42:31 INFO - Running post-run listener: copy_logs_to_upload_dir 05:42:31 INFO - Copying logs to upload dir... 05:42:31 INFO - mkdir: /builds/slave/test/build/upload/logs 05:42:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.296961 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-09-29 05:42:30.899592) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-29 05:42:30.903193) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1475151709.170193-1264048112 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/392dd43bc63694eb00c7da9f48daa1b801a79d4425c677bc4b10eef30f16aabd8bcaaac84cc606eb845db8e00f482f27d8a90612a5535c017ac9298998c1a773", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9e91ec93d6532a81e41ac8f3a6355e3976d63c70421c4fad74eada877caae648677c8330162df78fd28315b0cfe6129e1a8be0bf592d89340b60196a94ac211c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/73e5e1f89b4687571a418be6a319ad349ee39cd87d8f75eb0143b6f0e0e8f7367b9b50ebd71ae41597e5d8e54816d8815ccf97e55ce7f26e8df8070a41d8d63f"} build_url:https://queue.taskcluster.net/v1/task/dOINvdzmQSiPXjrLriUKXQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011226 build_url: 'https://queue.taskcluster.net/v1/task/dOINvdzmQSiPXjrLriUKXQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/392dd43bc63694eb00c7da9f48daa1b801a79d4425c677bc4b10eef30f16aabd8bcaaac84cc606eb845db8e00f482f27d8a90612a5535c017ac9298998c1a773", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9e91ec93d6532a81e41ac8f3a6355e3976d63c70421c4fad74eada877caae648677c8330162df78fd28315b0cfe6129e1a8be0bf592d89340b60196a94ac211c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/73e5e1f89b4687571a418be6a319ad349ee39cd87d8f75eb0143b6f0e0e8f7367b9b50ebd71ae41597e5d8e54816d8815ccf97e55ce7f26e8df8070a41d8d63f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-29 05:42:30.932507) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 05:42:30.933380) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1475151709.170193-1264048112 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004493 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 05:42:31.017843) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-29 05:42:31.018580) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-29 05:42:31.019284) ========= ========= Total master_lag: 0.19 =========