builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-013 starttime: 1484768613.41 results: success (0) buildid: 20170118100227 builduid: ce22bca750494301821895c97d74d0a6 revision: 4ad7551c5c9970c234eb6208d4461d2281664a2b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-18 11:43:33.408434) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-18 11:43:33.408857) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-18 11:43:33.409132) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-18 11:43:33.424845) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-18 11:43:33.425451) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1484768612.785104-703188752 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-18 11:43:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 226M=0s 2017-01-18 11:43:33 (226 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.104458 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-18 11:43:33.548771) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-18 11:43:33.549521) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1484768612.785104-703188752 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017850 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-18 11:43:33.602124) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-18 11:43:33.602487) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 4ad7551c5c9970c234eb6208d4461d2281664a2b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 4ad7551c5c9970c234eb6208d4461d2281664a2b --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=9c3a94c35cc88655b05d2c08000001b2-1484768612.785104-703188752 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-18 11:43:33,721 truncating revision to first 12 chars 2017-01-18 11:43:33,721 Setting DEBUG logging. 2017-01-18 11:43:33,721 attempt 1/10 2017-01-18 11:43:33,721 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/4ad7551c5c99?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-18 11:43:34,765 unpacking tar archive at: mozilla-aurora-4ad7551c5c99/testing/mozharness/ program finished with exit code 0 elapsedTime=1.375402 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-18 11:43:34.991717) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-18 11:43:34.992085) ========= script_repo_revision: 4ad7551c5c9970c234eb6208d4461d2281664a2b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-18 11:43:34.992524) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-18 11:43:34.992841) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-18 11:43:35.002846) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2017-01-18 11:43:35.003222) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=9c3a94c35cc88655b05d2c08000001b2-1484768612.785104-703188752 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:43:35 INFO - MultiFileLogger online at 20170118 11:43:35 in /builds/slave/test 11:43:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 11:43:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:43:35 INFO - {'append_to_log': False, 11:43:35 INFO - 'base_work_dir': '/builds/slave/test', 11:43:35 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 11:43:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:43:35 INFO - 'branch': 'Mozilla-Aurora', 11:43:35 INFO - 'buildbot_json_path': 'buildprops.json', 11:43:35 INFO - 'config_files': ('talos/linux_config.py',), 11:43:35 INFO - 'default_actions': ('clobber', 11:43:35 INFO - 'read-buildbot-config', 11:43:35 INFO - 'download-and-extract', 11:43:35 INFO - 'populate-webroot', 11:43:35 INFO - 'create-virtualenv', 11:43:35 INFO - 'install', 11:43:35 INFO - 'run-tests'), 11:43:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:43:35 INFO - 'download_minidump_stackwalk': True, 11:43:35 INFO - 'download_symbols': 'ondemand', 11:43:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:43:35 INFO - 'tooltool.py': '/tools/tooltool.py', 11:43:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:43:35 INFO - '/tools/misc-python/virtualenv.py')}, 11:43:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:43:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:43:35 INFO - 'installer_path': 'installer.exe', 11:43:35 INFO - 'log_level': 'info', 11:43:35 INFO - 'log_name': 'talos', 11:43:35 INFO - 'log_to_console': True, 11:43:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:43:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:43:35 INFO - 'opt_config_files': (), 11:43:35 INFO - 'pip_index': False, 11:43:35 INFO - 'sps_profile': False, 11:43:35 INFO - 'sps_profile_interval': 0, 11:43:35 INFO - 'suite': 'dromaeojs', 11:43:35 INFO - 'system_bits': '32', 11:43:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:43:35 INFO - 'title': 'talos-linux64-ix-013', 11:43:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:43:35 INFO - 'use_talos_json': True, 11:43:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:43:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:43:35 INFO - 'work_dir': 'build'} 11:43:35 INFO - [mozharness: 2017-01-18 19:43:35.223920Z] Running clobber step. 11:43:35 INFO - Running pre-action listener: _resource_record_pre_action 11:43:35 INFO - Running main action method: clobber 11:43:35 INFO - rmtree: /builds/slave/test/build 11:43:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:43:35 INFO - Running post-action listener: _resource_record_post_action 11:43:35 INFO - [mozharness: 2017-01-18 19:43:35.685142Z] Finished clobber step (success) 11:43:35 INFO - [mozharness: 2017-01-18 19:43:35.685241Z] Running read-buildbot-config step. 11:43:35 INFO - Running pre-action listener: _resource_record_pre_action 11:43:35 INFO - Running main action method: read_buildbot_config 11:43:35 INFO - Using buildbot properties: 11:43:35 INFO - { 11:43:35 INFO - "project": "", 11:43:35 INFO - "product": "firefox", 11:43:35 INFO - "script_repo_revision": "production", 11:43:35 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 11:43:35 INFO - "repository": "", 11:43:35 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 11:43:35 INFO - "buildid": "20170118100227", 11:43:35 INFO - "pgo_build": "True", 11:43:35 INFO - "basedir": "/builds/slave/test", 11:43:35 INFO - "buildnumber": 714, 11:43:35 INFO - "slavename": "talos-linux64-ix-013", 11:43:35 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 11:43:35 INFO - "platform": "ubuntu64_hw", 11:43:35 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 11:43:35 INFO - "branch": "mozilla-aurora", 11:43:35 INFO - "repo_path": "releases/mozilla-aurora", 11:43:35 INFO - "revision": "4ad7551c5c9970c234eb6208d4461d2281664a2b", 11:43:35 INFO - "stage_platform": "linux64-pgo", 11:43:35 INFO - "builduid": "ce22bca750494301821895c97d74d0a6", 11:43:35 INFO - "slavebuilddir": "test" 11:43:35 INFO - } 11:43:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/HcCzxjHnQJmxOHktZ5vpAg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 11:43:35 INFO - Running post-action listener: _resource_record_post_action 11:43:35 INFO - [mozharness: 2017-01-18 19:43:35.687653Z] Finished read-buildbot-config step (success) 11:43:35 INFO - [mozharness: 2017-01-18 19:43:35.687741Z] Running download-and-extract step. 11:43:35 INFO - Running pre-action listener: _resource_record_pre_action 11:43:35 INFO - Running main action method: download_and_extract 11:43:35 INFO - mkdir: /builds/slave/test/build/tests 11:43:35 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')]} 11:43:35 INFO - trying https://queue.taskcluster.net/v1/task/HcCzxjHnQJmxOHktZ5vpAg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 11:43:35 INFO - Downloading https://queue.taskcluster.net/v1/task/HcCzxjHnQJmxOHktZ5vpAg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 11:43:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HcCzxjHnQJmxOHktZ5vpAg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:43:36 INFO - Downloaded 1361 bytes. 11:43:36 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 11:43:36 INFO - Using the following test package requirements: 11:43:36 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 11:43:36 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 11:43:36 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 11:43:36 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 11:43:36 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 11:43:36 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 11:43:36 INFO - u'jsshell-linux-x86_64.zip'], 11:43:36 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 11:43:36 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 11:43:36 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 11:43:36 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 11:43:36 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 11:43:36 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 11:43:36 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 11:43:36 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 11:43:36 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 11:43:36 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 11:43:36 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 11:43:36 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:43:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HcCzxjHnQJmxOHktZ5vpAg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 11:43:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HcCzxjHnQJmxOHktZ5vpAg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:43:36 INFO - Fetch https://queue.taskcluster.net/v1/task/HcCzxjHnQJmxOHktZ5vpAg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 11:43:36 INFO - Http code: 200 11:43:36 INFO - via: 1.1 a75342fa94ff4a9431476624fe74f02e.cloudfront.net (CloudFront) 11:43:36 INFO - x-amz-cf-id: 3SMR7cLuXz8UP2eM89mp-cSNH84hah6hlZLHtPOMthycO8yzSY91Jw== 11:43:36 INFO - x-amz-version-id: Vx98g3ct8Xqwxb_dPGCtWPIYJFe6PaPi 11:43:37 INFO - Expected file size: 21948516 11:43:37 INFO - Obtained file size: 21948516 11:43:41 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:43:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HcCzxjHnQJmxOHktZ5vpAg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 11:43:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HcCzxjHnQJmxOHktZ5vpAg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:43:41 INFO - Fetch https://queue.taskcluster.net/v1/task/HcCzxjHnQJmxOHktZ5vpAg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 11:43:41 INFO - Http code: 200 11:43:41 INFO - via: 1.1 ff555a0cc6346f82fe74596f8ed6cc33.cloudfront.net (CloudFront) 11:43:41 INFO - x-amz-cf-id: AQcBK50WMeeiN-bpsz03bBv4HLvwcgzzKmIkV_AwAICR9_T4fkM5bA== 11:43:41 INFO - x-amz-version-id: Vx98g3ct8Xqwxb_dPGCtWPIYJFe6PaPi 11:43:41 INFO - Expected file size: 21948516 11:43:41 INFO - Obtained file size: 21948516 11:43:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HcCzxjHnQJmxOHktZ5vpAg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 11:43:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HcCzxjHnQJmxOHktZ5vpAg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:43:46 INFO - Fetch https://queue.taskcluster.net/v1/task/HcCzxjHnQJmxOHktZ5vpAg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 11:43:46 INFO - Http code: 200 11:43:46 INFO - via: 1.1 76bce8bb4fbd102fc0b3aa2e41094b79.cloudfront.net (CloudFront) 11:43:46 INFO - x-amz-cf-id: TsQ1cfRuWaI3hC1Ol_B0NQ9EAdztRqZwJAk4_mmtLXtRx4cz0PXKxA== 11:43:46 INFO - x-amz-version-id: wtIKZDcf6X5.lvJ7Ftxrwa22pmTK6eCJ 11:43:46 INFO - Expected file size: 14409038 11:43:46 INFO - Obtained file size: 14409038 11:43:47 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')]} 11:43:47 INFO - trying https://queue.taskcluster.net/v1/task/HcCzxjHnQJmxOHktZ5vpAg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 11:43:47 INFO - Downloading https://queue.taskcluster.net/v1/task/HcCzxjHnQJmxOHktZ5vpAg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 11:43:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HcCzxjHnQJmxOHktZ5vpAg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:43:48 INFO - Downloaded 64165242 bytes. 11:43:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HcCzxjHnQJmxOHktZ5vpAg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 11:43:48 INFO - mkdir: /builds/slave/test/properties 11:43:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:43:48 INFO - Writing to file /builds/slave/test/properties/build_url 11:43:48 INFO - Contents: 11:43:48 INFO - build_url:https://queue.taskcluster.net/v1/task/HcCzxjHnQJmxOHktZ5vpAg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 11:43:48 INFO - Running post-action listener: _resource_record_post_action 11:43:48 INFO - Running post-action listener: set_extra_try_arguments 11:43:48 INFO - [mozharness: 2017-01-18 19:43:48.960418Z] Finished download-and-extract step (success) 11:43:48 INFO - [mozharness: 2017-01-18 19:43:48.960682Z] Running populate-webroot step. 11:43:48 INFO - Running pre-action listener: _resource_record_pre_action 11:43:48 INFO - Running main action method: populate_webroot 11:43:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:43:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:43:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:43:48 INFO - '--tppagecycles', 11:43:48 INFO - '7'], 11:43:48 INFO - 'tests': ['tsvgm']}}, 11:43:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:43:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:43:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:43:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:43:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:43:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:43:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:43:48 INFO - 'talos_options': ['--disable-e10s'], 11:43:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:43:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:43:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:43:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:43:48 INFO - 'talos_options': ['--disable-e10s'], 11:43:48 INFO - 'tests': ['damp', 'tps']}, 11:43:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:43:48 INFO - 'tests': ['damp', 'tps']}, 11:43:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:43:48 INFO - 'tests': ['dromaeo_dom']}, 11:43:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:43:48 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:43:48 INFO - 'tests': ['basic_compositor_video']}, 11:43:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:43:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:43:48 INFO - 'tests': ['a11yr', 11:43:48 INFO - 'ts_paint', 11:43:48 INFO - 'tpaint', 11:43:48 INFO - 'sessionrestore', 11:43:48 INFO - 'sessionrestore_no_auto_restore', 11:43:48 INFO - 'tabpaint']}, 11:43:48 INFO - 'other-e10s': {'tests': ['a11yr', 11:43:48 INFO - 'ts_paint', 11:43:48 INFO - 'tpaint', 11:43:48 INFO - 'sessionrestore', 11:43:48 INFO - 'sessionrestore_no_auto_restore', 11:43:48 INFO - 'tabpaint']}, 11:43:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:43:48 INFO - 'ts_paint', 11:43:48 INFO - 'tpaint', 11:43:48 INFO - 'sessionrestore', 11:43:48 INFO - 'sessionrestore_no_auto_restore', 11:43:48 INFO - 'tabpaint']}, 11:43:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:43:48 INFO - 'ts_paint', 11:43:48 INFO - 'tpaint', 11:43:48 INFO - 'sessionrestore', 11:43:48 INFO - 'sessionrestore_no_auto_restore', 11:43:48 INFO - 'tabpaint']}, 11:43:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:43:48 INFO - 'tests': ['a11yr', 11:43:48 INFO - 'ts_paint', 11:43:48 INFO - 'tpaint', 11:43:48 INFO - 'sessionrestore', 11:43:48 INFO - 'sessionrestore_no_auto_restore', 11:43:48 INFO - 'tabpaint']}, 11:43:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:43:48 INFO - 'tests': ['a11yr', 11:43:48 INFO - 'ts_paint', 11:43:48 INFO - 'tpaint', 11:43:48 INFO - 'sessionrestore', 11:43:48 INFO - 'sessionrestore_no_auto_restore', 11:43:48 INFO - 'tabpaint']}, 11:43:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:43:48 INFO - 'tests': ['tsvgx', 11:43:48 INFO - 'tsvgr_opacity', 11:43:48 INFO - 'tart', 11:43:48 INFO - 'tscrollx', 11:43:48 INFO - 'cart']}, 11:43:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:43:48 INFO - 'tsvgr_opacity', 11:43:48 INFO - 'tart', 11:43:48 INFO - 'tscrollx', 11:43:48 INFO - 'cart']}, 11:43:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:43:48 INFO - 'talos_options': ['--disable-e10s'], 11:43:48 INFO - 'tests': ['tp5o']}, 11:43:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:43:48 INFO - 'tests': ['tp5o']}, 11:43:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:43:48 INFO - 'talos_options': ['--disable-e10s', 11:43:48 INFO - '--xperf_path', 11:43:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:43:48 INFO - 'tests': ['tp5n']}, 11:43:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:43:48 INFO - 'talos_options': ['--xperf_path', 11:43:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:43:48 INFO - 'tests': ['tp5n']}}, 11:43:48 INFO - 'talos.zip': {'path': '', 11:43:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:43:48 INFO - Running post-action listener: _resource_record_post_action 11:43:48 INFO - [mozharness: 2017-01-18 19:43:48.981395Z] Finished populate-webroot step (success) 11:43:48 INFO - [mozharness: 2017-01-18 19:43:48.981483Z] Running create-virtualenv step. 11:43:48 INFO - Running pre-action listener: _resource_record_pre_action 11:43:48 INFO - Running main action method: create_virtualenv 11:43:48 INFO - Creating virtualenv /builds/slave/test/build/venv 11:43:48 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 11:43:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:43:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:43:49 INFO - Using real prefix '/usr' 11:43:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:43:49 INFO - Installing distribute.............................................................................................................................................................................................done. 11:43:51 INFO - Installing pip.................done. 11:43:51 INFO - Return code: 0 11:43:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:43:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:43:51 INFO - Reading from file tmpfile_stdout 11:43:51 INFO - Output received: 11:43:51 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) 11:43:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:43:51 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')]} 11:43:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:43:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:43:51 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')]} 11:43:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:43:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:43:51 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 0x7f7cfb434f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xce98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdb6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb3f60>, '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 0xdb4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdb51d0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1484768612.785104-703188752', '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 11:43:51 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 11:43:51 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 11:43:51 INFO - Using env: {'DISPLAY': ':0', 11:43:51 INFO - 'HOME': '/home/cltbld', 11:43:51 INFO - 'LANG': 'en_US.UTF-8', 11:43:51 INFO - 'LANGUAGE': 'en_US:en', 11:43:51 INFO - 'LOGNAME': 'cltbld', 11:43:51 INFO - 'MAIL': '/var/mail/cltbld', 11:43:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:43:51 INFO - 'MOZ_NO_REMOTE': '1', 11:43:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:43:51 INFO - 'NO_EM_RESTART': '1', 11:43:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:43:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:43:51 INFO - 'PWD': '/builds/slave/test', 11:43:51 INFO - 'SHELL': '/bin/bash', 11:43:51 INFO - 'SHLVL': '1', 11:43:51 INFO - 'TERM': 'linux', 11:43:51 INFO - 'TMOUT': '86400', 11:43:51 INFO - 'USER': 'cltbld', 11:43:51 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1484768612.785104-703188752', 11:43:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:43:51 INFO - '_': '/tools/buildbot/bin/python'} 11:43:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:43:51 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 11:43:51 INFO - Cleaning up... 11:43:51 INFO - Return code: 0 11:43:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:43:51 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')]} 11:43:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:43:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:43:51 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')]} 11:43:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:43:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:43:52 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 0x7f7cfb434f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xce98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdb6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb3f60>, '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 0xdb4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdb51d0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1484768612.785104-703188752', '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 11:43:52 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 11:43:52 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 11:43:52 INFO - Using env: {'DISPLAY': ':0', 11:43:52 INFO - 'HOME': '/home/cltbld', 11:43:52 INFO - 'LANG': 'en_US.UTF-8', 11:43:52 INFO - 'LANGUAGE': 'en_US:en', 11:43:52 INFO - 'LOGNAME': 'cltbld', 11:43:52 INFO - 'MAIL': '/var/mail/cltbld', 11:43:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:43:52 INFO - 'MOZ_NO_REMOTE': '1', 11:43:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:43:52 INFO - 'NO_EM_RESTART': '1', 11:43:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:43:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:43:52 INFO - 'PWD': '/builds/slave/test', 11:43:52 INFO - 'SHELL': '/bin/bash', 11:43:52 INFO - 'SHLVL': '1', 11:43:52 INFO - 'TERM': 'linux', 11:43:52 INFO - 'TMOUT': '86400', 11:43:52 INFO - 'USER': 'cltbld', 11:43:52 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1484768612.785104-703188752', 11:43:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:43:52 INFO - '_': '/tools/buildbot/bin/python'} 11:43:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:43:52 INFO - Downloading/unpacking psutil>=3.1.1 11:43:52 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 11:43:52 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 11:43:52 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 11:43:52 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 11:43:52 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 11:43:52 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 11:43:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:43:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:43:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:43:54 INFO - Installing collected packages: psutil 11:43:54 INFO - Running setup.py install for psutil 11:43:54 INFO - building 'psutil._psutil_linux' extension 11:43:54 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 11:43:54 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 11:43:54 INFO - building 'psutil._psutil_posix' extension 11:43:54 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 11:43:54 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 11:43:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:43:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:43:54 INFO - Successfully installed psutil 11:43:54 INFO - Cleaning up... 11:43:54 INFO - Return code: 0 11:43:54 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:43:54 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')]} 11:43:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:43:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:43:54 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')]} 11:43:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:43:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:43:54 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 0x7f7cfb434f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xce98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdb6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb3f60>, '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 0xdb4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdb51d0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1484768612.785104-703188752', '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 11:43:54 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 11:43:54 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 11:43:54 INFO - Using env: {'DISPLAY': ':0', 11:43:54 INFO - 'HOME': '/home/cltbld', 11:43:54 INFO - 'LANG': 'en_US.UTF-8', 11:43:54 INFO - 'LANGUAGE': 'en_US:en', 11:43:54 INFO - 'LOGNAME': 'cltbld', 11:43:54 INFO - 'MAIL': '/var/mail/cltbld', 11:43:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:43:54 INFO - 'MOZ_NO_REMOTE': '1', 11:43:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:43:54 INFO - 'NO_EM_RESTART': '1', 11:43:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:43:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:43:54 INFO - 'PWD': '/builds/slave/test', 11:43:54 INFO - 'SHELL': '/bin/bash', 11:43:54 INFO - 'SHLVL': '1', 11:43:54 INFO - 'TERM': 'linux', 11:43:54 INFO - 'TMOUT': '86400', 11:43:54 INFO - 'USER': 'cltbld', 11:43:54 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1484768612.785104-703188752', 11:43:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:43:54 INFO - '_': '/tools/buildbot/bin/python'} 11:43:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:43:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:43:55 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 11:43:55 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 11:43:55 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 11:43:55 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 11:43:55 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 11:43:55 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 11:43:57 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:43:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:43:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:43:57 INFO - Installing collected packages: mozsystemmonitor 11:43:57 INFO - Running setup.py install for mozsystemmonitor 11:43:57 INFO - Successfully installed mozsystemmonitor 11:43:57 INFO - Cleaning up... 11:43:57 INFO - Return code: 0 11:43:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:43:57 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')]} 11:43:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:43:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:43:57 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')]} 11:43:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:43:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:43:57 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 0x7f7cfb434f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xce98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdb6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb3f60>, '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 0xdb4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdb51d0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1484768612.785104-703188752', '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 11:43:57 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 11:43:57 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 11:43:57 INFO - Using env: {'DISPLAY': ':0', 11:43:57 INFO - 'HOME': '/home/cltbld', 11:43:57 INFO - 'LANG': 'en_US.UTF-8', 11:43:57 INFO - 'LANGUAGE': 'en_US:en', 11:43:57 INFO - 'LOGNAME': 'cltbld', 11:43:57 INFO - 'MAIL': '/var/mail/cltbld', 11:43:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:43:57 INFO - 'MOZ_NO_REMOTE': '1', 11:43:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:43:57 INFO - 'NO_EM_RESTART': '1', 11:43:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:43:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:43:57 INFO - 'PWD': '/builds/slave/test', 11:43:57 INFO - 'SHELL': '/bin/bash', 11:43:57 INFO - 'SHLVL': '1', 11:43:57 INFO - 'TERM': 'linux', 11:43:57 INFO - 'TMOUT': '86400', 11:43:57 INFO - 'USER': 'cltbld', 11:43:57 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1484768612.785104-703188752', 11:43:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:43:57 INFO - '_': '/tools/buildbot/bin/python'} 11:43:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:43:57 INFO - Downloading/unpacking jsonschema==2.5.1 11:43:57 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 11:43:57 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 11:43:57 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 11:43:57 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 11:43:57 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 11:43:57 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 11:43:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:43:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:43:59 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 11:43:59 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 11:43:59 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 11:43:59 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 11:43:59 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 11:43:59 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 11:43:59 INFO - Downloading functools32-3.2.3-2.tar.gz 11:43:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:43:59 INFO - warning: no files found matching '*.txt' 11:43:59 INFO - no previously-included directories found matching 'build' 11:43:59 INFO - no previously-included directories found matching 'dist' 11:43:59 INFO - no previously-included directories found matching '.git*' 11:43:59 INFO - Installing collected packages: jsonschema, functools32 11:43:59 INFO - Running setup.py install for functools32 11:43:59 INFO - warning: no files found matching '*.txt' 11:43:59 INFO - no previously-included directories found matching 'build' 11:43:59 INFO - no previously-included directories found matching 'dist' 11:43:59 INFO - no previously-included directories found matching '.git*' 11:43:59 INFO - Successfully installed jsonschema functools32 11:43:59 INFO - Cleaning up... 11:44:00 INFO - Return code: 0 11:44:00 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:44:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:44:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:44:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:44:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:44:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44:00 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 0x7f7cfb434f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xce98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdb6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb3f60>, '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 0xdb4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdb51d0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1484768612.785104-703188752', '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 11:44:00 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 11:44:00 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 11:44:00 INFO - Using env: {'DISPLAY': ':0', 11:44:00 INFO - 'HOME': '/home/cltbld', 11:44:00 INFO - 'LANG': 'en_US.UTF-8', 11:44:00 INFO - 'LANGUAGE': 'en_US:en', 11:44:00 INFO - 'LOGNAME': 'cltbld', 11:44:00 INFO - 'MAIL': '/var/mail/cltbld', 11:44:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:44:00 INFO - 'MOZ_NO_REMOTE': '1', 11:44:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:44:00 INFO - 'NO_EM_RESTART': '1', 11:44:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:44:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:44:00 INFO - 'PWD': '/builds/slave/test', 11:44:00 INFO - 'SHELL': '/bin/bash', 11:44:00 INFO - 'SHLVL': '1', 11:44:00 INFO - 'TERM': 'linux', 11:44:00 INFO - 'TMOUT': '86400', 11:44:00 INFO - 'USER': 'cltbld', 11:44:00 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1484768612.785104-703188752', 11:44:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:44:00 INFO - '_': '/tools/buildbot/bin/python'} 11:44:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:44:00 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:44:00 INFO - Cleaning up... 11:44:00 INFO - Return code: 0 11:44:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:44:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:44:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:44:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:44:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:44:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44:00 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 0x7f7cfb434f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xce98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdb6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb3f60>, '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 0xdb4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdb51d0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1484768612.785104-703188752', '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 11:44:00 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 11:44:00 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 11:44:00 INFO - Using env: {'DISPLAY': ':0', 11:44:00 INFO - 'HOME': '/home/cltbld', 11:44:00 INFO - 'LANG': 'en_US.UTF-8', 11:44:00 INFO - 'LANGUAGE': 'en_US:en', 11:44:00 INFO - 'LOGNAME': 'cltbld', 11:44:00 INFO - 'MAIL': '/var/mail/cltbld', 11:44:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:44:00 INFO - 'MOZ_NO_REMOTE': '1', 11:44:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:44:00 INFO - 'NO_EM_RESTART': '1', 11:44:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:44:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:44:00 INFO - 'PWD': '/builds/slave/test', 11:44:00 INFO - 'SHELL': '/bin/bash', 11:44:00 INFO - 'SHLVL': '1', 11:44:00 INFO - 'TERM': 'linux', 11:44:00 INFO - 'TMOUT': '86400', 11:44:00 INFO - 'USER': 'cltbld', 11:44:00 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1484768612.785104-703188752', 11:44:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:44:00 INFO - '_': '/tools/buildbot/bin/python'} 11:44:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:44:00 INFO - Downloading/unpacking blobuploader==1.2.4 11:44:00 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 11:44:00 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 11:44:00 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 11:44:00 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 11:44:00 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 11:44:00 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 11:44:02 INFO - Downloading blobuploader-1.2.4.tar.gz 11:44:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:44:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:44:02 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 11:44:02 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 11:44:02 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 11:44:02 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 11:44:02 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 11:44:02 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 11:44:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:44:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:44:02 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 11:44:02 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 11:44:02 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 11:44:02 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 11:44:02 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 11:44:02 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 11:44:03 INFO - Downloading docopt-0.6.1.tar.gz 11:44:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:44:03 INFO - Installing collected packages: blobuploader, requests, docopt 11:44:03 INFO - Running setup.py install for blobuploader 11:44:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:44:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:44:03 INFO - Running setup.py install for requests 11:44:03 INFO - Running setup.py install for docopt 11:44:03 INFO - Successfully installed blobuploader requests docopt 11:44:03 INFO - Cleaning up... 11:44:03 INFO - Return code: 0 11:44:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:44: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')]} 11:44:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:44:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44: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')]} 11:44:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:44:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44:03 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 0x7f7cfb434f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xce98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdb6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb3f60>, '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 0xdb4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdb51d0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1484768612.785104-703188752', '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 11:44:03 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 11:44:03 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 11:44:03 INFO - Using env: {'DISPLAY': ':0', 11:44:03 INFO - 'HOME': '/home/cltbld', 11:44:03 INFO - 'LANG': 'en_US.UTF-8', 11:44:03 INFO - 'LANGUAGE': 'en_US:en', 11:44:03 INFO - 'LOGNAME': 'cltbld', 11:44:03 INFO - 'MAIL': '/var/mail/cltbld', 11:44:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:44:03 INFO - 'MOZ_NO_REMOTE': '1', 11:44:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:44:03 INFO - 'NO_EM_RESTART': '1', 11:44:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:44:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:44:03 INFO - 'PWD': '/builds/slave/test', 11:44:03 INFO - 'SHELL': '/bin/bash', 11:44:03 INFO - 'SHLVL': '1', 11:44:03 INFO - 'TERM': 'linux', 11:44:03 INFO - 'TMOUT': '86400', 11:44:03 INFO - 'USER': 'cltbld', 11:44:03 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1484768612.785104-703188752', 11:44:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:44:03 INFO - '_': '/tools/buildbot/bin/python'} 11:44:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:44:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:44:04 INFO - Running setup.py (path:/tmp/pip-rODM4O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:44:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:44:04 INFO - Running setup.py (path:/tmp/pip-VmOpB6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:44:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:44:04 INFO - Running setup.py (path:/tmp/pip-8qWbh6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:44:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:44:04 INFO - Running setup.py (path:/tmp/pip-ANxInR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:44:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:44:04 INFO - Running setup.py (path:/tmp/pip-nTZjV5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:44:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:44:04 INFO - Running setup.py (path:/tmp/pip-csaiTN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:44:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:44:04 INFO - Running setup.py (path:/tmp/pip-81ig3S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:44:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:44:04 INFO - Running setup.py (path:/tmp/pip-1l9FRK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:44:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:44:04 INFO - Running setup.py (path:/tmp/pip-GryP6z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:44:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:44:04 INFO - Running setup.py (path:/tmp/pip-bbnV3a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:44:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:44:04 INFO - Running setup.py (path:/tmp/pip-gON8yY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:44:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:44:04 INFO - Running setup.py (path:/tmp/pip-AopPLZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:44:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:44:04 INFO - Running setup.py (path:/tmp/pip-PlXuAl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:44:05 INFO - Running setup.py (path:/tmp/pip-uHFtYc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:44:05 INFO - Running setup.py (path:/tmp/pip-DMt0dZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:44:05 INFO - Running setup.py (path:/tmp/pip-tsv1d8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:44:05 INFO - Running setup.py (path:/tmp/pip-QxFO97-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:44:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:44:05 INFO - Running setup.py install for manifestparser 11:44:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:44:05 INFO - Running setup.py install for mozcrash 11:44:05 INFO - Running setup.py install for mozdebug 11:44:05 INFO - Running setup.py install for mozdevice 11:44:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:44:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:44:05 INFO - Running setup.py install for mozfile 11:44:05 INFO - Running setup.py install for mozhttpd 11:44:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:44:05 INFO - Running setup.py install for mozinfo 11:44:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:44:06 INFO - Running setup.py install for mozInstall 11:44:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:44:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:44:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:44:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:44:06 INFO - Running setup.py install for mozleak 11:44:06 INFO - Running setup.py install for mozlog 11:44:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:44:06 INFO - Running setup.py install for moznetwork 11:44:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:44:06 INFO - Running setup.py install for mozprocess 11:44:06 INFO - Running setup.py install for mozprofile 11:44:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:44:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:44:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:44:06 INFO - Running setup.py install for mozrunner 11:44:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:44:06 INFO - Running setup.py install for mozscreenshot 11:44:06 INFO - Running setup.py install for moztest 11:44:06 INFO - Running setup.py install for mozversion 11:44:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:44:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:44:07 INFO - Cleaning up... 11:44:07 INFO - Return code: 0 11:44:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:44:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:44:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:44:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:44:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:44:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44:07 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 0x7f7cfb434f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xce98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdb6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb3f60>, '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 0xdb4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdb51d0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1484768612.785104-703188752', '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 11:44:07 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 11:44:07 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 11:44:07 INFO - Using env: {'DISPLAY': ':0', 11:44:07 INFO - 'HOME': '/home/cltbld', 11:44:07 INFO - 'LANG': 'en_US.UTF-8', 11:44:07 INFO - 'LANGUAGE': 'en_US:en', 11:44:07 INFO - 'LOGNAME': 'cltbld', 11:44:07 INFO - 'MAIL': '/var/mail/cltbld', 11:44:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:44:07 INFO - 'MOZ_NO_REMOTE': '1', 11:44:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:44:07 INFO - 'NO_EM_RESTART': '1', 11:44:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:44:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:44:07 INFO - 'PWD': '/builds/slave/test', 11:44:07 INFO - 'SHELL': '/bin/bash', 11:44:07 INFO - 'SHLVL': '1', 11:44:07 INFO - 'TERM': 'linux', 11:44:07 INFO - 'TMOUT': '86400', 11:44:07 INFO - 'USER': 'cltbld', 11:44:07 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1484768612.785104-703188752', 11:44:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:44:07 INFO - '_': '/tools/buildbot/bin/python'} 11:44:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:44:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:44:07 INFO - Running setup.py (path:/tmp/pip-LRzqBf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:44:07 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)) 11:44:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:44:07 INFO - Running setup.py (path:/tmp/pip-VpDig7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:44:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:44:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:44:07 INFO - Running setup.py (path:/tmp/pip-qILGYW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:44:07 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)) 11:44:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:44:07 INFO - Running setup.py (path:/tmp/pip-61aMbi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:44:07 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)) 11:44:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:44:07 INFO - Running setup.py (path:/tmp/pip-YnhnKi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:44:07 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)) 11:44:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:44:07 INFO - Running setup.py (path:/tmp/pip-iXQF0b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:44:07 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)) 11:44:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:44:07 INFO - Running setup.py (path:/tmp/pip-bKX_DH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:44:07 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)) 11:44:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:44:07 INFO - Running setup.py (path:/tmp/pip-CtR8K9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:44:07 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)) 11:44:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:44:07 INFO - Running setup.py (path:/tmp/pip-g4ZK_m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:44:08 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)) 11:44:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:44:08 INFO - Running setup.py (path:/tmp/pip-vhOzWi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:44:08 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)) 11:44:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:44:08 INFO - Running setup.py (path:/tmp/pip-FwXMh7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:44:08 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)) 11:44:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:44:08 INFO - Running setup.py (path:/tmp/pip-7FUBAt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:44:08 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)) 11:44:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:44:08 INFO - Running setup.py (path:/tmp/pip-5AbaJp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:44:08 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)) 11:44:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:44:08 INFO - Running setup.py (path:/tmp/pip-PMMp8K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:44:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:44:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:44:08 INFO - Running setup.py (path:/tmp/pip-y3UmWM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:44:08 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)) 11:44:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:44:08 INFO - Running setup.py (path:/tmp/pip-iDCOj0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:44:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:44:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:44:08 INFO - Running setup.py (path:/tmp/pip-86kYDx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:44:08 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)) 11:44:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:44:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:44:08 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)) 11:44:08 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)) 11:44:08 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)) 11:44:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:44:08 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 11:44:08 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 11:44:08 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 11:44:08 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 11:44:08 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 11:44:08 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 11:44:10 INFO - Downloading blessings-1.6.tar.gz 11:44:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:44:10 INFO - Installing collected packages: blessings 11:44:10 INFO - Running setup.py install for blessings 11:44:10 INFO - Successfully installed blessings 11:44:10 INFO - Cleaning up... 11:44:10 INFO - Return code: 0 11:44:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:44:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:44:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:44:11 INFO - Reading from file tmpfile_stdout 11:44:11 INFO - Current package versions: 11:44:11 INFO - argparse == 1.2.1 11:44:11 INFO - blessings == 1.6 11:44:11 INFO - blobuploader == 1.2.4 11:44:11 INFO - docopt == 0.6.1 11:44:11 INFO - functools32 == 3.2.3-2 11:44:11 INFO - jsonschema == 2.5.1 11:44:11 INFO - manifestparser == 1.1 11:44:11 INFO - mozInstall == 1.12 11:44:11 INFO - mozcrash == 1.0 11:44:11 INFO - mozdebug == 0.1 11:44:11 INFO - mozdevice == 0.48 11:44:11 INFO - mozfile == 1.2 11:44:11 INFO - mozhttpd == 0.7 11:44:11 INFO - mozinfo == 0.9 11:44:11 INFO - mozleak == 0.1 11:44:11 INFO - mozlog == 3.4 11:44:11 INFO - moznetwork == 0.27 11:44:11 INFO - mozprocess == 0.23 11:44:11 INFO - mozprofile == 0.28 11:44:11 INFO - mozrunner == 6.13 11:44:11 INFO - mozscreenshot == 0.1 11:44:11 INFO - mozsystemmonitor == 0.3 11:44:11 INFO - moztest == 0.8 11:44:11 INFO - mozversion == 1.4 11:44:11 INFO - psutil == 3.1.1 11:44:11 INFO - requests == 1.2.3 11:44:11 INFO - wsgiref == 0.1.2 11:44:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:44:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:44:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:44:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:44:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:44:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44:11 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 0x7f7cfb434f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xce98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdb6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb3f60>, '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 0xdb4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdb51d0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1484768612.785104-703188752', '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 11:44:11 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 11:44:11 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 11:44:11 INFO - Using env: {'DISPLAY': ':0', 11:44:11 INFO - 'HOME': '/home/cltbld', 11:44:11 INFO - 'LANG': 'en_US.UTF-8', 11:44:11 INFO - 'LANGUAGE': 'en_US:en', 11:44:11 INFO - 'LOGNAME': 'cltbld', 11:44:11 INFO - 'MAIL': '/var/mail/cltbld', 11:44:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:44:11 INFO - 'MOZ_NO_REMOTE': '1', 11:44:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:44:11 INFO - 'NO_EM_RESTART': '1', 11:44:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:44:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:44:11 INFO - 'PWD': '/builds/slave/test', 11:44:11 INFO - 'SHELL': '/bin/bash', 11:44:11 INFO - 'SHLVL': '1', 11:44:11 INFO - 'TERM': 'linux', 11:44:11 INFO - 'TMOUT': '86400', 11:44:11 INFO - 'USER': 'cltbld', 11:44:11 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1484768612.785104-703188752', 11:44:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:44:11 INFO - '_': '/tools/buildbot/bin/python'} 11:44:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:44:11 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)) 11:44:11 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)) 11:44:11 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)) 11:44:11 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)) 11:44:11 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)) 11:44:11 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)) 11:44:11 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)) 11:44:11 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)) 11:44:11 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)) 11:44:11 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)) 11:44:11 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)) 11:44:11 INFO - Cleaning up... 11:44:11 INFO - Return code: 0 11:44:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:44:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:44:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:44:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:44:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:44:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7cfb434f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xce98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdb6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb3f60>, '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 0xdb4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdb51d0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1484768612.785104-703188752', '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 11:44:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:44:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:44:11 INFO - Using env: {'DISPLAY': ':0', 11:44:11 INFO - 'HOME': '/home/cltbld', 11:44:11 INFO - 'LANG': 'en_US.UTF-8', 11:44:11 INFO - 'LANGUAGE': 'en_US:en', 11:44:11 INFO - 'LOGNAME': 'cltbld', 11:44:11 INFO - 'MAIL': '/var/mail/cltbld', 11:44:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:44:11 INFO - 'MOZ_NO_REMOTE': '1', 11:44:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:44:11 INFO - 'NO_EM_RESTART': '1', 11:44:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:44:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:44:11 INFO - 'PWD': '/builds/slave/test', 11:44:11 INFO - 'SHELL': '/bin/bash', 11:44:11 INFO - 'SHLVL': '1', 11:44:11 INFO - 'TERM': 'linux', 11:44:11 INFO - 'TMOUT': '86400', 11:44:11 INFO - 'USER': 'cltbld', 11:44:11 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1484768612.785104-703188752', 11:44:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:44:11 INFO - '_': '/tools/buildbot/bin/python'} 11:44:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:44:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:44:11 INFO - Cleaning up... 11:44:11 INFO - Return code: 0 11:44:11 INFO - Running post-action listener: _resource_record_post_action 11:44:11 INFO - Running post-action listener: _start_resource_monitoring 11:44:11 INFO - Starting resource monitoring. 11:44:11 INFO - [mozharness: 2017-01-18 19:44:11.609055Z] Finished create-virtualenv step (success) 11:44:11 INFO - [mozharness: 2017-01-18 19:44:11.609558Z] Running install step. 11:44:11 INFO - Running pre-action listener: _resource_record_pre_action 11:44:11 INFO - Running main action method: install 11:44:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:44:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:44:11 INFO - Reading from file tmpfile_stdout 11:44:11 INFO - Detecting whether we're running mozinstall >=1.0... 11:44:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:44:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:44:11 INFO - Reading from file tmpfile_stdout 11:44:11 INFO - Output received: 11:44:11 INFO - Usage: mozinstall [options] installer 11:44:11 INFO - Options: 11:44:11 INFO - -h, --help show this help message and exit 11:44:11 INFO - -d DEST, --destination=DEST 11:44:11 INFO - Directory to install application into. [default: 11:44:11 INFO - "/builds/slave/test"] 11:44:11 INFO - --app=APP Application being installed. [default: firefox] 11:44:11 INFO - mkdir: /builds/slave/test/build/application 11:44:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:44:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:44:28 INFO - Reading from file tmpfile_stdout 11:44:28 INFO - Output received: 11:44:28 INFO - /builds/slave/test/build/application/firefox/firefox 11:44:28 INFO - Running post-action listener: _resource_record_post_action 11:44:28 INFO - [mozharness: 2017-01-18 19:44:28.695640Z] Finished install step (success) 11:44:28 INFO - [mozharness: 2017-01-18 19:44:28.695883Z] Running run-tests step. 11:44:28 INFO - Running pre-action listener: _resource_record_pre_action 11:44:28 INFO - Running main action method: run_tests 11:44:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:44:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:44:28 INFO - Python 2.7.3 11:44:28 INFO - Return code: 0 11:44:28 INFO - grabbing minidump binary from tooltool 11:44: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')]} 11:44:28 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 0xdb3f60>, '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 0xdb4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdb51d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:44:28 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 11:44:28 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 11:44:28 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 11:44:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:44:28 INFO - Return code: 0 11:44:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:44:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:44:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:44:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:44:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:44:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HcCzxjHnQJmxOHktZ5vpAg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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 11:44:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HcCzxjHnQJmxOHktZ5vpAg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-013 --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 11:44:28 INFO - Using env: {'DISPLAY': ':0', 11:44:28 INFO - 'HOME': '/home/cltbld', 11:44:28 INFO - 'LANG': 'en_US.UTF-8', 11:44:28 INFO - 'LANGUAGE': 'en_US:en', 11:44:28 INFO - 'LOGNAME': 'cltbld', 11:44:28 INFO - 'MAIL': '/var/mail/cltbld', 11:44:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:44:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:44:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:44:28 INFO - 'MOZ_NO_REMOTE': '1', 11:44:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:44:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:44:28 INFO - 'NO_EM_RESTART': '1', 11:44:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:44:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:44:28 INFO - 'PWD': '/builds/slave/test', 11:44:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:44:28 INFO - 'SHELL': '/bin/bash', 11:44:28 INFO - 'SHLVL': '1', 11:44:28 INFO - 'TERM': 'linux', 11:44:28 INFO - 'TMOUT': '86400', 11:44:28 INFO - 'USER': 'cltbld', 11:44:28 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1484768612.785104-703188752', 11:44:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:44:28 INFO - '_': '/tools/buildbot/bin/python'} 11:44:28 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HcCzxjHnQJmxOHktZ5vpAg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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 11:44:28 INFO - mozversion application_buildid: 20170118100227 11:44:28 INFO - mozversion application_changeset: 4ad7551c5c9970c234eb6208d4461d2281664a2b 11:44:28 INFO - mozversion application_display_name: FirefoxDeveloperEdition 11:44:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:44:28 INFO - mozversion application_name: Firefox 11:44:28 INFO - mozversion application_remotingname: firefox-dev 11:44:28 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:44:28 INFO - mozversion application_vendor: Mozilla 11:44:28 INFO - mozversion application_version: 52.0a2 11:44:28 INFO - mozversion platform_buildid: 20170118100227 11:44:28 INFO - mozversion platform_changeset: 4ad7551c5c9970c234eb6208d4461d2281664a2b 11:44:28 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:44:28 INFO - mozversion platform_version: 52.0a2 11:44:28 INFO - using testdate: 1484768668 11:44:28 INFO - actual date: 1484768668 11:44:28 INFO - starting webserver on 'localhost:40037' 11:44:28 INFO - SUITE-START | Running 2 tests 11:44:28 INFO - TEST-START | dromaeo_css 11:44:28 INFO - operating with platform_type : linux_ 11:44:28 INFO - Initialising browser for dromaeo_css test... 11:44:28 INFO - TEST-INFO | started process 868 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5ITFyr/profile http://localhost:40037/getInfo.html) 11:44:33 INFO - PROCESS | 868 | __metrics Screen width/height:1600/1200 11:44:33 INFO - PROCESS | 868 | colorDepth:24 11:44:33 INFO - PROCESS | 868 | Browser inner width/height: 1024/697 11:44:33 INFO - PROCESS | 868 | __metrics 11:44:33 INFO - PROCESS | 868 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:44:33 INFO - PROCESS | 868 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:44:34 INFO - PROCESS | 868 | console.error: PushService: 11:44:34 INFO - PROCESS | 868 | stateChangeProcessEnqueue: Error transitioning state 11:44:34 INFO - PROCESS | 868 | UnknownError 11:44:34 INFO - TEST-INFO | 868: exit 0 11:44:34 INFO - Browser initialized. 11:44:34 INFO - Running cycle 1/1 for dromaeo_css test... 11:44:34 INFO - TEST-INFO | started process 961 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5ITFyr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:44:46 INFO - PROCESS | 961 | RSS: Main: 147230720 11:44:46 INFO - PROCESS | 961 | 11:47:48 INFO - PROCESS | 961 | Cycle 1(1): loaded http://localhost:40037/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40037/tests/dromaeo/cssquery-ext.html) 11:47:49 INFO - PROCESS | 961 | RSS: Main: 242352128 11:47:49 INFO - PROCESS | 961 | 11:50:51 INFO - PROCESS | 961 | Cycle 1(1): loaded http://localhost:40037/tests/dromaeo/cssquery-ext.html (next: http://localhost:40037/tests/dromaeo/cssquery-jquery.html) 11:50:52 INFO - PROCESS | 961 | RSS: Main: 239382528 11:50:52 INFO - PROCESS | 961 | 11:53:54 INFO - PROCESS | 961 | Cycle 1(1): loaded http://localhost:40037/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40037/tests/dromaeo/cssquery-mootools.html) 11:53:55 INFO - PROCESS | 961 | RSS: Main: 175738880 11:53:55 INFO - PROCESS | 961 | 11:56:56 INFO - PROCESS | 961 | Cycle 1(1): loaded http://localhost:40037/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40037/tests/dromaeo/cssquery-prototype.html) 11:56:57 INFO - PROCESS | 961 | RSS: Main: 215506944 11:56:57 INFO - PROCESS | 961 | 12:00:00 INFO - PROCESS | 961 | Cycle 1(1): loaded http://localhost:40037/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40037/tests/dromaeo/cssquery-yui.html) 12:00:00 INFO - PROCESS | 961 | RSS: Main: 175378432 12:00:00 INFO - PROCESS | 961 | 12:03:03 INFO - PROCESS | 961 | Cycle 1(1): loaded http://localhost:40037/tests/dromaeo/cssquery-yui.html (next: http://localhost:40037/tests/dromaeo/cssquery-dojo.html) 12:03:03 INFO - PROCESS | 961 | RSS: Main: 265007104 12:03:03 INFO - PROCESS | 961 | 12:03:03 INFO - PROCESS | 961 | __start_tp_report 12:03:03 INFO - PROCESS | 961 | _x_x_mozilla_page_load 12:03:03 INFO - PROCESS | 961 | _x_x_mozilla_page_load_details 12:03:03 INFO - PROCESS | 961 | |i|pagename|runs| 12:03:03 INFO - PROCESS | 961 | |0;dojo.html;3221.710046095851;3267.01989403179;3270.1334146451195;3293.226091868409;3311.5694959655243;5538.280023596937;5542.445755424461;5618.15727640854;5636.577256705748;5647.491725744682;5527.50252477277;5639.915401268974;5644.068728659777;5648.943510564893;5694.145878118285;5092.3889133303965;5104.948950510503;5106.668066575679;5165.096108181072;5197.986392653434;4985.800567977295;5212.50481204285;5218.217267409881;5218.373795144588;5230.450802665722;4980.05378977993;5089.770960306795;5109.463506331837;5158.019976204528;5163.561097306733;5119.56483698886;5186.481351864821;5220.190870415092;5222.399424066205;5237.528622423962;5061.848144555669;5142.074426603247;5188.558972487305;5199.896002079937;5231.738413079331;5429.782808687648;5449.83650490482;5507.146392309199;5531;5561.110222364443;5929.584929054925;5945.4946329562035;5954.791582294599;6033.185519954794;6035.668038257894;6058.848528786772;6068.089786532011;6076.270847498285;6083.695815209266;6086.634801911855;5500.3949565547755;5538.501534861842;5576.972115139439;5581.274434323512;5606;6113.816585502442;6160.661163635953;6165.907511387333;6166.969165154145;6172.629642221481;5893.852653683693;5894.056950887837;5906.616069955439;5916.349201587822;5928.466438020599;5826.213461182686;5832.387599302097;5852.4440178183;5872.500837428866;5899.793507227227;5923.348431672513;5926.199963005025;5938.049912014057;5961.105834124829;5981.431763982502;5860.443257890493;5905.379935106838;5908.20239267702;5922.911156332659;5933.732982015819;4529.116822219636;4566.611837993742;4575;4605.65457590682;4616.28447590624;4105.261053010427;4122.896927576775;4129.566395528486;4159.209750147463;4172.01957539984;5714.257146570919;5721.370649228582;5727.2268243787385;5734.39788822176;5736.340320863071;5808.506276966421;5877.412258774174;5894.440028197314;5981.192539007266;6005.489533389624;5643.774249030075;5692.288463942007;5705.343885453226;5723.313202415737;5737.08206686928;5131.692098474104;5136.743162841918;5140.254663073833;5143.819966301162;5158.4067832199025;6020;6225.470834978896;6229.501639868799;6257.74969001244;6265.342139075423;5822.126680997715;5850.0932355484965;5852.151438041375;5965.522758179422;5984.850378740566;6205.162303089025;6234.3453937337745;6235.189425374672;6242.219722534684;6245.18812554365;5679.403662615366;5849.268841394825;5849.502792262705;5855.502282306052;5870.0607902737065;5791.710414479344;5921.259842519685;5972.283326000907;5983.371745966785;6049.243844519435;5843.415658434123;5886;5890.970545147418;5894.174815525916;5894.174815525916;5855.648661080349;5869.765209391577;5874.735636896436;5877.764889404547;5883.911741323798;5656.349519805275;5656.6888821115235;5781.739821707949;5834.708264586839;5845.795397161079;5946.970265148647;5955.523558115254;5955.940440595712;5969;5982.192404025401;5458.563314934716;5502.0371434999515;5650.265465489624;5654.123610840326;5659.434056594472 12:03:03 INFO - PROCESS | 961 | |1;ext.html;600.3396264109477;616.1866336435903;652.0968458684722;666.1240468783552;666.7499687617144;34155.82922085389;45144.32283515746;45923.31115033269;46034.309485357706;46097;46950.7652461738;47230.527694723045;47304;47314.290285645744;47365.52634473663;8391.496510209407;8929.598168082435;9090.363674542785;9100.499472529009;9103.681371152012;8469.407141500067;8688.131186881325;8695.913040869606;10597.258191926569;10884.836727449094;11062.834057489144;11123.110151187886;11132.10943124548;11137.164712646583;11137.276077054965;10557;10604.522796474177;10613.310134841211;10614.57541698331;10615.787684246348;10827.512761925653;10889.183311251609;10902.291351062155;10906.563737450493;10910.50902709372;44359;44412.3338149928;44643.33035004477;44743.32885006727;44744.55255447469;3888.786116763577;3910.432987216866;4081.3469844824685;4120.505539335269;4399.802008909607;32668;32722;32741.836290818632;32789.6721032789;33043;4483.708558943658;4530.75080870552;4550.88622784433;4558.270676691746;4659.207934651084;359491;364419;364485;364636;364990;61469.692651536454;61753.691231543555;61767.691161544804;61866;61890;40206.59793402028;40821.18357632831;40878.59121408748;43299.78350108292;43321.78339108284;18010.459686209433;18235.544111397056;18266.725999110025;18281.45155645333;18296.085195740427;12430.627081187578;13809.378577964017;14033.438662453591;14082.155070695791;14087.788683169761;18113.547161321072;19842.50393740168;20462.693059604117;20486.79513204879;21419.357419277447;7227;7336.339729424378;7530.171681115073;7540.660670269741;7626.885596716053;955.9283053770856;995.3430735714394;1043;1055.1400608504046;1080.5191689698165;33485.49771753426;33822.49266261008;33834.15414614605;33927.32145357079;34047.659523404946;1114.2367478277406;1134.5631931706187;1155.283724091069;1173.6068417080203;1224.240970598217;17508.299668013136;17659.20533575992;17764;17859.196336164903;17866.642667146585;528680;539174;540087;542043;543237;61204;61685.38314616886;61728;61758;62031.37968620256;1325.7282257137263;1366.7266546690503;1410.9294535273195;1437.8921580881477;1458.555140682102;31879.203019924687;33575.32849343048;34323.828380857936;34387.65612343844;34524.30951380908;51704.74147629238;52289;52291.73854130705;52344.21483677824;52355.21467177919;372265;373895;374110;374365;375693;30139.69860301369;30234;30786.53820192654;32580.674193258714;32934.670653293164;49545.752271238416;49677;49695.751521242164;49832.750836245585;50787.49212507828;42144.578554215295;42215.366769499095;42921.35617965795;44024;44400;41713;42036.789816050725;42888.35667465053;43754;43888.780556097016;41451.7927410361;42343;42395.7880210597;42557.57442425536;43029.56970430256;36445.635543644225;38014;38822.223555528166;41785.582144178166;42243.7887810559;29031.56452653254;29164.27089322784;29231.123066308046;29658.406831863675;29673 12:03:03 INFO - PROCESS | 961 | |2;jquery.html;400.5093760143822;400.5313782874037;424.42702351825034;428.1522585281143;435.6819521749123;16473;19580.216791328367;20016.399508014747;20074.49813754657;20312.390628281137;19575.804241957576;19746.90126549369;20035.499112522193;20042.098105585246;20252.189912403486;5253.973730131344;5607.4112218217115;5779.306483222009;5893.793717219898;5950.851228719273;5830.5044071254;5918.852028699274;5922.674252916088;5924.170616113747;5924.7333869975955;5694.402087780785;5852.12218167274;5877.324107727623;5880.147378630096;5880.617759845618;5716.599838011341;5772.797952071699;5857.297124345085;5904.527637788988;5908.881822363572;5168.5606723428555;5199.376074871002;5201.349831271091;5201.869953251161;5202.557782588485;23220.53558928812;23225.419364515852;23677.408064798346;23688.881555592285;23856;2439.7438268981678;2471.4439251168524;2567.7560631739957;2575.137328994789;2604.869756512167;14190.645233869132;14813.407463701438;15311.375698185211;15331.080135191813;15479.303431345617;1969.3205843983803;1984.1666500070005;1987.1455274232073;2037.3174986379581;2045.3557129504159;51850;61295.387046129414;63342.68328658327;65518.344816551704;86069.99999999937;11140.108791296676;11141;11183.105351571854;11251.606193783178;11562.07503399726;16060.357585696675;16060.75908861368;16064.67870642604;16066.839331606769;16070.196490175444;8332.791680207922;8356.415050946496;8413.284870785928;8427.241548260687;8711.34664900135;7775.727849525239;7799.49303295284;7878.487898286593;8029.397795165269;8054.879176812353;6918.515703900779;7017.859642807115;7071;7084.43324534036;7105.396041336441;1915.6168766246806;1918.3285849952683;1984.6427643024106;2016.1532156494306;2047.30391666834;804.0953926832314;868.9000764912116;994.6071301835879;1039.3088596083671;1063.4842101580728;19183.904080479508;19922.90038549827;20049.298274560322;20103.29638462647;20403.183872645226;1030.850526673628;1033.5504055735778;1035.3735989726258;1036.2280101324561;1043.7129789308;10853.945730271456;11733.88266117345;11747.060235181165;11778.646640600795;11800.763984720257;467206;474538;481985;484918;496886;82546.58726706328;82999;83120.58439707763;84287.57856210679;84794.57602711947;1043.6034306963306;1049.197364016528;1070.8340207267886;1075.3762817565948;1092.4919912240687;17356;17781.70684806999;18137.183826728095;18229.817701822813;18516.537086572942;39667.60332396639;39935.400968984904;40664.39003414892;41499.37750933799;42147.57852421437;53185.30319625672;54414;54486.45513544814;54504.45495544994;54603;6040.546958978182;6078;7344.045274114331;7380.335769780745;8387;12394.070444716863;12842.550510732079;13321.200727956353;13693;14232.146071235758;11987.520499179935;12183.208091474025;12334.396528451243;12512.436940337524;12789.360531973178;12234.150897466101;12300.261984280973;12309.93845030769;12326.876731232573;12377;12587.24476531411;12658.87341126577;12664.74670506603;12680.112392132462;12711.42798574085;8710.520921349387;8818.51498167607;8937;8948.910510894808;9015.549222538977;11643.708907277385;11811.232269902428;11869.347185904859;11936.76126477483;12239.265644061385 12:03:03 INFO - PROCESS | 961 | |3;mootools.html;1470.4265336518758;1510.7205167044099;1664.6504234110837;1828.615990641966;1828.9176987035582;7800.960995195023;8212.466189697672;8245.381596380266;8259.174082591739;8270.710525131622;7661.310482056614;7941.205879412056;8231.958840205805;8496.1503849615;8496.702615408461;2389.4982053768686;2411.46947671512;2412.577798885197;2413.0830284491867;2423.903043878243;2360.6931098957198;2413.119211487803;2416.3113512648897;2430.0158435833428;2430.8906099225487;2341.929742107731;2346.601077816775;2362.787349138577;2366.4675448024227;2366.5266946610745;2233.4751333436793;2235.4970131720315;2257.932262032142;2258.5934531784355;2261.5137745384823;2162.859414138076;2181.5636872625378;2183.8471307008517;2184.0171922634877;2184.3665337052234;8711.21599056088;8723.781905452352;8796.428232164888;8809.339299552496;8815.030346661926;5135;5260.263563101169;5275;5278.2082687596785;5280.2079688046715;3084.6606873243927;3181.1410919051727;3400.7279417646528;3409.437442821931;3412.7611067225303;989.9505024748734;997.4065431068575;1018.8369860822307;1082.9025387715144;1109.8945600167972;12134.575289864812;12192.39038048094;12215.877841221563;12234.694132646666;12246.387680616022;4453.844115455943;4582.335561343587;4690.507496712864;4822.373091498153;4849.175640141114;10199.796004080024;10201.489925503844;10204.489775511194;10209.183265338756;10218.642347517802;5310.495502927216;5312.787488500494;5321.228421878884;5322.414534401213;5325.600579956519;4175.853845115406;4266.658667306608;4818.060478206716;4828.179209534387;4918.631102667314;3981.1042515434374;4031.5162180538523;4039.171969746195;4135.669146468275;4137.13120244752;1268.9682757931125;1279.2836011833217;1283.5764197814885;1301.219268438948;1325.3704490367;842.7050532313641;895.1272509303377;915.208344781759;944.1313991128178;978.3396207559869;5906.7637294508595;5941.821745347646;5942.435468630473;5972.283326000821;6237.688115594202;946.5409276500892;957.305953183936;986.2159583131428;992.1709954020132;1015.4668798880499;3739.775613463201;3924.47019652349;3926.842926282917;3933.803309834554;3958.7030972677167;10312.226583006304;10696.090832279187;10742.194335424874;10750.139988800876;10750.247482676294;10525.21060920434;10527.789444211074;10589.258751887448;10614.097801686943;10635.20235982289;7741.18717534662;8058.879116813252;8061.113277539466;8167.224113709188;8331.166883311742;5815.098659707752;5869.4717475427415;5958.731857066356;6029.246344206974;6070.362611925684;9373.531323433937;9422.811543768948;9452.338336316392;9453.952730236304;9559.856602150834;9357.39176953496;9446.95276523613;9512.95243523778;9579.467285234328;9593.472359020321;7114.822129446598;7202.49582529218;7245.130584329914;7302.707891684486;7317.597532135784;7896.565688887166;7977.641006154853;7984.161663025531;7989.680412783424;7990.081140668897;7312.085989251344;7436.293552112541;7460.253974602496;7524.398048156244;7557.395408367427;7544.735934242275;7558.508696934681;7636.8472630548185;7675.347595454449;7718.575478348745;6979.162500499972;7072.115985501812;7077.433805295461;7081.362677359062;7083.220845707071;5027.874303142451;5078.847634570969;5119.974400127976;5132.46109158533;5297.496737809902;5211.296474975829;5297.867553311198;5328.307320048369;5350.759215835219;5488.753006114654 12:03:03 INFO - PROCESS | 961 | |4;prototype.html;332.1066331568082;347.75755486047825;347.9460683594043;355.15650330465144;362.60294977000194;5303.549198318147;5441.347038355393;5450.972745136274;5464.699441530719;5482.985647655181;5175.870603234921;5282.418933917266;5285.365756109272;5294.708791016493;5319.308489896318;4271.807768650418;4274.081072569397;4274.700770946035;4299.398084268205;4312.784360781964;4225.894352641178;4275.123599662062;4276.358546218061;4298.398224248592;4319.416878721364;4218.303979843322;4220.177065472234;4248.129133527619;4249.915001699964;4252.957470425303;4220.388043733657;4226.725262857904;4234.280172370673;4234.5765423457715;4241.809118589671;3588.6052534221217;3682.226732386175;3714.331420344337;3714.7028237740915;3785.4700341951875;5209.635325527214;5214.634975551713;5240.633155679104;5245.160774276135;5262.92105618416;4784.545468180518;4797.52024797521;4805.135075686375;4806.231003039532;4844.37023186987;5424.8607792363655;5546.306711661043;5573.303337082864;5590.245316882209;5671.922334756383;4085.6527195188146;4086.5913408659194;4095.9590404096175;4099.364598487239;4100.159467309194;5826.504747096502;5845.824625261249;5878.676672782995;5896.410358964112;5914.852128696774;4079.86715324113;4119.464469618931;4152.148809494047;4160.875173744793;4179.937300940488;4211.957880421157;4243.872683819491;4247.745135291892;4248.723832950848;4253.255680255943;4782.7847746850775;4814.026249237796;4815.085133824562;4818.397700287464;4819.445763737145;5399.244105825188;5640.971795140998;5713.285839270091;5735.512481439041;5743.8564035899435;1350.8716671916152;1366.8564800695983;1390.2214759734582;1421.5593166118535;1436.2029073863896;926.7303793802533;956.2111258211864;957.411192116857;958.2238386906628;967.9274054445945;5215.348081489814;5218.504242096995;5228.6862788232065;5233.790648374099;5248.186531087687;5508.807191748269;5530.86172845674;5560.694161821139;5578.41426650204;5586.217929489874;5196.870078248074;5246.816361427332;5270.604704647167;5293.338332708411;5506.614536982453;2953.896613618513;2976.8362740049506;2977.4045190961892;2988.237999310162;2990.2374894401787;5807.303123625107;5816.738246778905;5858.2677165354335;5901.468867801918;5912.467877890925;5401.378841433207;5688.411772643437;5728.450839376521;5789.478946894716;5790.276215473066;5893.263342082239;5894.616849904743;5913.21554205309;5928.762849486145;5936.5250779937505;5382.946170538401;5592.524635406036;5659.943400565941;5695.7436915338085;5714.428557144252;5504.669719816824;5519.448055194448;5521.5306698931045;5532.585056120726;5545.861353466195;5796.420592836316;5826.504747096545;5838.2702162229725;5843.590948633555;5889.64662120257;3891.3773796193605;3980.402939559089;4103.4870641169855;4121.340585506305;4129.525104613008;5563.221149039056;5606.887862242651;5644.322681278273;5653;5662.575306852085;5460.099083651153;5552.168394118948;5607.243022191952;5675.943240567542;5722.313322401338;5629.408912064175;5639.731060511353;5649.180868773922;5659.349174844946;5661.207430959586;5460.6996615186545;5569.526590239875;5587.329520457572;5625.706087599793;5633.464820842013;5630.943690563206;5634.605577609528;5636.267285252891;5643.492085712305;5684.175794509855;5228.686278823283;5350.170723537858;5363.115086010765;5396.865078373072;5397.244385785914 12:03:03 INFO - PROCESS | 961 | |5;yui.html;770.4799260499161;791.8574656561816;801.0427539090789;814.4909431605247;821.4455242711172;13933.094348867317;14536;14547.563573092797;14618.195999220039;14664.70670586589;13709.93145034276;13880.791788123186;13906.443742250298;13914.095583787072;13914.373853176607;706.752636577199;741.4142827166532;834.6577903059747;853.2406158518924;881.8412685716569;865.0441262405014;866.0733015673233;868.0711638546758;868.3053557154283;868.4962721621476;922.9769255768626;923.1184219070772;924.4314746430964;928.4614923344478;928.7817362919709;761.5735188294573;781.2578050851686;866.8266346730647;883.5317281840635;895.4985208283382;656.5404217048085;659.077291791491;660.6993817812884;660.8810414125455;661.6724721263006;15065.849341506555;15228.390864365412;15233.162176080423;15255.847441525553;15288.923555382264;13035.217886926815;13705.794413083811;13859.861401385959;14797.112173269637;15019.324130414157;12130.87869121315;12212.633620991384;12247.938760306231;12284.201526900812;12570.434330455151;4507.57178068083;4536.954630453686;4585.885352866205;4736.715797052153;4742.075295317414;62740.37259627391;63271.36728632701;63712.362876370644;63810.680946595436;65119;10448.634297799692;10761.83857242142;11032.613858514913;11333.979941805277;11578.942105289589;17682;17703.20335584902;17735.201915913814;17742;17744.556386090193;8259.545724985064;8442.915570844336;8522.190391912758;8656.437331573428;8919.910800892038;4894.804207831647;4907.5828554572545;4954.3063971044085;5008.6744361616375;5011.5489605935645;3788.7158463115375;4029.3553031514816;4029.597040295947;4062.289099407592;4062.6140516651462;652.103357882911;664.9401553860176;670.7250027488706;673.4444083630926;679.3478260869621;771.2557382126275;780.4575819805181;784.5684873319651;791.3431851563189;794.2018271636967;9286.674966376144;9468.053194680615;9908.504574771232;10033.347832390871;10214.795704086026;729.2051663686607;739.3826155160393;741.9258074192537;749.4454103963028;769.54981335918;4595.425571803525;4851.878703032452;4901.705897646153;4949.925751113737;4960.50394960501;82524.17475825165;85478;88224;88782;91358;45445;58727;68951.96572051423;70762.64618676873;71988.12047518145;64135.35864641387;64852.35147648463;65603.67198163978;66885;68362.65818670875;9414.901851121276;9435.149577985372;9652.517374131407;9668.274879383933;9675;44367.77816111028;44473;45074.77462612797;45183.32225016693;45908.540914591766;58316.708416457644;60473;61719.382806171365;62312.37687623066;62548;11939.462724177607;12321.93839030799;12757.170783899017;12847;13166.736665266833;14537.636559086108;14617.561473155822;14653.853461465675;14767.778483322974;14980.026298290577;13741.793873092112;14028.509002184874;14096.36566354496;14126.293685315488;14256.572302830931;12761;13008.609741707764;13380.598582042554;13496.122752021087;14045.859541404456;13061.08572399923;13100;13517.729645407233;13536.323183840965;13722.725545489235;11490.94254528722;11566.65300041;12084.577039803564;12300;12478;11326.773464530499;11337.180280733943;11370.943145284551;11376.146788990693;11651.30092194471 12:03:03 INFO - PROCESS | 961 | __end_tp_report 12:03:03 INFO - PROCESS | 961 | __start_cc_report 12:03:03 INFO - PROCESS | 961 | _x_x_mozilla_cycle_collect,964 12:03:03 INFO - PROCESS | 961 | __end_cc_report 12:03:03 INFO - PROCESS | 961 | __startTimestamp1484769783437__endTimestamp 12:03:03 INFO - PROCESS | 961 | 12:03:03 INFO - PROCESS | 961 | ------- Summary: start ------- 12:03:03 INFO - PROCESS | 961 | Number of tests: 6 12:03:03 INFO - PROCESS | 961 | 12:03:03 INFO - PROCESS | 961 | [#0] dojo.html Cycles:165 Average:5560.57 Median:5737.08 stddev:613.69 (10.7%) stddev-sans-first:587.51 12:03:03 INFO - PROCESS | 961 | Values: 3221.7 3267.0 3270.1 3293.2 3311.6 5538.3 5542.4 5618.2 5636.6 5647.5 5527.5 5639.9 5644.1 5648.9 5694.1 5092.4 5104.9 5106.7 5165.1 5198.0 4985.8 5212.5 5218.2 5218.4 5230.5 4980.1 5089.8 5109.5 5158.0 5163.6 5119.6 5186.5 5220.2 5222.4 5237.5 5061.8 5142.1 5188.6 5199.9 5231.7 5429.8 5449.8 5507.1 5531.0 5561.1 5929.6 5945.5 5954.8 6033.2 6035.7 6058.8 6068.1 6076.3 6083.7 6086.6 5500.4 5538.5 5577.0 5581.3 5606.0 6113.8 6160.7 6165.9 6167.0 6172.6 5893.9 5894.1 5906.6 5916.3 5928.5 5826.2 5832.4 5852.4 5872.5 5899.8 5923.3 5926.2 5938.0 5961.1 5981.4 5860.4 5905.4 5908.2 5922.9 5933.7 4529.1 4566.6 4575.0 4605.7 4616.3 4105.3 4122.9 4129.6 4159.2 4172.0 5714.3 5721.4 5727.2 5734.4 5736.3 5808.5 5877.4 5894.4 5981.2 6005.5 5643.8 5692.3 5705.3 5723.3 5737.1 5131.7 5136.7 5140.3 5143.8 5158.4 6020.0 6225.5 6229.5 6257.7 6265.3 5822.1 5850.1 5852.2 5965.5 5984.9 6205.2 6234.3 6235.2 6242.2 6245.2 5679.4 5849.3 5849.5 5855.5 5870.1 5791.7 5921.3 5972.3 5983.4 6049.2 5843.4 5886.0 5891.0 5894.2 5894.2 5855.6 5869.8 5874.7 5877.8 5883.9 5656.3 5656.7 5781.7 5834.7 5845.8 5947.0 5955.5 5955.9 5969.0 5982.2 5458.6 5502.0 5650.3 5654.1 5659.4 12:03:03 INFO - PROCESS | 961 | 12:03:03 INFO - PROCESS | 961 | [#1] ext.html Cycles:180 Average:59686.43 Median:22058.52 stddev:114442.85 (518.8%) stddev-sans-first:114677.91 12:03:03 INFO - PROCESS | 961 | Values: 600.3 616.2 652.1 666.1 666.7 34155.8 45144.3 45923.3 46034.3 46097.0 46950.8 47230.5 47304.0 47314.3 47365.5 8391.5 8929.6 9090.4 9100.5 9103.7 8469.4 8688.1 8695.9 10597.3 10884.8 11062.8 11123.1 11132.1 11137.2 11137.3 10557.0 10604.5 10613.3 10614.6 10615.8 10827.5 10889.2 10902.3 10906.6 10910.5 44359.0 44412.3 44643.3 44743.3 44744.6 3888.8 3910.4 4081.3 4120.5 4399.8 32668.0 32722.0 32741.8 32789.7 33043.0 4483.7 4530.8 4550.9 4558.3 4659.2 359491.0 364419.0 364485.0 364636.0 364990.0 61469.7 61753.7 61767.7 61866.0 61890.0 40206.6 40821.2 40878.6 43299.8 43321.8 18010.5 18235.5 18266.7 18281.5 18296.1 12430.6 13809.4 14033.4 14082.2 14087.8 18113.5 19842.5 20462.7 20486.8 21419.4 7227.0 7336.3 7530.2 7540.7 7626.9 955.9 995.3 1043.0 1055.1 1080.5 33485.5 33822.5 33834.2 33927.3 34047.7 1114.2 1134.6 1155.3 1173.6 1224.2 17508.3 17659.2 17764.0 17859.2 17866.6 528680.0 539174.0 540087.0 542043.0 543237.0 61204.0 61685.4 61728.0 61758.0 62031.4 1325.7 1366.7 1410.9 1437.9 1458.6 31879.2 33575.3 34323.8 34387.7 34524.3 51704.7 52289.0 52291.7 52344.2 52355.2 372265.0 373895.0 374110.0 374365.0 375693.0 30139.7 30234.0 30786.5 32580.7 32934.7 49545.8 49677.0 49695.8 49832.8 50787.5 42144.6 42215.4 42921.4 44024.0 44400.0 41713.0 42036.8 42888.4 43754.0 43888.8 41451.8 42343.0 42395.8 42557.6 43029.6 36445.6 38014.0 38822.2 41785.6 42243.8 29031.6 29164.3 29231.1 29658.4 29673.0 12:03:03 INFO - PROCESS | 961 | 12:03:03 INFO - PROCESS | 961 | [#2] jquery.html Cycles:180 Average:28339.47 Median:23772.44 stddev:78878.16 (331.8%) stddev-sans-first:79071.54 12:03:03 INFO - PROCESS | 961 | Values: 400.5 400.5 424.4 428.2 435.7 16473.0 19580.2 20016.4 20074.5 20312.4 19575.8 19746.9 20035.5 20042.1 20252.2 5254.0 5607.4 5779.3 5893.8 5950.9 5830.5 5918.9 5922.7 5924.2 5924.7 5694.4 5852.1 5877.3 5880.1 5880.6 5716.6 5772.8 5857.3 5904.5 5908.9 5168.6 5199.4 5201.3 5201.9 5202.6 23220.5 23225.4 23677.4 23688.9 23856.0 2439.7 2471.4 2567.8 2575.1 2604.9 14190.6 14813.4 15311.4 15331.1 15479.3 1969.3 1984.2 1987.1 2037.3 2045.4 51850.0 61295.4 63342.7 65518.3 86070.0 11140.1 11141.0 11183.1 11251.6 11562.1 16060.4 16060.8 16064.7 16066.8 16070.2 8332.8 8356.4 8413.3 8427.2 8711.3 7775.7 7799.5 7878.5 8029.4 8054.9 6918.5 7017.9 7071.0 7084.4 7105.4 1915.6 1918.3 1984.6 2016.2 2047.3 804.1 868.9 994.6 1039.3 1063.5 19183.9 19922.9 20049.3 20103.3 20403.2 1030.9 1033.6 1035.4 1036.2 1043.7 10853.9 11733.9 11747.1 11778.6 11800.8 467206.0 474538.0 481985.0 484918.0 496886.0 82546.6 82999.0 83120.6 84287.6 84794.6 1043.6 1049.2 1070.8 1075.4 1092.5 17356.0 17781.7 18137.2 18229.8 18516.5 39667.6 39935.4 40664.4 41499.4 42147.6 53185.3 54414.0 54486.5 54504.5 54603.0 6040.5 6078.0 7344.0 7380.3 8387.0 12394.1 12842.6 13321.2 13693.0 14232.1 11987.5 12183.2 12334.4 12512.4 12789.4 12234.2 12300.3 12309.9 12326.9 12377.0 12587.2 12658.9 12664.7 12680.1 12711.4 8710.5 8818.5 8937.0 8948.9 9015.5 11643.7 11811.2 11869.3 11936.8 12239.3 12:03:03 INFO - PROCESS | 961 | 12:03:03 INFO - PROCESS | 961 | [#3] mootools.html Cycles:180 Average:5669.93 Median:5267.63 stddev:3161.68 (60.0%) stddev-sans-first:3154.80 12:03:03 INFO - PROCESS | 961 | Values: 1470.4 1510.7 1664.7 1828.6 1828.9 7801.0 8212.5 8245.4 8259.2 8270.7 7661.3 7941.2 8232.0 8496.2 8496.7 2389.5 2411.5 2412.6 2413.1 2423.9 2360.7 2413.1 2416.3 2430.0 2430.9 2341.9 2346.6 2362.8 2366.5 2366.5 2233.5 2235.5 2257.9 2258.6 2261.5 2162.9 2181.6 2183.8 2184.0 2184.4 8711.2 8723.8 8796.4 8809.3 8815.0 5135.0 5260.3 5275.0 5278.2 5280.2 3084.7 3181.1 3400.7 3409.4 3412.8 990.0 997.4 1018.8 1082.9 1109.9 12134.6 12192.4 12215.9 12234.7 12246.4 4453.8 4582.3 4690.5 4822.4 4849.2 10199.8 10201.5 10204.5 10209.2 10218.6 5310.5 5312.8 5321.2 5322.4 5325.6 4175.9 4266.7 4818.1 4828.2 4918.6 3981.1 4031.5 4039.2 4135.7 4137.1 1269.0 1279.3 1283.6 1301.2 1325.4 842.7 895.1 915.2 944.1 978.3 5906.8 5941.8 5942.4 5972.3 6237.7 946.5 957.3 986.2 992.2 1015.5 3739.8 3924.5 3926.8 3933.8 3958.7 10312.2 10696.1 10742.2 10750.1 10750.2 10525.2 10527.8 10589.3 10614.1 10635.2 7741.2 8058.9 8061.1 8167.2 8331.2 5815.1 5869.5 5958.7 6029.2 6070.4 9373.5 9422.8 9452.3 9454.0 9559.9 9357.4 9447.0 9513.0 9579.5 9593.5 7114.8 7202.5 7245.1 7302.7 7317.6 7896.6 7977.6 7984.2 7989.7 7990.1 7312.1 7436.3 7460.3 7524.4 7557.4 7544.7 7558.5 7636.8 7675.3 7718.6 6979.2 7072.1 7077.4 7081.4 7083.2 5027.9 5078.8 5120.0 5132.5 5297.5 5211.3 5297.9 5328.3 5350.8 5488.8 12:03:03 INFO - PROCESS | 961 | 12:03:03 INFO - PROCESS | 961 | [#4] prototype.html Cycles:180 Average:4708.65 Median:5334.74 stddev:1366.78 (25.6%) stddev-sans-first:1330.55 12:03:03 INFO - PROCESS | 961 | Values: 332.1 347.8 347.9 355.2 362.6 5303.5 5441.3 5451.0 5464.7 5483.0 5175.9 5282.4 5285.4 5294.7 5319.3 4271.8 4274.1 4274.7 4299.4 4312.8 4225.9 4275.1 4276.4 4298.4 4319.4 4218.3 4220.2 4248.1 4249.9 4253.0 4220.4 4226.7 4234.3 4234.6 4241.8 3588.6 3682.2 3714.3 3714.7 3785.5 5209.6 5214.6 5240.6 5245.2 5262.9 4784.5 4797.5 4805.1 4806.2 4844.4 5424.9 5546.3 5573.3 5590.2 5671.9 4085.7 4086.6 4096.0 4099.4 4100.2 5826.5 5845.8 5878.7 5896.4 5914.9 4079.9 4119.5 4152.1 4160.9 4179.9 4212.0 4243.9 4247.7 4248.7 4253.3 4782.8 4814.0 4815.1 4818.4 4819.4 5399.2 5641.0 5713.3 5735.5 5743.9 1350.9 1366.9 1390.2 1421.6 1436.2 926.7 956.2 957.4 958.2 967.9 5215.3 5218.5 5228.7 5233.8 5248.2 5508.8 5530.9 5560.7 5578.4 5586.2 5196.9 5246.8 5270.6 5293.3 5506.6 2953.9 2976.8 2977.4 2988.2 2990.2 5807.3 5816.7 5858.3 5901.5 5912.5 5401.4 5688.4 5728.5 5789.5 5790.3 5893.3 5894.6 5913.2 5928.8 5936.5 5382.9 5592.5 5659.9 5695.7 5714.4 5504.7 5519.4 5521.5 5532.6 5545.9 5796.4 5826.5 5838.3 5843.6 5889.6 3891.4 3980.4 4103.5 4121.3 4129.5 5563.2 5606.9 5644.3 5653.0 5662.6 5460.1 5552.2 5607.2 5675.9 5722.3 5629.4 5639.7 5649.2 5659.3 5661.2 5460.7 5569.5 5587.3 5625.7 5633.5 5630.9 5634.6 5636.3 5643.5 5684.2 5228.7 5350.2 5363.1 5396.9 5397.2 12:03:03 INFO - PROCESS | 961 | 12:03:03 INFO - PROCESS | 961 | [#5] yui.html Cycles:180 Average:17494.57 Median:4898.26 stddev:22328.37 (455.8%) stddev-sans-first:22355.69 12:03:03 INFO - PROCESS | 961 | Values: 770.5 791.9 801.0 814.5 821.4 13933.1 14536.0 14547.6 14618.2 14664.7 13709.9 13880.8 13906.4 13914.1 13914.4 706.8 741.4 834.7 853.2 881.8 865.0 866.1 868.1 868.3 868.5 923.0 923.1 924.4 928.5 928.8 761.6 781.3 866.8 883.5 895.5 656.5 659.1 660.7 660.9 661.7 15065.8 15228.4 15233.2 15255.8 15288.9 13035.2 13705.8 13859.9 14797.1 15019.3 12130.9 12212.6 12247.9 12284.2 12570.4 4507.6 4537.0 4585.9 4736.7 4742.1 62740.4 63271.4 63712.4 63810.7 65119.0 10448.6 10761.8 11032.6 11334.0 11578.9 17682.0 17703.2 17735.2 17742.0 17744.6 8259.5 8442.9 8522.2 8656.4 8919.9 4894.8 4907.6 4954.3 5008.7 5011.5 3788.7 4029.4 4029.6 4062.3 4062.6 652.1 664.9 670.7 673.4 679.3 771.3 780.5 784.6 791.3 794.2 9286.7 9468.1 9908.5 10033.3 10214.8 729.2 739.4 741.9 749.4 769.5 4595.4 4851.9 4901.7 4949.9 4960.5 82524.2 85478.0 88224.0 88782.0 91358.0 45445.0 58727.0 68952.0 70762.6 71988.1 64135.4 64852.4 65603.7 66885.0 68362.7 9414.9 9435.1 9652.5 9668.3 9675.0 44367.8 44473.0 45074.8 45183.3 45908.5 58316.7 60473.0 61719.4 62312.4 62548.0 11939.5 12321.9 12757.2 12847.0 13166.7 14537.6 14617.6 14653.9 14767.8 14980.0 13741.8 14028.5 14096.4 14126.3 14256.6 12761.0 13008.6 13380.6 13496.1 14045.9 13061.1 13100.0 13517.7 13536.3 13722.7 11490.9 11566.7 12084.6 12300.0 12478.0 11326.8 11337.2 11370.9 11376.1 11651.3 12:03:03 INFO - PROCESS | 961 | -------- Summary: end -------- 12:03:03 INFO - PROCESS | 961 | 12:03:04 INFO - TEST-INFO | 961: exit 0 12:03:04 INFO - TEST-OK | dromaeo_css | took 1115226ms 12:03:04 INFO - TEST-START | kraken 12:03:04 INFO - operating with platform_type : linux_ 12:03:04 INFO - Initialising browser for kraken test... 12:03:04 INFO - TEST-INFO | started process 1363 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZkEm8L/profile http://localhost:40037/getInfo.html) 12:03:08 INFO - PROCESS | 1363 | __metrics Screen width/height:1600/1200 12:03:08 INFO - PROCESS | 1363 | colorDepth:24 12:03:08 INFO - PROCESS | 1363 | Browser inner width/height: 1024/697 12:03:08 INFO - PROCESS | 1363 | __metrics 12:03:08 INFO - PROCESS | 1363 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 12:03:08 INFO - PROCESS | 1363 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:03:09 INFO - PROCESS | 1363 | console.error: PushService: 12:03:09 INFO - PROCESS | 1363 | stateChangeProcessEnqueue: Error transitioning state 12:03:09 INFO - PROCESS | 1363 | UnknownError 12:03:09 INFO - TEST-INFO | 1363: exit 0 12:03:09 INFO - Browser initialized. 12:03:09 INFO - Running cycle 1/1 for kraken test... 12:03:09 INFO - TEST-INFO | started process 1460 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZkEm8L/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:03:21 INFO - PROCESS | 1460 | RSS: Main: 147374080 12:03:21 INFO - PROCESS | 1460 | 12:03:24 INFO - PROCESS | 1460 | Cycle 1(1): loaded http://localhost:40037/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40037/tests/kraken/driver.html?testName=audio-beat-detection) 12:03:24 INFO - PROCESS | 1460 | RSS: Main: 188911616 12:03:24 INFO - PROCESS | 1460 | 12:03:27 INFO - PROCESS | 1460 | Cycle 1(1): loaded http://localhost:40037/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40037/tests/kraken/driver.html?testName=audio-dft) 12:03:28 INFO - PROCESS | 1460 | RSS: Main: 178323456 12:03:28 INFO - PROCESS | 1460 | 12:03:30 INFO - PROCESS | 1460 | Cycle 1(1): loaded http://localhost:40037/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40037/tests/kraken/driver.html?testName=audio-fft) 12:03:31 INFO - PROCESS | 1460 | RSS: Main: 270151680 12:03:31 INFO - PROCESS | 1460 | 12:03:33 INFO - PROCESS | 1460 | Cycle 1(1): loaded http://localhost:40037/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40037/tests/kraken/driver.html?testName=audio-oscillator) 12:03:34 INFO - PROCESS | 1460 | RSS: Main: 176578560 12:03:34 INFO - PROCESS | 1460 | 12:03:36 INFO - PROCESS | 1460 | Cycle 1(1): loaded http://localhost:40037/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40037/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:03:36 INFO - PROCESS | 1460 | RSS: Main: 179052544 12:03:36 INFO - PROCESS | 1460 | 12:03:39 INFO - PROCESS | 1460 | Cycle 1(1): loaded http://localhost:40037/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40037/tests/kraken/driver.html?testName=imaging-darkroom) 12:03:40 INFO - PROCESS | 1460 | RSS: Main: 217407488 12:03:40 INFO - PROCESS | 1460 | 12:03:43 INFO - PROCESS | 1460 | Cycle 1(1): loaded http://localhost:40037/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40037/tests/kraken/driver.html?testName=imaging-desaturate) 12:03:44 INFO - PROCESS | 1460 | RSS: Main: 215851008 12:03:44 INFO - PROCESS | 1460 | 12:03:46 INFO - PROCESS | 1460 | Cycle 1(1): loaded http://localhost:40037/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40037/tests/kraken/driver.html?testName=json-parse-financial) 12:03:47 INFO - PROCESS | 1460 | RSS: Main: 214388736 12:03:47 INFO - PROCESS | 1460 | 12:03:48 INFO - PROCESS | 1460 | Cycle 1(1): loaded http://localhost:40037/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40037/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:03:49 INFO - PROCESS | 1460 | RSS: Main: 176898048 12:03:49 INFO - PROCESS | 1460 | 12:03:51 INFO - PROCESS | 1460 | Cycle 1(1): loaded http://localhost:40037/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40037/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:03:51 INFO - PROCESS | 1460 | RSS: Main: 184258560 12:03:51 INFO - PROCESS | 1460 | 12:03:53 INFO - PROCESS | 1460 | Cycle 1(1): loaded http://localhost:40037/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40037/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:03:54 INFO - PROCESS | 1460 | RSS: Main: 190431232 12:03:54 INFO - PROCESS | 1460 | 12:03:57 INFO - PROCESS | 1460 | Cycle 1(1): loaded http://localhost:40037/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40037/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:03:57 INFO - PROCESS | 1460 | RSS: Main: 198971392 12:03:57 INFO - PROCESS | 1460 | 12:04:00 INFO - PROCESS | 1460 | Cycle 1(1): loaded http://localhost:40037/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40037/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:04:00 INFO - PROCESS | 1460 | RSS: Main: 195248128 12:04:00 INFO - PROCESS | 1460 | 12:04:02 INFO - PROCESS | 1460 | Cycle 1(1): loaded http://localhost:40037/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40037/tests/kraken/driver.html?testName=ai-astar) 12:04:02 INFO - PROCESS | 1460 | RSS: Main: 245100544 12:04:02 INFO - PROCESS | 1460 | 12:04:02 INFO - PROCESS | 1460 | __start_tp_report 12:04:02 INFO - PROCESS | 1460 | _x_x_mozilla_page_load 12:04:02 INFO - PROCESS | 1460 | _x_x_mozilla_page_load_details 12:04:02 INFO - PROCESS | 1460 | |i|pagename|runs| 12:04:02 INFO - PROCESS | 1460 | |0;ai-astar;103;110;113;112;112;112;111;115;112;110 12:04:02 INFO - PROCESS | 1460 | |1;audio-beat-detection;150;123;123;164;119;118;117;116;147;120 12:04:02 INFO - PROCESS | 1460 | |2;audio-dft;160;160;159;162;160;159;160;162;160;160 12:04:02 INFO - PROCESS | 1460 | |3;audio-fft;75;76;75;117;76;77;76;75;97;74 12:04:02 INFO - PROCESS | 1460 | |4;audio-oscillator;82;81;116;82;82;82;106;81;81;115 12:04:02 INFO - PROCESS | 1460 | |5;imaging-gaussian-blur;117;117;116;116;116;116;117;117;117;117 12:04:02 INFO - PROCESS | 1460 | |6;imaging-darkroom;145;146;146;145;145;146;146;146;146;146 12:04:02 INFO - PROCESS | 1460 | |7;imaging-desaturate;86;85;85;84;85;85;84;85;85;84 12:04:02 INFO - PROCESS | 1460 | |8;json-parse-financial;50;50;50;51;52;52;52;55;49;51 12:04:02 INFO - PROCESS | 1460 | |9;json-stringify-tinderbox;59;59;58;59;60;60;59;59;60;59 12:04:02 INFO - PROCESS | 1460 | |10;stanford-crypto-aes;77;80;74;74;84;81;78;78;74;83 12:04:02 INFO - PROCESS | 1460 | |11;stanford-crypto-ccm;127;134;129;129;138;123;120;119;165;120 12:04:02 INFO - PROCESS | 1460 | |12;stanford-crypto-pbkdf2;152;157;150;152;152;155;156;152;151;152 12:04:02 INFO - PROCESS | 1460 | |13;stanford-crypto-sha256-iterative;63;61;68;65;62;64;61;63;61;61 12:04:02 INFO - PROCESS | 1460 | __end_tp_report 12:04:02 INFO - PROCESS | 1460 | __start_cc_report 12:04:02 INFO - PROCESS | 1460 | _x_x_mozilla_cycle_collect,1570 12:04:02 INFO - PROCESS | 1460 | __end_cc_report 12:04:02 INFO - PROCESS | 1460 | __startTimestamp1484769842827__endTimestamp 12:04:02 INFO - PROCESS | 1460 | 12:04:02 INFO - PROCESS | 1460 | ------- Summary: start ------- 12:04:02 INFO - PROCESS | 1460 | Number of tests: 14 12:04:02 INFO - PROCESS | 1460 | 12:04:02 INFO - PROCESS | 1460 | [#0] ai-astar Cycles:10 Average:111.00 Median:112.00 stddev:3.16 (2.8%) stddev-sans-first:1.54 12:04:02 INFO - PROCESS | 1460 | Values: 103.0 110.0 113.0 112.0 112.0 112.0 111.0 115.0 112.0 110.0 12:04:02 INFO - PROCESS | 1460 | 12:04:02 INFO - PROCESS | 1460 | [#1] audio-beat-detection Cycles:10 Average:129.70 Median:123.00 stddev:17.23 (14.0%) stddev-sans-first:16.64 12:04:02 INFO - PROCESS | 1460 | Values: 150.0 123.0 123.0 164.0 119.0 118.0 117.0 116.0 147.0 120.0 12:04:02 INFO - PROCESS | 1460 | 12:04:02 INFO - PROCESS | 1460 | [#2] audio-dft Cycles:10 Average:160.20 Median:160.00 stddev:1.03 (0.6%) stddev-sans-first:1.09 12:04:02 INFO - PROCESS | 1460 | Values: 160.0 160.0 159.0 162.0 160.0 159.0 160.0 162.0 160.0 160.0 12:04:02 INFO - PROCESS | 1460 | 12:04:02 INFO - PROCESS | 1460 | [#3] audio-fft Cycles:10 Average:81.80 Median:76.00 stddev:14.12 (18.6%) stddev-sans-first:14.76 12:04:02 INFO - PROCESS | 1460 | Values: 75.0 76.0 75.0 117.0 76.0 77.0 76.0 75.0 97.0 74.0 12:04:02 INFO - PROCESS | 1460 | 12:04:02 INFO - PROCESS | 1460 | [#4] audio-oscillator Cycles:10 Average:90.80 Median:81.50 stddev:15.09 (18.5%) stddev-sans-first:15.67 12:04:02 INFO - PROCESS | 1460 | Values: 82.0 81.0 116.0 82.0 82.0 82.0 106.0 81.0 81.0 115.0 12:04:02 INFO - PROCESS | 1460 | 12:04:02 INFO - PROCESS | 1460 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 12:04:02 INFO - PROCESS | 1460 | Values: 117.0 117.0 116.0 116.0 116.0 116.0 117.0 117.0 117.0 117.0 12:04:02 INFO - PROCESS | 1460 | 12:04:02 INFO - PROCESS | 1460 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 12:04:02 INFO - PROCESS | 1460 | Values: 145.0 146.0 146.0 145.0 145.0 146.0 146.0 146.0 146.0 146.0 12:04:02 INFO - PROCESS | 1460 | 12:04:02 INFO - PROCESS | 1460 | [#7] imaging-desaturate Cycles:10 Average:84.80 Median:85.00 stddev:0.63 (0.7%) stddev-sans-first:0.50 12:04:02 INFO - PROCESS | 1460 | Values: 86.0 85.0 85.0 84.0 85.0 85.0 84.0 85.0 85.0 84.0 12:04:02 INFO - PROCESS | 1460 | 12:04:02 INFO - PROCESS | 1460 | [#8] json-parse-financial Cycles:10 Average:51.20 Median:51.50 stddev:1.69 (3.3%) stddev-sans-first:1.73 12:04:02 INFO - PROCESS | 1460 | Values: 50.0 50.0 50.0 51.0 52.0 52.0 52.0 55.0 49.0 51.0 12:04:02 INFO - PROCESS | 1460 | 12:04:02 INFO - PROCESS | 1460 | [#9] json-stringify-tinderbox Cycles:10 Average:59.20 Median:59.00 stddev:0.63 (1.1%) stddev-sans-first:0.67 12:04:02 INFO - PROCESS | 1460 | Values: 59.0 59.0 58.0 59.0 60.0 60.0 59.0 59.0 60.0 59.0 12:04:02 INFO - PROCESS | 1460 | 12:04:02 INFO - PROCESS | 1460 | [#10] stanford-crypto-aes Cycles:10 Average:78.30 Median:79.00 stddev:3.68 (4.7%) stddev-sans-first:3.88 12:04:02 INFO - PROCESS | 1460 | Values: 77.0 80.0 74.0 74.0 84.0 81.0 78.0 78.0 74.0 83.0 12:04:02 INFO - PROCESS | 1460 | 12:04:02 INFO - PROCESS | 1460 | [#11] stanford-crypto-ccm Cycles:10 Average:130.40 Median:129.00 stddev:13.68 (10.6%) stddev-sans-first:14.45 12:04:02 INFO - PROCESS | 1460 | Values: 127.0 134.0 129.0 129.0 138.0 123.0 120.0 119.0 165.0 120.0 12:04:02 INFO - PROCESS | 1460 | 12:04:02 INFO - PROCESS | 1460 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.90 Median:152.00 stddev:2.28 (1.5%) stddev-sans-first:2.40 12:04:02 INFO - PROCESS | 1460 | Values: 152.0 157.0 150.0 152.0 152.0 155.0 156.0 152.0 151.0 152.0 12:04:02 INFO - PROCESS | 1460 | 12:04:02 INFO - PROCESS | 1460 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.90 Median:63.00 stddev:2.28 (3.6%) stddev-sans-first:2.42 12:04:02 INFO - PROCESS | 1460 | Values: 63.0 61.0 68.0 65.0 62.0 64.0 61.0 63.0 61.0 61.0 12:04:02 INFO - PROCESS | 1460 | -------- Summary: end -------- 12:04:02 INFO - PROCESS | 1460 | 12:04:04 INFO - TEST-INFO | 1460: exit 0 12:04:04 INFO - TEST-OK | kraken | took 59899ms 12:04:04 INFO - SUITE-END | took 1175s 12:04:04 INFO - Completed test suite (00:19:35) 12:04:04 INFO - javascript benchmark 12:04:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3221.710046095851, 3267.01989403179, 3270.1334146451195, 3293.226091868409, 3311.5694959655243, 5538.280023596937, 5542.445755424461, 5618.15727640854, 5636.577256705748, 5647.491725744682, 5527.50252477277, 5639.915401268974, 5644.068728659777, 5648.943510564893, 5694.145878118285, 5092.3889133303965, 5104.948950510503, 5106.668066575679, 5165.096108181072, 5197.986392653434, 4985.800567977295, 5212.50481204285, 5218.217267409881, 5218.373795144588, 5230.450802665722, 4980.05378977993, 5089.770960306795, 5109.463506331837, 5158.019976204528, 5163.561097306733, 5119.56483698886, 5186.481351864821, 5220.190870415092, 5222.399424066205, 5237.528622423962, 5061.848144555669, 5142.074426603247, 5188.558972487305, 5199.896002079937, 5231.738413079331, 5429.782808687648, 5449.83650490482, 5507.146392309199, 5531.0, 5561.110222364443, 5929.584929054925, 5945.4946329562035, 5954.791582294599, 6033.185519954794, 6035.668038257894, 6058.848528786772, 6068.089786532011, 6076.270847498285, 6083.695815209266, 6086.634801911855, 5500.3949565547755, 5538.501534861842, 5576.972115139439, 5581.274434323512, 5606.0, 6113.816585502442, 6160.661163635953, 6165.907511387333, 6166.969165154145, 6172.629642221481, 5893.852653683693, 5894.056950887837, 5906.616069955439, 5916.349201587822, 5928.466438020599, 5826.213461182686, 5832.387599302097, 5852.4440178183, 5872.500837428866, 5899.793507227227, 5923.348431672513, 5926.199963005025, 5938.049912014057, 5961.105834124829, 5981.431763982502, 5860.443257890493, 5905.379935106838, 5908.20239267702, 5922.911156332659, 5933.732982015819, 4529.116822219636, 4566.611837993742, 4575.0, 4605.65457590682, 4616.28447590624, 4105.261053010427, 4122.896927576775, 4129.566395528486, 4159.209750147463, 4172.01957539984, 5714.257146570919, 5721.370649228582, 5727.2268243787385, 5734.39788822176, 5736.340320863071, 5808.506276966421, 5877.412258774174, 5894.440028197314, 5981.192539007266, 6005.489533389624, 5643.774249030075, 5692.288463942007, 5705.343885453226, 5723.313202415737, 5737.08206686928, 5131.692098474104, 5136.743162841918, 5140.254663073833, 5143.819966301162, 5158.4067832199025, 6020.0, 6225.470834978896, 6229.501639868799, 6257.74969001244, 6265.342139075423, 5822.126680997715, 5850.0932355484965, 5852.151438041375, 5965.522758179422, 5984.850378740566, 6205.162303089025, 6234.3453937337745, 6235.189425374672, 6242.219722534684, 6245.18812554365, 5679.403662615366, 5849.268841394825, 5849.502792262705, 5855.502282306052, 5870.0607902737065, 5791.710414479344, 5921.259842519685, 5972.283326000907, 5983.371745966785, 6049.243844519435, 5843.415658434123, 5886.0, 5890.970545147418, 5894.174815525916, 5894.174815525916, 5855.648661080349, 5869.765209391577, 5874.735636896436, 5877.764889404547, 5883.911741323798, 5656.349519805275, 5656.6888821115235, 5781.739821707949, 5834.708264586839, 5845.795397161079, 5946.970265148647, 5955.523558115254, 5955.940440595712, 5969.0, 5982.192404025401, 5458.563314934716, 5502.0371434999515, 5650.265465489624, 5654.123610840326, 5659.434056594472], "value": 5520.335548121771, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [600.3396264109477, 616.1866336435903, 652.0968458684722, 666.1240468783552, 666.7499687617144, 34155.82922085389, 45144.32283515746, 45923.31115033269, 46034.309485357706, 46097.0, 46950.7652461738, 47230.527694723045, 47304.0, 47314.290285645744, 47365.52634473663, 8391.496510209407, 8929.598168082435, 9090.363674542785, 9100.499472529009, 9103.681371152012, 8469.407141500067, 8688.131186881325, 8695.913040869606, 10597.258191926569, 10884.836727449094, 11062.834057489144, 11123.110151187886, 11132.10943124548, 11137.164712646583, 11137.276077054965, 10557.0, 10604.522796474177, 10613.310134841211, 10614.57541698331, 10615.787684246348, 10827.512761925653, 10889.183311251609, 10902.291351062155, 10906.563737450493, 10910.50902709372, 44359.0, 44412.3338149928, 44643.33035004477, 44743.32885006727, 44744.55255447469, 3888.786116763577, 3910.432987216866, 4081.3469844824685, 4120.505539335269, 4399.802008909607, 32668.0, 32722.0, 32741.836290818632, 32789.6721032789, 33043.0, 4483.708558943658, 4530.75080870552, 4550.88622784433, 4558.270676691746, 4659.207934651084, 359491.0, 364419.0, 364485.0, 364636.0, 364990.0, 61469.692651536454, 61753.691231543555, 61767.691161544804, 61866.0, 61890.0, 40206.59793402028, 40821.18357632831, 40878.59121408748, 43299.78350108292, 43321.78339108284, 18010.459686209433, 18235.544111397056, 18266.725999110025, 18281.45155645333, 18296.085195740427, 12430.627081187578, 13809.378577964017, 14033.438662453591, 14082.155070695791, 14087.788683169761, 18113.547161321072, 19842.50393740168, 20462.693059604117, 20486.79513204879, 21419.357419277447, 7227.0, 7336.339729424378, 7530.171681115073, 7540.660670269741, 7626.885596716053, 955.9283053770856, 995.3430735714394, 1043.0, 1055.1400608504046, 1080.5191689698165, 33485.49771753426, 33822.49266261008, 33834.15414614605, 33927.32145357079, 34047.659523404946, 1114.2367478277406, 1134.5631931706187, 1155.283724091069, 1173.6068417080203, 1224.240970598217, 17508.299668013136, 17659.20533575992, 17764.0, 17859.196336164903, 17866.642667146585, 528680.0, 539174.0, 540087.0, 542043.0, 543237.0, 61204.0, 61685.38314616886, 61728.0, 61758.0, 62031.37968620256, 1325.7282257137263, 1366.7266546690503, 1410.9294535273195, 1437.8921580881477, 1458.555140682102, 31879.203019924687, 33575.32849343048, 34323.828380857936, 34387.65612343844, 34524.30951380908, 51704.74147629238, 52289.0, 52291.73854130705, 52344.21483677824, 52355.21467177919, 372265.0, 373895.0, 374110.0, 374365.0, 375693.0, 30139.69860301369, 30234.0, 30786.53820192654, 32580.674193258714, 32934.670653293164, 49545.752271238416, 49677.0, 49695.751521242164, 49832.750836245585, 50787.49212507828, 42144.578554215295, 42215.366769499095, 42921.35617965795, 44024.0, 44400.0, 41713.0, 42036.789816050725, 42888.35667465053, 43754.0, 43888.780556097016, 41451.7927410361, 42343.0, 42395.7880210597, 42557.57442425536, 43029.56970430256, 36445.635543644225, 38014.0, 38822.223555528166, 41785.582144178166, 42243.7887810559, 29031.56452653254, 29164.27089322784, 29231.123066308046, 29658.406831863675, 29673.0], "value": 21033.452878703323, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [400.5093760143822, 400.5313782874037, 424.42702351825034, 428.1522585281143, 435.6819521749123, 16473.0, 19580.216791328367, 20016.399508014747, 20074.49813754657, 20312.390628281137, 19575.804241957576, 19746.90126549369, 20035.499112522193, 20042.098105585246, 20252.189912403486, 5253.973730131344, 5607.4112218217115, 5779.306483222009, 5893.793717219898, 5950.851228719273, 5830.5044071254, 5918.852028699274, 5922.674252916088, 5924.170616113747, 5924.7333869975955, 5694.402087780785, 5852.12218167274, 5877.324107727623, 5880.147378630096, 5880.617759845618, 5716.599838011341, 5772.797952071699, 5857.297124345085, 5904.527637788988, 5908.881822363572, 5168.5606723428555, 5199.376074871002, 5201.349831271091, 5201.869953251161, 5202.557782588485, 23220.53558928812, 23225.419364515852, 23677.408064798346, 23688.881555592285, 23856.0, 2439.7438268981678, 2471.4439251168524, 2567.7560631739957, 2575.137328994789, 2604.869756512167, 14190.645233869132, 14813.407463701438, 15311.375698185211, 15331.080135191813, 15479.303431345617, 1969.3205843983803, 1984.1666500070005, 1987.1455274232073, 2037.3174986379581, 2045.3557129504159, 51850.0, 61295.387046129414, 63342.68328658327, 65518.344816551704, 86069.99999999937, 11140.108791296676, 11141.0, 11183.105351571854, 11251.606193783178, 11562.07503399726, 16060.357585696675, 16060.75908861368, 16064.67870642604, 16066.839331606769, 16070.196490175444, 8332.791680207922, 8356.415050946496, 8413.284870785928, 8427.241548260687, 8711.34664900135, 7775.727849525239, 7799.49303295284, 7878.487898286593, 8029.397795165269, 8054.879176812353, 6918.515703900779, 7017.859642807115, 7071.0, 7084.43324534036, 7105.396041336441, 1915.6168766246806, 1918.3285849952683, 1984.6427643024106, 2016.1532156494306, 2047.30391666834, 804.0953926832314, 868.9000764912116, 994.6071301835879, 1039.3088596083671, 1063.4842101580728, 19183.904080479508, 19922.90038549827, 20049.298274560322, 20103.29638462647, 20403.183872645226, 1030.850526673628, 1033.5504055735778, 1035.3735989726258, 1036.2280101324561, 1043.7129789308, 10853.945730271456, 11733.88266117345, 11747.060235181165, 11778.646640600795, 11800.763984720257, 467206.0, 474538.0, 481985.0, 484918.0, 496886.0, 82546.58726706328, 82999.0, 83120.58439707763, 84287.57856210679, 84794.57602711947, 1043.6034306963306, 1049.197364016528, 1070.8340207267886, 1075.3762817565948, 1092.4919912240687, 17356.0, 17781.70684806999, 18137.183826728095, 18229.817701822813, 18516.537086572942, 39667.60332396639, 39935.400968984904, 40664.39003414892, 41499.37750933799, 42147.57852421437, 53185.30319625672, 54414.0, 54486.45513544814, 54504.45495544994, 54603.0, 6040.546958978182, 6078.0, 7344.045274114331, 7380.335769780745, 8387.0, 12394.070444716863, 12842.550510732079, 13321.200727956353, 13693.0, 14232.146071235758, 11987.520499179935, 12183.208091474025, 12334.396528451243, 12512.436940337524, 12789.360531973178, 12234.150897466101, 12300.261984280973, 12309.93845030769, 12326.876731232573, 12377.0, 12587.24476531411, 12658.87341126577, 12664.74670506603, 12680.112392132462, 12711.42798574085, 8710.520921349387, 8818.51498167607, 8937.0, 8948.910510894808, 9015.549222538977, 11643.708907277385, 11811.232269902428, 11869.347185904859, 11936.76126477483, 12239.265644061385], "value": 9471.058594175043, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1470.4265336518758, 1510.7205167044099, 1664.6504234110837, 1828.615990641966, 1828.9176987035582, 7800.960995195023, 8212.466189697672, 8245.381596380266, 8259.174082591739, 8270.710525131622, 7661.310482056614, 7941.205879412056, 8231.958840205805, 8496.1503849615, 8496.702615408461, 2389.4982053768686, 2411.46947671512, 2412.577798885197, 2413.0830284491867, 2423.903043878243, 2360.6931098957198, 2413.119211487803, 2416.3113512648897, 2430.0158435833428, 2430.8906099225487, 2341.929742107731, 2346.601077816775, 2362.787349138577, 2366.4675448024227, 2366.5266946610745, 2233.4751333436793, 2235.4970131720315, 2257.932262032142, 2258.5934531784355, 2261.5137745384823, 2162.859414138076, 2181.5636872625378, 2183.8471307008517, 2184.0171922634877, 2184.3665337052234, 8711.21599056088, 8723.781905452352, 8796.428232164888, 8809.339299552496, 8815.030346661926, 5135.0, 5260.263563101169, 5275.0, 5278.2082687596785, 5280.2079688046715, 3084.6606873243927, 3181.1410919051727, 3400.7279417646528, 3409.437442821931, 3412.7611067225303, 989.9505024748734, 997.4065431068575, 1018.8369860822307, 1082.9025387715144, 1109.8945600167972, 12134.575289864812, 12192.39038048094, 12215.877841221563, 12234.694132646666, 12246.387680616022, 4453.844115455943, 4582.335561343587, 4690.507496712864, 4822.373091498153, 4849.175640141114, 10199.796004080024, 10201.489925503844, 10204.489775511194, 10209.183265338756, 10218.642347517802, 5310.495502927216, 5312.787488500494, 5321.228421878884, 5322.414534401213, 5325.600579956519, 4175.853845115406, 4266.658667306608, 4818.060478206716, 4828.179209534387, 4918.631102667314, 3981.1042515434374, 4031.5162180538523, 4039.171969746195, 4135.669146468275, 4137.13120244752, 1268.9682757931125, 1279.2836011833217, 1283.5764197814885, 1301.219268438948, 1325.3704490367, 842.7050532313641, 895.1272509303377, 915.208344781759, 944.1313991128178, 978.3396207559869, 5906.7637294508595, 5941.821745347646, 5942.435468630473, 5972.283326000821, 6237.688115594202, 946.5409276500892, 957.305953183936, 986.2159583131428, 992.1709954020132, 1015.4668798880499, 3739.775613463201, 3924.47019652349, 3926.842926282917, 3933.803309834554, 3958.7030972677167, 10312.226583006304, 10696.090832279187, 10742.194335424874, 10750.139988800876, 10750.247482676294, 10525.21060920434, 10527.789444211074, 10589.258751887448, 10614.097801686943, 10635.20235982289, 7741.18717534662, 8058.879116813252, 8061.113277539466, 8167.224113709188, 8331.166883311742, 5815.098659707752, 5869.4717475427415, 5958.731857066356, 6029.246344206974, 6070.362611925684, 9373.531323433937, 9422.811543768948, 9452.338336316392, 9453.952730236304, 9559.856602150834, 9357.39176953496, 9446.95276523613, 9512.95243523778, 9579.467285234328, 9593.472359020321, 7114.822129446598, 7202.49582529218, 7245.130584329914, 7302.707891684486, 7317.597532135784, 7896.565688887166, 7977.641006154853, 7984.161663025531, 7989.680412783424, 7990.081140668897, 7312.085989251344, 7436.293552112541, 7460.253974602496, 7524.398048156244, 7557.395408367427, 7544.735934242275, 7558.508696934681, 7636.8472630548185, 7675.347595454449, 7718.575478348745, 6979.162500499972, 7072.115985501812, 7077.433805295461, 7081.362677359062, 7083.220845707071, 5027.874303142451, 5078.847634570969, 5119.974400127976, 5132.46109158533, 5297.496737809902, 5211.296474975829, 5297.867553311198, 5328.307320048369, 5350.759215835219, 5488.753006114654], "value": 4569.147236633016, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.1066331568082, 347.75755486047825, 347.9460683594043, 355.15650330465144, 362.60294977000194, 5303.549198318147, 5441.347038355393, 5450.972745136274, 5464.699441530719, 5482.985647655181, 5175.870603234921, 5282.418933917266, 5285.365756109272, 5294.708791016493, 5319.308489896318, 4271.807768650418, 4274.081072569397, 4274.700770946035, 4299.398084268205, 4312.784360781964, 4225.894352641178, 4275.123599662062, 4276.358546218061, 4298.398224248592, 4319.416878721364, 4218.303979843322, 4220.177065472234, 4248.129133527619, 4249.915001699964, 4252.957470425303, 4220.388043733657, 4226.725262857904, 4234.280172370673, 4234.5765423457715, 4241.809118589671, 3588.6052534221217, 3682.226732386175, 3714.331420344337, 3714.7028237740915, 3785.4700341951875, 5209.635325527214, 5214.634975551713, 5240.633155679104, 5245.160774276135, 5262.92105618416, 4784.545468180518, 4797.52024797521, 4805.135075686375, 4806.231003039532, 4844.37023186987, 5424.8607792363655, 5546.306711661043, 5573.303337082864, 5590.245316882209, 5671.922334756383, 4085.6527195188146, 4086.5913408659194, 4095.9590404096175, 4099.364598487239, 4100.159467309194, 5826.504747096502, 5845.824625261249, 5878.676672782995, 5896.410358964112, 5914.852128696774, 4079.86715324113, 4119.464469618931, 4152.148809494047, 4160.875173744793, 4179.937300940488, 4211.957880421157, 4243.872683819491, 4247.745135291892, 4248.723832950848, 4253.255680255943, 4782.7847746850775, 4814.026249237796, 4815.085133824562, 4818.397700287464, 4819.445763737145, 5399.244105825188, 5640.971795140998, 5713.285839270091, 5735.512481439041, 5743.8564035899435, 1350.8716671916152, 1366.8564800695983, 1390.2214759734582, 1421.5593166118535, 1436.2029073863896, 926.7303793802533, 956.2111258211864, 957.411192116857, 958.2238386906628, 967.9274054445945, 5215.348081489814, 5218.504242096995, 5228.6862788232065, 5233.790648374099, 5248.186531087687, 5508.807191748269, 5530.86172845674, 5560.694161821139, 5578.41426650204, 5586.217929489874, 5196.870078248074, 5246.816361427332, 5270.604704647167, 5293.338332708411, 5506.614536982453, 2953.896613618513, 2976.8362740049506, 2977.4045190961892, 2988.237999310162, 2990.2374894401787, 5807.303123625107, 5816.738246778905, 5858.2677165354335, 5901.468867801918, 5912.467877890925, 5401.378841433207, 5688.411772643437, 5728.450839376521, 5789.478946894716, 5790.276215473066, 5893.263342082239, 5894.616849904743, 5913.21554205309, 5928.762849486145, 5936.5250779937505, 5382.946170538401, 5592.524635406036, 5659.943400565941, 5695.7436915338085, 5714.428557144252, 5504.669719816824, 5519.448055194448, 5521.5306698931045, 5532.585056120726, 5545.861353466195, 5796.420592836316, 5826.504747096545, 5838.2702162229725, 5843.590948633555, 5889.64662120257, 3891.3773796193605, 3980.402939559089, 4103.4870641169855, 4121.340585506305, 4129.525104613008, 5563.221149039056, 5606.887862242651, 5644.322681278273, 5653.0, 5662.575306852085, 5460.099083651153, 5552.168394118948, 5607.243022191952, 5675.943240567542, 5722.313322401338, 5629.408912064175, 5639.731060511353, 5649.180868773922, 5659.349174844946, 5661.207430959586, 5460.6996615186545, 5569.526590239875, 5587.329520457572, 5625.706087599793, 5633.464820842013, 5630.943690563206, 5634.605577609528, 5636.267285252891, 5643.492085712305, 5684.175794509855, 5228.686278823283, 5350.170723537858, 5363.115086010765, 5396.865078373072, 5397.244385785914], "value": 4274.158264394128, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [770.4799260499161, 791.8574656561816, 801.0427539090789, 814.4909431605247, 821.4455242711172, 13933.094348867317, 14536.0, 14547.563573092797, 14618.195999220039, 14664.70670586589, 13709.93145034276, 13880.791788123186, 13906.443742250298, 13914.095583787072, 13914.373853176607, 706.752636577199, 741.4142827166532, 834.6577903059747, 853.2406158518924, 881.8412685716569, 865.0441262405014, 866.0733015673233, 868.0711638546758, 868.3053557154283, 868.4962721621476, 922.9769255768626, 923.1184219070772, 924.4314746430964, 928.4614923344478, 928.7817362919709, 761.5735188294573, 781.2578050851686, 866.8266346730647, 883.5317281840635, 895.4985208283382, 656.5404217048085, 659.077291791491, 660.6993817812884, 660.8810414125455, 661.6724721263006, 15065.849341506555, 15228.390864365412, 15233.162176080423, 15255.847441525553, 15288.923555382264, 13035.217886926815, 13705.794413083811, 13859.861401385959, 14797.112173269637, 15019.324130414157, 12130.87869121315, 12212.633620991384, 12247.938760306231, 12284.201526900812, 12570.434330455151, 4507.57178068083, 4536.954630453686, 4585.885352866205, 4736.715797052153, 4742.075295317414, 62740.37259627391, 63271.36728632701, 63712.362876370644, 63810.680946595436, 65119.0, 10448.634297799692, 10761.83857242142, 11032.613858514913, 11333.979941805277, 11578.942105289589, 17682.0, 17703.20335584902, 17735.201915913814, 17742.0, 17744.556386090193, 8259.545724985064, 8442.915570844336, 8522.190391912758, 8656.437331573428, 8919.910800892038, 4894.804207831647, 4907.5828554572545, 4954.3063971044085, 5008.6744361616375, 5011.5489605935645, 3788.7158463115375, 4029.3553031514816, 4029.597040295947, 4062.289099407592, 4062.6140516651462, 652.103357882911, 664.9401553860176, 670.7250027488706, 673.4444083630926, 679.3478260869621, 771.2557382126275, 780.4575819805181, 784.5684873319651, 791.3431851563189, 794.2018271636967, 9286.674966376144, 9468.053194680615, 9908.504574771232, 10033.347832390871, 10214.795704086026, 729.2051663686607, 739.3826155160393, 741.9258074192537, 749.4454103963028, 769.54981335918, 4595.425571803525, 4851.878703032452, 4901.705897646153, 4949.925751113737, 4960.50394960501, 82524.17475825165, 85478.0, 88224.0, 88782.0, 91358.0, 45445.0, 58727.0, 68951.96572051423, 70762.64618676873, 71988.12047518145, 64135.35864641387, 64852.35147648463, 65603.67198163978, 66885.0, 68362.65818670875, 9414.901851121276, 9435.149577985372, 9652.517374131407, 9668.274879383933, 9675.0, 44367.77816111028, 44473.0, 45074.77462612797, 45183.32225016693, 45908.540914591766, 58316.708416457644, 60473.0, 61719.382806171365, 62312.37687623066, 62548.0, 11939.462724177607, 12321.93839030799, 12757.170783899017, 12847.0, 13166.736665266833, 14537.636559086108, 14617.561473155822, 14653.853461465675, 14767.778483322974, 14980.026298290577, 13741.793873092112, 14028.509002184874, 14096.36566354496, 14126.293685315488, 14256.572302830931, 12761.0, 13008.609741707764, 13380.598582042554, 13496.122752021087, 14045.859541404456, 13061.08572399923, 13100.0, 13517.729645407233, 13536.323183840965, 13722.725545489235, 11490.94254528722, 11566.65300041, 12084.577039803564, 12300.0, 12478.0, 11326.773464530499, 11337.180280733943, 11370.943145284551, 11376.146788990693, 11651.30092194471], "value": 7367.577244790227, "unit": "score"}], "name": "dromaeo_css", "value": 7354.535476311764, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 110.0, 113.0, 112.0, 112.0, 112.0, 111.0, 115.0, 112.0, 110.0], "value": 111.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 123.0, 123.0, 164.0, 119.0, 118.0, 117.0, 116.0, 147.0, 120.0], "value": 129.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 159.0, 162.0, 160.0, 159.0, 160.0, 162.0, 160.0, 160.0], "value": 160.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 117.0, 76.0, 77.0, 76.0, 75.0, 97.0, 74.0], "value": 81.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 116.0, 82.0, 82.0, 82.0, 106.0, 81.0, 81.0, 115.0], "value": 90.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 116.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 145.0, 145.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 85.0, 84.0, 85.0, 85.0, 84.0, 85.0, 85.0, 84.0], "value": 84.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 50.0, 50.0, 51.0, 52.0, 52.0, 52.0, 55.0, 49.0, 51.0], "value": 51.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 58.0, 59.0, 60.0, 60.0, 59.0, 59.0, 60.0, 59.0], "value": 59.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 80.0, 74.0, 74.0, 84.0, 81.0, 78.0, 78.0, 74.0, 83.0], "value": 78.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 134.0, 129.0, 129.0, 138.0, 123.0, 120.0, 119.0, 165.0, 120.0], "value": 130.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 157.0, 150.0, 152.0, 152.0, 155.0, 156.0, 152.0, 151.0, 152.0], "value": 152.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 61.0, 68.0, 65.0, 62.0, 64.0, 61.0, 63.0, 61.0, 61.0], "value": 62.9, "unit": "score"}], "name": "kraken", "value": 1455.5000000000002, "alertThreshold": 2.0}]} 12:04:04 INFO - Return code: 0 12:04:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:04:04 INFO - # TBPL SUCCESS # 12:04:04 INFO - Running post-action listener: _resource_record_post_action 12:04:04 INFO - [mozharness: 2017-01-18 20:04:04.625810Z] Finished run-tests step (success) 12:04:04 INFO - Running post-run listener: _resource_record_post_run 12:04:04 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 266240; Write bytes: 357277696; Read time: 28; Write time: 259064 12:04:04 INFO - TinderboxPrint: CPU usage
13.0% 12:04:04 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 28 12:04:04 INFO - TinderboxPrint: I/O write bytes / time
357,277,696 / 259,064 12:04:04 INFO - TinderboxPrint: CPU idle
8,276.6 (87.0%) 12:04:04 INFO - TinderboxPrint: CPU user
1,190.7 (12.5%) 12:04:04 INFO - TinderboxPrint: Swap in / out
0 / 0 12:04:04 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 108429312; Read time: 0; Write time: 96420 12:04:04 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 262144; Write bytes: 248422400; Read time: 20; Write time: 162520 12:04:05 INFO - Running post-run listener: _upload_blobber_files 12:04:05 INFO - Blob upload gear active. 12:04:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:04:05 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 12:04:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:04:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:04:05 INFO - (blobuploader) - INFO - Open directory for files ... 12:04:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:04:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:04:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:04:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:04:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:04:06 INFO - (blobuploader) - INFO - Done attempting. 12:04:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:04:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:04:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:04:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:04:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:04:09 INFO - (blobuploader) - INFO - Done attempting. 12:04:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:04:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:04:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:04:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:04:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:04:10 INFO - (blobuploader) - INFO - Done attempting. 12:04:10 INFO - (blobuploader) - INFO - Iteration through files over. 12:04:10 INFO - Return code: 0 12:04:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:04:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:04:10 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ef78a36f04459bbd8a0d5b5c62588515e490073a5c3d7f1e52461f3cae29561673b6ac44c64ca23279fb146f9e58e771d67e2c5328a2cc8fe517c3fa68777722", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/92a35d09eee21a4cf8b696cdbbacf91735a9461b41805cea0ffe6294af985afcca1313d37974903fce7be3feea96e758bcb2898968d0348ba219f52206c53860", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6e6a99b502ff2420b59ac6b1f034beea2cd7fcf324e4844b428e69a210252706b7b29da2117f891155864e11d105dad89c752aef2273e604a98af8484fbd46e2"} 12:04:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:04:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:04:10 INFO - Contents: 12:04:10 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ef78a36f04459bbd8a0d5b5c62588515e490073a5c3d7f1e52461f3cae29561673b6ac44c64ca23279fb146f9e58e771d67e2c5328a2cc8fe517c3fa68777722", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/92a35d09eee21a4cf8b696cdbbacf91735a9461b41805cea0ffe6294af985afcca1313d37974903fce7be3feea96e758bcb2898968d0348ba219f52206c53860", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6e6a99b502ff2420b59ac6b1f034beea2cd7fcf324e4844b428e69a210252706b7b29da2117f891155864e11d105dad89c752aef2273e604a98af8484fbd46e2"} 12:04:10 INFO - Running post-run listener: copy_logs_to_upload_dir 12:04:10 INFO - Copying logs to upload dir... 12:04:10 INFO - mkdir: /builds/slave/test/build/upload/logs 12:04:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.300947 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2017-01-18 12:04:10.327440) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-18 12:04:10.335039) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1484768612.785104-703188752 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ef78a36f04459bbd8a0d5b5c62588515e490073a5c3d7f1e52461f3cae29561673b6ac44c64ca23279fb146f9e58e771d67e2c5328a2cc8fe517c3fa68777722", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/92a35d09eee21a4cf8b696cdbbacf91735a9461b41805cea0ffe6294af985afcca1313d37974903fce7be3feea96e758bcb2898968d0348ba219f52206c53860", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6e6a99b502ff2420b59ac6b1f034beea2cd7fcf324e4844b428e69a210252706b7b29da2117f891155864e11d105dad89c752aef2273e604a98af8484fbd46e2"} build_url:https://queue.taskcluster.net/v1/task/HcCzxjHnQJmxOHktZ5vpAg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011474 build_url: 'https://queue.taskcluster.net/v1/task/HcCzxjHnQJmxOHktZ5vpAg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ef78a36f04459bbd8a0d5b5c62588515e490073a5c3d7f1e52461f3cae29561673b6ac44c64ca23279fb146f9e58e771d67e2c5328a2cc8fe517c3fa68777722", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/92a35d09eee21a4cf8b696cdbbacf91735a9461b41805cea0ffe6294af985afcca1313d37974903fce7be3feea96e758bcb2898968d0348ba219f52206c53860", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6e6a99b502ff2420b59ac6b1f034beea2cd7fcf324e4844b428e69a210252706b7b29da2117f891155864e11d105dad89c752aef2273e604a98af8484fbd46e2"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-18 12:04:10.360337) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-18 12:04:10.360692) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1484768612.785104-703188752 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004557 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-18 12:04:10.412378) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-18 12:04:10.412721) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-18 12:04:10.413019) ========= ========= Total master_lag: 0.15 =========