builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-041 starttime: 1475793420.74 results: success (0) buildid: 20161006123013 builduid: b2ee9b87bee3438c822ad40b183950a9 revision: ef345e3b5fa9fabdfd7d0a93ff01ec9c085968df ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-06 15:37:00.736441) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-06 15:37:00.737005) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-06 15:37:00.737330) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-06 15:37:00.754459) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 15:37:00.754801) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c6b6742ce8f6f39ef4ce27d000001f1-1475793420.328211-2058082381 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-06 15:37:01-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 37.9M=0s 2016-10-06 15:37:01 (37.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.087558 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 15:37:00.856741) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 15:37:00.857108) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c6b6742ce8f6f39ef4ce27d000001f1-1475793420.328211-2058082381 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016994 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 15:37:00.910306) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-06 15:37:00.911229) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ef345e3b5fa9fabdfd7d0a93ff01ec9c085968df --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev ef345e3b5fa9fabdfd7d0a93ff01ec9c085968df --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c6b6742ce8f6f39ef4ce27d000001f1-1475793420.328211-2058082381 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-06 15:37:01,234 truncating revision to first 12 chars 2016-10-06 15:37:01,234 Setting DEBUG logging. 2016-10-06 15:37:01,235 attempt 1/10 2016-10-06 15:37:01,235 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ef345e3b5fa9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-06 15:37:02,604 unpacking tar archive at: fx-team-ef345e3b5fa9/testing/mozharness/ program finished with exit code 0 elapsedTime=1.699490 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-06 15:37:02.626684) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-06 15:37:02.627064) ========= script_repo_revision: ef345e3b5fa9fabdfd7d0a93ff01ec9c085968df ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-06 15:37:02.627550) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-06 15:37:02.627887) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-06 15:37:02.637539) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-10-06 15:37:02.638009) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c6b6742ce8f6f39ef4ce27d000001f1-1475793420.328211-2058082381 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:37:03 INFO - MultiFileLogger online at 20161006 15:37:03 in /builds/slave/test 15:37:03 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 15:37:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:37:03 INFO - {'append_to_log': False, 15:37:03 INFO - 'base_work_dir': '/builds/slave/test', 15:37:03 INFO - 'blob_upload_branch': 'Fx-Team', 15:37:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:37:03 INFO - 'branch': 'Fx-Team', 15:37:03 INFO - 'buildbot_json_path': 'buildprops.json', 15:37:03 INFO - 'config_files': ('talos/linux_config.py',), 15:37:03 INFO - 'default_actions': ('clobber', 15:37:03 INFO - 'read-buildbot-config', 15:37:03 INFO - 'download-and-extract', 15:37:03 INFO - 'populate-webroot', 15:37:03 INFO - 'create-virtualenv', 15:37:03 INFO - 'install', 15:37:03 INFO - 'run-tests'), 15:37:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:37:03 INFO - 'download_minidump_stackwalk': True, 15:37:03 INFO - 'download_symbols': 'ondemand', 15:37:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:37:03 INFO - 'tooltool.py': '/tools/tooltool.py', 15:37:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:37:03 INFO - '/tools/misc-python/virtualenv.py')}, 15:37:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:37:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:37:03 INFO - 'installer_path': 'installer.exe', 15:37:03 INFO - 'log_level': 'info', 15:37:03 INFO - 'log_name': 'talos', 15:37:03 INFO - 'log_to_console': True, 15:37:03 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:37:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:37:03 INFO - 'opt_config_files': (), 15:37:03 INFO - 'pip_index': False, 15:37:03 INFO - 'sps_profile': False, 15:37:03 INFO - 'sps_profile_interval': 0, 15:37:03 INFO - 'suite': 'dromaeojs', 15:37:03 INFO - 'system_bits': '32', 15:37:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:37:03 INFO - 'title': 'talos-linux64-ix-041', 15:37:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:37:03 INFO - 'use_talos_json': True, 15:37:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:37:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:37:03 INFO - 'work_dir': 'build'} 15:37:03 INFO - [mozharness: 2016-10-06 22:37:03.052368Z] Running clobber step. 15:37:03 INFO - Running pre-action listener: _resource_record_pre_action 15:37:03 INFO - Running main action method: clobber 15:37:03 INFO - rmtree: /builds/slave/test/build 15:37:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:37:03 INFO - Running post-action listener: _resource_record_post_action 15:37:03 INFO - [mozharness: 2016-10-06 22:37:03.519927Z] Finished clobber step (success) 15:37:03 INFO - [mozharness: 2016-10-06 22:37:03.520030Z] Running read-buildbot-config step. 15:37:03 INFO - Running pre-action listener: _resource_record_pre_action 15:37:03 INFO - Running main action method: read_buildbot_config 15:37:03 INFO - Using buildbot properties: 15:37:03 INFO - { 15:37:03 INFO - "project": "", 15:37:03 INFO - "product": "firefox", 15:37:03 INFO - "script_repo_revision": "production", 15:37:03 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 15:37:03 INFO - "repository": "", 15:37:03 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 15:37:03 INFO - "buildid": "20161006123013", 15:37:03 INFO - "pgo_build": "True", 15:37:03 INFO - "basedir": "/builds/slave/test", 15:37:03 INFO - "buildnumber": 1113, 15:37:03 INFO - "slavename": "talos-linux64-ix-041", 15:37:03 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:37:03 INFO - "platform": "ubuntu64_hw", 15:37:03 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 15:37:03 INFO - "branch": "fx-team", 15:37:03 INFO - "repo_path": "integration/fx-team", 15:37:03 INFO - "revision": "ef345e3b5fa9fabdfd7d0a93ff01ec9c085968df", 15:37:03 INFO - "stage_platform": "linux64-pgo", 15:37:03 INFO - "builduid": "b2ee9b87bee3438c822ad40b183950a9", 15:37:03 INFO - "slavebuilddir": "test" 15:37:03 INFO - } 15:37:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/L5CadNaoTp2DYS2r7D6mLQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 15:37:03 INFO - Running post-action listener: _resource_record_post_action 15:37:03 INFO - [mozharness: 2016-10-06 22:37:03.522482Z] Finished read-buildbot-config step (success) 15:37:03 INFO - [mozharness: 2016-10-06 22:37:03.522571Z] Running download-and-extract step. 15:37:03 INFO - Running pre-action listener: _resource_record_pre_action 15:37:03 INFO - Running main action method: download_and_extract 15:37:03 INFO - mkdir: /builds/slave/test/build/tests 15:37:03 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')]} 15:37:03 INFO - trying https://queue.taskcluster.net/v1/task/L5CadNaoTp2DYS2r7D6mLQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 15:37:03 INFO - Downloading https://queue.taskcluster.net/v1/task/L5CadNaoTp2DYS2r7D6mLQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 15:37:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/L5CadNaoTp2DYS2r7D6mLQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 15:37:04 INFO - Downloaded 1361 bytes. 15:37:04 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 15:37:04 INFO - Using the following test package requirements: 15:37:04 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 15:37:04 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:37:04 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:37:04 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:37:04 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:37:04 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:37:04 INFO - u'jsshell-linux-x86_64.zip'], 15:37:04 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:37:04 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:37:04 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 15:37:04 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:37:04 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:37:04 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:37:04 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:37:04 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:37:04 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:37:04 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:37:04 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:37:04 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:37:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/L5CadNaoTp2DYS2r7D6mLQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 15:37:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/L5CadNaoTp2DYS2r7D6mLQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:37:04 INFO - Fetch https://queue.taskcluster.net/v1/task/L5CadNaoTp2DYS2r7D6mLQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 15:37:04 INFO - Http code: 200 15:37:04 INFO - via: 1.1 5c2ff4ca1e447265402af29264e83497.cloudfront.net (CloudFront) 15:37:04 INFO - x-amz-cf-id: nsrNeAvFeVT5gvmtyey_I6KlSr3Cxvyz5-CmmzzOI7BtBuN5y25XDQ== 15:37:04 INFO - x-amz-version-id: X4vMAY1GdDTMONcQybUW1ESDrkIEaa86 15:37:04 INFO - Expected file size: 22018140 15:37:04 INFO - Obtained file size: 22018140 15:37:08 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:37:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/L5CadNaoTp2DYS2r7D6mLQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 15:37:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/L5CadNaoTp2DYS2r7D6mLQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:37:08 INFO - Fetch https://queue.taskcluster.net/v1/task/L5CadNaoTp2DYS2r7D6mLQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 15:37:09 INFO - Http code: 200 15:37:09 INFO - via: 1.1 e2af8a85927835558866752f53562ecd.cloudfront.net (CloudFront) 15:37:09 INFO - x-amz-cf-id: We_kQacBE8QMk8Z4EgUsAHIYy-aC6GV1eDWjwJ9V3SD-0ywlniVReA== 15:37:09 INFO - x-amz-version-id: X4vMAY1GdDTMONcQybUW1ESDrkIEaa86 15:37:09 INFO - Expected file size: 22018140 15:37:09 INFO - Obtained file size: 22018140 15:37:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/L5CadNaoTp2DYS2r7D6mLQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 15:37:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/L5CadNaoTp2DYS2r7D6mLQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:37:14 INFO - Fetch https://queue.taskcluster.net/v1/task/L5CadNaoTp2DYS2r7D6mLQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 15:37:14 INFO - Http code: 200 15:37:14 INFO - via: 1.1 bb8a7ff26b131d51953dc2d3e19a2751.cloudfront.net (CloudFront) 15:37:14 INFO - x-amz-cf-id: HMfxEObI7raSXb-Z3rpyGngsZoHn4g8afB9hyA8BnebRPTXuzXjw4w== 15:37:14 INFO - x-amz-version-id: 1ZSe9Rpsdr0D1hP09gW8lXucYeGyd1kf 15:37:15 INFO - Expected file size: 14409006 15:37:15 INFO - Obtained file size: 14409006 15:37:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:37:15 INFO - trying https://queue.taskcluster.net/v1/task/L5CadNaoTp2DYS2r7D6mLQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:37:15 INFO - Downloading https://queue.taskcluster.net/v1/task/L5CadNaoTp2DYS2r7D6mLQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:37:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/L5CadNaoTp2DYS2r7D6mLQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:37:16 INFO - Downloaded 59705984 bytes. 15:37:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/L5CadNaoTp2DYS2r7D6mLQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:37:16 INFO - mkdir: /builds/slave/test/properties 15:37:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:37:16 INFO - Writing to file /builds/slave/test/properties/build_url 15:37:16 INFO - Contents: 15:37:16 INFO - build_url:https://queue.taskcluster.net/v1/task/L5CadNaoTp2DYS2r7D6mLQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:37:17 INFO - Running post-action listener: _resource_record_post_action 15:37:17 INFO - Running post-action listener: set_extra_try_arguments 15:37:17 INFO - [mozharness: 2016-10-06 22:37:17.191294Z] Finished download-and-extract step (success) 15:37:17 INFO - [mozharness: 2016-10-06 22:37:17.191521Z] Running populate-webroot step. 15:37:17 INFO - Running pre-action listener: _resource_record_pre_action 15:37:17 INFO - Running main action method: populate_webroot 15:37:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:37:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:37:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:37:17 INFO - '--tppagecycles', 15:37:17 INFO - '7'], 15:37:17 INFO - 'tests': ['tsvgm']}}, 15:37:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:37:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:37:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:37:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:37:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:37:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:37:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:37:17 INFO - 'talos_options': ['--disable-e10s'], 15:37:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:37:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:37:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:37:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:37:17 INFO - 'talos_options': ['--disable-e10s'], 15:37:17 INFO - 'tests': ['damp', 'tps']}, 15:37:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:37:17 INFO - 'tests': ['damp', 'tps']}, 15:37:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:37:17 INFO - 'tests': ['dromaeo_dom']}, 15:37:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:37:17 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:37:17 INFO - 'tests': ['basic_compositor_video']}, 15:37:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:37:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:37:17 INFO - 'tests': ['a11yr', 15:37:17 INFO - 'ts_paint', 15:37:17 INFO - 'tpaint', 15:37:17 INFO - 'sessionrestore', 15:37:17 INFO - 'sessionrestore_no_auto_restore', 15:37:17 INFO - 'tabpaint']}, 15:37:17 INFO - 'other-e10s': {'tests': ['a11yr', 15:37:17 INFO - 'ts_paint', 15:37:17 INFO - 'tpaint', 15:37:17 INFO - 'sessionrestore', 15:37:17 INFO - 'sessionrestore_no_auto_restore', 15:37:17 INFO - 'tabpaint']}, 15:37:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:37:17 INFO - 'ts_paint', 15:37:17 INFO - 'tpaint', 15:37:17 INFO - 'sessionrestore', 15:37:17 INFO - 'sessionrestore_no_auto_restore', 15:37:17 INFO - 'tabpaint']}, 15:37:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:37:17 INFO - 'ts_paint', 15:37:17 INFO - 'tpaint', 15:37:17 INFO - 'sessionrestore', 15:37:17 INFO - 'sessionrestore_no_auto_restore', 15:37:17 INFO - 'tabpaint']}, 15:37:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:37:17 INFO - 'tests': ['a11yr', 15:37:17 INFO - 'ts_paint', 15:37:17 INFO - 'tpaint', 15:37:17 INFO - 'sessionrestore', 15:37:17 INFO - 'sessionrestore_no_auto_restore', 15:37:17 INFO - 'tabpaint']}, 15:37:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:37:17 INFO - 'tests': ['a11yr', 15:37:17 INFO - 'ts_paint', 15:37:17 INFO - 'tpaint', 15:37:17 INFO - 'sessionrestore', 15:37:17 INFO - 'sessionrestore_no_auto_restore', 15:37:17 INFO - 'tabpaint']}, 15:37:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:37:17 INFO - 'tests': ['tsvgx', 15:37:17 INFO - 'tsvgr_opacity', 15:37:17 INFO - 'tart', 15:37:17 INFO - 'tscrollx', 15:37:17 INFO - 'cart']}, 15:37:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:37:17 INFO - 'tsvgr_opacity', 15:37:17 INFO - 'tart', 15:37:17 INFO - 'tscrollx', 15:37:17 INFO - 'cart']}, 15:37:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:37:17 INFO - 'talos_options': ['--disable-e10s'], 15:37:17 INFO - 'tests': ['tp5o']}, 15:37:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:37:17 INFO - 'tests': ['tp5o']}, 15:37:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:37:17 INFO - 'talos_options': ['--disable-e10s', 15:37:17 INFO - '--xperf_path', 15:37:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:37:17 INFO - 'tests': ['tp5n']}, 15:37:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:37:17 INFO - 'talos_options': ['--xperf_path', 15:37:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:37:17 INFO - 'tests': ['tp5n']}}, 15:37:17 INFO - 'talos.zip': {'path': '', 15:37:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:37:17 INFO - Running post-action listener: _resource_record_post_action 15:37:17 INFO - [mozharness: 2016-10-06 22:37:17.207687Z] Finished populate-webroot step (success) 15:37:17 INFO - [mozharness: 2016-10-06 22:37:17.207775Z] Running create-virtualenv step. 15:37:17 INFO - Running pre-action listener: _resource_record_pre_action 15:37:17 INFO - Running main action method: create_virtualenv 15:37:17 INFO - Creating virtualenv /builds/slave/test/build/venv 15:37:17 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 15:37:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:37:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:37:17 INFO - Using real prefix '/usr' 15:37:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:37:17 INFO - Installing distribute.............................................................................................................................................................................................done. 15:37:19 INFO - Installing pip.................done. 15:37:19 INFO - Return code: 0 15:37:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:37:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:37:19 INFO - Reading from file tmpfile_stdout 15:37:19 INFO - Output received: 15:37:19 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) 15:37:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:37:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:37:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:37:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:37:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:37:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:37:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:37:20 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 0x7fb926ec0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b21790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1e930>, '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 0x1b1f830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b1fcc0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1475793420.328211-2058082381', '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 15:37:20 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 15:37:20 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 15:37:20 INFO - Using env: {'DISPLAY': ':0', 15:37:20 INFO - 'HOME': '/home/cltbld', 15:37:20 INFO - 'LANG': 'en_US.UTF-8', 15:37:20 INFO - 'LANGUAGE': 'en_US:en', 15:37:20 INFO - 'LOGNAME': 'cltbld', 15:37:20 INFO - 'MAIL': '/var/mail/cltbld', 15:37:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:37:20 INFO - 'MOZ_NO_REMOTE': '1', 15:37:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:37:20 INFO - 'NO_EM_RESTART': '1', 15:37:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:37:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:37:20 INFO - 'PWD': '/builds/slave/test', 15:37:20 INFO - 'SHELL': '/bin/bash', 15:37:20 INFO - 'SHLVL': '1', 15:37:20 INFO - 'TERM': 'linux', 15:37:20 INFO - 'TMOUT': '86400', 15:37:20 INFO - 'USER': 'cltbld', 15:37:20 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1475793420.328211-2058082381', 15:37:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:37:20 INFO - '_': '/tools/buildbot/bin/python'} 15:37:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:37:20 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 15:37:20 INFO - Cleaning up... 15:37:20 INFO - Return code: 0 15:37:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:37:20 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')]} 15:37:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:37:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:37:20 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')]} 15:37:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:37:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:37:20 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 0x7fb926ec0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b21790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1e930>, '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 0x1b1f830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b1fcc0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1475793420.328211-2058082381', '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 15:37:20 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 15:37:20 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 15:37:20 INFO - Using env: {'DISPLAY': ':0', 15:37:20 INFO - 'HOME': '/home/cltbld', 15:37:20 INFO - 'LANG': 'en_US.UTF-8', 15:37:20 INFO - 'LANGUAGE': 'en_US:en', 15:37:20 INFO - 'LOGNAME': 'cltbld', 15:37:20 INFO - 'MAIL': '/var/mail/cltbld', 15:37:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:37:20 INFO - 'MOZ_NO_REMOTE': '1', 15:37:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:37:20 INFO - 'NO_EM_RESTART': '1', 15:37:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:37:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:37:20 INFO - 'PWD': '/builds/slave/test', 15:37:20 INFO - 'SHELL': '/bin/bash', 15:37:20 INFO - 'SHLVL': '1', 15:37:20 INFO - 'TERM': 'linux', 15:37:20 INFO - 'TMOUT': '86400', 15:37:20 INFO - 'USER': 'cltbld', 15:37:20 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1475793420.328211-2058082381', 15:37:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:37:20 INFO - '_': '/tools/buildbot/bin/python'} 15:37:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:37:20 INFO - Downloading/unpacking psutil>=3.1.1 15:37:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:37:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:37:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:37:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:37:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:37:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:37:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:37:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:37:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:37:22 INFO - Installing collected packages: psutil 15:37:22 INFO - Running setup.py install for psutil 15:37:22 INFO - building 'psutil._psutil_linux' extension 15:37:22 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 15:37:22 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 15:37:22 INFO - building 'psutil._psutil_posix' extension 15:37:22 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 15:37:22 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 15:37:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:37:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:37:22 INFO - Successfully installed psutil 15:37:22 INFO - Cleaning up... 15:37:22 INFO - Return code: 0 15:37:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:37:22 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')]} 15:37:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:37:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:37:22 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')]} 15:37:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:37:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:37: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb926ec0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b21790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1e930>, '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 0x1b1f830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b1fcc0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1475793420.328211-2058082381', '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 15:37: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:37: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 mozsystemmonitor==0.3 15:37:23 INFO - Using env: {'DISPLAY': ':0', 15:37:23 INFO - 'HOME': '/home/cltbld', 15:37:23 INFO - 'LANG': 'en_US.UTF-8', 15:37:23 INFO - 'LANGUAGE': 'en_US:en', 15:37:23 INFO - 'LOGNAME': 'cltbld', 15:37:23 INFO - 'MAIL': '/var/mail/cltbld', 15:37:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:37:23 INFO - 'MOZ_NO_REMOTE': '1', 15:37:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:37:23 INFO - 'NO_EM_RESTART': '1', 15:37:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:37:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:37:23 INFO - 'PWD': '/builds/slave/test', 15:37:23 INFO - 'SHELL': '/bin/bash', 15:37:23 INFO - 'SHLVL': '1', 15:37:23 INFO - 'TERM': 'linux', 15:37:23 INFO - 'TMOUT': '86400', 15:37:23 INFO - 'USER': 'cltbld', 15:37:23 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1475793420.328211-2058082381', 15:37:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:37:23 INFO - '_': '/tools/buildbot/bin/python'} 15:37:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:37:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:37: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 15:37: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 15:37: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 15:37: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 15:37: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 15:37: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 15:37:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:37:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:37:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:37:25 INFO - Installing collected packages: mozsystemmonitor 15:37:25 INFO - Running setup.py install for mozsystemmonitor 15:37:25 INFO - Successfully installed mozsystemmonitor 15:37:25 INFO - Cleaning up... 15:37:25 INFO - Return code: 0 15:37:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:37:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:37:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:37:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:37:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:37:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:37:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:37:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb926ec0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b21790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1e930>, '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 0x1b1f830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b1fcc0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1475793420.328211-2058082381', '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 15:37:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:37:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:37:25 INFO - Using env: {'DISPLAY': ':0', 15:37:25 INFO - 'HOME': '/home/cltbld', 15:37:25 INFO - 'LANG': 'en_US.UTF-8', 15:37:25 INFO - 'LANGUAGE': 'en_US:en', 15:37:25 INFO - 'LOGNAME': 'cltbld', 15:37:25 INFO - 'MAIL': '/var/mail/cltbld', 15:37:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:37:25 INFO - 'MOZ_NO_REMOTE': '1', 15:37:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:37:25 INFO - 'NO_EM_RESTART': '1', 15:37:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:37:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:37:25 INFO - 'PWD': '/builds/slave/test', 15:37:25 INFO - 'SHELL': '/bin/bash', 15:37:25 INFO - 'SHLVL': '1', 15:37:25 INFO - 'TERM': 'linux', 15:37:25 INFO - 'TMOUT': '86400', 15:37:25 INFO - 'USER': 'cltbld', 15:37:25 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1475793420.328211-2058082381', 15:37:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:37:25 INFO - '_': '/tools/buildbot/bin/python'} 15:37:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:37:25 INFO - Downloading/unpacking jsonschema==2.5.1 15:37: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 15:37: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 15:37: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 15:37: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 15:37: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 15:37: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 15:37:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:37:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:37:27 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 15:37:27 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 15:37:27 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 15:37:27 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 15:37:27 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 15:37:27 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 15:37:27 INFO - Downloading functools32-3.2.3-2.tar.gz 15:37:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:37:27 INFO - warning: no files found matching '*.txt' 15:37:27 INFO - no previously-included directories found matching 'build' 15:37:27 INFO - no previously-included directories found matching 'dist' 15:37:27 INFO - no previously-included directories found matching '.git*' 15:37:27 INFO - Installing collected packages: jsonschema, functools32 15:37:27 INFO - Running setup.py install for functools32 15:37:27 INFO - warning: no files found matching '*.txt' 15:37:27 INFO - no previously-included directories found matching 'build' 15:37:27 INFO - no previously-included directories found matching 'dist' 15:37:27 INFO - no previously-included directories found matching '.git*' 15:37:27 INFO - Successfully installed jsonschema functools32 15:37:27 INFO - Cleaning up... 15:37:27 INFO - Return code: 0 15:37:27 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:37:27 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')]} 15:37:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:37:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:37:27 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')]} 15:37:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:37:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:37:27 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 0x7fb926ec0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b21790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1e930>, '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 0x1b1f830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b1fcc0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1475793420.328211-2058082381', '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 15:37:27 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 15:37:27 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 15:37:27 INFO - Using env: {'DISPLAY': ':0', 15:37:27 INFO - 'HOME': '/home/cltbld', 15:37:27 INFO - 'LANG': 'en_US.UTF-8', 15:37:27 INFO - 'LANGUAGE': 'en_US:en', 15:37:27 INFO - 'LOGNAME': 'cltbld', 15:37:27 INFO - 'MAIL': '/var/mail/cltbld', 15:37:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:37:27 INFO - 'MOZ_NO_REMOTE': '1', 15:37:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:37:27 INFO - 'NO_EM_RESTART': '1', 15:37:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:37:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:37:27 INFO - 'PWD': '/builds/slave/test', 15:37:27 INFO - 'SHELL': '/bin/bash', 15:37:27 INFO - 'SHLVL': '1', 15:37:27 INFO - 'TERM': 'linux', 15:37:27 INFO - 'TMOUT': '86400', 15:37:27 INFO - 'USER': 'cltbld', 15:37:27 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1475793420.328211-2058082381', 15:37:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:37:27 INFO - '_': '/tools/buildbot/bin/python'} 15:37:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:37:28 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:37:28 INFO - Cleaning up... 15:37:28 INFO - Return code: 0 15:37:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:37:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:37:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:37:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:37:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:37:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:37:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:37:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb926ec0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b21790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1e930>, '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 0x1b1f830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b1fcc0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1475793420.328211-2058082381', '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 15:37:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:37:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:37:28 INFO - Using env: {'DISPLAY': ':0', 15:37:28 INFO - 'HOME': '/home/cltbld', 15:37:28 INFO - 'LANG': 'en_US.UTF-8', 15:37:28 INFO - 'LANGUAGE': 'en_US:en', 15:37:28 INFO - 'LOGNAME': 'cltbld', 15:37:28 INFO - 'MAIL': '/var/mail/cltbld', 15:37:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:37:28 INFO - 'MOZ_NO_REMOTE': '1', 15:37:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:37:28 INFO - 'NO_EM_RESTART': '1', 15:37:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:37:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:37:28 INFO - 'PWD': '/builds/slave/test', 15:37:28 INFO - 'SHELL': '/bin/bash', 15:37:28 INFO - 'SHLVL': '1', 15:37:28 INFO - 'TERM': 'linux', 15:37:28 INFO - 'TMOUT': '86400', 15:37:28 INFO - 'USER': 'cltbld', 15:37:28 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1475793420.328211-2058082381', 15:37:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:37:28 INFO - '_': '/tools/buildbot/bin/python'} 15:37:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:37:28 INFO - Downloading/unpacking blobuploader==1.2.4 15:37: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 15:37: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 15:37: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 15:37: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 15:37: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 15:37: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 15:37:30 INFO - Downloading blobuploader-1.2.4.tar.gz 15:37:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:37:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:37:30 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 15:37:30 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 15:37:30 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 15:37:30 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 15:37:30 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 15:37:30 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 15:37:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:37:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:37:30 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 15:37:30 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 15:37:30 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 15:37:30 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 15:37:30 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 15:37:30 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 15:37:30 INFO - Downloading docopt-0.6.1.tar.gz 15:37:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:37:31 INFO - Installing collected packages: blobuploader, requests, docopt 15:37:31 INFO - Running setup.py install for blobuploader 15:37:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:37:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:37:31 INFO - Running setup.py install for requests 15:37:31 INFO - Running setup.py install for docopt 15:37:31 INFO - Successfully installed blobuploader requests docopt 15:37:31 INFO - Cleaning up... 15:37:31 INFO - Return code: 0 15:37:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:37:31 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')]} 15:37:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:37:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:37:31 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')]} 15:37:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:37:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:37:31 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 0x7fb926ec0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b21790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1e930>, '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 0x1b1f830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b1fcc0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1475793420.328211-2058082381', '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 15:37:31 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 15:37:31 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 15:37:31 INFO - Using env: {'DISPLAY': ':0', 15:37:31 INFO - 'HOME': '/home/cltbld', 15:37:31 INFO - 'LANG': 'en_US.UTF-8', 15:37:31 INFO - 'LANGUAGE': 'en_US:en', 15:37:31 INFO - 'LOGNAME': 'cltbld', 15:37:31 INFO - 'MAIL': '/var/mail/cltbld', 15:37:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:37:31 INFO - 'MOZ_NO_REMOTE': '1', 15:37:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:37:31 INFO - 'NO_EM_RESTART': '1', 15:37:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:37:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:37:31 INFO - 'PWD': '/builds/slave/test', 15:37:31 INFO - 'SHELL': '/bin/bash', 15:37:31 INFO - 'SHLVL': '1', 15:37:31 INFO - 'TERM': 'linux', 15:37:31 INFO - 'TMOUT': '86400', 15:37:31 INFO - 'USER': 'cltbld', 15:37:31 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1475793420.328211-2058082381', 15:37:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:37:31 INFO - '_': '/tools/buildbot/bin/python'} 15:37:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:37:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:37:31 INFO - Running setup.py (path:/tmp/pip-Rf2kFe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:37:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:37:31 INFO - Running setup.py (path:/tmp/pip-LOkDC5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:37:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:37:32 INFO - Running setup.py (path:/tmp/pip-Z7uBWd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:37:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:37:32 INFO - Running setup.py (path:/tmp/pip-SQypsy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:37:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:37:32 INFO - Running setup.py (path:/tmp/pip-rpuuQB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:37:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:37:32 INFO - Running setup.py (path:/tmp/pip-IIo2IA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:37:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:37:32 INFO - Running setup.py (path:/tmp/pip-jmym_X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:37:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:37:32 INFO - Running setup.py (path:/tmp/pip-18Ja2b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:37:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:37:32 INFO - Running setup.py (path:/tmp/pip-M65LJA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:37:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:37:32 INFO - Running setup.py (path:/tmp/pip-AoEuPR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:37:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:37:32 INFO - Running setup.py (path:/tmp/pip-3_0KX0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:37:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:37:32 INFO - Running setup.py (path:/tmp/pip-mFpL_A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:37:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:37:32 INFO - Running setup.py (path:/tmp/pip-iWmdDl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:37:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:37:32 INFO - Running setup.py (path:/tmp/pip-_KIyce-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:37:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:37:32 INFO - Running setup.py (path:/tmp/pip-rHwtK1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:37:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:37:32 INFO - Running setup.py (path:/tmp/pip-IGo9B1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:37:33 INFO - Running setup.py (path:/tmp/pip-9devw8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:37:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:37:33 INFO - Running setup.py install for manifestparser 15:37:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:37:33 INFO - Running setup.py install for mozcrash 15:37:33 INFO - Running setup.py install for mozdebug 15:37:33 INFO - Running setup.py install for mozdevice 15:37:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:37:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:37:33 INFO - Running setup.py install for mozfile 15:37:33 INFO - Running setup.py install for mozhttpd 15:37:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:37:33 INFO - Running setup.py install for mozinfo 15:37:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:37:33 INFO - Running setup.py install for mozInstall 15:37:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:37:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:37:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:37:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:37:33 INFO - Running setup.py install for mozleak 15:37:33 INFO - Running setup.py install for mozlog 15:37:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:37:34 INFO - Running setup.py install for moznetwork 15:37:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:37:34 INFO - Running setup.py install for mozprocess 15:37:34 INFO - Running setup.py install for mozprofile 15:37:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:37:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:37:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:37:34 INFO - Running setup.py install for mozrunner 15:37:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:37:34 INFO - Running setup.py install for mozscreenshot 15:37:34 INFO - Running setup.py install for moztest 15:37:34 INFO - Running setup.py install for mozversion 15:37:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:37:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:37:34 INFO - Cleaning up... 15:37:34 INFO - Return code: 0 15:37:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:37:34 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')]} 15:37:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:37:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:37:34 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')]} 15:37:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:37:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:37:34 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 0x7fb926ec0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b21790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1e930>, '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 0x1b1f830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b1fcc0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1475793420.328211-2058082381', '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 15:37:34 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 15:37:34 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 15:37:34 INFO - Using env: {'DISPLAY': ':0', 15:37:34 INFO - 'HOME': '/home/cltbld', 15:37:34 INFO - 'LANG': 'en_US.UTF-8', 15:37:34 INFO - 'LANGUAGE': 'en_US:en', 15:37:34 INFO - 'LOGNAME': 'cltbld', 15:37:34 INFO - 'MAIL': '/var/mail/cltbld', 15:37:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:37:34 INFO - 'MOZ_NO_REMOTE': '1', 15:37:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:37:34 INFO - 'NO_EM_RESTART': '1', 15:37:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:37:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:37:34 INFO - 'PWD': '/builds/slave/test', 15:37:34 INFO - 'SHELL': '/bin/bash', 15:37:34 INFO - 'SHLVL': '1', 15:37:34 INFO - 'TERM': 'linux', 15:37:34 INFO - 'TMOUT': '86400', 15:37:34 INFO - 'USER': 'cltbld', 15:37:34 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1475793420.328211-2058082381', 15:37:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:37:34 INFO - '_': '/tools/buildbot/bin/python'} 15:37:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:37:35 INFO - Running setup.py (path:/tmp/pip-dGeCDr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:37:35 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)) 15:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:37:35 INFO - Running setup.py (path:/tmp/pip-Niow_D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:37:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:37:35 INFO - Running setup.py (path:/tmp/pip-ftaVbg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:37:35 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)) 15:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:37:35 INFO - Running setup.py (path:/tmp/pip-_QNrZh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:37:35 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)) 15:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:37:35 INFO - Running setup.py (path:/tmp/pip-SjvWJG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:37:35 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)) 15:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:37:35 INFO - Running setup.py (path:/tmp/pip-av_BNS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:37:35 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)) 15:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:37:35 INFO - Running setup.py (path:/tmp/pip-iIhV8i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:37:35 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)) 15:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:37:35 INFO - Running setup.py (path:/tmp/pip-wNHrT_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:37:35 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)) 15:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:37:35 INFO - Running setup.py (path:/tmp/pip-nnCWua-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:37:35 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)) 15:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:37:35 INFO - Running setup.py (path:/tmp/pip-l3wn69-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:37:35 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)) 15:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:37:35 INFO - Running setup.py (path:/tmp/pip-cKy2js-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:37:35 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)) 15:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:37:35 INFO - Running setup.py (path:/tmp/pip-VF3nTm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:37:36 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)) 15:37:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:37:36 INFO - Running setup.py (path:/tmp/pip-2cgl2O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:37:36 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)) 15:37:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:37:36 INFO - Running setup.py (path:/tmp/pip-wCC0ww-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:37:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:37:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:37:36 INFO - Running setup.py (path:/tmp/pip-upDHCs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:37:36 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)) 15:37:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:37:36 INFO - Running setup.py (path:/tmp/pip-9xZufC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:37:36 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)) 15:37:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:37:36 INFO - Running setup.py (path:/tmp/pip-YnRQ0K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:37:36 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)) 15:37:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:37:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:37:36 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)) 15:37:36 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)) 15:37:36 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)) 15:37:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:37:36 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 15:37:36 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 15:37:36 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 15:37:36 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 15:37:36 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 15:37:36 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 15:37:38 INFO - Downloading blessings-1.6.tar.gz 15:37:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:37:38 INFO - Installing collected packages: blessings 15:37:38 INFO - Running setup.py install for blessings 15:37:38 INFO - Successfully installed blessings 15:37:38 INFO - Cleaning up... 15:37:38 INFO - Return code: 0 15:37:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:37:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:37:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:37:38 INFO - Reading from file tmpfile_stdout 15:37:38 INFO - Current package versions: 15:37:38 INFO - argparse == 1.2.1 15:37:38 INFO - blessings == 1.6 15:37:38 INFO - blobuploader == 1.2.4 15:37:38 INFO - docopt == 0.6.1 15:37:38 INFO - functools32 == 3.2.3-2 15:37:38 INFO - jsonschema == 2.5.1 15:37:38 INFO - manifestparser == 1.1 15:37:38 INFO - mozInstall == 1.12 15:37:38 INFO - mozcrash == 0.17 15:37:38 INFO - mozdebug == 0.1 15:37:38 INFO - mozdevice == 0.48 15:37:38 INFO - mozfile == 1.2 15:37:38 INFO - mozhttpd == 0.7 15:37:38 INFO - mozinfo == 0.9 15:37:38 INFO - mozleak == 0.1 15:37:38 INFO - mozlog == 3.4 15:37:38 INFO - moznetwork == 0.27 15:37:38 INFO - mozprocess == 0.23 15:37:38 INFO - mozprofile == 0.28 15:37:38 INFO - mozrunner == 6.12 15:37:38 INFO - mozscreenshot == 0.1 15:37:38 INFO - mozsystemmonitor == 0.3 15:37:38 INFO - moztest == 0.7 15:37:38 INFO - mozversion == 1.4 15:37:38 INFO - psutil == 3.1.1 15:37:38 INFO - requests == 1.2.3 15:37:38 INFO - wsgiref == 0.1.2 15:37:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:37:38 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')]} 15:37:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:37:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:37:38 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')]} 15:37:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:37:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:37:38 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 0x7fb926ec0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b21790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1e930>, '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 0x1b1f830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b1fcc0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1475793420.328211-2058082381', '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 15:37:38 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 15:37:38 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 15:37:38 INFO - Using env: {'DISPLAY': ':0', 15:37:38 INFO - 'HOME': '/home/cltbld', 15:37:38 INFO - 'LANG': 'en_US.UTF-8', 15:37:38 INFO - 'LANGUAGE': 'en_US:en', 15:37:38 INFO - 'LOGNAME': 'cltbld', 15:37:38 INFO - 'MAIL': '/var/mail/cltbld', 15:37:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:37:38 INFO - 'MOZ_NO_REMOTE': '1', 15:37:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:37:38 INFO - 'NO_EM_RESTART': '1', 15:37:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:37:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:37:38 INFO - 'PWD': '/builds/slave/test', 15:37:38 INFO - 'SHELL': '/bin/bash', 15:37:38 INFO - 'SHLVL': '1', 15:37:38 INFO - 'TERM': 'linux', 15:37:38 INFO - 'TMOUT': '86400', 15:37:38 INFO - 'USER': 'cltbld', 15:37:38 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1475793420.328211-2058082381', 15:37:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:37:38 INFO - '_': '/tools/buildbot/bin/python'} 15:37:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:37:38 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)) 15:37:38 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)) 15:37:38 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)) 15:37:38 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)) 15:37:38 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)) 15:37:38 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)) 15:37:38 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)) 15:37:38 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)) 15:37:38 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)) 15:37:38 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)) 15:37:38 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)) 15:37:38 INFO - Cleaning up... 15:37:38 INFO - Return code: 0 15:37:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:37:38 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')]} 15:37:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:37:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:37:38 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')]} 15:37:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:37:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:37:39 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 0x7fb926ec0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b21790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1e930>, '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 0x1b1f830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b1fcc0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1475793420.328211-2058082381', '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 15:37:39 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 15:37:39 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 15:37:39 INFO - Using env: {'DISPLAY': ':0', 15:37:39 INFO - 'HOME': '/home/cltbld', 15:37:39 INFO - 'LANG': 'en_US.UTF-8', 15:37:39 INFO - 'LANGUAGE': 'en_US:en', 15:37:39 INFO - 'LOGNAME': 'cltbld', 15:37:39 INFO - 'MAIL': '/var/mail/cltbld', 15:37:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:37:39 INFO - 'MOZ_NO_REMOTE': '1', 15:37:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:37:39 INFO - 'NO_EM_RESTART': '1', 15:37:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:37:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:37:39 INFO - 'PWD': '/builds/slave/test', 15:37:39 INFO - 'SHELL': '/bin/bash', 15:37:39 INFO - 'SHLVL': '1', 15:37:39 INFO - 'TERM': 'linux', 15:37:39 INFO - 'TMOUT': '86400', 15:37:39 INFO - 'USER': 'cltbld', 15:37:39 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1475793420.328211-2058082381', 15:37:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:37:39 INFO - '_': '/tools/buildbot/bin/python'} 15:37:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:37:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:37:39 INFO - Cleaning up... 15:37:39 INFO - Return code: 0 15:37:39 INFO - Running post-action listener: _resource_record_post_action 15:37:39 INFO - Running post-action listener: _start_resource_monitoring 15:37:39 INFO - Starting resource monitoring. 15:37:39 INFO - [mozharness: 2016-10-06 22:37:39.250824Z] Finished create-virtualenv step (success) 15:37:39 INFO - [mozharness: 2016-10-06 22:37:39.251336Z] Running install step. 15:37:39 INFO - Running pre-action listener: _resource_record_pre_action 15:37:39 INFO - Running main action method: install 15:37:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:37:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:37:39 INFO - Reading from file tmpfile_stdout 15:37:39 INFO - Detecting whether we're running mozinstall >=1.0... 15:37:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:37:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:37:39 INFO - Reading from file tmpfile_stdout 15:37:39 INFO - Output received: 15:37:39 INFO - Usage: mozinstall [options] installer 15:37:39 INFO - Options: 15:37:39 INFO - -h, --help show this help message and exit 15:37:39 INFO - -d DEST, --destination=DEST 15:37:39 INFO - Directory to install application into. [default: 15:37:39 INFO - "/builds/slave/test"] 15:37:39 INFO - --app=APP Application being installed. [default: firefox] 15:37:39 INFO - mkdir: /builds/slave/test/build/application 15:37:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:37:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 15:37:56 INFO - Reading from file tmpfile_stdout 15:37:56 INFO - Output received: 15:37:56 INFO - /builds/slave/test/build/application/firefox/firefox 15:37:56 INFO - Running post-action listener: _resource_record_post_action 15:37:56 INFO - [mozharness: 2016-10-06 22:37:56.577680Z] Finished install step (success) 15:37:56 INFO - [mozharness: 2016-10-06 22:37:56.577926Z] Running run-tests step. 15:37:56 INFO - Running pre-action listener: _resource_record_pre_action 15:37:56 INFO - Running main action method: run_tests 15:37:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:37:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:37:56 INFO - Python 2.7.3 15:37:56 INFO - Return code: 0 15:37:56 INFO - grabbing minidump binary from tooltool 15:37:56 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')]} 15:37:56 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 0x1b1e930>, '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 0x1b1f830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b1fcc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:37:56 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 15:37:56 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 15:37:56 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 15:37:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:37:56 INFO - Return code: 0 15:37:56 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:37:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:37:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:37:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:37:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:37:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/L5CadNaoTp2DYS2r7D6mLQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 15:37:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/L5CadNaoTp2DYS2r7D6mLQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-041 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 15:37:56 INFO - Using env: {'DISPLAY': ':0', 15:37:56 INFO - 'HOME': '/home/cltbld', 15:37:56 INFO - 'LANG': 'en_US.UTF-8', 15:37:56 INFO - 'LANGUAGE': 'en_US:en', 15:37:56 INFO - 'LOGNAME': 'cltbld', 15:37:56 INFO - 'MAIL': '/var/mail/cltbld', 15:37:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:37:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:37:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:37:56 INFO - 'MOZ_NO_REMOTE': '1', 15:37:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:37:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:37:56 INFO - 'NO_EM_RESTART': '1', 15:37:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:37:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:37:56 INFO - 'PWD': '/builds/slave/test', 15:37:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:37:56 INFO - 'SHELL': '/bin/bash', 15:37:56 INFO - 'SHLVL': '1', 15:37:56 INFO - 'TERM': 'linux', 15:37:56 INFO - 'TMOUT': '86400', 15:37:56 INFO - 'USER': 'cltbld', 15:37:56 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1475793420.328211-2058082381', 15:37:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:37:56 INFO - '_': '/tools/buildbot/bin/python'} 15:37:56 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/L5CadNaoTp2DYS2r7D6mLQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 15:37:56 INFO - mozversion application_buildid: 20161006123013 15:37:56 INFO - mozversion application_changeset: ef345e3b5fa9fabdfd7d0a93ff01ec9c085968df 15:37:56 INFO - mozversion application_display_name: Nightly 15:37:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:37:56 INFO - mozversion application_name: Firefox 15:37:56 INFO - mozversion application_remotingname: firefox 15:37:56 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 15:37:56 INFO - mozversion application_vendor: Mozilla 15:37:56 INFO - mozversion application_version: 52.0a1 15:37:56 INFO - mozversion platform_buildid: 20161006123013 15:37:56 INFO - mozversion platform_changeset: ef345e3b5fa9fabdfd7d0a93ff01ec9c085968df 15:37:56 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 15:37:56 INFO - mozversion platform_version: 52.0a1 15:37:56 INFO - using testdate: 1475793476 15:37:56 INFO - actual date: 1475793476 15:37:56 INFO - starting webserver on 'localhost:56812' 15:37:56 INFO - SUITE-START | Running 2 tests 15:37:56 INFO - TEST-START | dromaeo_css 15:37:56 INFO - operating with platform_type : linux_ 15:37:56 INFO - Initialising browser for dromaeo_css test... 15:37:56 INFO - TEST-INFO | started process 20712 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIidFHC/profile http://localhost:56812/getInfo.html) 15:38:01 INFO - PROCESS | 20712 | __metrics Screen width/height:1600/1200 15:38:01 INFO - PROCESS | 20712 | colorDepth:24 15:38:01 INFO - PROCESS | 20712 | Browser inner width/height: 1024/697 15:38:01 INFO - PROCESS | 20712 | __metrics 15:38:01 INFO - PROCESS | 20712 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:38:01 INFO - PROCESS | 20712 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:38:02 INFO - PROCESS | 20712 | console.error: PushService: 15:38:02 INFO - PROCESS | 20712 | stateChangeProcessEnqueue: Error transitioning state 15:38:02 INFO - PROCESS | 20712 | UnknownError 15:38:03 INFO - TEST-INFO | 20712: exit 0 15:38:03 INFO - Browser initialized. 15:38:03 INFO - Running cycle 1/1 for dromaeo_css test... 15:38:03 INFO - TEST-INFO | started process 20795 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIidFHC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:38:15 INFO - PROCESS | 20795 | RSS: Main: 173223936 15:38:15 INFO - PROCESS | 20795 | 15:39:07 INFO - PROCESS | 20795 | 1475793547076 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] 15:41:15 INFO - PROCESS | 20795 | Cycle 1(1): loaded http://localhost:56812/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56812/tests/dromaeo/cssquery-ext.html) 15:41:18 INFO - PROCESS | 20795 | RSS: Main: 447045632 15:41:18 INFO - PROCESS | 20795 | 15:44:21 INFO - PROCESS | 20795 | Cycle 1(1): loaded http://localhost:56812/tests/dromaeo/cssquery-ext.html (next: http://localhost:56812/tests/dromaeo/cssquery-jquery.html) 15:44:21 INFO - PROCESS | 20795 | RSS: Main: 285138944 15:44:21 INFO - PROCESS | 20795 | 15:47:23 INFO - PROCESS | 20795 | Cycle 1(1): loaded http://localhost:56812/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56812/tests/dromaeo/cssquery-mootools.html) 15:47:24 INFO - PROCESS | 20795 | RSS: Main: 221229056 15:47:24 INFO - PROCESS | 20795 | 15:50:26 INFO - PROCESS | 20795 | Cycle 1(1): loaded http://localhost:56812/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56812/tests/dromaeo/cssquery-prototype.html) 15:50:26 INFO - PROCESS | 20795 | RSS: Main: 253022208 15:50:26 INFO - PROCESS | 20795 | 15:53:29 INFO - PROCESS | 20795 | Cycle 1(1): loaded http://localhost:56812/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56812/tests/dromaeo/cssquery-yui.html) 15:53:30 INFO - PROCESS | 20795 | RSS: Main: 222412800 15:53:30 INFO - PROCESS | 20795 | 15:56:33 INFO - PROCESS | 20795 | Cycle 1(1): loaded http://localhost:56812/tests/dromaeo/cssquery-yui.html (next: http://localhost:56812/tests/dromaeo/cssquery-dojo.html) 15:56:33 INFO - PROCESS | 20795 | RSS: Main: 310677504 15:56:33 INFO - PROCESS | 20795 | 15:56:33 INFO - PROCESS | 20795 | __start_tp_report 15:56:33 INFO - PROCESS | 20795 | _x_x_mozilla_page_load 15:56:33 INFO - PROCESS | 20795 | _x_x_mozilla_page_load_details 15:56:33 INFO - PROCESS | 20795 | |i|pagename|runs| 15:56:33 INFO - PROCESS | 20795 | |0;dojo.html;2950.970490295097;2994.0568720852943;2997.8051426657266;3026.7578593712506;3046.741027012704;5101.209312556555;5156.303898973638;5209.609279304048;5217.373915130185;5227.9738601307035;5157.200633901752;5248.21276808478;5257.947420525794;5272.182811664188;5299.390570084442;4715.858524244278;4753.429588449391;4753.548412900777;4783.306420569015;4783.593394561449;4800.255960326155;4837.201861692816;4874.390701162355;4876.683015603974;4932.260160975864;4805.567498925078;4814.927776083362;4853.02939412119;4864.270359446076;4910.582600478963;4654.232051711463;4721.5750582447745;4725.1730947084125;4784.114938736345;4786;4675.088357770236;4678.672492925497;4685.461171965234;4703.858884233444;4729.69256998294;5192.896142077175;5238.528532432061;5241.318628578299;5250.976059668328;5251.658642188284;5411.891762164734;5431.6740995540395;5518.724063796834;5544.556435485151;5586.273784408041;5629.324481062258;5630.662160270397;5658.377578466366;5679.403662615448;5692.203091567184;5253.028189784902;5253.080710875582;5254.054270231357;5257.13257312543;5321.9622173676535;5526.806561770399;5577.27495425592;5580.944190558123;5735.569832262597;5740.282464691913;5412.972935135299;5442.319710036246;5454.53636440899;5496.945030549723;5499.285092937973;5516.806911758069;5528.170774383874;5529.557635389159;5529.889402211933;5532.30846144232;5261.3686357637325;5363.624546281801;5506.862328441741;5509.586780991442;5582.469665381782;5548.140038294071;5572.108462645957;5582.134769110794;5596.944030559724;5666.206731057655;4288.185244803477;4315.201687687788;4324.718893271927;4325.632321252729;4380.4305440292555;3796.962030379661;3857.8071096445065;3874.3994680824517;3900.063984643722;3924.9018774530864;5178.559822415062;5246.291750613618;5325.4940780625775;5332.2801421808335;5421.566274698014;5642.915356269577;5649.943500565024;5655.406182350876;5660.745266463019;5661;5304.734763261821;5328.6802791832615;5343.465653434625;5349.491798279158;5411.512963833274;4788.377510923558;4806.303086052572;4820.927686084711;4823.9517604824205;4850.684705494132;5721.284839395075;5852.3269823969085;5853.94146058534;5858.7070646468355;5859.20900678403;5537.723113844372;5571.415001424954;5589.301337332833;5590.0496915523645;5591.832245032656;5775.451332123442;5782.508486778671;5785.652860828363;5791.797287094932;5796.333421656564;5282.524572788468;5366.838994830161;5372.731363431891;5443.183522471661;5452.972735136299;5538.47384498472;5546.667199968015;5547.33431988164;5548.140038294071;5552.083906155601;5407.324084489439;5411.404745477916;5413.621046526705;5415.458454154553;5418.187271909245;5363.463653634605;5417.052015897281;5419.756110975094;5420.05149098914;5420.945790542044;5394.487523685244;5401.864953376197;5402.837914862561;5410.675359478444;5410.972945135407;5448.700321482356;5461.1808228766;5464.480874316933;5469.371022332482;5472.699001554953;5335.093034184276;5344.545713614386;5360.919586206132;5423.213634023124;5427.0231358354295 15:56:33 INFO - PROCESS | 20795 | |1;ext.html;592.3839207224486;607.5352355448081;612.9824491344369;626.1077963901439;628.7924984755032;39837.4024389634;41185.58814411855;41316;41370.37944430828;45620.54379456204;44324.77837610807;44479.55520444795;44575.331370029475;44958.55041449585;45015.32477012847;7940.523568585874;8813.206811386974;9013.05362936892;9028.32287578431;9040.683576074838;7868.449208555404;9988.350757200795;10219.897801021969;10269.486525673723;10652.733681657943;10870.456477176149;10917.617883374083;10920.945395273013;10922.781544369107;10930.617428390007;10725.088367488774;10771.084457821056;10776.568937242579;10780.838287425695;10784.622538211204;10548.20888433363;10557.313774604703;10642.255042147053;10644.733881652943;10646.467676616137;41339;41552.168956621;41625.791871040754;41708.58291417108;41713;3540.7521473496868;3700.389435743099;3720.330340538702;3720.813959302024;3832.967909109024;30547.34874048308;30641.387172256655;31091.689083109333;31115.533267001014;32325.191870203198;4318.719283246579;4354.194474022316;4387.62705170061;4404.515503294635;4411.338299255105;331767;332752.3362383197;332989;333872;334716;56107.719461402434;56567;56680;56770.43229567734;56774.7161264191;35228.11929701727;60050.39949600448;60108.39891601115;60179;60216;16514.83485165157;17590.91204543969;17590.912045439945;17597;17606.559836003948;11953.163278570417;12322.81515777264;13092.410841512155;13395.665108372368;13493.392797324144;17847.553811154827;18442;18487.445376638723;18559.814401856078;18596.163172657263;5580.832575022756;6896.93103068973;6922.758117912643;7008.369246767816;7058.118035080685;903.2593273515654;1001.2040427859869;1023.467796745688;1073.5383784972537;1076.7738774857369;31723.206919826727;32357.191070223435;32576.348473030408;32741.18147046343;32852.507212391836;1072.1422861710755;1095.085603521053;1120.7335710646917;1123.550579768083;1184.603157942082;15378.538643840702;16178;16217.675646487005;16273.349066037226;16397.180140992903;508595;514067;514865;515345;518600;56015.439845601024;56510.152347714815;56663.43336566664;56671.43328566744;56719.432805671415;1232.8458942632171;1277.3230188000189;1332.0875200487696;1352.4860552989999;1378.8896888248917;28521.572176417787;32492.675073248964;32541.18647033843;32936.835315823264;33298;47744.7612761934;48601;48739;48751.26873096835;48783;409407.2474202116;410350;412473;414739;414996;27483.725162748116;27799.166025019284;28500.57249141306;28514.57228141621;30236.395272094876;46907;47187.528124718316;47553.286700700206;47679;48599.5140048595;39912.80043599763;40532.39201411922;40636.79681601573;41936.370954436316;42045.36931945962;39368.60631393649;40521.18957620772;40566;41226.58773412227;41868.3719744198;40702;40990;41546.169076618906;41738;41824.16351673011;32442;35508;35517.64482355143;35906.28187436289;36279.63720362762;27524.862375688794;27569.310767230978;27711.090335515288;28033.57949630798;28051 15:56:33 INFO - PROCESS | 20795 | |2;jquery.html;343.9492350868097;372.41158968829234;379.4933763425826;380.82101412336203;401.63451259353974;14152.292385380728;18148.546286342833;18180.818191818078;18602.34891778788;19694.310699125534;17937.64124717508;18395.080245987712;18544.721829172573;18585.90707046463;19143.808561914375;5197.584193264539;5442.9727851360685;5448.210009548613;5448.400675925645;5449.073657478239;5143.0485360208295;5217.58259339252;5359.249705041298;5442.8911421771545;5444.210589464545;5266.8419947401635;5268.288781014571;5269.8946021079555;5270.998510283034;5276.3140791697215;5255.211718242275;5258.290130832327;5260.263563101169;5570.189688351302;5779.248697669318;5706.457886500776;5731.111677689964;5732.254806875121;5734.197212390269;5734.311882574076;12746.215529825831;13044.54344097952;13145.802812957812;13255.27096009719;13684.110532815335;2083.906224219914;2092.424583239606;2119.9682004769943;2177.7822217778253;2191.4391341142814;9680.95159524205;10053.396796192252;10277.17782577392;10411.479426028744;12998.119034670673;1790.8030116687285;1842.1526097994938;1874.3158747057362;1891.1206289075508;1898.933537326187;71437.64281178612;74671.62664186698;79749;82867;84296.57851710764;10592.364458132537;10841.945790270998;10901.83647245292;11191.216614836883;11245.059191015058;15345.6163595911;15609.892664490148;15639.68720625581;15662.530124096294;15664.530064098095;7991.120976692559;8116.2695357418115;8178.918210817935;8295.677210381104;8306.875396869053;7734.419918506134;7822.960885195537;7844.058712954482;8008.599570021475;8076.152004039609;4624.930626040612;4641.419822522184;4678.391809064868;4829.855104346875;4859.813084112164;1897.8328328078408;1957.2758079510672;1971.9802801972085;2001.9699704504444;2033.6136134134467;851.9872201916976;923.2429407885469;1037.3464717228098;1044.4673216659407;1060.8886066963012;19020.334288299844;19347;19398.70901936472;19455.12451939666;19699.704504432444;973.8977407372265;1010.4442556593991;1019.1642852860583;1021.9744506387251;1038.3354653022072;9685.17675997548;10571.471426428801;10843.349399036084;10847.51186196623;10848.240623156304;330668;332250;335447;434550;448607;83832.16167838365;87138;89168.5541572288;92940.53529732443;93275.53362233145;1011.1132716095589;1042.5829668132808;1071.7802850415646;1080.378782200238;1082.355998181081;16375.88858116954;16910.74633880468;17408.564785880455;17439.30242790274;17523.912380438527;39470.2105957885;40463.393049104874;41022.79488602538;41321.380179296735;42665.36001959911;55882.44117558935;56877;57462;58535.707321463124;58981.41018589931;7429.628518574158;7716.884246736416;7904.170062143392;8186.345092392713;8349.081601023761;12517;12877.678058048248;12948.8057679133;13000.479980800663;13041.869581304445;10961.890381096406;10974.451277435937;11107.777844443228;11167.38579378142;11577.305361678325;11028;11247.831282530606;11479.196456248317;11547;11855.407229638311;11180.385078820744;11330.773384532427;11432.14258930567;11520.769584608093;11592.594259200887;7328.377087947584;7526.134494533198;7559.395248380007;7560.206178351194;8043.1554686757045;8315.708950186714;10956.233063685784;11129.499172537093;11240.718982025515;11489.851014898777 15:56:33 INFO - PROCESS | 20795 | |3;mootools.html;1346.535445271381;1483.2509582660757;1502.489153687746;1630.6249562600601;1757.903315317657;7883.093444253913;8699.260562852158;9056.320775941806;9091.772705682344;9295.90704092959;9124.178823905848;9195.126462986022;9197.862032069525;9204.585793639286;9213.401128926615;2321.3268152235873;2347.95304093918;2348.58899692554;2349.1425629645228;2355.9057637694473;2307.246492665578;2341.028473183627;2381.809455243585;2387.7492863249367;2390.605550084234;2319.2926157521947;2338.333574931145;2340.6254999200046;2342.3792694935855;2350.424146084203;2235.8993845277;2253.808426283768;2266.705328307326;2271.6478945763433;2314.0628045641542;2300.5168914527967;2301.9539609207723;2311.7457079721216;2312.8034117099896;2314.155333303349;9094.49980251086;9100.68147614837;9146.451212927246;9196.816063678689;9231.492267925261;5121.308623335839;5288.973555132238;5292.206169074631;5369.677819330814;5371;3380.154961259685;3546.5389499365174;3597.262561174979;3606.9639303607155;3638.781673099596;1074.8334008228737;1125.5047778977223;1158.6537262044344;1183.4023817971954;1189.6014835030276;12787.488500460064;12928.612141635766;12961.41673624689;12968.481260749653;12972.221666700028;4157.937630935538;4259.893502662396;4440;4475.820967161277;4481.5294394088805;9952.950235248922;9954.203663706887;9958.651447199314;9963.950180249198;9964.750881227883;5241.685498870003;5287.603429742785;5292.417834038252;5296.814611488579;5298.496642818926;4210.642095421924;4349.282368409177;4570.268756998931;4679.461861885927;4934.9013019739405;3675.320065787838;3707.3882809336155;3792.6776224020714;3813.694904407641;3967.26605577969;1046.3669479964665;1050.653284416156;1054.9736256593646;1064.5528877871313;1064.9307794993301;953.77109493721;976.7509285132246;982.3565564555228;988.6724960254429;1000.2098342309639;5989.281286245591;6014.338422773491;6023.518118550505;6101.237345331833;6122.816315510542;985.522021819417;1000.1287294404133;1005.3967619428431;1010.2574607663362;1024.3495380433478;4062.4515690382013;4155.4182414462;4184.8744537663915;4289.463817022872;4374.234508960919;11130.610428634958;11579.826302605468;11616.128790340757;11627.53489860396;11642.941785291188;11290.379029153475;11335.886641133648;11462.360248447205;11569.768604628029;11572.016378607745;8367.163283671583;8519.48883067018;8529.829403411897;8533.146685331292;8540.44487108336;6011;6022.277326720821;6066.726997285221;6071.39286071407;6100.437816117153;10167.440790756284;10392.37645741258;10433.269671123253;10523.579056837641;10650.467476626292;10723;10747.516361763583;10778.676639700821;10796.352218866894;10813.837792433276;7462.216467271075;7540.3213710766295;7622.656980435783;7650.349720273616;7701.537907725555;8892.911070889208;8926.910730892867;8954.104589540993;8955.104489550993;8964.596593153194;7893.723719670013;7966.482178658369;8156.388270879589;8184.181581842006;8263.256306932164;7684.423668224794;7805.531668099932;7811.921880781119;7866.488678235896;7914.24814642608;7201.099862517185;7244.239354867663;7310.305520975498;7330.230325815925;7332.156801967842;4980.850574482772;5118.155504341891;5179.507946745053;5195.480451954774;5216.739163041909;5148.716820574904;5239.24031015493;5264.763085661078;5283.365996080495;5429.53848922846 15:56:33 INFO - PROCESS | 20795 | |4;prototype.html;315.92101974506386;321.3556818578751;329.88289157349146;330.17456359102243;337.87160878866035;5006.899862002767;5104.336436263286;5147.7426128693605;5154.458781827911;5186.585073194145;4995.225740010295;5143.81996630118;5146.45962173971;5148.48515148485;5160.716160611165;4131.5539561153655;4133.545310015911;4134.276501612221;4137.54487006429;4138.482689663792;3960.5841386654274;4078.3474644056955;4111.136661301115;4159.064210552617;4164.66682665386;4092.9795351023204;4112.465379500661;4116.115035267417;4124.463819703435;4138.482689663792;4092.5676013395073;4100.938485922714;4111.897202569945;4117.814698338582;4121.52602450719;3688.723345749053;3693.150575367654;3699.8520059197867;3705.7591256568235;3725.869594564177;4844.975775121137;5064.518870707277;5075.390953085616;5101.51535604117;5124.282600435942;4619.74591397473;4621.491635920046;4688.812447502096;4690.545930761441;4707.293905914106;5399.595030372738;5405.621606487547;5416.647917885325;5439.972800136014;5446.373667028302;3838.309104361214;3903.6291552302487;3937.8424863005444;3942.56631770505;3947.1513624570566;5579.609427340088;5579.832605021856;5592.5246354059955;5594.4964953154;5610.7194640268235;4006.779627120478;4031.274370613259;4044.170944956277;4047.6964227683043;4070.9389359159636;3874.9418758718643;4011.277969965376;4050.1697152083752;4119.855805046869;4119.958800412018;4570.840020599329;4608.838690645811;4634.21218392874;4640.076751646441;4647.16351056813;5383.631202270988;5393.865153371197;5406.837794866082;5463.770651603437;5466.617336786467;1322.418136020148;1355.6881917158912;1366.6856622976572;1377.2646465453602;1404.8876089912783;941.2328951904176;950.7432993091827;973.0998826085843;981.1513041219293;986.7582442301682;5166.483351664803;5189.922151167735;5190.195519694454;5206.427292997767;5224.555912747383;5429.56563474921;5480.342358916955;5489.313835770528;5500.3949565547755;5508.173773933942;4932.950670493249;5108.719020453911;5184.922226166611;5203.635745497779;5204.1673332266655;2572.915938090153;2581.8838152282815;2582.793376529911;2585.818992670495;2614.163467690321;4998.5751211146735;5009.323741294951;5016.4198277542455;5021.472745361758;5031.823886163967;4729.712849569585;4791.6645834791925;4897.510248975074;4922.384701912261;4971.279164521196;4895.290182923527;4914;4979.800807967641;4992.925106123411;5037;4882.829100981448;4885.8045678172475;4887.291342755351;4896.681715688612;4900.754962251945;4602.527191298752;4805.543473370024;4808.3989501312335;4862.003289325609;4869.514797986648;5057.241413787961;5078.984203159309;5083.161278389172;5086.796528138833;5090;3626.474161246552;3664.37705590045;3702.2965636528975;3709.5919448860063;3720.9441858371606;4579.793909274024;4892.119418504703;4913.6069114471475;4937.802487900443;4954.142196676246;4651.837185698484;4703.31801888731;4705.223638099676;4730.503297153749;4772.5227477252;4729.101470720552;4741.960956788614;4765.404324459442;4771.566501084402;4788.61691064721;4619.729574367076;4772.761361931959;4794.5924596409695;4794.7842347093765;5022.221555658879;5467.17992301158;5489.945100548944;5503.587230957774;5510.779568817203;5513.4486551346145;5354;5363.5440987516495;5376.542993845567;5447.1829225616475;5469.726513674221 15:56:33 INFO - PROCESS | 20795 | |5;yui.html;730.0509337860781;735.2390276064273;777.2072486064214;782.8512582609304;802.7350974178514;15158.545243642695;16691;16710.832891671078;16723.247453864577;16759.245833937486;15132.773008404884;15304;15307.387704491806;15312.693746125098;15326;639.9136116624243;670.4502308107354;759.6050053971932;776.9184235655246;797.9880301795478;774.1523032279673;777.0830420104274;786.712849809821;787.1498781316193;787.4527203593505;840.1178762299592;846.031294168177;846.1580727176469;846.7925358287229;847.0555330806168;654.6072356586058;690.4648897104734;831.9542425166613;837.1670188162786;838.4550042472381;582.6533212738414;611.6788685939918;615.5721773367511;616.2881871438495;616.8334549671564;14468.421263149461;14500.492482763158;14513.056651317736;14525.201113938729;14538.781918271234;13980.231087290194;14356.49752258666;14536.200508972002;14601.488947886774;14859.182744949023;12777.29724865132;12873;13048.804267935988;13500.39248233822;13805.309734513334;4137.172565486884;4200.411942328076;4203.91592168158;4245.596668316505;4362.258416069244;71726.64136679335;73610;74292;74555.62722186354;76297.61851190764;10425.9478702606;10815.56737730482;11248.662540123809;11250.437478126061;11461.197716159788;21843;21843.126274949143;21853.125874965142;21855.453613659785;21908.23321183751;8148.185181481923;8192.057913339922;8237.670493180205;8374.748757537283;8455.788605284793;4360.694751367438;4616.261398176276;4641.837535686234;4674.462436819741;4876.975615121902;3525.823708814549;3607.9278414432088;3638.7089032877307;3650.1604630935035;3659.341318562631;613.8557439001831;617.6170774120075;622.330994181257;641.3234038089766;641.5092454272485;606.3693758491208;631.4979591224987;669.7689297192461;705.982350441243;719.4927576058866;8976.730698079067;9055.547222638974;9312.068793120634;9377.571426434177;9681.854772178423;646.2955378637308;672.6737532296833;688.8932215506604;690.4441924250925;715.4562532475356;4066.5933406659096;4306.784660767012;4371.628411584988;4470.173017991682;4499.368178064342;62892.685536572026;63321.19692809644;97790.5110474443;115682.4215878932;120158.39920800341;78894.21105788983;93761.5311923436;98265.01734982559;101594.4920275394;102727.15935450108;50417.49582504202;64027.679861600394;71985.28014719786;81390.59304703439;83813;9420.670276540288;10047;10204;10293.3823970562;10390.844137338097;48397.51602484071;49089.754551227015;49527.25709114294;49984.25023624576;50166.749166255395;69264.6536767313;72152;72474.63762681364;74178;75815;12603.621891343275;12802.551910683082;12824.294663793207;12968.67578310512;12970.80543791825;12675.619731408073;12988.48046078184;13206.339683016004;14687.265636718335;14806.333714983068;14035.929820350833;14332.426702931765;14391.208483533506;14577.34401951936;15278.159701216095;14012.859871401155;14493;14639.121652700873;14885.181315027778;15144.16707081121;13861.23763193034;14521.709565808836;14539.78190327167;14539.78190327167;14964.551063468114;11086.722831929266;11314.943425282821;11586.293593267263;12082.758344832879;12567.685807854878;10414.323069000491;11009.83485247738;11751.177417580688;11879.346635935106;12230.938845305716 15:56:33 INFO - PROCESS | 20795 | __end_tp_report 15:56:33 INFO - PROCESS | 20795 | __start_cc_report 15:56:33 INFO - PROCESS | 20795 | _x_x_mozilla_cycle_collect,2750 15:56:33 INFO - PROCESS | 20795 | __end_cc_report 15:56:33 INFO - PROCESS | 20795 | __startTimestamp1475794593496__endTimestamp 15:56:33 INFO - PROCESS | 20795 | 15:56:33 INFO - PROCESS | 20795 | ------- Summary: start ------- 15:56:33 INFO - PROCESS | 20795 | Number of tests: 6 15:56:33 INFO - PROCESS | 20795 | 15:56:33 INFO - PROCESS | 20795 | [#0] dojo.html Cycles:165 Average:5186.62 Median:5394.49 stddev:575.14 (10.7%) stddev-sans-first:549.51 15:56:33 INFO - PROCESS | 20795 | Values: 2951.0 2994.1 2997.8 3026.8 3046.7 5101.2 5156.3 5209.6 5217.4 5228.0 5157.2 5248.2 5257.9 5272.2 5299.4 4715.9 4753.4 4753.5 4783.3 4783.6 4800.3 4837.2 4874.4 4876.7 4932.3 4805.6 4814.9 4853.0 4864.3 4910.6 4654.2 4721.6 4725.2 4784.1 4786.0 4675.1 4678.7 4685.5 4703.9 4729.7 5192.9 5238.5 5241.3 5251.0 5251.7 5411.9 5431.7 5518.7 5544.6 5586.3 5629.3 5630.7 5658.4 5679.4 5692.2 5253.0 5253.1 5254.1 5257.1 5322.0 5526.8 5577.3 5580.9 5735.6 5740.3 5413.0 5442.3 5454.5 5496.9 5499.3 5516.8 5528.2 5529.6 5529.9 5532.3 5261.4 5363.6 5506.9 5509.6 5582.5 5548.1 5572.1 5582.1 5596.9 5666.2 4288.2 4315.2 4324.7 4325.6 4380.4 3797.0 3857.8 3874.4 3900.1 3924.9 5178.6 5246.3 5325.5 5332.3 5421.6 5642.9 5649.9 5655.4 5660.7 5661.0 5304.7 5328.7 5343.5 5349.5 5411.5 4788.4 4806.3 4820.9 4824.0 4850.7 5721.3 5852.3 5853.9 5858.7 5859.2 5537.7 5571.4 5589.3 5590.0 5591.8 5775.5 5782.5 5785.7 5791.8 5796.3 5282.5 5366.8 5372.7 5443.2 5453.0 5538.5 5546.7 5547.3 5548.1 5552.1 5407.3 5411.4 5413.6 5415.5 5418.2 5363.5 5417.1 5419.8 5420.1 5420.9 5394.5 5401.9 5402.8 5410.7 5411.0 5448.7 5461.2 5464.5 5469.4 5472.7 5335.1 5344.5 5360.9 5423.2 5427.0 15:56:33 INFO - PROCESS | 20795 | 15:56:33 INFO - PROCESS | 20795 | [#1] ext.html Cycles:180 Average:58245.56 Median:3720.57 stddev:112824.89 (3032.5%) stddev-sans-first:113058.36 15:56:33 INFO - PROCESS | 20795 | Values: 592.4 607.5 613.0 626.1 628.8 39837.4 41185.6 41316.0 41370.4 45620.5 44324.8 44479.6 44575.3 44958.6 45015.3 7940.5 8813.2 9013.1 9028.3 9040.7 7868.4 9988.4 10219.9 10269.5 10652.7 10870.5 10917.6 10920.9 10922.8 10930.6 10725.1 10771.1 10776.6 10780.8 10784.6 10548.2 10557.3 10642.3 10644.7 10646.5 41339.0 41552.2 41625.8 41708.6 41713.0 3540.8 3700.4 3720.3 3720.8 3833.0 30547.3 30641.4 31091.7 31115.5 32325.2 4318.7 4354.2 4387.6 4404.5 4411.3 331767.0 332752.3 332989.0 333872.0 334716.0 56107.7 56567.0 56680.0 56770.4 56774.7 35228.1 60050.4 60108.4 60179.0 60216.0 16514.8 17590.9 17590.9 17597.0 17606.6 11953.2 12322.8 13092.4 13395.7 13493.4 17847.6 18442.0 18487.4 18559.8 18596.2 5580.8 6896.9 6922.8 7008.4 7058.1 903.3 1001.2 1023.5 1073.5 1076.8 31723.2 32357.2 32576.3 32741.2 32852.5 1072.1 1095.1 1120.7 1123.6 1184.6 15378.5 16178.0 16217.7 16273.3 16397.2 508595.0 514067.0 514865.0 515345.0 518600.0 56015.4 56510.2 56663.4 56671.4 56719.4 1232.8 1277.3 1332.1 1352.5 1378.9 28521.6 32492.7 32541.2 32936.8 33298.0 47744.8 48601.0 48739.0 48751.3 48783.0 409407.2 410350.0 412473.0 414739.0 414996.0 27483.7 27799.2 28500.6 28514.6 30236.4 46907.0 47187.5 47553.3 47679.0 48599.5 39912.8 40532.4 40636.8 41936.4 42045.4 39368.6 40521.2 40566.0 41226.6 41868.4 40702.0 40990.0 41546.2 41738.0 41824.2 32442.0 35508.0 35517.6 35906.3 36279.6 27524.9 27569.3 27711.1 28033.6 28051.0 15:56:33 INFO - PROCESS | 20795 | 15:56:33 INFO - PROCESS | 20795 | [#2] jquery.html Cycles:180 Average:25189.71 Median:2106.20 stddev:63421.85 (3011.2%) stddev-sans-first:63572.33 15:56:33 INFO - PROCESS | 20795 | Values: 343.9 372.4 379.5 380.8 401.6 14152.3 18148.5 18180.8 18602.3 19694.3 17937.6 18395.1 18544.7 18585.9 19143.8 5197.6 5443.0 5448.2 5448.4 5449.1 5143.0 5217.6 5359.2 5442.9 5444.2 5266.8 5268.3 5269.9 5271.0 5276.3 5255.2 5258.3 5260.3 5570.2 5779.2 5706.5 5731.1 5732.3 5734.2 5734.3 12746.2 13044.5 13145.8 13255.3 13684.1 2083.9 2092.4 2120.0 2177.8 2191.4 9681.0 10053.4 10277.2 10411.5 12998.1 1790.8 1842.2 1874.3 1891.1 1898.9 71437.6 74671.6 79749.0 82867.0 84296.6 10592.4 10841.9 10901.8 11191.2 11245.1 15345.6 15609.9 15639.7 15662.5 15664.5 7991.1 8116.3 8178.9 8295.7 8306.9 7734.4 7823.0 7844.1 8008.6 8076.2 4624.9 4641.4 4678.4 4829.9 4859.8 1897.8 1957.3 1972.0 2002.0 2033.6 852.0 923.2 1037.3 1044.5 1060.9 19020.3 19347.0 19398.7 19455.1 19699.7 973.9 1010.4 1019.2 1022.0 1038.3 9685.2 10571.5 10843.3 10847.5 10848.2 330668.0 332250.0 335447.0 434550.0 448607.0 83832.2 87138.0 89168.6 92940.5 93275.5 1011.1 1042.6 1071.8 1080.4 1082.4 16375.9 16910.7 17408.6 17439.3 17523.9 39470.2 40463.4 41022.8 41321.4 42665.4 55882.4 56877.0 57462.0 58535.7 58981.4 7429.6 7716.9 7904.2 8186.3 8349.1 12517.0 12877.7 12948.8 13000.5 13041.9 10961.9 10974.5 11107.8 11167.4 11577.3 11028.0 11247.8 11479.2 11547.0 11855.4 11180.4 11330.8 11432.1 11520.8 11592.6 7328.4 7526.1 7559.4 7560.2 8043.2 8315.7 10956.2 11129.5 11240.7 11489.9 15:56:33 INFO - PROCESS | 20795 | 15:56:33 INFO - PROCESS | 20795 | [#3] mootools.html Cycles:180 Average:5926.02 Median:4478.68 stddev:3457.33 (77.2%) stddev-sans-first:3449.90 15:56:33 INFO - PROCESS | 20795 | Values: 1346.5 1483.3 1502.5 1630.6 1757.9 7883.1 8699.3 9056.3 9091.8 9295.9 9124.2 9195.1 9197.9 9204.6 9213.4 2321.3 2348.0 2348.6 2349.1 2355.9 2307.2 2341.0 2381.8 2387.7 2390.6 2319.3 2338.3 2340.6 2342.4 2350.4 2235.9 2253.8 2266.7 2271.6 2314.1 2300.5 2302.0 2311.7 2312.8 2314.2 9094.5 9100.7 9146.5 9196.8 9231.5 5121.3 5289.0 5292.2 5369.7 5371.0 3380.2 3546.5 3597.3 3607.0 3638.8 1074.8 1125.5 1158.7 1183.4 1189.6 12787.5 12928.6 12961.4 12968.5 12972.2 4157.9 4259.9 4440.0 4475.8 4481.5 9953.0 9954.2 9958.7 9964.0 9964.8 5241.7 5287.6 5292.4 5296.8 5298.5 4210.6 4349.3 4570.3 4679.5 4934.9 3675.3 3707.4 3792.7 3813.7 3967.3 1046.4 1050.7 1055.0 1064.6 1064.9 953.8 976.8 982.4 988.7 1000.2 5989.3 6014.3 6023.5 6101.2 6122.8 985.5 1000.1 1005.4 1010.3 1024.3 4062.5 4155.4 4184.9 4289.5 4374.2 11130.6 11579.8 11616.1 11627.5 11642.9 11290.4 11335.9 11462.4 11569.8 11572.0 8367.2 8519.5 8529.8 8533.1 8540.4 6011.0 6022.3 6066.7 6071.4 6100.4 10167.4 10392.4 10433.3 10523.6 10650.5 10723.0 10747.5 10778.7 10796.4 10813.8 7462.2 7540.3 7622.7 7650.3 7701.5 8892.9 8926.9 8954.1 8955.1 8964.6 7893.7 7966.5 8156.4 8184.2 8263.3 7684.4 7805.5 7811.9 7866.5 7914.2 7201.1 7244.2 7310.3 7330.2 7332.2 4980.9 5118.2 5179.5 5195.5 5216.7 5148.7 5239.2 5264.8 5283.4 5429.5 15:56:33 INFO - PROCESS | 20795 | 15:56:33 INFO - PROCESS | 20795 | [#4] prototype.html Cycles:180 Average:4375.41 Median:4853.49 stddev:1236.80 (25.5%) stddev-sans-first:1202.15 15:56:33 INFO - PROCESS | 20795 | Values: 315.9 321.4 329.9 330.2 337.9 5006.9 5104.3 5147.7 5154.5 5186.6 4995.2 5143.8 5146.5 5148.5 5160.7 4131.6 4133.5 4134.3 4137.5 4138.5 3960.6 4078.3 4111.1 4159.1 4164.7 4093.0 4112.5 4116.1 4124.5 4138.5 4092.6 4100.9 4111.9 4117.8 4121.5 3688.7 3693.2 3699.9 3705.8 3725.9 4845.0 5064.5 5075.4 5101.5 5124.3 4619.7 4621.5 4688.8 4690.5 4707.3 5399.6 5405.6 5416.6 5440.0 5446.4 3838.3 3903.6 3937.8 3942.6 3947.2 5579.6 5579.8 5592.5 5594.5 5610.7 4006.8 4031.3 4044.2 4047.7 4070.9 3874.9 4011.3 4050.2 4119.9 4120.0 4570.8 4608.8 4634.2 4640.1 4647.2 5383.6 5393.9 5406.8 5463.8 5466.6 1322.4 1355.7 1366.7 1377.3 1404.9 941.2 950.7 973.1 981.2 986.8 5166.5 5189.9 5190.2 5206.4 5224.6 5429.6 5480.3 5489.3 5500.4 5508.2 4933.0 5108.7 5184.9 5203.6 5204.2 2572.9 2581.9 2582.8 2585.8 2614.2 4998.6 5009.3 5016.4 5021.5 5031.8 4729.7 4791.7 4897.5 4922.4 4971.3 4895.3 4914.0 4979.8 4992.9 5037.0 4882.8 4885.8 4887.3 4896.7 4900.8 4602.5 4805.5 4808.4 4862.0 4869.5 5057.2 5079.0 5083.2 5086.8 5090.0 3626.5 3664.4 3702.3 3709.6 3720.9 4579.8 4892.1 4913.6 4937.8 4954.1 4651.8 4703.3 4705.2 4730.5 4772.5 4729.1 4742.0 4765.4 4771.6 4788.6 4619.7 4772.8 4794.6 4794.8 5022.2 5467.2 5489.9 5503.6 5510.8 5513.4 5354.0 5363.5 5376.5 5447.2 5469.7 15:56:33 INFO - PROCESS | 20795 | 15:56:33 INFO - PROCESS | 20795 | [#5] yui.html Cycles:180 Average:19574.54 Median:4366.94 stddev:26951.38 (617.2%) stddev-sans-first:26989.84 15:56:33 INFO - PROCESS | 20795 | Values: 730.1 735.2 777.2 782.9 802.7 15158.5 16691.0 16710.8 16723.2 16759.2 15132.8 15304.0 15307.4 15312.7 15326.0 639.9 670.5 759.6 776.9 798.0 774.2 777.1 786.7 787.1 787.5 840.1 846.0 846.2 846.8 847.1 654.6 690.5 832.0 837.2 838.5 582.7 611.7 615.6 616.3 616.8 14468.4 14500.5 14513.1 14525.2 14538.8 13980.2 14356.5 14536.2 14601.5 14859.2 12777.3 12873.0 13048.8 13500.4 13805.3 4137.2 4200.4 4203.9 4245.6 4362.3 71726.6 73610.0 74292.0 74555.6 76297.6 10425.9 10815.6 11248.7 11250.4 11461.2 21843.0 21843.1 21853.1 21855.5 21908.2 8148.2 8192.1 8237.7 8374.7 8455.8 4360.7 4616.3 4641.8 4674.5 4877.0 3525.8 3607.9 3638.7 3650.2 3659.3 613.9 617.6 622.3 641.3 641.5 606.4 631.5 669.8 706.0 719.5 8976.7 9055.5 9312.1 9377.6 9681.9 646.3 672.7 688.9 690.4 715.5 4066.6 4306.8 4371.6 4470.2 4499.4 62892.7 63321.2 97790.5 115682.4 120158.4 78894.2 93761.5 98265.0 101594.5 102727.2 50417.5 64027.7 71985.3 81390.6 83813.0 9420.7 10047.0 10204.0 10293.4 10390.8 48397.5 49089.8 49527.3 49984.3 50166.7 69264.7 72152.0 72474.6 74178.0 75815.0 12603.6 12802.6 12824.3 12968.7 12970.8 12675.6 12988.5 13206.3 14687.3 14806.3 14035.9 14332.4 14391.2 14577.3 15278.2 14012.9 14493.0 14639.1 14885.2 15144.2 13861.2 14521.7 14539.8 14539.8 14964.6 11086.7 11314.9 11586.3 12082.8 12567.7 10414.3 11009.8 11751.2 11879.3 12230.9 15:56:33 INFO - PROCESS | 20795 | -------- Summary: end -------- 15:56:33 INFO - PROCESS | 20795 | 15:56:34 INFO - TEST-INFO | 20795: exit 0 15:56:34 INFO - TEST-OK | dromaeo_css | took 1117577ms 15:56:34 INFO - TEST-START | kraken 15:56:34 INFO - operating with platform_type : linux_ 15:56:34 INFO - Initialising browser for kraken test... 15:56:34 INFO - TEST-INFO | started process 21097 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCp91jy/profile http://localhost:56812/getInfo.html) 15:56:38 INFO - PROCESS | 21097 | __metrics Screen width/height:1600/1200 15:56:38 INFO - PROCESS | 21097 | colorDepth:24 15:56:38 INFO - PROCESS | 21097 | Browser inner width/height: 1024/697 15:56:38 INFO - PROCESS | 21097 | __metrics 15:56:39 INFO - PROCESS | 21097 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:56:39 INFO - PROCESS | 21097 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:56:39 INFO - PROCESS | 21097 | console.error: PushService: 15:56:39 INFO - PROCESS | 21097 | stateChangeProcessEnqueue: Error transitioning state 15:56:39 INFO - PROCESS | 21097 | UnknownError 15:56:40 INFO - TEST-INFO | 21097: exit 0 15:56:40 INFO - Browser initialized. 15:56:40 INFO - Running cycle 1/1 for kraken test... 15:56:40 INFO - TEST-INFO | started process 21182 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCp91jy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:56:52 INFO - PROCESS | 21182 | RSS: Main: 178479104 15:56:52 INFO - PROCESS | 21182 | 15:56:54 INFO - PROCESS | 21182 | Cycle 1(1): loaded http://localhost:56812/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56812/tests/kraken/driver.html?testName=audio-beat-detection) 15:56:55 INFO - PROCESS | 21182 | RSS: Main: 237625344 15:56:55 INFO - PROCESS | 21182 | 15:56:58 INFO - PROCESS | 21182 | Cycle 1(1): loaded http://localhost:56812/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56812/tests/kraken/driver.html?testName=audio-dft) 15:56:59 INFO - PROCESS | 21182 | RSS: Main: 221904896 15:56:59 INFO - PROCESS | 21182 | 15:57:02 INFO - PROCESS | 21182 | Cycle 1(1): loaded http://localhost:56812/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56812/tests/kraken/driver.html?testName=audio-fft) 15:57:02 INFO - PROCESS | 21182 | RSS: Main: 303775744 15:57:02 INFO - PROCESS | 21182 | 15:57:04 INFO - PROCESS | 21182 | Cycle 1(1): loaded http://localhost:56812/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56812/tests/kraken/driver.html?testName=audio-oscillator) 15:57:05 INFO - PROCESS | 21182 | RSS: Main: 212705280 15:57:05 INFO - PROCESS | 21182 | 15:57:07 INFO - PROCESS | 21182 | Cycle 1(1): loaded http://localhost:56812/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56812/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:57:08 INFO - PROCESS | 21182 | RSS: Main: 217497600 15:57:08 INFO - PROCESS | 21182 | 15:57:11 INFO - PROCESS | 21182 | Cycle 1(1): loaded http://localhost:56812/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56812/tests/kraken/driver.html?testName=imaging-darkroom) 15:57:11 INFO - PROCESS | 21182 | RSS: Main: 254468096 15:57:11 INFO - PROCESS | 21182 | 15:57:15 INFO - PROCESS | 21182 | Cycle 1(1): loaded http://localhost:56812/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56812/tests/kraken/driver.html?testName=imaging-desaturate) 15:57:15 INFO - PROCESS | 21182 | RSS: Main: 253542400 15:57:15 INFO - PROCESS | 21182 | 15:57:18 INFO - PROCESS | 21182 | Cycle 1(1): loaded http://localhost:56812/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56812/tests/kraken/driver.html?testName=json-parse-financial) 15:57:19 INFO - PROCESS | 21182 | RSS: Main: 253177856 15:57:19 INFO - PROCESS | 21182 | 15:57:20 INFO - PROCESS | 21182 | Cycle 1(1): loaded http://localhost:56812/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56812/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:57:21 INFO - PROCESS | 21182 | RSS: Main: 215265280 15:57:21 INFO - PROCESS | 21182 | 15:57:23 INFO - PROCESS | 21182 | Cycle 1(1): loaded http://localhost:56812/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56812/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:57:23 INFO - PROCESS | 21182 | RSS: Main: 222711808 15:57:23 INFO - PROCESS | 21182 | 15:57:25 INFO - PROCESS | 21182 | Cycle 1(1): loaded http://localhost:56812/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56812/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:57:26 INFO - PROCESS | 21182 | RSS: Main: 228405248 15:57:26 INFO - PROCESS | 21182 | 15:57:28 INFO - PROCESS | 21182 | Cycle 1(1): loaded http://localhost:56812/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56812/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:57:29 INFO - PROCESS | 21182 | RSS: Main: 238653440 15:57:29 INFO - PROCESS | 21182 | 15:57:32 INFO - PROCESS | 21182 | Cycle 1(1): loaded http://localhost:56812/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56812/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:57:33 INFO - PROCESS | 21182 | RSS: Main: 234065920 15:57:33 INFO - PROCESS | 21182 | 15:57:34 INFO - PROCESS | 21182 | Cycle 1(1): loaded http://localhost:56812/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56812/tests/kraken/driver.html?testName=ai-astar) 15:57:34 INFO - PROCESS | 21182 | RSS: Main: 285679616 15:57:34 INFO - PROCESS | 21182 | 15:57:34 INFO - PROCESS | 21182 | __start_tp_report 15:57:34 INFO - PROCESS | 21182 | _x_x_mozilla_page_load 15:57:34 INFO - PROCESS | 21182 | _x_x_mozilla_page_load_details 15:57:34 INFO - PROCESS | 21182 | |i|pagename|runs| 15:57:34 INFO - PROCESS | 21182 | |0;ai-astar;111;111;112;110;114;110;111;112;112;111 15:57:34 INFO - PROCESS | 21182 | |1;audio-beat-detection;148;122;127;162;126;125;130;129;159;124 15:57:34 INFO - PROCESS | 21182 | |2;audio-dft;164;159;160;160;161;160;161;160;161;160 15:57:34 INFO - PROCESS | 21182 | |3;audio-fft;74;76;76;107;78;76;76;76;102;76 15:57:34 INFO - PROCESS | 21182 | |4;audio-oscillator;83;83;108;82;82;82;109;83;83;120 15:57:34 INFO - PROCESS | 21182 | |5;imaging-gaussian-blur;116;117;116;117;117;117;117;117;117;116 15:57:34 INFO - PROCESS | 21182 | |6;imaging-darkroom;146;145;146;145;146;146;145;145;146;146 15:57:34 INFO - PROCESS | 21182 | |7;imaging-desaturate;97;97;95;96;95;95;95;95;95;95 15:57:34 INFO - PROCESS | 21182 | |8;json-parse-financial;52;52;51;51;52;54;53;54;53;54 15:57:34 INFO - PROCESS | 21182 | |9;json-stringify-tinderbox;60;61;60;61;61;60;60;60;60;61 15:57:34 INFO - PROCESS | 21182 | |10;stanford-crypto-aes;84;85;79;79;80;81;79;86;82;85 15:57:34 INFO - PROCESS | 21182 | |11;stanford-crypto-ccm;132;137;128;140;136;129;130;130;166;141 15:57:34 INFO - PROCESS | 21182 | |12;stanford-crypto-pbkdf2;169;165;168;170;167;166;168;169;172;167 15:57:34 INFO - PROCESS | 21182 | |13;stanford-crypto-sha256-iterative;70;66;68;67;66;66;67;65;65;65 15:57:34 INFO - PROCESS | 21182 | __end_tp_report 15:57:34 INFO - PROCESS | 21182 | __start_cc_report 15:57:34 INFO - PROCESS | 21182 | _x_x_mozilla_cycle_collect,1656 15:57:34 INFO - PROCESS | 21182 | __end_cc_report 15:57:34 INFO - PROCESS | 21182 | __startTimestamp1475794654920__endTimestamp 15:57:34 INFO - PROCESS | 21182 | 15:57:34 INFO - PROCESS | 21182 | ------- Summary: start ------- 15:57:34 INFO - PROCESS | 21182 | Number of tests: 14 15:57:34 INFO - PROCESS | 21182 | 15:57:34 INFO - PROCESS | 21182 | [#0] ai-astar Cycles:10 Average:111.40 Median:111.50 stddev:1.17 (1.1%) stddev-sans-first:1.24 15:57:34 INFO - PROCESS | 21182 | Values: 111.0 111.0 112.0 110.0 114.0 110.0 111.0 112.0 112.0 111.0 15:57:34 INFO - PROCESS | 21182 | 15:57:34 INFO - PROCESS | 21182 | [#1] audio-beat-detection Cycles:10 Average:135.20 Median:129.50 stddev:15.16 (11.7%) stddev-sans-first:15.36 15:57:34 INFO - PROCESS | 21182 | Values: 148.0 122.0 127.0 162.0 126.0 125.0 130.0 129.0 159.0 124.0 15:57:34 INFO - PROCESS | 21182 | 15:57:34 INFO - PROCESS | 21182 | [#2] audio-dft Cycles:10 Average:160.60 Median:160.50 stddev:1.35 (0.8%) stddev-sans-first:0.67 15:57:34 INFO - PROCESS | 21182 | Values: 164.0 159.0 160.0 160.0 161.0 160.0 161.0 160.0 161.0 160.0 15:57:34 INFO - PROCESS | 21182 | 15:57:34 INFO - PROCESS | 21182 | [#3] audio-fft Cycles:10 Average:81.70 Median:76.00 stddev:12.11 (15.9%) stddev-sans-first:12.52 15:57:34 INFO - PROCESS | 21182 | Values: 74.0 76.0 76.0 107.0 78.0 76.0 76.0 76.0 102.0 76.0 15:57:34 INFO - PROCESS | 21182 | 15:57:34 INFO - PROCESS | 21182 | [#4] audio-oscillator Cycles:10 Average:91.50 Median:82.50 stddev:14.72 (17.8%) stddev-sans-first:15.29 15:57:34 INFO - PROCESS | 21182 | Values: 83.0 83.0 108.0 82.0 82.0 82.0 109.0 83.0 83.0 120.0 15:57:34 INFO - PROCESS | 21182 | 15:57:34 INFO - PROCESS | 21182 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 15:57:34 INFO - PROCESS | 21182 | Values: 116.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 15:57:34 INFO - PROCESS | 21182 | 15:57:34 INFO - PROCESS | 21182 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 15:57:34 INFO - PROCESS | 21182 | Values: 146.0 145.0 146.0 145.0 146.0 146.0 145.0 145.0 146.0 146.0 15:57:34 INFO - PROCESS | 21182 | 15:57:34 INFO - PROCESS | 21182 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.00 stddev:0.85 (0.9%) stddev-sans-first:0.71 15:57:34 INFO - PROCESS | 21182 | Values: 97.0 97.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 15:57:34 INFO - PROCESS | 21182 | 15:57:34 INFO - PROCESS | 21182 | [#8] json-parse-financial Cycles:10 Average:52.60 Median:53.00 stddev:1.17 (2.2%) stddev-sans-first:1.22 15:57:34 INFO - PROCESS | 21182 | Values: 52.0 52.0 51.0 51.0 52.0 54.0 53.0 54.0 53.0 54.0 15:57:34 INFO - PROCESS | 21182 | 15:57:34 INFO - PROCESS | 21182 | [#9] json-stringify-tinderbox Cycles:10 Average:60.40 Median:60.50 stddev:0.52 (0.9%) stddev-sans-first:0.53 15:57:34 INFO - PROCESS | 21182 | Values: 60.0 61.0 60.0 61.0 61.0 60.0 60.0 60.0 60.0 61.0 15:57:34 INFO - PROCESS | 21182 | 15:57:34 INFO - PROCESS | 21182 | [#10] stanford-crypto-aes Cycles:10 Average:82.00 Median:83.00 stddev:2.79 (3.4%) stddev-sans-first:2.86 15:57:34 INFO - PROCESS | 21182 | Values: 84.0 85.0 79.0 79.0 80.0 81.0 79.0 86.0 82.0 85.0 15:57:34 INFO - PROCESS | 21182 | 15:57:34 INFO - PROCESS | 21182 | [#11] stanford-crypto-ccm Cycles:10 Average:136.90 Median:136.50 stddev:11.23 (8.2%) stddev-sans-first:11.77 15:57:34 INFO - PROCESS | 21182 | Values: 132.0 137.0 128.0 140.0 136.0 129.0 130.0 130.0 166.0 141.0 15:57:34 INFO - PROCESS | 21182 | 15:57:34 INFO - PROCESS | 21182 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.10 Median:168.50 stddev:2.02 (1.2%) stddev-sans-first:2.12 15:57:34 INFO - PROCESS | 21182 | Values: 169.0 165.0 168.0 170.0 167.0 166.0 168.0 169.0 172.0 167.0 15:57:34 INFO - PROCESS | 21182 | 15:57:34 INFO - PROCESS | 21182 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:66.50 stddev:1.58 (2.4%) stddev-sans-first:1.05 15:57:34 INFO - PROCESS | 21182 | Values: 70.0 66.0 68.0 67.0 66.0 66.0 67.0 65.0 65.0 65.0 15:57:34 INFO - PROCESS | 21182 | -------- Summary: end -------- 15:57:34 INFO - PROCESS | 21182 | 15:57:36 INFO - TEST-INFO | 21182: exit 0 15:57:36 INFO - TEST-OK | kraken | took 61681ms 15:57:36 INFO - SUITE-END | took 1179s 15:57:36 INFO - Completed test suite (00:19:39) 15:57:36 INFO - javascript benchmark 15:57:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2950.970490295097, 2994.0568720852943, 2997.8051426657266, 3026.7578593712506, 3046.741027012704, 5101.209312556555, 5156.303898973638, 5209.609279304048, 5217.373915130185, 5227.9738601307035, 5157.200633901752, 5248.21276808478, 5257.947420525794, 5272.182811664188, 5299.390570084442, 4715.858524244278, 4753.429588449391, 4753.548412900777, 4783.306420569015, 4783.593394561449, 4800.255960326155, 4837.201861692816, 4874.390701162355, 4876.683015603974, 4932.260160975864, 4805.567498925078, 4814.927776083362, 4853.02939412119, 4864.270359446076, 4910.582600478963, 4654.232051711463, 4721.5750582447745, 4725.1730947084125, 4784.114938736345, 4786.0, 4675.088357770236, 4678.672492925497, 4685.461171965234, 4703.858884233444, 4729.69256998294, 5192.896142077175, 5238.528532432061, 5241.318628578299, 5250.976059668328, 5251.658642188284, 5411.891762164734, 5431.6740995540395, 5518.724063796834, 5544.556435485151, 5586.273784408041, 5629.324481062258, 5630.662160270397, 5658.377578466366, 5679.403662615448, 5692.203091567184, 5253.028189784902, 5253.080710875582, 5254.054270231357, 5257.13257312543, 5321.9622173676535, 5526.806561770399, 5577.27495425592, 5580.944190558123, 5735.569832262597, 5740.282464691913, 5412.972935135299, 5442.319710036246, 5454.53636440899, 5496.945030549723, 5499.285092937973, 5516.806911758069, 5528.170774383874, 5529.557635389159, 5529.889402211933, 5532.30846144232, 5261.3686357637325, 5363.624546281801, 5506.862328441741, 5509.586780991442, 5582.469665381782, 5548.140038294071, 5572.108462645957, 5582.134769110794, 5596.944030559724, 5666.206731057655, 4288.185244803477, 4315.201687687788, 4324.718893271927, 4325.632321252729, 4380.4305440292555, 3796.962030379661, 3857.8071096445065, 3874.3994680824517, 3900.063984643722, 3924.9018774530864, 5178.559822415062, 5246.291750613618, 5325.4940780625775, 5332.2801421808335, 5421.566274698014, 5642.915356269577, 5649.943500565024, 5655.406182350876, 5660.745266463019, 5661.0, 5304.734763261821, 5328.6802791832615, 5343.465653434625, 5349.491798279158, 5411.512963833274, 4788.377510923558, 4806.303086052572, 4820.927686084711, 4823.9517604824205, 4850.684705494132, 5721.284839395075, 5852.3269823969085, 5853.94146058534, 5858.7070646468355, 5859.20900678403, 5537.723113844372, 5571.415001424954, 5589.301337332833, 5590.0496915523645, 5591.832245032656, 5775.451332123442, 5782.508486778671, 5785.652860828363, 5791.797287094932, 5796.333421656564, 5282.524572788468, 5366.838994830161, 5372.731363431891, 5443.183522471661, 5452.972735136299, 5538.47384498472, 5546.667199968015, 5547.33431988164, 5548.140038294071, 5552.083906155601, 5407.324084489439, 5411.404745477916, 5413.621046526705, 5415.458454154553, 5418.187271909245, 5363.463653634605, 5417.052015897281, 5419.756110975094, 5420.05149098914, 5420.945790542044, 5394.487523685244, 5401.864953376197, 5402.837914862561, 5410.675359478444, 5410.972945135407, 5448.700321482356, 5461.1808228766, 5464.480874316933, 5469.371022332482, 5472.699001554953, 5335.093034184276, 5344.545713614386, 5360.919586206132, 5423.213634023124, 5427.0231358354295], "value": 5148.370204283047, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [592.3839207224486, 607.5352355448081, 612.9824491344369, 626.1077963901439, 628.7924984755032, 39837.4024389634, 41185.58814411855, 41316.0, 41370.37944430828, 45620.54379456204, 44324.77837610807, 44479.55520444795, 44575.331370029475, 44958.55041449585, 45015.32477012847, 7940.523568585874, 8813.206811386974, 9013.05362936892, 9028.32287578431, 9040.683576074838, 7868.449208555404, 9988.350757200795, 10219.897801021969, 10269.486525673723, 10652.733681657943, 10870.456477176149, 10917.617883374083, 10920.945395273013, 10922.781544369107, 10930.617428390007, 10725.088367488774, 10771.084457821056, 10776.568937242579, 10780.838287425695, 10784.622538211204, 10548.20888433363, 10557.313774604703, 10642.255042147053, 10644.733881652943, 10646.467676616137, 41339.0, 41552.168956621, 41625.791871040754, 41708.58291417108, 41713.0, 3540.7521473496868, 3700.389435743099, 3720.330340538702, 3720.813959302024, 3832.967909109024, 30547.34874048308, 30641.387172256655, 31091.689083109333, 31115.533267001014, 32325.191870203198, 4318.719283246579, 4354.194474022316, 4387.62705170061, 4404.515503294635, 4411.338299255105, 331767.0, 332752.3362383197, 332989.0, 333872.0, 334716.0, 56107.719461402434, 56567.0, 56680.0, 56770.43229567734, 56774.7161264191, 35228.11929701727, 60050.39949600448, 60108.39891601115, 60179.0, 60216.0, 16514.83485165157, 17590.91204543969, 17590.912045439945, 17597.0, 17606.559836003948, 11953.163278570417, 12322.81515777264, 13092.410841512155, 13395.665108372368, 13493.392797324144, 17847.553811154827, 18442.0, 18487.445376638723, 18559.814401856078, 18596.163172657263, 5580.832575022756, 6896.93103068973, 6922.758117912643, 7008.369246767816, 7058.118035080685, 903.2593273515654, 1001.2040427859869, 1023.467796745688, 1073.5383784972537, 1076.7738774857369, 31723.206919826727, 32357.191070223435, 32576.348473030408, 32741.18147046343, 32852.507212391836, 1072.1422861710755, 1095.085603521053, 1120.7335710646917, 1123.550579768083, 1184.603157942082, 15378.538643840702, 16178.0, 16217.675646487005, 16273.349066037226, 16397.180140992903, 508595.0, 514067.0, 514865.0, 515345.0, 518600.0, 56015.439845601024, 56510.152347714815, 56663.43336566664, 56671.43328566744, 56719.432805671415, 1232.8458942632171, 1277.3230188000189, 1332.0875200487696, 1352.4860552989999, 1378.8896888248917, 28521.572176417787, 32492.675073248964, 32541.18647033843, 32936.835315823264, 33298.0, 47744.7612761934, 48601.0, 48739.0, 48751.26873096835, 48783.0, 409407.2474202116, 410350.0, 412473.0, 414739.0, 414996.0, 27483.725162748116, 27799.166025019284, 28500.57249141306, 28514.57228141621, 30236.395272094876, 46907.0, 47187.528124718316, 47553.286700700206, 47679.0, 48599.5140048595, 39912.80043599763, 40532.39201411922, 40636.79681601573, 41936.370954436316, 42045.36931945962, 39368.60631393649, 40521.18957620772, 40566.0, 41226.58773412227, 41868.3719744198, 40702.0, 40990.0, 41546.169076618906, 41738.0, 41824.16351673011, 32442.0, 35508.0, 35517.64482355143, 35906.28187436289, 36279.63720362762, 27524.862375688794, 27569.310767230978, 27711.090335515288, 28033.57949630798, 28051.0], "value": 20199.021270826957, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.9492350868097, 372.41158968829234, 379.4933763425826, 380.82101412336203, 401.63451259353974, 14152.292385380728, 18148.546286342833, 18180.818191818078, 18602.34891778788, 19694.310699125534, 17937.64124717508, 18395.080245987712, 18544.721829172573, 18585.90707046463, 19143.808561914375, 5197.584193264539, 5442.9727851360685, 5448.210009548613, 5448.400675925645, 5449.073657478239, 5143.0485360208295, 5217.58259339252, 5359.249705041298, 5442.8911421771545, 5444.210589464545, 5266.8419947401635, 5268.288781014571, 5269.8946021079555, 5270.998510283034, 5276.3140791697215, 5255.211718242275, 5258.290130832327, 5260.263563101169, 5570.189688351302, 5779.248697669318, 5706.457886500776, 5731.111677689964, 5732.254806875121, 5734.197212390269, 5734.311882574076, 12746.215529825831, 13044.54344097952, 13145.802812957812, 13255.27096009719, 13684.110532815335, 2083.906224219914, 2092.424583239606, 2119.9682004769943, 2177.7822217778253, 2191.4391341142814, 9680.95159524205, 10053.396796192252, 10277.17782577392, 10411.479426028744, 12998.119034670673, 1790.8030116687285, 1842.1526097994938, 1874.3158747057362, 1891.1206289075508, 1898.933537326187, 71437.64281178612, 74671.62664186698, 79749.0, 82867.0, 84296.57851710764, 10592.364458132537, 10841.945790270998, 10901.83647245292, 11191.216614836883, 11245.059191015058, 15345.6163595911, 15609.892664490148, 15639.68720625581, 15662.530124096294, 15664.530064098095, 7991.120976692559, 8116.2695357418115, 8178.918210817935, 8295.677210381104, 8306.875396869053, 7734.419918506134, 7822.960885195537, 7844.058712954482, 8008.599570021475, 8076.152004039609, 4624.930626040612, 4641.419822522184, 4678.391809064868, 4829.855104346875, 4859.813084112164, 1897.8328328078408, 1957.2758079510672, 1971.9802801972085, 2001.9699704504444, 2033.6136134134467, 851.9872201916976, 923.2429407885469, 1037.3464717228098, 1044.4673216659407, 1060.8886066963012, 19020.334288299844, 19347.0, 19398.70901936472, 19455.12451939666, 19699.704504432444, 973.8977407372265, 1010.4442556593991, 1019.1642852860583, 1021.9744506387251, 1038.3354653022072, 9685.17675997548, 10571.471426428801, 10843.349399036084, 10847.51186196623, 10848.240623156304, 330668.0, 332250.0, 335447.0, 434550.0, 448607.0, 83832.16167838365, 87138.0, 89168.5541572288, 92940.53529732443, 93275.53362233145, 1011.1132716095589, 1042.5829668132808, 1071.7802850415646, 1080.378782200238, 1082.355998181081, 16375.88858116954, 16910.74633880468, 17408.564785880455, 17439.30242790274, 17523.912380438527, 39470.2105957885, 40463.393049104874, 41022.79488602538, 41321.380179296735, 42665.36001959911, 55882.44117558935, 56877.0, 57462.0, 58535.707321463124, 58981.41018589931, 7429.628518574158, 7716.884246736416, 7904.170062143392, 8186.345092392713, 8349.081601023761, 12517.0, 12877.678058048248, 12948.8057679133, 13000.479980800663, 13041.869581304445, 10961.890381096406, 10974.451277435937, 11107.777844443228, 11167.38579378142, 11577.305361678325, 11028.0, 11247.831282530606, 11479.196456248317, 11547.0, 11855.407229638311, 11180.385078820744, 11330.773384532427, 11432.14258930567, 11520.769584608093, 11592.594259200887, 7328.377087947584, 7526.134494533198, 7559.395248380007, 7560.206178351194, 8043.1554686757045, 8315.708950186714, 10956.233063685784, 11129.499172537093, 11240.718982025515, 11489.851014898777], "value": 8780.306416396514, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1346.535445271381, 1483.2509582660757, 1502.489153687746, 1630.6249562600601, 1757.903315317657, 7883.093444253913, 8699.260562852158, 9056.320775941806, 9091.772705682344, 9295.90704092959, 9124.178823905848, 9195.126462986022, 9197.862032069525, 9204.585793639286, 9213.401128926615, 2321.3268152235873, 2347.95304093918, 2348.58899692554, 2349.1425629645228, 2355.9057637694473, 2307.246492665578, 2341.028473183627, 2381.809455243585, 2387.7492863249367, 2390.605550084234, 2319.2926157521947, 2338.333574931145, 2340.6254999200046, 2342.3792694935855, 2350.424146084203, 2235.8993845277, 2253.808426283768, 2266.705328307326, 2271.6478945763433, 2314.0628045641542, 2300.5168914527967, 2301.9539609207723, 2311.7457079721216, 2312.8034117099896, 2314.155333303349, 9094.49980251086, 9100.68147614837, 9146.451212927246, 9196.816063678689, 9231.492267925261, 5121.308623335839, 5288.973555132238, 5292.206169074631, 5369.677819330814, 5371.0, 3380.154961259685, 3546.5389499365174, 3597.262561174979, 3606.9639303607155, 3638.781673099596, 1074.8334008228737, 1125.5047778977223, 1158.6537262044344, 1183.4023817971954, 1189.6014835030276, 12787.488500460064, 12928.612141635766, 12961.41673624689, 12968.481260749653, 12972.221666700028, 4157.937630935538, 4259.893502662396, 4440.0, 4475.820967161277, 4481.5294394088805, 9952.950235248922, 9954.203663706887, 9958.651447199314, 9963.950180249198, 9964.750881227883, 5241.685498870003, 5287.603429742785, 5292.417834038252, 5296.814611488579, 5298.496642818926, 4210.642095421924, 4349.282368409177, 4570.268756998931, 4679.461861885927, 4934.9013019739405, 3675.320065787838, 3707.3882809336155, 3792.6776224020714, 3813.694904407641, 3967.26605577969, 1046.3669479964665, 1050.653284416156, 1054.9736256593646, 1064.5528877871313, 1064.9307794993301, 953.77109493721, 976.7509285132246, 982.3565564555228, 988.6724960254429, 1000.2098342309639, 5989.281286245591, 6014.338422773491, 6023.518118550505, 6101.237345331833, 6122.816315510542, 985.522021819417, 1000.1287294404133, 1005.3967619428431, 1010.2574607663362, 1024.3495380433478, 4062.4515690382013, 4155.4182414462, 4184.8744537663915, 4289.463817022872, 4374.234508960919, 11130.610428634958, 11579.826302605468, 11616.128790340757, 11627.53489860396, 11642.941785291188, 11290.379029153475, 11335.886641133648, 11462.360248447205, 11569.768604628029, 11572.016378607745, 8367.163283671583, 8519.48883067018, 8529.829403411897, 8533.146685331292, 8540.44487108336, 6011.0, 6022.277326720821, 6066.726997285221, 6071.39286071407, 6100.437816117153, 10167.440790756284, 10392.37645741258, 10433.269671123253, 10523.579056837641, 10650.467476626292, 10723.0, 10747.516361763583, 10778.676639700821, 10796.352218866894, 10813.837792433276, 7462.216467271075, 7540.3213710766295, 7622.656980435783, 7650.349720273616, 7701.537907725555, 8892.911070889208, 8926.910730892867, 8954.104589540993, 8955.104489550993, 8964.596593153194, 7893.723719670013, 7966.482178658369, 8156.388270879589, 8184.181581842006, 8263.256306932164, 7684.423668224794, 7805.531668099932, 7811.921880781119, 7866.488678235896, 7914.24814642608, 7201.099862517185, 7244.239354867663, 7310.305520975498, 7330.230325815925, 7332.156801967842, 4980.850574482772, 5118.155504341891, 5179.507946745053, 5195.480451954774, 5216.739163041909, 5148.716820574904, 5239.24031015493, 5264.763085661078, 5283.365996080495, 5429.53848922846], "value": 4691.486073023884, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [315.92101974506386, 321.3556818578751, 329.88289157349146, 330.17456359102243, 337.87160878866035, 5006.899862002767, 5104.336436263286, 5147.7426128693605, 5154.458781827911, 5186.585073194145, 4995.225740010295, 5143.81996630118, 5146.45962173971, 5148.48515148485, 5160.716160611165, 4131.5539561153655, 4133.545310015911, 4134.276501612221, 4137.54487006429, 4138.482689663792, 3960.5841386654274, 4078.3474644056955, 4111.136661301115, 4159.064210552617, 4164.66682665386, 4092.9795351023204, 4112.465379500661, 4116.115035267417, 4124.463819703435, 4138.482689663792, 4092.5676013395073, 4100.938485922714, 4111.897202569945, 4117.814698338582, 4121.52602450719, 3688.723345749053, 3693.150575367654, 3699.8520059197867, 3705.7591256568235, 3725.869594564177, 4844.975775121137, 5064.518870707277, 5075.390953085616, 5101.51535604117, 5124.282600435942, 4619.74591397473, 4621.491635920046, 4688.812447502096, 4690.545930761441, 4707.293905914106, 5399.595030372738, 5405.621606487547, 5416.647917885325, 5439.972800136014, 5446.373667028302, 3838.309104361214, 3903.6291552302487, 3937.8424863005444, 3942.56631770505, 3947.1513624570566, 5579.609427340088, 5579.832605021856, 5592.5246354059955, 5594.4964953154, 5610.7194640268235, 4006.779627120478, 4031.274370613259, 4044.170944956277, 4047.6964227683043, 4070.9389359159636, 3874.9418758718643, 4011.277969965376, 4050.1697152083752, 4119.855805046869, 4119.958800412018, 4570.840020599329, 4608.838690645811, 4634.21218392874, 4640.076751646441, 4647.16351056813, 5383.631202270988, 5393.865153371197, 5406.837794866082, 5463.770651603437, 5466.617336786467, 1322.418136020148, 1355.6881917158912, 1366.6856622976572, 1377.2646465453602, 1404.8876089912783, 941.2328951904176, 950.7432993091827, 973.0998826085843, 981.1513041219293, 986.7582442301682, 5166.483351664803, 5189.922151167735, 5190.195519694454, 5206.427292997767, 5224.555912747383, 5429.56563474921, 5480.342358916955, 5489.313835770528, 5500.3949565547755, 5508.173773933942, 4932.950670493249, 5108.719020453911, 5184.922226166611, 5203.635745497779, 5204.1673332266655, 2572.915938090153, 2581.8838152282815, 2582.793376529911, 2585.818992670495, 2614.163467690321, 4998.5751211146735, 5009.323741294951, 5016.4198277542455, 5021.472745361758, 5031.823886163967, 4729.712849569585, 4791.6645834791925, 4897.510248975074, 4922.384701912261, 4971.279164521196, 4895.290182923527, 4914.0, 4979.800807967641, 4992.925106123411, 5037.0, 4882.829100981448, 4885.8045678172475, 4887.291342755351, 4896.681715688612, 4900.754962251945, 4602.527191298752, 4805.543473370024, 4808.3989501312335, 4862.003289325609, 4869.514797986648, 5057.241413787961, 5078.984203159309, 5083.161278389172, 5086.796528138833, 5090.0, 3626.474161246552, 3664.37705590045, 3702.2965636528975, 3709.5919448860063, 3720.9441858371606, 4579.793909274024, 4892.119418504703, 4913.6069114471475, 4937.802487900443, 4954.142196676246, 4651.837185698484, 4703.31801888731, 4705.223638099676, 4730.503297153749, 4772.5227477252, 4729.101470720552, 4741.960956788614, 4765.404324459442, 4771.566501084402, 4788.61691064721, 4619.729574367076, 4772.761361931959, 4794.5924596409695, 4794.7842347093765, 5022.221555658879, 5467.17992301158, 5489.945100548944, 5503.587230957774, 5510.779568817203, 5513.4486551346145, 5354.0, 5363.5440987516495, 5376.542993845567, 5447.1829225616475, 5469.726513674221], "value": 3988.8531753097222, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [730.0509337860781, 735.2390276064273, 777.2072486064214, 782.8512582609304, 802.7350974178514, 15158.545243642695, 16691.0, 16710.832891671078, 16723.247453864577, 16759.245833937486, 15132.773008404884, 15304.0, 15307.387704491806, 15312.693746125098, 15326.0, 639.9136116624243, 670.4502308107354, 759.6050053971932, 776.9184235655246, 797.9880301795478, 774.1523032279673, 777.0830420104274, 786.712849809821, 787.1498781316193, 787.4527203593505, 840.1178762299592, 846.031294168177, 846.1580727176469, 846.7925358287229, 847.0555330806168, 654.6072356586058, 690.4648897104734, 831.9542425166613, 837.1670188162786, 838.4550042472381, 582.6533212738414, 611.6788685939918, 615.5721773367511, 616.2881871438495, 616.8334549671564, 14468.421263149461, 14500.492482763158, 14513.056651317736, 14525.201113938729, 14538.781918271234, 13980.231087290194, 14356.49752258666, 14536.200508972002, 14601.488947886774, 14859.182744949023, 12777.29724865132, 12873.0, 13048.804267935988, 13500.39248233822, 13805.309734513334, 4137.172565486884, 4200.411942328076, 4203.91592168158, 4245.596668316505, 4362.258416069244, 71726.64136679335, 73610.0, 74292.0, 74555.62722186354, 76297.61851190764, 10425.9478702606, 10815.56737730482, 11248.662540123809, 11250.437478126061, 11461.197716159788, 21843.0, 21843.126274949143, 21853.125874965142, 21855.453613659785, 21908.23321183751, 8148.185181481923, 8192.057913339922, 8237.670493180205, 8374.748757537283, 8455.788605284793, 4360.694751367438, 4616.261398176276, 4641.837535686234, 4674.462436819741, 4876.975615121902, 3525.823708814549, 3607.9278414432088, 3638.7089032877307, 3650.1604630935035, 3659.341318562631, 613.8557439001831, 617.6170774120075, 622.330994181257, 641.3234038089766, 641.5092454272485, 606.3693758491208, 631.4979591224987, 669.7689297192461, 705.982350441243, 719.4927576058866, 8976.730698079067, 9055.547222638974, 9312.068793120634, 9377.571426434177, 9681.854772178423, 646.2955378637308, 672.6737532296833, 688.8932215506604, 690.4441924250925, 715.4562532475356, 4066.5933406659096, 4306.784660767012, 4371.628411584988, 4470.173017991682, 4499.368178064342, 62892.685536572026, 63321.19692809644, 97790.5110474443, 115682.4215878932, 120158.39920800341, 78894.21105788983, 93761.5311923436, 98265.01734982559, 101594.4920275394, 102727.15935450108, 50417.49582504202, 64027.679861600394, 71985.28014719786, 81390.59304703439, 83813.0, 9420.670276540288, 10047.0, 10204.0, 10293.3823970562, 10390.844137338097, 48397.51602484071, 49089.754551227015, 49527.25709114294, 49984.25023624576, 50166.749166255395, 69264.6536767313, 72152.0, 72474.63762681364, 74178.0, 75815.0, 12603.621891343275, 12802.551910683082, 12824.294663793207, 12968.67578310512, 12970.80543791825, 12675.619731408073, 12988.48046078184, 13206.339683016004, 14687.265636718335, 14806.333714983068, 14035.929820350833, 14332.426702931765, 14391.208483533506, 14577.34401951936, 15278.159701216095, 14012.859871401155, 14493.0, 14639.121652700873, 14885.181315027778, 15144.16707081121, 13861.23763193034, 14521.709565808836, 14539.78190327167, 14539.78190327167, 14964.551063468114, 11086.722831929266, 11314.943425282821, 11586.293593267263, 12082.758344832879, 12567.685807854878, 10414.323069000491, 11009.83485247738, 11751.177417580688, 11879.346635935106, 12230.938845305716], "value": 7439.347279795957, "unit": "score"}], "name": "dromaeo_css", "value": 7091.015856341486, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 111.0, 112.0, 110.0, 114.0, 110.0, 111.0, 112.0, 112.0, 111.0], "value": 111.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 122.0, 127.0, 162.0, 126.0, 125.0, 130.0, 129.0, 159.0, 124.0], "value": 135.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 159.0, 160.0, 160.0, 161.0, 160.0, 161.0, 160.0, 161.0, 160.0], "value": 160.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 76.0, 107.0, 78.0, 76.0, 76.0, 76.0, 102.0, 76.0], "value": 81.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 108.0, 82.0, 82.0, 82.0, 109.0, 83.0, 83.0, 120.0], "value": 91.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 145.0, 146.0, 146.0, 145.0, 145.0, 146.0, 146.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 97.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 51.0, 51.0, 52.0, 54.0, 53.0, 54.0, 53.0, 54.0], "value": 52.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 60.0, 61.0, 61.0, 60.0, 60.0, 60.0, 60.0, 61.0], "value": 60.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 79.0, 79.0, 80.0, 81.0, 79.0, 86.0, 82.0, 85.0], "value": 82.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 137.0, 128.0, 140.0, 136.0, 129.0, 130.0, 130.0, 166.0, 141.0], "value": 136.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 165.0, 168.0, 170.0, 167.0, 166.0, 168.0, 169.0, 172.0, 167.0], "value": 168.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 66.0, 68.0, 67.0, 66.0, 66.0, 67.0, 65.0, 65.0, 65.0], "value": 66.5, "unit": "score"}], "name": "kraken", "value": 1504.7, "alertThreshold": 2.0}]} 15:57:36 INFO - Return code: 0 15:57:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:57:36 INFO - # TBPL SUCCESS # 15:57:36 INFO - Running post-action listener: _resource_record_post_action 15:57:36 INFO - [mozharness: 2016-10-06 22:57:36.726399Z] Finished run-tests step (success) 15:57:36 INFO - Running post-run listener: _resource_record_post_run 15:57:36 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 403869696; Read time: 8; Write time: 327588 15:57:36 INFO - TinderboxPrint: CPU usage
13.1% 15:57:36 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 15:57:36 INFO - TinderboxPrint: I/O write bytes / time
403,869,696 / 327,588 15:57:36 INFO - TinderboxPrint: CPU idle
8,295.5 (86.9%) 15:57:36 INFO - TinderboxPrint: CPU user
1,204.7 (12.6%) 15:57:36 INFO - TinderboxPrint: Swap in / out
0 / 0 15:57:36 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103936000; Read time: 0; Write time: 105536 15:57:36 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 288514048; Read time: 0; Write time: 219696 15:57:37 INFO - Running post-run listener: _upload_blobber_files 15:57:37 INFO - Blob upload gear active. 15:57:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:57:37 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 15:57:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:57:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:57:37 INFO - (blobuploader) - INFO - Open directory for files ... 15:57:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:57:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:57:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:57:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:57:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:57:41 INFO - (blobuploader) - INFO - Done attempting. 15:57:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:57:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:57:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:57:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:57:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:57:41 INFO - (blobuploader) - INFO - Done attempting. 15:57:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:57:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:57:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:57:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:57:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:57:42 INFO - (blobuploader) - INFO - Done attempting. 15:57:42 INFO - (blobuploader) - INFO - Iteration through files over. 15:57:42 INFO - Return code: 0 15:57:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:57:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:57:42 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f26f8eb612ea96f3f690bd1d388945db4e62850034dd0f6299768df1f8b698be5ca3ac87e64fa20872a262b460d9e36a4344550fa1c6f6f25f8c16022fa2f18d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/20a33c48321ebb00cfb32b01024436fb92b8528c0f2e08697384f1be624a4155e3002bc9ebc9ec2351faf8cb1f94f61b2f771dd3e0647c178073c555f58f640f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/319c4cd51683764a6ee3eac6298445d425214428dc1ccf372d7882081168ec516b0ddb9a2bdd12dea1d223a411e2fc1ebae77f1b7f6f8878eab70bbbeb954ec3"} 15:57:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:57:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:57:42 INFO - Contents: 15:57:42 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f26f8eb612ea96f3f690bd1d388945db4e62850034dd0f6299768df1f8b698be5ca3ac87e64fa20872a262b460d9e36a4344550fa1c6f6f25f8c16022fa2f18d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/20a33c48321ebb00cfb32b01024436fb92b8528c0f2e08697384f1be624a4155e3002bc9ebc9ec2351faf8cb1f94f61b2f771dd3e0647c178073c555f58f640f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/319c4cd51683764a6ee3eac6298445d425214428dc1ccf372d7882081168ec516b0ddb9a2bdd12dea1d223a411e2fc1ebae77f1b7f6f8878eab70bbbeb954ec3"} 15:57:42 INFO - Running post-run listener: copy_logs_to_upload_dir 15:57:42 INFO - Copying logs to upload dir... 15:57:42 INFO - mkdir: /builds/slave/test/build/upload/logs 15:57:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.019907 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-10-06 15:57:42.673599) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-06 15:57:42.677499) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c6b6742ce8f6f39ef4ce27d000001f1-1475793420.328211-2058082381 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f26f8eb612ea96f3f690bd1d388945db4e62850034dd0f6299768df1f8b698be5ca3ac87e64fa20872a262b460d9e36a4344550fa1c6f6f25f8c16022fa2f18d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/20a33c48321ebb00cfb32b01024436fb92b8528c0f2e08697384f1be624a4155e3002bc9ebc9ec2351faf8cb1f94f61b2f771dd3e0647c178073c555f58f640f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/319c4cd51683764a6ee3eac6298445d425214428dc1ccf372d7882081168ec516b0ddb9a2bdd12dea1d223a411e2fc1ebae77f1b7f6f8878eab70bbbeb954ec3"} build_url:https://queue.taskcluster.net/v1/task/L5CadNaoTp2DYS2r7D6mLQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011441 build_url: 'https://queue.taskcluster.net/v1/task/L5CadNaoTp2DYS2r7D6mLQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f26f8eb612ea96f3f690bd1d388945db4e62850034dd0f6299768df1f8b698be5ca3ac87e64fa20872a262b460d9e36a4344550fa1c6f6f25f8c16022fa2f18d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/20a33c48321ebb00cfb32b01024436fb92b8528c0f2e08697384f1be624a4155e3002bc9ebc9ec2351faf8cb1f94f61b2f771dd3e0647c178073c555f58f640f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/319c4cd51683764a6ee3eac6298445d425214428dc1ccf372d7882081168ec516b0ddb9a2bdd12dea1d223a411e2fc1ebae77f1b7f6f8878eab70bbbeb954ec3"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-06 15:57:42.703998) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 15:57:42.704378) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c6b6742ce8f6f39ef4ce27d000001f1-1475793420.328211-2058082381 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004467 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 15:57:42.788065) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-06 15:57:42.788421) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-06 15:57:42.788773) ========= ========= Total master_lag: 0.18 =========