builder: cedar_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-008 starttime: 1479387894.35 results: success (0) buildid: 20161117034731 builduid: 93ac791856a14d468dcc502b09e43d92 revision: 76094c82d70cebcf7e596a43a96585cf3100d64b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-17 05:04:54.354729) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-17 05:04:54.355143) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 1 secs) (at 2016-11-17 05:04:54.355425) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 1 secs) (at 2016-11-17 05:04:55.770175) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 05:04:55.770457) ========= 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=32c5991c409366f7fec8a718000001d2-1479386971.676950-1929419083 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-17 05:04:56-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 45.3M=0s 2016-11-17 05:04:56 (45.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.148741 ========= master_lag: 0.26 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 05:04:56.174374) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 05:04:56.177705) ========= 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=32c5991c409366f7fec8a718000001d2-1479386971.676950-1929419083 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017435 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 05:04:56.230282) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-17 05:04:56.230626) ========= bash -c 'python archiver_client.py mozharness --repo projects/cedar --rev 76094c82d70cebcf7e596a43a96585cf3100d64b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/cedar --rev 76094c82d70cebcf7e596a43a96585cf3100d64b --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=32c5991c409366f7fec8a718000001d2-1479386971.676950-1929419083 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-17 05:04:57,278 truncating revision to first 12 chars 2016-11-17 05:04:57,278 Setting DEBUG logging. 2016-11-17 05:04:57,278 attempt 1/10 2016-11-17 05:04:57,278 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/cedar/76094c82d70c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-17 05:04:58,702 unpacking tar archive at: cedar-76094c82d70c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.741225 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-17 05:04:57.994092) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-17 05:04:57.994415) ========= script_repo_revision: 76094c82d70cebcf7e596a43a96585cf3100d64b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-17 05:04:57.994822) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-17 05:04:57.995096) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-17 05:04:58.008298) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-11-17 05:04:58.008644) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Cedar --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Cedar 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', 'Cedar', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Cedar'] 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=32c5991c409366f7fec8a718000001d2-1479386971.676950-1929419083 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:04:59 INFO - MultiFileLogger online at 20161117 05:04:59 in /builds/slave/test 05:04:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Cedar --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Cedar 05:04:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:04:59 INFO - {'append_to_log': False, 05:04:59 INFO - 'base_work_dir': '/builds/slave/test', 05:04:59 INFO - 'blob_upload_branch': 'Cedar', 05:04:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:04:59 INFO - 'branch': 'Cedar', 05:04:59 INFO - 'buildbot_json_path': 'buildprops.json', 05:04:59 INFO - 'config_files': ('talos/linux_config.py',), 05:04:59 INFO - 'default_actions': ('clobber', 05:04:59 INFO - 'read-buildbot-config', 05:04:59 INFO - 'download-and-extract', 05:04:59 INFO - 'populate-webroot', 05:04:59 INFO - 'create-virtualenv', 05:04:59 INFO - 'install', 05:04:59 INFO - 'run-tests'), 05:04:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:04:59 INFO - 'download_minidump_stackwalk': True, 05:04:59 INFO - 'download_symbols': 'ondemand', 05:04:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:04:59 INFO - 'tooltool.py': '/tools/tooltool.py', 05:04:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:04:59 INFO - '/tools/misc-python/virtualenv.py')}, 05:04:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:04:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:04:59 INFO - 'installer_path': 'installer.exe', 05:04:59 INFO - 'log_level': 'info', 05:04:59 INFO - 'log_name': 'talos', 05:04:59 INFO - 'log_to_console': True, 05:04:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:04:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:04:59 INFO - 'opt_config_files': (), 05:04:59 INFO - 'pip_index': False, 05:04:59 INFO - 'sps_profile': False, 05:04:59 INFO - 'sps_profile_interval': 0, 05:04:59 INFO - 'suite': 'dromaeojs', 05:04:59 INFO - 'system_bits': '32', 05:04:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:04:59 INFO - 'title': 'talos-linux64-ix-008', 05:04:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:04:59 INFO - 'use_talos_json': True, 05:04:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:04:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:04:59 INFO - 'work_dir': 'build'} 05:04:59 INFO - [mozharness: 2016-11-17 13:04:59.144698Z] Running clobber step. 05:04:59 INFO - Running pre-action listener: _resource_record_pre_action 05:04:59 INFO - Running main action method: clobber 05:04:59 INFO - rmtree: /builds/slave/test/build 05:04:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:05:00 INFO - Running post-action listener: _resource_record_post_action 05:05:00 INFO - [mozharness: 2016-11-17 13:05:00.116046Z] Finished clobber step (success) 05:05:00 INFO - [mozharness: 2016-11-17 13:05:00.116143Z] Running read-buildbot-config step. 05:05:00 INFO - Running pre-action listener: _resource_record_pre_action 05:05:00 INFO - Running main action method: read_buildbot_config 05:05:00 INFO - Using buildbot properties: 05:05:00 INFO - { 05:05:00 INFO - "project": "", 05:05:00 INFO - "product": "firefox", 05:05:00 INFO - "script_repo_revision": "default", 05:05:00 INFO - "builddir": "cedar_ubuntu64_hw_test-dromaeojs", 05:05:00 INFO - "repository": "", 05:05:00 INFO - "buildername": "Ubuntu HW 12.04 x64 cedar talos dromaeojs", 05:05:00 INFO - "buildid": "20161117034731", 05:05:00 INFO - "pgo_build": "False", 05:05:00 INFO - "basedir": "/builds/slave/test", 05:05:00 INFO - "buildnumber": 4, 05:05:00 INFO - "slavename": "talos-linux64-ix-008", 05:05:00 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:05:00 INFO - "platform": "ubuntu64_hw", 05:05:00 INFO - "scheduler": "tests-cedar-linux64-talos", 05:05:00 INFO - "branch": "cedar", 05:05:00 INFO - "repo_path": "projects/cedar", 05:05:00 INFO - "revision": "76094c82d70cebcf7e596a43a96585cf3100d64b", 05:05:00 INFO - "stage_platform": "linux64", 05:05:00 INFO - "builduid": "93ac791856a14d468dcc502b09e43d92", 05:05:00 INFO - "slavebuilddir": "test" 05:05:00 INFO - } 05:05:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/YTRb5Uh2T-m1hqgN9Iv_sQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 05:05:00 INFO - Running post-action listener: _resource_record_post_action 05:05:00 INFO - [mozharness: 2016-11-17 13:05:00.118814Z] Finished read-buildbot-config step (success) 05:05:00 INFO - [mozharness: 2016-11-17 13:05:00.118902Z] Running download-and-extract step. 05:05:00 INFO - Running pre-action listener: _resource_record_pre_action 05:05:00 INFO - Running main action method: download_and_extract 05:05:00 INFO - mkdir: /builds/slave/test/build/tests 05:05:00 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:05:00 INFO - trying https://queue.taskcluster.net/v1/task/YTRb5Uh2T-m1hqgN9Iv_sQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 05:05:00 INFO - Downloading https://queue.taskcluster.net/v1/task/YTRb5Uh2T-m1hqgN9Iv_sQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 05:05:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YTRb5Uh2T-m1hqgN9Iv_sQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:05:00 INFO - Downloaded 1361 bytes. 05:05:00 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 05:05:00 INFO - Using the following test package requirements: 05:05:00 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 05:05:00 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 05:05:00 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:05:00 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 05:05:00 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:05:00 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 05:05:00 INFO - u'jsshell-linux-x86_64.zip'], 05:05:00 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 05:05:00 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:05:00 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 05:05:00 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 05:05:00 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:05:00 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 05:05:00 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:05:00 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 05:05:00 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:05:00 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 05:05:00 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:05:00 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:05:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YTRb5Uh2T-m1hqgN9Iv_sQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 05:05:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YTRb5Uh2T-m1hqgN9Iv_sQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:05:00 INFO - Fetch https://queue.taskcluster.net/v1/task/YTRb5Uh2T-m1hqgN9Iv_sQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 05:05:01 INFO - Http code: 200 05:05:01 INFO - via: 1.1 c54d7f08e2f3dab1918454910cc8aad0.cloudfront.net (CloudFront) 05:05:01 INFO - x-amz-cf-id: HiFUIhvURVXHaLBWTos3FWY-f7FGN1krAzrggxhB3I14l6KpEi9iEA== 05:05:01 INFO - x-amz-version-id: oODP5HhZ31Yq85DuuNGgOYlS1haHXuaN 05:05:01 INFO - Expected file size: 20360018 05:05:01 INFO - Obtained file size: 20360018 05:05:05 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:05:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YTRb5Uh2T-m1hqgN9Iv_sQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 05:05:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YTRb5Uh2T-m1hqgN9Iv_sQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:05:05 INFO - Fetch https://queue.taskcluster.net/v1/task/YTRb5Uh2T-m1hqgN9Iv_sQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 05:05:06 INFO - Http code: 200 05:05:06 INFO - via: 1.1 d2bd759914e30b1d5aee2929535c55f9.cloudfront.net (CloudFront) 05:05:06 INFO - x-amz-cf-id: 2NOlOHyJ6quu2T4tEk348iFoa1Xxi1RPSwuSnaM4dEQowLiC0-K4MA== 05:05:06 INFO - x-amz-version-id: oODP5HhZ31Yq85DuuNGgOYlS1haHXuaN 05:05:06 INFO - Expected file size: 20360018 05:05:06 INFO - Obtained file size: 20360018 05:05:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YTRb5Uh2T-m1hqgN9Iv_sQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 05:05:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YTRb5Uh2T-m1hqgN9Iv_sQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:05:10 INFO - Fetch https://queue.taskcluster.net/v1/task/YTRb5Uh2T-m1hqgN9Iv_sQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 05:05:11 INFO - Http code: 200 05:05:11 INFO - via: 1.1 c0740de9f16cf32ffedfd2f9806b8483.cloudfront.net (CloudFront) 05:05:11 INFO - x-amz-cf-id: LA9aRBIcpvETY0je_V6dslOVmQmDAU0usol2TtLUlGG7sr0BQ_A42w== 05:05:11 INFO - x-amz-version-id: 5RwasP3NGqShgpgpoT88JyAV0y.P3ntn 05:05:11 INFO - Expected file size: 14409389 05:05:11 INFO - Obtained file size: 14409389 05:05: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:05:12 INFO - trying https://queue.taskcluster.net/v1/task/YTRb5Uh2T-m1hqgN9Iv_sQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 05:05:12 INFO - Downloading https://queue.taskcluster.net/v1/task/YTRb5Uh2T-m1hqgN9Iv_sQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 05:05:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YTRb5Uh2T-m1hqgN9Iv_sQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:05:14 INFO - Downloaded 55717472 bytes. 05:05:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YTRb5Uh2T-m1hqgN9Iv_sQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 05:05:14 INFO - mkdir: /builds/slave/test/properties 05:05:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:05:14 INFO - Writing to file /builds/slave/test/properties/build_url 05:05:14 INFO - Contents: 05:05:14 INFO - build_url:https://queue.taskcluster.net/v1/task/YTRb5Uh2T-m1hqgN9Iv_sQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 05:05:15 INFO - Running post-action listener: _resource_record_post_action 05:05:15 INFO - Running post-action listener: set_extra_try_arguments 05:05:15 INFO - [mozharness: 2016-11-17 13:05:15.372386Z] Finished download-and-extract step (success) 05:05:15 INFO - [mozharness: 2016-11-17 13:05:15.372612Z] Running populate-webroot step. 05:05:15 INFO - Running pre-action listener: _resource_record_pre_action 05:05:15 INFO - Running main action method: populate_webroot 05:05:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:05:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:05:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:05:15 INFO - '--tppagecycles', 05:05:15 INFO - '7'], 05:05:15 INFO - 'tests': ['tsvgm']}}, 05:05:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:05:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:05:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:05:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:05:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:05:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:05:15 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 05:05:15 INFO - 'talos_options': ['--disable-e10s'], 05:05:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:05:15 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:05:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:05:15 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 05:05:15 INFO - 'talos_options': ['--disable-e10s'], 05:05:15 INFO - 'tests': ['damp', 'tps']}, 05:05:15 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:05:15 INFO - 'tests': ['damp', 'tps']}, 05:05:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:05:15 INFO - 'tests': ['dromaeo_dom']}, 05:05:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:05:15 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:05:15 INFO - 'tests': ['basic_compositor_video']}, 05:05:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:05:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:05:15 INFO - 'tests': ['a11yr', 05:05:15 INFO - 'ts_paint', 05:05:15 INFO - 'tpaint', 05:05:15 INFO - 'sessionrestore', 05:05:15 INFO - 'sessionrestore_no_auto_restore', 05:05:15 INFO - 'tabpaint']}, 05:05:15 INFO - 'other-e10s': {'tests': ['a11yr', 05:05:15 INFO - 'ts_paint', 05:05:15 INFO - 'tpaint', 05:05:15 INFO - 'sessionrestore', 05:05:15 INFO - 'sessionrestore_no_auto_restore', 05:05:15 INFO - 'tabpaint']}, 05:05:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:05:15 INFO - 'ts_paint', 05:05:15 INFO - 'tpaint', 05:05:15 INFO - 'sessionrestore', 05:05:15 INFO - 'sessionrestore_no_auto_restore', 05:05:15 INFO - 'tabpaint']}, 05:05:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:05:15 INFO - 'ts_paint', 05:05:15 INFO - 'tpaint', 05:05:15 INFO - 'sessionrestore', 05:05:15 INFO - 'sessionrestore_no_auto_restore', 05:05:15 INFO - 'tabpaint']}, 05:05:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:05:15 INFO - 'tests': ['a11yr', 05:05:15 INFO - 'ts_paint', 05:05:15 INFO - 'tpaint', 05:05:15 INFO - 'sessionrestore', 05:05:15 INFO - 'sessionrestore_no_auto_restore', 05:05:15 INFO - 'tabpaint']}, 05:05:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:05:15 INFO - 'tests': ['a11yr', 05:05:15 INFO - 'ts_paint', 05:05:15 INFO - 'tpaint', 05:05:15 INFO - 'sessionrestore', 05:05:15 INFO - 'sessionrestore_no_auto_restore', 05:05:15 INFO - 'tabpaint']}, 05:05:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:05:15 INFO - 'tests': ['tsvgx', 05:05:15 INFO - 'tsvgr_opacity', 05:05:15 INFO - 'tart', 05:05:15 INFO - 'tscrollx', 05:05:15 INFO - 'cart']}, 05:05:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:05:15 INFO - 'tsvgr_opacity', 05:05:15 INFO - 'tart', 05:05:15 INFO - 'tscrollx', 05:05:15 INFO - 'cart']}, 05:05:15 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 05:05:15 INFO - 'talos_options': ['--disable-e10s'], 05:05:15 INFO - 'tests': ['tp5o']}, 05:05:15 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:05:15 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 05:05:15 INFO - 'talos_options': ['--disable-e10s', 05:05:15 INFO - '--xperf_path', 05:05:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:05:15 INFO - 'tests': ['tp5n']}, 05:05:15 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:05:15 INFO - 'talos_options': ['--xperf_path', 05:05:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:05:15 INFO - 'tests': ['tp5n']}}, 05:05:15 INFO - 'talos.zip': {'path': '', 05:05:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:05:15 INFO - Running post-action listener: _resource_record_post_action 05:05:15 INFO - [mozharness: 2016-11-17 13:05:15.388075Z] Finished populate-webroot step (success) 05:05:15 INFO - [mozharness: 2016-11-17 13:05:15.388163Z] Running create-virtualenv step. 05:05:15 INFO - Running pre-action listener: _resource_record_pre_action 05:05:15 INFO - Running main action method: create_virtualenv 05:05:15 INFO - Creating virtualenv /builds/slave/test/build/venv 05:05:15 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:05:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:05:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:05:15 INFO - Using real prefix '/usr' 05:05:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:05:15 INFO - Installing distribute.............................................................................................................................................................................................done. 05:05:17 INFO - Installing pip.................done. 05:05:17 INFO - Return code: 0 05:05:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:05:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:05:18 INFO - Reading from file tmpfile_stdout 05:05:18 INFO - Output received: 05:05:18 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:05:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:05:18 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:05:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:18 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:05:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:18 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 0x7f16d6425e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9fb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x113b130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c9fc0>, '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 0x11caec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11cb350>, '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': '32c5991c409366f7fec8a718000001d2-1479386971.676950-1929419083', '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:05:18 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:05:18 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:05:18 INFO - Using env: {'DISPLAY': ':0', 05:05:18 INFO - 'HOME': '/home/cltbld', 05:05:18 INFO - 'LANG': 'en_US.UTF-8', 05:05:18 INFO - 'LANGUAGE': 'en_US:en', 05:05:18 INFO - 'LOGNAME': 'cltbld', 05:05:18 INFO - 'MAIL': '/var/mail/cltbld', 05:05:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:18 INFO - 'MOZ_NO_REMOTE': '1', 05:05:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:05:18 INFO - 'NO_EM_RESTART': '1', 05:05:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:05:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:18 INFO - 'PWD': '/builds/slave/test', 05:05:18 INFO - 'SHELL': '/bin/bash', 05:05:18 INFO - 'SHLVL': '1', 05:05:18 INFO - 'TERM': 'linux', 05:05:18 INFO - 'TMOUT': '86400', 05:05:18 INFO - 'USER': 'cltbld', 05:05:18 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1479386971.676950-1929419083', 05:05:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:18 INFO - '_': '/tools/buildbot/bin/python'} 05:05:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:18 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:05:18 INFO - Cleaning up... 05:05:18 INFO - Return code: 0 05:05:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:05:18 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:05:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:18 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:05:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:18 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 0x7f16d6425e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9fb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x113b130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c9fc0>, '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 0x11caec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11cb350>, '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': '32c5991c409366f7fec8a718000001d2-1479386971.676950-1929419083', '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:05:18 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:05:18 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:05:18 INFO - Using env: {'DISPLAY': ':0', 05:05:18 INFO - 'HOME': '/home/cltbld', 05:05:18 INFO - 'LANG': 'en_US.UTF-8', 05:05:18 INFO - 'LANGUAGE': 'en_US:en', 05:05:18 INFO - 'LOGNAME': 'cltbld', 05:05:18 INFO - 'MAIL': '/var/mail/cltbld', 05:05:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:18 INFO - 'MOZ_NO_REMOTE': '1', 05:05:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:05:18 INFO - 'NO_EM_RESTART': '1', 05:05:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:05:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:18 INFO - 'PWD': '/builds/slave/test', 05:05:18 INFO - 'SHELL': '/bin/bash', 05:05:18 INFO - 'SHLVL': '1', 05:05:18 INFO - 'TERM': 'linux', 05:05:18 INFO - 'TMOUT': '86400', 05:05:18 INFO - 'USER': 'cltbld', 05:05:18 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1479386971.676950-1929419083', 05:05:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:18 INFO - '_': '/tools/buildbot/bin/python'} 05:05:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:18 INFO - Downloading/unpacking psutil>=3.1.1 05:05: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:05: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:05: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:05: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:05: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:05: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:05:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:05:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:05:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:05:20 INFO - Installing collected packages: psutil 05:05:20 INFO - Running setup.py install for psutil 05:05:20 INFO - building 'psutil._psutil_linux' extension 05:05:20 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:05:20 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:05:20 INFO - building 'psutil._psutil_posix' extension 05:05:20 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:05:21 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:05:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:05:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:05:21 INFO - Successfully installed psutil 05:05:21 INFO - Cleaning up... 05:05:21 INFO - Return code: 0 05:05:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:05: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:05:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05: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:05:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f16d6425e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9fb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x113b130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c9fc0>, '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 0x11caec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11cb350>, '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': '32c5991c409366f7fec8a718000001d2-1479386971.676950-1929419083', '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:05:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:05:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:05:21 INFO - Using env: {'DISPLAY': ':0', 05:05:21 INFO - 'HOME': '/home/cltbld', 05:05:21 INFO - 'LANG': 'en_US.UTF-8', 05:05:21 INFO - 'LANGUAGE': 'en_US:en', 05:05:21 INFO - 'LOGNAME': 'cltbld', 05:05:21 INFO - 'MAIL': '/var/mail/cltbld', 05:05:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:21 INFO - 'MOZ_NO_REMOTE': '1', 05:05:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:05:21 INFO - 'NO_EM_RESTART': '1', 05:05:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:05:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:21 INFO - 'PWD': '/builds/slave/test', 05:05:21 INFO - 'SHELL': '/bin/bash', 05:05:21 INFO - 'SHLVL': '1', 05:05:21 INFO - 'TERM': 'linux', 05:05:21 INFO - 'TMOUT': '86400', 05:05:21 INFO - 'USER': 'cltbld', 05:05:21 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1479386971.676950-1929419083', 05:05:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:21 INFO - '_': '/tools/buildbot/bin/python'} 05:05:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:05:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:05:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:05:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:05:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:05:23 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:05:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:05:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:05:23 INFO - Installing collected packages: mozsystemmonitor 05:05:23 INFO - Running setup.py install for mozsystemmonitor 05:05:23 INFO - Successfully installed mozsystemmonitor 05:05:23 INFO - Cleaning up... 05:05:23 INFO - Return code: 0 05:05:23 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:05:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:05:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:05:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:23 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 0x7f16d6425e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9fb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x113b130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c9fc0>, '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 0x11caec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11cb350>, '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': '32c5991c409366f7fec8a718000001d2-1479386971.676950-1929419083', '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:05:23 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:05:23 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:05:23 INFO - Using env: {'DISPLAY': ':0', 05:05:23 INFO - 'HOME': '/home/cltbld', 05:05:23 INFO - 'LANG': 'en_US.UTF-8', 05:05:23 INFO - 'LANGUAGE': 'en_US:en', 05:05:23 INFO - 'LOGNAME': 'cltbld', 05:05:23 INFO - 'MAIL': '/var/mail/cltbld', 05:05:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:23 INFO - 'MOZ_NO_REMOTE': '1', 05:05:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:05:23 INFO - 'NO_EM_RESTART': '1', 05:05:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:05:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:23 INFO - 'PWD': '/builds/slave/test', 05:05:23 INFO - 'SHELL': '/bin/bash', 05:05:23 INFO - 'SHLVL': '1', 05:05:23 INFO - 'TERM': 'linux', 05:05:23 INFO - 'TMOUT': '86400', 05:05:23 INFO - 'USER': 'cltbld', 05:05:23 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1479386971.676950-1929419083', 05:05:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:23 INFO - '_': '/tools/buildbot/bin/python'} 05:05:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:23 INFO - Downloading/unpacking jsonschema==2.5.1 05:05:23 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:05:23 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:05:23 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:05:23 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:05:23 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:05:23 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:05:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:05:25 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:05:25 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:05:25 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:05:25 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:05:25 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:05:25 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:05:25 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:05:25 INFO - Downloading functools32-3.2.3-2.tar.gz 05:05:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:05:25 INFO - warning: no files found matching '*.txt' 05:05:25 INFO - no previously-included directories found matching 'build' 05:05:25 INFO - no previously-included directories found matching 'dist' 05:05:25 INFO - no previously-included directories found matching '.git*' 05:05:26 INFO - Installing collected packages: jsonschema, functools32 05:05:26 INFO - Running setup.py install for functools32 05:05:26 INFO - warning: no files found matching '*.txt' 05:05:26 INFO - no previously-included directories found matching 'build' 05:05:26 INFO - no previously-included directories found matching 'dist' 05:05:26 INFO - no previously-included directories found matching '.git*' 05:05:26 INFO - Successfully installed jsonschema functools32 05:05:26 INFO - Cleaning up... 05:05:26 INFO - Return code: 0 05:05:26 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:05:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:05:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:05:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f16d6425e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9fb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x113b130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c9fc0>, '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 0x11caec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11cb350>, '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': '32c5991c409366f7fec8a718000001d2-1479386971.676950-1929419083', '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:05:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:05:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 05:05:26 INFO - Using env: {'DISPLAY': ':0', 05:05:26 INFO - 'HOME': '/home/cltbld', 05:05:26 INFO - 'LANG': 'en_US.UTF-8', 05:05:26 INFO - 'LANGUAGE': 'en_US:en', 05:05:26 INFO - 'LOGNAME': 'cltbld', 05:05:26 INFO - 'MAIL': '/var/mail/cltbld', 05:05:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:26 INFO - 'MOZ_NO_REMOTE': '1', 05:05:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:05:26 INFO - 'NO_EM_RESTART': '1', 05:05:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:05:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:26 INFO - 'PWD': '/builds/slave/test', 05:05:26 INFO - 'SHELL': '/bin/bash', 05:05:26 INFO - 'SHLVL': '1', 05:05:26 INFO - 'TERM': 'linux', 05:05:26 INFO - 'TMOUT': '86400', 05:05:26 INFO - 'USER': 'cltbld', 05:05:26 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1479386971.676950-1929419083', 05:05:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:26 INFO - '_': '/tools/buildbot/bin/python'} 05:05:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:26 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:05:26 INFO - Cleaning up... 05:05:26 INFO - Return code: 0 05:05:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:05:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:05:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:05:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f16d6425e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9fb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x113b130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c9fc0>, '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 0x11caec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11cb350>, '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': '32c5991c409366f7fec8a718000001d2-1479386971.676950-1929419083', '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:05:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:05:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:05:26 INFO - Using env: {'DISPLAY': ':0', 05:05:26 INFO - 'HOME': '/home/cltbld', 05:05:26 INFO - 'LANG': 'en_US.UTF-8', 05:05:26 INFO - 'LANGUAGE': 'en_US:en', 05:05:26 INFO - 'LOGNAME': 'cltbld', 05:05:26 INFO - 'MAIL': '/var/mail/cltbld', 05:05:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:26 INFO - 'MOZ_NO_REMOTE': '1', 05:05:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:05:26 INFO - 'NO_EM_RESTART': '1', 05:05:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:05:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:26 INFO - 'PWD': '/builds/slave/test', 05:05:26 INFO - 'SHELL': '/bin/bash', 05:05:26 INFO - 'SHLVL': '1', 05:05:26 INFO - 'TERM': 'linux', 05:05:26 INFO - 'TMOUT': '86400', 05:05:26 INFO - 'USER': 'cltbld', 05:05:26 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1479386971.676950-1929419083', 05:05:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:26 INFO - '_': '/tools/buildbot/bin/python'} 05:05:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:26 INFO - Downloading/unpacking blobuploader==1.2.4 05:05: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:05: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:05: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:05: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:05: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:05: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:05:28 INFO - Downloading blobuploader-1.2.4.tar.gz 05:05:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:05:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:05:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:05:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:05:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:05:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:05:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:05:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:05:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:05:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:05:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:05:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:05:29 INFO - Downloading docopt-0.6.1.tar.gz 05:05:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:05:29 INFO - Installing collected packages: blobuploader, requests, docopt 05:05:29 INFO - Running setup.py install for blobuploader 05:05:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:05:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:05:29 INFO - Running setup.py install for requests 05:05:29 INFO - Running setup.py install for docopt 05:05:29 INFO - Successfully installed blobuploader requests docopt 05:05:29 INFO - Cleaning up... 05:05:29 INFO - Return code: 0 05:05:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:05:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:05:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:05:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:29 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 0x7f16d6425e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9fb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x113b130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c9fc0>, '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 0x11caec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11cb350>, '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': '32c5991c409366f7fec8a718000001d2-1479386971.676950-1929419083', '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:05:29 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:05:29 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:05:29 INFO - Using env: {'DISPLAY': ':0', 05:05:29 INFO - 'HOME': '/home/cltbld', 05:05:29 INFO - 'LANG': 'en_US.UTF-8', 05:05:29 INFO - 'LANGUAGE': 'en_US:en', 05:05:29 INFO - 'LOGNAME': 'cltbld', 05:05:29 INFO - 'MAIL': '/var/mail/cltbld', 05:05:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:29 INFO - 'MOZ_NO_REMOTE': '1', 05:05:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:05:29 INFO - 'NO_EM_RESTART': '1', 05:05:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:05:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:29 INFO - 'PWD': '/builds/slave/test', 05:05:29 INFO - 'SHELL': '/bin/bash', 05:05:29 INFO - 'SHLVL': '1', 05:05:29 INFO - 'TERM': 'linux', 05:05:29 INFO - 'TMOUT': '86400', 05:05:29 INFO - 'USER': 'cltbld', 05:05:29 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1479386971.676950-1929419083', 05:05:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:29 INFO - '_': '/tools/buildbot/bin/python'} 05:05:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:05:30 INFO - Running setup.py (path:/tmp/pip-YLB2_b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:05:30 INFO - Running setup.py (path:/tmp/pip-IIDtvx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:05:30 INFO - Running setup.py (path:/tmp/pip-lIdzTx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:05:30 INFO - Running setup.py (path:/tmp/pip-TQqwkj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:05:30 INFO - Running setup.py (path:/tmp/pip-pG8LFd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:05:30 INFO - Running setup.py (path:/tmp/pip-uctMcv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:05:30 INFO - Running setup.py (path:/tmp/pip-VN2VER-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:05:30 INFO - Running setup.py (path:/tmp/pip-aavxtM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:05:30 INFO - Running setup.py (path:/tmp/pip-w0kD4h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:05:30 INFO - Running setup.py (path:/tmp/pip-E59_e0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:05:30 INFO - Running setup.py (path:/tmp/pip-CMgkol-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:05:30 INFO - Running setup.py (path:/tmp/pip-iPkp0l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:05:31 INFO - Running setup.py (path:/tmp/pip-diMNLy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:05:31 INFO - Running setup.py (path:/tmp/pip-AwIOba-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:05:31 INFO - Running setup.py (path:/tmp/pip-HNp5wG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:05:31 INFO - Running setup.py (path:/tmp/pip-QgSGHo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:05:31 INFO - Running setup.py (path:/tmp/pip-d39_xH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:05:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:05:31 INFO - Running setup.py install for manifestparser 05:05:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:05:31 INFO - Running setup.py install for mozcrash 05:05:31 INFO - Running setup.py install for mozdebug 05:05:31 INFO - Running setup.py install for mozdevice 05:05:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:05:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:05:31 INFO - Running setup.py install for mozfile 05:05:31 INFO - Running setup.py install for mozhttpd 05:05:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:05:32 INFO - Running setup.py install for mozinfo 05:05:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:05:32 INFO - Running setup.py install for mozInstall 05:05:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:05:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:05:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:05:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:05:32 INFO - Running setup.py install for mozleak 05:05:32 INFO - Running setup.py install for mozlog 05:05:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:05:32 INFO - Running setup.py install for moznetwork 05:05:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:05:32 INFO - Running setup.py install for mozprocess 05:05:32 INFO - Running setup.py install for mozprofile 05:05:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:05:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:05:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:05:32 INFO - Running setup.py install for mozrunner 05:05:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:05:32 INFO - Running setup.py install for mozscreenshot 05:05:32 INFO - Running setup.py install for moztest 05:05:33 INFO - Running setup.py install for mozversion 05:05:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:05:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:05:33 INFO - Cleaning up... 05:05:33 INFO - Return code: 0 05:05:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:05:33 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:05:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:33 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:05:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:33 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 0x7f16d6425e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9fb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x113b130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c9fc0>, '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 0x11caec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11cb350>, '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': '32c5991c409366f7fec8a718000001d2-1479386971.676950-1929419083', '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:05:33 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:05:33 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:05:33 INFO - Using env: {'DISPLAY': ':0', 05:05:33 INFO - 'HOME': '/home/cltbld', 05:05:33 INFO - 'LANG': 'en_US.UTF-8', 05:05:33 INFO - 'LANGUAGE': 'en_US:en', 05:05:33 INFO - 'LOGNAME': 'cltbld', 05:05:33 INFO - 'MAIL': '/var/mail/cltbld', 05:05:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:33 INFO - 'MOZ_NO_REMOTE': '1', 05:05:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:05:33 INFO - 'NO_EM_RESTART': '1', 05:05:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:05:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:33 INFO - 'PWD': '/builds/slave/test', 05:05:33 INFO - 'SHELL': '/bin/bash', 05:05:33 INFO - 'SHLVL': '1', 05:05:33 INFO - 'TERM': 'linux', 05:05:33 INFO - 'TMOUT': '86400', 05:05:33 INFO - 'USER': 'cltbld', 05:05:33 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1479386971.676950-1929419083', 05:05:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:33 INFO - '_': '/tools/buildbot/bin/python'} 05:05:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:05:33 INFO - Running setup.py (path:/tmp/pip-p9vN3j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:05:33 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:05:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:05:33 INFO - Running setup.py (path:/tmp/pip-lupB_I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:05:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:05:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:05:33 INFO - Running setup.py (path:/tmp/pip-Dduiru-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:05:33 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:05:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:05:33 INFO - Running setup.py (path:/tmp/pip-TdKOby-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:05:33 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:05:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:05:33 INFO - Running setup.py (path:/tmp/pip-OWTEYY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:05:33 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:05:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:05:33 INFO - Running setup.py (path:/tmp/pip-6f9vE9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:05:33 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:05:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:05:33 INFO - Running setup.py (path:/tmp/pip-4TRCSv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:05:33 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:05:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:05:33 INFO - Running setup.py (path:/tmp/pip-PMQX8I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:05:34 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:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:05:34 INFO - Running setup.py (path:/tmp/pip-Gxx9pJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:05:34 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:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:05:34 INFO - Running setup.py (path:/tmp/pip-RdTNqD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:05:34 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:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:05:34 INFO - Running setup.py (path:/tmp/pip-Sz6Qib-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:05:34 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:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:05:34 INFO - Running setup.py (path:/tmp/pip-sV4cT5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:05:34 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:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:05:34 INFO - Running setup.py (path:/tmp/pip-dxsul_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:05:34 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:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:05:34 INFO - Running setup.py (path:/tmp/pip-6LLaaW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:05:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:05:34 INFO - Running setup.py (path:/tmp/pip-CNxV8_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:05:34 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:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:05:34 INFO - Running setup.py (path:/tmp/pip-9oo8xd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:05:34 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:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:05:34 INFO - Running setup.py (path:/tmp/pip-dw_p2q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:05:34 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:05:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:05:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:05:34 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:05:34 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:05:34 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:05:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:05:34 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:05:34 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:05:34 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:05:34 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:05:34 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:05:34 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:05:36 INFO - Downloading blessings-1.6.tar.gz 05:05:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:05:36 INFO - Installing collected packages: blessings 05:05:36 INFO - Running setup.py install for blessings 05:05:36 INFO - Successfully installed blessings 05:05:36 INFO - Cleaning up... 05:05:36 INFO - Return code: 0 05:05:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:05:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:05:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:05:37 INFO - Reading from file tmpfile_stdout 05:05:37 INFO - Current package versions: 05:05:37 INFO - argparse == 1.2.1 05:05:37 INFO - blessings == 1.6 05:05:37 INFO - blobuploader == 1.2.4 05:05:37 INFO - docopt == 0.6.1 05:05:37 INFO - functools32 == 3.2.3-2 05:05:37 INFO - jsonschema == 2.5.1 05:05:37 INFO - manifestparser == 1.1 05:05:37 INFO - mozInstall == 1.12 05:05:37 INFO - mozcrash == 1.0 05:05:37 INFO - mozdebug == 0.1 05:05:37 INFO - mozdevice == 0.48 05:05:37 INFO - mozfile == 1.2 05:05:37 INFO - mozhttpd == 0.7 05:05:37 INFO - mozinfo == 0.9 05:05:37 INFO - mozleak == 0.1 05:05:37 INFO - mozlog == 3.4 05:05:37 INFO - moznetwork == 0.27 05:05:37 INFO - mozprocess == 0.23 05:05:37 INFO - mozprofile == 0.28 05:05:37 INFO - mozrunner == 6.13 05:05:37 INFO - mozscreenshot == 0.1 05:05:37 INFO - mozsystemmonitor == 0.3 05:05:37 INFO - moztest == 0.7 05:05:37 INFO - mozversion == 1.4 05:05:37 INFO - psutil == 3.1.1 05:05:37 INFO - requests == 1.2.3 05:05:37 INFO - wsgiref == 0.1.2 05:05:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:05:37 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:05:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:37 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:05:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:37 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 0x7f16d6425e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9fb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x113b130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c9fc0>, '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 0x11caec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11cb350>, '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': '32c5991c409366f7fec8a718000001d2-1479386971.676950-1929419083', '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:05:37 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:05:37 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:05:37 INFO - Using env: {'DISPLAY': ':0', 05:05:37 INFO - 'HOME': '/home/cltbld', 05:05:37 INFO - 'LANG': 'en_US.UTF-8', 05:05:37 INFO - 'LANGUAGE': 'en_US:en', 05:05:37 INFO - 'LOGNAME': 'cltbld', 05:05:37 INFO - 'MAIL': '/var/mail/cltbld', 05:05:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:37 INFO - 'MOZ_NO_REMOTE': '1', 05:05:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:05:37 INFO - 'NO_EM_RESTART': '1', 05:05:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:05:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:37 INFO - 'PWD': '/builds/slave/test', 05:05:37 INFO - 'SHELL': '/bin/bash', 05:05:37 INFO - 'SHLVL': '1', 05:05:37 INFO - 'TERM': 'linux', 05:05:37 INFO - 'TMOUT': '86400', 05:05:37 INFO - 'USER': 'cltbld', 05:05:37 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1479386971.676950-1929419083', 05:05:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:37 INFO - '_': '/tools/buildbot/bin/python'} 05:05:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:37 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:05:37 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:05:37 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:05:37 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:05:37 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:05:37 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:05:37 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:05:37 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:05:37 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:05:37 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:05:37 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:05:37 INFO - Cleaning up... 05:05:37 INFO - Return code: 0 05:05:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:05:37 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:05:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:37 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:05:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:37 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 0x7f16d6425e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9fb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x113b130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c9fc0>, '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 0x11caec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11cb350>, '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': '32c5991c409366f7fec8a718000001d2-1479386971.676950-1929419083', '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:05:37 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:05:37 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:05:37 INFO - Using env: {'DISPLAY': ':0', 05:05:37 INFO - 'HOME': '/home/cltbld', 05:05:37 INFO - 'LANG': 'en_US.UTF-8', 05:05:37 INFO - 'LANGUAGE': 'en_US:en', 05:05:37 INFO - 'LOGNAME': 'cltbld', 05:05:37 INFO - 'MAIL': '/var/mail/cltbld', 05:05:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:37 INFO - 'MOZ_NO_REMOTE': '1', 05:05:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:05:37 INFO - 'NO_EM_RESTART': '1', 05:05:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:05:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:37 INFO - 'PWD': '/builds/slave/test', 05:05:37 INFO - 'SHELL': '/bin/bash', 05:05:37 INFO - 'SHLVL': '1', 05:05:37 INFO - 'TERM': 'linux', 05:05:37 INFO - 'TMOUT': '86400', 05:05:37 INFO - 'USER': 'cltbld', 05:05:37 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1479386971.676950-1929419083', 05:05:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:37 INFO - '_': '/tools/buildbot/bin/python'} 05:05:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:37 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:05:37 INFO - Cleaning up... 05:05:37 INFO - Return code: 0 05:05:37 INFO - Running post-action listener: _resource_record_post_action 05:05:37 INFO - Running post-action listener: _start_resource_monitoring 05:05:37 INFO - Starting resource monitoring. 05:05:37 INFO - [mozharness: 2016-11-17 13:05:37.556960Z] Finished create-virtualenv step (success) 05:05:37 INFO - [mozharness: 2016-11-17 13:05:37.557480Z] Running install step. 05:05:37 INFO - Running pre-action listener: _resource_record_pre_action 05:05:37 INFO - Running main action method: install 05:05:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:05:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:05:37 INFO - Reading from file tmpfile_stdout 05:05:37 INFO - Detecting whether we're running mozinstall >=1.0... 05:05:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:05:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:05:37 INFO - Reading from file tmpfile_stdout 05:05:37 INFO - Output received: 05:05:37 INFO - Usage: mozinstall [options] installer 05:05:37 INFO - Options: 05:05:37 INFO - -h, --help show this help message and exit 05:05:37 INFO - -d DEST, --destination=DEST 05:05:37 INFO - Directory to install application into. [default: 05:05:37 INFO - "/builds/slave/test"] 05:05:37 INFO - --app=APP Application being installed. [default: firefox] 05:05:37 INFO - mkdir: /builds/slave/test/build/application 05:05:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:05:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:05:53 INFO - Reading from file tmpfile_stdout 05:05:53 INFO - Output received: 05:05:53 INFO - /builds/slave/test/build/application/firefox/firefox 05:05:53 INFO - Running post-action listener: _resource_record_post_action 05:05:53 INFO - [mozharness: 2016-11-17 13:05:53.913511Z] Finished install step (success) 05:05:53 INFO - [mozharness: 2016-11-17 13:05:53.913766Z] Running run-tests step. 05:05:53 INFO - Running pre-action listener: _resource_record_pre_action 05:05:53 INFO - Running main action method: run_tests 05:05:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:05:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:05:53 INFO - Python 2.7.3 05:05:53 INFO - Return code: 0 05:05:53 INFO - grabbing minidump binary from tooltool 05:05:53 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:05:53 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 0x11c9fc0>, '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 0x11caec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11cb350>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:05:53 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:05:53 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:05:53 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:05:53 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:05:53 INFO - Return code: 0 05:05:53 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:05:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:05:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:05:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:05:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:05:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Cedar', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YTRb5Uh2T-m1hqgN9Iv_sQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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:05:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Cedar --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YTRb5Uh2T-m1hqgN9Iv_sQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-008 --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:05:53 INFO - Using env: {'DISPLAY': ':0', 05:05:53 INFO - 'HOME': '/home/cltbld', 05:05:53 INFO - 'LANG': 'en_US.UTF-8', 05:05:53 INFO - 'LANGUAGE': 'en_US:en', 05:05:53 INFO - 'LOGNAME': 'cltbld', 05:05:53 INFO - 'MAIL': '/var/mail/cltbld', 05:05:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:05:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:05:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:53 INFO - 'MOZ_NO_REMOTE': '1', 05:05:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:05:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:05:53 INFO - 'NO_EM_RESTART': '1', 05:05:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:05:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:53 INFO - 'PWD': '/builds/slave/test', 05:05:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:05:54 INFO - 'SHELL': '/bin/bash', 05:05:54 INFO - 'SHLVL': '1', 05:05:54 INFO - 'TERM': 'linux', 05:05:54 INFO - 'TMOUT': '86400', 05:05:54 INFO - 'USER': 'cltbld', 05:05:54 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1479386971.676950-1929419083', 05:05:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:54 INFO - '_': '/tools/buildbot/bin/python'} 05:05:54 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Cedar', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YTRb5Uh2T-m1hqgN9Iv_sQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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:05:54 INFO - mozversion application_buildid: 20161117034731 05:05:54 INFO - mozversion application_changeset: 76094c82d70cebcf7e596a43a96585cf3100d64b 05:05:54 INFO - mozversion application_display_name: Nightly 05:05:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:05:54 INFO - mozversion application_name: Firefox 05:05:54 INFO - mozversion application_remotingname: firefox 05:05:54 INFO - mozversion application_repository: https://hg.mozilla.org/projects/cedar 05:05:54 INFO - mozversion application_vendor: Mozilla 05:05:54 INFO - mozversion application_version: 53.0a1 05:05:54 INFO - mozversion platform_buildid: 20161117034731 05:05:54 INFO - mozversion platform_changeset: 76094c82d70cebcf7e596a43a96585cf3100d64b 05:05:54 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/cedar 05:05:54 INFO - mozversion platform_version: 53.0a1 05:05:54 INFO - using testdate: 1479387954 05:05:54 INFO - actual date: 1479387954 05:05:54 INFO - starting webserver on 'localhost:47671' 05:05:54 INFO - SUITE-START | Running 2 tests 05:05:54 INFO - TEST-START | dromaeo_css 05:05:54 INFO - operating with platform_type : linux_ 05:05:54 INFO - Initialising browser for dromaeo_css test... 05:05:54 INFO - TEST-INFO | started process 4075 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1CE8oX/profile http://localhost:47671/getInfo.html) 05:05:58 INFO - PROCESS | 4075 | __metrics Screen width/height:1600/1200 05:05:58 INFO - PROCESS | 4075 | colorDepth:24 05:05:58 INFO - PROCESS | 4075 | Browser inner width/height: 1024/697 05:05:58 INFO - PROCESS | 4075 | __metrics 05:05:59 INFO - PROCESS | 4075 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:05:59 INFO - PROCESS | 4075 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:05:59 INFO - PROCESS | 4075 | console.error: PushService: 05:05:59 INFO - PROCESS | 4075 | stateChangeProcessEnqueue: Error transitioning state 05:05:59 INFO - PROCESS | 4075 | UnknownError 05:06:00 INFO - TEST-INFO | 4075: exit 0 05:06:00 INFO - Browser initialized. 05:06:00 INFO - Running cycle 1/1 for dromaeo_css test... 05:06:00 INFO - TEST-INFO | started process 4159 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1CE8oX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:06:12 INFO - PROCESS | 4159 | RSS: Main: 174809088 05:06:12 INFO - PROCESS | 4159 | 05:07:04 INFO - PROCESS | 4159 | 1479388024488 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:09:16 INFO - PROCESS | 4159 | Cycle 1(1): loaded http://localhost:47671/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47671/tests/dromaeo/cssquery-ext.html) 05:09:19 INFO - PROCESS | 4159 | RSS: Main: 398487552 05:09:19 INFO - PROCESS | 4159 | 05:12:21 INFO - PROCESS | 4159 | Cycle 1(1): loaded http://localhost:47671/tests/dromaeo/cssquery-ext.html (next: http://localhost:47671/tests/dromaeo/cssquery-jquery.html) 05:12:22 INFO - PROCESS | 4159 | RSS: Main: 281702400 05:12:22 INFO - PROCESS | 4159 | 05:15:24 INFO - PROCESS | 4159 | Cycle 1(1): loaded http://localhost:47671/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47671/tests/dromaeo/cssquery-mootools.html) 05:15:25 INFO - PROCESS | 4159 | RSS: Main: 241774592 05:15:25 INFO - PROCESS | 4159 | 05:18:27 INFO - PROCESS | 4159 | Cycle 1(1): loaded http://localhost:47671/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47671/tests/dromaeo/cssquery-prototype.html) 05:18:28 INFO - PROCESS | 4159 | RSS: Main: 220733440 05:18:28 INFO - PROCESS | 4159 | 05:21:31 INFO - PROCESS | 4159 | Cycle 1(1): loaded http://localhost:47671/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47671/tests/dromaeo/cssquery-yui.html) 05:21:32 INFO - PROCESS | 4159 | RSS: Main: 219422720 05:21:32 INFO - PROCESS | 4159 | 05:24:35 INFO - PROCESS | 4159 | Cycle 1(1): loaded http://localhost:47671/tests/dromaeo/cssquery-yui.html (next: http://localhost:47671/tests/dromaeo/cssquery-dojo.html) 05:24:35 INFO - PROCESS | 4159 | RSS: Main: 317100032 05:24:35 INFO - PROCESS | 4159 | 05:24:35 INFO - PROCESS | 4159 | __start_tp_report 05:24:35 INFO - PROCESS | 4159 | _x_x_mozilla_page_load 05:24:35 INFO - PROCESS | 4159 | _x_x_mozilla_page_load_details 05:24:35 INFO - PROCESS | 4159 | |i|pagename|runs| 05:24:35 INFO - PROCESS | 4159 | |0;dojo.html;2574.703909050459;2595.7274486178962;2613.9085132020377;2629.487249986252;2640.709521952585;4636.304554316855;4693.202155633542;4730.479647238805;4738.976305118478;4751.928721069183;4669.953300466995;4736.952630473695;4750.596199323053;4755.334253204554;4796.400449943757;4288.914221715564;4372.825086996532;4415.337699345092;4431.158079964813;4439.733615983036;4441.444819397575;4481;4481.887952801189;4482.125985432842;4483.484399294074;4202.537720850704;4417.933730994037;4426.380306757057;4454.621357184627;4520.570545798144;4237.300845360543;4269.658427325807;4318.805653745589;4375.562443755631;4382.561743825592;4261.509926358477;4303.33298338758;4305.74165550068;4345.196138714348;4369.563043695637;4716.693414928053;4736.905261894777;4742.691725037896;4776.402949631296;4778.307145463888;4883.9511604883855;4933.407991041062;4940.1601727706375;4998;5055.898882022376;5106.183010718304;5148.176291793295;5156.871078223037;5174.353205849269;5199.584033277367;4794.376731024944;4802.207635740098;4806.903861922812;4807.134715751198;4845.515448455127;5020.3724534433195;5086.109930762102;5239.050384696004;5241.895162096736;5248.212768084818;4910.091633047898;4949.57928576075;4956.727379994063;4957.380327459067;4961.627877909099;4989.750512474362;5030.8239211627415;5038.042771873405;5048;5118.897622047538;4991.126552853236;5025.949740502549;5038.571721403721;5043.36957880265;5092.668976516515;5000.62495312853;5026.572741316956;5026.673266237683;5030.89938201234;5065.366829146356;4142.130152667974;4240.766757828287;4241.066965267636;4299.398084268205;4332.740035597874;3781.5840257571645;3790.7915064671706;3801.9809900950318;3828.004718773139;3834.9616503835164;4423.270160423494;4425.6238219751685;4426.402435671143;4429.9778501107285;4473.194824931544;4921.311016457699;4931.827386041471;4990.276409920614;5112.9744351278005;5159.17453207485;4400.779961002001;4420.381146639473;4432.734035957853;4468.195724769573;4509.053098849278;4634.606058485067;4635.745034023161;4635.860924172212;4636.744979026119;4687.414073240845;4605.171069207575;4818.975905120452;4828.613710903049;4836.153673107122;4885.096257192502;4955.058538877602;5039.143345631178;5106.617003724661;5145.253938178868;5148.176291793295;4822.927656085091;4823.397075365579;4831.4685384608365;4857.222844344888;4885.877853053702;5082.771275292546;5089.312942752681;5090.949090509048;5095.923561146512;5096.413912399973;4873.488283730299;4972.030454061423;4974.875628109182;5001.499850015115;5208.218767184952;4879.146149423766;4894.706317620954;4908.6073114151495;4909;4909.214525675875;4897.730624815669;4901.387326584177;4901.90196196067;4904.190808516555;4907.190313598359;4794.352762377034;4808.975955120202;4809.831655892027;4812.614990800797;4814.422269327703;4893.828715995065;4923.138450771173;4936.3829521309835;4936.901261974668;4945.184044632595;4825.276208568743;4833.758312084311;4833.927491087707;4835.58897493717;4843.0313937213405 05:24:35 INFO - PROCESS | 4159 | |1;ext.html;545.5553723715171;563.918231856381;575.5625724449417;577.1832856508041;593.3621357041181;27254.727452725467;28452.715472845266;28591.285217869565;30445;30467.84766076172;27905.86047069767;27972.3006924827;27997.58003629947;28281.15156545302;28334.858325708396;5275.762590683428;5413.350397952231;5413.675179489223;5455.454454554552;5461.317335333083;5544.251526043993;5611.130274807411;5614.494695477406;5614.775408983635;5617.241672374218;5605.5515558755405;5619.5785316101255;5629.662220266777;5633.57748168889;5634.3802181759975;5618.0449323615085;5641.774329026834;5658.603897727161;5658.632188907708;5659.915101273484;5589.385167631557;5645.237892884449;5647.124695672177;5648.03983322832;5649.870025994817;25848;26072.60891086635;26344;26373;26374.47251054968;3073.3545955349405;3078.1996680862912;3088.459519584064;3097.1482842218343;3110.2690867646083;18200.726989095176;18226.726599101024;18248.270069197217;18379.72430413545;18739.625207495774;2471.159805666064;2552.6043463263222;2596.1692258477296;2600.0128713508416;2755.3249453883727;243252;243624;245128;246143;246209;50858.491415086115;51228;51390.22914656283;51427.48572514227;51543.226851597254;31208.687913121033;32194.678053219635;32285.51571726426;34374.48438273428;55755;13801.51694690681;14014.089084209698;14017.509387171604;14020;14024.71950560983;9637.325387222827;9696.36973596728;9708.951455242819;9712.3201375903;9733.659321923698;17100.315987360365;17122.555241302794;17159;17198;17298.481045568402;6594.340565943367;6601.76893808724;6650.86698266032;6671.933280667228;6771.153605799275;815.2255357410484;844.1995957354005;861.7802460372565;955.8327292723745;985.2462865907586;25545.23364299074;25614.359641008752;25653;26121.608175877376;26164.738352616612;953.3421938862163;955.7276176289724;959.5490119643756;970.8592254123113;979.9755006124761;13282.867171328357;13776.655583610289;14061.226632535105;14087.22520261375;14238.928805355907;283632;286459;286546;286728;286962;40765.796171018956;41102.779444110696;41132.58867411288;41280.793596032425;41304.79347603243;1034.886162522122;1100.5157730598512;1128.9774204516027;1154.076738609126;1160.1067178272683;23728.169514066925;25772.742272577783;26663.867100599437;27096.32259193536;27176.320591985357;40036;40463.797681011405;40579.79710101431;40596.59403405928;40629.1874162521;265257;266408;267178;267259;267929;20078;20879.686804698245;22154.66767998449;22685.886570567043;22986.655200172347;36072.639273606925;36515.63484365122;36679.81660091683;37021.81489092537;37655;31408.842955785076;31726.365472689955;31747.682523174473;31881.68118318787;32076.679233208302;30928.53607195939;31027.379452410372;32058.519122213653;32121.10318934382;32468;31287.374252515277;31907.840460797546;32206.19484512906;32208.83895580507;32216.83891580527;26839;29122;29386;29504.114876553736;29632.703672962994;22983.770162298162;23002.53994920059;23043.76956230483;23160.768392316535;23182.884085579462 05:24:35 INFO - PROCESS | 4159 | |2;jquery.html;346.96877281044704;357.51378125748977;362.59389483778153;368.40134780980907;391.54385141310377;9590.664326748565;10355.948220258908;11462.369569673676;11712.590059347924;12262.693432664188;15688.607784805386;16138.273777680004;16182.7572586411;16259.51221463355;16313.655700581381;3957.2283404736017;4231.936520952188;4258.893527661802;4271.6155546000855;4273.679474039444;3971.066799302176;4077.3476243800997;4105.178964207155;4134.958650413502;4165.250254954107;4120.072983578701;4121.587841215869;4125.257453658341;4126.587341265865;4126.8968275793195;3958.7426817256787;4097.528784189826;4101.384792281182;4101.835926562934;4108.917821643566;3810.2950954073585;3852.9614703852885;3853.383458646631;3855.4409610606585;3859.826307816155;16129.596760080974;16411;16478.505644830675;16634.50096497107;16722.66554668912;1872.4757068020976;1890.1022014543119;1997.0913234478278;2104.347652227799;2401.8438801477846;10731.463426828628;10919.836202456969;11093.944530277378;11342.886571134348;11504.712382190512;1410.6684929041667;1451;1530.900491468051;1544.2047345616904;1547.9845201547953;61733.07400388953;73747.63126184388;77791.61104194443;78349.60825195894;81580;15883.841161588467;16344.18279086041;16345.101019444044;16358;17449;28506.71493285082;28574.714252857204;28643.856780715963;28646.140615781558;28730.138095857157;8557.35819813504;8826.338024648177;8940.552972351357;9106.27149828012;9146.496942668084;7321.670524826395;7344.632768361561;7373.705051797868;7566.35685966699;7583.203763604853;6795.490338224653;8253.628586713612;8386.37102217324;8405.537695426689;8430.693242547415;3133.9031339031158;3265.9020229393154;3283.8522266498067;3320.7841490303053;3348.799072055636;816.2205094135087;822.6750433578703;844.2190973349627;861.6553378648591;885.9822803543893;16239.431619893483;16695.24871380791;16905.408310709066;17370.305187792346;17518.737218941726;846.1284876577135;853.8463076646264;872.376250980552;891.0457854329817;897.3808072430003;9382.765430864147;9493.572789224363;9570.085982803466;9625.51872406377;9833.655822046194;330817;343419;352311;352478;352728;73234;73472.63263683647;74111.25888741152;74981.62509187419;75940.62029689817;882.161946151159;887.6538150121457;909.3725329522608;912.9452232866049;930.6742640076054;14728.852711472748;15078.924605376902;15581.688366232385;15601.84398156004;15784.21078946071;38056.61943380531;38284.42573361346;38471.230575388894;39296.2140757189;39342;49887.75056124842;50856;51564;51581;51619;6474.838129046811;6909.2399836019;7143.357097861218;7203.351698347174;7238.674259658434;10101.393916365041;11610.88389116098;11878.643640690792;11908.702282442662;11961.401929903644;9713.465759383302;10258.846117308098;10412.27114102036;10514.684559462923;10743.677689669323;8825.205731484197;9429.952850235704;10465.267431279737;10488.842667359842;10536.57853685844;10168.28821982454;10302.52335145684;10317.638882639072;10401.375917444977;10873.293235939638;6702.497312701665;6864.7940561783225;6891.724331026703;7043.683034263573;7072.469564782559;8174.877376839233;9092.545372731469;9765.316427849983;9946.45294508809;10088 05:24:35 INFO - PROCESS | 4159 | |3;mootools.html;1220.9389530523472;1309.7773378525653;1341.02105463012;1381.9930900345503;1639.7130502162127;5576.637518561291;5972.492338151257;6096.969515152429;6383.2340119185765;6389.520785941061;6234.937650623492;6307.053941908716;6307.77922772703;6308.211473565804;6312.905306420407;1690.2140504665329;1723.8965662060255;1727.9136043197852;1727.9395221167263;1728.4641761054052;1689.2145152504083;1739;1741.355698391597;1744.886582372148;1746.397492864966;1722.5874782678209;1741.5820203151216;1743.128435782109;1743.581540430294;1744.9912750436295;1684.991575042123;1698.5838469574971;1698.702727022766;1716.7081596128687;1718.9484315470556;1693.7713408689792;1712.1097029544692;1714.0658341203948;1716.3134746101534;1716.5022143578346;6208.379162083801;6215.595986260879;6226.533010024266;6269.62382257066;6309.305976342599;4122.876313710593;4271.380649805792;4282;4293.957060429387;4304.526502084768;2575.2016874768883;2694.5015172193207;2764.640596722433;2765.2119146043283;2771.3210263485375;787.9251471110235;791;809.2150613904503;811.4928169893816;827.5986146718836;8632.179942905414;8729.60716767747;8738.781530461789;8740.51927144007;8745.518996455192;3541.6812486876306;3696.2977034363385;3759.473673685686;3852.5184351956004;3856.36369998947;6889.138857642794;6891.552049116792;6894.345037221557;6895.275996020346;6896.620685862225;4044.8988775280854;4049.250888585621;4051.716379853441;4054.8378064877666;4066.2274167908004;3497.5453191085;3614.765040272374;3777.036855601804;3778.7732736035928;3782.0733920189728;2951.5130003549175;3055.801372910754;3063.2998685729635;3114.065780265911;3134.605100730199;952.6903756279237;954.203240294362;957.5451660461225;958.4009993753904;977.0522593084696;797.1510341486298;797.5812698333422;801.1667865420014;820.4707963363597;820.7373640435123;4295.8496452624;4374.890627734332;4483.596476317147;4539.5460453955;4658.021815418732;786.5909726941958;797.8232107641182;803.5660743198607;812.634314558451;832.3715594725943;3179.825109618947;3189.9681003190135;3233.951490727641;3257.478803391446;3304.9504257436156;7803.765887023398;7962.6416811243635;8029;8031.839363212703;8050.11448740638;7982.121966583672;7989.480683755537;7994.320482758914;7999.240072193133;8004.479708818908;6209.410106039919;6261.7182226799905;6313.084602732578;6319.526035547352;6321.557490975588;4559.361689363425;4596.540345965511;4599.2871104978785;4636.698614590041;4668.346431499661;7236.819079523054;7484.288992545699;7518.699252029857;7543.43424243173;7543.7736867894055;7557.093148822177;7563.3193012626925;7601.353884919844;7630.8092297693;7649.732259370895;5804.622699524517;5966.880662386815;6005.699715014144;6020.939790602038;6054.48536874353;5745.253117094751;5954.404559544184;6288.151099601495;6548.050532672641;6562.146920900253;5849.502792262705;5907.3501914790195;5919.141724450017;5925.200097986716;5958.582899197015;5826.329972053099;5841.737121829613;5930.584859059824;5932.436418540232;5942.821715348547;5438.782448702166;5441.483059109379;5447.346318441812;5481.945180548143;5497.615166938276;4044.0698639312536;4132.40080188377;4149.336106223111;4223.831046758218;4353.73877567347;4089.8737828348494;4091.488563929509;4096.877093687194;4188.790560472025;4259.190753756776 05:24:35 INFO - PROCESS | 4159 | |4;prototype.html;295.9704029597041;299.9670036296007;302.7169596427341;304.64052418146576;306.5524334471671;4841.467438581753;4861.295112208728;4882.487338829425;4893.7797799099035;4899.975500122503;4764.332993380929;4790.904181916359;4793.496682848294;4821.855344339667;4831.3719216501895;3574.53531040965;3691.7046636269033;3692.0769807548113;3707.703383729295;3800.9809950950207;3790.4314352847155;3803.961960380402;3825.9617403825882;3827.8086095695244;3845.9807700961455;3799.8290076946605;3811.8475260989667;3815.828287727059;3815.931539169037;3819.2552452271816;3606.5672119345713;3663.5420572428447;3722.88831335059;3781.5273090863643;3823.636754508317;3363.1255873473074;3366.7474939379645;3375.780574262665;3380.107140001607;3390.779599326036;4656.464506581752;4666.3900954171095;4669.809198654355;4692.976535117336;4698.38920940279;4201.2017716633745;4297.419848320468;4314.546972567898;4314.756326710125;4320.762358070305;4959.181735013718;4982.202847544376;4985.501449854985;4990.4011518617635;5037.9244311335;3677.3380791457525;3683.797391143486;3697.4638677391627;3712.9257414851822;3720.9441858372147;5143.794248230104;5267.578593712494;5280;5295.973520132375;5317.494837990384;3732.2831497511447;3774.830132644038;3784.6215378461934;3793.3172029034486;3799.981000094982;3851.8844434667003;3860.2279544091293;3865.2655995361356;3877.662206538796;3894.668953139015;4357.128574285156;4363.36731173978;4364.781760911942;4369.453818272716;4389.714668546534;4841.201201801734;4995.600351971833;5029.899402011939;5041.79832806691;5101.913342427852;1285.190330092036;1297.9935100324437;1301.9414126364336;1305.4582348325528;1305.9813345590455;855.9186877246651;899.9055099214619;905.7418635688797;910.3263584947091;915.7069737683877;4308.784560771949;4351.173277077409;4405.449318835145;4423.314386270134;4492.663050271242;5122.410922743858;5139.177731562932;5146.25379320004;5184.289184569083;5212.192110222922;4439.245328294198;4474.261746811805;4482.708623939434;4485.25993211123;4485.349624304457;2522.2937577478338;2636.6816591704146;2644.6165306030516;2646.2325925481396;2655.1901669990452;4670.346151538787;4697.6711630185555;4706.576408123286;4715.8210447388155;4725.834595789131;5100.770465329069;5108.412532558803;5108.514691104339;5109.693418394908;5118.206677964921;4592.494825569184;4709.882252943636;4918.409790825124;4938.012397520511;4946.307516947702;5163.690178589297;5219.191025390918;5225.608079393985;5230.137027390438;5235.4764523548865;5139.383274007143;5140.203268493389;5144.76848541824;5156.607715916756;5165.922511162411;4657.883552911068;4890.559849613552;4909.558139767438;4916.631252655993;4934.322330407678;3570.696490798311;3586.9103272418397;3587.3004764070756;3591.76653517531;3626.8005259710967;5192.506711862367;5202.791888324425;5226.085435048927;5245.606579506476;5262.631615786858;4991.675541089818;5025.924611130763;5063.544281014726;5064.215046667772;5070.873228169326;4976.30331753562;5045.419776725576;5050.641323519965;5053.4946505350645;5058.215976523645;4972.726500042532;4973.975130124326;4982.576480999156;4988.176950803077;4998.1503144464805;4838.225883858566;4910.508949105061;5051.2423136529815;5079.593632509464;5098.5411312982005;4847.3698419205275;4866.756662166948;4973.701577905193;4982.975085124551;4983.152864013199 05:24:35 INFO - PROCESS | 4159 | |5;yui.html;594.3684585811947;594.7710131599333;658.8748137853811;681.4310051107325;682.9180498340199;10714.142868570516;10979.121670266379;11362.545498180083;11491.885081149187;11511.36687482188;11017.394043327613;11156.721081972935;11161;11175.385353805537;11178.664640060812;615.7167702856691;628.9465395441393;742.3689863615924;756.9772906812805;760.9657565409569;741.7329761285932;753.8869169624545;765.9617019149048;770.8959290495767;771.2364758888688;807.8263173417714;814.6741303478597;816.1348970091692;816.6161903905185;817.3502065857627;810.0643756461296;811.2252798577344;811.9188081191893;812.4962523235632;813.5118928642826;596.83885350955;598.0670154558859;598.5181928547518;598.5540772124751;598.6767145741294;10372.377657340583;10403.219758518066;10404.68785936423;10407.375557466501;10418;9457.43255404678;9556.474393908333;9609.13517783396;9657.613695452173;10177.18582513397;8286.46138001028;8288.544130072843;8377.916220837775;8390.790230244233;8397.244248017707;2458.8155888308447;2484.714257860333;2496.226169887341;2529.696436427622;2551.8979240830345;45217;46487.76756116198;47450.28824567634;47566;49158;6975;7036.718531258794;7484.513506622052;7492.51298665585;7558.319751222306;15106.471273505374;15108.54674359771;15117.470888518848;15122.924385378003;15203.163825989455;6341.112244285804;6425.10048593188;6544.869102618016;6607.108040414579;6780.118584583973;3377.071410054481;3396.633170571812;3447.637998010223;3484.738644601665;3614.8373323200517;2613.568761154388;2649.655544779205;2669.599560066006;2691.1253842501264;2796.5385711357803;471.37542755847954;474.563401670464;480.48348025872326;481.1819906159473;488.47976904597203;548.5310059898809;555.7415801652251;557.3534699748272;575.0569066730566;585.3034888482692;6536.509761767887;6807.319268073153;7156.499045066899;7379.963100184572;7423.369013633794;496.94036715593637;507.710604955172;524.5855773938622;554.6588847858538;578.7337824600646;3410.7271418286477;3526.4710293455673;3610.9638903610626;3689.760165589228;3776.981115094462;42475.15049699051;53920.460795392326;55893.44106558882;56465.15302270469;61604.69197653983;35724.821375892956;37333.81333093371;50304.74847625739;56636.43363566312;59061;51482.48517514777;51717.7414112927;52689.2096618551;52815.20777188422;53200.81788958518;6928.653567321715;7028.9297107030325;7042;7071;7450.888236676563;35873.82063089668;36426.27147457089;36530;36601.45097823482;37265;48677.2698409517;49506;49870.50129498804;49891.50108498868;51687.2246916289;8444.873326899979;8574.78563035929;8575.142485751376;8670.78323041929;8977;10158.238132140266;10213.744656383353;10274.589016439259;10314.48427578603;10453.738656533647;9320.95339523298;9428.15146636806;9618.470984095942;9641.325107242426;9667.613295468103;9553.856692149484;9562.713118606453;9583.520823958635;9668.323217374716;9764.60941562358;9009.459432434074;9063.954680226556;9161.31290153228;9262.861057084285;9290.349675522648;7807.648655810389;7981.122076571689;8016.95991520062;8128.227818357246;8224.465409748347;8354.87467687973;8394.24451799341;8416.915830841857;8522.141099912567;8862.867056994279 05:24:35 INFO - PROCESS | 4159 | __end_tp_report 05:24:35 INFO - PROCESS | 4159 | __start_cc_report 05:24:35 INFO - PROCESS | 4159 | _x_x_mozilla_cycle_collect,2553 05:24:35 INFO - PROCESS | 4159 | __end_cc_report 05:24:35 INFO - PROCESS | 4159 | __startTimestamp1479389075298__endTimestamp 05:24:35 INFO - PROCESS | 4159 | 05:24:35 INFO - PROCESS | 4159 | ------- Summary: start ------- 05:24:35 INFO - PROCESS | 4159 | Number of tests: 6 05:24:35 INFO - PROCESS | 4159 | 05:24:35 INFO - PROCESS | 4159 | [#0] dojo.html Cycles:165 Average:4686.97 Median:4823.40 stddev:484.86 (10.1%) stddev-sans-first:457.15 05:24:35 INFO - PROCESS | 4159 | Values: 2574.7 2595.7 2613.9 2629.5 2640.7 4636.3 4693.2 4730.5 4739.0 4751.9 4670.0 4737.0 4750.6 4755.3 4796.4 4288.9 4372.8 4415.3 4431.2 4439.7 4441.4 4481.0 4481.9 4482.1 4483.5 4202.5 4417.9 4426.4 4454.6 4520.6 4237.3 4269.7 4318.8 4375.6 4382.6 4261.5 4303.3 4305.7 4345.2 4369.6 4716.7 4736.9 4742.7 4776.4 4778.3 4884.0 4933.4 4940.2 4998.0 5055.9 5106.2 5148.2 5156.9 5174.4 5199.6 4794.4 4802.2 4806.9 4807.1 4845.5 5020.4 5086.1 5239.1 5241.9 5248.2 4910.1 4949.6 4956.7 4957.4 4961.6 4989.8 5030.8 5038.0 5048.0 5118.9 4991.1 5025.9 5038.6 5043.4 5092.7 5000.6 5026.6 5026.7 5030.9 5065.4 4142.1 4240.8 4241.1 4299.4 4332.7 3781.6 3790.8 3802.0 3828.0 3835.0 4423.3 4425.6 4426.4 4430.0 4473.2 4921.3 4931.8 4990.3 5113.0 5159.2 4400.8 4420.4 4432.7 4468.2 4509.1 4634.6 4635.7 4635.9 4636.7 4687.4 4605.2 4819.0 4828.6 4836.2 4885.1 4955.1 5039.1 5106.6 5145.3 5148.2 4822.9 4823.4 4831.5 4857.2 4885.9 5082.8 5089.3 5090.9 5095.9 5096.4 4873.5 4972.0 4974.9 5001.5 5208.2 4879.1 4894.7 4908.6 4909.0 4909.2 4897.7 4901.4 4901.9 4904.2 4907.2 4794.4 4809.0 4809.8 4812.6 4814.4 4893.8 4923.1 4936.4 4936.9 4945.2 4825.3 4833.8 4833.9 4835.6 4843.0 05:24:35 INFO - PROCESS | 4159 | 05:24:35 INFO - PROCESS | 4159 | [#1] ext.html Cycles:180 Average:39608.11 Median:17068.82 stddev:69950.90 (409.8%) stddev-sans-first:70085.64 05:24:35 INFO - PROCESS | 4159 | Values: 545.6 563.9 575.6 577.2 593.4 27254.7 28452.7 28591.3 30445.0 30467.8 27905.9 27972.3 27997.6 28281.2 28334.9 5275.8 5413.4 5413.7 5455.5 5461.3 5544.3 5611.1 5614.5 5614.8 5617.2 5605.6 5619.6 5629.7 5633.6 5634.4 5618.0 5641.8 5658.6 5658.6 5659.9 5589.4 5645.2 5647.1 5648.0 5649.9 25848.0 26072.6 26344.0 26373.0 26374.5 3073.4 3078.2 3088.5 3097.1 3110.3 18200.7 18226.7 18248.3 18379.7 18739.6 2471.2 2552.6 2596.2 2600.0 2755.3 243252.0 243624.0 245128.0 246143.0 246209.0 50858.5 51228.0 51390.2 51427.5 51543.2 31208.7 32194.7 32285.5 34374.5 55755.0 13801.5 14014.1 14017.5 14020.0 14024.7 9637.3 9696.4 9709.0 9712.3 9733.7 17100.3 17122.6 17159.0 17198.0 17298.5 6594.3 6601.8 6650.9 6671.9 6771.2 815.2 844.2 861.8 955.8 985.2 25545.2 25614.4 25653.0 26121.6 26164.7 953.3 955.7 959.5 970.9 980.0 13282.9 13776.7 14061.2 14087.2 14238.9 283632.0 286459.0 286546.0 286728.0 286962.0 40765.8 41102.8 41132.6 41280.8 41304.8 1034.9 1100.5 1129.0 1154.1 1160.1 23728.2 25772.7 26663.9 27096.3 27176.3 40036.0 40463.8 40579.8 40596.6 40629.2 265257.0 266408.0 267178.0 267259.0 267929.0 20078.0 20879.7 22154.7 22685.9 22986.7 36072.6 36515.6 36679.8 37021.8 37655.0 31408.8 31726.4 31747.7 31881.7 32076.7 30928.5 31027.4 32058.5 32121.1 32468.0 31287.4 31907.8 32206.2 32208.8 32216.8 26839.0 29122.0 29386.0 29504.1 29632.7 22983.8 23002.5 23043.8 23160.8 23182.9 05:24:35 INFO - PROCESS | 4159 | 05:24:35 INFO - PROCESS | 4159 | [#2] jquery.html Cycles:180 Average:23526.43 Median:39319.11 stddev:57601.70 (146.5%) stddev-sans-first:57736.99 05:24:35 INFO - PROCESS | 4159 | Values: 347.0 357.5 362.6 368.4 391.5 9590.7 10355.9 11462.4 11712.6 12262.7 15688.6 16138.3 16182.8 16259.5 16313.7 3957.2 4231.9 4258.9 4271.6 4273.7 3971.1 4077.3 4105.2 4135.0 4165.3 4120.1 4121.6 4125.3 4126.6 4126.9 3958.7 4097.5 4101.4 4101.8 4108.9 3810.3 3853.0 3853.4 3855.4 3859.8 16129.6 16411.0 16478.5 16634.5 16722.7 1872.5 1890.1 1997.1 2104.3 2401.8 10731.5 10919.8 11093.9 11342.9 11504.7 1410.7 1451.0 1530.9 1544.2 1548.0 61733.1 73747.6 77791.6 78349.6 81580.0 15883.8 16344.2 16345.1 16358.0 17449.0 28506.7 28574.7 28643.9 28646.1 28730.1 8557.4 8826.3 8940.6 9106.3 9146.5 7321.7 7344.6 7373.7 7566.4 7583.2 6795.5 8253.6 8386.4 8405.5 8430.7 3133.9 3265.9 3283.9 3320.8 3348.8 816.2 822.7 844.2 861.7 886.0 16239.4 16695.2 16905.4 17370.3 17518.7 846.1 853.8 872.4 891.0 897.4 9382.8 9493.6 9570.1 9625.5 9833.7 330817.0 343419.0 352311.0 352478.0 352728.0 73234.0 73472.6 74111.3 74981.6 75940.6 882.2 887.7 909.4 912.9 930.7 14728.9 15078.9 15581.7 15601.8 15784.2 38056.6 38284.4 38471.2 39296.2 39342.0 49887.8 50856.0 51564.0 51581.0 51619.0 6474.8 6909.2 7143.4 7203.4 7238.7 10101.4 11610.9 11878.6 11908.7 11961.4 9713.5 10258.8 10412.3 10514.7 10743.7 8825.2 9430.0 10465.3 10488.8 10536.6 10168.3 10302.5 10317.6 10401.4 10873.3 6702.5 6864.8 6891.7 7043.7 7072.5 8174.9 9092.5 9765.3 9946.5 10088.0 05:24:35 INFO - PROCESS | 4159 | 05:24:35 INFO - PROCESS | 4159 | [#3] mootools.html Cycles:180 Average:4348.21 Median:5660.95 stddev:2352.11 (41.5%) stddev-sans-first:2346.96 05:24:35 INFO - PROCESS | 4159 | Values: 1220.9 1309.8 1341.0 1382.0 1639.7 5576.6 5972.5 6097.0 6383.2 6389.5 6234.9 6307.1 6307.8 6308.2 6312.9 1690.2 1723.9 1727.9 1727.9 1728.5 1689.2 1739.0 1741.4 1744.9 1746.4 1722.6 1741.6 1743.1 1743.6 1745.0 1685.0 1698.6 1698.7 1716.7 1718.9 1693.8 1712.1 1714.1 1716.3 1716.5 6208.4 6215.6 6226.5 6269.6 6309.3 4122.9 4271.4 4282.0 4294.0 4304.5 2575.2 2694.5 2764.6 2765.2 2771.3 787.9 791.0 809.2 811.5 827.6 8632.2 8729.6 8738.8 8740.5 8745.5 3541.7 3696.3 3759.5 3852.5 3856.4 6889.1 6891.6 6894.3 6895.3 6896.6 4044.9 4049.3 4051.7 4054.8 4066.2 3497.5 3614.8 3777.0 3778.8 3782.1 2951.5 3055.8 3063.3 3114.1 3134.6 952.7 954.2 957.5 958.4 977.1 797.2 797.6 801.2 820.5 820.7 4295.8 4374.9 4483.6 4539.5 4658.0 786.6 797.8 803.6 812.6 832.4 3179.8 3190.0 3234.0 3257.5 3305.0 7803.8 7962.6 8029.0 8031.8 8050.1 7982.1 7989.5 7994.3 7999.2 8004.5 6209.4 6261.7 6313.1 6319.5 6321.6 4559.4 4596.5 4599.3 4636.7 4668.3 7236.8 7484.3 7518.7 7543.4 7543.8 7557.1 7563.3 7601.4 7630.8 7649.7 5804.6 5966.9 6005.7 6020.9 6054.5 5745.3 5954.4 6288.2 6548.1 6562.1 5849.5 5907.4 5919.1 5925.2 5958.6 5826.3 5841.7 5930.6 5932.4 5942.8 5438.8 5441.5 5447.3 5481.9 5497.6 4044.1 4132.4 4149.3 4223.8 4353.7 4089.9 4091.5 4096.9 4188.8 4259.2 05:24:35 INFO - PROCESS | 4159 | 05:24:35 INFO - PROCESS | 4159 | [#4] prototype.html Cycles:180 Average:4190.24 Median:4712.85 stddev:1205.82 (25.6%) stddev-sans-first:1173.24 05:24:35 INFO - PROCESS | 4159 | Values: 296.0 300.0 302.7 304.6 306.6 4841.5 4861.3 4882.5 4893.8 4900.0 4764.3 4790.9 4793.5 4821.9 4831.4 3574.5 3691.7 3692.1 3707.7 3801.0 3790.4 3804.0 3826.0 3827.8 3846.0 3799.8 3811.8 3815.8 3815.9 3819.3 3606.6 3663.5 3722.9 3781.5 3823.6 3363.1 3366.7 3375.8 3380.1 3390.8 4656.5 4666.4 4669.8 4693.0 4698.4 4201.2 4297.4 4314.5 4314.8 4320.8 4959.2 4982.2 4985.5 4990.4 5037.9 3677.3 3683.8 3697.5 3712.9 3720.9 5143.8 5267.6 5280.0 5296.0 5317.5 3732.3 3774.8 3784.6 3793.3 3800.0 3851.9 3860.2 3865.3 3877.7 3894.7 4357.1 4363.4 4364.8 4369.5 4389.7 4841.2 4995.6 5029.9 5041.8 5101.9 1285.2 1298.0 1301.9 1305.5 1306.0 855.9 899.9 905.7 910.3 915.7 4308.8 4351.2 4405.4 4423.3 4492.7 5122.4 5139.2 5146.3 5184.3 5212.2 4439.2 4474.3 4482.7 4485.3 4485.3 2522.3 2636.7 2644.6 2646.2 2655.2 4670.3 4697.7 4706.6 4715.8 4725.8 5100.8 5108.4 5108.5 5109.7 5118.2 4592.5 4709.9 4918.4 4938.0 4946.3 5163.7 5219.2 5225.6 5230.1 5235.5 5139.4 5140.2 5144.8 5156.6 5165.9 4657.9 4890.6 4909.6 4916.6 4934.3 3570.7 3586.9 3587.3 3591.8 3626.8 5192.5 5202.8 5226.1 5245.6 5262.6 4991.7 5025.9 5063.5 5064.2 5070.9 4976.3 5045.4 5050.6 5053.5 5058.2 4972.7 4974.0 4982.6 4988.2 4998.2 4838.2 4910.5 5051.2 5079.6 5098.5 4847.4 4866.8 4973.7 4983.0 4983.2 05:24:35 INFO - PROCESS | 4159 | 05:24:35 INFO - PROCESS | 4159 | [#5] yui.html Cycles:180 Average:12883.23 Median:594.57 stddev:16497.28 (2774.7%) stddev-sans-first:16517.75 05:24:35 INFO - PROCESS | 4159 | Values: 594.4 594.8 658.9 681.4 682.9 10714.1 10979.1 11362.5 11491.9 11511.4 11017.4 11156.7 11161.0 11175.4 11178.7 615.7 628.9 742.4 757.0 761.0 741.7 753.9 766.0 770.9 771.2 807.8 814.7 816.1 816.6 817.4 810.1 811.2 811.9 812.5 813.5 596.8 598.1 598.5 598.6 598.7 10372.4 10403.2 10404.7 10407.4 10418.0 9457.4 9556.5 9609.1 9657.6 10177.2 8286.5 8288.5 8377.9 8390.8 8397.2 2458.8 2484.7 2496.2 2529.7 2551.9 45217.0 46487.8 47450.3 47566.0 49158.0 6975.0 7036.7 7484.5 7492.5 7558.3 15106.5 15108.5 15117.5 15122.9 15203.2 6341.1 6425.1 6544.9 6607.1 6780.1 3377.1 3396.6 3447.6 3484.7 3614.8 2613.6 2649.7 2669.6 2691.1 2796.5 471.4 474.6 480.5 481.2 488.5 548.5 555.7 557.4 575.1 585.3 6536.5 6807.3 7156.5 7380.0 7423.4 496.9 507.7 524.6 554.7 578.7 3410.7 3526.5 3611.0 3689.8 3777.0 42475.2 53920.5 55893.4 56465.2 61604.7 35724.8 37333.8 50304.7 56636.4 59061.0 51482.5 51717.7 52689.2 52815.2 53200.8 6928.7 7028.9 7042.0 7071.0 7450.9 35873.8 36426.3 36530.0 36601.5 37265.0 48677.3 49506.0 49870.5 49891.5 51687.2 8444.9 8574.8 8575.1 8670.8 8977.0 10158.2 10213.7 10274.6 10314.5 10453.7 9321.0 9428.2 9618.5 9641.3 9667.6 9553.9 9562.7 9583.5 9668.3 9764.6 9009.5 9064.0 9161.3 9262.9 9290.3 7807.6 7981.1 8017.0 8128.2 8224.5 8354.9 8394.2 8416.9 8522.1 8862.9 05:24:35 INFO - PROCESS | 4159 | -------- Summary: end -------- 05:24:35 INFO - PROCESS | 4159 | 05:24:36 INFO - TEST-INFO | 4159: exit 0 05:24:36 INFO - TEST-OK | dromaeo_css | took 1122103ms 05:24:36 INFO - TEST-START | kraken 05:24:36 INFO - operating with platform_type : linux_ 05:24:36 INFO - Initialising browser for kraken test... 05:24:36 INFO - TEST-INFO | started process 4460 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIfZRvC/profile http://localhost:47671/getInfo.html) 05:24:40 INFO - PROCESS | 4460 | __metrics Screen width/height:1600/1200 05:24:40 INFO - PROCESS | 4460 | colorDepth:24 05:24:40 INFO - PROCESS | 4460 | Browser inner width/height: 1024/697 05:24:40 INFO - PROCESS | 4460 | __metrics 05:24:41 INFO - PROCESS | 4460 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:24:41 INFO - PROCESS | 4460 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:24:41 INFO - PROCESS | 4460 | console.error: PushService: 05:24:41 INFO - PROCESS | 4460 | stateChangeProcessEnqueue: Error transitioning state 05:24:41 INFO - PROCESS | 4460 | UnknownError 05:24:42 INFO - TEST-INFO | 4460: exit 0 05:24:42 INFO - Browser initialized. 05:24:42 INFO - Running cycle 1/1 for kraken test... 05:24:42 INFO - TEST-INFO | started process 4541 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIfZRvC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:24:54 INFO - PROCESS | 4541 | RSS: Main: 174813184 05:24:54 INFO - PROCESS | 4541 | 05:24:57 INFO - PROCESS | 4541 | Cycle 1(1): loaded http://localhost:47671/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47671/tests/kraken/driver.html?testName=audio-beat-detection) 05:24:58 INFO - PROCESS | 4541 | RSS: Main: 231256064 05:24:58 INFO - PROCESS | 4541 | 05:25:01 INFO - PROCESS | 4541 | Cycle 1(1): loaded http://localhost:47671/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47671/tests/kraken/driver.html?testName=audio-dft) 05:25:01 INFO - PROCESS | 4541 | RSS: Main: 217919488 05:25:01 INFO - PROCESS | 4541 | 05:25:05 INFO - PROCESS | 4541 | Cycle 1(1): loaded http://localhost:47671/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47671/tests/kraken/driver.html?testName=audio-fft) 05:25:05 INFO - PROCESS | 4541 | RSS: Main: 300171264 05:25:05 INFO - PROCESS | 4541 | 05:25:07 INFO - PROCESS | 4541 | Cycle 1(1): loaded http://localhost:47671/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47671/tests/kraken/driver.html?testName=audio-oscillator) 05:25:08 INFO - PROCESS | 4541 | RSS: Main: 210829312 05:25:08 INFO - PROCESS | 4541 | 05:25:10 INFO - PROCESS | 4541 | Cycle 1(1): loaded http://localhost:47671/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47671/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:25:11 INFO - PROCESS | 4541 | RSS: Main: 214044672 05:25:11 INFO - PROCESS | 4541 | 05:25:14 INFO - PROCESS | 4541 | Cycle 1(1): loaded http://localhost:47671/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47671/tests/kraken/driver.html?testName=imaging-darkroom) 05:25:15 INFO - PROCESS | 4541 | RSS: Main: 253771776 05:25:15 INFO - PROCESS | 4541 | 05:25:18 INFO - PROCESS | 4541 | Cycle 1(1): loaded http://localhost:47671/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47671/tests/kraken/driver.html?testName=imaging-desaturate) 05:25:19 INFO - PROCESS | 4541 | RSS: Main: 248328192 05:25:19 INFO - PROCESS | 4541 | 05:25:22 INFO - PROCESS | 4541 | Cycle 1(1): loaded http://localhost:47671/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47671/tests/kraken/driver.html?testName=json-parse-financial) 05:25:22 INFO - PROCESS | 4541 | RSS: Main: 250400768 05:25:22 INFO - PROCESS | 4541 | 05:25:24 INFO - PROCESS | 4541 | Cycle 1(1): loaded http://localhost:47671/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47671/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:25:25 INFO - PROCESS | 4541 | RSS: Main: 213905408 05:25:25 INFO - PROCESS | 4541 | 05:25:26 INFO - PROCESS | 4541 | Cycle 1(1): loaded http://localhost:47671/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47671/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:25:27 INFO - PROCESS | 4541 | RSS: Main: 221179904 05:25:27 INFO - PROCESS | 4541 | 05:25:29 INFO - PROCESS | 4541 | Cycle 1(1): loaded http://localhost:47671/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47671/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:25:30 INFO - PROCESS | 4541 | RSS: Main: 229425152 05:25:30 INFO - PROCESS | 4541 | 05:25:33 INFO - PROCESS | 4541 | Cycle 1(1): loaded http://localhost:47671/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47671/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:25:34 INFO - PROCESS | 4541 | RSS: Main: 237924352 05:25:34 INFO - PROCESS | 4541 | 05:25:36 INFO - PROCESS | 4541 | Cycle 1(1): loaded http://localhost:47671/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47671/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:25:37 INFO - PROCESS | 4541 | RSS: Main: 234487808 05:25:37 INFO - PROCESS | 4541 | 05:25:39 INFO - PROCESS | 4541 | Cycle 1(1): loaded http://localhost:47671/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47671/tests/kraken/driver.html?testName=ai-astar) 05:25:39 INFO - PROCESS | 4541 | RSS: Main: 284356608 05:25:39 INFO - PROCESS | 4541 | 05:25:39 INFO - PROCESS | 4541 | __start_tp_report 05:25:39 INFO - PROCESS | 4541 | _x_x_mozilla_page_load 05:25:39 INFO - PROCESS | 4541 | _x_x_mozilla_page_load_details 05:25:39 INFO - PROCESS | 4541 | |i|pagename|runs| 05:25:39 INFO - PROCESS | 4541 | |0;ai-astar;108;117;115;115;116;116;116;116;116;115 05:25:39 INFO - PROCESS | 4541 | |1;audio-beat-detection;154;131;128;160;132;131;134;130;160;140 05:25:39 INFO - PROCESS | 4541 | |2;audio-dft;166;164;163;163;161;169;162;162;162;161 05:25:39 INFO - PROCESS | 4541 | |3;audio-fft;76;79;76;105;76;77;77;78;110;77 05:25:39 INFO - PROCESS | 4541 | |4;audio-oscillator;85;84;123;83;85;84;113;85;84;131 05:25:39 INFO - PROCESS | 4541 | |5;imaging-gaussian-blur;117;117;116;116;117;117;117;117;117;117 05:25:39 INFO - PROCESS | 4541 | |6;imaging-darkroom;149;148;147;147;148;147;146;146;147;147 05:25:39 INFO - PROCESS | 4541 | |7;imaging-desaturate;95;96;96;95;96;96;96;96;96;96 05:25:39 INFO - PROCESS | 4541 | |8;json-parse-financial;65;63;63;66;65;65;64;64;65;65 05:25:39 INFO - PROCESS | 4541 | |9;json-stringify-tinderbox;65;66;65;66;65;66;65;65;66;66 05:25:39 INFO - PROCESS | 4541 | |10;stanford-crypto-aes;86;85;84;85;83;84;84;88;93;86 05:25:39 INFO - PROCESS | 4541 | |11;stanford-crypto-ccm;145;142;142;139;139;151;142;141;191;142 05:25:39 INFO - PROCESS | 4541 | |12;stanford-crypto-pbkdf2;182;176;177;175;174;181;176;177;176;177 05:25:39 INFO - PROCESS | 4541 | |13;stanford-crypto-sha256-iterative;69;71;68;69;69;68;67;68;68;67 05:25:39 INFO - PROCESS | 4541 | __end_tp_report 05:25:39 INFO - PROCESS | 4541 | __start_cc_report 05:25:39 INFO - PROCESS | 4541 | _x_x_mozilla_cycle_collect,1983 05:25:39 INFO - PROCESS | 4541 | __end_cc_report 05:25:39 INFO - PROCESS | 4541 | __startTimestamp1479389139621__endTimestamp 05:25:39 INFO - PROCESS | 4541 | 05:25:39 INFO - PROCESS | 4541 | ------- Summary: start ------- 05:25:39 INFO - PROCESS | 4541 | Number of tests: 14 05:25:39 INFO - PROCESS | 4541 | 05:25:39 INFO - PROCESS | 4541 | [#0] ai-astar Cycles:10 Average:115.00 Median:116.00 stddev:2.54 (2.2%) stddev-sans-first:0.67 05:25:39 INFO - PROCESS | 4541 | Values: 108.0 117.0 115.0 115.0 116.0 116.0 116.0 116.0 116.0 115.0 05:25:39 INFO - PROCESS | 4541 | 05:25:39 INFO - PROCESS | 4541 | [#1] audio-beat-detection Cycles:10 Average:140.00 Median:137.00 stddev:12.92 (9.4%) stddev-sans-first:12.67 05:25:39 INFO - PROCESS | 4541 | Values: 154.0 131.0 128.0 160.0 132.0 131.0 134.0 130.0 160.0 140.0 05:25:39 INFO - PROCESS | 4541 | 05:25:39 INFO - PROCESS | 4541 | [#2] audio-dft Cycles:10 Average:163.30 Median:163.00 stddev:2.50 (1.5%) stddev-sans-first:2.45 05:25:39 INFO - PROCESS | 4541 | Values: 166.0 164.0 163.0 163.0 161.0 169.0 162.0 162.0 162.0 161.0 05:25:39 INFO - PROCESS | 4541 | 05:25:39 INFO - PROCESS | 4541 | [#3] audio-fft Cycles:10 Average:83.10 Median:77.00 stddev:12.95 (16.8%) stddev-sans-first:13.48 05:25:39 INFO - PROCESS | 4541 | Values: 76.0 79.0 76.0 105.0 76.0 77.0 77.0 78.0 110.0 77.0 05:25:39 INFO - PROCESS | 4541 | 05:25:39 INFO - PROCESS | 4541 | [#4] audio-oscillator Cycles:10 Average:95.70 Median:84.00 stddev:18.87 (22.5%) stddev-sans-first:19.62 05:25:39 INFO - PROCESS | 4541 | Values: 85.0 84.0 123.0 83.0 85.0 84.0 113.0 85.0 84.0 131.0 05:25:39 INFO - PROCESS | 4541 | 05:25:39 INFO - PROCESS | 4541 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 05:25:39 INFO - PROCESS | 4541 | Values: 117.0 117.0 116.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 05:25:39 INFO - PROCESS | 4541 | 05:25:39 INFO - PROCESS | 4541 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:0.92 (0.6%) stddev-sans-first:0.71 05:25:39 INFO - PROCESS | 4541 | Values: 149.0 148.0 147.0 147.0 148.0 147.0 146.0 146.0 147.0 147.0 05:25:39 INFO - PROCESS | 4541 | 05:25:39 INFO - PROCESS | 4541 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 05:25:39 INFO - PROCESS | 4541 | Values: 95.0 96.0 96.0 95.0 96.0 96.0 96.0 96.0 96.0 96.0 05:25:39 INFO - PROCESS | 4541 | 05:25:39 INFO - PROCESS | 4541 | [#8] json-parse-financial Cycles:10 Average:64.50 Median:65.00 stddev:0.97 (1.5%) stddev-sans-first:1.01 05:25:39 INFO - PROCESS | 4541 | Values: 65.0 63.0 63.0 66.0 65.0 65.0 64.0 64.0 65.0 65.0 05:25:39 INFO - PROCESS | 4541 | 05:25:39 INFO - PROCESS | 4541 | [#9] json-stringify-tinderbox Cycles:10 Average:65.50 Median:66.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 05:25:39 INFO - PROCESS | 4541 | Values: 65.0 66.0 65.0 66.0 65.0 66.0 65.0 65.0 66.0 66.0 05:25:39 INFO - PROCESS | 4541 | 05:25:39 INFO - PROCESS | 4541 | [#10] stanford-crypto-aes Cycles:10 Average:85.80 Median:85.50 stddev:2.90 (3.4%) stddev-sans-first:3.07 05:25:39 INFO - PROCESS | 4541 | Values: 86.0 85.0 84.0 85.0 83.0 84.0 84.0 88.0 93.0 86.0 05:25:39 INFO - PROCESS | 4541 | 05:25:39 INFO - PROCESS | 4541 | [#11] stanford-crypto-ccm Cycles:10 Average:147.40 Median:142.00 stddev:15.70 (11.1%) stddev-sans-first:16.63 05:25:39 INFO - PROCESS | 4541 | Values: 145.0 142.0 142.0 139.0 139.0 151.0 142.0 141.0 191.0 142.0 05:25:39 INFO - PROCESS | 4541 | 05:25:39 INFO - PROCESS | 4541 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.10 Median:177.00 stddev:2.51 (1.4%) stddev-sans-first:1.94 05:25:39 INFO - PROCESS | 4541 | Values: 182.0 176.0 177.0 175.0 174.0 181.0 176.0 177.0 176.0 177.0 05:25:39 INFO - PROCESS | 4541 | 05:25:39 INFO - PROCESS | 4541 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.40 Median:68.50 stddev:1.17 (1.7%) stddev-sans-first:1.22 05:25:39 INFO - PROCESS | 4541 | Values: 69.0 71.0 68.0 69.0 69.0 68.0 67.0 68.0 68.0 67.0 05:25:39 INFO - PROCESS | 4541 | -------- Summary: end -------- 05:25:39 INFO - PROCESS | 4541 | 05:25:41 INFO - TEST-INFO | 4541: exit 0 05:25:41 INFO - TEST-OK | kraken | took 64759ms 05:25:41 INFO - SUITE-END | took 1186s 05:25:41 INFO - Completed test suite (00:19:47) 05:25:41 INFO - javascript benchmark 05:25:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2574.703909050459, 2595.7274486178962, 2613.9085132020377, 2629.487249986252, 2640.709521952585, 4636.304554316855, 4693.202155633542, 4730.479647238805, 4738.976305118478, 4751.928721069183, 4669.953300466995, 4736.952630473695, 4750.596199323053, 4755.334253204554, 4796.400449943757, 4288.914221715564, 4372.825086996532, 4415.337699345092, 4431.158079964813, 4439.733615983036, 4441.444819397575, 4481.0, 4481.887952801189, 4482.125985432842, 4483.484399294074, 4202.537720850704, 4417.933730994037, 4426.380306757057, 4454.621357184627, 4520.570545798144, 4237.300845360543, 4269.658427325807, 4318.805653745589, 4375.562443755631, 4382.561743825592, 4261.509926358477, 4303.33298338758, 4305.74165550068, 4345.196138714348, 4369.563043695637, 4716.693414928053, 4736.905261894777, 4742.691725037896, 4776.402949631296, 4778.307145463888, 4883.9511604883855, 4933.407991041062, 4940.1601727706375, 4998.0, 5055.898882022376, 5106.183010718304, 5148.176291793295, 5156.871078223037, 5174.353205849269, 5199.584033277367, 4794.376731024944, 4802.207635740098, 4806.903861922812, 4807.134715751198, 4845.515448455127, 5020.3724534433195, 5086.109930762102, 5239.050384696004, 5241.895162096736, 5248.212768084818, 4910.091633047898, 4949.57928576075, 4956.727379994063, 4957.380327459067, 4961.627877909099, 4989.750512474362, 5030.8239211627415, 5038.042771873405, 5048.0, 5118.897622047538, 4991.126552853236, 5025.949740502549, 5038.571721403721, 5043.36957880265, 5092.668976516515, 5000.62495312853, 5026.572741316956, 5026.673266237683, 5030.89938201234, 5065.366829146356, 4142.130152667974, 4240.766757828287, 4241.066965267636, 4299.398084268205, 4332.740035597874, 3781.5840257571645, 3790.7915064671706, 3801.9809900950318, 3828.004718773139, 3834.9616503835164, 4423.270160423494, 4425.6238219751685, 4426.402435671143, 4429.9778501107285, 4473.194824931544, 4921.311016457699, 4931.827386041471, 4990.276409920614, 5112.9744351278005, 5159.17453207485, 4400.779961002001, 4420.381146639473, 4432.734035957853, 4468.195724769573, 4509.053098849278, 4634.606058485067, 4635.745034023161, 4635.860924172212, 4636.744979026119, 4687.414073240845, 4605.171069207575, 4818.975905120452, 4828.613710903049, 4836.153673107122, 4885.096257192502, 4955.058538877602, 5039.143345631178, 5106.617003724661, 5145.253938178868, 5148.176291793295, 4822.927656085091, 4823.397075365579, 4831.4685384608365, 4857.222844344888, 4885.877853053702, 5082.771275292546, 5089.312942752681, 5090.949090509048, 5095.923561146512, 5096.413912399973, 4873.488283730299, 4972.030454061423, 4974.875628109182, 5001.499850015115, 5208.218767184952, 4879.146149423766, 4894.706317620954, 4908.6073114151495, 4909.0, 4909.214525675875, 4897.730624815669, 4901.387326584177, 4901.90196196067, 4904.190808516555, 4907.190313598359, 4794.352762377034, 4808.975955120202, 4809.831655892027, 4812.614990800797, 4814.422269327703, 4893.828715995065, 4923.138450771173, 4936.3829521309835, 4936.901261974668, 4945.184044632595, 4825.276208568743, 4833.758312084311, 4833.927491087707, 4835.58897493717, 4843.0313937213405], "value": 4655.949122187487, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [545.5553723715171, 563.918231856381, 575.5625724449417, 577.1832856508041, 593.3621357041181, 27254.727452725467, 28452.715472845266, 28591.285217869565, 30445.0, 30467.84766076172, 27905.86047069767, 27972.3006924827, 27997.58003629947, 28281.15156545302, 28334.858325708396, 5275.762590683428, 5413.350397952231, 5413.675179489223, 5455.454454554552, 5461.317335333083, 5544.251526043993, 5611.130274807411, 5614.494695477406, 5614.775408983635, 5617.241672374218, 5605.5515558755405, 5619.5785316101255, 5629.662220266777, 5633.57748168889, 5634.3802181759975, 5618.0449323615085, 5641.774329026834, 5658.603897727161, 5658.632188907708, 5659.915101273484, 5589.385167631557, 5645.237892884449, 5647.124695672177, 5648.03983322832, 5649.870025994817, 25848.0, 26072.60891086635, 26344.0, 26373.0, 26374.47251054968, 3073.3545955349405, 3078.1996680862912, 3088.459519584064, 3097.1482842218343, 3110.2690867646083, 18200.726989095176, 18226.726599101024, 18248.270069197217, 18379.72430413545, 18739.625207495774, 2471.159805666064, 2552.6043463263222, 2596.1692258477296, 2600.0128713508416, 2755.3249453883727, 243252.0, 243624.0, 245128.0, 246143.0, 246209.0, 50858.491415086115, 51228.0, 51390.22914656283, 51427.48572514227, 51543.226851597254, 31208.687913121033, 32194.678053219635, 32285.51571726426, 34374.48438273428, 55755.0, 13801.51694690681, 14014.089084209698, 14017.509387171604, 14020.0, 14024.71950560983, 9637.325387222827, 9696.36973596728, 9708.951455242819, 9712.3201375903, 9733.659321923698, 17100.315987360365, 17122.555241302794, 17159.0, 17198.0, 17298.481045568402, 6594.340565943367, 6601.76893808724, 6650.86698266032, 6671.933280667228, 6771.153605799275, 815.2255357410484, 844.1995957354005, 861.7802460372565, 955.8327292723745, 985.2462865907586, 25545.23364299074, 25614.359641008752, 25653.0, 26121.608175877376, 26164.738352616612, 953.3421938862163, 955.7276176289724, 959.5490119643756, 970.8592254123113, 979.9755006124761, 13282.867171328357, 13776.655583610289, 14061.226632535105, 14087.22520261375, 14238.928805355907, 283632.0, 286459.0, 286546.0, 286728.0, 286962.0, 40765.796171018956, 41102.779444110696, 41132.58867411288, 41280.793596032425, 41304.79347603243, 1034.886162522122, 1100.5157730598512, 1128.9774204516027, 1154.076738609126, 1160.1067178272683, 23728.169514066925, 25772.742272577783, 26663.867100599437, 27096.32259193536, 27176.320591985357, 40036.0, 40463.797681011405, 40579.79710101431, 40596.59403405928, 40629.1874162521, 265257.0, 266408.0, 267178.0, 267259.0, 267929.0, 20078.0, 20879.686804698245, 22154.66767998449, 22685.886570567043, 22986.655200172347, 36072.639273606925, 36515.63484365122, 36679.81660091683, 37021.81489092537, 37655.0, 31408.842955785076, 31726.365472689955, 31747.682523174473, 31881.68118318787, 32076.679233208302, 30928.53607195939, 31027.379452410372, 32058.519122213653, 32121.10318934382, 32468.0, 31287.374252515277, 31907.840460797546, 32206.19484512906, 32208.83895580507, 32216.83891580527, 26839.0, 29122.0, 29386.0, 29504.114876553736, 29632.703672962994, 22983.770162298162, 23002.53994920059, 23043.76956230483, 23160.768392316535, 23182.884085579462], "value": 14812.223464372919, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.96877281044704, 357.51378125748977, 362.59389483778153, 368.40134780980907, 391.54385141310377, 9590.664326748565, 10355.948220258908, 11462.369569673676, 11712.590059347924, 12262.693432664188, 15688.607784805386, 16138.273777680004, 16182.7572586411, 16259.51221463355, 16313.655700581381, 3957.2283404736017, 4231.936520952188, 4258.893527661802, 4271.6155546000855, 4273.679474039444, 3971.066799302176, 4077.3476243800997, 4105.178964207155, 4134.958650413502, 4165.250254954107, 4120.072983578701, 4121.587841215869, 4125.257453658341, 4126.587341265865, 4126.8968275793195, 3958.7426817256787, 4097.528784189826, 4101.384792281182, 4101.835926562934, 4108.917821643566, 3810.2950954073585, 3852.9614703852885, 3853.383458646631, 3855.4409610606585, 3859.826307816155, 16129.596760080974, 16411.0, 16478.505644830675, 16634.50096497107, 16722.66554668912, 1872.4757068020976, 1890.1022014543119, 1997.0913234478278, 2104.347652227799, 2401.8438801477846, 10731.463426828628, 10919.836202456969, 11093.944530277378, 11342.886571134348, 11504.712382190512, 1410.6684929041667, 1451.0, 1530.900491468051, 1544.2047345616904, 1547.9845201547953, 61733.07400388953, 73747.63126184388, 77791.61104194443, 78349.60825195894, 81580.0, 15883.841161588467, 16344.18279086041, 16345.101019444044, 16358.0, 17449.0, 28506.71493285082, 28574.714252857204, 28643.856780715963, 28646.140615781558, 28730.138095857157, 8557.35819813504, 8826.338024648177, 8940.552972351357, 9106.27149828012, 9146.496942668084, 7321.670524826395, 7344.632768361561, 7373.705051797868, 7566.35685966699, 7583.203763604853, 6795.490338224653, 8253.628586713612, 8386.37102217324, 8405.537695426689, 8430.693242547415, 3133.9031339031158, 3265.9020229393154, 3283.8522266498067, 3320.7841490303053, 3348.799072055636, 816.2205094135087, 822.6750433578703, 844.2190973349627, 861.6553378648591, 885.9822803543893, 16239.431619893483, 16695.24871380791, 16905.408310709066, 17370.305187792346, 17518.737218941726, 846.1284876577135, 853.8463076646264, 872.376250980552, 891.0457854329817, 897.3808072430003, 9382.765430864147, 9493.572789224363, 9570.085982803466, 9625.51872406377, 9833.655822046194, 330817.0, 343419.0, 352311.0, 352478.0, 352728.0, 73234.0, 73472.63263683647, 74111.25888741152, 74981.62509187419, 75940.62029689817, 882.161946151159, 887.6538150121457, 909.3725329522608, 912.9452232866049, 930.6742640076054, 14728.852711472748, 15078.924605376902, 15581.688366232385, 15601.84398156004, 15784.21078946071, 38056.61943380531, 38284.42573361346, 38471.230575388894, 39296.2140757189, 39342.0, 49887.75056124842, 50856.0, 51564.0, 51581.0, 51619.0, 6474.838129046811, 6909.2399836019, 7143.357097861218, 7203.351698347174, 7238.674259658434, 10101.393916365041, 11610.88389116098, 11878.643640690792, 11908.702282442662, 11961.401929903644, 9713.465759383302, 10258.846117308098, 10412.27114102036, 10514.684559462923, 10743.677689669323, 8825.205731484197, 9429.952850235704, 10465.267431279737, 10488.842667359842, 10536.57853685844, 10168.28821982454, 10302.52335145684, 10317.638882639072, 10401.375917444977, 10873.293235939638, 6702.497312701665, 6864.7940561783225, 6891.724331026703, 7043.683034263573, 7072.469564782559, 8174.877376839233, 9092.545372731469, 9765.316427849983, 9946.45294508809, 10088.0], "value": 8295.250985442923, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1220.9389530523472, 1309.7773378525653, 1341.02105463012, 1381.9930900345503, 1639.7130502162127, 5576.637518561291, 5972.492338151257, 6096.969515152429, 6383.2340119185765, 6389.520785941061, 6234.937650623492, 6307.053941908716, 6307.77922772703, 6308.211473565804, 6312.905306420407, 1690.2140504665329, 1723.8965662060255, 1727.9136043197852, 1727.9395221167263, 1728.4641761054052, 1689.2145152504083, 1739.0, 1741.355698391597, 1744.886582372148, 1746.397492864966, 1722.5874782678209, 1741.5820203151216, 1743.128435782109, 1743.581540430294, 1744.9912750436295, 1684.991575042123, 1698.5838469574971, 1698.702727022766, 1716.7081596128687, 1718.9484315470556, 1693.7713408689792, 1712.1097029544692, 1714.0658341203948, 1716.3134746101534, 1716.5022143578346, 6208.379162083801, 6215.595986260879, 6226.533010024266, 6269.62382257066, 6309.305976342599, 4122.876313710593, 4271.380649805792, 4282.0, 4293.957060429387, 4304.526502084768, 2575.2016874768883, 2694.5015172193207, 2764.640596722433, 2765.2119146043283, 2771.3210263485375, 787.9251471110235, 791.0, 809.2150613904503, 811.4928169893816, 827.5986146718836, 8632.179942905414, 8729.60716767747, 8738.781530461789, 8740.51927144007, 8745.518996455192, 3541.6812486876306, 3696.2977034363385, 3759.473673685686, 3852.5184351956004, 3856.36369998947, 6889.138857642794, 6891.552049116792, 6894.345037221557, 6895.275996020346, 6896.620685862225, 4044.8988775280854, 4049.250888585621, 4051.716379853441, 4054.8378064877666, 4066.2274167908004, 3497.5453191085, 3614.765040272374, 3777.036855601804, 3778.7732736035928, 3782.0733920189728, 2951.5130003549175, 3055.801372910754, 3063.2998685729635, 3114.065780265911, 3134.605100730199, 952.6903756279237, 954.203240294362, 957.5451660461225, 958.4009993753904, 977.0522593084696, 797.1510341486298, 797.5812698333422, 801.1667865420014, 820.4707963363597, 820.7373640435123, 4295.8496452624, 4374.890627734332, 4483.596476317147, 4539.5460453955, 4658.021815418732, 786.5909726941958, 797.8232107641182, 803.5660743198607, 812.634314558451, 832.3715594725943, 3179.825109618947, 3189.9681003190135, 3233.951490727641, 3257.478803391446, 3304.9504257436156, 7803.765887023398, 7962.6416811243635, 8029.0, 8031.839363212703, 8050.11448740638, 7982.121966583672, 7989.480683755537, 7994.320482758914, 7999.240072193133, 8004.479708818908, 6209.410106039919, 6261.7182226799905, 6313.084602732578, 6319.526035547352, 6321.557490975588, 4559.361689363425, 4596.540345965511, 4599.2871104978785, 4636.698614590041, 4668.346431499661, 7236.819079523054, 7484.288992545699, 7518.699252029857, 7543.43424243173, 7543.7736867894055, 7557.093148822177, 7563.3193012626925, 7601.353884919844, 7630.8092297693, 7649.732259370895, 5804.622699524517, 5966.880662386815, 6005.699715014144, 6020.939790602038, 6054.48536874353, 5745.253117094751, 5954.404559544184, 6288.151099601495, 6548.050532672641, 6562.146920900253, 5849.502792262705, 5907.3501914790195, 5919.141724450017, 5925.200097986716, 5958.582899197015, 5826.329972053099, 5841.737121829613, 5930.584859059824, 5932.436418540232, 5942.821715348547, 5438.782448702166, 5441.483059109379, 5447.346318441812, 5481.945180548143, 5497.615166938276, 4044.0698639312536, 4132.40080188377, 4149.336106223111, 4223.831046758218, 4353.73877567347, 4089.8737828348494, 4091.488563929509, 4096.877093687194, 4188.790560472025, 4259.190753756776], "value": 3535.618070939712, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.9704029597041, 299.9670036296007, 302.7169596427341, 304.64052418146576, 306.5524334471671, 4841.467438581753, 4861.295112208728, 4882.487338829425, 4893.7797799099035, 4899.975500122503, 4764.332993380929, 4790.904181916359, 4793.496682848294, 4821.855344339667, 4831.3719216501895, 3574.53531040965, 3691.7046636269033, 3692.0769807548113, 3707.703383729295, 3800.9809950950207, 3790.4314352847155, 3803.961960380402, 3825.9617403825882, 3827.8086095695244, 3845.9807700961455, 3799.8290076946605, 3811.8475260989667, 3815.828287727059, 3815.931539169037, 3819.2552452271816, 3606.5672119345713, 3663.5420572428447, 3722.88831335059, 3781.5273090863643, 3823.636754508317, 3363.1255873473074, 3366.7474939379645, 3375.780574262665, 3380.107140001607, 3390.779599326036, 4656.464506581752, 4666.3900954171095, 4669.809198654355, 4692.976535117336, 4698.38920940279, 4201.2017716633745, 4297.419848320468, 4314.546972567898, 4314.756326710125, 4320.762358070305, 4959.181735013718, 4982.202847544376, 4985.501449854985, 4990.4011518617635, 5037.9244311335, 3677.3380791457525, 3683.797391143486, 3697.4638677391627, 3712.9257414851822, 3720.9441858372147, 5143.794248230104, 5267.578593712494, 5280.0, 5295.973520132375, 5317.494837990384, 3732.2831497511447, 3774.830132644038, 3784.6215378461934, 3793.3172029034486, 3799.981000094982, 3851.8844434667003, 3860.2279544091293, 3865.2655995361356, 3877.662206538796, 3894.668953139015, 4357.128574285156, 4363.36731173978, 4364.781760911942, 4369.453818272716, 4389.714668546534, 4841.201201801734, 4995.600351971833, 5029.899402011939, 5041.79832806691, 5101.913342427852, 1285.190330092036, 1297.9935100324437, 1301.9414126364336, 1305.4582348325528, 1305.9813345590455, 855.9186877246651, 899.9055099214619, 905.7418635688797, 910.3263584947091, 915.7069737683877, 4308.784560771949, 4351.173277077409, 4405.449318835145, 4423.314386270134, 4492.663050271242, 5122.410922743858, 5139.177731562932, 5146.25379320004, 5184.289184569083, 5212.192110222922, 4439.245328294198, 4474.261746811805, 4482.708623939434, 4485.25993211123, 4485.349624304457, 2522.2937577478338, 2636.6816591704146, 2644.6165306030516, 2646.2325925481396, 2655.1901669990452, 4670.346151538787, 4697.6711630185555, 4706.576408123286, 4715.8210447388155, 4725.834595789131, 5100.770465329069, 5108.412532558803, 5108.514691104339, 5109.693418394908, 5118.206677964921, 4592.494825569184, 4709.882252943636, 4918.409790825124, 4938.012397520511, 4946.307516947702, 5163.690178589297, 5219.191025390918, 5225.608079393985, 5230.137027390438, 5235.4764523548865, 5139.383274007143, 5140.203268493389, 5144.76848541824, 5156.607715916756, 5165.922511162411, 4657.883552911068, 4890.559849613552, 4909.558139767438, 4916.631252655993, 4934.322330407678, 3570.696490798311, 3586.9103272418397, 3587.3004764070756, 3591.76653517531, 3626.8005259710967, 5192.506711862367, 5202.791888324425, 5226.085435048927, 5245.606579506476, 5262.631615786858, 4991.675541089818, 5025.924611130763, 5063.544281014726, 5064.215046667772, 5070.873228169326, 4976.30331753562, 5045.419776725576, 5050.641323519965, 5053.4946505350645, 5058.215976523645, 4972.726500042532, 4973.975130124326, 4982.576480999156, 4988.176950803077, 4998.1503144464805, 4838.225883858566, 4910.508949105061, 5051.2423136529815, 5079.593632509464, 5098.5411312982005, 4847.3698419205275, 4866.756662166948, 4973.701577905193, 4982.975085124551, 4983.152864013199], "value": 3809.9093966184455, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [594.3684585811947, 594.7710131599333, 658.8748137853811, 681.4310051107325, 682.9180498340199, 10714.142868570516, 10979.121670266379, 11362.545498180083, 11491.885081149187, 11511.36687482188, 11017.394043327613, 11156.721081972935, 11161.0, 11175.385353805537, 11178.664640060812, 615.7167702856691, 628.9465395441393, 742.3689863615924, 756.9772906812805, 760.9657565409569, 741.7329761285932, 753.8869169624545, 765.9617019149048, 770.8959290495767, 771.2364758888688, 807.8263173417714, 814.6741303478597, 816.1348970091692, 816.6161903905185, 817.3502065857627, 810.0643756461296, 811.2252798577344, 811.9188081191893, 812.4962523235632, 813.5118928642826, 596.83885350955, 598.0670154558859, 598.5181928547518, 598.5540772124751, 598.6767145741294, 10372.377657340583, 10403.219758518066, 10404.68785936423, 10407.375557466501, 10418.0, 9457.43255404678, 9556.474393908333, 9609.13517783396, 9657.613695452173, 10177.18582513397, 8286.46138001028, 8288.544130072843, 8377.916220837775, 8390.790230244233, 8397.244248017707, 2458.8155888308447, 2484.714257860333, 2496.226169887341, 2529.696436427622, 2551.8979240830345, 45217.0, 46487.76756116198, 47450.28824567634, 47566.0, 49158.0, 6975.0, 7036.718531258794, 7484.513506622052, 7492.51298665585, 7558.319751222306, 15106.471273505374, 15108.54674359771, 15117.470888518848, 15122.924385378003, 15203.163825989455, 6341.112244285804, 6425.10048593188, 6544.869102618016, 6607.108040414579, 6780.118584583973, 3377.071410054481, 3396.633170571812, 3447.637998010223, 3484.738644601665, 3614.8373323200517, 2613.568761154388, 2649.655544779205, 2669.599560066006, 2691.1253842501264, 2796.5385711357803, 471.37542755847954, 474.563401670464, 480.48348025872326, 481.1819906159473, 488.47976904597203, 548.5310059898809, 555.7415801652251, 557.3534699748272, 575.0569066730566, 585.3034888482692, 6536.509761767887, 6807.319268073153, 7156.499045066899, 7379.963100184572, 7423.369013633794, 496.94036715593637, 507.710604955172, 524.5855773938622, 554.6588847858538, 578.7337824600646, 3410.7271418286477, 3526.4710293455673, 3610.9638903610626, 3689.760165589228, 3776.981115094462, 42475.15049699051, 53920.460795392326, 55893.44106558882, 56465.15302270469, 61604.69197653983, 35724.821375892956, 37333.81333093371, 50304.74847625739, 56636.43363566312, 59061.0, 51482.48517514777, 51717.7414112927, 52689.2096618551, 52815.20777188422, 53200.81788958518, 6928.653567321715, 7028.9297107030325, 7042.0, 7071.0, 7450.888236676563, 35873.82063089668, 36426.27147457089, 36530.0, 36601.45097823482, 37265.0, 48677.2698409517, 49506.0, 49870.50129498804, 49891.50108498868, 51687.2246916289, 8444.873326899979, 8574.78563035929, 8575.142485751376, 8670.78323041929, 8977.0, 10158.238132140266, 10213.744656383353, 10274.589016439259, 10314.48427578603, 10453.738656533647, 9320.95339523298, 9428.15146636806, 9618.470984095942, 9641.325107242426, 9667.613295468103, 9553.856692149484, 9562.713118606453, 9583.520823958635, 9668.323217374716, 9764.60941562358, 9009.459432434074, 9063.954680226556, 9161.31290153228, 9262.861057084285, 9290.349675522648, 7807.648655810389, 7981.122076571689, 8016.95991520062, 8128.227818357246, 8224.465409748347, 8354.87467687973, 8394.24451799341, 8416.915830841857, 8522.141099912567, 8862.867056994279], "value": 5472.631506947113, "unit": "score"}], "name": "dromaeo_css", "value": 5899.93569523864, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 117.0, 115.0, 115.0, 116.0, 116.0, 116.0, 116.0, 116.0, 115.0], "value": 115.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 131.0, 128.0, 160.0, 132.0, 131.0, 134.0, 130.0, 160.0, 140.0], "value": 140.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 164.0, 163.0, 163.0, 161.0, 169.0, 162.0, 162.0, 162.0, 161.0], "value": 163.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 79.0, 76.0, 105.0, 76.0, 77.0, 77.0, 78.0, 110.0, 77.0], "value": 83.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 123.0, 83.0, 85.0, 84.0, 113.0, 85.0, 84.0, 131.0], "value": 95.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 147.0, 147.0, 148.0, 147.0, 146.0, 146.0, 147.0, 147.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 63.0, 66.0, 65.0, 65.0, 64.0, 64.0, 65.0, 65.0], "value": 64.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 66.0, 65.0, 66.0, 65.0, 65.0, 66.0, 66.0], "value": 65.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 84.0, 85.0, 83.0, 84.0, 84.0, 88.0, 93.0, 86.0], "value": 85.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 142.0, 142.0, 139.0, 139.0, 151.0, 142.0, 141.0, 191.0, 142.0], "value": 147.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 176.0, 177.0, 175.0, 174.0, 181.0, 176.0, 177.0, 176.0, 177.0], "value": 177.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 71.0, 68.0, 69.0, 69.0, 68.0, 67.0, 68.0, 68.0, 67.0], "value": 68.4, "unit": "score"}], "name": "kraken", "value": 1565.6, "alertThreshold": 2.0}]} 05:25:41 INFO - Return code: 0 05:25:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:25:41 INFO - # TBPL SUCCESS # 05:25:41 INFO - Running post-action listener: _resource_record_post_action 05:25:41 INFO - [mozharness: 2016-11-17 13:25:41.449060Z] Finished run-tests step (success) 05:25:41 INFO - Running post-run listener: _resource_record_post_run 05:25:41 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 4096; Write bytes: 392347648; Read time: 12; Write time: 272076 05:25:41 INFO - TinderboxPrint: CPU usage
13.0% 05:25:41 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 05:25:41 INFO - TinderboxPrint: I/O write bytes / time
392,347,648 / 272,076 05:25:41 INFO - TinderboxPrint: CPU idle
8,346.2 (86.9%) 05:25:41 INFO - TinderboxPrint: CPU user
1,203.8 (12.5%) 05:25:41 INFO - TinderboxPrint: Swap in / out
0 / 0 05:25:41 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99065856; Read time: 0; Write time: 56036 05:25:41 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 293281792; Read time: 0; Write time: 216040 05:25:42 INFO - Running post-run listener: _upload_blobber_files 05:25:42 INFO - Blob upload gear active. 05:25:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:25:42 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:25:42 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', 'Cedar', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:25:42 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 Cedar -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:25:42 INFO - (blobuploader) - INFO - Open directory for files ... 05:25:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:25:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:25:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:25:45 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:25:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:25:45 INFO - (blobuploader) - INFO - Done attempting. 05:25:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:25:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:25:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:25:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:25:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:25:46 INFO - (blobuploader) - INFO - Done attempting. 05:25:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:25:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:25:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:25:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:25:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:25:47 INFO - (blobuploader) - INFO - Done attempting. 05:25:47 INFO - (blobuploader) - INFO - Iteration through files over. 05:25:47 INFO - Return code: 0 05:25:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:25:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:25:47 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/085963a9d6fd356640c6573fc8f444478da0a314c4eb95e4a2fdd400d324d0c50dd6ce5632b4c3831401d44371356dbde4a13d2829c41f50b4b35beb87ca3885", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/c6b01ab7f5ce2f28fef4c90ec6aa5b91aa6ab6cd4e1ff6dcaacef360095d472c268960bef809f06bd8d40a12d99f60adb3701f172d4abedc65fd17d3ce0a76de", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/623732363316df6522e0013503d70f0ef8c3e2e0a85dc8293c30de523e92e7dbd721667ac67a96b505e96fe5da78c920f82190b3c9c33febd448845b1cae1337"} 05:25:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:25:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:25:47 INFO - Contents: 05:25:47 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/085963a9d6fd356640c6573fc8f444478da0a314c4eb95e4a2fdd400d324d0c50dd6ce5632b4c3831401d44371356dbde4a13d2829c41f50b4b35beb87ca3885", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/c6b01ab7f5ce2f28fef4c90ec6aa5b91aa6ab6cd4e1ff6dcaacef360095d472c268960bef809f06bd8d40a12d99f60adb3701f172d4abedc65fd17d3ce0a76de", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/623732363316df6522e0013503d70f0ef8c3e2e0a85dc8293c30de523e92e7dbd721667ac67a96b505e96fe5da78c920f82190b3c9c33febd448845b1cae1337"} 05:25:47 INFO - Running post-run listener: copy_logs_to_upload_dir 05:25:47 INFO - Copying logs to upload dir... 05:25:47 INFO - mkdir: /builds/slave/test/build/upload/logs 05:25:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.057497 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-11-17 05:25:46.077124) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-17 05:25:46.081382) ========= 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=32c5991c409366f7fec8a718000001d2-1479386971.676950-1929419083 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/085963a9d6fd356640c6573fc8f444478da0a314c4eb95e4a2fdd400d324d0c50dd6ce5632b4c3831401d44371356dbde4a13d2829c41f50b4b35beb87ca3885", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/c6b01ab7f5ce2f28fef4c90ec6aa5b91aa6ab6cd4e1ff6dcaacef360095d472c268960bef809f06bd8d40a12d99f60adb3701f172d4abedc65fd17d3ce0a76de", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/623732363316df6522e0013503d70f0ef8c3e2e0a85dc8293c30de523e92e7dbd721667ac67a96b505e96fe5da78c920f82190b3c9c33febd448845b1cae1337"} build_url:https://queue.taskcluster.net/v1/task/YTRb5Uh2T-m1hqgN9Iv_sQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011324 build_url: 'https://queue.taskcluster.net/v1/task/YTRb5Uh2T-m1hqgN9Iv_sQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/085963a9d6fd356640c6573fc8f444478da0a314c4eb95e4a2fdd400d324d0c50dd6ce5632b4c3831401d44371356dbde4a13d2829c41f50b4b35beb87ca3885", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/c6b01ab7f5ce2f28fef4c90ec6aa5b91aa6ab6cd4e1ff6dcaacef360095d472c268960bef809f06bd8d40a12d99f60adb3701f172d4abedc65fd17d3ce0a76de", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/623732363316df6522e0013503d70f0ef8c3e2e0a85dc8293c30de523e92e7dbd721667ac67a96b505e96fe5da78c920f82190b3c9c33febd448845b1cae1337"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-17 05:25:46.114296) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 05:25:46.114875) ========= 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=32c5991c409366f7fec8a718000001d2-1479386971.676950-1929419083 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004530 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 05:25:46.197867) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-17 05:25:46.198207) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-17 05:25:46.198520) ========= ========= Total master_lag: 0.42 =========