builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-045 starttime: 1481805903.95 results: success (0) buildid: 20161215030701 builduid: 8cf536eb5a134210bec7145866753b17 revision: ea07499d13936886f4b10455628a2f951798bf9c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-15 04:45:03.951624) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-15 04:45:03.952097) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-15 04:45:03.952593) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-15 04:45:03.991463) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-15 04:45:03.991778) ========= 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=4300f881736b422476174874000001bc-1481803713.780047-815925066 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-15 04:45:04-- 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% 40.5M=0s 2016-12-15 04:45:04 (40.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.119381 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-15 04:45:04.130228) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-15 04:45:04.130552) ========= 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=4300f881736b422476174874000001bc-1481803713.780047-815925066 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018882 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-15 04:45:04.180636) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-15 04:45:04.181027) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev ea07499d13936886f4b10455628a2f951798bf9c --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 ea07499d13936886f4b10455628a2f951798bf9c --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=4300f881736b422476174874000001bc-1481803713.780047-815925066 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-15 04:45:04,797 truncating revision to first 12 chars 2016-12-15 04:45:04,797 Setting DEBUG logging. 2016-12-15 04:45:04,797 attempt 1/10 2016-12-15 04:45:04,797 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/ea07499d1393?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-15 04:45:05,105 unpacking tar archive at: mozilla-aurora-ea07499d1393/testing/mozharness/ program finished with exit code 0 elapsedTime=0.667566 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-15 04:45:04.862275) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-15 04:45:04.862591) ========= script_repo_revision: ea07499d13936886f4b10455628a2f951798bf9c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-15 04:45:04.863037) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-15 04:45:04.863321) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-15 04:45:04.872711) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-12-15 04:45:04.873241) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=4300f881736b422476174874000001bc-1481803713.780047-815925066 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:45:05 INFO - MultiFileLogger online at 20161215 04:45:05 in /builds/slave/test 04:45:05 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 04:45:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:45:05 INFO - {'append_to_log': False, 04:45:05 INFO - 'base_work_dir': '/builds/slave/test', 04:45:05 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 04:45:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:45:05 INFO - 'branch': 'Mozilla-Aurora', 04:45:05 INFO - 'buildbot_json_path': 'buildprops.json', 04:45:05 INFO - 'config_files': ('talos/linux_config.py',), 04:45:05 INFO - 'default_actions': ('clobber', 04:45:05 INFO - 'read-buildbot-config', 04:45:05 INFO - 'download-and-extract', 04:45:05 INFO - 'populate-webroot', 04:45:05 INFO - 'create-virtualenv', 04:45:05 INFO - 'install', 04:45:05 INFO - 'run-tests'), 04:45:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:45:05 INFO - 'download_minidump_stackwalk': True, 04:45:05 INFO - 'download_symbols': 'ondemand', 04:45:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:45:05 INFO - 'tooltool.py': '/tools/tooltool.py', 04:45:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:45:05 INFO - '/tools/misc-python/virtualenv.py')}, 04:45:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:45:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:45:05 INFO - 'installer_path': 'installer.exe', 04:45:05 INFO - 'log_level': 'info', 04:45:05 INFO - 'log_name': 'talos', 04:45:05 INFO - 'log_to_console': True, 04:45:05 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:45:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:45:05 INFO - 'opt_config_files': (), 04:45:05 INFO - 'pip_index': False, 04:45:05 INFO - 'sps_profile': False, 04:45:05 INFO - 'sps_profile_interval': 0, 04:45:05 INFO - 'suite': 'dromaeojs-e10s', 04:45:05 INFO - 'system_bits': '32', 04:45:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:45:05 INFO - 'title': 'talos-linux64-ix-045', 04:45:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:45:05 INFO - 'use_talos_json': True, 04:45:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:45:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:45:05 INFO - 'work_dir': 'build'} 04:45:05 INFO - [mozharness: 2016-12-15 12:45:05.592960Z] Running clobber step. 04:45:05 INFO - Running pre-action listener: _resource_record_pre_action 04:45:05 INFO - Running main action method: clobber 04:45:05 INFO - rmtree: /builds/slave/test/build 04:45:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:45:06 INFO - Running post-action listener: _resource_record_post_action 04:45:06 INFO - [mozharness: 2016-12-15 12:45:06.574051Z] Finished clobber step (success) 04:45:06 INFO - [mozharness: 2016-12-15 12:45:06.574151Z] Running read-buildbot-config step. 04:45:06 INFO - Running pre-action listener: _resource_record_pre_action 04:45:06 INFO - Running main action method: read_buildbot_config 04:45:06 INFO - Using buildbot properties: 04:45:06 INFO - { 04:45:06 INFO - "project": "", 04:45:06 INFO - "product": "firefox", 04:45:06 INFO - "script_repo_revision": "production", 04:45:06 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 04:45:06 INFO - "repository": "", 04:45:06 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 04:45:06 INFO - "buildid": "20161215030701", 04:45:06 INFO - "pgo_build": "True", 04:45:06 INFO - "basedir": "/builds/slave/test", 04:45:06 INFO - "buildnumber": 753, 04:45:06 INFO - "slavename": "talos-linux64-ix-045", 04:45:06 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:45:06 INFO - "platform": "ubuntu64_hw", 04:45:06 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 04:45:06 INFO - "branch": "mozilla-aurora", 04:45:06 INFO - "repo_path": "releases/mozilla-aurora", 04:45:06 INFO - "revision": "ea07499d13936886f4b10455628a2f951798bf9c", 04:45:06 INFO - "stage_platform": "linux64-pgo", 04:45:06 INFO - "builduid": "8cf536eb5a134210bec7145866753b17", 04:45:06 INFO - "slavebuilddir": "test" 04:45:06 INFO - } 04:45:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/Quz9EPRcSIibvZdjhzxAZw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 04:45:06 INFO - Running post-action listener: _resource_record_post_action 04:45:06 INFO - [mozharness: 2016-12-15 12:45:06.576598Z] Finished read-buildbot-config step (success) 04:45:06 INFO - [mozharness: 2016-12-15 12:45:06.576686Z] Running download-and-extract step. 04:45:06 INFO - Running pre-action listener: _resource_record_pre_action 04:45:06 INFO - Running main action method: download_and_extract 04:45:06 INFO - mkdir: /builds/slave/test/build/tests 04:45:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:45:06 INFO - trying https://queue.taskcluster.net/v1/task/Quz9EPRcSIibvZdjhzxAZw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 04:45:06 INFO - Downloading https://queue.taskcluster.net/v1/task/Quz9EPRcSIibvZdjhzxAZw/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 04:45:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Quz9EPRcSIibvZdjhzxAZw/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 04:45:07 INFO - Downloaded 1361 bytes. 04:45:07 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 04:45:07 INFO - Using the following test package requirements: 04:45:07 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 04:45:07 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 04:45:07 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 04:45:07 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 04:45:07 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 04:45:07 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 04:45:07 INFO - u'jsshell-linux-x86_64.zip'], 04:45:07 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 04:45:07 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 04:45:07 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 04:45:07 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 04:45:07 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 04:45:07 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 04:45:07 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 04:45:07 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 04:45:07 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 04:45:07 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 04:45:07 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 04:45:07 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:45:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Quz9EPRcSIibvZdjhzxAZw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 04:45:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Quz9EPRcSIibvZdjhzxAZw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:45:07 INFO - Fetch https://queue.taskcluster.net/v1/task/Quz9EPRcSIibvZdjhzxAZw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 04:45:07 INFO - Http code: 200 04:45:07 INFO - via: 1.1 bb8a7ff26b131d51953dc2d3e19a2751.cloudfront.net (CloudFront) 04:45:07 INFO - x-amz-cf-id: Nt2e-hz_DWQMQiV3F867dZA3V0h2AgVoWpSSq9k1kIF1haz2UgbScg== 04:45:07 INFO - x-amz-version-id: emIFLUz2.m82EumU7tirjYS_rbtJDgQH 04:45:07 INFO - Expected file size: 21953604 04:45:07 INFO - Obtained file size: 21953604 04:45:12 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 04:45:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Quz9EPRcSIibvZdjhzxAZw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 04:45:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Quz9EPRcSIibvZdjhzxAZw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:45:12 INFO - Fetch https://queue.taskcluster.net/v1/task/Quz9EPRcSIibvZdjhzxAZw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 04:45:12 INFO - Http code: 200 04:45:12 INFO - via: 1.1 0cf1d7257c633ae75623c5e75bf3805e.cloudfront.net (CloudFront) 04:45:12 INFO - x-amz-cf-id: DHKxUr9B3j4FZIMu2mvr8V9-lPwLHPyF4VXmsyb9Y1pw2MPqVdWoIQ== 04:45:12 INFO - x-amz-version-id: emIFLUz2.m82EumU7tirjYS_rbtJDgQH 04:45:12 INFO - Expected file size: 21953604 04:45:12 INFO - Obtained file size: 21953604 04:45:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Quz9EPRcSIibvZdjhzxAZw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 04:45:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Quz9EPRcSIibvZdjhzxAZw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:45:17 INFO - Fetch https://queue.taskcluster.net/v1/task/Quz9EPRcSIibvZdjhzxAZw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 04:45:17 INFO - Http code: 200 04:45:17 INFO - via: 1.1 0302e8c462515ae281b72d9c815a5698.cloudfront.net (CloudFront) 04:45:17 INFO - x-amz-cf-id: N3aiyRe8yl5lFIkTge2IJMV-g2oW2csToDUEI545zCucYzEjCqEgJw== 04:45:17 INFO - x-amz-version-id: HEDlEuzGYrxPkfwRkfSlym_lLFkmrZCJ 04:45:18 INFO - Expected file size: 14409038 04:45:18 INFO - Obtained file size: 14409038 04:45:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:45:18 INFO - trying https://queue.taskcluster.net/v1/task/Quz9EPRcSIibvZdjhzxAZw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 04:45:18 INFO - Downloading https://queue.taskcluster.net/v1/task/Quz9EPRcSIibvZdjhzxAZw/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 04:45:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Quz9EPRcSIibvZdjhzxAZw/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 04:45:19 INFO - Downloaded 63981342 bytes. 04:45:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Quz9EPRcSIibvZdjhzxAZw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 04:45:19 INFO - mkdir: /builds/slave/test/properties 04:45:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:45:19 INFO - Writing to file /builds/slave/test/properties/build_url 04:45:19 INFO - Contents: 04:45:19 INFO - build_url:https://queue.taskcluster.net/v1/task/Quz9EPRcSIibvZdjhzxAZw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 04:45:19 INFO - Running post-action listener: _resource_record_post_action 04:45:19 INFO - Running post-action listener: set_extra_try_arguments 04:45:19 INFO - [mozharness: 2016-12-15 12:45:19.982865Z] Finished download-and-extract step (success) 04:45:19 INFO - [mozharness: 2016-12-15 12:45:19.983166Z] Running populate-webroot step. 04:45:19 INFO - Running pre-action listener: _resource_record_pre_action 04:45:19 INFO - Running main action method: populate_webroot 04:45:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:45:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:45:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:45:19 INFO - '--tppagecycles', 04:45:19 INFO - '7'], 04:45:19 INFO - 'tests': ['tsvgm']}}, 04:45:19 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:45:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:45:19 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:45:19 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:45:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:45:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:45:19 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:45:19 INFO - 'talos_options': ['--disable-e10s'], 04:45:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:45:19 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:45:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:45:19 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:45:19 INFO - 'talos_options': ['--disable-e10s'], 04:45:19 INFO - 'tests': ['damp', 'tps']}, 04:45:19 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:45:19 INFO - 'tests': ['damp', 'tps']}, 04:45:19 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:45:19 INFO - 'tests': ['dromaeo_dom']}, 04:45:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:45:19 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:45:19 INFO - 'tests': ['basic_compositor_video']}, 04:45:19 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:45:19 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:45:19 INFO - 'tests': ['a11yr', 04:45:19 INFO - 'ts_paint', 04:45:19 INFO - 'tpaint', 04:45:19 INFO - 'sessionrestore', 04:45:19 INFO - 'sessionrestore_no_auto_restore', 04:45:19 INFO - 'tabpaint']}, 04:45:19 INFO - 'other-e10s': {'tests': ['a11yr', 04:45:19 INFO - 'ts_paint', 04:45:19 INFO - 'tpaint', 04:45:19 INFO - 'sessionrestore', 04:45:19 INFO - 'sessionrestore_no_auto_restore', 04:45:19 INFO - 'tabpaint']}, 04:45:19 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:45:19 INFO - 'ts_paint', 04:45:19 INFO - 'tpaint', 04:45:19 INFO - 'sessionrestore', 04:45:19 INFO - 'sessionrestore_no_auto_restore', 04:45:19 INFO - 'tabpaint']}, 04:45:19 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:45:19 INFO - 'ts_paint', 04:45:19 INFO - 'tpaint', 04:45:19 INFO - 'sessionrestore', 04:45:19 INFO - 'sessionrestore_no_auto_restore', 04:45:19 INFO - 'tabpaint']}, 04:45:19 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:45:19 INFO - 'tests': ['a11yr', 04:45:19 INFO - 'ts_paint', 04:45:19 INFO - 'tpaint', 04:45:19 INFO - 'sessionrestore', 04:45:19 INFO - 'sessionrestore_no_auto_restore', 04:45:19 INFO - 'tabpaint']}, 04:45:20 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:45:20 INFO - 'tests': ['a11yr', 04:45:20 INFO - 'ts_paint', 04:45:20 INFO - 'tpaint', 04:45:20 INFO - 'sessionrestore', 04:45:20 INFO - 'sessionrestore_no_auto_restore', 04:45:20 INFO - 'tabpaint']}, 04:45:20 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:45:20 INFO - 'tests': ['tsvgx', 04:45:20 INFO - 'tsvgr_opacity', 04:45:20 INFO - 'tart', 04:45:20 INFO - 'tscrollx', 04:45:20 INFO - 'cart']}, 04:45:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:45:20 INFO - 'tsvgr_opacity', 04:45:20 INFO - 'tart', 04:45:20 INFO - 'tscrollx', 04:45:20 INFO - 'cart']}, 04:45:20 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:45:20 INFO - 'talos_options': ['--disable-e10s'], 04:45:20 INFO - 'tests': ['tp5o']}, 04:45:20 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:45:20 INFO - 'tests': ['tp5o']}, 04:45:20 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:45:20 INFO - 'talos_options': ['--disable-e10s', 04:45:20 INFO - '--xperf_path', 04:45:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:45:20 INFO - 'tests': ['tp5n']}, 04:45:20 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:45:20 INFO - 'talos_options': ['--xperf_path', 04:45:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:45:20 INFO - 'tests': ['tp5n']}}, 04:45:20 INFO - 'talos.zip': {'path': '', 04:45:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:45:20 INFO - Running post-action listener: _resource_record_post_action 04:45:20 INFO - [mozharness: 2016-12-15 12:45:20.002676Z] Finished populate-webroot step (success) 04:45:20 INFO - [mozharness: 2016-12-15 12:45:20.002770Z] Running create-virtualenv step. 04:45:20 INFO - Running pre-action listener: _resource_record_pre_action 04:45:20 INFO - Running main action method: create_virtualenv 04:45:20 INFO - Creating virtualenv /builds/slave/test/build/venv 04:45:20 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 04:45:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:45:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:45:20 INFO - Using real prefix '/usr' 04:45:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:45:20 INFO - Installing distribute.............................................................................................................................................................................................done. 04:45:22 INFO - Installing pip.................done. 04:45:22 INFO - Return code: 0 04:45:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:45:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:45:22 INFO - Reading from file tmpfile_stdout 04:45:22 INFO - Output received: 04:45:22 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) 04:45:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:45:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:45:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:45:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:22 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 0x7f13ff37cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d2b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1df8ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df5f60>, '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 0x1df6d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1df71d0>, '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': '4300f881736b422476174874000001bc-1481803713.780047-815925066', '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 04:45:22 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 04:45:22 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 04:45:22 INFO - Using env: {'DISPLAY': ':0', 04:45:22 INFO - 'HOME': '/home/cltbld', 04:45:22 INFO - 'LANG': 'en_US.UTF-8', 04:45:22 INFO - 'LANGUAGE': 'en_US:en', 04:45:22 INFO - 'LOGNAME': 'cltbld', 04:45:22 INFO - 'MAIL': '/var/mail/cltbld', 04:45:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:22 INFO - 'MOZ_NO_REMOTE': '1', 04:45:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:45:22 INFO - 'NO_EM_RESTART': '1', 04:45:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:45:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:22 INFO - 'PWD': '/builds/slave/test', 04:45:22 INFO - 'SHELL': '/bin/bash', 04:45:22 INFO - 'SHLVL': '1', 04:45:22 INFO - 'TERM': 'linux', 04:45:22 INFO - 'TMOUT': '86400', 04:45:22 INFO - 'USER': 'cltbld', 04:45:22 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1481803713.780047-815925066', 04:45:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:22 INFO - '_': '/tools/buildbot/bin/python'} 04:45:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:22 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 04:45:22 INFO - Cleaning up... 04:45:23 INFO - Return code: 0 04:45:23 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:45:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:45:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:45:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f13ff37cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d2b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1df8ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df5f60>, '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 0x1df6d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1df71d0>, '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': '4300f881736b422476174874000001bc-1481803713.780047-815925066', '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 04:45:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:45:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:45:23 INFO - Using env: {'DISPLAY': ':0', 04:45:23 INFO - 'HOME': '/home/cltbld', 04:45:23 INFO - 'LANG': 'en_US.UTF-8', 04:45:23 INFO - 'LANGUAGE': 'en_US:en', 04:45:23 INFO - 'LOGNAME': 'cltbld', 04:45:23 INFO - 'MAIL': '/var/mail/cltbld', 04:45:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:23 INFO - 'MOZ_NO_REMOTE': '1', 04:45:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:45:23 INFO - 'NO_EM_RESTART': '1', 04:45:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:45:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:23 INFO - 'PWD': '/builds/slave/test', 04:45:23 INFO - 'SHELL': '/bin/bash', 04:45:23 INFO - 'SHLVL': '1', 04:45:23 INFO - 'TERM': 'linux', 04:45:23 INFO - 'TMOUT': '86400', 04:45:23 INFO - 'USER': 'cltbld', 04:45:23 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1481803713.780047-815925066', 04:45:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:23 INFO - '_': '/tools/buildbot/bin/python'} 04:45:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:23 INFO - Downloading/unpacking psutil>=3.1.1 04:45:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:45:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:45:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:45:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:45:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:45:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:45:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:45:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:45:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:45:25 INFO - Installing collected packages: psutil 04:45:25 INFO - Running setup.py install for psutil 04:45:25 INFO - building 'psutil._psutil_linux' extension 04:45:25 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 04:45:25 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 04:45:25 INFO - building 'psutil._psutil_posix' extension 04:45:25 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 04:45:25 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 04:45:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:45:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:45:25 INFO - Successfully installed psutil 04:45:25 INFO - Cleaning up... 04:45:25 INFO - Return code: 0 04:45:25 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:45:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:45:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:45:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f13ff37cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d2b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1df8ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df5f60>, '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 0x1df6d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1df71d0>, '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': '4300f881736b422476174874000001bc-1481803713.780047-815925066', '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 04:45:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:45:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:45:25 INFO - Using env: {'DISPLAY': ':0', 04:45:25 INFO - 'HOME': '/home/cltbld', 04:45:25 INFO - 'LANG': 'en_US.UTF-8', 04:45:25 INFO - 'LANGUAGE': 'en_US:en', 04:45:25 INFO - 'LOGNAME': 'cltbld', 04:45:25 INFO - 'MAIL': '/var/mail/cltbld', 04:45:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:25 INFO - 'MOZ_NO_REMOTE': '1', 04:45:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:45:25 INFO - 'NO_EM_RESTART': '1', 04:45:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:45:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:25 INFO - 'PWD': '/builds/slave/test', 04:45:25 INFO - 'SHELL': '/bin/bash', 04:45:25 INFO - 'SHLVL': '1', 04:45:25 INFO - 'TERM': 'linux', 04:45:25 INFO - 'TMOUT': '86400', 04:45:25 INFO - 'USER': 'cltbld', 04:45:25 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1481803713.780047-815925066', 04:45:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:25 INFO - '_': '/tools/buildbot/bin/python'} 04:45:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:26 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:45:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:45:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:45:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:45:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:45:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:45:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:45:28 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:45:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:45:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:45:28 INFO - Installing collected packages: mozsystemmonitor 04:45:28 INFO - Running setup.py install for mozsystemmonitor 04:45:28 INFO - Successfully installed mozsystemmonitor 04:45:28 INFO - Cleaning up... 04:45:28 INFO - Return code: 0 04:45:28 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:45: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')]} 04:45:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45: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')]} 04:45:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f13ff37cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d2b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1df8ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df5f60>, '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 0x1df6d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1df71d0>, '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': '4300f881736b422476174874000001bc-1481803713.780047-815925066', '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 04:45:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:45:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:45:28 INFO - Using env: {'DISPLAY': ':0', 04:45:28 INFO - 'HOME': '/home/cltbld', 04:45:28 INFO - 'LANG': 'en_US.UTF-8', 04:45:28 INFO - 'LANGUAGE': 'en_US:en', 04:45:28 INFO - 'LOGNAME': 'cltbld', 04:45:28 INFO - 'MAIL': '/var/mail/cltbld', 04:45:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:28 INFO - 'MOZ_NO_REMOTE': '1', 04:45:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:45:28 INFO - 'NO_EM_RESTART': '1', 04:45:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:45:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:28 INFO - 'PWD': '/builds/slave/test', 04:45:28 INFO - 'SHELL': '/bin/bash', 04:45:28 INFO - 'SHLVL': '1', 04:45:28 INFO - 'TERM': 'linux', 04:45:28 INFO - 'TMOUT': '86400', 04:45:28 INFO - 'USER': 'cltbld', 04:45:28 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1481803713.780047-815925066', 04:45:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:28 INFO - '_': '/tools/buildbot/bin/python'} 04:45:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:28 INFO - Downloading/unpacking jsonschema==2.5.1 04:45:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:45:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:45:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:45:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:45:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:45:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:45:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:45:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:45:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:45:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:45:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:45:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:45:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:45:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:45:30 INFO - Downloading functools32-3.2.3-2.tar.gz 04:45:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:45:30 INFO - warning: no files found matching '*.txt' 04:45:30 INFO - no previously-included directories found matching 'build' 04:45:30 INFO - no previously-included directories found matching 'dist' 04:45:30 INFO - no previously-included directories found matching '.git*' 04:45:30 INFO - Installing collected packages: jsonschema, functools32 04:45:30 INFO - Running setup.py install for functools32 04:45:30 INFO - warning: no files found matching '*.txt' 04:45:30 INFO - no previously-included directories found matching 'build' 04:45:30 INFO - no previously-included directories found matching 'dist' 04:45:30 INFO - no previously-included directories found matching '.git*' 04:45:30 INFO - Successfully installed jsonschema functools32 04:45:30 INFO - Cleaning up... 04:45:30 INFO - Return code: 0 04:45:30 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:45:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:45:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:45:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f13ff37cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d2b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1df8ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df5f60>, '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 0x1df6d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1df71d0>, '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': '4300f881736b422476174874000001bc-1481803713.780047-815925066', '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 04:45:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:45:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:45:30 INFO - Using env: {'DISPLAY': ':0', 04:45:30 INFO - 'HOME': '/home/cltbld', 04:45:30 INFO - 'LANG': 'en_US.UTF-8', 04:45:30 INFO - 'LANGUAGE': 'en_US:en', 04:45:30 INFO - 'LOGNAME': 'cltbld', 04:45:30 INFO - 'MAIL': '/var/mail/cltbld', 04:45:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:30 INFO - 'MOZ_NO_REMOTE': '1', 04:45:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:45:30 INFO - 'NO_EM_RESTART': '1', 04:45:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:45:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:30 INFO - 'PWD': '/builds/slave/test', 04:45:30 INFO - 'SHELL': '/bin/bash', 04:45:30 INFO - 'SHLVL': '1', 04:45:30 INFO - 'TERM': 'linux', 04:45:30 INFO - 'TMOUT': '86400', 04:45:30 INFO - 'USER': 'cltbld', 04:45:30 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1481803713.780047-815925066', 04:45:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:30 INFO - '_': '/tools/buildbot/bin/python'} 04:45:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:31 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:45:31 INFO - Cleaning up... 04:45:31 INFO - Return code: 0 04:45:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:45:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:45:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:45:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:31 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 0x7f13ff37cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d2b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1df8ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df5f60>, '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 0x1df6d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1df71d0>, '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': '4300f881736b422476174874000001bc-1481803713.780047-815925066', '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 04:45:31 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 04:45:31 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 04:45:31 INFO - Using env: {'DISPLAY': ':0', 04:45:31 INFO - 'HOME': '/home/cltbld', 04:45:31 INFO - 'LANG': 'en_US.UTF-8', 04:45:31 INFO - 'LANGUAGE': 'en_US:en', 04:45:31 INFO - 'LOGNAME': 'cltbld', 04:45:31 INFO - 'MAIL': '/var/mail/cltbld', 04:45:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:31 INFO - 'MOZ_NO_REMOTE': '1', 04:45:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:45:31 INFO - 'NO_EM_RESTART': '1', 04:45:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:45:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:31 INFO - 'PWD': '/builds/slave/test', 04:45:31 INFO - 'SHELL': '/bin/bash', 04:45:31 INFO - 'SHLVL': '1', 04:45:31 INFO - 'TERM': 'linux', 04:45:31 INFO - 'TMOUT': '86400', 04:45:31 INFO - 'USER': 'cltbld', 04:45:31 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1481803713.780047-815925066', 04:45:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:31 INFO - '_': '/tools/buildbot/bin/python'} 04:45:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:31 INFO - Downloading/unpacking blobuploader==1.2.4 04:45:31 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 04:45:31 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 04:45:31 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 04:45:31 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 04:45:31 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 04:45:31 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 04:45:33 INFO - Downloading blobuploader-1.2.4.tar.gz 04:45:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:45:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:45:33 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 04:45:33 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 04:45:33 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 04:45:33 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 04:45:33 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 04:45:33 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 04:45:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:45:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:45:33 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 04:45:33 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 04:45:33 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 04:45:33 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 04:45:33 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 04:45:33 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 04:45:34 INFO - Downloading docopt-0.6.1.tar.gz 04:45:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:45:34 INFO - Installing collected packages: blobuploader, requests, docopt 04:45:34 INFO - Running setup.py install for blobuploader 04:45:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:45:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:45:34 INFO - Running setup.py install for requests 04:45:34 INFO - Running setup.py install for docopt 04:45:34 INFO - Successfully installed blobuploader requests docopt 04:45:34 INFO - Cleaning up... 04:45:34 INFO - Return code: 0 04:45:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:45:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:45:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:45:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:34 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 0x7f13ff37cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d2b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1df8ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df5f60>, '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 0x1df6d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1df71d0>, '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': '4300f881736b422476174874000001bc-1481803713.780047-815925066', '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 04:45:34 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 04:45:34 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 04:45:34 INFO - Using env: {'DISPLAY': ':0', 04:45:34 INFO - 'HOME': '/home/cltbld', 04:45:34 INFO - 'LANG': 'en_US.UTF-8', 04:45:34 INFO - 'LANGUAGE': 'en_US:en', 04:45:34 INFO - 'LOGNAME': 'cltbld', 04:45:34 INFO - 'MAIL': '/var/mail/cltbld', 04:45:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:34 INFO - 'MOZ_NO_REMOTE': '1', 04:45:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:45:34 INFO - 'NO_EM_RESTART': '1', 04:45:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:45:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:34 INFO - 'PWD': '/builds/slave/test', 04:45:34 INFO - 'SHELL': '/bin/bash', 04:45:34 INFO - 'SHLVL': '1', 04:45:34 INFO - 'TERM': 'linux', 04:45:34 INFO - 'TMOUT': '86400', 04:45:34 INFO - 'USER': 'cltbld', 04:45:34 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1481803713.780047-815925066', 04:45:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:34 INFO - '_': '/tools/buildbot/bin/python'} 04:45:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:45:35 INFO - Running setup.py (path:/tmp/pip-WjQXkH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:45:35 INFO - Running setup.py (path:/tmp/pip-6w2L6f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:45:35 INFO - Running setup.py (path:/tmp/pip-rX85Jm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:45:35 INFO - Running setup.py (path:/tmp/pip-0Fc5_u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:45:35 INFO - Running setup.py (path:/tmp/pip-dZsdf0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:45:35 INFO - Running setup.py (path:/tmp/pip-x50_vk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:45:35 INFO - Running setup.py (path:/tmp/pip-uH6TqU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:45:35 INFO - Running setup.py (path:/tmp/pip-OdYOhC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:45:35 INFO - Running setup.py (path:/tmp/pip-0rZqIC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:45:35 INFO - Running setup.py (path:/tmp/pip-CePmH0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:45:35 INFO - Running setup.py (path:/tmp/pip-P5DO7J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:45:35 INFO - Running setup.py (path:/tmp/pip-hqhjSI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:45:35 INFO - Running setup.py (path:/tmp/pip-bRpyBX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:45:35 INFO - Running setup.py (path:/tmp/pip-wKfClE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:45:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:45:36 INFO - Running setup.py (path:/tmp/pip-rxY3rc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:45:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:45:36 INFO - Running setup.py (path:/tmp/pip-A75cMy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:45:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:45:36 INFO - Running setup.py (path:/tmp/pip-7mlAFj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:45:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:45:36 INFO - Running setup.py install for manifestparser 04:45:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:45:36 INFO - Running setup.py install for mozcrash 04:45:36 INFO - Running setup.py install for mozdebug 04:45:36 INFO - Running setup.py install for mozdevice 04:45:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:45:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:45:36 INFO - Running setup.py install for mozfile 04:45:36 INFO - Running setup.py install for mozhttpd 04:45:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:45:36 INFO - Running setup.py install for mozinfo 04:45:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:45:36 INFO - Running setup.py install for mozInstall 04:45:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:45:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:45:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:45:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:45:37 INFO - Running setup.py install for mozleak 04:45:37 INFO - Running setup.py install for mozlog 04:45:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:45:37 INFO - Running setup.py install for moznetwork 04:45:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:45:37 INFO - Running setup.py install for mozprocess 04:45:37 INFO - Running setup.py install for mozprofile 04:45:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:45:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:45:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:45:37 INFO - Running setup.py install for mozrunner 04:45:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:45:37 INFO - Running setup.py install for mozscreenshot 04:45:37 INFO - Running setup.py install for moztest 04:45:37 INFO - Running setup.py install for mozversion 04:45:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:45:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:45:38 INFO - Cleaning up... 04:45:38 INFO - Return code: 0 04:45:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:45:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:45:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:45:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:38 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 0x7f13ff37cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d2b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1df8ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df5f60>, '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 0x1df6d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1df71d0>, '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': '4300f881736b422476174874000001bc-1481803713.780047-815925066', '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 04:45:38 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 04:45:38 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 04:45:38 INFO - Using env: {'DISPLAY': ':0', 04:45:38 INFO - 'HOME': '/home/cltbld', 04:45:38 INFO - 'LANG': 'en_US.UTF-8', 04:45:38 INFO - 'LANGUAGE': 'en_US:en', 04:45:38 INFO - 'LOGNAME': 'cltbld', 04:45:38 INFO - 'MAIL': '/var/mail/cltbld', 04:45:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:38 INFO - 'MOZ_NO_REMOTE': '1', 04:45:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:45:38 INFO - 'NO_EM_RESTART': '1', 04:45:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:45:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:38 INFO - 'PWD': '/builds/slave/test', 04:45:38 INFO - 'SHELL': '/bin/bash', 04:45:38 INFO - 'SHLVL': '1', 04:45:38 INFO - 'TERM': 'linux', 04:45:38 INFO - 'TMOUT': '86400', 04:45:38 INFO - 'USER': 'cltbld', 04:45:38 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1481803713.780047-815925066', 04:45:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:38 INFO - '_': '/tools/buildbot/bin/python'} 04:45:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:45:38 INFO - Running setup.py (path:/tmp/pip-S2BleF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:45:38 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)) 04:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:45:38 INFO - Running setup.py (path:/tmp/pip-5xQFjt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:45:38 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)) 04:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:45:38 INFO - Running setup.py (path:/tmp/pip-cQ1Jzz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:45:38 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)) 04:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:45:38 INFO - Running setup.py (path:/tmp/pip-bzdVyG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:45:38 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)) 04:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:45:38 INFO - Running setup.py (path:/tmp/pip-DJ2HFK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:45:38 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)) 04:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:45:38 INFO - Running setup.py (path:/tmp/pip-BR4qA0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:45:38 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)) 04:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:45:38 INFO - Running setup.py (path:/tmp/pip-1NJD3R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:45:38 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)) 04:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:45:38 INFO - Running setup.py (path:/tmp/pip-LpEJBD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:45:38 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)) 04:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:45:38 INFO - Running setup.py (path:/tmp/pip-vhdNXB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:45:39 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)) 04:45:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:45:39 INFO - Running setup.py (path:/tmp/pip-CBbYqN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:45:39 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)) 04:45:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:45:39 INFO - Running setup.py (path:/tmp/pip-3yaZsm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:45:39 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)) 04:45:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:45:39 INFO - Running setup.py (path:/tmp/pip-62eZXd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:45:39 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)) 04:45:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:45:39 INFO - Running setup.py (path:/tmp/pip-DM1Ys5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:45:39 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)) 04:45:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:45:39 INFO - Running setup.py (path:/tmp/pip-1GS2h_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:45:39 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)) 04:45:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:45:39 INFO - Running setup.py (path:/tmp/pip-6kgGPn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:45:39 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)) 04:45:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:45:39 INFO - Running setup.py (path:/tmp/pip-gwNDfQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:45:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:45:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:45:39 INFO - Running setup.py (path:/tmp/pip-DNkVHj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:45:39 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)) 04:45:39 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)) 04:45:39 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)) 04:45:39 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)) 04:45:39 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)) 04:45:39 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)) 04:45:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:45:39 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 04:45:39 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 04:45:39 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 04:45:39 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 04:45:39 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 04:45:39 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 04:45:41 INFO - Downloading blessings-1.6.tar.gz 04:45:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:45:41 INFO - Installing collected packages: blessings 04:45:41 INFO - Running setup.py install for blessings 04:45:41 INFO - Successfully installed blessings 04:45:41 INFO - Cleaning up... 04:45:41 INFO - Return code: 0 04:45:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:45:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:45:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:45:42 INFO - Reading from file tmpfile_stdout 04:45:42 INFO - Current package versions: 04:45:42 INFO - argparse == 1.2.1 04:45:42 INFO - blessings == 1.6 04:45:42 INFO - blobuploader == 1.2.4 04:45:42 INFO - docopt == 0.6.1 04:45:42 INFO - functools32 == 3.2.3-2 04:45:42 INFO - jsonschema == 2.5.1 04:45:42 INFO - manifestparser == 1.1 04:45:42 INFO - mozInstall == 1.12 04:45:42 INFO - mozcrash == 1.0 04:45:42 INFO - mozdebug == 0.1 04:45:42 INFO - mozdevice == 0.48 04:45:42 INFO - mozfile == 1.2 04:45:42 INFO - mozhttpd == 0.7 04:45:42 INFO - mozinfo == 0.9 04:45:42 INFO - mozleak == 0.1 04:45:42 INFO - mozlog == 3.4 04:45:42 INFO - moznetwork == 0.27 04:45:42 INFO - mozprocess == 0.23 04:45:42 INFO - mozprofile == 0.28 04:45:42 INFO - mozrunner == 6.13 04:45:42 INFO - mozscreenshot == 0.1 04:45:42 INFO - mozsystemmonitor == 0.3 04:45:42 INFO - moztest == 0.7 04:45:42 INFO - mozversion == 1.4 04:45:42 INFO - psutil == 3.1.1 04:45:42 INFO - requests == 1.2.3 04:45:42 INFO - wsgiref == 0.1.2 04:45:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:45:42 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')]} 04:45:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:42 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')]} 04:45:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:42 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 0x7f13ff37cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d2b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1df8ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df5f60>, '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 0x1df6d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1df71d0>, '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': '4300f881736b422476174874000001bc-1481803713.780047-815925066', '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 04:45:42 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 04:45:42 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 04:45:42 INFO - Using env: {'DISPLAY': ':0', 04:45:42 INFO - 'HOME': '/home/cltbld', 04:45:42 INFO - 'LANG': 'en_US.UTF-8', 04:45:42 INFO - 'LANGUAGE': 'en_US:en', 04:45:42 INFO - 'LOGNAME': 'cltbld', 04:45:42 INFO - 'MAIL': '/var/mail/cltbld', 04:45:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:42 INFO - 'MOZ_NO_REMOTE': '1', 04:45:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:45:42 INFO - 'NO_EM_RESTART': '1', 04:45:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:45:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:42 INFO - 'PWD': '/builds/slave/test', 04:45:42 INFO - 'SHELL': '/bin/bash', 04:45:42 INFO - 'SHLVL': '1', 04:45:42 INFO - 'TERM': 'linux', 04:45:42 INFO - 'TMOUT': '86400', 04:45:42 INFO - 'USER': 'cltbld', 04:45:42 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1481803713.780047-815925066', 04:45:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:42 INFO - '_': '/tools/buildbot/bin/python'} 04:45:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:42 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)) 04:45:42 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)) 04:45:42 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)) 04:45:42 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)) 04:45:42 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)) 04:45:42 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)) 04:45:42 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)) 04:45:42 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)) 04:45:42 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)) 04:45:42 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)) 04:45:42 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)) 04:45:42 INFO - Cleaning up... 04:45:42 INFO - Return code: 0 04:45:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:45:42 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')]} 04:45:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:42 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')]} 04:45:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:42 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 0x7f13ff37cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d2b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1df8ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df5f60>, '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 0x1df6d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1df71d0>, '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': '4300f881736b422476174874000001bc-1481803713.780047-815925066', '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 04:45:42 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 04:45:42 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 04:45:42 INFO - Using env: {'DISPLAY': ':0', 04:45:42 INFO - 'HOME': '/home/cltbld', 04:45:42 INFO - 'LANG': 'en_US.UTF-8', 04:45:42 INFO - 'LANGUAGE': 'en_US:en', 04:45:42 INFO - 'LOGNAME': 'cltbld', 04:45:42 INFO - 'MAIL': '/var/mail/cltbld', 04:45:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:42 INFO - 'MOZ_NO_REMOTE': '1', 04:45:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:45:42 INFO - 'NO_EM_RESTART': '1', 04:45:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:45:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:42 INFO - 'PWD': '/builds/slave/test', 04:45:42 INFO - 'SHELL': '/bin/bash', 04:45:42 INFO - 'SHLVL': '1', 04:45:42 INFO - 'TERM': 'linux', 04:45:42 INFO - 'TMOUT': '86400', 04:45:42 INFO - 'USER': 'cltbld', 04:45:42 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1481803713.780047-815925066', 04:45:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:42 INFO - '_': '/tools/buildbot/bin/python'} 04:45:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:45:42 INFO - Cleaning up... 04:45:42 INFO - Return code: 0 04:45:42 INFO - Running post-action listener: _resource_record_post_action 04:45:42 INFO - Running post-action listener: _start_resource_monitoring 04:45:42 INFO - Starting resource monitoring. 04:45:42 INFO - [mozharness: 2016-12-15 12:45:42.547423Z] Finished create-virtualenv step (success) 04:45:42 INFO - [mozharness: 2016-12-15 12:45:42.547883Z] Running install step. 04:45:42 INFO - Running pre-action listener: _resource_record_pre_action 04:45:42 INFO - Running main action method: install 04:45:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:45:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:45:42 INFO - Reading from file tmpfile_stdout 04:45:42 INFO - Detecting whether we're running mozinstall >=1.0... 04:45:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:45:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:45:42 INFO - Reading from file tmpfile_stdout 04:45:42 INFO - Output received: 04:45:42 INFO - Usage: mozinstall [options] installer 04:45:42 INFO - Options: 04:45:42 INFO - -h, --help show this help message and exit 04:45:42 INFO - -d DEST, --destination=DEST 04:45:42 INFO - Directory to install application into. [default: 04:45:42 INFO - "/builds/slave/test"] 04:45:42 INFO - --app=APP Application being installed. [default: firefox] 04:45:42 INFO - mkdir: /builds/slave/test/build/application 04:45:42 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'] 04:45:42 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 04:45:58 INFO - Reading from file tmpfile_stdout 04:45:58 INFO - Output received: 04:45:58 INFO - /builds/slave/test/build/application/firefox/firefox 04:45:58 INFO - Running post-action listener: _resource_record_post_action 04:45:58 INFO - [mozharness: 2016-12-15 12:45:58.751504Z] Finished install step (success) 04:45:58 INFO - [mozharness: 2016-12-15 12:45:58.751747Z] Running run-tests step. 04:45:58 INFO - Running pre-action listener: _resource_record_pre_action 04:45:58 INFO - Running main action method: run_tests 04:45:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:45:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:45:58 INFO - Python 2.7.3 04:45:58 INFO - Return code: 0 04:45:58 INFO - grabbing minidump binary from tooltool 04:45:58 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')]} 04:45:58 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 0x1df5f60>, '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 0x1df6d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1df71d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:45:58 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 04:45:58 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 04:45:58 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 04:45:58 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:45:58 INFO - Return code: 0 04:45:58 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:45:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:45:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:45:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:45:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:45:58 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Quz9EPRcSIibvZdjhzxAZw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 04:45:58 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Quz9EPRcSIibvZdjhzxAZw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-045 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 04:45:58 INFO - Using env: {'DISPLAY': ':0', 04:45:58 INFO - 'HOME': '/home/cltbld', 04:45:58 INFO - 'LANG': 'en_US.UTF-8', 04:45:58 INFO - 'LANGUAGE': 'en_US:en', 04:45:58 INFO - 'LOGNAME': 'cltbld', 04:45:58 INFO - 'MAIL': '/var/mail/cltbld', 04:45:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:45:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:45:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:58 INFO - 'MOZ_NO_REMOTE': '1', 04:45:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:45:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:45:58 INFO - 'NO_EM_RESTART': '1', 04:45:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:45:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:58 INFO - 'PWD': '/builds/slave/test', 04:45:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:45:58 INFO - 'SHELL': '/bin/bash', 04:45:58 INFO - 'SHLVL': '1', 04:45:58 INFO - 'TERM': 'linux', 04:45:58 INFO - 'TMOUT': '86400', 04:45:58 INFO - 'USER': 'cltbld', 04:45:58 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1481803713.780047-815925066', 04:45:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:58 INFO - '_': '/tools/buildbot/bin/python'} 04:45:58 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Quz9EPRcSIibvZdjhzxAZw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 04:45:59 INFO - mozversion application_buildid: 20161215030701 04:45:59 INFO - mozversion application_changeset: ea07499d13936886f4b10455628a2f951798bf9c 04:45:59 INFO - mozversion application_display_name: FirefoxDeveloperEdition 04:45:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:45:59 INFO - mozversion application_name: Firefox 04:45:59 INFO - mozversion application_remotingname: firefox-dev 04:45:59 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:45:59 INFO - mozversion application_vendor: Mozilla 04:45:59 INFO - mozversion application_version: 52.0a2 04:45:59 INFO - mozversion platform_buildid: 20161215030701 04:45:59 INFO - mozversion platform_changeset: ea07499d13936886f4b10455628a2f951798bf9c 04:45:59 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:45:59 INFO - mozversion platform_version: 52.0a2 04:45:59 INFO - using testdate: 1481805959 04:45:59 INFO - actual date: 1481805959 04:45:59 INFO - starting webserver on 'localhost:44739' 04:45:59 INFO - SUITE-START | Running 2 tests 04:45:59 INFO - TEST-START | dromaeo_css 04:45:59 INFO - operating with platform_type : linux_ 04:45:59 INFO - Initialising browser for dromaeo_css test... 04:45:59 INFO - TEST-INFO | started process 18344 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkpGfBY/profile http://localhost:44739/getInfo.html) 04:46:03 INFO - PROCESS | 18344 | __metrics Screen width/height:1600/1200 04:46:03 INFO - PROCESS | 18344 | colorDepth:24 04:46:03 INFO - PROCESS | 18344 | Browser inner width/height: 1024/697 04:46:03 INFO - PROCESS | 18344 | __metrics 04:46:04 ERROR - PROCESS | 18344 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 04:46:04 INFO - TEST-INFO | 18344: exit 0 04:46:04 INFO - Browser initialized. 04:46:04 INFO - Running cycle 1/1 for dromaeo_css test... 04:46:04 INFO - TEST-INFO | started process 18475 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkpGfBY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:46:16 INFO - PROCESS | 18475 | RSS: Main: 151654400 04:46:16 INFO - PROCESS | 18475 | 04:47:06 INFO - PROCESS | 18475 | 1481806026401 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:49:17 INFO - PROCESS | 18475 | Cycle 1(1): loaded http://localhost:44739/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44739/tests/dromaeo/cssquery-ext.html) 04:49:18 INFO - PROCESS | 18475 | RSS: Main: 155869184 04:49:18 INFO - PROCESS | 18475 | 04:52:20 INFO - PROCESS | 18475 | Cycle 1(1): loaded http://localhost:44739/tests/dromaeo/cssquery-ext.html (next: http://localhost:44739/tests/dromaeo/cssquery-jquery.html) 04:52:21 INFO - PROCESS | 18475 | RSS: Main: 153182208 04:52:21 INFO - PROCESS | 18475 | 04:55:23 INFO - PROCESS | 18475 | Cycle 1(1): loaded http://localhost:44739/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44739/tests/dromaeo/cssquery-mootools.html) 04:55:23 INFO - PROCESS | 18475 | RSS: Main: 153227264 04:55:23 INFO - PROCESS | 18475 | 04:58:25 INFO - PROCESS | 18475 | Cycle 1(1): loaded http://localhost:44739/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44739/tests/dromaeo/cssquery-prototype.html) 04:58:26 INFO - PROCESS | 18475 | RSS: Main: 151003136 04:58:26 INFO - PROCESS | 18475 | 05:01:28 INFO - PROCESS | 18475 | Cycle 1(1): loaded http://localhost:44739/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44739/tests/dromaeo/cssquery-yui.html) 05:01:29 INFO - PROCESS | 18475 | RSS: Main: 154497024 05:01:29 INFO - PROCESS | 18475 | 05:04:31 INFO - PROCESS | 18475 | Cycle 1(1): loaded http://localhost:44739/tests/dromaeo/cssquery-yui.html (next: http://localhost:44739/tests/dromaeo/cssquery-dojo.html) 05:04:31 INFO - PROCESS | 18475 | RSS: Main: 154607616 05:04:31 INFO - PROCESS | 18475 | 05:04:31 INFO - PROCESS | 18475 | __start_tp_report 05:04:31 INFO - PROCESS | 18475 | _x_x_mozilla_page_load 05:04:31 INFO - PROCESS | 18475 | _x_x_mozilla_page_load_details 05:04:31 INFO - PROCESS | 18475 | |i|pagename|runs| 05:04:31 INFO - PROCESS | 18475 | |0;dojo.html;3246.4643333849917;3248.707616314532;3253.495708165235;3292.967070329297;3305.6033276006883;5729.169270455786;5779.913301300484;5795.4784069433745;5797;5799.971000144993;5725.169850371693;5821.097729851869;5831.533477321815;5839.445252700986;5850.385709500494;5284.762185701643;5296.470352964711;5328.040952628526;5340;5358.571314294866;5353.250544923714;5367.221752845854;5372.785088596452;5377.865553361177;5391.191321301797;5139.614528910347;5158.690478571298;5350.5452036576935;5358.678479291255;5371.57027437804;5188;5225.242339860699;5233.581313494911;5269.7365131743645;5351.331083614548;5235.947640523622;5250.264962905197;5314.707691076989;5318.547923426513;5322.866928326784;5757.798477053325;5769.624974376694;5786.132080187964;5839.9124013139835;5856.853578660525;6076.149339092531;6099.634021958653;6116.274903966718;6178.196834411543;6189.969050154766;6198.659073750942;6219.689015549205;6251.562390632657;6256.405641464099;6266.937330626681;5620.437956204347;5668.376478587352;5835.387284335126;5843.152742852262;5886.676232807194;6189.783357582463;6198.690065496708;6225.159603453476;6324.3991820776955;6333.334999825044;6065.60573562717;6068.4538391544975;6075.635461872302;6078.209832721718;6100.969495152496;6166.876662466815;6188.2883468400805;6191.102290167901;6197.628142311476;6201.162843016135;5789.565782566325;5880.411958804086;6029.879402411927;6032.728527216286;6076.969615151896;6142.877142457215;6151.630902145886;6153.046277826855;6153.353897840751;6158.199434073542;4671.813127474931;4713.410823647044;4717.551832575899;4725.40932383452;4747.738874361874;4055.8174882130374;4101.241270364992;4113.835446582163;4125.608067233608;4185.079282557833;5774.942250577525;5788.82633520995;5790.884182316414;5791.305043394819;5873.941260587425;5969.253843269591;6137.294211165684;6157.168782214344;6182.938170618326;6184.165137706352;5621.381648018714;5713.22871412354;5733.741981610754;5737.885242295214;5834.474897259267;5245.868853278698;5252.474752524717;5265.789368425297;5277.419483856773;5277.788888444496;6247.875042499125;6282.371762823773;6304.085907543381;6336.112944187726;6339;5967.4629283362965;6015.428534289235;6079.544034197541;6103;6113.388661134029;6258.3741625838875;6289.245290565162;6304.464120549805;6306.558540902276;6309.873802523832;6031.577789554689;6107.969460152671;6110.602810817282;6123.112148738319;6129.387061293835;5965.224520812267;6029.246344206974;6091.604045737013;6104.114903338902;6195.659238741912;5999.250093738283;6019.4883434908525;6020.909686354796;6030.1256317832795;6043.184170136975;6015.037593984942;6029.276486821609;6035.969820150871;6045.244344456943;6064.787732429344;5751.1085781703905;5798.623089499169;5859.179714840011;5979.880402392015;5992.970035149797;5990.7004649768205;6036.456718895321;6069.969650151721;6080.787172448943;6094.969525152346;5876.236089308362;5893.292804863272;5897;5906.7341969612335;5930.169776231245 05:04:31 INFO - PROCESS | 18475 | |1;ext.html;615.9599626024309;619.4270299972526;660.1319265166309;670.1020632352646;689.6138162628926;41902.952426189324;44835.10329793406;45246.547534524645;45443.54556454434;45467;45320.32019519702;45646.7717661412;45962.54037459625;46001;46016;8706.782330441727;8865.202131808135;8901.24339431146;8940.418872773249;8948.194662480375;8722.563871806384;8822.735317940473;8857.379983401132;8862.60118294675;8867.73396798097;8835.95582022089;8841.204291613754;8930.642774289021;8931.64273429062;8942.597583108776;8863;8866.290696744245;8885.244754195868;8897.110288971051;8920.732378028637;8802.779930501789;8849.336299777542;8860;8861.86707199386;8862.778430539223;43305.78347108276;43530;43776;43778.562214378086;43866;3804.4863943367845;3834.3673293906472;3842.1931394407206;3901.6293452122004;3917.5494818096;33197.83401083003;33315.55147846969;33491.832540837386;34008;34603.65396346054;4253.723507972003;4353.325234588644;4373.387725718402;4400.867973960786;4447.043885564619;255034;257092.99999999814;257306;257678;258211;64449.67775161188;64487;64488.67755661192;64522;64584.35415645877;65431.67284163549;65448.672756636865;65552;65649.67175164094;65883.67058164679;17614.2073606688;17740.733888991675;17848.107594620476;17863.464096076877;17933.461996140137;13476.797848032287;13516.391762370717;13519.256440895648;13535.661608459868;13545.1195672281;18307.617795613514;18432.894026358194;18450.07749612514;18623.720644190347;18686.5050795936;6753.696083676246;6797.592144471348;6867.793966181022;6946.93053069473;7102.585121058864;930.1953809954341;964.4358050540372;1047.1151876664208;1154.32472003877;1167.9299242045504;34015.31969360599;34127.48808767871;34165.31669366599;34392.484112738326;34805;1125.3023125661978;1140.663504266227;1148.6783700563856;1169.3276366089533;1247.1955588645455;17490.387836425918;17631.91184044097;17845.910770446324;17847.910760446113;17908.91045544764;493850;499007;500600;501117;501341;63297.36702633007;63561.36438635555;63667;63680.36319636837;63826.68086659537;1399.6081097292774;1430.2991534148193;1458.4603696632103;1460.0655580428322;1471.0952764050032;32331.51502727508;33448.66551334455;33619;33994.83002584971;34146.48780268348;56231;59345.70327148337;60896.39103608907;61253.38746612477;66205.66897165483;433183;437086;437829;438605;439851;30178.849105754332;30181.547276790425;30440.543391848696;30520.389592208474;30744.231394215323;49412.50587494223;49962.25056624081;50092.499075010244;51000.48999510106;51322;42358;42492.362614561425;42844;43194.35208471938;44261.557384425745;42180;43296.56703433051;43999;44026.484031831984;44097.55902440935;44046.77976610096;44278.55721442744;44736.10527789491;44895.55104448914;47338.763306183246;37778;38353.23293534169;38636.80681596574;38686.613133868304;39242.411363830135;29527.704722952494;29866.10401687953;29992.25019374533;30122.3975520484;30504.84747576248 05:04:31 INFO - PROCESS | 18475 | |2;jquery.html;400.7935913004801;408.872432790975;412.8101073506187;420.4450125833899;433.96962212645127;18652.62694746104;19693.50766230845;20223.39329820104;20247.797522024775;20420;18535.629287414242;19121.52196195096;19198;19917.601647967032;20125.396238112844;5369.9463005370035;5711.685857277848;5714.885702285952;5730.828075157731;5764.740586673589;5530.336359636849;5661.094224924013;5736.139579063132;5736.368999410061;5741.937741517811;5635.239242702224;5683.204351390808;5685.772569097252;5690.174924635925;5699.601027928046;5455.863603409907;5632.943670563324;5635.351934527541;5646;5671.546276297886;5055.646104772667;5079.187330027178;5112.539871411554;5112.616553758446;5115.437301896788;23645.645315320286;25642.102526411487;26098;26514.867425662942;26713;2603.1799983005294;2626.4090579619624;2638.8416694998364;2650.363912660967;2854.4291141771523;15762.684746305124;16230.837691623168;16973.745393819103;17086.145692715316;17366.479005629724;2046.2019812273224;2112.1129125767216;2113.926012589552;2135.284679632325;2141.1435425829636;104373.47813260886;105762.47118764433;109299.1745288911;110602.9999999992;110680.4465977665;18269.360572379905;18878.96165710899;19270;20344.38966830968;20643.27748528794;33719.15702107467;33789.32421351608;34005.829970850486;34128.658713413046;34354;9946.701598952042;9948.104670579538;9951.950240248752;10189.592416303412;10199.13307368867;8179.550124743197;8253.380996425292;8258;8307.37694672902;8418.789530261793;9024.819503610022;9180.770480737901;9272.67545635913;9328.860067098998;9588.280878934107;3379.678930501598;3471.5486986691567;3511.4030614795547;3515.191505953645;3627.9637203627626;989.3074847606704;1030.9278350515392;1034.2966782587912;1070.5075665194097;1081.8701755789198;18590.628187436174;19443.902780486005;20236.291729789387;20500.17999280042;20726.792732072787;982.4056445850158;1028.5782829040058;1044.8119338519139;1076.9892301076889;1124.9212555121226;10797.784044319227;11370.204085714086;11456.656300310837;11466.48400821965;11468.082553395709;390094;490711;510266;514668;524607;89017.55491222632;92871;97524.51237743766;101874;102868;1053.5733028123623;1077.5851297250458;1094.4746521669483;1096.1614365010773;1096.923215374932;18091.36680216239;18161.27354905842;18467;18488;18511.629767404847;42486;43434.34848477212;43650.34524482199;43905.902352441444;44627;63648.36351636425;63725;64766.35233647603;64801;64998.67500662467;8724.69463568772;8829.293656507336;8871.512066836385;8941.418807777734;8973.237274831452;11238.098076321228;13742.519011834538;13809.447622095004;13840.93079534596;14130.081544699562;12099.395030248628;12132.818007730068;12189;12380.876191237972;12419.379031048593;11708.648740537797;11767.882321177021;11951.163418560618;11976.28142311464;12239.571614993432;12120.151589388659;12187.939060304641;12210.328431936328;12355.75288494243;12380.690482737644;8778.51718155482;8817.823643527221;8849.955750221208;8965.596548155218;9041.00548939603;6689.732410703517;9018.864717029119;11229.540159779177;12197.756044878875;12234.877651223374 05:04:31 INFO - PROCESS | 18475 | |3;mootools.html;1524.5045360257916;1551.123615157436;1731.4805558332505;1812.2207450796152;1829.9752138802264;7966.60166991651;8190.8771368429525;8477.830443391136;9054.818903621923;9056.366054376196;8421.494710317385;8634.784130396743;8672.826543469128;8815.250703690179;8841.071687472819;2480.3551076720046;2509.335026218054;2521.445282037958;2528.5448619248527;2532.328932832801;2520.3447103753065;2561.6541766861515;2565.961510577343;2566.2814411964678;2566.781823545001;2503.7621425964503;2504.2862784106533;2514.0823599386185;2524.684414448194;2534.2270607464716;2431.963520547193;2440.9259925632755;2455.0793452455327;2475.8390704604144;2480.2807185916063;2446.498467814112;2456.9631455528183;2495.5008998200433;2513.1078467144084;2515.05685367987;8752.606132724042;8774;8819.206271435602;8866.202041816203;8929.821403571892;5473.452654734535;5577.330720313547;5586.944130558683;5610.270664813548;5615.9157612635845;3212.566303549038;3349.6650334966553;3413.0614081127887;3447.379471695094;3458.651126060838;1001.4892404873494;1050.217587897014;1055.9208059395576;1080.724415274108;1108.036008672452;12135.635930922086;12138.33239171854;12174.391280435942;12189.51241950321;12202.633920982385;4831.879203019882;4935.925961110586;5066.771995260222;5078.949210507848;5095.541401273903;10349.844752328721;10387.68836934893;10401.427921464392;10407.843882341771;10427.739306517398;5585.441455854463;5590.580706447033;5599.048161812501;5630.943690563124;5635.436456354331;4524.298733696282;4873.439554451284;5161.225816127536;5176.7411629418375;5235.0576896159055;4185.735126601195;4211.894702632459;4235.2800023996;4270.743755374688;4316.69783115179;1397.7274431485966;1419.5599364197133;1433.849445808196;1434.0391937401757;1438.503716217903;830.3440282177133;965.2278177458005;1001.979960400788;1022.8261195596766;1040.7138037039874;6072.574919755575;6141.907871381933;6182.474489668429;6254.655993920378;6309.3690630936535;501.38830626635445;505.9747012649353;513.5044681882002;518.7172990720067;519.5324208212563;3919.2161567686576;3926.9986153530667;3987.980060099681;4009.3785463253244;4062.370332598452;10235.897641023643;10636;10665;10666.306690065121;10687.30532515384;10236.385816851012;10497.317674351143;10526.684199474028;10527.84208236877;10555.26113172086;7959.482633628795;8095.797605059803;8154.75535733929;8198.385121115822;8201.466904651179;5915.645061296336;5950.5239580834295;6021.066734656135;6045.183900173421;6079.392060793885;9539.046095390682;9675.758106047406;9688;9763.218942484726;9793.265505087289;9768.511574421109;9820.803583928138;9953.054459826304;9966.950165249127;9971.252156088178;6722.394984451423;6818.931810682028;7665.310122088816;7725.072991241087;7996.800079997814;8261.091279959079;8420.789480263042;8576.271016963628;8631.6978905738;8660.307175426076;7528.585927774025;7548.433867459853;7570.507916985378;7631.618419079135;7768.53388796674;7236.34872861445;7279.59962202084;7460.888086678596;7525.435592330487;7687.807804804925;6848.075509806113;6889.104416425833;6891.207511136284;6982.615956122462;6987.860242795217;5197.402298735694;5203.687778733288;5211.166213405837;5286.101362768415;5409.972950135224;5150.304708864255;5181.2746215529105;5218.791248350023;5368.4631536846;5372.5701943843615 05:04:31 INFO - PROCESS | 18475 | |4;prototype.html;346.49930849921856;350.9716530565443;356.2163240870087;356.88222886447465;361.5715377277924;5535.861603459915;5705.4294570542925;5751.338596061454;5759.856003599912;5825.242718446601;5452.454754524546;5519.337679478458;5602.38373778884;5629.296337957755;5693.629914055584;4390.8902277443;4459.576340247688;4476.55234476553;4488.573585509372;4509.143262780078;4278.700490965633;4440.378347031418;4462.44219472566;4482.686211965164;4484.2376795944765;4435.356873253377;4447.288433850585;4454.995252136551;4455.398521199645;4475.5748203920575;4423.734575925439;4443.977780111095;4453.908792345896;4467.396901418332;4488.640908727294;3774.490443790108;3926.980365098185;3999.5400528939253;4014.859479918218;4018.176273863851;5488.780448782044;5493.121100623921;5506.889862202734;5580.246666700024;5590.18942253375;5110.718910459923;5123.871903202413;5130.4356520782685;5132.948670513321;5143.639945203838;5621.409751976065;5872.941270587282;5929.673867937262;5962.821115366546;5981.461668449861;4329.783510824446;4333.9133217335475;4352.651787856996;4360.1279744051;4394.362817391492;6162.291336496315;6178.135061091451;6196.535259855529;6213.192285002966;6220.502359811204;4373;4421.801018954155;4448.286545207421;4458.9331160032625;4478.888027799331;4497.302918047708;4498.21281275782;4506.1213063452315;4506.414166158378;4529.932051019237;5058.291839142523;5102.846914592568;5113.3097031900215;5171.612129090333;5174.586033117342;5712.457316554921;5754.338251101177;5966.224390829165;5984.349546776463;6052.878942421215;1520.5590378790027;1524.5654988328274;1524.5654988328274;1537.6309685675358;1541.3911504955704;1040.2354269611828;1069.4492336446735;1079.1474734959295;1087.6736978906297;1091.061686949223;5544.556435485151;5550.58370622205;5589.189567512688;5619.8247989885585;5631.521320687705;5965.480366583736;5974;5992.64044157352;5994.980853254957;6022.849428764316;5434.8803966453115;5505.642133261325;5558.44415558441;5560.638558493685;5625.353084395347;3134.388794185112;3135.905922822273;3144.371125774854;3153.132888455693;3172.7779055465894;5804.6807425592;5954.76180952757;6032.366601506867;6042.335343112254;6057.969710151509;5962.522998160137;5973.850653733604;5976.491998180203;5981.611195272293;5986.844735895074;5934.317553481233;5970.9701451492465;5978.521718262528;5985.707860676611;5997.970010150008;5763.394843541536;5897.67562784051;6095.896915564123;6121.969390153199;6165.198524191826;6100.23747031621;6109.419605137505;6115.816525504242;6122.877542449037;6132.294786099477;6086.482648974887;6211.3478084800445;6224;6234.2830574482705;6271.404216599416;4339.284018136972;4394.560543945579;4397.142557201315;4410.536893626123;4411.7794110295;6068.027890935552;6158.907616385847;6214.5960512566535;6236.688165591611;6280.623162610075;5880.26496687914;5944.492749277947;5959.880802383841;6018.247719035121;6066.848328791815;5968.194293770285;5974.2830860297045;5982.820515384546;6006.909896351471;6083.361247068994;5686.374498805046;5964.165016897551;5986.461218490357;6005.7297421617;6022.277326720821;6051.273847138372;6055.397038761929;6058.303295121117;6083.452489275986;6118.583159652002;5598.040685759952;5842.620229685057;5874.941250587611;5895.492182151613;5944.375840536854 05:04:31 INFO - PROCESS | 18475 | |5;yui.html;692.3146085375478;693.2201273567235;695.5235663570458;735.5917465806475;736.6280028585563;13877.236751978637;14466;14761.18813465259;14781.630459238524;14785.334659940301;12964.546240881571;13061.869381306184;13062.15096018758;13088.934555327234;13097.67255818605;703.7536862098276;721.8231533274355;815.502543448496;831.2892476932242;837.6440012994483;836.5399030533213;840.474703310431;840.8108175660458;841.8021764885247;845.5898889038812;881.8104107616861;887.9556022198897;890.7906641939139;893.3791015244375;899.2266650680409;882.3338379523419;884.6638277454558;887.8490656588395;887.8490656588395;888.1606881496988;654.4208375587592;654.8919428294325;656.1797752808989;656.2354856592065;656.9474442044625;13335.66660833487;13606.727865442735;13637.931810340884;13678;13682.726345473135;13328.13367131143;13657.317134143352;13679.034421099766;13810.861891381059;14094.436222551085;11109.44452777358;11148.944255278753;11296.152788540892;11299.943500282528;11302;3761.755485893408;3814.6566808987322;3839.9040023999346;3841.78870162141;3876.0116170376655;65534;66216.66891665559;66373.66813165903;66555;67618;10802.837957430645;10831.404272765074;10886.836697449544;11005.17461190414;11212.383318917375;19921.203151873764;19941.900290498455;19943.800561994194;19943.900280498503;19967.301144459874;7770.261825126604;7875.212478752079;8026.007724771495;8125.674973001132;8155.592220388957;4504.662150338738;4582.725036497821;4595.724256544618;4609.53904609543;4657.091867085954;3249.6750324967315;3327.218103745618;3340.3820293245826;3366.242595416061;3369.2082360645227;573.9167820666064;576.2796504369538;576.9038826230196;578.9044807606782;586.7271718650762;595.1281372788885;619.4115590189339;661.1207094564218;691.7509696509253;710.7299226293975;8764.211220990013;8839.116088391238;9082;9159.175674189355;9270.860937085949;532.6511135206446;542.2029616463792;596.7374355283662;626.8965620672537;686.289690170671;4118;4449.621782148489;4467.508574056851;4525.0497395546645;4597.7241365518175;86326.13673863307;86401;87269;88589.55705221562;88921.55539222262;72495.27504724886;72690;73677.6316118416;75087.24912750802;76691.61654191693;67040.32959670438;67667.66166169138;67839;68184;69946.99999999898;8550;8580.313574913867;8690.522021288889;8786.560671966505;8837.955810220908;43806.56193438025;44783;45353.54646453625;45505.31742023806;46035.76982115068;41794.79102604467;55944.160837586656;57411.71294143503;63976;64472.677636611515;11118.888811111785;11295.717607059889;11600.18798684084;11689.064874810165;11778.175527712978;12451.626451206479;12792.36038198105;13167.341632918507;13227.6234108806;13366.198028118344;12512.687182820502;12686.175398599062;12766.74466510646;12897.355132243538;12940.935295323463;11176.105911526896;11383.203175777617;11515.884841151816;11519;11756.58851940178;10710.946445267724;11428.542858285575;11893.76212475763;12175.75648487043;12530.436130373973;9901.702948911545;10154.136898363722;10220.591176352862;10449.21630877672;10457.790844183226;10254.692359229235;10773;10783.730406739895;10863.728406789893;10904.400257985886 05:04:31 INFO - PROCESS | 18475 | __end_tp_report 05:04:31 INFO - PROCESS | 18475 | __start_cc_report 05:04:31 INFO - PROCESS | 18475 | _x_x_mozilla_cycle_collect,325 05:04:31 INFO - PROCESS | 18475 | __end_cc_report 05:04:31 INFO - PROCESS | 18475 | __startTimestamp1481807071843__endTimestamp 05:04:31 INFO - PROCESS | 18475 | 05:04:31 INFO - PROCESS | 18475 | ------- Summary: start ------- 05:04:31 INFO - PROCESS | 18475 | Number of tests: 6 05:04:31 INFO - PROCESS | 18475 | 05:04:31 INFO - PROCESS | 18475 | [#0] dojo.html Cycles:165 Average:5709.96 Median:5897.00 stddev:645.97 (11.0%) stddev-sans-first:618.37 05:04:31 INFO - PROCESS | 18475 | Values: 3246.5 3248.7 3253.5 3293.0 3305.6 5729.2 5779.9 5795.5 5797.0 5800.0 5725.2 5821.1 5831.5 5839.4 5850.4 5284.8 5296.5 5328.0 5340.0 5358.6 5353.3 5367.2 5372.8 5377.9 5391.2 5139.6 5158.7 5350.5 5358.7 5371.6 5188.0 5225.2 5233.6 5269.7 5351.3 5235.9 5250.3 5314.7 5318.5 5322.9 5757.8 5769.6 5786.1 5839.9 5856.9 6076.1 6099.6 6116.3 6178.2 6190.0 6198.7 6219.7 6251.6 6256.4 6266.9 5620.4 5668.4 5835.4 5843.2 5886.7 6189.8 6198.7 6225.2 6324.4 6333.3 6065.6 6068.5 6075.6 6078.2 6101.0 6166.9 6188.3 6191.1 6197.6 6201.2 5789.6 5880.4 6029.9 6032.7 6077.0 6142.9 6151.6 6153.0 6153.4 6158.2 4671.8 4713.4 4717.6 4725.4 4747.7 4055.8 4101.2 4113.8 4125.6 4185.1 5774.9 5788.8 5790.9 5791.3 5873.9 5969.3 6137.3 6157.2 6182.9 6184.2 5621.4 5713.2 5733.7 5737.9 5834.5 5245.9 5252.5 5265.8 5277.4 5277.8 6247.9 6282.4 6304.1 6336.1 6339.0 5967.5 6015.4 6079.5 6103.0 6113.4 6258.4 6289.2 6304.5 6306.6 6309.9 6031.6 6108.0 6110.6 6123.1 6129.4 5965.2 6029.2 6091.6 6104.1 6195.7 5999.3 6019.5 6020.9 6030.1 6043.2 6015.0 6029.3 6036.0 6045.2 6064.8 5751.1 5798.6 5859.2 5979.9 5993.0 5990.7 6036.5 6070.0 6080.8 6095.0 5876.2 5893.3 5897.0 5906.7 5930.2 05:04:31 INFO - PROCESS | 18475 | 05:04:31 INFO - PROCESS | 18475 | [#1] ext.html Cycles:180 Average:58218.10 Median:241235.50 stddev:108752.38 (45.1%) stddev-sans-first:108971.46 05:04:31 INFO - PROCESS | 18475 | Values: 616.0 619.4 660.1 670.1 689.6 41903.0 44835.1 45246.5 45443.5 45467.0 45320.3 45646.8 45962.5 46001.0 46016.0 8706.8 8865.2 8901.2 8940.4 8948.2 8722.6 8822.7 8857.4 8862.6 8867.7 8836.0 8841.2 8930.6 8931.6 8942.6 8863.0 8866.3 8885.2 8897.1 8920.7 8802.8 8849.3 8860.0 8861.9 8862.8 43305.8 43530.0 43776.0 43778.6 43866.0 3804.5 3834.4 3842.2 3901.6 3917.5 33197.8 33315.6 33491.8 34008.0 34603.7 4253.7 4353.3 4373.4 4400.9 4447.0 255034.0 257093.0 257306.0 257678.0 258211.0 64449.7 64487.0 64488.7 64522.0 64584.4 65431.7 65448.7 65552.0 65649.7 65883.7 17614.2 17740.7 17848.1 17863.5 17933.5 13476.8 13516.4 13519.3 13535.7 13545.1 18307.6 18432.9 18450.1 18623.7 18686.5 6753.7 6797.6 6867.8 6946.9 7102.6 930.2 964.4 1047.1 1154.3 1167.9 34015.3 34127.5 34165.3 34392.5 34805.0 1125.3 1140.7 1148.7 1169.3 1247.2 17490.4 17631.9 17845.9 17847.9 17908.9 493850.0 499007.0 500600.0 501117.0 501341.0 63297.4 63561.4 63667.0 63680.4 63826.7 1399.6 1430.3 1458.5 1460.1 1471.1 32331.5 33448.7 33619.0 33994.8 34146.5 56231.0 59345.7 60896.4 61253.4 66205.7 433183.0 437086.0 437829.0 438605.0 439851.0 30178.8 30181.5 30440.5 30520.4 30744.2 49412.5 49962.3 50092.5 51000.5 51322.0 42358.0 42492.4 42844.0 43194.4 44261.6 42180.0 43296.6 43999.0 44026.5 44097.6 44046.8 44278.6 44736.1 44895.6 47338.8 37778.0 38353.2 38636.8 38686.6 39242.4 29527.7 29866.1 29992.3 30122.4 30504.8 05:04:31 INFO - PROCESS | 18475 | 05:04:31 INFO - PROCESS | 18475 | [#2] jquery.html Cycles:180 Average:31353.89 Median:2644.60 stddev:81173.04 (3069.4%) stddev-sans-first:81367.48 05:04:31 INFO - PROCESS | 18475 | Values: 400.8 408.9 412.8 420.4 434.0 18652.6 19693.5 20223.4 20247.8 20420.0 18535.6 19121.5 19198.0 19917.6 20125.4 5369.9 5711.7 5714.9 5730.8 5764.7 5530.3 5661.1 5736.1 5736.4 5741.9 5635.2 5683.2 5685.8 5690.2 5699.6 5455.9 5632.9 5635.4 5646.0 5671.5 5055.6 5079.2 5112.5 5112.6 5115.4 23645.6 25642.1 26098.0 26514.9 26713.0 2603.2 2626.4 2638.8 2650.4 2854.4 15762.7 16230.8 16973.7 17086.1 17366.5 2046.2 2112.1 2113.9 2135.3 2141.1 104373.5 105762.5 109299.2 110603.0 110680.4 18269.4 18879.0 19270.0 20344.4 20643.3 33719.2 33789.3 34005.8 34128.7 34354.0 9946.7 9948.1 9952.0 10189.6 10199.1 8179.6 8253.4 8258.0 8307.4 8418.8 9024.8 9180.8 9272.7 9328.9 9588.3 3379.7 3471.5 3511.4 3515.2 3628.0 989.3 1030.9 1034.3 1070.5 1081.9 18590.6 19443.9 20236.3 20500.2 20726.8 982.4 1028.6 1044.8 1077.0 1124.9 10797.8 11370.2 11456.7 11466.5 11468.1 390094.0 490711.0 510266.0 514668.0 524607.0 89017.6 92871.0 97524.5 101874.0 102868.0 1053.6 1077.6 1094.5 1096.2 1096.9 18091.4 18161.3 18467.0 18488.0 18511.6 42486.0 43434.3 43650.3 43905.9 44627.0 63648.4 63725.0 64766.4 64801.0 64998.7 8724.7 8829.3 8871.5 8941.4 8973.2 11238.1 13742.5 13809.4 13840.9 14130.1 12099.4 12132.8 12189.0 12380.9 12419.4 11708.6 11767.9 11951.2 11976.3 12239.6 12120.2 12187.9 12210.3 12355.8 12380.7 8778.5 8817.8 8850.0 8965.6 9041.0 6689.7 9018.9 11229.5 12197.8 12234.9 05:04:31 INFO - PROCESS | 18475 | 05:04:31 INFO - PROCESS | 18475 | [#3] mootools.html Cycles:180 Average:5803.27 Median:2847.73 stddev:3189.79 (112.0%) stddev-sans-first:3182.53 05:04:31 INFO - PROCESS | 18475 | Values: 1524.5 1551.1 1731.5 1812.2 1830.0 7966.6 8190.9 8477.8 9054.8 9056.4 8421.5 8634.8 8672.8 8815.3 8841.1 2480.4 2509.3 2521.4 2528.5 2532.3 2520.3 2561.7 2566.0 2566.3 2566.8 2503.8 2504.3 2514.1 2524.7 2534.2 2432.0 2440.9 2455.1 2475.8 2480.3 2446.5 2457.0 2495.5 2513.1 2515.1 8752.6 8774.0 8819.2 8866.2 8929.8 5473.5 5577.3 5586.9 5610.3 5615.9 3212.6 3349.7 3413.1 3447.4 3458.7 1001.5 1050.2 1055.9 1080.7 1108.0 12135.6 12138.3 12174.4 12189.5 12202.6 4831.9 4935.9 5066.8 5078.9 5095.5 10349.8 10387.7 10401.4 10407.8 10427.7 5585.4 5590.6 5599.0 5630.9 5635.4 4524.3 4873.4 5161.2 5176.7 5235.1 4185.7 4211.9 4235.3 4270.7 4316.7 1397.7 1419.6 1433.8 1434.0 1438.5 830.3 965.2 1002.0 1022.8 1040.7 6072.6 6141.9 6182.5 6254.7 6309.4 501.4 506.0 513.5 518.7 519.5 3919.2 3927.0 3988.0 4009.4 4062.4 10235.9 10636.0 10665.0 10666.3 10687.3 10236.4 10497.3 10526.7 10527.8 10555.3 7959.5 8095.8 8154.8 8198.4 8201.5 5915.6 5950.5 6021.1 6045.2 6079.4 9539.0 9675.8 9688.0 9763.2 9793.3 9768.5 9820.8 9953.1 9967.0 9971.3 6722.4 6818.9 7665.3 7725.1 7996.8 8261.1 8420.8 8576.3 8631.7 8660.3 7528.6 7548.4 7570.5 7631.6 7768.5 7236.3 7279.6 7460.9 7525.4 7687.8 6848.1 6889.1 6891.2 6982.6 6987.9 5197.4 5203.7 5211.2 5286.1 5410.0 5150.3 5181.3 5218.8 5368.5 5372.6 05:04:31 INFO - PROCESS | 18475 | 05:04:31 INFO - PROCESS | 18475 | [#4] prototype.html Cycles:180 Average:4999.04 Median:5600.21 stddev:1444.74 (25.8%) stddev-sans-first:1405.95 05:04:31 INFO - PROCESS | 18475 | Values: 346.5 351.0 356.2 356.9 361.6 5535.9 5705.4 5751.3 5759.9 5825.2 5452.5 5519.3 5602.4 5629.3 5693.6 4390.9 4459.6 4476.6 4488.6 4509.1 4278.7 4440.4 4462.4 4482.7 4484.2 4435.4 4447.3 4455.0 4455.4 4475.6 4423.7 4444.0 4453.9 4467.4 4488.6 3774.5 3927.0 3999.5 4014.9 4018.2 5488.8 5493.1 5506.9 5580.2 5590.2 5110.7 5123.9 5130.4 5132.9 5143.6 5621.4 5872.9 5929.7 5962.8 5981.5 4329.8 4333.9 4352.7 4360.1 4394.4 6162.3 6178.1 6196.5 6213.2 6220.5 4373.0 4421.8 4448.3 4458.9 4478.9 4497.3 4498.2 4506.1 4506.4 4529.9 5058.3 5102.8 5113.3 5171.6 5174.6 5712.5 5754.3 5966.2 5984.3 6052.9 1520.6 1524.6 1524.6 1537.6 1541.4 1040.2 1069.4 1079.1 1087.7 1091.1 5544.6 5550.6 5589.2 5619.8 5631.5 5965.5 5974.0 5992.6 5995.0 6022.8 5434.9 5505.6 5558.4 5560.6 5625.4 3134.4 3135.9 3144.4 3153.1 3172.8 5804.7 5954.8 6032.4 6042.3 6058.0 5962.5 5973.9 5976.5 5981.6 5986.8 5934.3 5971.0 5978.5 5985.7 5998.0 5763.4 5897.7 6095.9 6122.0 6165.2 6100.2 6109.4 6115.8 6122.9 6132.3 6086.5 6211.3 6224.0 6234.3 6271.4 4339.3 4394.6 4397.1 4410.5 4411.8 6068.0 6158.9 6214.6 6236.7 6280.6 5880.3 5944.5 5959.9 6018.2 6066.8 5968.2 5974.3 5982.8 6006.9 6083.4 5686.4 5964.2 5986.5 6005.7 6022.3 6051.3 6055.4 6058.3 6083.5 6118.6 5598.0 5842.6 5874.9 5895.5 5944.4 05:04:31 INFO - PROCESS | 18475 | 05:04:31 INFO - PROCESS | 18475 | [#5] yui.html Cycles:180 Average:17360.10 Median:4596.72 stddev:23236.60 (505.5%) stddev-sans-first:23268.08 05:04:31 INFO - PROCESS | 18475 | Values: 692.3 693.2 695.5 735.6 736.6 13877.2 14466.0 14761.2 14781.6 14785.3 12964.5 13061.9 13062.2 13088.9 13097.7 703.8 721.8 815.5 831.3 837.6 836.5 840.5 840.8 841.8 845.6 881.8 888.0 890.8 893.4 899.2 882.3 884.7 887.8 887.8 888.2 654.4 654.9 656.2 656.2 656.9 13335.7 13606.7 13637.9 13678.0 13682.7 13328.1 13657.3 13679.0 13810.9 14094.4 11109.4 11148.9 11296.2 11299.9 11302.0 3761.8 3814.7 3839.9 3841.8 3876.0 65534.0 66216.7 66373.7 66555.0 67618.0 10802.8 10831.4 10886.8 11005.2 11212.4 19921.2 19941.9 19943.8 19943.9 19967.3 7770.3 7875.2 8026.0 8125.7 8155.6 4504.7 4582.7 4595.7 4609.5 4657.1 3249.7 3327.2 3340.4 3366.2 3369.2 573.9 576.3 576.9 578.9 586.7 595.1 619.4 661.1 691.8 710.7 8764.2 8839.1 9082.0 9159.2 9270.9 532.7 542.2 596.7 626.9 686.3 4118.0 4449.6 4467.5 4525.0 4597.7 86326.1 86401.0 87269.0 88589.6 88921.6 72495.3 72690.0 73677.6 75087.2 76691.6 67040.3 67667.7 67839.0 68184.0 69947.0 8550.0 8580.3 8690.5 8786.6 8838.0 43806.6 44783.0 45353.5 45505.3 46035.8 41794.8 55944.2 57411.7 63976.0 64472.7 11118.9 11295.7 11600.2 11689.1 11778.2 12451.6 12792.4 13167.3 13227.6 13366.2 12512.7 12686.2 12766.7 12897.4 12940.9 11176.1 11383.2 11515.9 11519.0 11756.6 10710.9 11428.5 11893.8 12175.8 12530.4 9901.7 10154.1 10220.6 10449.2 10457.8 10254.7 10773.0 10783.7 10863.7 10904.4 05:04:31 INFO - PROCESS | 18475 | -------- Summary: end -------- 05:04:31 INFO - PROCESS | 18475 | 05:04:32 INFO - TEST-INFO | 18475: exit 0 05:04:32 INFO - TEST-OK | dromaeo_css | took 1113600ms 05:04:32 INFO - TEST-START | kraken 05:04:32 INFO - operating with platform_type : linux_ 05:04:32 INFO - Initialising browser for kraken test... 05:04:32 INFO - TEST-INFO | started process 18849 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCACwQ4/profile http://localhost:44739/getInfo.html) 05:04:37 INFO - PROCESS | 18849 | __metrics Screen width/height:1600/1200 05:04:37 INFO - PROCESS | 18849 | colorDepth:24 05:04:37 INFO - PROCESS | 18849 | Browser inner width/height: 1024/697 05:04:37 INFO - PROCESS | 18849 | __metrics 05:04:37 ERROR - PROCESS | 18849 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 05:04:38 INFO - TEST-INFO | 18849: exit 0 05:04:38 INFO - Browser initialized. 05:04:38 INFO - Running cycle 1/1 for kraken test... 05:04:38 INFO - TEST-INFO | started process 18979 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCACwQ4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:04:50 INFO - PROCESS | 18979 | RSS: Main: 152104960 05:04:50 INFO - PROCESS | 18979 | 05:04:52 INFO - PROCESS | 18979 | Cycle 1(1): loaded http://localhost:44739/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44739/tests/kraken/driver.html?testName=audio-beat-detection) 05:04:53 INFO - PROCESS | 18979 | RSS: Main: 156860416 05:04:53 INFO - PROCESS | 18979 | 05:04:56 INFO - PROCESS | 18979 | Cycle 1(1): loaded http://localhost:44739/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44739/tests/kraken/driver.html?testName=audio-dft) 05:04:56 INFO - PROCESS | 18979 | RSS: Main: 155049984 05:04:56 INFO - PROCESS | 18979 | 05:04:59 INFO - PROCESS | 18979 | Cycle 1(1): loaded http://localhost:44739/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44739/tests/kraken/driver.html?testName=audio-fft) 05:05:00 INFO - PROCESS | 18979 | RSS: Main: 155824128 05:05:00 INFO - PROCESS | 18979 | 05:05:02 INFO - PROCESS | 18979 | Cycle 1(1): loaded http://localhost:44739/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44739/tests/kraken/driver.html?testName=audio-oscillator) 05:05:03 INFO - PROCESS | 18979 | RSS: Main: 155312128 05:05:03 INFO - PROCESS | 18979 | 05:05:05 INFO - PROCESS | 18979 | Cycle 1(1): loaded http://localhost:44739/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44739/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:05:05 INFO - PROCESS | 18979 | RSS: Main: 155250688 05:05:05 INFO - PROCESS | 18979 | 05:05:08 INFO - PROCESS | 18979 | Cycle 1(1): loaded http://localhost:44739/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44739/tests/kraken/driver.html?testName=imaging-darkroom) 05:05:09 INFO - PROCESS | 18979 | RSS: Main: 158584832 05:05:09 INFO - PROCESS | 18979 | 05:05:12 INFO - PROCESS | 18979 | Cycle 1(1): loaded http://localhost:44739/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44739/tests/kraken/driver.html?testName=imaging-desaturate) 05:05:13 INFO - PROCESS | 18979 | RSS: Main: 158715904 05:05:13 INFO - PROCESS | 18979 | 05:05:16 INFO - PROCESS | 18979 | Cycle 1(1): loaded http://localhost:44739/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44739/tests/kraken/driver.html?testName=json-parse-financial) 05:05:16 INFO - PROCESS | 18979 | RSS: Main: 158453760 05:05:16 INFO - PROCESS | 18979 | 05:05:18 INFO - PROCESS | 18979 | Cycle 1(1): loaded http://localhost:44739/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44739/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:05:18 INFO - PROCESS | 18979 | RSS: Main: 157847552 05:05:18 INFO - PROCESS | 18979 | 05:05:20 INFO - PROCESS | 18979 | Cycle 1(1): loaded http://localhost:44739/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44739/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:05:21 INFO - PROCESS | 18979 | RSS: Main: 157384704 05:05:21 INFO - PROCESS | 18979 | 05:05:23 INFO - PROCESS | 18979 | Cycle 1(1): loaded http://localhost:44739/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44739/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:05:23 INFO - PROCESS | 18979 | RSS: Main: 157712384 05:05:23 INFO - PROCESS | 18979 | 05:05:26 INFO - PROCESS | 18979 | Cycle 1(1): loaded http://localhost:44739/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44739/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:05:27 INFO - PROCESS | 18979 | RSS: Main: 157913088 05:05:27 INFO - PROCESS | 18979 | 05:05:29 INFO - PROCESS | 18979 | Cycle 1(1): loaded http://localhost:44739/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44739/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:05:30 INFO - PROCESS | 18979 | RSS: Main: 158216192 05:05:30 INFO - PROCESS | 18979 | 05:05:32 INFO - PROCESS | 18979 | Cycle 1(1): loaded http://localhost:44739/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44739/tests/kraken/driver.html?testName=ai-astar) 05:05:32 INFO - PROCESS | 18979 | RSS: Main: 159297536 05:05:32 INFO - PROCESS | 18979 | 05:05:32 INFO - PROCESS | 18979 | __start_tp_report 05:05:32 INFO - PROCESS | 18979 | _x_x_mozilla_page_load 05:05:32 INFO - PROCESS | 18979 | _x_x_mozilla_page_load_details 05:05:32 INFO - PROCESS | 18979 | |i|pagename|runs| 05:05:32 INFO - PROCESS | 18979 | |0;ai-astar;103;111;113;112;112;112;111;112;111;110 05:05:32 INFO - PROCESS | 18979 | |1;audio-beat-detection;155;126;121;167;121;122;121;118;145;119 05:05:32 INFO - PROCESS | 18979 | |2;audio-dft;161;164;164;162;164;161;162;164;162;162 05:05:32 INFO - PROCESS | 18979 | |3;audio-fft;74;75;76;111;75;75;77;76;101;75 05:05:32 INFO - PROCESS | 18979 | |4;audio-oscillator;82;83;118;83;84;82;97;82;81;114 05:05:32 INFO - PROCESS | 18979 | |5;imaging-gaussian-blur;120;118;118;118;117;117;118;119;117;117 05:05:32 INFO - PROCESS | 18979 | |6;imaging-darkroom;146;149;148;147;148;147;150;147;149;147 05:05:32 INFO - PROCESS | 18979 | |7;imaging-desaturate;85;86;85;85;86;85;85;85;85;87 05:05:32 INFO - PROCESS | 18979 | |8;json-parse-financial;51;57;51;53;52;52;51;55;52;55 05:05:32 INFO - PROCESS | 18979 | |9;json-stringify-tinderbox;59;60;59;59;61;61;61;58;59;59 05:05:32 INFO - PROCESS | 18979 | |10;stanford-crypto-aes;74;75;77;76;74;76;75;80;75;74 05:05:32 INFO - PROCESS | 18979 | |11;stanford-crypto-ccm;125;123;122;122;131;124;121;126;159;125 05:05:32 INFO - PROCESS | 18979 | |12;stanford-crypto-pbkdf2;152;157;152;151;154;152;155;155;153;154 05:05:32 INFO - PROCESS | 18979 | |13;stanford-crypto-sha256-iterative;69;63;64;65;65;62;63;64;62;60 05:05:32 INFO - PROCESS | 18979 | __end_tp_report 05:05:32 INFO - PROCESS | 18979 | __start_cc_report 05:05:32 INFO - PROCESS | 18979 | _x_x_mozilla_cycle_collect,800 05:05:32 INFO - PROCESS | 18979 | __end_cc_report 05:05:32 INFO - PROCESS | 18979 | __startTimestamp1481807132399__endTimestamp 05:05:32 INFO - PROCESS | 18979 | 05:05:32 INFO - PROCESS | 18979 | ------- Summary: start ------- 05:05:32 INFO - PROCESS | 18979 | Number of tests: 14 05:05:32 INFO - PROCESS | 18979 | 05:05:32 INFO - PROCESS | 18979 | [#0] ai-astar Cycles:10 Average:110.70 Median:112.00 stddev:2.83 (2.5%) stddev-sans-first:0.88 05:05:32 INFO - PROCESS | 18979 | Values: 103.0 111.0 113.0 112.0 112.0 112.0 111.0 112.0 111.0 110.0 05:05:32 INFO - PROCESS | 18979 | 05:05:32 INFO - PROCESS | 18979 | [#1] audio-beat-detection Cycles:10 Average:131.50 Median:124.00 stddev:17.59 (14.2%) stddev-sans-first:16.47 05:05:32 INFO - PROCESS | 18979 | Values: 155.0 126.0 121.0 167.0 121.0 122.0 121.0 118.0 145.0 119.0 05:05:32 INFO - PROCESS | 18979 | 05:05:32 INFO - PROCESS | 18979 | [#2] audio-dft Cycles:10 Average:162.60 Median:163.00 stddev:1.26 (0.8%) stddev-sans-first:1.20 05:05:32 INFO - PROCESS | 18979 | Values: 161.0 164.0 164.0 162.0 164.0 161.0 162.0 164.0 162.0 162.0 05:05:32 INFO - PROCESS | 18979 | 05:05:32 INFO - PROCESS | 18979 | [#3] audio-fft Cycles:10 Average:81.50 Median:75.00 stddev:13.15 (17.5%) stddev-sans-first:13.67 05:05:32 INFO - PROCESS | 18979 | Values: 74.0 75.0 76.0 111.0 75.0 75.0 77.0 76.0 101.0 75.0 05:05:32 INFO - PROCESS | 18979 | 05:05:32 INFO - PROCESS | 18979 | [#4] audio-oscillator Cycles:10 Average:90.60 Median:82.50 stddev:14.19 (17.2%) stddev-sans-first:14.71 05:05:32 INFO - PROCESS | 18979 | Values: 82.0 83.0 118.0 83.0 84.0 82.0 97.0 82.0 81.0 114.0 05:05:32 INFO - PROCESS | 18979 | 05:05:32 INFO - PROCESS | 18979 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.99 (0.8%) stddev-sans-first:0.71 05:05:32 INFO - PROCESS | 18979 | Values: 120.0 118.0 118.0 118.0 117.0 117.0 118.0 119.0 117.0 117.0 05:05:32 INFO - PROCESS | 18979 | 05:05:32 INFO - PROCESS | 18979 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:148.00 stddev:1.23 (0.8%) stddev-sans-first:1.12 05:05:32 INFO - PROCESS | 18979 | Values: 146.0 149.0 148.0 147.0 148.0 147.0 150.0 147.0 149.0 147.0 05:05:32 INFO - PROCESS | 18979 | 05:05:32 INFO - PROCESS | 18979 | [#7] imaging-desaturate Cycles:10 Average:85.40 Median:85.00 stddev:0.70 (0.8%) stddev-sans-first:0.73 05:05:32 INFO - PROCESS | 18979 | Values: 85.0 86.0 85.0 85.0 86.0 85.0 85.0 85.0 85.0 87.0 05:05:32 INFO - PROCESS | 18979 | 05:05:32 INFO - PROCESS | 18979 | [#8] json-parse-financial Cycles:10 Average:52.90 Median:52.50 stddev:2.08 (4.0%) stddev-sans-first:2.09 05:05:32 INFO - PROCESS | 18979 | Values: 51.0 57.0 51.0 53.0 52.0 52.0 51.0 55.0 52.0 55.0 05:05:32 INFO - PROCESS | 18979 | 05:05:32 INFO - PROCESS | 18979 | [#9] json-stringify-tinderbox Cycles:10 Average:59.60 Median:59.50 stddev:1.07 (1.8%) stddev-sans-first:1.12 05:05:32 INFO - PROCESS | 18979 | Values: 59.0 60.0 59.0 59.0 61.0 61.0 61.0 58.0 59.0 59.0 05:05:32 INFO - PROCESS | 18979 | 05:05:32 INFO - PROCESS | 18979 | [#10] stanford-crypto-aes Cycles:10 Average:75.60 Median:75.50 stddev:1.84 (2.4%) stddev-sans-first:1.86 05:05:32 INFO - PROCESS | 18979 | Values: 74.0 75.0 77.0 76.0 74.0 76.0 75.0 80.0 75.0 74.0 05:05:32 INFO - PROCESS | 18979 | 05:05:32 INFO - PROCESS | 18979 | [#11] stanford-crypto-ccm Cycles:10 Average:127.80 Median:125.00 stddev:11.32 (9.1%) stddev-sans-first:11.96 05:05:32 INFO - PROCESS | 18979 | Values: 125.0 123.0 122.0 122.0 131.0 124.0 121.0 126.0 159.0 125.0 05:05:32 INFO - PROCESS | 18979 | 05:05:32 INFO - PROCESS | 18979 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.50 Median:154.00 stddev:1.84 (1.2%) stddev-sans-first:1.87 05:05:32 INFO - PROCESS | 18979 | Values: 152.0 157.0 152.0 151.0 154.0 152.0 155.0 155.0 153.0 154.0 05:05:32 INFO - PROCESS | 18979 | 05:05:32 INFO - PROCESS | 18979 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.70 Median:64.00 stddev:2.41 (3.8%) stddev-sans-first:1.62 05:05:32 INFO - PROCESS | 18979 | Values: 69.0 63.0 64.0 65.0 65.0 62.0 63.0 64.0 62.0 60.0 05:05:32 INFO - PROCESS | 18979 | -------- Summary: end -------- 05:05:32 INFO - PROCESS | 18979 | 05:05:33 INFO - TEST-INFO | 18979: exit 0 05:05:33 INFO - TEST-OK | kraken | took 60778ms 05:05:33 INFO - SUITE-END | took 1174s 05:05:33 INFO - Completed test suite (00:19:34) 05:05:33 INFO - javascript benchmark 05:05:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7509.6166790824445, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3246.4643333849917, 3248.707616314532, 3253.495708165235, 3292.967070329297, 3305.6033276006883, 5729.169270455786, 5779.913301300484, 5795.4784069433745, 5797.0, 5799.971000144993, 5725.169850371693, 5821.097729851869, 5831.533477321815, 5839.445252700986, 5850.385709500494, 5284.762185701643, 5296.470352964711, 5328.040952628526, 5340.0, 5358.571314294866, 5353.250544923714, 5367.221752845854, 5372.785088596452, 5377.865553361177, 5391.191321301797, 5139.614528910347, 5158.690478571298, 5350.5452036576935, 5358.678479291255, 5371.57027437804, 5188.0, 5225.242339860699, 5233.581313494911, 5269.7365131743645, 5351.331083614548, 5235.947640523622, 5250.264962905197, 5314.707691076989, 5318.547923426513, 5322.866928326784, 5757.798477053325, 5769.624974376694, 5786.132080187964, 5839.9124013139835, 5856.853578660525, 6076.149339092531, 6099.634021958653, 6116.274903966718, 6178.196834411543, 6189.969050154766, 6198.659073750942, 6219.689015549205, 6251.562390632657, 6256.405641464099, 6266.937330626681, 5620.437956204347, 5668.376478587352, 5835.387284335126, 5843.152742852262, 5886.676232807194, 6189.783357582463, 6198.690065496708, 6225.159603453476, 6324.3991820776955, 6333.334999825044, 6065.60573562717, 6068.4538391544975, 6075.635461872302, 6078.209832721718, 6100.969495152496, 6166.876662466815, 6188.2883468400805, 6191.102290167901, 6197.628142311476, 6201.162843016135, 5789.565782566325, 5880.411958804086, 6029.879402411927, 6032.728527216286, 6076.969615151896, 6142.877142457215, 6151.630902145886, 6153.046277826855, 6153.353897840751, 6158.199434073542, 4671.813127474931, 4713.410823647044, 4717.551832575899, 4725.40932383452, 4747.738874361874, 4055.8174882130374, 4101.241270364992, 4113.835446582163, 4125.608067233608, 4185.079282557833, 5774.942250577525, 5788.82633520995, 5790.884182316414, 5791.305043394819, 5873.941260587425, 5969.253843269591, 6137.294211165684, 6157.168782214344, 6182.938170618326, 6184.165137706352, 5621.381648018714, 5713.22871412354, 5733.741981610754, 5737.885242295214, 5834.474897259267, 5245.868853278698, 5252.474752524717, 5265.789368425297, 5277.419483856773, 5277.788888444496, 6247.875042499125, 6282.371762823773, 6304.085907543381, 6336.112944187726, 6339.0, 5967.4629283362965, 6015.428534289235, 6079.544034197541, 6103.0, 6113.388661134029, 6258.3741625838875, 6289.245290565162, 6304.464120549805, 6306.558540902276, 6309.873802523832, 6031.577789554689, 6107.969460152671, 6110.602810817282, 6123.112148738319, 6129.387061293835, 5965.224520812267, 6029.246344206974, 6091.604045737013, 6104.114903338902, 6195.659238741912, 5999.250093738283, 6019.4883434908525, 6020.909686354796, 6030.1256317832795, 6043.184170136975, 6015.037593984942, 6029.276486821609, 6035.969820150871, 6045.244344456943, 6064.787732429344, 5751.1085781703905, 5798.623089499169, 5859.179714840011, 5979.880402392015, 5992.970035149797, 5990.7004649768205, 6036.456718895321, 6069.969650151721, 6080.787172448943, 6094.969525152346, 5876.236089308362, 5893.292804863272, 5897.0, 5906.7341969612335, 5930.169776231245], "value": 5665.655678164861, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [615.9599626024309, 619.4270299972526, 660.1319265166309, 670.1020632352646, 689.6138162628926, 41902.952426189324, 44835.10329793406, 45246.547534524645, 45443.54556454434, 45467.0, 45320.32019519702, 45646.7717661412, 45962.54037459625, 46001.0, 46016.0, 8706.782330441727, 8865.202131808135, 8901.24339431146, 8940.418872773249, 8948.194662480375, 8722.563871806384, 8822.735317940473, 8857.379983401132, 8862.60118294675, 8867.73396798097, 8835.95582022089, 8841.204291613754, 8930.642774289021, 8931.64273429062, 8942.597583108776, 8863.0, 8866.290696744245, 8885.244754195868, 8897.110288971051, 8920.732378028637, 8802.779930501789, 8849.336299777542, 8860.0, 8861.86707199386, 8862.778430539223, 43305.78347108276, 43530.0, 43776.0, 43778.562214378086, 43866.0, 3804.4863943367845, 3834.3673293906472, 3842.1931394407206, 3901.6293452122004, 3917.5494818096, 33197.83401083003, 33315.55147846969, 33491.832540837386, 34008.0, 34603.65396346054, 4253.723507972003, 4353.325234588644, 4373.387725718402, 4400.867973960786, 4447.043885564619, 255034.0, 257092.99999999814, 257306.0, 257678.0, 258211.0, 64449.67775161188, 64487.0, 64488.67755661192, 64522.0, 64584.35415645877, 65431.67284163549, 65448.672756636865, 65552.0, 65649.67175164094, 65883.67058164679, 17614.2073606688, 17740.733888991675, 17848.107594620476, 17863.464096076877, 17933.461996140137, 13476.797848032287, 13516.391762370717, 13519.256440895648, 13535.661608459868, 13545.1195672281, 18307.617795613514, 18432.894026358194, 18450.07749612514, 18623.720644190347, 18686.5050795936, 6753.696083676246, 6797.592144471348, 6867.793966181022, 6946.93053069473, 7102.585121058864, 930.1953809954341, 964.4358050540372, 1047.1151876664208, 1154.32472003877, 1167.9299242045504, 34015.31969360599, 34127.48808767871, 34165.31669366599, 34392.484112738326, 34805.0, 1125.3023125661978, 1140.663504266227, 1148.6783700563856, 1169.3276366089533, 1247.1955588645455, 17490.387836425918, 17631.91184044097, 17845.910770446324, 17847.910760446113, 17908.91045544764, 493850.0, 499007.0, 500600.0, 501117.0, 501341.0, 63297.36702633007, 63561.36438635555, 63667.0, 63680.36319636837, 63826.68086659537, 1399.6081097292774, 1430.2991534148193, 1458.4603696632103, 1460.0655580428322, 1471.0952764050032, 32331.51502727508, 33448.66551334455, 33619.0, 33994.83002584971, 34146.48780268348, 56231.0, 59345.70327148337, 60896.39103608907, 61253.38746612477, 66205.66897165483, 433183.0, 437086.0, 437829.0, 438605.0, 439851.0, 30178.849105754332, 30181.547276790425, 30440.543391848696, 30520.389592208474, 30744.231394215323, 49412.50587494223, 49962.25056624081, 50092.499075010244, 51000.48999510106, 51322.0, 42358.0, 42492.362614561425, 42844.0, 43194.35208471938, 44261.557384425745, 42180.0, 43296.56703433051, 43999.0, 44026.484031831984, 44097.55902440935, 44046.77976610096, 44278.55721442744, 44736.10527789491, 44895.55104448914, 47338.763306183246, 37778.0, 38353.23293534169, 38636.80681596574, 38686.613133868304, 39242.411363830135, 29527.704722952494, 29866.10401687953, 29992.25019374533, 30122.3975520484, 30504.84747576248], "value": 20787.59761564371, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [400.7935913004801, 408.872432790975, 412.8101073506187, 420.4450125833899, 433.96962212645127, 18652.62694746104, 19693.50766230845, 20223.39329820104, 20247.797522024775, 20420.0, 18535.629287414242, 19121.52196195096, 19198.0, 19917.601647967032, 20125.396238112844, 5369.9463005370035, 5711.685857277848, 5714.885702285952, 5730.828075157731, 5764.740586673589, 5530.336359636849, 5661.094224924013, 5736.139579063132, 5736.368999410061, 5741.937741517811, 5635.239242702224, 5683.204351390808, 5685.772569097252, 5690.174924635925, 5699.601027928046, 5455.863603409907, 5632.943670563324, 5635.351934527541, 5646.0, 5671.546276297886, 5055.646104772667, 5079.187330027178, 5112.539871411554, 5112.616553758446, 5115.437301896788, 23645.645315320286, 25642.102526411487, 26098.0, 26514.867425662942, 26713.0, 2603.1799983005294, 2626.4090579619624, 2638.8416694998364, 2650.363912660967, 2854.4291141771523, 15762.684746305124, 16230.837691623168, 16973.745393819103, 17086.145692715316, 17366.479005629724, 2046.2019812273224, 2112.1129125767216, 2113.926012589552, 2135.284679632325, 2141.1435425829636, 104373.47813260886, 105762.47118764433, 109299.1745288911, 110602.9999999992, 110680.4465977665, 18269.360572379905, 18878.96165710899, 19270.0, 20344.38966830968, 20643.27748528794, 33719.15702107467, 33789.32421351608, 34005.829970850486, 34128.658713413046, 34354.0, 9946.701598952042, 9948.104670579538, 9951.950240248752, 10189.592416303412, 10199.13307368867, 8179.550124743197, 8253.380996425292, 8258.0, 8307.37694672902, 8418.789530261793, 9024.819503610022, 9180.770480737901, 9272.67545635913, 9328.860067098998, 9588.280878934107, 3379.678930501598, 3471.5486986691567, 3511.4030614795547, 3515.191505953645, 3627.9637203627626, 989.3074847606704, 1030.9278350515392, 1034.2966782587912, 1070.5075665194097, 1081.8701755789198, 18590.628187436174, 19443.902780486005, 20236.291729789387, 20500.17999280042, 20726.792732072787, 982.4056445850158, 1028.5782829040058, 1044.8119338519139, 1076.9892301076889, 1124.9212555121226, 10797.784044319227, 11370.204085714086, 11456.656300310837, 11466.48400821965, 11468.082553395709, 390094.0, 490711.0, 510266.0, 514668.0, 524607.0, 89017.55491222632, 92871.0, 97524.51237743766, 101874.0, 102868.0, 1053.5733028123623, 1077.5851297250458, 1094.4746521669483, 1096.1614365010773, 1096.923215374932, 18091.36680216239, 18161.27354905842, 18467.0, 18488.0, 18511.629767404847, 42486.0, 43434.34848477212, 43650.34524482199, 43905.902352441444, 44627.0, 63648.36351636425, 63725.0, 64766.35233647603, 64801.0, 64998.67500662467, 8724.69463568772, 8829.293656507336, 8871.512066836385, 8941.418807777734, 8973.237274831452, 11238.098076321228, 13742.519011834538, 13809.447622095004, 13840.93079534596, 14130.081544699562, 12099.395030248628, 12132.818007730068, 12189.0, 12380.876191237972, 12419.379031048593, 11708.648740537797, 11767.882321177021, 11951.163418560618, 11976.28142311464, 12239.571614993432, 12120.151589388659, 12187.939060304641, 12210.328431936328, 12355.75288494243, 12380.690482737644, 8778.51718155482, 8817.823643527221, 8849.955750221208, 8965.596548155218, 9041.00548939603, 6689.732410703517, 9018.864717029119, 11229.540159779177, 12197.756044878875, 12234.877651223374], "value": 10452.915059548608, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1524.5045360257916, 1551.123615157436, 1731.4805558332505, 1812.2207450796152, 1829.9752138802264, 7966.60166991651, 8190.8771368429525, 8477.830443391136, 9054.818903621923, 9056.366054376196, 8421.494710317385, 8634.784130396743, 8672.826543469128, 8815.250703690179, 8841.071687472819, 2480.3551076720046, 2509.335026218054, 2521.445282037958, 2528.5448619248527, 2532.328932832801, 2520.3447103753065, 2561.6541766861515, 2565.961510577343, 2566.2814411964678, 2566.781823545001, 2503.7621425964503, 2504.2862784106533, 2514.0823599386185, 2524.684414448194, 2534.2270607464716, 2431.963520547193, 2440.9259925632755, 2455.0793452455327, 2475.8390704604144, 2480.2807185916063, 2446.498467814112, 2456.9631455528183, 2495.5008998200433, 2513.1078467144084, 2515.05685367987, 8752.606132724042, 8774.0, 8819.206271435602, 8866.202041816203, 8929.821403571892, 5473.452654734535, 5577.330720313547, 5586.944130558683, 5610.270664813548, 5615.9157612635845, 3212.566303549038, 3349.6650334966553, 3413.0614081127887, 3447.379471695094, 3458.651126060838, 1001.4892404873494, 1050.217587897014, 1055.9208059395576, 1080.724415274108, 1108.036008672452, 12135.635930922086, 12138.33239171854, 12174.391280435942, 12189.51241950321, 12202.633920982385, 4831.879203019882, 4935.925961110586, 5066.771995260222, 5078.949210507848, 5095.541401273903, 10349.844752328721, 10387.68836934893, 10401.427921464392, 10407.843882341771, 10427.739306517398, 5585.441455854463, 5590.580706447033, 5599.048161812501, 5630.943690563124, 5635.436456354331, 4524.298733696282, 4873.439554451284, 5161.225816127536, 5176.7411629418375, 5235.0576896159055, 4185.735126601195, 4211.894702632459, 4235.2800023996, 4270.743755374688, 4316.69783115179, 1397.7274431485966, 1419.5599364197133, 1433.849445808196, 1434.0391937401757, 1438.503716217903, 830.3440282177133, 965.2278177458005, 1001.979960400788, 1022.8261195596766, 1040.7138037039874, 6072.574919755575, 6141.907871381933, 6182.474489668429, 6254.655993920378, 6309.3690630936535, 501.38830626635445, 505.9747012649353, 513.5044681882002, 518.7172990720067, 519.5324208212563, 3919.2161567686576, 3926.9986153530667, 3987.980060099681, 4009.3785463253244, 4062.370332598452, 10235.897641023643, 10636.0, 10665.0, 10666.306690065121, 10687.30532515384, 10236.385816851012, 10497.317674351143, 10526.684199474028, 10527.84208236877, 10555.26113172086, 7959.482633628795, 8095.797605059803, 8154.75535733929, 8198.385121115822, 8201.466904651179, 5915.645061296336, 5950.5239580834295, 6021.066734656135, 6045.183900173421, 6079.392060793885, 9539.046095390682, 9675.758106047406, 9688.0, 9763.218942484726, 9793.265505087289, 9768.511574421109, 9820.803583928138, 9953.054459826304, 9966.950165249127, 9971.252156088178, 6722.394984451423, 6818.931810682028, 7665.310122088816, 7725.072991241087, 7996.800079997814, 8261.091279959079, 8420.789480263042, 8576.271016963628, 8631.6978905738, 8660.307175426076, 7528.585927774025, 7548.433867459853, 7570.507916985378, 7631.618419079135, 7768.53388796674, 7236.34872861445, 7279.59962202084, 7460.888086678596, 7525.435592330487, 7687.807804804925, 6848.075509806113, 6889.104416425833, 6891.207511136284, 6982.615956122462, 6987.860242795217, 5197.402298735694, 5203.687778733288, 5211.166213405837, 5286.101362768415, 5409.972950135224, 5150.304708864255, 5181.2746215529105, 5218.791248350023, 5368.4631536846, 5372.5701943843615], "value": 4643.27008136004, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.49930849921856, 350.9716530565443, 356.2163240870087, 356.88222886447465, 361.5715377277924, 5535.861603459915, 5705.4294570542925, 5751.338596061454, 5759.856003599912, 5825.242718446601, 5452.454754524546, 5519.337679478458, 5602.38373778884, 5629.296337957755, 5693.629914055584, 4390.8902277443, 4459.576340247688, 4476.55234476553, 4488.573585509372, 4509.143262780078, 4278.700490965633, 4440.378347031418, 4462.44219472566, 4482.686211965164, 4484.2376795944765, 4435.356873253377, 4447.288433850585, 4454.995252136551, 4455.398521199645, 4475.5748203920575, 4423.734575925439, 4443.977780111095, 4453.908792345896, 4467.396901418332, 4488.640908727294, 3774.490443790108, 3926.980365098185, 3999.5400528939253, 4014.859479918218, 4018.176273863851, 5488.780448782044, 5493.121100623921, 5506.889862202734, 5580.246666700024, 5590.18942253375, 5110.718910459923, 5123.871903202413, 5130.4356520782685, 5132.948670513321, 5143.639945203838, 5621.409751976065, 5872.941270587282, 5929.673867937262, 5962.821115366546, 5981.461668449861, 4329.783510824446, 4333.9133217335475, 4352.651787856996, 4360.1279744051, 4394.362817391492, 6162.291336496315, 6178.135061091451, 6196.535259855529, 6213.192285002966, 6220.502359811204, 4373.0, 4421.801018954155, 4448.286545207421, 4458.9331160032625, 4478.888027799331, 4497.302918047708, 4498.21281275782, 4506.1213063452315, 4506.414166158378, 4529.932051019237, 5058.291839142523, 5102.846914592568, 5113.3097031900215, 5171.612129090333, 5174.586033117342, 5712.457316554921, 5754.338251101177, 5966.224390829165, 5984.349546776463, 6052.878942421215, 1520.5590378790027, 1524.5654988328274, 1524.5654988328274, 1537.6309685675358, 1541.3911504955704, 1040.2354269611828, 1069.4492336446735, 1079.1474734959295, 1087.6736978906297, 1091.061686949223, 5544.556435485151, 5550.58370622205, 5589.189567512688, 5619.8247989885585, 5631.521320687705, 5965.480366583736, 5974.0, 5992.64044157352, 5994.980853254957, 6022.849428764316, 5434.8803966453115, 5505.642133261325, 5558.44415558441, 5560.638558493685, 5625.353084395347, 3134.388794185112, 3135.905922822273, 3144.371125774854, 3153.132888455693, 3172.7779055465894, 5804.6807425592, 5954.76180952757, 6032.366601506867, 6042.335343112254, 6057.969710151509, 5962.522998160137, 5973.850653733604, 5976.491998180203, 5981.611195272293, 5986.844735895074, 5934.317553481233, 5970.9701451492465, 5978.521718262528, 5985.707860676611, 5997.970010150008, 5763.394843541536, 5897.67562784051, 6095.896915564123, 6121.969390153199, 6165.198524191826, 6100.23747031621, 6109.419605137505, 6115.816525504242, 6122.877542449037, 6132.294786099477, 6086.482648974887, 6211.3478084800445, 6224.0, 6234.2830574482705, 6271.404216599416, 4339.284018136972, 4394.560543945579, 4397.142557201315, 4410.536893626123, 4411.7794110295, 6068.027890935552, 6158.907616385847, 6214.5960512566535, 6236.688165591611, 6280.623162610075, 5880.26496687914, 5944.492749277947, 5959.880802383841, 6018.247719035121, 6066.848328791815, 5968.194293770285, 5974.2830860297045, 5982.820515384546, 6006.909896351471, 6083.361247068994, 5686.374498805046, 5964.165016897551, 5986.461218490357, 6005.7297421617, 6022.277326720821, 6051.273847138372, 6055.397038761929, 6058.303295121117, 6083.452489275986, 6118.583159652002, 5598.040685759952, 5842.620229685057, 5874.941250587611, 5895.492182151613, 5944.375840536854], "value": 4541.207630863154, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [692.3146085375478, 693.2201273567235, 695.5235663570458, 735.5917465806475, 736.6280028585563, 13877.236751978637, 14466.0, 14761.18813465259, 14781.630459238524, 14785.334659940301, 12964.546240881571, 13061.869381306184, 13062.15096018758, 13088.934555327234, 13097.67255818605, 703.7536862098276, 721.8231533274355, 815.502543448496, 831.2892476932242, 837.6440012994483, 836.5399030533213, 840.474703310431, 840.8108175660458, 841.8021764885247, 845.5898889038812, 881.8104107616861, 887.9556022198897, 890.7906641939139, 893.3791015244375, 899.2266650680409, 882.3338379523419, 884.6638277454558, 887.8490656588395, 887.8490656588395, 888.1606881496988, 654.4208375587592, 654.8919428294325, 656.1797752808989, 656.2354856592065, 656.9474442044625, 13335.66660833487, 13606.727865442735, 13637.931810340884, 13678.0, 13682.726345473135, 13328.13367131143, 13657.317134143352, 13679.034421099766, 13810.861891381059, 14094.436222551085, 11109.44452777358, 11148.944255278753, 11296.152788540892, 11299.943500282528, 11302.0, 3761.755485893408, 3814.6566808987322, 3839.9040023999346, 3841.78870162141, 3876.0116170376655, 65534.0, 66216.66891665559, 66373.66813165903, 66555.0, 67618.0, 10802.837957430645, 10831.404272765074, 10886.836697449544, 11005.17461190414, 11212.383318917375, 19921.203151873764, 19941.900290498455, 19943.800561994194, 19943.900280498503, 19967.301144459874, 7770.261825126604, 7875.212478752079, 8026.007724771495, 8125.674973001132, 8155.592220388957, 4504.662150338738, 4582.725036497821, 4595.724256544618, 4609.53904609543, 4657.091867085954, 3249.6750324967315, 3327.218103745618, 3340.3820293245826, 3366.242595416061, 3369.2082360645227, 573.9167820666064, 576.2796504369538, 576.9038826230196, 578.9044807606782, 586.7271718650762, 595.1281372788885, 619.4115590189339, 661.1207094564218, 691.7509696509253, 710.7299226293975, 8764.211220990013, 8839.116088391238, 9082.0, 9159.175674189355, 9270.860937085949, 532.6511135206446, 542.2029616463792, 596.7374355283662, 626.8965620672537, 686.289690170671, 4118.0, 4449.621782148489, 4467.508574056851, 4525.0497395546645, 4597.7241365518175, 86326.13673863307, 86401.0, 87269.0, 88589.55705221562, 88921.55539222262, 72495.27504724886, 72690.0, 73677.6316118416, 75087.24912750802, 76691.61654191693, 67040.32959670438, 67667.66166169138, 67839.0, 68184.0, 69946.99999999898, 8550.0, 8580.313574913867, 8690.522021288889, 8786.560671966505, 8837.955810220908, 43806.56193438025, 44783.0, 45353.54646453625, 45505.31742023806, 46035.76982115068, 41794.79102604467, 55944.160837586656, 57411.71294143503, 63976.0, 64472.677636611515, 11118.888811111785, 11295.717607059889, 11600.18798684084, 11689.064874810165, 11778.175527712978, 12451.626451206479, 12792.36038198105, 13167.341632918507, 13227.6234108806, 13366.198028118344, 12512.687182820502, 12686.175398599062, 12766.74466510646, 12897.355132243538, 12940.935295323463, 11176.105911526896, 11383.203175777617, 11515.884841151816, 11519.0, 11756.58851940178, 10710.946445267724, 11428.542858285575, 11893.76212475763, 12175.75648487043, 12530.436130373973, 9901.702948911545, 10154.136898363722, 10220.591176352862, 10449.21630877672, 10457.790844183226, 10254.692359229235, 10773.0, 10783.730406739895, 10863.728406789893, 10904.400257985886], "value": 6908.365217527538, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1461.0999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 111.0, 113.0, 112.0, 112.0, 112.0, 111.0, 112.0, 111.0, 110.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 126.0, 121.0, 167.0, 121.0, 122.0, 121.0, 118.0, 145.0, 119.0], "value": 131.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 164.0, 164.0, 162.0, 164.0, 161.0, 162.0, 164.0, 162.0, 162.0], "value": 162.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 111.0, 75.0, 75.0, 77.0, 76.0, 101.0, 75.0], "value": 81.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 118.0, 83.0, 84.0, 82.0, 97.0, 82.0, 81.0, 114.0], "value": 90.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 118.0, 118.0, 118.0, 117.0, 117.0, 118.0, 119.0, 117.0, 117.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 149.0, 148.0, 147.0, 148.0, 147.0, 150.0, 147.0, 149.0, 147.0], "value": 147.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 85.0, 85.0, 86.0, 85.0, 85.0, 85.0, 85.0, 87.0], "value": 85.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 57.0, 51.0, 53.0, 52.0, 52.0, 51.0, 55.0, 52.0, 55.0], "value": 52.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 59.0, 59.0, 61.0, 61.0, 61.0, 58.0, 59.0, 59.0], "value": 59.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 77.0, 76.0, 74.0, 76.0, 75.0, 80.0, 75.0, 74.0], "value": 75.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 123.0, 122.0, 122.0, 131.0, 124.0, 121.0, 126.0, 159.0, 125.0], "value": 127.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 157.0, 152.0, 151.0, 154.0, 152.0, 155.0, 155.0, 153.0, 154.0], "value": 153.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 63.0, 64.0, 65.0, 65.0, 62.0, 63.0, 64.0, 62.0, 60.0], "value": 63.7, "unit": "score"}]}]} 05:05:33 INFO - Return code: 0 05:05:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:05:33 ERROR - # TBPL SUCCESS # 05:05:33 INFO - Running post-action listener: _resource_record_post_action 05:05:33 INFO - [mozharness: 2016-12-15 13:05:33.700079Z] Finished run-tests step (success) 05:05:33 INFO - Running post-run listener: _resource_record_post_run 05:05:33 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 371703808; Read time: 12; Write time: 236592 05:05:33 INFO - TinderboxPrint: CPU usage
13.3% 05:05:33 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 05:05:33 INFO - TinderboxPrint: I/O write bytes / time
371,703,808 / 236,592 05:05:33 INFO - TinderboxPrint: CPU idle
8,235.6 (86.7%) 05:05:33 INFO - TinderboxPrint: CPU user
1,209.0 (12.7%) 05:05:33 INFO - TinderboxPrint: Swap in / out
0 / 0 05:05:33 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 124010496; Read time: 0; Write time: 75292 05:05:33 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 247095296; Read time: 0; Write time: 161276 05:05:34 INFO - Running post-run listener: _upload_blobber_files 05:05:34 INFO - Blob upload gear active. 05:05:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:05:34 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:05:34 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'] 05:05:34 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 05:05:34 INFO - (blobuploader) - INFO - Open directory for files ... 05:05:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:05:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:05:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:05:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:05:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:05:35 INFO - (blobuploader) - INFO - Done attempting. 05:05:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:05:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:05:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:05:38 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:05:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:05:38 INFO - (blobuploader) - INFO - Done attempting. 05:05:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:05:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:05:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:05:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:05:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:05:39 INFO - (blobuploader) - INFO - Done attempting. 05:05:39 INFO - (blobuploader) - INFO - Iteration through files over. 05:05:39 INFO - Return code: 0 05:05:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:05:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:05:39 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fba231b641412b7df0d65d25703bd5dc9b89f94e9655762839c7ee541f6092759c8db54c5f4cd98eb2eb5a1cd2932dd1e9a315aed2654a5b40cc9bd918bf5b01", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/973f12aeca703716bcc09bff15e9fba427687949d86272d3b219b0930fe64ff5bd519a432e6bf1a0f244e4192b09f100bed696a0f83010b4cc813a2734a2d2d2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/edacd7a0e8e4eef4b25d89c38840128031543ec4ba9f00472dabf18067d2769d3e23a18e6948aeeb5095ad39cf73dea49b25f68839a50425faf7ff4194709829"} 05:05:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:05:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:05:39 INFO - Contents: 05:05:39 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fba231b641412b7df0d65d25703bd5dc9b89f94e9655762839c7ee541f6092759c8db54c5f4cd98eb2eb5a1cd2932dd1e9a315aed2654a5b40cc9bd918bf5b01", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/973f12aeca703716bcc09bff15e9fba427687949d86272d3b219b0930fe64ff5bd519a432e6bf1a0f244e4192b09f100bed696a0f83010b4cc813a2734a2d2d2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/edacd7a0e8e4eef4b25d89c38840128031543ec4ba9f00472dabf18067d2769d3e23a18e6948aeeb5095ad39cf73dea49b25f68839a50425faf7ff4194709829"} 05:05:39 INFO - Running post-run listener: copy_logs_to_upload_dir 05:05:39 INFO - Copying logs to upload dir... 05:05:39 INFO - mkdir: /builds/slave/test/build/upload/logs 05:05:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.125736 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-12-15 05:05:39.016201) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-15 05:05:39.019250) ========= 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=4300f881736b422476174874000001bc-1481803713.780047-815925066 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fba231b641412b7df0d65d25703bd5dc9b89f94e9655762839c7ee541f6092759c8db54c5f4cd98eb2eb5a1cd2932dd1e9a315aed2654a5b40cc9bd918bf5b01", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/973f12aeca703716bcc09bff15e9fba427687949d86272d3b219b0930fe64ff5bd519a432e6bf1a0f244e4192b09f100bed696a0f83010b4cc813a2734a2d2d2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/edacd7a0e8e4eef4b25d89c38840128031543ec4ba9f00472dabf18067d2769d3e23a18e6948aeeb5095ad39cf73dea49b25f68839a50425faf7ff4194709829"} build_url:https://queue.taskcluster.net/v1/task/Quz9EPRcSIibvZdjhzxAZw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011715 build_url: 'https://queue.taskcluster.net/v1/task/Quz9EPRcSIibvZdjhzxAZw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fba231b641412b7df0d65d25703bd5dc9b89f94e9655762839c7ee541f6092759c8db54c5f4cd98eb2eb5a1cd2932dd1e9a315aed2654a5b40cc9bd918bf5b01", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/973f12aeca703716bcc09bff15e9fba427687949d86272d3b219b0930fe64ff5bd519a432e6bf1a0f244e4192b09f100bed696a0f83010b4cc813a2734a2d2d2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/edacd7a0e8e4eef4b25d89c38840128031543ec4ba9f00472dabf18067d2769d3e23a18e6948aeeb5095ad39cf73dea49b25f68839a50425faf7ff4194709829"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-15 05:05:39.044954) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-15 05:05:39.045280) ========= 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=4300f881736b422476174874000001bc-1481803713.780047-815925066 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004408 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-15 05:05:39.130486) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-15 05:05:39.130789) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-15 05:05:39.131071) ========= ========= Total master_lag: 0.18 =========