builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-011 starttime: 1481797983.25 results: success (0) buildid: 20161215004017 builduid: e94fb94d74f4400bbe46f07620f1fc7a revision: 7e3a96f3ee277bc54a695ed54f60228984de2a7f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-15 02:33:03.251744) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-15 02:33:03.252179) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-15 02:33:03.252452) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-15 02:33:03.267491) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-15 02:33:03.267788) ========= 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=5cf47e208febbcd81da23b2e0000026f-1481797983.25521-542867285 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-15 02:33:03-- 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% 45.2M=0s 2016-12-15 02:33:04 (45.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.113748 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-15 02:33:03.395234) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-15 02:33:03.395540) ========= 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=5cf47e208febbcd81da23b2e0000026f-1481797983.25521-542867285 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022046 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-15 02:33:03.445291) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-15 02:33:03.445838) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 7e3a96f3ee277bc54a695ed54f60228984de2a7f --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 7e3a96f3ee277bc54a695ed54f60228984de2a7f --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=5cf47e208febbcd81da23b2e0000026f-1481797983.25521-542867285 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-15 02:33:04,176 truncating revision to first 12 chars 2016-12-15 02:33:04,176 Setting DEBUG logging. 2016-12-15 02:33:04,176 attempt 1/10 2016-12-15 02:33:04,176 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/7e3a96f3ee27?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-15 02:33:05,355 unpacking tar archive at: mozilla-aurora-7e3a96f3ee27/testing/mozharness/ program finished with exit code 0 elapsedTime=1.497024 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-15 02:33:04.956511) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-15 02:33:04.956813) ========= script_repo_revision: 7e3a96f3ee277bc54a695ed54f60228984de2a7f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-15 02:33:04.957218) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-15 02:33:04.957484) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-15 02:33:04.966371) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-12-15 02:33:04.966649) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5cf47e208febbcd81da23b2e0000026f-1481797983.25521-542867285 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:33:05 INFO - MultiFileLogger online at 20161215 02:33:05 in /builds/slave/test 02:33:05 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 02:33:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:33:05 INFO - {'append_to_log': False, 02:33:05 INFO - 'base_work_dir': '/builds/slave/test', 02:33:05 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:33:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:33:05 INFO - 'branch': 'Mozilla-Aurora', 02:33:05 INFO - 'buildbot_json_path': 'buildprops.json', 02:33:05 INFO - 'config_files': ('talos/linux_config.py',), 02:33:05 INFO - 'default_actions': ('clobber', 02:33:05 INFO - 'read-buildbot-config', 02:33:05 INFO - 'download-and-extract', 02:33:05 INFO - 'populate-webroot', 02:33:05 INFO - 'create-virtualenv', 02:33:05 INFO - 'install', 02:33:05 INFO - 'run-tests'), 02:33:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:33:05 INFO - 'download_minidump_stackwalk': True, 02:33:05 INFO - 'download_symbols': 'ondemand', 02:33:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:33:05 INFO - 'tooltool.py': '/tools/tooltool.py', 02:33:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:33:05 INFO - '/tools/misc-python/virtualenv.py')}, 02:33:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:33:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:33:05 INFO - 'installer_path': 'installer.exe', 02:33:05 INFO - 'log_level': 'info', 02:33:05 INFO - 'log_name': 'talos', 02:33:05 INFO - 'log_to_console': True, 02:33:05 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:33:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:33:05 INFO - 'opt_config_files': (), 02:33:05 INFO - 'pip_index': False, 02:33:05 INFO - 'sps_profile': False, 02:33:05 INFO - 'sps_profile_interval': 0, 02:33:05 INFO - 'suite': 'dromaeojs', 02:33:05 INFO - 'system_bits': '32', 02:33:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:33:05 INFO - 'title': 'talos-linux64-ix-011', 02:33:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:33:05 INFO - 'use_talos_json': True, 02:33:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:33:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:33:05 INFO - 'work_dir': 'build'} 02:33:05 INFO - [mozharness: 2016-12-15 10:33:05.790953Z] Running clobber step. 02:33:05 INFO - Running pre-action listener: _resource_record_pre_action 02:33:05 INFO - Running main action method: clobber 02:33:05 INFO - rmtree: /builds/slave/test/build 02:33:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:33:06 INFO - Running post-action listener: _resource_record_post_action 02:33:06 INFO - [mozharness: 2016-12-15 10:33:06.303900Z] Finished clobber step (success) 02:33:06 INFO - [mozharness: 2016-12-15 10:33:06.303999Z] Running read-buildbot-config step. 02:33:06 INFO - Running pre-action listener: _resource_record_pre_action 02:33:06 INFO - Running main action method: read_buildbot_config 02:33:06 INFO - Using buildbot properties: 02:33:06 INFO - { 02:33:06 INFO - "project": "", 02:33:06 INFO - "product": "firefox", 02:33:06 INFO - "script_repo_revision": "production", 02:33:06 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 02:33:06 INFO - "repository": "", 02:33:06 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 02:33:06 INFO - "buildid": "20161215004017", 02:33:06 INFO - "stage_platform": "linux64-pgo", 02:33:06 INFO - "basedir": "/builds/slave/test", 02:33:06 INFO - "nightly_build": "True", 02:33:06 INFO - "buildnumber": 674, 02:33:06 INFO - "slavename": "talos-linux64-ix-011", 02:33:06 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 02:33:06 INFO - "platform": "ubuntu64_hw", 02:33:06 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 02:33:06 INFO - "branch": "mozilla-aurora", 02:33:06 INFO - "repo_path": "releases/mozilla-aurora", 02:33:06 INFO - "revision": "7e3a96f3ee277bc54a695ed54f60228984de2a7f", 02:33:06 INFO - "pgo_build": "True", 02:33:06 INFO - "builduid": "e94fb94d74f4400bbe46f07620f1fc7a", 02:33:06 INFO - "slavebuilddir": "test" 02:33:06 INFO - } 02:33:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/dYncMFW1RoaJz4xmuryazQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 02:33:06 INFO - Running post-action listener: _resource_record_post_action 02:33:06 INFO - [mozharness: 2016-12-15 10:33:06.306477Z] Finished read-buildbot-config step (success) 02:33:06 INFO - [mozharness: 2016-12-15 10:33:06.306564Z] Running download-and-extract step. 02:33:06 INFO - Running pre-action listener: _resource_record_pre_action 02:33:06 INFO - Running main action method: download_and_extract 02:33:06 INFO - mkdir: /builds/slave/test/build/tests 02:33: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')]} 02:33:06 INFO - trying https://queue.taskcluster.net/v1/task/dYncMFW1RoaJz4xmuryazQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 02:33:06 INFO - Downloading https://queue.taskcluster.net/v1/task/dYncMFW1RoaJz4xmuryazQ/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 02:33:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dYncMFW1RoaJz4xmuryazQ/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 02:33:06 INFO - Downloaded 1361 bytes. 02:33:06 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 02:33:06 INFO - Using the following test package requirements: 02:33:06 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 02:33:06 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:33:06 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 02:33:06 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:33:06 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 02:33:06 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:33:06 INFO - u'jsshell-linux-x86_64.zip'], 02:33:06 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:33:06 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 02:33:06 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 02:33:06 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:33:06 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 02:33:06 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:33:06 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 02:33:06 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:33:06 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 02:33:06 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:33:06 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 02:33:06 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:33:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dYncMFW1RoaJz4xmuryazQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 02:33:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dYncMFW1RoaJz4xmuryazQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:33:06 INFO - Fetch https://queue.taskcluster.net/v1/task/dYncMFW1RoaJz4xmuryazQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 02:33:07 INFO - Http code: 200 02:33:07 INFO - via: 1.1 9767e262e4af15c8d83a726bb0f44fa5.cloudfront.net (CloudFront) 02:33:07 INFO - x-amz-cf-id: ZvICGDGusU3klb3DKH5siLk-ytnRMP4I_xM4VUwyVQ8sEgEFUDMxsA== 02:33:07 INFO - x-amz-version-id: fxuiUEn4EZ3plHedckqLXu6WosJVIZe2 02:33:07 INFO - Expected file size: 21952602 02:33:07 INFO - Obtained file size: 21952602 02:33:11 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 02:33:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dYncMFW1RoaJz4xmuryazQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 02:33:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dYncMFW1RoaJz4xmuryazQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:33:11 INFO - Fetch https://queue.taskcluster.net/v1/task/dYncMFW1RoaJz4xmuryazQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 02:33:12 INFO - Http code: 200 02:33:12 INFO - via: 1.1 978198446b6fdba8a499c04f84a3a7e6.cloudfront.net (CloudFront) 02:33:12 INFO - x-amz-cf-id: gr2X7X-iikfWlZ-FzWEljcokyIMqQJM2OWsIX9WN0HC4jGSbY8JUtA== 02:33:12 INFO - x-amz-version-id: fxuiUEn4EZ3plHedckqLXu6WosJVIZe2 02:33:12 INFO - Expected file size: 21952602 02:33:12 INFO - Obtained file size: 21952602 02:33:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dYncMFW1RoaJz4xmuryazQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 02:33:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dYncMFW1RoaJz4xmuryazQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:33:16 INFO - Fetch https://queue.taskcluster.net/v1/task/dYncMFW1RoaJz4xmuryazQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 02:33:17 INFO - Http code: 200 02:33:17 INFO - via: 1.1 978198446b6fdba8a499c04f84a3a7e6.cloudfront.net (CloudFront) 02:33:17 INFO - x-amz-cf-id: JWGp5PT4s1pD1U7wCyBUQkCkUm-d_Is4nIREeo_1O3i5e5Gli3zR0A== 02:33:17 INFO - x-amz-version-id: JkpGFNXPORN9L5Rbt3QeqmVR8vd2lYtx 02:33:17 INFO - Expected file size: 14409038 02:33:17 INFO - Obtained file size: 14409038 02:33:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:33:17 INFO - trying https://queue.taskcluster.net/v1/task/dYncMFW1RoaJz4xmuryazQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 02:33:17 INFO - Downloading https://queue.taskcluster.net/v1/task/dYncMFW1RoaJz4xmuryazQ/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 02:33:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dYncMFW1RoaJz4xmuryazQ/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 02:33:19 INFO - Downloaded 63979185 bytes. 02:33:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dYncMFW1RoaJz4xmuryazQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 02:33:19 INFO - mkdir: /builds/slave/test/properties 02:33:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:33:19 INFO - Writing to file /builds/slave/test/properties/build_url 02:33:19 INFO - Contents: 02:33:19 INFO - build_url:https://queue.taskcluster.net/v1/task/dYncMFW1RoaJz4xmuryazQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 02:33:19 INFO - Running post-action listener: _resource_record_post_action 02:33:19 INFO - Running post-action listener: set_extra_try_arguments 02:33:19 INFO - [mozharness: 2016-12-15 10:33:19.718985Z] Finished download-and-extract step (success) 02:33:19 INFO - [mozharness: 2016-12-15 10:33:19.719210Z] Running populate-webroot step. 02:33:19 INFO - Running pre-action listener: _resource_record_pre_action 02:33:19 INFO - Running main action method: populate_webroot 02:33:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:33:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:33:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:33:19 INFO - '--tppagecycles', 02:33:19 INFO - '7'], 02:33:19 INFO - 'tests': ['tsvgm']}}, 02:33:19 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:33:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:33:19 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:33:19 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:33:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:33:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:33:19 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:33:19 INFO - 'talos_options': ['--disable-e10s'], 02:33:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:33:19 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:33:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:33:19 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:33:19 INFO - 'talos_options': ['--disable-e10s'], 02:33:19 INFO - 'tests': ['damp', 'tps']}, 02:33:19 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:33:19 INFO - 'tests': ['damp', 'tps']}, 02:33:19 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:33:19 INFO - 'tests': ['dromaeo_dom']}, 02:33:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:33:19 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:33:19 INFO - 'tests': ['basic_compositor_video']}, 02:33:19 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:33:19 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:33:19 INFO - 'tests': ['a11yr', 02:33:19 INFO - 'ts_paint', 02:33:19 INFO - 'tpaint', 02:33:19 INFO - 'sessionrestore', 02:33:19 INFO - 'sessionrestore_no_auto_restore', 02:33:19 INFO - 'tabpaint']}, 02:33:19 INFO - 'other-e10s': {'tests': ['a11yr', 02:33:19 INFO - 'ts_paint', 02:33:19 INFO - 'tpaint', 02:33:19 INFO - 'sessionrestore', 02:33:19 INFO - 'sessionrestore_no_auto_restore', 02:33:19 INFO - 'tabpaint']}, 02:33:19 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:33:19 INFO - 'ts_paint', 02:33:19 INFO - 'tpaint', 02:33:19 INFO - 'sessionrestore', 02:33:19 INFO - 'sessionrestore_no_auto_restore', 02:33:19 INFO - 'tabpaint']}, 02:33:19 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:33:19 INFO - 'ts_paint', 02:33:19 INFO - 'tpaint', 02:33:19 INFO - 'sessionrestore', 02:33:19 INFO - 'sessionrestore_no_auto_restore', 02:33:19 INFO - 'tabpaint']}, 02:33:19 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:33:19 INFO - 'tests': ['a11yr', 02:33:19 INFO - 'ts_paint', 02:33:19 INFO - 'tpaint', 02:33:19 INFO - 'sessionrestore', 02:33:19 INFO - 'sessionrestore_no_auto_restore', 02:33:19 INFO - 'tabpaint']}, 02:33:19 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:33:19 INFO - 'tests': ['a11yr', 02:33:19 INFO - 'ts_paint', 02:33:19 INFO - 'tpaint', 02:33:19 INFO - 'sessionrestore', 02:33:19 INFO - 'sessionrestore_no_auto_restore', 02:33:19 INFO - 'tabpaint']}, 02:33:19 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:33:19 INFO - 'tests': ['tsvgx', 02:33:19 INFO - 'tsvgr_opacity', 02:33:19 INFO - 'tart', 02:33:19 INFO - 'tscrollx', 02:33:19 INFO - 'cart']}, 02:33:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:33:19 INFO - 'tsvgr_opacity', 02:33:19 INFO - 'tart', 02:33:19 INFO - 'tscrollx', 02:33:19 INFO - 'cart']}, 02:33:19 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:33:19 INFO - 'talos_options': ['--disable-e10s'], 02:33:19 INFO - 'tests': ['tp5o']}, 02:33:19 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:33:19 INFO - 'tests': ['tp5o']}, 02:33:19 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:33:19 INFO - 'talos_options': ['--disable-e10s', 02:33:19 INFO - '--xperf_path', 02:33:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:33:19 INFO - 'tests': ['tp5n']}, 02:33:19 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:33:19 INFO - 'talos_options': ['--xperf_path', 02:33:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:33:19 INFO - 'tests': ['tp5n']}}, 02:33:19 INFO - 'talos.zip': {'path': '', 02:33:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:33:19 INFO - Running post-action listener: _resource_record_post_action 02:33:19 INFO - [mozharness: 2016-12-15 10:33:19.739745Z] Finished populate-webroot step (success) 02:33:19 INFO - [mozharness: 2016-12-15 10:33:19.739833Z] Running create-virtualenv step. 02:33:19 INFO - Running pre-action listener: _resource_record_pre_action 02:33:19 INFO - Running main action method: create_virtualenv 02:33:19 INFO - Creating virtualenv /builds/slave/test/build/venv 02:33:19 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 02:33:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:33:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:33:19 INFO - Using real prefix '/usr' 02:33:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:33:20 INFO - Installing distribute.............................................................................................................................................................................................done. 02:33:22 INFO - Installing pip.................done. 02:33:22 INFO - Return code: 0 02:33:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:33:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:33:22 INFO - Reading from file tmpfile_stdout 02:33:22 INFO - Output received: 02:33: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) 02:33:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:33: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')]} 02:33:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33: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')]} 02:33:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33: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 0x7f1aba0c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe7fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe7cf60>, '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 0xe7dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe7e1d0>, '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': '5cf47e208febbcd81da23b2e0000026f-1481797983.25521-542867285', '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 02:33: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 02:33: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 02:33:22 INFO - Using env: {'DISPLAY': ':0', 02:33:22 INFO - 'HOME': '/home/cltbld', 02:33:22 INFO - 'LANG': 'en_US.UTF-8', 02:33:22 INFO - 'LANGUAGE': 'en_US:en', 02:33:22 INFO - 'LOGNAME': 'cltbld', 02:33:22 INFO - 'MAIL': '/var/mail/cltbld', 02:33:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:22 INFO - 'MOZ_NO_REMOTE': '1', 02:33:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:33:22 INFO - 'NO_EM_RESTART': '1', 02:33:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:33:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:22 INFO - 'PWD': '/builds/slave/test', 02:33:22 INFO - 'SHELL': '/bin/bash', 02:33:22 INFO - 'SHLVL': '1', 02:33:22 INFO - 'TERM': 'linux', 02:33:22 INFO - 'TMOUT': '86400', 02:33:22 INFO - 'USER': 'cltbld', 02:33:22 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1481797983.25521-542867285', 02:33:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:22 INFO - '_': '/tools/buildbot/bin/python'} 02:33:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33: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 02:33:22 INFO - Cleaning up... 02:33:22 INFO - Return code: 0 02:33:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:33: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')]} 02:33:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33: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')]} 02:33:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33: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', '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 0x7f1aba0c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe7fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe7cf60>, '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 0xe7dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe7e1d0>, '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': '5cf47e208febbcd81da23b2e0000026f-1481797983.25521-542867285', '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 02:33: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', 'psutil>=3.1.1'] in /builds/slave/test/build 02:33: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 psutil>=3.1.1 02:33:22 INFO - Using env: {'DISPLAY': ':0', 02:33:22 INFO - 'HOME': '/home/cltbld', 02:33:22 INFO - 'LANG': 'en_US.UTF-8', 02:33:22 INFO - 'LANGUAGE': 'en_US:en', 02:33:22 INFO - 'LOGNAME': 'cltbld', 02:33:22 INFO - 'MAIL': '/var/mail/cltbld', 02:33:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:22 INFO - 'MOZ_NO_REMOTE': '1', 02:33:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:33:22 INFO - 'NO_EM_RESTART': '1', 02:33:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:33:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:22 INFO - 'PWD': '/builds/slave/test', 02:33:22 INFO - 'SHELL': '/bin/bash', 02:33:22 INFO - 'SHLVL': '1', 02:33:22 INFO - 'TERM': 'linux', 02:33:22 INFO - 'TMOUT': '86400', 02:33:22 INFO - 'USER': 'cltbld', 02:33:22 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1481797983.25521-542867285', 02:33:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:22 INFO - '_': '/tools/buildbot/bin/python'} 02:33:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:23 INFO - Downloading/unpacking psutil>=3.1.1 02:33: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 02:33: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 02:33: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 02:33: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 02:33: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 02:33: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 02:33:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:33:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:33:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:33:25 INFO - Installing collected packages: psutil 02:33:25 INFO - Running setup.py install for psutil 02:33:25 INFO - building 'psutil._psutil_linux' extension 02:33: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 02:33: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 02:33:25 INFO - building 'psutil._psutil_posix' extension 02:33: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 02:33: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 02:33:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:33:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:33:25 INFO - Successfully installed psutil 02:33:25 INFO - Cleaning up... 02:33:25 INFO - Return code: 0 02:33:25 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:33: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')]} 02:33:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33: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')]} 02:33:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33: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 0x7f1aba0c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe7fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe7cf60>, '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 0xe7dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe7e1d0>, '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': '5cf47e208febbcd81da23b2e0000026f-1481797983.25521-542867285', '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 02:33: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 02:33: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 02:33:25 INFO - Using env: {'DISPLAY': ':0', 02:33:25 INFO - 'HOME': '/home/cltbld', 02:33:25 INFO - 'LANG': 'en_US.UTF-8', 02:33:25 INFO - 'LANGUAGE': 'en_US:en', 02:33:25 INFO - 'LOGNAME': 'cltbld', 02:33:25 INFO - 'MAIL': '/var/mail/cltbld', 02:33:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:25 INFO - 'MOZ_NO_REMOTE': '1', 02:33:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:33:25 INFO - 'NO_EM_RESTART': '1', 02:33:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:33:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:25 INFO - 'PWD': '/builds/slave/test', 02:33:25 INFO - 'SHELL': '/bin/bash', 02:33:25 INFO - 'SHLVL': '1', 02:33:25 INFO - 'TERM': 'linux', 02:33:25 INFO - 'TMOUT': '86400', 02:33:25 INFO - 'USER': 'cltbld', 02:33:25 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1481797983.25521-542867285', 02:33:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:25 INFO - '_': '/tools/buildbot/bin/python'} 02:33:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:33:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:33:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:33:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:33:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:33:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:33:27 INFO - Installing collected packages: mozsystemmonitor 02:33:27 INFO - Running setup.py install for mozsystemmonitor 02:33:27 INFO - Successfully installed mozsystemmonitor 02:33:27 INFO - Cleaning up... 02:33:28 INFO - Return code: 0 02:33:28 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:33: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')]} 02:33:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33: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')]} 02:33:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33: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 0x7f1aba0c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe7fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe7cf60>, '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 0xe7dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe7e1d0>, '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': '5cf47e208febbcd81da23b2e0000026f-1481797983.25521-542867285', '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 02:33: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 02:33: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 02:33:28 INFO - Using env: {'DISPLAY': ':0', 02:33:28 INFO - 'HOME': '/home/cltbld', 02:33:28 INFO - 'LANG': 'en_US.UTF-8', 02:33:28 INFO - 'LANGUAGE': 'en_US:en', 02:33:28 INFO - 'LOGNAME': 'cltbld', 02:33:28 INFO - 'MAIL': '/var/mail/cltbld', 02:33:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:28 INFO - 'MOZ_NO_REMOTE': '1', 02:33:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:33:28 INFO - 'NO_EM_RESTART': '1', 02:33:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:33:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:28 INFO - 'PWD': '/builds/slave/test', 02:33:28 INFO - 'SHELL': '/bin/bash', 02:33:28 INFO - 'SHLVL': '1', 02:33:28 INFO - 'TERM': 'linux', 02:33:28 INFO - 'TMOUT': '86400', 02:33:28 INFO - 'USER': 'cltbld', 02:33:28 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1481797983.25521-542867285', 02:33:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:28 INFO - '_': '/tools/buildbot/bin/python'} 02:33:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:28 INFO - Downloading/unpacking jsonschema==2.5.1 02:33: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 02:33: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 02:33: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 02:33: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 02:33: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 02:33: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 02:33:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:33:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:33: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 02:33: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 02:33: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 02:33: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 02:33: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 02:33: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 02:33:30 INFO - Downloading functools32-3.2.3-2.tar.gz 02:33:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:33:30 INFO - warning: no files found matching '*.txt' 02:33:30 INFO - no previously-included directories found matching 'build' 02:33:30 INFO - no previously-included directories found matching 'dist' 02:33:30 INFO - no previously-included directories found matching '.git*' 02:33:30 INFO - Installing collected packages: jsonschema, functools32 02:33:30 INFO - Running setup.py install for functools32 02:33:30 INFO - warning: no files found matching '*.txt' 02:33:30 INFO - no previously-included directories found matching 'build' 02:33:30 INFO - no previously-included directories found matching 'dist' 02:33:30 INFO - no previously-included directories found matching '.git*' 02:33:30 INFO - Successfully installed jsonschema functools32 02:33:30 INFO - Cleaning up... 02:33:30 INFO - Return code: 0 02:33:30 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:33: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')]} 02:33:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33: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')]} 02:33:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33: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 0x7f1aba0c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe7fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe7cf60>, '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 0xe7dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe7e1d0>, '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': '5cf47e208febbcd81da23b2e0000026f-1481797983.25521-542867285', '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 02:33: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 02:33: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 02:33:30 INFO - Using env: {'DISPLAY': ':0', 02:33:30 INFO - 'HOME': '/home/cltbld', 02:33:30 INFO - 'LANG': 'en_US.UTF-8', 02:33:30 INFO - 'LANGUAGE': 'en_US:en', 02:33:30 INFO - 'LOGNAME': 'cltbld', 02:33:30 INFO - 'MAIL': '/var/mail/cltbld', 02:33:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:30 INFO - 'MOZ_NO_REMOTE': '1', 02:33:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:33:30 INFO - 'NO_EM_RESTART': '1', 02:33:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:33:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:30 INFO - 'PWD': '/builds/slave/test', 02:33:30 INFO - 'SHELL': '/bin/bash', 02:33:30 INFO - 'SHLVL': '1', 02:33:30 INFO - 'TERM': 'linux', 02:33:30 INFO - 'TMOUT': '86400', 02:33:30 INFO - 'USER': 'cltbld', 02:33:30 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1481797983.25521-542867285', 02:33:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:30 INFO - '_': '/tools/buildbot/bin/python'} 02:33:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:30 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:33:30 INFO - Cleaning up... 02:33:30 INFO - Return code: 0 02:33:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:33: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')]} 02:33:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33: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')]} 02:33:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33: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', '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 0x7f1aba0c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe7fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe7cf60>, '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 0xe7dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe7e1d0>, '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': '5cf47e208febbcd81da23b2e0000026f-1481797983.25521-542867285', '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 02:33: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:33: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 blobuploader==1.2.4 02:33:30 INFO - Using env: {'DISPLAY': ':0', 02:33:30 INFO - 'HOME': '/home/cltbld', 02:33:30 INFO - 'LANG': 'en_US.UTF-8', 02:33:30 INFO - 'LANGUAGE': 'en_US:en', 02:33:30 INFO - 'LOGNAME': 'cltbld', 02:33:30 INFO - 'MAIL': '/var/mail/cltbld', 02:33:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:30 INFO - 'MOZ_NO_REMOTE': '1', 02:33:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:33:30 INFO - 'NO_EM_RESTART': '1', 02:33:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:33:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:30 INFO - 'PWD': '/builds/slave/test', 02:33:30 INFO - 'SHELL': '/bin/bash', 02:33:30 INFO - 'SHLVL': '1', 02:33:30 INFO - 'TERM': 'linux', 02:33:30 INFO - 'TMOUT': '86400', 02:33:30 INFO - 'USER': 'cltbld', 02:33:30 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1481797983.25521-542867285', 02:33:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:30 INFO - '_': '/tools/buildbot/bin/python'} 02:33:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:31 INFO - Downloading/unpacking blobuploader==1.2.4 02:33: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 02:33: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 02:33: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 02:33: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 02:33: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 02:33: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 02:33:33 INFO - Downloading blobuploader-1.2.4.tar.gz 02:33:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:33:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:33: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 02:33: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 02:33: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 02:33: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 02:33: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 02:33: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 02:33:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:33:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:33: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 02:33: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 02:33: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 02:33: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 02:33: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 02:33: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 02:33:33 INFO - Downloading docopt-0.6.1.tar.gz 02:33:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:33:33 INFO - Installing collected packages: blobuploader, requests, docopt 02:33:33 INFO - Running setup.py install for blobuploader 02:33:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:33:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:33:33 INFO - Running setup.py install for requests 02:33:34 INFO - Running setup.py install for docopt 02:33:34 INFO - Successfully installed blobuploader requests docopt 02:33:34 INFO - Cleaning up... 02:33:34 INFO - Return code: 0 02:33:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:33: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')]} 02:33:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33: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')]} 02:33:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33: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 0x7f1aba0c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe7fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe7cf60>, '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 0xe7dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe7e1d0>, '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': '5cf47e208febbcd81da23b2e0000026f-1481797983.25521-542867285', '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 02:33: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 02:33: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 02:33:34 INFO - Using env: {'DISPLAY': ':0', 02:33:34 INFO - 'HOME': '/home/cltbld', 02:33:34 INFO - 'LANG': 'en_US.UTF-8', 02:33:34 INFO - 'LANGUAGE': 'en_US:en', 02:33:34 INFO - 'LOGNAME': 'cltbld', 02:33:34 INFO - 'MAIL': '/var/mail/cltbld', 02:33:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:34 INFO - 'MOZ_NO_REMOTE': '1', 02:33:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:33:34 INFO - 'NO_EM_RESTART': '1', 02:33:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:33:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:34 INFO - 'PWD': '/builds/slave/test', 02:33:34 INFO - 'SHELL': '/bin/bash', 02:33:34 INFO - 'SHLVL': '1', 02:33:34 INFO - 'TERM': 'linux', 02:33:34 INFO - 'TMOUT': '86400', 02:33:34 INFO - 'USER': 'cltbld', 02:33:34 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1481797983.25521-542867285', 02:33:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:34 INFO - '_': '/tools/buildbot/bin/python'} 02:33:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:33:34 INFO - Running setup.py (path:/tmp/pip-3l_eHY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:33:34 INFO - Running setup.py (path:/tmp/pip-Ry72Rx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:33:34 INFO - Running setup.py (path:/tmp/pip-DWpymG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:33:34 INFO - Running setup.py (path:/tmp/pip-6pd4OK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:33:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:33:35 INFO - Running setup.py (path:/tmp/pip-X66s7h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:33:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:33:35 INFO - Running setup.py (path:/tmp/pip-4jd3FS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:33:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:33:35 INFO - Running setup.py (path:/tmp/pip-0NjfvU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:33:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:33:35 INFO - Running setup.py (path:/tmp/pip-Pvr6Zk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:33:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:33:35 INFO - Running setup.py (path:/tmp/pip-CN0cb2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:33:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:33:35 INFO - Running setup.py (path:/tmp/pip-OyqwBU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:33:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:33:35 INFO - Running setup.py (path:/tmp/pip-lHaWqT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:33:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:33:35 INFO - Running setup.py (path:/tmp/pip-cp1I85-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:33:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:33:35 INFO - Running setup.py (path:/tmp/pip-n1emEp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:33:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:33:35 INFO - Running setup.py (path:/tmp/pip-x3BoZF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:33:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:33:35 INFO - Running setup.py (path:/tmp/pip-fcxvLx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:33:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:33:35 INFO - Running setup.py (path:/tmp/pip-YlwvIK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:33:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:33:35 INFO - Running setup.py (path:/tmp/pip-ddj4DQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:33:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:33:35 INFO - Running setup.py install for manifestparser 02:33:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:33:36 INFO - Running setup.py install for mozcrash 02:33:36 INFO - Running setup.py install for mozdebug 02:33:36 INFO - Running setup.py install for mozdevice 02:33:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:33:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:33:36 INFO - Running setup.py install for mozfile 02:33:36 INFO - Running setup.py install for mozhttpd 02:33:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:33:36 INFO - Running setup.py install for mozinfo 02:33:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:33:36 INFO - Running setup.py install for mozInstall 02:33:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:33:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:33:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:33:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:33:36 INFO - Running setup.py install for mozleak 02:33:36 INFO - Running setup.py install for mozlog 02:33:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:33:37 INFO - Running setup.py install for moznetwork 02:33:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:33:37 INFO - Running setup.py install for mozprocess 02:33:37 INFO - Running setup.py install for mozprofile 02:33:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:33:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:33:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:33:37 INFO - Running setup.py install for mozrunner 02:33:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:33:37 INFO - Running setup.py install for mozscreenshot 02:33:37 INFO - Running setup.py install for moztest 02:33:37 INFO - Running setup.py install for mozversion 02:33:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:33:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:33:37 INFO - Cleaning up... 02:33:37 INFO - Return code: 0 02:33:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:33:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:33:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:33:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:37 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 0x7f1aba0c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe7fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe7cf60>, '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 0xe7dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe7e1d0>, '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': '5cf47e208febbcd81da23b2e0000026f-1481797983.25521-542867285', '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 02:33:37 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 02:33:37 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 02:33:37 INFO - Using env: {'DISPLAY': ':0', 02:33:37 INFO - 'HOME': '/home/cltbld', 02:33:37 INFO - 'LANG': 'en_US.UTF-8', 02:33:37 INFO - 'LANGUAGE': 'en_US:en', 02:33:37 INFO - 'LOGNAME': 'cltbld', 02:33:37 INFO - 'MAIL': '/var/mail/cltbld', 02:33:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:37 INFO - 'MOZ_NO_REMOTE': '1', 02:33:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:33:37 INFO - 'NO_EM_RESTART': '1', 02:33:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:33:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:37 INFO - 'PWD': '/builds/slave/test', 02:33:37 INFO - 'SHELL': '/bin/bash', 02:33:37 INFO - 'SHLVL': '1', 02:33:37 INFO - 'TERM': 'linux', 02:33:37 INFO - 'TMOUT': '86400', 02:33:37 INFO - 'USER': 'cltbld', 02:33:37 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1481797983.25521-542867285', 02:33:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:37 INFO - '_': '/tools/buildbot/bin/python'} 02:33:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:33:38 INFO - Running setup.py (path:/tmp/pip-23XhzQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:33: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)) 02:33:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:33:38 INFO - Running setup.py (path:/tmp/pip-5DAtqZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:33: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)) 02:33:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:33:38 INFO - Running setup.py (path:/tmp/pip-Rm0bNA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:33: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)) 02:33:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:33:38 INFO - Running setup.py (path:/tmp/pip-WiydHT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:33: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)) 02:33:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:33:38 INFO - Running setup.py (path:/tmp/pip-vakIl7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:33: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)) 02:33:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:33:38 INFO - Running setup.py (path:/tmp/pip-sOcDOc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:33: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)) 02:33:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:33:38 INFO - Running setup.py (path:/tmp/pip-iwt4Ys-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:33: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)) 02:33:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:33:38 INFO - Running setup.py (path:/tmp/pip-2elMTU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:33: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)) 02:33:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:33:38 INFO - Running setup.py (path:/tmp/pip-ztVgTa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:33:38 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)) 02:33:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:33:38 INFO - Running setup.py (path:/tmp/pip-PrdAnM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:33:38 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)) 02:33:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:33:38 INFO - Running setup.py (path:/tmp/pip-dO3INU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:33:38 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)) 02:33:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:33:38 INFO - Running setup.py (path:/tmp/pip-gZgxeF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:33:38 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)) 02:33:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:33:38 INFO - Running setup.py (path:/tmp/pip-M4XFL4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:33: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)) 02:33:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:33:39 INFO - Running setup.py (path:/tmp/pip-MmH7pW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:33: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)) 02:33:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:33:39 INFO - Running setup.py (path:/tmp/pip-RQgG0c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:33: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)) 02:33:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:33:39 INFO - Running setup.py (path:/tmp/pip-QLdJam-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:33: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)) 02:33:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:33:39 INFO - Running setup.py (path:/tmp/pip-_yy58h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:33: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)) 02:33: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)) 02:33: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)) 02:33: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)) 02:33: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)) 02:33: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)) 02:33:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:33: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 02:33: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 02:33: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 02:33: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 02:33: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 02:33: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 02:33:41 INFO - Downloading blessings-1.6.tar.gz 02:33:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:33:41 INFO - Installing collected packages: blessings 02:33:41 INFO - Running setup.py install for blessings 02:33:41 INFO - Successfully installed blessings 02:33:41 INFO - Cleaning up... 02:33:41 INFO - Return code: 0 02:33:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:33:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:33:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:33:41 INFO - Reading from file tmpfile_stdout 02:33:41 INFO - Current package versions: 02:33:41 INFO - argparse == 1.2.1 02:33:41 INFO - blessings == 1.6 02:33:41 INFO - blobuploader == 1.2.4 02:33:41 INFO - docopt == 0.6.1 02:33:41 INFO - functools32 == 3.2.3-2 02:33:41 INFO - jsonschema == 2.5.1 02:33:41 INFO - manifestparser == 1.1 02:33:41 INFO - mozInstall == 1.12 02:33:41 INFO - mozcrash == 1.0 02:33:41 INFO - mozdebug == 0.1 02:33:41 INFO - mozdevice == 0.48 02:33:41 INFO - mozfile == 1.2 02:33:41 INFO - mozhttpd == 0.7 02:33:41 INFO - mozinfo == 0.9 02:33:41 INFO - mozleak == 0.1 02:33:41 INFO - mozlog == 3.4 02:33:41 INFO - moznetwork == 0.27 02:33:41 INFO - mozprocess == 0.23 02:33:41 INFO - mozprofile == 0.28 02:33:41 INFO - mozrunner == 6.13 02:33:41 INFO - mozscreenshot == 0.1 02:33:41 INFO - mozsystemmonitor == 0.3 02:33:41 INFO - moztest == 0.7 02:33:41 INFO - mozversion == 1.4 02:33:41 INFO - psutil == 3.1.1 02:33:41 INFO - requests == 1.2.3 02:33:41 INFO - wsgiref == 0.1.2 02:33:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:33:41 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')]} 02:33:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:41 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')]} 02:33:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:41 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 0x7f1aba0c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe7fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe7cf60>, '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 0xe7dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe7e1d0>, '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': '5cf47e208febbcd81da23b2e0000026f-1481797983.25521-542867285', '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 02:33:41 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 02:33:41 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 02:33:41 INFO - Using env: {'DISPLAY': ':0', 02:33:41 INFO - 'HOME': '/home/cltbld', 02:33:41 INFO - 'LANG': 'en_US.UTF-8', 02:33:41 INFO - 'LANGUAGE': 'en_US:en', 02:33:41 INFO - 'LOGNAME': 'cltbld', 02:33:41 INFO - 'MAIL': '/var/mail/cltbld', 02:33:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:41 INFO - 'MOZ_NO_REMOTE': '1', 02:33:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:33:41 INFO - 'NO_EM_RESTART': '1', 02:33:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:33:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:41 INFO - 'PWD': '/builds/slave/test', 02:33:41 INFO - 'SHELL': '/bin/bash', 02:33:41 INFO - 'SHLVL': '1', 02:33:41 INFO - 'TERM': 'linux', 02:33:41 INFO - 'TMOUT': '86400', 02:33:41 INFO - 'USER': 'cltbld', 02:33:41 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1481797983.25521-542867285', 02:33:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:41 INFO - '_': '/tools/buildbot/bin/python'} 02:33:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:41 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)) 02:33:41 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)) 02:33:41 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)) 02:33:41 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)) 02:33:41 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)) 02:33:41 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)) 02:33:41 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)) 02:33:41 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)) 02:33:41 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)) 02:33:41 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)) 02:33:41 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)) 02:33:41 INFO - Cleaning up... 02:33:41 INFO - Return code: 0 02:33:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:33:41 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')]} 02:33:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:41 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')]} 02:33:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:41 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 0x7f1aba0c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe7fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe7cf60>, '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 0xe7dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe7e1d0>, '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': '5cf47e208febbcd81da23b2e0000026f-1481797983.25521-542867285', '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 02:33:41 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 02:33:41 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 02:33:41 INFO - Using env: {'DISPLAY': ':0', 02:33:41 INFO - 'HOME': '/home/cltbld', 02:33:41 INFO - 'LANG': 'en_US.UTF-8', 02:33:41 INFO - 'LANGUAGE': 'en_US:en', 02:33:41 INFO - 'LOGNAME': 'cltbld', 02:33:41 INFO - 'MAIL': '/var/mail/cltbld', 02:33:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:41 INFO - 'MOZ_NO_REMOTE': '1', 02:33:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:33:41 INFO - 'NO_EM_RESTART': '1', 02:33:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:33:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:41 INFO - 'PWD': '/builds/slave/test', 02:33:41 INFO - 'SHELL': '/bin/bash', 02:33:41 INFO - 'SHLVL': '1', 02:33:41 INFO - 'TERM': 'linux', 02:33:41 INFO - 'TMOUT': '86400', 02:33:41 INFO - 'USER': 'cltbld', 02:33:41 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1481797983.25521-542867285', 02:33:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:41 INFO - '_': '/tools/buildbot/bin/python'} 02:33:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:33:42 INFO - Cleaning up... 02:33:42 INFO - Return code: 0 02:33:42 INFO - Running post-action listener: _resource_record_post_action 02:33:42 INFO - Running post-action listener: _start_resource_monitoring 02:33:42 INFO - Starting resource monitoring. 02:33:42 INFO - [mozharness: 2016-12-15 10:33:42.199605Z] Finished create-virtualenv step (success) 02:33:42 INFO - [mozharness: 2016-12-15 10:33:42.200069Z] Running install step. 02:33:42 INFO - Running pre-action listener: _resource_record_pre_action 02:33:42 INFO - Running main action method: install 02:33:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:33:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:33:42 INFO - Reading from file tmpfile_stdout 02:33:42 INFO - Detecting whether we're running mozinstall >=1.0... 02:33:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:33:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:33:42 INFO - Reading from file tmpfile_stdout 02:33:42 INFO - Output received: 02:33:42 INFO - Usage: mozinstall [options] installer 02:33:42 INFO - Options: 02:33:42 INFO - -h, --help show this help message and exit 02:33:42 INFO - -d DEST, --destination=DEST 02:33:42 INFO - Directory to install application into. [default: 02:33:42 INFO - "/builds/slave/test"] 02:33:42 INFO - --app=APP Application being installed. [default: firefox] 02:33:42 INFO - mkdir: /builds/slave/test/build/application 02:33: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'] 02:33: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 02:33:59 INFO - Reading from file tmpfile_stdout 02:33:59 INFO - Output received: 02:33:59 INFO - /builds/slave/test/build/application/firefox/firefox 02:33:59 INFO - Running post-action listener: _resource_record_post_action 02:33:59 INFO - [mozharness: 2016-12-15 10:33:59.562446Z] Finished install step (success) 02:33:59 INFO - [mozharness: 2016-12-15 10:33:59.562688Z] Running run-tests step. 02:33:59 INFO - Running pre-action listener: _resource_record_pre_action 02:33:59 INFO - Running main action method: run_tests 02:33:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:33:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:33:59 INFO - Python 2.7.3 02:33:59 INFO - Return code: 0 02:33:59 INFO - grabbing minidump binary from tooltool 02:33:59 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')]} 02:33:59 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 0xe7cf60>, '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 0xe7dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe7e1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:33:59 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 02:33:59 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 02:33:59 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 02:33:59 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:33:59 INFO - Return code: 0 02:33:59 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:33:59 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:33:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:33:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:33:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:33:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dYncMFW1RoaJz4xmuryazQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 02:33:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dYncMFW1RoaJz4xmuryazQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-011 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 02:33:59 INFO - Using env: {'DISPLAY': ':0', 02:33:59 INFO - 'HOME': '/home/cltbld', 02:33:59 INFO - 'LANG': 'en_US.UTF-8', 02:33:59 INFO - 'LANGUAGE': 'en_US:en', 02:33:59 INFO - 'LOGNAME': 'cltbld', 02:33:59 INFO - 'MAIL': '/var/mail/cltbld', 02:33:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:33:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:33:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:59 INFO - 'MOZ_NO_REMOTE': '1', 02:33:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:33:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:33:59 INFO - 'NO_EM_RESTART': '1', 02:33:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:33:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:59 INFO - 'PWD': '/builds/slave/test', 02:33:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:33:59 INFO - 'SHELL': '/bin/bash', 02:33:59 INFO - 'SHLVL': '1', 02:33:59 INFO - 'TERM': 'linux', 02:33:59 INFO - 'TMOUT': '86400', 02:33:59 INFO - 'USER': 'cltbld', 02:33:59 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1481797983.25521-542867285', 02:33:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:59 INFO - '_': '/tools/buildbot/bin/python'} 02:33:59 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dYncMFW1RoaJz4xmuryazQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 02:33:59 INFO - mozversion application_buildid: 20161215004017 02:33:59 INFO - mozversion application_changeset: 7e3a96f3ee277bc54a695ed54f60228984de2a7f 02:33:59 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:33:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:33:59 INFO - mozversion application_name: Firefox 02:33:59 INFO - mozversion application_remotingname: firefox-dev 02:33:59 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:33:59 INFO - mozversion application_vendor: Mozilla 02:33:59 INFO - mozversion application_version: 52.0a2 02:33:59 INFO - mozversion platform_buildid: 20161215004017 02:33:59 INFO - mozversion platform_changeset: 7e3a96f3ee277bc54a695ed54f60228984de2a7f 02:33:59 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:33:59 INFO - mozversion platform_version: 52.0a2 02:33:59 INFO - using testdate: 1481798039 02:33:59 INFO - actual date: 1481798039 02:33:59 INFO - starting webserver on 'localhost:38804' 02:33:59 INFO - SUITE-START | Running 2 tests 02:33:59 INFO - TEST-START | dromaeo_css 02:33:59 INFO - operating with platform_type : linux_ 02:33:59 INFO - Initialising browser for dromaeo_css test... 02:33:59 INFO - TEST-INFO | started process 13024 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8RlJBp/profile http://localhost:38804/getInfo.html) 02:34:05 INFO - PROCESS | 13024 | __metrics Screen width/height:1600/1200 02:34:05 INFO - PROCESS | 13024 | colorDepth:24 02:34:05 INFO - PROCESS | 13024 | Browser inner width/height: 1024/697 02:34:05 INFO - PROCESS | 13024 | __metrics 02:34:06 INFO - PROCESS | 13024 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:34:06 INFO - PROCESS | 13024 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:34:06 INFO - PROCESS | 13024 | console.error: PushService: 02:34:06 INFO - PROCESS | 13024 | stateChangeProcessEnqueue: Error transitioning state 02:34:06 INFO - PROCESS | 13024 | UnknownError 02:34:07 INFO - TEST-INFO | 13024: exit 0 02:34:07 INFO - Browser initialized. 02:34:07 INFO - Running cycle 1/1 for dromaeo_css test... 02:34:07 INFO - TEST-INFO | started process 13114 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8RlJBp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:34:19 INFO - PROCESS | 13114 | RSS: Main: 144412672 02:34:19 INFO - PROCESS | 13114 | 02:35:10 INFO - PROCESS | 13114 | 1481798110925 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] 02:37:21 INFO - PROCESS | 13114 | Cycle 1(1): loaded http://localhost:38804/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38804/tests/dromaeo/cssquery-ext.html) 02:37:22 INFO - PROCESS | 13114 | RSS: Main: 243281920 02:37:22 INFO - PROCESS | 13114 | 02:40:25 INFO - PROCESS | 13114 | Cycle 1(1): loaded http://localhost:38804/tests/dromaeo/cssquery-ext.html (next: http://localhost:38804/tests/dromaeo/cssquery-jquery.html) 02:40:25 INFO - PROCESS | 13114 | RSS: Main: 235950080 02:40:25 INFO - PROCESS | 13114 | 02:43:27 INFO - PROCESS | 13114 | Cycle 1(1): loaded http://localhost:38804/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38804/tests/dromaeo/cssquery-mootools.html) 02:43:28 INFO - PROCESS | 13114 | RSS: Main: 233459712 02:43:28 INFO - PROCESS | 13114 | 02:46:30 INFO - PROCESS | 13114 | Cycle 1(1): loaded http://localhost:38804/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38804/tests/dromaeo/cssquery-prototype.html) 02:46:30 INFO - PROCESS | 13114 | RSS: Main: 172978176 02:46:30 INFO - PROCESS | 13114 | 02:49:33 INFO - PROCESS | 13114 | Cycle 1(1): loaded http://localhost:38804/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38804/tests/dromaeo/cssquery-yui.html) 02:49:33 INFO - PROCESS | 13114 | RSS: Main: 176017408 02:49:33 INFO - PROCESS | 13114 | 02:52:36 INFO - PROCESS | 13114 | Cycle 1(1): loaded http://localhost:38804/tests/dromaeo/cssquery-yui.html (next: http://localhost:38804/tests/dromaeo/cssquery-dojo.html) 02:52:36 INFO - PROCESS | 13114 | RSS: Main: 265646080 02:52:36 INFO - PROCESS | 13114 | 02:52:36 INFO - PROCESS | 13114 | __start_tp_report 02:52:36 INFO - PROCESS | 13114 | _x_x_mozilla_page_load 02:52:36 INFO - PROCESS | 13114 | _x_x_mozilla_page_load_details 02:52:36 INFO - PROCESS | 13114 | |i|pagename|runs| 02:52:36 INFO - PROCESS | 13114 | |0;dojo.html;3226.887058952937;3265.999999999999;3269.133679574913;3289.9177520562;3311.834408279587;5505.284313039304;5561.416051314614;5579.776808927648;5583;5585.972070139649;5506.421825708293;5579.832605021856;5583.469570390816;5584.106542953128;5608.046632072547;4998.3252260944855;5017.448080711137;5030.320906677588;5085.313482679828;5103.26002729604;4928.581070608984;4946.233333833244;5052.9747351263195;5096.974515127419;5103.41310749263;4995.850124496271;5009.098362294803;5013.623978201649;5015.849524514252;5052.545270925616;5050.545450909399;5066.771995260186;5132.794688212467;5140.511651393112;5168.948310516885;4857.78139983698;5020.221865610836;5034.672746271517;5071.442141364447;5102.846914592568;5489;5491.423400542965;5512.586556008316;5559.805406810783;5569.387367389584;5946.70266486674;5960;5981.790637327673;6077.0276755719315;6084.421979911901;6084.30030546484;6113.388661133851;6128.877422451571;6130.325664176937;6135;5450.4822041906355;5494.395616482184;5572.136318870582;5623.100303951348;5632.690202038927;6159;6192.287886892975;6195.411435913581;6198.81403557894;6205;5926.67403292823;5928.466438020599;5941;5944.7027648617395;5945.435183657545;5753.741081651336;5817.650940943472;5833.241678581757;5905.527557795366;5906.793262235801;5956.6723830188885;5957.434043765836;5960.254968128984;5961.5230781537375;5982.700864956735;5898.793542226002;5928.67392293428;5956.374580668968;5966.105084237312;5985.132155837379;4502.212112880298;4543.454785425704;4550;4577.885552861205;4636.397268355092;4079.5104587449696;4106.07613287014;4129.174165166918;4137.110521237948;4145.523264824584;5658.688772117491;5659;5662.094064949588;5664.745086471119;5669.603127781016;5855.180274761537;5860.853478663067;5919.4080591940465;5958.612690175125;5958.821235362946;5595.552355811526;5662.462066103713;5665.2635157430095;5670.262865827416;5696.3733989261145;4994.350734404504;4998.375203099613;5002.799888004512;5004;5027.622928280393;6071.939280607137;6162.753489860355;6239.282482514478;6245.406686364879;6248.375162483715;5857;5875.853103672443;5881.882362352814;5982.4316689914385;6014.338422773404;6216.43856106492;6225.657588832658;6244.219472565929;6244.843878903063;6252.468540173954;5678.858028549319;5861.853453663693;5869.442402971711;5872.1778950946045;5906.763729450946;5750.856228594152;5946.464818166386;5965.403459654173;6004.1294012368835;6067.817965461043;5827.562932779973;5869.8239052828485;5877.676727780014;5880.88263230002;5886.264216972879;5915.40845915405;5917.615355001911;5929.644221346733;5930;5936.940630593639;5625.690587017753;5706.714664266853;5724.341700704473;5745.396733342939;5762.654240745569;5858.882822343615;5878.177055212188;5892.705364731832;5893.616914900518;5896.7936122235515;5580.497755202051;5614.971925140511;5714.285714285715;5723.456271654186;5724.055530837365 02:52:36 INFO - PROCESS | 13114 | |1;ext.html;591.46767908882;626.4549841637776;637.7672149665372;640.5836206465797;645.8740545593605;31497.425128743587;46542;47355.76322118393;47403.28895066577;47459.76270118653;46622.533774662246;46719.76640116803;46996.29505557419;47018.0596388072;47072;8075.838483230332;8278.254957053863;8868.068852770446;9009.054049324825;9019.594118264693;10589.099926506256;10857.022867941883;10872.61945831896;11197.27217730849;11198.048165905908;10913.508892099835;10982.286151400174;10989.395583242918;10989.945050274737;10993;10689.091427228617;10710.089642380408;10763.461826908624;10776.40729759859;10780.137588992862;10740.516676749565;10773.299735517166;10813.08088812452;10815.134789216923;10820.188485863591;43786.34320485195;44163;44187.337189942176;44191;44234.33648495275;3634.0914771307175;3834.3673293906472;3851.287511810324;3922.490076290064;4084.9183016339507;31445.842770786;33543.329133417436;34270.31459370798;34888.82555587231;35476.46785298223;4242;4294.871153865389;4335.3063509838275;4375.409319741826;4502.2571275739465;378416;386214.9999999972;387530;387657;387690;39869.60130398717;40948;68599;69157;69447.3055269451;43146.13707725828;43233.567664323586;43307.783461082494;43309.56690433055;43345.56654433478;17585.824141758676;17751.911240443715;17771.378001769877;17776.288948442176;17784;12820.35898205086;13056.543020994219;13067.411966461532;13413.597592072254;14427.49503767363;9409.153176214037;9705.12653861156;9705.951470242604;9926.404415735078;9952.25358098131;3454.4818277258614;3514.9648503514636;3534.54050973377;3565.4830049642655;3586.5696116466193;969.3650658818485;1128.5260190719916;1149.287441786098;1193.2065176657425;1202.753435545711;31211.687883120878;32024;32076.83961580177;32336.35327293488;32400.837995810343;956.7560272130562;1096.9451527423757;1100.6863044032573;1149.201305092969;1177.5054477119459;15178.772318415233;17697.76322967797;17991.460256192335;18183.545411364823;18202.817971820376;556242;557397;559262;559392;559871;62430;62825.371746282864;63091.684541577;63141.68429157825;63237.36762632315;1224.1736827641307;1236.6599185224136;1379.827521559805;1383.100984360174;1391.979120313196;32766.83616581902;35158.47262291119;35356.823215883756;38326.80836595799;38464.80767596256;59488;59986.70006650114;60046.699766502636;60125.39874601198;60187;496216;498070;501893;503024;503597;26229.081982130534;26415.735842641327;30547.389052219274;31457.8427107863;31503.21241968969;39725;47671.76164119157;49642.25536617026;49666.255006174215;53877.46122538881;42472.78763606162;44021.33967990419;44677.77661111674;45314.546854531036;46242.7687861572;41914.37128443015;42243.7887810559;43079;44392.334114988946;44820.32769508525;42009;42942.141157177306;42988.570114298454;43043.56956430396;43361.566384335754;35993.820030899675;37984.43023354707;38507.80746096252;38981.41527877028;39075.80462097671;29417.11748647544;29639.851800740857;29648.258793530335;29964;30086.69913300839 02:52:36 INFO - PROCESS | 13114 | |2;jquery.html;413.02938095475616;416.1697413659749;421.51104718526506;427.39310179545043;439.4309369366672;19107.853528788284;19627.803721962777;19979.500512487197;20322;20363.49091272719;18087.72868406975;18813.059347032628;19083.809161908375;19572.41282761516;19952.900235498837;5054.924176137351;5259.737013149346;5306.230596563496;5351.973240133794;5363.275957745713;5178.378594568657;5311.389190243133;5328.0675881720545;5331.440198779131;5334.226537152111;5273.367195936493;5371.435999220064;5380;5380.542653874425;5386.003589335985;5346.973265133688;5353.063213937565;5355.143177091666;5357.544608708284;7049.189343225544;7034.155901291827;7169.068021157216;7197.1363436387965;7200.783976480661;7205.207427183006;26735.19794406171;26932.192034239004;27029.459410811673;27759.583606245924;27987.160385188476;2523.116909081825;2581.174024312221;2697.379602691392;2828.0808737160505;3067.1871953932227;7536.547807131589;7559.69761209551;7643.312101910799;8354.45696029756;15109.471168509159;2030.5634288628016;2133.208105191631;2160.5030842906062;2208.845380823343;2232.8883555822144;100806.49596752043;101013.4949325256;101197.49401253021;101314;102467;18647.627047458976;19471.4158575243;19513.317033903746;20149.899250503946;20693.344532437368;34589.30821383558;34647.480287795704;34653.48019779706;34990.12524686852;35131.297374052374;10499.68500944973;10523.52644131016;10683.89316106829;10684.51919663617;11004;9023.187913087853;9037.909620903838;9045.412048216846;9310.906890931139;9320.254379649612;9063.41087829289;9232.815343693088;9303.302252331103;9379.577918993662;9571.521423928776;3640.967867361845;3651.507046548682;3652.908677283089;3656.8537258509364;3713.2573485302505;940.3182692547848;991.5191132300828;1003.7992401519725;1077.5582011375297;1097.7530055737554;20575.897120514303;21045.684314735292;21088;21299.615524990826;21537.353879383645;982.8181786369402;1022.7340891368298;1029.9485025748684;1086.3861918016296;1104.5526561742506;10580.735481612868;11696.88303116975;11841.23032002917;11847.822282665767;11870.465829037714;435862;438011;443102;443177;444186;53961.730191349576;53978.46021539813;82540;85364;91414;1007.6825799873017;1023.9641612543526;1056.4506456642503;1092.7268182954263;1096.6764804382726;18410.631787364444;18785.90607046956;18804.247830086642;18973.43079707611;19343.709844352627;41419;41634.75478678101;42086;42247.78876105723;43666.781666092735;56640.43359566516;57461.425385745606;58390.4160958385;58480.4151958475;59339.40660593512;8615.267702245128;8943.23982461498;9002.954985225031;9108.407953483002;9709.969094658434;12403.824661616789;12613.30626815534;13366;13599.320033998458;14147.575572732834;10899.891001089887;11430.828537571777;11467;11550.191486595857;11887.465064071965;11213.71965700864;11338.716532086764;11543.711407214887;11575.710607234887;12005.63983080509;11499.770004600028;11590.768184636092;11655.009324207538;11798.646040618794;12008.219465734699;8184.508929464251;8356.456830306011;8392.244697977212;8909.821803563762;9162.816743665222;8919.687810926587;11042.282251653938;11385.259958102697;11714.907443288479;11774.705632359259 02:52:36 INFO - PROCESS | 13114 | |3;mootools.html;1508.3212554350541;1541.5375387383785;1695.448979081798;1751.1856986501275;1838.0625880800796;8625.094365091662;9254.768630784234;9274.397164184324;9274.48990305533;9285.7678558036;7583.924160758391;7771.844563108734;7778.338841198491;7971.282584567388;9093.681721139761;2228.810551103154;2386.248331775485;2458.6312053192073;2463.359526523108;2473.208573256559;2470.357212453725;2516.4338023944647;2520.243926821946;2524.7222805491383;2528.1657053172503;2510.146550172941;2512.1835403493938;2533.1893793985932;2534.6578211941337;2536;2478.7025556933104;2492.962605560918;2498.0757119865584;2501.262127672341;2503.349129226396;2468.469279105001;2490.8007359411204;2502.349389158832;2507.4734305795805;2507.749225077496;9075.954620226923;9090.181883630505;9121.361504694674;9129.132732390412;9131.817363652755;5553.222548843165;5695.031844586389;5713.285839270091;5719.056355701305;5724.227229324029;3431.656834316573;3461.498082777983;3663.139162296885;3706.388445906422;3710.3321402147603;1137.5677242647823;1144.7653231087606;1168.8480497535352;1199.1725709260581;1205.6804946689135;12237.082218833622;12250.203736757172;12260.570880019157;12288.1398302118;12369.69075773104;4690.226112691436;4863.221884498464;4970.850874473772;4986.675866068694;5135.537801597874;10562.260641755003;10564.683059508227;10576.259661823598;10586.470676466146;10598.152147828156;5647.237622920853;5648.322201335784;5664.320281566238;5667.121596152603;5679.204911312419;4423.358613001097;4988.351514303117;5065.012322597132;5139.331886854685;5177.4822517747925;3643.799591022519;3977.204559088194;4019.457373254632;4099.200655872136;4102.610252026053;1195.061876427018;1217.2331431198288;1217.7686239614445;1219.5487669562142;1225.0628269373758;924.3160061554402;987.8123156600223;993.5429702336861;1029.9279050466396;1039.3400190878695;6388.7125079371535;6412.294647588761;6422.100905873182;6462.903056454157;6559.47524198063;962.9374090684223;968.1673760565908;973.532704301939;984.867042949207;1055.767731099157;4161.97919010403;4352.651787856964;4360.978195109067;4367.781610919505;4468.865934021985;11145.387003714712;11429.314241145557;11461.598844040418;11506;11512.59705910289;11222.887771122347;11239.887601123884;11428.371439570737;11457.54169833214;11497.827532587018;8513.574321284035;8585.31317494599;8588.613512391958;8656.22094011542;8674.56627168639;6044.848878778066;6105.114758359924;6152.938470615237;6161.383861613982;6195.721192546256;10427.53076111592;10518.526666299882;10525.684229472821;10538.473076346;10566.682999510027;10387.169026477712;10456.47717614101;10623;10786.892131078588;10811.459427028774;7005.22942476317;7680.5391676499585;7815.804604884696;7833.960830195812;7839.25527074927;8072.677092916218;8590.570471476276;8920.063393343866;8924.196822286025;8957.238634716123;8030.5181689098845;8260.173982601691;8278.337732981227;8470.364722645949;8488.872666910125;8034.076081250497;8127.390445716476;8156.0620528639965;8223.301019413417;8467.322614190727;6797.93202067973;6960.825979350557;7030.683619237045;7190.6404679764755;7263.0921134858145;5513.972430137984;5569.136783798518;5587.5809314302405;5663.575231857545;5801.912971305518;5541.362743284412;5632.408597097246;5650.29371328584;5713.914291285717;5846.6784326862435 02:52:36 INFO - PROCESS | 13114 | |4;prototype.html;344.73799912066823;353.56158363629106;354.9911252218695;359.2366221778719;360.5331096230381;5274.604404669651;5286.392064912537;5287.228778359249;5313.681179129255;5329.866753331169;5212.843614691556;5226.529612334899;5241.973790131044;5245.632805703603;5276.2085687146855;4110.177964407116;4185.560516145806;4222.451081359434;4234.61888430042;4254.4469219001485;4196.790160491979;4206.726562773425;4208.158368326347;4211.957880421187;4252.574742525738;4166.250074986501;4168.7081904266715;4178.206140833247;4198.496180458349;4221.810018549173;3985.4818873546396;4073.572274911136;4078.4086307485545;4149.481314835645;4151.252774500589;3685.4471829225563;3694.9815250923843;3698.3158115748674;3702.6667599916136;3711.536057992751;4888.462269150391;5068.239764035424;5076.705440112784;5090.898182036375;5107.61692873036;4539.931901021488;4590.006933394535;4677.555632214934;4702.976485117587;4737.1946769049;5411.242426060355;5419.3225846769155;5436.2661040759385;5437.075697131497;5441.863953401196;3825.565412970136;4101.589841015874;4102.179564087194;4107.9178416431805;4111.9177616447805;5627.8593035174035;5664.660120392789;5680.943190568124;5681.829545113695;5696.829095127153;4131.612078095933;4132.938005929914;4135.958640413557;4136;4147.605977432139;4186.28833098374;4190.182914331676;4196;4202.936955945664;4205.957940420618;4450.310201918643;4660.184467718136;4661.930071048869;4662.650301227353;4674.836380726726;5506.779728810883;5508.504234618824;5508.55931525477;5513.2005859150195;5533.723313834292;1389.9166050037031;1393.261571367177;1407.099456347938;1409.873111419977;1411.8870490360746;919.7608621758391;942.6606421688186;948.6205517792938;953.9618415263451;958.3531116496337;5095.8726031848755;5134.870328527718;5138.665986710852;5185.299984502044;5192.428832828386;5381.600783796162;5389.811356602579;5407.161889906992;5431.6740995540395;5466.851961088216;5077.390713114376;5169.121249387613;5203.557697595671;5390.191471279261;5398.73006349681;2747.5466548019353;2836.971630283712;2887.595736596878;2893.811902226391;2900.622919020514;5684.403137670485;5729.88540229193;5739;5781.682007489629;5782;5479.4520547945685;5529.589954561641;5567.47109024642;5587.7485513152005;5597.468240517144;5637.915431268534;5668.1295172592945;5710.65736055838;5733.0540460823495;5733.369329373765;5415.6479828811;5442.530516760374;5450.400455949763;5461.699606521521;5465.754041068082;5359.598030147832;5591.552675785846;5594.216809646571;5615.382307946041;5617.410171931889;5893.911591326219;5923;5928.851778705394;5996.2504686914135;6025.397460254115;4081.8367265309057;4155.522114956819;4155.97922010388;4180.749155050707;4202.138561594927;5644.971775141098;5645.9153112702525;5652.689102099424;5653.40639232891;5659.660420374791;5508;5529.060059789926;5531.695756733418;5533.446655334435;5554.1946417770005;5395.136778115482;5482.835514934558;5509.457351941463;5518.751656175402;5545.7781688732;5444.509994100392;5449.1826226066405;5452.836414907559;5460.672359658433;5464.699441530595;5423.538999185113;5537.446255374431;5561.777528898799;5576.888462230651;5602.747876345493;5377.542908852635;5397.8110766123;5420.593455490933;5423.7830486780085;5423.945760542344 02:52:36 INFO - PROCESS | 13114 | |5;yui.html;771.8147644565303;779.3414564692839;788.1448628238361;849.2993280543552;907.246985002448;14778.26108694565;15296.388144474235;15466.767998480018;15506.379744810221;15567.84432155678;12269.877301226985;13989.510367137153;14055.718885622282;14083.155010699365;14100.717985640307;856.8500512410319;881.4843316659761;884.9159329863653;885.0795173020051;885.5262434597491;876.9342299327544;880.5905254056862;883.3021912688968;883.3066043156124;883.4875772052227;922.5986695787354;923.1230331185367;925.0333401595349;925.079545851875;926.073926073926;905.7554460295717;908.2416182487631;913.2739472119614;914.7987442762615;914.8307563100848;674.4132604633951;674.5109795398346;674.7368526274756;674.81442603284;675.1864003875319;13335.131867527934;13626.863731362757;14258;14265.144091354552;14391.928040359835;12385.75228495434;12466.626001219978;12896.677583060406;13031.609051728463;13155.605331839964;10940.890591094147;10997.560097596166;11128.109751219883;11301.604443844508;11922.940385298105;3808.352580061396;3829.4064420014943;3835.5397352317623;3938.6652134568594;3943.2310699413624;65325;69043;69424.3057569423;69973.65013174953;70493.29506704918;11496.885031149748;11714.110789783961;11757.412129393497;11796.174267801172;11966.282023078644;21014.579708405745;21050.368488945354;21170.153193872382;21186.470338241666;21315;8399.160083991552;8440.40917135807;8494.575271236414;8613.310935125175;8620.78448038804;4664.65015123867;4863.562279394871;4890.046440943982;4895.755212239374;4899.779509922062;3577.964220357815;3698.7965661888857;3699.7780133192095;3708.851645934132;3709.7588656737767;657.7401926239204;667.8864593019198;684.6850448793512;693.2997672350962;706.7491040680587;680.1498127340824;698.9720411183496;735.7755884455293;760.3840888880025;807.3258828877836;9034.819303614022;9752;9975;10447.582096716047;10532.631357902437;720.2113685514354;725.742361461684;738.3945164964784;746.8655641984386;751.2712668711341;4445.133199026223;4545.340925565841;4548.181327361107;4617.076584683077;4619.653525985565;91882;91904.54047729852;95119.52440237754;95670;96102;52998.73500632472;63415.36584634187;64203.35796641974;65238.67380663161;67587;67241.66379168171;67267.32732672709;67558;67611.66194168998;68031.31968680349;9656.9034309656;10078.949605251926;10286.691399258034;10366.481675916324;10525;41661;43136.568634313255;43612.78193609012;46486.30270546012;47902.760486197345;58780.4121958792;59747;59859.700701496215;62703;62793.37206628058;12387.62837114888;12495.437705303102;12969.221846689228;13088.607341779762;13672.248026358646;12417.875821241672;12978.805317920427;13262.602121936357;13759.38082786257;14419.711605768036;13158.934205328913;13217.801732974205;13426.932865335611;13621.931890340486;14269.42922283097;12996.740065198832;13011.804822927854;13302.733945320846;13405.396757146147;13689.86310136886;12919.483220671067;12972.545960891324;12997;13209.141405808592;13632.386542605806;10306.948465257627;10358.741031474274;10633.317395808603;10693.786124277627;11642.883571164519;10948.39783811866;11274.605388811353;11313;11470.082393408675;11798.646040618794 02:52:36 INFO - PROCESS | 13114 | __end_tp_report 02:52:36 INFO - PROCESS | 13114 | __start_cc_report 02:52:36 INFO - PROCESS | 13114 | _x_x_mozilla_cycle_collect,1039 02:52:36 INFO - PROCESS | 13114 | __end_cc_report 02:52:36 INFO - PROCESS | 13114 | __startTimestamp1481799156679__endTimestamp 02:52:36 INFO - PROCESS | 13114 | 02:52:36 INFO - PROCESS | 13114 | ------- Summary: start ------- 02:52:36 INFO - PROCESS | 13114 | Number of tests: 6 02:52:36 INFO - PROCESS | 13114 | 02:52:36 INFO - PROCESS | 13114 | [#0] dojo.html Cycles:165 Average:5540.45 Median:5724.06 stddev:634.10 (11.1%) stddev-sans-first:609.52 02:52:36 INFO - PROCESS | 13114 | Values: 3226.9 3266.0 3269.1 3289.9 3311.8 5505.3 5561.4 5579.8 5583.0 5586.0 5506.4 5579.8 5583.5 5584.1 5608.0 4998.3 5017.4 5030.3 5085.3 5103.3 4928.6 4946.2 5053.0 5097.0 5103.4 4995.9 5009.1 5013.6 5015.8 5052.5 5050.5 5066.8 5132.8 5140.5 5168.9 4857.8 5020.2 5034.7 5071.4 5102.8 5489.0 5491.4 5512.6 5559.8 5569.4 5946.7 5960.0 5981.8 6077.0 6084.4 6084.3 6113.4 6128.9 6130.3 6135.0 5450.5 5494.4 5572.1 5623.1 5632.7 6159.0 6192.3 6195.4 6198.8 6205.0 5926.7 5928.5 5941.0 5944.7 5945.4 5753.7 5817.7 5833.2 5905.5 5906.8 5956.7 5957.4 5960.3 5961.5 5982.7 5898.8 5928.7 5956.4 5966.1 5985.1 4502.2 4543.5 4550.0 4577.9 4636.4 4079.5 4106.1 4129.2 4137.1 4145.5 5658.7 5659.0 5662.1 5664.7 5669.6 5855.2 5860.9 5919.4 5958.6 5958.8 5595.6 5662.5 5665.3 5670.3 5696.4 4994.4 4998.4 5002.8 5004.0 5027.6 6071.9 6162.8 6239.3 6245.4 6248.4 5857.0 5875.9 5881.9 5982.4 6014.3 6216.4 6225.7 6244.2 6244.8 6252.5 5678.9 5861.9 5869.4 5872.2 5906.8 5750.9 5946.5 5965.4 6004.1 6067.8 5827.6 5869.8 5877.7 5880.9 5886.3 5915.4 5917.6 5929.6 5930.0 5936.9 5625.7 5706.7 5724.3 5745.4 5762.7 5858.9 5878.2 5892.7 5893.6 5896.8 5580.5 5615.0 5714.3 5723.5 5724.1 02:52:36 INFO - PROCESS | 13114 | 02:52:36 INFO - PROCESS | 13114 | [#1] ext.html Cycles:180 Average:64097.16 Median:39028.61 stddev:129288.44 (331.3%) stddev-sans-first:129563.20 02:52:36 INFO - PROCESS | 13114 | Values: 591.5 626.5 637.8 640.6 645.9 31497.4 46542.0 47355.8 47403.3 47459.8 46622.5 46719.8 46996.3 47018.1 47072.0 8075.8 8278.3 8868.1 9009.1 9019.6 10589.1 10857.0 10872.6 11197.3 11198.0 10913.5 10982.3 10989.4 10989.9 10993.0 10689.1 10710.1 10763.5 10776.4 10780.1 10740.5 10773.3 10813.1 10815.1 10820.2 43786.3 44163.0 44187.3 44191.0 44234.3 3634.1 3834.4 3851.3 3922.5 4084.9 31445.8 33543.3 34270.3 34888.8 35476.5 4242.0 4294.9 4335.3 4375.4 4502.3 378416.0 386215.0 387530.0 387657.0 387690.0 39869.6 40948.0 68599.0 69157.0 69447.3 43146.1 43233.6 43307.8 43309.6 43345.6 17585.8 17751.9 17771.4 17776.3 17784.0 12820.4 13056.5 13067.4 13413.6 14427.5 9409.2 9705.1 9706.0 9926.4 9952.3 3454.5 3515.0 3534.5 3565.5 3586.6 969.4 1128.5 1149.3 1193.2 1202.8 31211.7 32024.0 32076.8 32336.4 32400.8 956.8 1096.9 1100.7 1149.2 1177.5 15178.8 17697.8 17991.5 18183.5 18202.8 556242.0 557397.0 559262.0 559392.0 559871.0 62430.0 62825.4 63091.7 63141.7 63237.4 1224.2 1236.7 1379.8 1383.1 1392.0 32766.8 35158.5 35356.8 38326.8 38464.8 59488.0 59986.7 60046.7 60125.4 60187.0 496216.0 498070.0 501893.0 503024.0 503597.0 26229.1 26415.7 30547.4 31457.8 31503.2 39725.0 47671.8 49642.3 49666.3 53877.5 42472.8 44021.3 44677.8 45314.5 46242.8 41914.4 42243.8 43079.0 44392.3 44820.3 42009.0 42942.1 42988.6 43043.6 43361.6 35993.8 37984.4 38507.8 38981.4 39075.8 29417.1 29639.9 29648.3 29964.0 30086.7 02:52:36 INFO - PROCESS | 13114 | 02:52:36 INFO - PROCESS | 13114 | [#2] jquery.html Cycles:180 Average:29002.22 Median:2947.63 stddev:72975.77 (2475.7%) stddev-sans-first:73148.91 02:52:36 INFO - PROCESS | 13114 | Values: 413.0 416.2 421.5 427.4 439.4 19107.9 19627.8 19979.5 20322.0 20363.5 18087.7 18813.1 19083.8 19572.4 19952.9 5054.9 5259.7 5306.2 5352.0 5363.3 5178.4 5311.4 5328.1 5331.4 5334.2 5273.4 5371.4 5380.0 5380.5 5386.0 5347.0 5353.1 5355.1 5357.5 7049.2 7034.2 7169.1 7197.1 7200.8 7205.2 26735.2 26932.2 27029.5 27759.6 27987.2 2523.1 2581.2 2697.4 2828.1 3067.2 7536.5 7559.7 7643.3 8354.5 15109.5 2030.6 2133.2 2160.5 2208.8 2232.9 100806.5 101013.5 101197.5 101314.0 102467.0 18647.6 19471.4 19513.3 20149.9 20693.3 34589.3 34647.5 34653.5 34990.1 35131.3 10499.7 10523.5 10683.9 10684.5 11004.0 9023.2 9037.9 9045.4 9310.9 9320.3 9063.4 9232.8 9303.3 9379.6 9571.5 3641.0 3651.5 3652.9 3656.9 3713.3 940.3 991.5 1003.8 1077.6 1097.8 20575.9 21045.7 21088.0 21299.6 21537.4 982.8 1022.7 1029.9 1086.4 1104.6 10580.7 11696.9 11841.2 11847.8 11870.5 435862.0 438011.0 443102.0 443177.0 444186.0 53961.7 53978.5 82540.0 85364.0 91414.0 1007.7 1024.0 1056.5 1092.7 1096.7 18410.6 18785.9 18804.2 18973.4 19343.7 41419.0 41634.8 42086.0 42247.8 43666.8 56640.4 57461.4 58390.4 58480.4 59339.4 8615.3 8943.2 9003.0 9108.4 9710.0 12403.8 12613.3 13366.0 13599.3 14147.6 10899.9 11430.8 11467.0 11550.2 11887.5 11213.7 11338.7 11543.7 11575.7 12005.6 11499.8 11590.8 11655.0 11798.6 12008.2 8184.5 8356.5 8392.2 8909.8 9162.8 8919.7 11042.3 11385.3 11714.9 11774.7 02:52:36 INFO - PROCESS | 13114 | 02:52:36 INFO - PROCESS | 13114 | [#3] mootools.html Cycles:180 Average:6028.75 Median:4917.04 stddev:3364.44 (68.4%) stddev-sans-first:3356.72 02:52:36 INFO - PROCESS | 13114 | Values: 1508.3 1541.5 1695.4 1751.2 1838.1 8625.1 9254.8 9274.4 9274.5 9285.8 7583.9 7771.8 7778.3 7971.3 9093.7 2228.8 2386.2 2458.6 2463.4 2473.2 2470.4 2516.4 2520.2 2524.7 2528.2 2510.1 2512.2 2533.2 2534.7 2536.0 2478.7 2493.0 2498.1 2501.3 2503.3 2468.5 2490.8 2502.3 2507.5 2507.7 9076.0 9090.2 9121.4 9129.1 9131.8 5553.2 5695.0 5713.3 5719.1 5724.2 3431.7 3461.5 3663.1 3706.4 3710.3 1137.6 1144.8 1168.8 1199.2 1205.7 12237.1 12250.2 12260.6 12288.1 12369.7 4690.2 4863.2 4970.9 4986.7 5135.5 10562.3 10564.7 10576.3 10586.5 10598.2 5647.2 5648.3 5664.3 5667.1 5679.2 4423.4 4988.4 5065.0 5139.3 5177.5 3643.8 3977.2 4019.5 4099.2 4102.6 1195.1 1217.2 1217.8 1219.5 1225.1 924.3 987.8 993.5 1029.9 1039.3 6388.7 6412.3 6422.1 6462.9 6559.5 962.9 968.2 973.5 984.9 1055.8 4162.0 4352.7 4361.0 4367.8 4468.9 11145.4 11429.3 11461.6 11506.0 11512.6 11222.9 11239.9 11428.4 11457.5 11497.8 8513.6 8585.3 8588.6 8656.2 8674.6 6044.8 6105.1 6152.9 6161.4 6195.7 10427.5 10518.5 10525.7 10538.5 10566.7 10387.2 10456.5 10623.0 10786.9 10811.5 7005.2 7680.5 7815.8 7834.0 7839.3 8072.7 8590.6 8920.1 8924.2 8957.2 8030.5 8260.2 8278.3 8470.4 8488.9 8034.1 8127.4 8156.1 8223.3 8467.3 6797.9 6960.8 7030.7 7190.6 7263.1 5514.0 5569.1 5587.6 5663.6 5801.9 5541.4 5632.4 5650.3 5713.9 5846.7 02:52:36 INFO - PROCESS | 13114 | 02:52:36 INFO - PROCESS | 13114 | [#4] prototype.html Cycles:180 Average:4633.09 Median:5300.45 stddev:1339.24 (25.3%) stddev-sans-first:1303.74 02:52:36 INFO - PROCESS | 13114 | Values: 344.7 353.6 355.0 359.2 360.5 5274.6 5286.4 5287.2 5313.7 5329.9 5212.8 5226.5 5242.0 5245.6 5276.2 4110.2 4185.6 4222.5 4234.6 4254.4 4196.8 4206.7 4208.2 4212.0 4252.6 4166.3 4168.7 4178.2 4198.5 4221.8 3985.5 4073.6 4078.4 4149.5 4151.3 3685.4 3695.0 3698.3 3702.7 3711.5 4888.5 5068.2 5076.7 5090.9 5107.6 4539.9 4590.0 4677.6 4703.0 4737.2 5411.2 5419.3 5436.3 5437.1 5441.9 3825.6 4101.6 4102.2 4107.9 4111.9 5627.9 5664.7 5680.9 5681.8 5696.8 4131.6 4132.9 4136.0 4136.0 4147.6 4186.3 4190.2 4196.0 4202.9 4206.0 4450.3 4660.2 4661.9 4662.7 4674.8 5506.8 5508.5 5508.6 5513.2 5533.7 1389.9 1393.3 1407.1 1409.9 1411.9 919.8 942.7 948.6 954.0 958.4 5095.9 5134.9 5138.7 5185.3 5192.4 5381.6 5389.8 5407.2 5431.7 5466.9 5077.4 5169.1 5203.6 5390.2 5398.7 2747.5 2837.0 2887.6 2893.8 2900.6 5684.4 5729.9 5739.0 5781.7 5782.0 5479.5 5529.6 5567.5 5587.7 5597.5 5637.9 5668.1 5710.7 5733.1 5733.4 5415.6 5442.5 5450.4 5461.7 5465.8 5359.6 5591.6 5594.2 5615.4 5617.4 5893.9 5923.0 5928.9 5996.3 6025.4 4081.8 4155.5 4156.0 4180.7 4202.1 5645.0 5645.9 5652.7 5653.4 5659.7 5508.0 5529.1 5531.7 5533.4 5554.2 5395.1 5482.8 5509.5 5518.8 5545.8 5444.5 5449.2 5452.8 5460.7 5464.7 5423.5 5537.4 5561.8 5576.9 5602.7 5377.5 5397.8 5420.6 5423.8 5423.9 02:52:36 INFO - PROCESS | 13114 | 02:52:36 INFO - PROCESS | 13114 | [#5] yui.html Cycles:180 Average:17768.74 Median:4546.76 stddev:23290.39 (512.2%) stddev-sans-first:23320.76 02:52:36 INFO - PROCESS | 13114 | Values: 771.8 779.3 788.1 849.3 907.2 14778.3 15296.4 15466.8 15506.4 15567.8 12269.9 13989.5 14055.7 14083.2 14100.7 856.9 881.5 884.9 885.1 885.5 876.9 880.6 883.3 883.3 883.5 922.6 923.1 925.0 925.1 926.1 905.8 908.2 913.3 914.8 914.8 674.4 674.5 674.7 674.8 675.2 13335.1 13626.9 14258.0 14265.1 14391.9 12385.8 12466.6 12896.7 13031.6 13155.6 10940.9 10997.6 11128.1 11301.6 11922.9 3808.4 3829.4 3835.5 3938.7 3943.2 65325.0 69043.0 69424.3 69973.7 70493.3 11496.9 11714.1 11757.4 11796.2 11966.3 21014.6 21050.4 21170.2 21186.5 21315.0 8399.2 8440.4 8494.6 8613.3 8620.8 4664.7 4863.6 4890.0 4895.8 4899.8 3578.0 3698.8 3699.8 3708.9 3709.8 657.7 667.9 684.7 693.3 706.7 680.1 699.0 735.8 760.4 807.3 9034.8 9752.0 9975.0 10447.6 10532.6 720.2 725.7 738.4 746.9 751.3 4445.1 4545.3 4548.2 4617.1 4619.7 91882.0 91904.5 95119.5 95670.0 96102.0 52998.7 63415.4 64203.4 65238.7 67587.0 67241.7 67267.3 67558.0 67611.7 68031.3 9656.9 10078.9 10286.7 10366.5 10525.0 41661.0 43136.6 43612.8 46486.3 47902.8 58780.4 59747.0 59859.7 62703.0 62793.4 12387.6 12495.4 12969.2 13088.6 13672.2 12417.9 12978.8 13262.6 13759.4 14419.7 13158.9 13217.8 13426.9 13621.9 14269.4 12996.7 13011.8 13302.7 13405.4 13689.9 12919.5 12972.5 12997.0 13209.1 13632.4 10306.9 10358.7 10633.3 10693.8 11642.9 10948.4 11274.6 11313.0 11470.1 11798.6 02:52:36 INFO - PROCESS | 13114 | -------- Summary: end -------- 02:52:36 INFO - PROCESS | 13114 | 02:52:37 INFO - TEST-INFO | 13114: exit 0 02:52:37 INFO - TEST-OK | dromaeo_css | took 1117617ms 02:52:37 INFO - TEST-START | kraken 02:52:37 INFO - operating with platform_type : linux_ 02:52:37 INFO - Initialising browser for kraken test... 02:52:37 INFO - TEST-INFO | started process 13430 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQRgYuK/profile http://localhost:38804/getInfo.html) 02:52:42 INFO - PROCESS | 13430 | __metrics Screen width/height:1600/1200 02:52:42 INFO - PROCESS | 13430 | colorDepth:24 02:52:42 INFO - PROCESS | 13430 | Browser inner width/height: 1024/697 02:52:42 INFO - PROCESS | 13430 | __metrics 02:52:42 INFO - PROCESS | 13430 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:52:42 INFO - PROCESS | 13430 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:52:43 INFO - PROCESS | 13430 | console.error: PushService: 02:52:43 INFO - PROCESS | 13430 | stateChangeProcessEnqueue: Error transitioning state 02:52:43 INFO - PROCESS | 13430 | UnknownError 02:52:43 INFO - TEST-INFO | 13430: exit 0 02:52:43 INFO - Browser initialized. 02:52:43 INFO - Running cycle 1/1 for kraken test... 02:52:43 INFO - TEST-INFO | started process 13525 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQRgYuK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:52:55 INFO - PROCESS | 13525 | RSS: Main: 147771392 02:52:55 INFO - PROCESS | 13525 | 02:52:58 INFO - PROCESS | 13525 | Cycle 1(1): loaded http://localhost:38804/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38804/tests/kraken/driver.html?testName=audio-beat-detection) 02:52:59 INFO - PROCESS | 13525 | RSS: Main: 189227008 02:52:59 INFO - PROCESS | 13525 | 02:53:01 INFO - PROCESS | 13525 | Cycle 1(1): loaded http://localhost:38804/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38804/tests/kraken/driver.html?testName=audio-dft) 02:53:02 INFO - PROCESS | 13525 | RSS: Main: 178114560 02:53:02 INFO - PROCESS | 13525 | 02:53:05 INFO - PROCESS | 13525 | Cycle 1(1): loaded http://localhost:38804/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38804/tests/kraken/driver.html?testName=audio-fft) 02:53:05 INFO - PROCESS | 13525 | RSS: Main: 270004224 02:53:05 INFO - PROCESS | 13525 | 02:53:07 INFO - PROCESS | 13525 | Cycle 1(1): loaded http://localhost:38804/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38804/tests/kraken/driver.html?testName=audio-oscillator) 02:53:08 INFO - PROCESS | 13525 | RSS: Main: 176844800 02:53:08 INFO - PROCESS | 13525 | 02:53:10 INFO - PROCESS | 13525 | Cycle 1(1): loaded http://localhost:38804/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38804/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:53:10 INFO - PROCESS | 13525 | RSS: Main: 179208192 02:53:10 INFO - PROCESS | 13525 | 02:53:13 INFO - PROCESS | 13525 | Cycle 1(1): loaded http://localhost:38804/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38804/tests/kraken/driver.html?testName=imaging-darkroom) 02:53:14 INFO - PROCESS | 13525 | RSS: Main: 217808896 02:53:14 INFO - PROCESS | 13525 | 02:53:17 INFO - PROCESS | 13525 | Cycle 1(1): loaded http://localhost:38804/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38804/tests/kraken/driver.html?testName=imaging-desaturate) 02:53:18 INFO - PROCESS | 13525 | RSS: Main: 216211456 02:53:18 INFO - PROCESS | 13525 | 02:53:21 INFO - PROCESS | 13525 | Cycle 1(1): loaded http://localhost:38804/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38804/tests/kraken/driver.html?testName=json-parse-financial) 02:53:21 INFO - PROCESS | 13525 | RSS: Main: 214278144 02:53:21 INFO - PROCESS | 13525 | 02:53:23 INFO - PROCESS | 13525 | Cycle 1(1): loaded http://localhost:38804/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38804/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:53:23 INFO - PROCESS | 13525 | RSS: Main: 176848896 02:53:23 INFO - PROCESS | 13525 | 02:53:25 INFO - PROCESS | 13525 | Cycle 1(1): loaded http://localhost:38804/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38804/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:53:26 INFO - PROCESS | 13525 | RSS: Main: 185131008 02:53:26 INFO - PROCESS | 13525 | 02:53:28 INFO - PROCESS | 13525 | Cycle 1(1): loaded http://localhost:38804/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38804/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:53:28 INFO - PROCESS | 13525 | RSS: Main: 189763584 02:53:28 INFO - PROCESS | 13525 | 02:53:31 INFO - PROCESS | 13525 | Cycle 1(1): loaded http://localhost:38804/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38804/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:53:31 INFO - PROCESS | 13525 | RSS: Main: 199200768 02:53:31 INFO - PROCESS | 13525 | 02:53:34 INFO - PROCESS | 13525 | Cycle 1(1): loaded http://localhost:38804/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38804/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:53:35 INFO - PROCESS | 13525 | RSS: Main: 195256320 02:53:35 INFO - PROCESS | 13525 | 02:53:36 INFO - PROCESS | 13525 | Cycle 1(1): loaded http://localhost:38804/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38804/tests/kraken/driver.html?testName=ai-astar) 02:53:37 INFO - PROCESS | 13525 | RSS: Main: 247492608 02:53:37 INFO - PROCESS | 13525 | 02:53:37 INFO - PROCESS | 13525 | __start_tp_report 02:53:37 INFO - PROCESS | 13525 | _x_x_mozilla_page_load 02:53:37 INFO - PROCESS | 13525 | _x_x_mozilla_page_load_details 02:53:37 INFO - PROCESS | 13525 | |i|pagename|runs| 02:53:37 INFO - PROCESS | 13525 | |0;ai-astar;102;110;111;110;111;110;110;111;111;111 02:53:37 INFO - PROCESS | 13525 | |1;audio-beat-detection;146;119;120;153;118;120;116;117;143;117 02:53:37 INFO - PROCESS | 13525 | |2;audio-dft;161;161;161;162;161;163;162;161;161;161 02:53:37 INFO - PROCESS | 13525 | |3;audio-fft;76;76;76;110;75;76;75;75;97;76 02:53:37 INFO - PROCESS | 13525 | |4;audio-oscillator;82;82;113;83;82;82;99;81;81;107 02:53:37 INFO - PROCESS | 13525 | |5;imaging-gaussian-blur;117;117;117;117;116;117;116;116;117;117 02:53:37 INFO - PROCESS | 13525 | |6;imaging-darkroom;147;146;146;147;146;146;148;146;147;146 02:53:37 INFO - PROCESS | 13525 | |7;imaging-desaturate;85;84;84;85;85;86;85;85;85;85 02:53:37 INFO - PROCESS | 13525 | |8;json-parse-financial;50;48;48;50;50;51;48;49;49;55 02:53:37 INFO - PROCESS | 13525 | |9;json-stringify-tinderbox;59;59;58;59;59;60;59;60;60;60 02:53:37 INFO - PROCESS | 13525 | |10;stanford-crypto-aes;74;74;82;74;75;73;75;76;75;74 02:53:37 INFO - PROCESS | 13525 | |11;stanford-crypto-ccm;124;123;125;122;121;120;132;131;163;119 02:53:37 INFO - PROCESS | 13525 | |12;stanford-crypto-pbkdf2;156;156;156;156;158;157;157;157;162;162 02:53:37 INFO - PROCESS | 13525 | |13;stanford-crypto-sha256-iterative;62;61;65;61;62;62;64;62;60;60 02:53:37 INFO - PROCESS | 13525 | __end_tp_report 02:53:37 INFO - PROCESS | 13525 | __start_cc_report 02:53:37 INFO - PROCESS | 13525 | _x_x_mozilla_cycle_collect,1624 02:53:37 INFO - PROCESS | 13525 | __end_cc_report 02:53:37 INFO - PROCESS | 13525 | __startTimestamp1481799217075__endTimestamp 02:53:37 INFO - PROCESS | 13525 | 02:53:37 INFO - PROCESS | 13525 | ------- Summary: start ------- 02:53:37 INFO - PROCESS | 13525 | Number of tests: 14 02:53:37 INFO - PROCESS | 13525 | 02:53:37 INFO - PROCESS | 13525 | [#0] ai-astar Cycles:10 Average:109.70 Median:111.00 stddev:2.75 (2.5%) stddev-sans-first:0.53 02:53:37 INFO - PROCESS | 13525 | Values: 102.0 110.0 111.0 110.0 111.0 110.0 110.0 111.0 111.0 111.0 02:53:37 INFO - PROCESS | 13525 | 02:53:37 INFO - PROCESS | 13525 | [#1] audio-beat-detection Cycles:10 Average:126.90 Median:120.00 stddev:14.36 (12.0%) stddev-sans-first:13.47 02:53:37 INFO - PROCESS | 13525 | Values: 146.0 119.0 120.0 153.0 118.0 120.0 116.0 117.0 143.0 117.0 02:53:37 INFO - PROCESS | 13525 | 02:53:37 INFO - PROCESS | 13525 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.00 stddev:0.70 (0.4%) stddev-sans-first:0.73 02:53:37 INFO - PROCESS | 13525 | Values: 161.0 161.0 161.0 162.0 161.0 163.0 162.0 161.0 161.0 161.0 02:53:37 INFO - PROCESS | 13525 | 02:53:37 INFO - PROCESS | 13525 | [#3] audio-fft Cycles:10 Average:81.20 Median:76.00 stddev:12.15 (16.0%) stddev-sans-first:12.75 02:53:37 INFO - PROCESS | 13525 | Values: 76.0 76.0 76.0 110.0 75.0 76.0 75.0 75.0 97.0 76.0 02:53:37 INFO - PROCESS | 13525 | 02:53:37 INFO - PROCESS | 13525 | [#4] audio-oscillator Cycles:10 Average:89.20 Median:82.00 stddev:12.29 (15.0%) stddev-sans-first:12.76 02:53:37 INFO - PROCESS | 13525 | Values: 82.0 82.0 113.0 83.0 82.0 82.0 99.0 81.0 81.0 107.0 02:53:37 INFO - PROCESS | 13525 | 02:53:37 INFO - PROCESS | 13525 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 02:53:37 INFO - PROCESS | 13525 | Values: 117.0 117.0 117.0 117.0 116.0 117.0 116.0 116.0 117.0 117.0 02:53:37 INFO - PROCESS | 13525 | 02:53:37 INFO - PROCESS | 13525 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:146.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 02:53:37 INFO - PROCESS | 13525 | Values: 147.0 146.0 146.0 147.0 146.0 146.0 148.0 146.0 147.0 146.0 02:53:37 INFO - PROCESS | 13525 | 02:53:37 INFO - PROCESS | 13525 | [#7] imaging-desaturate Cycles:10 Average:84.90 Median:85.00 stddev:0.57 (0.7%) stddev-sans-first:0.60 02:53:37 INFO - PROCESS | 13525 | Values: 85.0 84.0 84.0 85.0 85.0 86.0 85.0 85.0 85.0 85.0 02:53:37 INFO - PROCESS | 13525 | 02:53:37 INFO - PROCESS | 13525 | [#8] json-parse-financial Cycles:10 Average:49.80 Median:50.00 stddev:2.10 (4.2%) stddev-sans-first:2.22 02:53:37 INFO - PROCESS | 13525 | Values: 50.0 48.0 48.0 50.0 50.0 51.0 48.0 49.0 49.0 55.0 02:53:37 INFO - PROCESS | 13525 | 02:53:37 INFO - PROCESS | 13525 | [#9] json-stringify-tinderbox Cycles:10 Average:59.30 Median:59.50 stddev:0.67 (1.1%) stddev-sans-first:0.71 02:53:37 INFO - PROCESS | 13525 | Values: 59.0 59.0 58.0 59.0 59.0 60.0 59.0 60.0 60.0 60.0 02:53:37 INFO - PROCESS | 13525 | 02:53:37 INFO - PROCESS | 13525 | [#10] stanford-crypto-aes Cycles:10 Average:75.20 Median:75.00 stddev:2.53 (3.4%) stddev-sans-first:2.65 02:53:37 INFO - PROCESS | 13525 | Values: 74.0 74.0 82.0 74.0 75.0 73.0 75.0 76.0 75.0 74.0 02:53:37 INFO - PROCESS | 13525 | 02:53:37 INFO - PROCESS | 13525 | [#11] stanford-crypto-ccm Cycles:10 Average:128.00 Median:124.50 stddev:13.04 (10.5%) stddev-sans-first:13.75 02:53:37 INFO - PROCESS | 13525 | Values: 124.0 123.0 125.0 122.0 121.0 120.0 132.0 131.0 163.0 119.0 02:53:37 INFO - PROCESS | 13525 | 02:53:37 INFO - PROCESS | 13525 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.70 Median:157.00 stddev:2.36 (1.5%) stddev-sans-first:2.42 02:53:37 INFO - PROCESS | 13525 | Values: 156.0 156.0 156.0 156.0 158.0 157.0 157.0 157.0 162.0 162.0 02:53:37 INFO - PROCESS | 13525 | 02:53:37 INFO - PROCESS | 13525 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.90 Median:62.00 stddev:1.60 (2.6%) stddev-sans-first:1.69 02:53:37 INFO - PROCESS | 13525 | Values: 62.0 61.0 65.0 61.0 62.0 62.0 64.0 62.0 60.0 60.0 02:53:37 INFO - PROCESS | 13525 | -------- Summary: end -------- 02:53:37 INFO - PROCESS | 13525 | 02:53:38 INFO - TEST-INFO | 13525: exit 0 02:53:38 INFO - TEST-OK | kraken | took 60763ms 02:53:38 INFO - SUITE-END | took 1178s 02:53:38 INFO - Completed test suite (00:19:38) 02:53:38 INFO - javascript benchmark 02:53:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3226.887058952937, 3265.999999999999, 3269.133679574913, 3289.9177520562, 3311.834408279587, 5505.284313039304, 5561.416051314614, 5579.776808927648, 5583.0, 5585.972070139649, 5506.421825708293, 5579.832605021856, 5583.469570390816, 5584.106542953128, 5608.046632072547, 4998.3252260944855, 5017.448080711137, 5030.320906677588, 5085.313482679828, 5103.26002729604, 4928.581070608984, 4946.233333833244, 5052.9747351263195, 5096.974515127419, 5103.41310749263, 4995.850124496271, 5009.098362294803, 5013.623978201649, 5015.849524514252, 5052.545270925616, 5050.545450909399, 5066.771995260186, 5132.794688212467, 5140.511651393112, 5168.948310516885, 4857.78139983698, 5020.221865610836, 5034.672746271517, 5071.442141364447, 5102.846914592568, 5489.0, 5491.423400542965, 5512.586556008316, 5559.805406810783, 5569.387367389584, 5946.70266486674, 5960.0, 5981.790637327673, 6077.0276755719315, 6084.421979911901, 6084.30030546484, 6113.388661133851, 6128.877422451571, 6130.325664176937, 6135.0, 5450.4822041906355, 5494.395616482184, 5572.136318870582, 5623.100303951348, 5632.690202038927, 6159.0, 6192.287886892975, 6195.411435913581, 6198.81403557894, 6205.0, 5926.67403292823, 5928.466438020599, 5941.0, 5944.7027648617395, 5945.435183657545, 5753.741081651336, 5817.650940943472, 5833.241678581757, 5905.527557795366, 5906.793262235801, 5956.6723830188885, 5957.434043765836, 5960.254968128984, 5961.5230781537375, 5982.700864956735, 5898.793542226002, 5928.67392293428, 5956.374580668968, 5966.105084237312, 5985.132155837379, 4502.212112880298, 4543.454785425704, 4550.0, 4577.885552861205, 4636.397268355092, 4079.5104587449696, 4106.07613287014, 4129.174165166918, 4137.110521237948, 4145.523264824584, 5658.688772117491, 5659.0, 5662.094064949588, 5664.745086471119, 5669.603127781016, 5855.180274761537, 5860.853478663067, 5919.4080591940465, 5958.612690175125, 5958.821235362946, 5595.552355811526, 5662.462066103713, 5665.2635157430095, 5670.262865827416, 5696.3733989261145, 4994.350734404504, 4998.375203099613, 5002.799888004512, 5004.0, 5027.622928280393, 6071.939280607137, 6162.753489860355, 6239.282482514478, 6245.406686364879, 6248.375162483715, 5857.0, 5875.853103672443, 5881.882362352814, 5982.4316689914385, 6014.338422773404, 6216.43856106492, 6225.657588832658, 6244.219472565929, 6244.843878903063, 6252.468540173954, 5678.858028549319, 5861.853453663693, 5869.442402971711, 5872.1778950946045, 5906.763729450946, 5750.856228594152, 5946.464818166386, 5965.403459654173, 6004.1294012368835, 6067.817965461043, 5827.562932779973, 5869.8239052828485, 5877.676727780014, 5880.88263230002, 5886.264216972879, 5915.40845915405, 5917.615355001911, 5929.644221346733, 5930.0, 5936.940630593639, 5625.690587017753, 5706.714664266853, 5724.341700704473, 5745.396733342939, 5762.654240745569, 5858.882822343615, 5878.177055212188, 5892.705364731832, 5893.616914900518, 5896.7936122235515, 5580.497755202051, 5614.971925140511, 5714.285714285715, 5723.456271654186, 5724.055530837365], "value": 5497.889507177937, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [591.46767908882, 626.4549841637776, 637.7672149665372, 640.5836206465797, 645.8740545593605, 31497.425128743587, 46542.0, 47355.76322118393, 47403.28895066577, 47459.76270118653, 46622.533774662246, 46719.76640116803, 46996.29505557419, 47018.0596388072, 47072.0, 8075.838483230332, 8278.254957053863, 8868.068852770446, 9009.054049324825, 9019.594118264693, 10589.099926506256, 10857.022867941883, 10872.61945831896, 11197.27217730849, 11198.048165905908, 10913.508892099835, 10982.286151400174, 10989.395583242918, 10989.945050274737, 10993.0, 10689.091427228617, 10710.089642380408, 10763.461826908624, 10776.40729759859, 10780.137588992862, 10740.516676749565, 10773.299735517166, 10813.08088812452, 10815.134789216923, 10820.188485863591, 43786.34320485195, 44163.0, 44187.337189942176, 44191.0, 44234.33648495275, 3634.0914771307175, 3834.3673293906472, 3851.287511810324, 3922.490076290064, 4084.9183016339507, 31445.842770786, 33543.329133417436, 34270.31459370798, 34888.82555587231, 35476.46785298223, 4242.0, 4294.871153865389, 4335.3063509838275, 4375.409319741826, 4502.2571275739465, 378416.0, 386214.9999999972, 387530.0, 387657.0, 387690.0, 39869.60130398717, 40948.0, 68599.0, 69157.0, 69447.3055269451, 43146.13707725828, 43233.567664323586, 43307.783461082494, 43309.56690433055, 43345.56654433478, 17585.824141758676, 17751.911240443715, 17771.378001769877, 17776.288948442176, 17784.0, 12820.35898205086, 13056.543020994219, 13067.411966461532, 13413.597592072254, 14427.49503767363, 9409.153176214037, 9705.12653861156, 9705.951470242604, 9926.404415735078, 9952.25358098131, 3454.4818277258614, 3514.9648503514636, 3534.54050973377, 3565.4830049642655, 3586.5696116466193, 969.3650658818485, 1128.5260190719916, 1149.287441786098, 1193.2065176657425, 1202.753435545711, 31211.687883120878, 32024.0, 32076.83961580177, 32336.35327293488, 32400.837995810343, 956.7560272130562, 1096.9451527423757, 1100.6863044032573, 1149.201305092969, 1177.5054477119459, 15178.772318415233, 17697.76322967797, 17991.460256192335, 18183.545411364823, 18202.817971820376, 556242.0, 557397.0, 559262.0, 559392.0, 559871.0, 62430.0, 62825.371746282864, 63091.684541577, 63141.68429157825, 63237.36762632315, 1224.1736827641307, 1236.6599185224136, 1379.827521559805, 1383.100984360174, 1391.979120313196, 32766.83616581902, 35158.47262291119, 35356.823215883756, 38326.80836595799, 38464.80767596256, 59488.0, 59986.70006650114, 60046.699766502636, 60125.39874601198, 60187.0, 496216.0, 498070.0, 501893.0, 503024.0, 503597.0, 26229.081982130534, 26415.735842641327, 30547.389052219274, 31457.8427107863, 31503.21241968969, 39725.0, 47671.76164119157, 49642.25536617026, 49666.255006174215, 53877.46122538881, 42472.78763606162, 44021.33967990419, 44677.77661111674, 45314.546854531036, 46242.7687861572, 41914.37128443015, 42243.7887810559, 43079.0, 44392.334114988946, 44820.32769508525, 42009.0, 42942.141157177306, 42988.570114298454, 43043.56956430396, 43361.566384335754, 35993.820030899675, 37984.43023354707, 38507.80746096252, 38981.41527877028, 39075.80462097671, 29417.11748647544, 29639.851800740857, 29648.258793530335, 29964.0, 30086.69913300839], "value": 20405.982379820816, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [413.02938095475616, 416.1697413659749, 421.51104718526506, 427.39310179545043, 439.4309369366672, 19107.853528788284, 19627.803721962777, 19979.500512487197, 20322.0, 20363.49091272719, 18087.72868406975, 18813.059347032628, 19083.809161908375, 19572.41282761516, 19952.900235498837, 5054.924176137351, 5259.737013149346, 5306.230596563496, 5351.973240133794, 5363.275957745713, 5178.378594568657, 5311.389190243133, 5328.0675881720545, 5331.440198779131, 5334.226537152111, 5273.367195936493, 5371.435999220064, 5380.0, 5380.542653874425, 5386.003589335985, 5346.973265133688, 5353.063213937565, 5355.143177091666, 5357.544608708284, 7049.189343225544, 7034.155901291827, 7169.068021157216, 7197.1363436387965, 7200.783976480661, 7205.207427183006, 26735.19794406171, 26932.192034239004, 27029.459410811673, 27759.583606245924, 27987.160385188476, 2523.116909081825, 2581.174024312221, 2697.379602691392, 2828.0808737160505, 3067.1871953932227, 7536.547807131589, 7559.69761209551, 7643.312101910799, 8354.45696029756, 15109.471168509159, 2030.5634288628016, 2133.208105191631, 2160.5030842906062, 2208.845380823343, 2232.8883555822144, 100806.49596752043, 101013.4949325256, 101197.49401253021, 101314.0, 102467.0, 18647.627047458976, 19471.4158575243, 19513.317033903746, 20149.899250503946, 20693.344532437368, 34589.30821383558, 34647.480287795704, 34653.48019779706, 34990.12524686852, 35131.297374052374, 10499.68500944973, 10523.52644131016, 10683.89316106829, 10684.51919663617, 11004.0, 9023.187913087853, 9037.909620903838, 9045.412048216846, 9310.906890931139, 9320.254379649612, 9063.41087829289, 9232.815343693088, 9303.302252331103, 9379.577918993662, 9571.521423928776, 3640.967867361845, 3651.507046548682, 3652.908677283089, 3656.8537258509364, 3713.2573485302505, 940.3182692547848, 991.5191132300828, 1003.7992401519725, 1077.5582011375297, 1097.7530055737554, 20575.897120514303, 21045.684314735292, 21088.0, 21299.615524990826, 21537.353879383645, 982.8181786369402, 1022.7340891368298, 1029.9485025748684, 1086.3861918016296, 1104.5526561742506, 10580.735481612868, 11696.88303116975, 11841.23032002917, 11847.822282665767, 11870.465829037714, 435862.0, 438011.0, 443102.0, 443177.0, 444186.0, 53961.730191349576, 53978.46021539813, 82540.0, 85364.0, 91414.0, 1007.6825799873017, 1023.9641612543526, 1056.4506456642503, 1092.7268182954263, 1096.6764804382726, 18410.631787364444, 18785.90607046956, 18804.247830086642, 18973.43079707611, 19343.709844352627, 41419.0, 41634.75478678101, 42086.0, 42247.78876105723, 43666.781666092735, 56640.43359566516, 57461.425385745606, 58390.4160958385, 58480.4151958475, 59339.40660593512, 8615.267702245128, 8943.23982461498, 9002.954985225031, 9108.407953483002, 9709.969094658434, 12403.824661616789, 12613.30626815534, 13366.0, 13599.320033998458, 14147.575572732834, 10899.891001089887, 11430.828537571777, 11467.0, 11550.191486595857, 11887.465064071965, 11213.71965700864, 11338.716532086764, 11543.711407214887, 11575.710607234887, 12005.63983080509, 11499.770004600028, 11590.768184636092, 11655.009324207538, 11798.646040618794, 12008.219465734699, 8184.508929464251, 8356.456830306011, 8392.244697977212, 8909.821803563762, 9162.816743665222, 8919.687810926587, 11042.282251653938, 11385.259958102697, 11714.907443288479, 11774.705632359259], "value": 10251.872964907065, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1508.3212554350541, 1541.5375387383785, 1695.448979081798, 1751.1856986501275, 1838.0625880800796, 8625.094365091662, 9254.768630784234, 9274.397164184324, 9274.48990305533, 9285.7678558036, 7583.924160758391, 7771.844563108734, 7778.338841198491, 7971.282584567388, 9093.681721139761, 2228.810551103154, 2386.248331775485, 2458.6312053192073, 2463.359526523108, 2473.208573256559, 2470.357212453725, 2516.4338023944647, 2520.243926821946, 2524.7222805491383, 2528.1657053172503, 2510.146550172941, 2512.1835403493938, 2533.1893793985932, 2534.6578211941337, 2536.0, 2478.7025556933104, 2492.962605560918, 2498.0757119865584, 2501.262127672341, 2503.349129226396, 2468.469279105001, 2490.8007359411204, 2502.349389158832, 2507.4734305795805, 2507.749225077496, 9075.954620226923, 9090.181883630505, 9121.361504694674, 9129.132732390412, 9131.817363652755, 5553.222548843165, 5695.031844586389, 5713.285839270091, 5719.056355701305, 5724.227229324029, 3431.656834316573, 3461.498082777983, 3663.139162296885, 3706.388445906422, 3710.3321402147603, 1137.5677242647823, 1144.7653231087606, 1168.8480497535352, 1199.1725709260581, 1205.6804946689135, 12237.082218833622, 12250.203736757172, 12260.570880019157, 12288.1398302118, 12369.69075773104, 4690.226112691436, 4863.221884498464, 4970.850874473772, 4986.675866068694, 5135.537801597874, 10562.260641755003, 10564.683059508227, 10576.259661823598, 10586.470676466146, 10598.152147828156, 5647.237622920853, 5648.322201335784, 5664.320281566238, 5667.121596152603, 5679.204911312419, 4423.358613001097, 4988.351514303117, 5065.012322597132, 5139.331886854685, 5177.4822517747925, 3643.799591022519, 3977.204559088194, 4019.457373254632, 4099.200655872136, 4102.610252026053, 1195.061876427018, 1217.2331431198288, 1217.7686239614445, 1219.5487669562142, 1225.0628269373758, 924.3160061554402, 987.8123156600223, 993.5429702336861, 1029.9279050466396, 1039.3400190878695, 6388.7125079371535, 6412.294647588761, 6422.100905873182, 6462.903056454157, 6559.47524198063, 962.9374090684223, 968.1673760565908, 973.532704301939, 984.867042949207, 1055.767731099157, 4161.97919010403, 4352.651787856964, 4360.978195109067, 4367.781610919505, 4468.865934021985, 11145.387003714712, 11429.314241145557, 11461.598844040418, 11506.0, 11512.59705910289, 11222.887771122347, 11239.887601123884, 11428.371439570737, 11457.54169833214, 11497.827532587018, 8513.574321284035, 8585.31317494599, 8588.613512391958, 8656.22094011542, 8674.56627168639, 6044.848878778066, 6105.114758359924, 6152.938470615237, 6161.383861613982, 6195.721192546256, 10427.53076111592, 10518.526666299882, 10525.684229472821, 10538.473076346, 10566.682999510027, 10387.169026477712, 10456.47717614101, 10623.0, 10786.892131078588, 10811.459427028774, 7005.22942476317, 7680.5391676499585, 7815.804604884696, 7833.960830195812, 7839.25527074927, 8072.677092916218, 8590.570471476276, 8920.063393343866, 8924.196822286025, 8957.238634716123, 8030.5181689098845, 8260.173982601691, 8278.337732981227, 8470.364722645949, 8488.872666910125, 8034.076081250497, 8127.390445716476, 8156.0620528639965, 8223.301019413417, 8467.322614190727, 6797.93202067973, 6960.825979350557, 7030.683619237045, 7190.6404679764755, 7263.0921134858145, 5513.972430137984, 5569.136783798518, 5587.5809314302405, 5663.575231857545, 5801.912971305518, 5541.362743284412, 5632.408597097246, 5650.29371328584, 5713.914291285717, 5846.6784326862435], "value": 4845.940260224467, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [344.73799912066823, 353.56158363629106, 354.9911252218695, 359.2366221778719, 360.5331096230381, 5274.604404669651, 5286.392064912537, 5287.228778359249, 5313.681179129255, 5329.866753331169, 5212.843614691556, 5226.529612334899, 5241.973790131044, 5245.632805703603, 5276.2085687146855, 4110.177964407116, 4185.560516145806, 4222.451081359434, 4234.61888430042, 4254.4469219001485, 4196.790160491979, 4206.726562773425, 4208.158368326347, 4211.957880421187, 4252.574742525738, 4166.250074986501, 4168.7081904266715, 4178.206140833247, 4198.496180458349, 4221.810018549173, 3985.4818873546396, 4073.572274911136, 4078.4086307485545, 4149.481314835645, 4151.252774500589, 3685.4471829225563, 3694.9815250923843, 3698.3158115748674, 3702.6667599916136, 3711.536057992751, 4888.462269150391, 5068.239764035424, 5076.705440112784, 5090.898182036375, 5107.61692873036, 4539.931901021488, 4590.006933394535, 4677.555632214934, 4702.976485117587, 4737.1946769049, 5411.242426060355, 5419.3225846769155, 5436.2661040759385, 5437.075697131497, 5441.863953401196, 3825.565412970136, 4101.589841015874, 4102.179564087194, 4107.9178416431805, 4111.9177616447805, 5627.8593035174035, 5664.660120392789, 5680.943190568124, 5681.829545113695, 5696.829095127153, 4131.612078095933, 4132.938005929914, 4135.958640413557, 4136.0, 4147.605977432139, 4186.28833098374, 4190.182914331676, 4196.0, 4202.936955945664, 4205.957940420618, 4450.310201918643, 4660.184467718136, 4661.930071048869, 4662.650301227353, 4674.836380726726, 5506.779728810883, 5508.504234618824, 5508.55931525477, 5513.2005859150195, 5533.723313834292, 1389.9166050037031, 1393.261571367177, 1407.099456347938, 1409.873111419977, 1411.8870490360746, 919.7608621758391, 942.6606421688186, 948.6205517792938, 953.9618415263451, 958.3531116496337, 5095.8726031848755, 5134.870328527718, 5138.665986710852, 5185.299984502044, 5192.428832828386, 5381.600783796162, 5389.811356602579, 5407.161889906992, 5431.6740995540395, 5466.851961088216, 5077.390713114376, 5169.121249387613, 5203.557697595671, 5390.191471279261, 5398.73006349681, 2747.5466548019353, 2836.971630283712, 2887.595736596878, 2893.811902226391, 2900.622919020514, 5684.403137670485, 5729.88540229193, 5739.0, 5781.682007489629, 5782.0, 5479.4520547945685, 5529.589954561641, 5567.47109024642, 5587.7485513152005, 5597.468240517144, 5637.915431268534, 5668.1295172592945, 5710.65736055838, 5733.0540460823495, 5733.369329373765, 5415.6479828811, 5442.530516760374, 5450.400455949763, 5461.699606521521, 5465.754041068082, 5359.598030147832, 5591.552675785846, 5594.216809646571, 5615.382307946041, 5617.410171931889, 5893.911591326219, 5923.0, 5928.851778705394, 5996.2504686914135, 6025.397460254115, 4081.8367265309057, 4155.522114956819, 4155.97922010388, 4180.749155050707, 4202.138561594927, 5644.971775141098, 5645.9153112702525, 5652.689102099424, 5653.40639232891, 5659.660420374791, 5508.0, 5529.060059789926, 5531.695756733418, 5533.446655334435, 5554.1946417770005, 5395.136778115482, 5482.835514934558, 5509.457351941463, 5518.751656175402, 5545.7781688732, 5444.509994100392, 5449.1826226066405, 5452.836414907559, 5460.672359658433, 5464.699441530595, 5423.538999185113, 5537.446255374431, 5561.777528898799, 5576.888462230651, 5602.747876345493, 5377.542908852635, 5397.8110766123, 5420.593455490933, 5423.7830486780085, 5423.945760542344], "value": 4211.711912513806, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [771.8147644565303, 779.3414564692839, 788.1448628238361, 849.2993280543552, 907.246985002448, 14778.26108694565, 15296.388144474235, 15466.767998480018, 15506.379744810221, 15567.84432155678, 12269.877301226985, 13989.510367137153, 14055.718885622282, 14083.155010699365, 14100.717985640307, 856.8500512410319, 881.4843316659761, 884.9159329863653, 885.0795173020051, 885.5262434597491, 876.9342299327544, 880.5905254056862, 883.3021912688968, 883.3066043156124, 883.4875772052227, 922.5986695787354, 923.1230331185367, 925.0333401595349, 925.079545851875, 926.073926073926, 905.7554460295717, 908.2416182487631, 913.2739472119614, 914.7987442762615, 914.8307563100848, 674.4132604633951, 674.5109795398346, 674.7368526274756, 674.81442603284, 675.1864003875319, 13335.131867527934, 13626.863731362757, 14258.0, 14265.144091354552, 14391.928040359835, 12385.75228495434, 12466.626001219978, 12896.677583060406, 13031.609051728463, 13155.605331839964, 10940.890591094147, 10997.560097596166, 11128.109751219883, 11301.604443844508, 11922.940385298105, 3808.352580061396, 3829.4064420014943, 3835.5397352317623, 3938.6652134568594, 3943.2310699413624, 65325.0, 69043.0, 69424.3057569423, 69973.65013174953, 70493.29506704918, 11496.885031149748, 11714.110789783961, 11757.412129393497, 11796.174267801172, 11966.282023078644, 21014.579708405745, 21050.368488945354, 21170.153193872382, 21186.470338241666, 21315.0, 8399.160083991552, 8440.40917135807, 8494.575271236414, 8613.310935125175, 8620.78448038804, 4664.65015123867, 4863.562279394871, 4890.046440943982, 4895.755212239374, 4899.779509922062, 3577.964220357815, 3698.7965661888857, 3699.7780133192095, 3708.851645934132, 3709.7588656737767, 657.7401926239204, 667.8864593019198, 684.6850448793512, 693.2997672350962, 706.7491040680587, 680.1498127340824, 698.9720411183496, 735.7755884455293, 760.3840888880025, 807.3258828877836, 9034.819303614022, 9752.0, 9975.0, 10447.582096716047, 10532.631357902437, 720.2113685514354, 725.742361461684, 738.3945164964784, 746.8655641984386, 751.2712668711341, 4445.133199026223, 4545.340925565841, 4548.181327361107, 4617.076584683077, 4619.653525985565, 91882.0, 91904.54047729852, 95119.52440237754, 95670.0, 96102.0, 52998.73500632472, 63415.36584634187, 64203.35796641974, 65238.67380663161, 67587.0, 67241.66379168171, 67267.32732672709, 67558.0, 67611.66194168998, 68031.31968680349, 9656.9034309656, 10078.949605251926, 10286.691399258034, 10366.481675916324, 10525.0, 41661.0, 43136.568634313255, 43612.78193609012, 46486.30270546012, 47902.760486197345, 58780.4121958792, 59747.0, 59859.700701496215, 62703.0, 62793.37206628058, 12387.62837114888, 12495.437705303102, 12969.221846689228, 13088.607341779762, 13672.248026358646, 12417.875821241672, 12978.805317920427, 13262.602121936357, 13759.38082786257, 14419.711605768036, 13158.934205328913, 13217.801732974205, 13426.932865335611, 13621.931890340486, 14269.42922283097, 12996.740065198832, 13011.804822927854, 13302.733945320846, 13405.396757146147, 13689.86310136886, 12919.483220671067, 12972.545960891324, 12997.0, 13209.141405808592, 13632.386542605806, 10306.948465257627, 10358.741031474274, 10633.317395808603, 10693.786124277627, 11642.883571164519, 10948.39783811866, 11274.605388811353, 11313.0, 11470.082393408675, 11798.646040618794], "value": 7333.380920637721, "unit": "score"}], "name": "dromaeo_css", "value": 7458.597157438517, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 110.0, 111.0, 110.0, 111.0, 110.0, 110.0, 111.0, 111.0, 111.0], "value": 109.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 119.0, 120.0, 153.0, 118.0, 120.0, 116.0, 117.0, 143.0, 117.0], "value": 126.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 162.0, 161.0, 163.0, 162.0, 161.0, 161.0, 161.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 110.0, 75.0, 76.0, 75.0, 75.0, 97.0, 76.0], "value": 81.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 113.0, 83.0, 82.0, 82.0, 99.0, 81.0, 81.0, 107.0], "value": 89.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 116.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 147.0, 146.0, 146.0, 148.0, 146.0, 147.0, 146.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 84.0, 85.0, 85.0, 86.0, 85.0, 85.0, 85.0, 85.0], "value": 84.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 48.0, 48.0, 50.0, 50.0, 51.0, 48.0, 49.0, 49.0, 55.0], "value": 49.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 58.0, 59.0, 59.0, 60.0, 59.0, 60.0, 60.0, 60.0], "value": 59.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 82.0, 74.0, 75.0, 73.0, 75.0, 76.0, 75.0, 74.0], "value": 75.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 123.0, 125.0, 122.0, 121.0, 120.0, 132.0, 131.0, 163.0, 119.0], "value": 128.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 156.0, 156.0, 156.0, 158.0, 157.0, 157.0, 157.0, 162.0, 162.0], "value": 157.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 65.0, 61.0, 62.0, 62.0, 64.0, 62.0, 60.0, 60.0], "value": 61.9, "unit": "score"}], "name": "kraken", "value": 1448.4, "alertThreshold": 2.0}]} 02:53:38 INFO - Return code: 0 02:53:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:53:38 INFO - # TBPL SUCCESS # 02:53:38 INFO - Running post-action listener: _resource_record_post_action 02:53:38 INFO - [mozharness: 2016-12-15 10:53:38.391464Z] Finished run-tests step (success) 02:53:38 INFO - Running post-run listener: _resource_record_post_run 02:53:38 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 266240; Write bytes: 352944128; Read time: 36; Write time: 493896 02:53:38 INFO - TinderboxPrint: CPU usage
13.0% 02:53:38 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 36 02:53:38 INFO - TinderboxPrint: I/O write bytes / time
352,944,128 / 493,896 02:53:38 INFO - TinderboxPrint: CPU idle
8,305.1 (87.0%) 02:53:38 INFO - TinderboxPrint: CPU user
1,190.1 (12.5%) 02:53:38 INFO - TinderboxPrint: Swap in / out
0 / 0 02:53:38 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 108244992; Read time: 0; Write time: 236020 02:53:38 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 262144; Write bytes: 244699136; Read time: 20; Write time: 257876 02:53:39 INFO - Running post-run listener: _upload_blobber_files 02:53:39 INFO - Blob upload gear active. 02:53:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:53:39 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 02:53:39 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'] 02:53:39 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 02:53:39 INFO - (blobuploader) - INFO - Open directory for files ... 02:53:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:53:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:53:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:53:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:53:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:53:40 INFO - (blobuploader) - INFO - Done attempting. 02:53:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:53:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:53:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:53:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:53:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:53:41 INFO - (blobuploader) - INFO - Done attempting. 02:53:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:53:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:53:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:53:44 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:53:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:53:44 INFO - (blobuploader) - INFO - Done attempting. 02:53:44 INFO - (blobuploader) - INFO - Iteration through files over. 02:53:44 INFO - Return code: 0 02:53:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:53:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:53:44 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/608948862f8c2eee3e2bf5e32680e364d128562151f0a5ea9ab81459bcac51061943366ec5c9ce57be3f40623a0b317deb8b9bb706c0aba2d4a1a380d1ec8cbd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/74e65c24328a152958127d34fbafe89b3d848aa67909af6b3e203d7878d32d035902f907519490b057ba75bdd34b3af81676e9cd85bacf6041e589492dbb5698", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6641e9074dbcf6f684e561f14d9b89b16cd145b3b8d3e12881968bc22e121c12230e3e875e2719cb75ebcc865f33b4c78a1dea57351085c103c487e391f36a76"} 02:53:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:53:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:53:44 INFO - Contents: 02:53:44 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/608948862f8c2eee3e2bf5e32680e364d128562151f0a5ea9ab81459bcac51061943366ec5c9ce57be3f40623a0b317deb8b9bb706c0aba2d4a1a380d1ec8cbd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/74e65c24328a152958127d34fbafe89b3d848aa67909af6b3e203d7878d32d035902f907519490b057ba75bdd34b3af81676e9cd85bacf6041e589492dbb5698", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6641e9074dbcf6f684e561f14d9b89b16cd145b3b8d3e12881968bc22e121c12230e3e875e2719cb75ebcc865f33b4c78a1dea57351085c103c487e391f36a76"} 02:53:44 INFO - Running post-run listener: copy_logs_to_upload_dir 02:53:44 INFO - Copying logs to upload dir... 02:53:44 INFO - mkdir: /builds/slave/test/build/upload/logs 02:53:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.787294 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-12-15 02:53:43.772334) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-15 02:53:43.775491) ========= 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=5cf47e208febbcd81da23b2e0000026f-1481797983.25521-542867285 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/608948862f8c2eee3e2bf5e32680e364d128562151f0a5ea9ab81459bcac51061943366ec5c9ce57be3f40623a0b317deb8b9bb706c0aba2d4a1a380d1ec8cbd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/74e65c24328a152958127d34fbafe89b3d848aa67909af6b3e203d7878d32d035902f907519490b057ba75bdd34b3af81676e9cd85bacf6041e589492dbb5698", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6641e9074dbcf6f684e561f14d9b89b16cd145b3b8d3e12881968bc22e121c12230e3e875e2719cb75ebcc865f33b4c78a1dea57351085c103c487e391f36a76"} build_url:https://queue.taskcluster.net/v1/task/dYncMFW1RoaJz4xmuryazQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011706 build_url: 'https://queue.taskcluster.net/v1/task/dYncMFW1RoaJz4xmuryazQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/608948862f8c2eee3e2bf5e32680e364d128562151f0a5ea9ab81459bcac51061943366ec5c9ce57be3f40623a0b317deb8b9bb706c0aba2d4a1a380d1ec8cbd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/74e65c24328a152958127d34fbafe89b3d848aa67909af6b3e203d7878d32d035902f907519490b057ba75bdd34b3af81676e9cd85bacf6041e589492dbb5698", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6641e9074dbcf6f684e561f14d9b89b16cd145b3b8d3e12881968bc22e121c12230e3e875e2719cb75ebcc865f33b4c78a1dea57351085c103c487e391f36a76"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-15 02:53:43.804051) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-15 02:53:43.804732) ========= 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=5cf47e208febbcd81da23b2e0000026f-1481797983.25521-542867285 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004485 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-15 02:53:43.889607) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-15 02:53:43.890364) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-15 02:53:43.891008) ========= ========= Total master_lag: 0.17 =========