builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-038 starttime: 1476698938.96 results: success (0) buildid: 20161017014536 builduid: 597d596a3471495fb3fb789eb9f37fe0 revision: 0a184681d389f62a1aff59218a2d52e77bcc911b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-17 03:08:58.958567) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-17 03:08:58.959102) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-17 03:08:58.959394) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-17 03:08:59.017576) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 03:08:59.017829) ========= 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=8783db0840cc980e80bb0bd400000236-1476697705.653901-30023657 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-17 03:08:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 56.9M=0s 2016-10-17 03:08:59 (56.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.074506 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 03:08:59.106913) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 03:08:59.107204) ========= 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=8783db0840cc980e80bb0bd400000236-1476697705.653901-30023657 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017512 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 03:08:59.160290) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 03:08:59.160591) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 0a184681d389f62a1aff59218a2d52e77bcc911b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 0a184681d389f62a1aff59218a2d52e77bcc911b --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=8783db0840cc980e80bb0bd400000236-1476697705.653901-30023657 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-17 03:08:59,984 truncating revision to first 12 chars 2016-10-17 03:08:59,984 Setting DEBUG logging. 2016-10-17 03:08:59,984 attempt 1/10 2016-10-17 03:08:59,984 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/0a184681d389?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-17 03:09:00,282 unpacking tar archive at: mozilla-central-0a184681d389/testing/mozharness/ program finished with exit code 0 elapsedTime=0.660087 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 03:08:59.836969) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-17 03:08:59.837251) ========= script_repo_revision: 0a184681d389f62a1aff59218a2d52e77bcc911b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-17 03:08:59.837612) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-17 03:08:59.837926) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-17 03:08:59.847837) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-10-17 03:08:59.848117) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=8783db0840cc980e80bb0bd400000236-1476697705.653901-30023657 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:09:00 INFO - MultiFileLogger online at 20161017 03:09:00 in /builds/slave/test 03:09:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 03:09:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:09:00 INFO - {'append_to_log': False, 03:09:00 INFO - 'base_work_dir': '/builds/slave/test', 03:09:00 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 03:09:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:09:00 INFO - 'branch': 'Firefox-Non-PGO', 03:09:00 INFO - 'buildbot_json_path': 'buildprops.json', 03:09:00 INFO - 'config_files': ('talos/linux_config.py',), 03:09:00 INFO - 'default_actions': ('clobber', 03:09:00 INFO - 'read-buildbot-config', 03:09:00 INFO - 'download-and-extract', 03:09:00 INFO - 'populate-webroot', 03:09:00 INFO - 'create-virtualenv', 03:09:00 INFO - 'install', 03:09:00 INFO - 'run-tests'), 03:09:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:09:00 INFO - 'download_minidump_stackwalk': True, 03:09:00 INFO - 'download_symbols': 'ondemand', 03:09:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:09:00 INFO - 'tooltool.py': '/tools/tooltool.py', 03:09:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:09:00 INFO - '/tools/misc-python/virtualenv.py')}, 03:09:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:09:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:09:00 INFO - 'installer_path': 'installer.exe', 03:09:00 INFO - 'log_level': 'info', 03:09:00 INFO - 'log_name': 'talos', 03:09:00 INFO - 'log_to_console': True, 03:09:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:09:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:09:00 INFO - 'opt_config_files': (), 03:09:00 INFO - 'pip_index': False, 03:09:00 INFO - 'sps_profile': False, 03:09:00 INFO - 'sps_profile_interval': 0, 03:09:00 INFO - 'suite': 'dromaeojs', 03:09:00 INFO - 'system_bits': '32', 03:09:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:09:00 INFO - 'title': 'talos-linux64-ix-038', 03:09:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:09:00 INFO - 'use_talos_json': True, 03:09:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:09:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:09:00 INFO - 'work_dir': 'build'} 03:09:00 INFO - [mozharness: 2016-10-17 10:09:00.770449Z] Running clobber step. 03:09:00 INFO - Running pre-action listener: _resource_record_pre_action 03:09:00 INFO - Running main action method: clobber 03:09:00 INFO - rmtree: /builds/slave/test/build 03:09:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:09:01 INFO - Running post-action listener: _resource_record_post_action 03:09:01 INFO - [mozharness: 2016-10-17 10:09:01.234213Z] Finished clobber step (success) 03:09:01 INFO - [mozharness: 2016-10-17 10:09:01.234314Z] Running read-buildbot-config step. 03:09:01 INFO - Running pre-action listener: _resource_record_pre_action 03:09:01 INFO - Running main action method: read_buildbot_config 03:09:01 INFO - Using buildbot properties: 03:09:01 INFO - { 03:09:01 INFO - "project": "", 03:09:01 INFO - "product": "firefox", 03:09:01 INFO - "script_repo_revision": "production", 03:09:01 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 03:09:01 INFO - "repository": "", 03:09:01 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 03:09:01 INFO - "buildid": "20161017014536", 03:09:01 INFO - "pgo_build": "False", 03:09:01 INFO - "basedir": "/builds/slave/test", 03:09:01 INFO - "buildnumber": 251, 03:09:01 INFO - "slavename": "talos-linux64-ix-038", 03:09:01 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:09:01 INFO - "platform": "ubuntu64_hw", 03:09:01 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 03:09:01 INFO - "branch": "mozilla-central", 03:09:01 INFO - "repo_path": "mozilla-central", 03:09:01 INFO - "revision": "0a184681d389f62a1aff59218a2d52e77bcc911b", 03:09:01 INFO - "stage_platform": "linux64", 03:09:01 INFO - "builduid": "597d596a3471495fb3fb789eb9f37fe0", 03:09:01 INFO - "slavebuilddir": "test" 03:09:01 INFO - } 03:09:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/AIKHBGKwRiGO1JkDdVYN7g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 03:09:01 INFO - Running post-action listener: _resource_record_post_action 03:09:01 INFO - [mozharness: 2016-10-17 10:09:01.236757Z] Finished read-buildbot-config step (success) 03:09:01 INFO - [mozharness: 2016-10-17 10:09:01.236846Z] Running download-and-extract step. 03:09:01 INFO - Running pre-action listener: _resource_record_pre_action 03:09:01 INFO - Running main action method: download_and_extract 03:09:01 INFO - mkdir: /builds/slave/test/build/tests 03:09:01 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')]} 03:09:01 INFO - trying https://queue.taskcluster.net/v1/task/AIKHBGKwRiGO1JkDdVYN7g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 03:09:01 INFO - Downloading https://queue.taskcluster.net/v1/task/AIKHBGKwRiGO1JkDdVYN7g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 03:09:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AIKHBGKwRiGO1JkDdVYN7g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:09:01 INFO - Downloaded 1361 bytes. 03:09:01 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 03:09:01 INFO - Using the following test package requirements: 03:09:01 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 03:09:01 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:09:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:09:01 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:09:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 03:09:01 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:09:01 INFO - u'jsshell-linux-x86_64.zip'], 03:09:01 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:09:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:09:01 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 03:09:01 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:09:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:09:01 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:09:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:09:01 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:09:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:09:01 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:09:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:09:01 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:09:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AIKHBGKwRiGO1JkDdVYN7g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 03:09:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AIKHBGKwRiGO1JkDdVYN7g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:09:01 INFO - Fetch https://queue.taskcluster.net/v1/task/AIKHBGKwRiGO1JkDdVYN7g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 03:09:02 INFO - Http code: 200 03:09:02 INFO - via: 1.1 ccaa055c9a26ce13da709353563e04a5.cloudfront.net (CloudFront) 03:09:02 INFO - x-amz-cf-id: ApzSIRWqTcvL3awF49aCgzoLdQbszF28QmgrY8omNNxh06zVTDNdvA== 03:09:02 INFO - x-amz-version-id: V4UdYHksYVmp.eIK3ID0lYDQsZXvBoPh 03:09:02 INFO - Expected file size: 20546796 03:09:02 INFO - Obtained file size: 20546796 03:09:06 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:09:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AIKHBGKwRiGO1JkDdVYN7g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 03:09:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AIKHBGKwRiGO1JkDdVYN7g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:09:06 INFO - Fetch https://queue.taskcluster.net/v1/task/AIKHBGKwRiGO1JkDdVYN7g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 03:09:07 INFO - Http code: 200 03:09:07 INFO - via: 1.1 ff555a0cc6346f82fe74596f8ed6cc33.cloudfront.net (CloudFront) 03:09:07 INFO - x-amz-cf-id: T_xRNayI8wnx4JH8bM3NynOjzaxXkgM6dun6IujNdfZeH6K3ZX8rtA== 03:09:07 INFO - x-amz-version-id: V4UdYHksYVmp.eIK3ID0lYDQsZXvBoPh 03:09:07 INFO - Expected file size: 20546796 03:09:07 INFO - Obtained file size: 20546796 03:09:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AIKHBGKwRiGO1JkDdVYN7g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 03:09:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AIKHBGKwRiGO1JkDdVYN7g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:09:12 INFO - Fetch https://queue.taskcluster.net/v1/task/AIKHBGKwRiGO1JkDdVYN7g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 03:09:12 INFO - Http code: 200 03:09:12 INFO - via: 1.1 b9a8ce441329f20cea895e08f19f1ec8.cloudfront.net (CloudFront) 03:09:12 INFO - x-amz-cf-id: pzNAVr5QhR_fPAZndSyHkS_JzDn3jBgXz1Qn27sGOeNeiF-EIKp-QQ== 03:09:12 INFO - x-amz-version-id: Nrnyh_oWQFIulSFnjNKEKB7nk9XqGpAT 03:09:13 INFO - Expected file size: 14409028 03:09:13 INFO - Obtained file size: 14409028 03:09:13 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')]} 03:09:13 INFO - trying https://queue.taskcluster.net/v1/task/AIKHBGKwRiGO1JkDdVYN7g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 03:09:13 INFO - Downloading https://queue.taskcluster.net/v1/task/AIKHBGKwRiGO1JkDdVYN7g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 03:09:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AIKHBGKwRiGO1JkDdVYN7g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:09:15 INFO - Downloaded 55622169 bytes. 03:09:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AIKHBGKwRiGO1JkDdVYN7g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 03:09:15 INFO - mkdir: /builds/slave/test/properties 03:09:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:09:15 INFO - Writing to file /builds/slave/test/properties/build_url 03:09:15 INFO - Contents: 03:09:15 INFO - build_url:https://queue.taskcluster.net/v1/task/AIKHBGKwRiGO1JkDdVYN7g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 03:09:16 INFO - Running post-action listener: _resource_record_post_action 03:09:16 INFO - Running post-action listener: set_extra_try_arguments 03:09:16 INFO - [mozharness: 2016-10-17 10:09:16.316713Z] Finished download-and-extract step (success) 03:09:16 INFO - [mozharness: 2016-10-17 10:09:16.316941Z] Running populate-webroot step. 03:09:16 INFO - Running pre-action listener: _resource_record_pre_action 03:09:16 INFO - Running main action method: populate_webroot 03:09:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:09:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:09:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:09:16 INFO - '--tppagecycles', 03:09:16 INFO - '7'], 03:09:16 INFO - 'tests': ['tsvgm']}}, 03:09:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:09:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:09:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:09:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:09:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:09:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:09:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:09:16 INFO - 'talos_options': ['--disable-e10s'], 03:09:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:09:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:09:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:09:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:09:16 INFO - 'talos_options': ['--disable-e10s'], 03:09:16 INFO - 'tests': ['damp', 'tps']}, 03:09:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:09:16 INFO - 'tests': ['damp', 'tps']}, 03:09:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:09:16 INFO - 'tests': ['dromaeo_dom']}, 03:09:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:09:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:09:16 INFO - 'tests': ['basic_compositor_video']}, 03:09:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:09:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:09:16 INFO - 'tests': ['a11yr', 03:09:16 INFO - 'ts_paint', 03:09:16 INFO - 'tpaint', 03:09:16 INFO - 'sessionrestore', 03:09:16 INFO - 'sessionrestore_no_auto_restore', 03:09:16 INFO - 'tabpaint']}, 03:09:16 INFO - 'other-e10s': {'tests': ['a11yr', 03:09:16 INFO - 'ts_paint', 03:09:16 INFO - 'tpaint', 03:09:16 INFO - 'sessionrestore', 03:09:16 INFO - 'sessionrestore_no_auto_restore', 03:09:16 INFO - 'tabpaint']}, 03:09:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:09:16 INFO - 'ts_paint', 03:09:16 INFO - 'tpaint', 03:09:16 INFO - 'sessionrestore', 03:09:16 INFO - 'sessionrestore_no_auto_restore', 03:09:16 INFO - 'tabpaint']}, 03:09:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:09:16 INFO - 'ts_paint', 03:09:16 INFO - 'tpaint', 03:09:16 INFO - 'sessionrestore', 03:09:16 INFO - 'sessionrestore_no_auto_restore', 03:09:16 INFO - 'tabpaint']}, 03:09:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:09:16 INFO - 'tests': ['a11yr', 03:09:16 INFO - 'ts_paint', 03:09:16 INFO - 'tpaint', 03:09:16 INFO - 'sessionrestore', 03:09:16 INFO - 'sessionrestore_no_auto_restore', 03:09:16 INFO - 'tabpaint']}, 03:09:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:09:16 INFO - 'tests': ['a11yr', 03:09:16 INFO - 'ts_paint', 03:09:16 INFO - 'tpaint', 03:09:16 INFO - 'sessionrestore', 03:09:16 INFO - 'sessionrestore_no_auto_restore', 03:09:16 INFO - 'tabpaint']}, 03:09:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:09:16 INFO - 'tests': ['tsvgx', 03:09:16 INFO - 'tsvgr_opacity', 03:09:16 INFO - 'tart', 03:09:16 INFO - 'tscrollx', 03:09:16 INFO - 'cart']}, 03:09:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:09:16 INFO - 'tsvgr_opacity', 03:09:16 INFO - 'tart', 03:09:16 INFO - 'tscrollx', 03:09:16 INFO - 'cart']}, 03:09:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:09:16 INFO - 'talos_options': ['--disable-e10s'], 03:09:16 INFO - 'tests': ['tp5o']}, 03:09:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:09:16 INFO - 'tests': ['tp5o']}, 03:09:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:09:16 INFO - 'talos_options': ['--disable-e10s', 03:09:16 INFO - '--xperf_path', 03:09:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:09:16 INFO - 'tests': ['tp5n']}, 03:09:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:09:16 INFO - 'talos_options': ['--xperf_path', 03:09:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:09:16 INFO - 'tests': ['tp5n']}}, 03:09:16 INFO - 'talos.zip': {'path': '', 03:09:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:09:16 INFO - Running post-action listener: _resource_record_post_action 03:09:16 INFO - [mozharness: 2016-10-17 10:09:16.338982Z] Finished populate-webroot step (success) 03:09:16 INFO - [mozharness: 2016-10-17 10:09:16.339070Z] Running create-virtualenv step. 03:09:16 INFO - Running pre-action listener: _resource_record_pre_action 03:09:16 INFO - Running main action method: create_virtualenv 03:09:16 INFO - Creating virtualenv /builds/slave/test/build/venv 03:09:16 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 03:09:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:09:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:09:16 INFO - Using real prefix '/usr' 03:09:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:09:16 INFO - Installing distribute.............................................................................................................................................................................................done. 03:09:18 INFO - Installing pip.................done. 03:09:18 INFO - Return code: 0 03:09:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:09:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:09:19 INFO - Reading from file tmpfile_stdout 03:09:19 INFO - Output received: 03:09:19 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 03:09:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:09:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:09:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:09:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:09:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:09:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:19 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 0x7fd4d3b21f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xecd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf9aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf97f60>, '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 0xf98d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf991d0>, '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': '8783db0840cc980e80bb0bd400000236-1476697705.653901-30023657', '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 03:09:19 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 03:09:19 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 03:09:19 INFO - Using env: {'DISPLAY': ':0', 03:09:19 INFO - 'HOME': '/home/cltbld', 03:09:19 INFO - 'LANG': 'en_US.UTF-8', 03:09:19 INFO - 'LANGUAGE': 'en_US:en', 03:09:19 INFO - 'LOGNAME': 'cltbld', 03:09:19 INFO - 'MAIL': '/var/mail/cltbld', 03:09:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:09:19 INFO - 'MOZ_NO_REMOTE': '1', 03:09:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:09:19 INFO - 'NO_EM_RESTART': '1', 03:09:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:09:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:09:19 INFO - 'PWD': '/builds/slave/test', 03:09:19 INFO - 'SHELL': '/bin/bash', 03:09:19 INFO - 'SHLVL': '1', 03:09:19 INFO - 'TERM': 'linux', 03:09:19 INFO - 'TMOUT': '86400', 03:09:19 INFO - 'USER': 'cltbld', 03:09:19 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1476697705.653901-30023657', 03:09:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:09:19 INFO - '_': '/tools/buildbot/bin/python'} 03:09:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:09:19 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 03:09:19 INFO - Cleaning up... 03:09:19 INFO - Return code: 0 03:09:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:09:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:09:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:09:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:09:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:09:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:19 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 0x7fd4d3b21f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xecd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf9aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf97f60>, '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 0xf98d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf991d0>, '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': '8783db0840cc980e80bb0bd400000236-1476697705.653901-30023657', '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 03:09:19 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 03:09:19 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 03:09:19 INFO - Using env: {'DISPLAY': ':0', 03:09:19 INFO - 'HOME': '/home/cltbld', 03:09:19 INFO - 'LANG': 'en_US.UTF-8', 03:09:19 INFO - 'LANGUAGE': 'en_US:en', 03:09:19 INFO - 'LOGNAME': 'cltbld', 03:09:19 INFO - 'MAIL': '/var/mail/cltbld', 03:09:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:09:19 INFO - 'MOZ_NO_REMOTE': '1', 03:09:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:09:19 INFO - 'NO_EM_RESTART': '1', 03:09:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:09:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:09:19 INFO - 'PWD': '/builds/slave/test', 03:09:19 INFO - 'SHELL': '/bin/bash', 03:09:19 INFO - 'SHLVL': '1', 03:09:19 INFO - 'TERM': 'linux', 03:09:19 INFO - 'TMOUT': '86400', 03:09:19 INFO - 'USER': 'cltbld', 03:09:19 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1476697705.653901-30023657', 03:09:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:09:19 INFO - '_': '/tools/buildbot/bin/python'} 03:09:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:09:19 INFO - Downloading/unpacking psutil>=3.1.1 03:09:19 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 03:09:19 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 03:09:19 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 03:09:19 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 03:09:19 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 03:09:19 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 03:09:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:09:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:09:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:09:21 INFO - Installing collected packages: psutil 03:09:21 INFO - Running setup.py install for psutil 03:09:21 INFO - building 'psutil._psutil_linux' extension 03:09:21 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 03:09:21 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:09:21 INFO - building 'psutil._psutil_posix' extension 03:09:21 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 03:09:22 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:09:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:09:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:09:22 INFO - Successfully installed psutil 03:09:22 INFO - Cleaning up... 03:09:22 INFO - Return code: 0 03:09:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:09: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')]} 03:09:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:09:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09: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')]} 03:09:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:09:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4d3b21f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xecd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf9aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf97f60>, '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 0xf98d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf991d0>, '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': '8783db0840cc980e80bb0bd400000236-1476697705.653901-30023657', '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 03:09: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:09: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 mozsystemmonitor==0.3 03:09:22 INFO - Using env: {'DISPLAY': ':0', 03:09:22 INFO - 'HOME': '/home/cltbld', 03:09:22 INFO - 'LANG': 'en_US.UTF-8', 03:09:22 INFO - 'LANGUAGE': 'en_US:en', 03:09:22 INFO - 'LOGNAME': 'cltbld', 03:09:22 INFO - 'MAIL': '/var/mail/cltbld', 03:09:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:09:22 INFO - 'MOZ_NO_REMOTE': '1', 03:09:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:09:22 INFO - 'NO_EM_RESTART': '1', 03:09:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:09:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:09:22 INFO - 'PWD': '/builds/slave/test', 03:09:22 INFO - 'SHELL': '/bin/bash', 03:09:22 INFO - 'SHLVL': '1', 03:09:22 INFO - 'TERM': 'linux', 03:09:22 INFO - 'TMOUT': '86400', 03:09:22 INFO - 'USER': 'cltbld', 03:09:22 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1476697705.653901-30023657', 03:09:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:09:22 INFO - '_': '/tools/buildbot/bin/python'} 03:09:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:09:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:09:22 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 03:09:22 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 03:09:22 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 03:09:22 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 03:09:22 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 03:09:22 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 03:09:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:09:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:09:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:09:24 INFO - Installing collected packages: mozsystemmonitor 03:09:24 INFO - Running setup.py install for mozsystemmonitor 03:09:24 INFO - Successfully installed mozsystemmonitor 03:09:24 INFO - Cleaning up... 03:09:24 INFO - Return code: 0 03:09:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:09:24 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')]} 03:09:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:09:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:24 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')]} 03:09:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:09:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:24 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 0x7fd4d3b21f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xecd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf9aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf97f60>, '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 0xf98d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf991d0>, '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': '8783db0840cc980e80bb0bd400000236-1476697705.653901-30023657', '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 03:09:24 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 03:09:24 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 03:09:24 INFO - Using env: {'DISPLAY': ':0', 03:09:24 INFO - 'HOME': '/home/cltbld', 03:09:24 INFO - 'LANG': 'en_US.UTF-8', 03:09:24 INFO - 'LANGUAGE': 'en_US:en', 03:09:24 INFO - 'LOGNAME': 'cltbld', 03:09:24 INFO - 'MAIL': '/var/mail/cltbld', 03:09:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:09:24 INFO - 'MOZ_NO_REMOTE': '1', 03:09:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:09:24 INFO - 'NO_EM_RESTART': '1', 03:09:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:09:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:09:24 INFO - 'PWD': '/builds/slave/test', 03:09:24 INFO - 'SHELL': '/bin/bash', 03:09:24 INFO - 'SHLVL': '1', 03:09:24 INFO - 'TERM': 'linux', 03:09:24 INFO - 'TMOUT': '86400', 03:09:24 INFO - 'USER': 'cltbld', 03:09:24 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1476697705.653901-30023657', 03:09:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:09:24 INFO - '_': '/tools/buildbot/bin/python'} 03:09:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:09:24 INFO - Downloading/unpacking jsonschema==2.5.1 03:09:24 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 03:09:24 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 03:09:24 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 03:09:24 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 03:09:24 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 03:09:24 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 03:09:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:09:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:09:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:09:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:09:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:26 INFO - Downloading functools32-3.2.3-2.tar.gz 03:09:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:09:26 INFO - warning: no files found matching '*.txt' 03:09:26 INFO - no previously-included directories found matching 'build' 03:09:26 INFO - no previously-included directories found matching 'dist' 03:09:26 INFO - no previously-included directories found matching '.git*' 03:09:26 INFO - Installing collected packages: jsonschema, functools32 03:09:27 INFO - Running setup.py install for functools32 03:09:27 INFO - warning: no files found matching '*.txt' 03:09:27 INFO - no previously-included directories found matching 'build' 03:09:27 INFO - no previously-included directories found matching 'dist' 03:09:27 INFO - no previously-included directories found matching '.git*' 03:09:27 INFO - Successfully installed jsonschema functools32 03:09:27 INFO - Cleaning up... 03:09:27 INFO - Return code: 0 03:09:27 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:09:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:09:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:09:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:09:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:09:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4d3b21f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xecd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf9aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf97f60>, '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 0xf98d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf991d0>, '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': '8783db0840cc980e80bb0bd400000236-1476697705.653901-30023657', '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 03:09:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:09:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:09:27 INFO - Using env: {'DISPLAY': ':0', 03:09:27 INFO - 'HOME': '/home/cltbld', 03:09:27 INFO - 'LANG': 'en_US.UTF-8', 03:09:27 INFO - 'LANGUAGE': 'en_US:en', 03:09:27 INFO - 'LOGNAME': 'cltbld', 03:09:27 INFO - 'MAIL': '/var/mail/cltbld', 03:09:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:09:27 INFO - 'MOZ_NO_REMOTE': '1', 03:09:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:09:27 INFO - 'NO_EM_RESTART': '1', 03:09:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:09:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:09:27 INFO - 'PWD': '/builds/slave/test', 03:09:27 INFO - 'SHELL': '/bin/bash', 03:09:27 INFO - 'SHLVL': '1', 03:09:27 INFO - 'TERM': 'linux', 03:09:27 INFO - 'TMOUT': '86400', 03:09:27 INFO - 'USER': 'cltbld', 03:09:27 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1476697705.653901-30023657', 03:09:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:09:27 INFO - '_': '/tools/buildbot/bin/python'} 03:09:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:09:27 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:09:27 INFO - Cleaning up... 03:09:27 INFO - Return code: 0 03:09:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:09:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:09:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:09:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:09:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:09:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd4d3b21f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xecd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf9aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf97f60>, '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 0xf98d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf991d0>, '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': '8783db0840cc980e80bb0bd400000236-1476697705.653901-30023657', '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 03:09:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:09:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:09:27 INFO - Using env: {'DISPLAY': ':0', 03:09:27 INFO - 'HOME': '/home/cltbld', 03:09:27 INFO - 'LANG': 'en_US.UTF-8', 03:09:27 INFO - 'LANGUAGE': 'en_US:en', 03:09:27 INFO - 'LOGNAME': 'cltbld', 03:09:27 INFO - 'MAIL': '/var/mail/cltbld', 03:09:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:09:27 INFO - 'MOZ_NO_REMOTE': '1', 03:09:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:09:27 INFO - 'NO_EM_RESTART': '1', 03:09:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:09:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:09:27 INFO - 'PWD': '/builds/slave/test', 03:09:27 INFO - 'SHELL': '/bin/bash', 03:09:27 INFO - 'SHLVL': '1', 03:09:27 INFO - 'TERM': 'linux', 03:09:27 INFO - 'TMOUT': '86400', 03:09:27 INFO - 'USER': 'cltbld', 03:09:27 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1476697705.653901-30023657', 03:09:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:09:27 INFO - '_': '/tools/buildbot/bin/python'} 03:09:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:09:27 INFO - Downloading/unpacking blobuploader==1.2.4 03:09:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:09:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:09:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:29 INFO - Downloading blobuploader-1.2.4.tar.gz 03:09:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:09:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:09:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:09:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:09:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:09:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:09: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 03:09: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 03:09: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 03:09: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 03:09: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 03:09: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 03:09:30 INFO - Downloading docopt-0.6.1.tar.gz 03:09:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:09:30 INFO - Installing collected packages: blobuploader, requests, docopt 03:09:30 INFO - Running setup.py install for blobuploader 03:09:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:09:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:09:30 INFO - Running setup.py install for requests 03:09:30 INFO - Running setup.py install for docopt 03:09:30 INFO - Successfully installed blobuploader requests docopt 03:09:30 INFO - Cleaning up... 03:09:30 INFO - Return code: 0 03:09:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:09: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')]} 03:09:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:09:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09: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')]} 03:09:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:09:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:30 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 0x7fd4d3b21f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xecd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf9aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf97f60>, '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 0xf98d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf991d0>, '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': '8783db0840cc980e80bb0bd400000236-1476697705.653901-30023657', '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 03:09:30 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 03:09:30 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 03:09:30 INFO - Using env: {'DISPLAY': ':0', 03:09:30 INFO - 'HOME': '/home/cltbld', 03:09:30 INFO - 'LANG': 'en_US.UTF-8', 03:09:30 INFO - 'LANGUAGE': 'en_US:en', 03:09:30 INFO - 'LOGNAME': 'cltbld', 03:09:30 INFO - 'MAIL': '/var/mail/cltbld', 03:09:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:09:30 INFO - 'MOZ_NO_REMOTE': '1', 03:09:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:09:30 INFO - 'NO_EM_RESTART': '1', 03:09:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:09:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:09:30 INFO - 'PWD': '/builds/slave/test', 03:09:30 INFO - 'SHELL': '/bin/bash', 03:09:30 INFO - 'SHLVL': '1', 03:09:30 INFO - 'TERM': 'linux', 03:09:30 INFO - 'TMOUT': '86400', 03:09:30 INFO - 'USER': 'cltbld', 03:09:30 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1476697705.653901-30023657', 03:09:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:09:30 INFO - '_': '/tools/buildbot/bin/python'} 03:09:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:09:31 INFO - Running setup.py (path:/tmp/pip-2sDFlB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:09:31 INFO - Running setup.py (path:/tmp/pip-ZWDILy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:09:31 INFO - Running setup.py (path:/tmp/pip-V4txax-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:09:31 INFO - Running setup.py (path:/tmp/pip-U0wDvT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:09:31 INFO - Running setup.py (path:/tmp/pip-5V0YcN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:09:31 INFO - Running setup.py (path:/tmp/pip-PAkdbg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:09:31 INFO - Running setup.py (path:/tmp/pip-DWgg9z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:09:31 INFO - Running setup.py (path:/tmp/pip-baLyzX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:09:31 INFO - Running setup.py (path:/tmp/pip-joVUyr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:09:31 INFO - Running setup.py (path:/tmp/pip-tZEsxk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:09:31 INFO - Running setup.py (path:/tmp/pip-k3yP9A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:09:31 INFO - Running setup.py (path:/tmp/pip-G_XmdD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:09:32 INFO - Running setup.py (path:/tmp/pip-4CYGMt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:09:32 INFO - Running setup.py (path:/tmp/pip-LzyHTz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:09:32 INFO - Running setup.py (path:/tmp/pip-rui51X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:09:32 INFO - Running setup.py (path:/tmp/pip-4MDpE0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:09:32 INFO - Running setup.py (path:/tmp/pip-MqoaBK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:09:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:09:32 INFO - Running setup.py install for manifestparser 03:09:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:09:32 INFO - Running setup.py install for mozcrash 03:09:32 INFO - Running setup.py install for mozdebug 03:09:32 INFO - Running setup.py install for mozdevice 03:09:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:09:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:09:32 INFO - Running setup.py install for mozfile 03:09:32 INFO - Running setup.py install for mozhttpd 03:09:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:09:33 INFO - Running setup.py install for mozinfo 03:09:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:09:33 INFO - Running setup.py install for mozInstall 03:09:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:09:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:09:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:09:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:09:33 INFO - Running setup.py install for mozleak 03:09:33 INFO - Running setup.py install for mozlog 03:09:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:09:33 INFO - Running setup.py install for moznetwork 03:09:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:09:33 INFO - Running setup.py install for mozprocess 03:09:33 INFO - Running setup.py install for mozprofile 03:09:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:09:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:09:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:09:33 INFO - Running setup.py install for mozrunner 03:09:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:09:33 INFO - Running setup.py install for mozscreenshot 03:09:33 INFO - Running setup.py install for moztest 03:09:34 INFO - Running setup.py install for mozversion 03:09:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:09:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:09:34 INFO - Cleaning up... 03:09:34 INFO - Return code: 0 03:09:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:09: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')]} 03:09:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:09:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09: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')]} 03:09:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:09:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4d3b21f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xecd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf9aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf97f60>, '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 0xf98d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf991d0>, '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': '8783db0840cc980e80bb0bd400000236-1476697705.653901-30023657', '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 03:09:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:09:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:09:34 INFO - Using env: {'DISPLAY': ':0', 03:09:34 INFO - 'HOME': '/home/cltbld', 03:09:34 INFO - 'LANG': 'en_US.UTF-8', 03:09:34 INFO - 'LANGUAGE': 'en_US:en', 03:09:34 INFO - 'LOGNAME': 'cltbld', 03:09:34 INFO - 'MAIL': '/var/mail/cltbld', 03:09:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:09:34 INFO - 'MOZ_NO_REMOTE': '1', 03:09:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:09:34 INFO - 'NO_EM_RESTART': '1', 03:09:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:09:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:09:34 INFO - 'PWD': '/builds/slave/test', 03:09:34 INFO - 'SHELL': '/bin/bash', 03:09:34 INFO - 'SHLVL': '1', 03:09:34 INFO - 'TERM': 'linux', 03:09:34 INFO - 'TMOUT': '86400', 03:09:34 INFO - 'USER': 'cltbld', 03:09:34 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1476697705.653901-30023657', 03:09:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:09:34 INFO - '_': '/tools/buildbot/bin/python'} 03:09:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:09:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:09:34 INFO - Running setup.py (path:/tmp/pip-mVEdC8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:09:34 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)) 03:09:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:09:34 INFO - Running setup.py (path:/tmp/pip-ZVWh2H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:09:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:09:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:09:34 INFO - Running setup.py (path:/tmp/pip-owpS4C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:09:34 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)) 03:09:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:09:34 INFO - Running setup.py (path:/tmp/pip-M5DHBK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:09:34 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)) 03:09:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:09:34 INFO - Running setup.py (path:/tmp/pip-WA3xjH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:09:34 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)) 03:09:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:09:34 INFO - Running setup.py (path:/tmp/pip-uxfU9n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:09:34 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)) 03:09:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:09:34 INFO - Running setup.py (path:/tmp/pip-mYHxVi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:09:34 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)) 03:09:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:09:34 INFO - Running setup.py (path:/tmp/pip-fw3i5H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:09:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:09:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:09:34 INFO - Running setup.py (path:/tmp/pip-foPa8u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:09:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:09:35 INFO - Running setup.py (path:/tmp/pip-zVaAwo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:09:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:09:35 INFO - Running setup.py (path:/tmp/pip-0VpLj4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:09:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:09:35 INFO - Running setup.py (path:/tmp/pip-qq1vUF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:09:35 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)) 03:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:09:35 INFO - Running setup.py (path:/tmp/pip-hFpiZf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:09:35 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)) 03:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:09:35 INFO - Running setup.py (path:/tmp/pip-FSBGAb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:09:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:09:35 INFO - Running setup.py (path:/tmp/pip-d9bqUr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:09:35 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)) 03:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:09:35 INFO - Running setup.py (path:/tmp/pip-PXvtwt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:09:35 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)) 03:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:09:35 INFO - Running setup.py (path:/tmp/pip-LrPvQj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:09:35 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)) 03:09:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:09:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:09:35 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)) 03:09:35 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)) 03:09:35 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)) 03:09:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:09:35 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 03:09:35 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 03:09:35 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 03:09:35 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 03:09:35 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 03:09:35 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 03:09:37 INFO - Downloading blessings-1.6.tar.gz 03:09:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:09:37 INFO - Installing collected packages: blessings 03:09:37 INFO - Running setup.py install for blessings 03:09:37 INFO - Successfully installed blessings 03:09:37 INFO - Cleaning up... 03:09:37 INFO - Return code: 0 03:09:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:09:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:09:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:09:38 INFO - Reading from file tmpfile_stdout 03:09:38 INFO - Current package versions: 03:09:38 INFO - argparse == 1.2.1 03:09:38 INFO - blessings == 1.6 03:09:38 INFO - blobuploader == 1.2.4 03:09:38 INFO - docopt == 0.6.1 03:09:38 INFO - functools32 == 3.2.3-2 03:09:38 INFO - jsonschema == 2.5.1 03:09:38 INFO - manifestparser == 1.1 03:09:38 INFO - mozInstall == 1.12 03:09:38 INFO - mozcrash == 0.17 03:09:38 INFO - mozdebug == 0.1 03:09:38 INFO - mozdevice == 0.48 03:09:38 INFO - mozfile == 1.2 03:09:38 INFO - mozhttpd == 0.7 03:09:38 INFO - mozinfo == 0.9 03:09:38 INFO - mozleak == 0.1 03:09:38 INFO - mozlog == 3.4 03:09:38 INFO - moznetwork == 0.27 03:09:38 INFO - mozprocess == 0.23 03:09:38 INFO - mozprofile == 0.28 03:09:38 INFO - mozrunner == 6.12 03:09:38 INFO - mozscreenshot == 0.1 03:09:38 INFO - mozsystemmonitor == 0.3 03:09:38 INFO - moztest == 0.7 03:09:38 INFO - mozversion == 1.4 03:09:38 INFO - psutil == 3.1.1 03:09:38 INFO - requests == 1.2.3 03:09:38 INFO - wsgiref == 0.1.2 03:09:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:09:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:09:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:09:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:09:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:09:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4d3b21f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xecd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf9aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf97f60>, '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 0xf98d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf991d0>, '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': '8783db0840cc980e80bb0bd400000236-1476697705.653901-30023657', '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 03:09:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:09:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:09:38 INFO - Using env: {'DISPLAY': ':0', 03:09:38 INFO - 'HOME': '/home/cltbld', 03:09:38 INFO - 'LANG': 'en_US.UTF-8', 03:09:38 INFO - 'LANGUAGE': 'en_US:en', 03:09:38 INFO - 'LOGNAME': 'cltbld', 03:09:38 INFO - 'MAIL': '/var/mail/cltbld', 03:09:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:09:38 INFO - 'MOZ_NO_REMOTE': '1', 03:09:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:09:38 INFO - 'NO_EM_RESTART': '1', 03:09:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:09:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:09:38 INFO - 'PWD': '/builds/slave/test', 03:09:38 INFO - 'SHELL': '/bin/bash', 03:09:38 INFO - 'SHLVL': '1', 03:09:38 INFO - 'TERM': 'linux', 03:09:38 INFO - 'TMOUT': '86400', 03:09:38 INFO - 'USER': 'cltbld', 03:09:38 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1476697705.653901-30023657', 03:09:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:09:38 INFO - '_': '/tools/buildbot/bin/python'} 03:09:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:09:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:09:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:09:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:09:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:09:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:09:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:09:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:09:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:09:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:09:38 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:09:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:09:38 INFO - Cleaning up... 03:09:38 INFO - Return code: 0 03:09:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:09:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:09:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:09:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:09:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:09:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:38 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 0x7fd4d3b21f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xecd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf9aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf97f60>, '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 0xf98d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf991d0>, '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': '8783db0840cc980e80bb0bd400000236-1476697705.653901-30023657', '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 03:09:38 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 03:09:38 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 03:09:38 INFO - Using env: {'DISPLAY': ':0', 03:09:38 INFO - 'HOME': '/home/cltbld', 03:09:38 INFO - 'LANG': 'en_US.UTF-8', 03:09:38 INFO - 'LANGUAGE': 'en_US:en', 03:09:38 INFO - 'LOGNAME': 'cltbld', 03:09:38 INFO - 'MAIL': '/var/mail/cltbld', 03:09:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:09:38 INFO - 'MOZ_NO_REMOTE': '1', 03:09:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:09:38 INFO - 'NO_EM_RESTART': '1', 03:09:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:09:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:09:38 INFO - 'PWD': '/builds/slave/test', 03:09:38 INFO - 'SHELL': '/bin/bash', 03:09:38 INFO - 'SHLVL': '1', 03:09:38 INFO - 'TERM': 'linux', 03:09:38 INFO - 'TMOUT': '86400', 03:09:38 INFO - 'USER': 'cltbld', 03:09:38 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1476697705.653901-30023657', 03:09:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:09:38 INFO - '_': '/tools/buildbot/bin/python'} 03:09:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:09:38 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:09:38 INFO - Cleaning up... 03:09:38 INFO - Return code: 0 03:09:38 INFO - Running post-action listener: _resource_record_post_action 03:09:38 INFO - Running post-action listener: _start_resource_monitoring 03:09:38 INFO - Starting resource monitoring. 03:09:38 INFO - [mozharness: 2016-10-17 10:09:38.544029Z] Finished create-virtualenv step (success) 03:09:38 INFO - [mozharness: 2016-10-17 10:09:38.544538Z] Running install step. 03:09:38 INFO - Running pre-action listener: _resource_record_pre_action 03:09:38 INFO - Running main action method: install 03:09:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:09:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:09:38 INFO - Reading from file tmpfile_stdout 03:09:38 INFO - Detecting whether we're running mozinstall >=1.0... 03:09:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:09:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:09:38 INFO - Reading from file tmpfile_stdout 03:09:38 INFO - Output received: 03:09:38 INFO - Usage: mozinstall [options] installer 03:09:38 INFO - Options: 03:09:38 INFO - -h, --help show this help message and exit 03:09:38 INFO - -d DEST, --destination=DEST 03:09:38 INFO - Directory to install application into. [default: 03:09:38 INFO - "/builds/slave/test"] 03:09:38 INFO - --app=APP Application being installed. [default: firefox] 03:09:38 INFO - mkdir: /builds/slave/test/build/application 03:09:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:09:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:09:54 INFO - Reading from file tmpfile_stdout 03:09:54 INFO - Output received: 03:09:54 INFO - /builds/slave/test/build/application/firefox/firefox 03:09:54 INFO - Running post-action listener: _resource_record_post_action 03:09:54 INFO - [mozharness: 2016-10-17 10:09:54.903584Z] Finished install step (success) 03:09:54 INFO - [mozharness: 2016-10-17 10:09:54.903829Z] Running run-tests step. 03:09:54 INFO - Running pre-action listener: _resource_record_pre_action 03:09:54 INFO - Running main action method: run_tests 03:09:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:09:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:09:54 INFO - Python 2.7.3 03:09:54 INFO - Return code: 0 03:09:54 INFO - grabbing minidump binary from tooltool 03:09:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:09:54 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 0xf97f60>, '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 0xf98d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf991d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:09:54 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 03:09:54 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 03:09:54 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 03:09:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:09:54 INFO - Return code: 0 03:09:54 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:09:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:09:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:09:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:09:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:09:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AIKHBGKwRiGO1JkDdVYN7g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--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 03:09:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/AIKHBGKwRiGO1JkDdVYN7g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-038 --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 03:09:54 INFO - Using env: {'DISPLAY': ':0', 03:09:54 INFO - 'HOME': '/home/cltbld', 03:09:54 INFO - 'LANG': 'en_US.UTF-8', 03:09:54 INFO - 'LANGUAGE': 'en_US:en', 03:09:54 INFO - 'LOGNAME': 'cltbld', 03:09:54 INFO - 'MAIL': '/var/mail/cltbld', 03:09:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:09:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:09:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:09:54 INFO - 'MOZ_NO_REMOTE': '1', 03:09:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:09:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:09:54 INFO - 'NO_EM_RESTART': '1', 03:09:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:09:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:09:54 INFO - 'PWD': '/builds/slave/test', 03:09:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:09:54 INFO - 'SHELL': '/bin/bash', 03:09:54 INFO - 'SHLVL': '1', 03:09:54 INFO - 'TERM': 'linux', 03:09:54 INFO - 'TMOUT': '86400', 03:09:54 INFO - 'USER': 'cltbld', 03:09:54 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1476697705.653901-30023657', 03:09:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:09:54 INFO - '_': '/tools/buildbot/bin/python'} 03:09:54 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AIKHBGKwRiGO1JkDdVYN7g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--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 03:09:55 INFO - mozversion application_buildid: 20161017014536 03:09:55 INFO - mozversion application_changeset: 0a184681d389f62a1aff59218a2d52e77bcc911b 03:09:55 INFO - mozversion application_display_name: Nightly 03:09:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:09:55 INFO - mozversion application_name: Firefox 03:09:55 INFO - mozversion application_remotingname: firefox 03:09:55 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:09:55 INFO - mozversion application_vendor: Mozilla 03:09:55 INFO - mozversion application_version: 52.0a1 03:09:55 INFO - mozversion platform_buildid: 20161017014536 03:09:55 INFO - mozversion platform_changeset: 0a184681d389f62a1aff59218a2d52e77bcc911b 03:09:55 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:09:55 INFO - mozversion platform_version: 52.0a1 03:09:55 INFO - using testdate: 1476698995 03:09:55 INFO - actual date: 1476698995 03:09:55 INFO - starting webserver on 'localhost:45739' 03:09:55 INFO - SUITE-START | Running 2 tests 03:09:55 INFO - TEST-START | dromaeo_css 03:09:55 INFO - operating with platform_type : linux_ 03:09:55 INFO - Initialising browser for dromaeo_css test... 03:09:55 INFO - TEST-INFO | started process 27197 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgYeGpH/profile http://localhost:45739/getInfo.html) 03:09:59 INFO - PROCESS | 27197 | __metrics Screen width/height:1600/1200 03:09:59 INFO - PROCESS | 27197 | colorDepth:24 03:09:59 INFO - PROCESS | 27197 | Browser inner width/height: 1024/697 03:09:59 INFO - PROCESS | 27197 | __metrics 03:10:00 INFO - PROCESS | 27197 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:10:00 INFO - PROCESS | 27197 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:10:01 INFO - PROCESS | 27197 | console.error: PushService: 03:10:01 INFO - PROCESS | 27197 | stateChangeProcessEnqueue: Error transitioning state 03:10:01 INFO - PROCESS | 27197 | UnknownError 03:10:02 INFO - TEST-INFO | 27197: exit 0 03:10:02 INFO - Browser initialized. 03:10:02 INFO - Running cycle 1/1 for dromaeo_css test... 03:10:02 INFO - TEST-INFO | started process 27282 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgYeGpH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:10:14 INFO - PROCESS | 27282 | RSS: Main: 174039040 03:10:14 INFO - PROCESS | 27282 | 03:11:06 INFO - PROCESS | 27282 | 1476699066036 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] 03:13:19 INFO - PROCESS | 27282 | Cycle 1(1): loaded http://localhost:45739/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45739/tests/dromaeo/cssquery-ext.html) 03:13:20 INFO - PROCESS | 27282 | RSS: Main: 267268096 03:13:20 INFO - PROCESS | 27282 | 03:16:23 INFO - PROCESS | 27282 | Cycle 1(1): loaded http://localhost:45739/tests/dromaeo/cssquery-ext.html (next: http://localhost:45739/tests/dromaeo/cssquery-jquery.html) 03:16:24 INFO - PROCESS | 27282 | RSS: Main: 281567232 03:16:24 INFO - PROCESS | 27282 | 03:19:26 INFO - PROCESS | 27282 | Cycle 1(1): loaded http://localhost:45739/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45739/tests/dromaeo/cssquery-mootools.html) 03:19:26 INFO - PROCESS | 27282 | RSS: Main: 242810880 03:19:26 INFO - PROCESS | 27282 | 03:22:29 INFO - PROCESS | 27282 | Cycle 1(1): loaded http://localhost:45739/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45739/tests/dromaeo/cssquery-prototype.html) 03:22:29 INFO - PROCESS | 27282 | RSS: Main: 219365376 03:22:29 INFO - PROCESS | 27282 | 03:25:32 INFO - PROCESS | 27282 | Cycle 1(1): loaded http://localhost:45739/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45739/tests/dromaeo/cssquery-yui.html) 03:25:33 INFO - PROCESS | 27282 | RSS: Main: 218251264 03:25:33 INFO - PROCESS | 27282 | 03:28:36 INFO - PROCESS | 27282 | Cycle 1(1): loaded http://localhost:45739/tests/dromaeo/cssquery-yui.html (next: http://localhost:45739/tests/dromaeo/cssquery-dojo.html) 03:28:36 INFO - PROCESS | 27282 | RSS: Main: 296316928 03:28:36 INFO - PROCESS | 27282 | 03:28:36 INFO - PROCESS | 27282 | __start_tp_report 03:28:36 INFO - PROCESS | 27282 | _x_x_mozilla_page_load 03:28:36 INFO - PROCESS | 27282 | _x_x_mozilla_page_load_details 03:28:36 INFO - PROCESS | 27282 | |i|pagename|runs| 03:28:36 INFO - PROCESS | 27282 | |0;dojo.html;2565.846049237046;2600.33691408691;2621.213635909227;2640.89436422543;2656.7210442903506;4488.124815660939;4552.977235113828;4634.837780677677;4654.976725116374;4665.04366604846;4606.930896036553;4629.328747331635;4674.0651869626045;4692.389989301395;4738.360321356616;4203.684723645723;4208.97895510522;4255.936160957588;4286.935695964563;4290.721103128302;3937.606239376068;4311.805968731399;4362.083962367907;4404.11917616478;4455.443069616298;4178.415021896937;4343.131373725236;4407.625351845097;4415.955840441587;4436.29019356903;4216.304309788881;4279.91440171198;4280.764557949312;4286.657067434598;4287.48550173978;4258.041940563379;4258.488981322261;4261.914761704779;4264.936025959613;4266.722663026924;4545.136424079415;4578.816847326103;4582.95417045832;4589.747563883985;4666.836660716858;4922.212446008622;4926;4932.408111026664;4934.111859865223;4992.950070499285;4869.610431165534;4949.604031677457;4956.801727930879;4963.92554111685;5002.649814512985;4592.05862798129;4641.675082744176;4671.789769460348;4673.813047478131;4697.506761790031;5100.387953445536;5137.17805151174;5138.794448222104;5144.022635699205;5198.194279886624;4873.02539492103;4916.852494425173;4921.532454416824;4927.348119671249;4985.127602669519;4826;4878.804847806048;4881.975590122098;4953.405591329064;4982.202847544376;4877.122118018719;4914.827981020647;4929.654924155275;4932.284818701268;4934.9013019739405;4881.511848815161;4914.0908931847725;4916;4984.850454486371;4988.251762235621;4232.386303985905;4241.172971270635;4244.299690551086;4297.8495752648505;4300.075483771005;3648.5986541480415;3665.7983810890123;3691.53855768029;3715.8327875245677;3761.962380376216;4251.383549385384;4280.76455794928;4297.527272000078;4311.805968731414;4379.189849877783;4946.35697359341;4980;4995.950040499549;5001.0998020355955;5063.974680126649;4304.440422745023;4305.117450922553;4317.84887528935;4324.481062272547;4382.233109205877;4382.211201983673;4424.911501769947;4429.180601588717;4441.889527618096;4491.371208030879;4716.882077948078;4718.127146477913;4724.740139292372;4725.669203155883;4729.716217026989;4960.7767650456535;4990.301357809837;5001.299818025552;5021.548060674557;5067.239914012927;4723.244280915037;4730.030343779586;4733.644976626836;4774.212254978029;4792.185328494094;4900.607951363811;4929.926051109308;4938.037082768826;4946.8763280918265;5009.0983622948215;4839.128956787671;4865.391826021747;4901.534354236342;4907.803687852446;4939.259111133359;4848.248521479177;4883.438404583376;4891.828785992473;4952.5542701157065;4958.330625365674;4880.682755620874;4886.486918873609;4888.95111048885;4893.951060489492;4945.703257804399;4659.044895796286;4708.788104535236;4780.163471392562;4819.662623616313;4889.633277504273;4839.588634965927;4876.80492780299;4900.338454308623;4926.113299605962;4993.875153121201;4808.182608956556;4821.228603423436;4827.275908613736;4828.444728856086;4876.512348765095 03:28:36 INFO - PROCESS | 27282 | |1;ext.html;565.1438071321945;573.031576635486;579.938712156753;581.7120525339957;591.2874985642304;26666;27408.040718574855;29434.705652943463;38024.239515209745;39443.21113577727;39672;40051;40083.59916400835;40134.79932600333;40238.19523609534;7322.048133742619;7469.066366704162;7470.215627359104;7475.140358858746;7478.925210747904;7483.064616922885;7564.054493188351;7565.394768418513;7568.129665088502;7576.924230757677;7571.31858132768;7600.923990760105;7601.6579253933705;7608.467407281492;7610.277023682769;7540.396768258526;7572.659230334593;7575.696972121109;7582.8483430331635;7585.1656317805;7528.698852045966;7584.54492730438;7585.317321441097;7591.772246832604;7595.6961721531625;36464.63535364639;36712.449313260324;36744;36795.81602091972;36819.631803682154;3023.8790448382038;3158.810471371702;3351.5642966414453;3381.8647254109806;3644.5626524816926;25845.74154258452;28330.433391332263;28385.858070709513;28393.148205553865;29926.251843703863;3475.5134281200653;3523.894283171509;3540.3090904551314;3550.946735798965;3606.296772129436;236497;236756;238502;238542;238684;52015;52375;52470.21294680583;52514;52554;32279.677203228137;33110.83444582762;33290.833545832116;34868.65131348654;54855.725721371935;14561.417543298361;14687.92656036713;14688.55934321972;14775.48285810013;14779.482718104815;10947.83578246327;11033.448327583588;11043.282186657842;11049.116070714324;11052.171087168334;17377.391791287246;17516.38692645751;17546.736798948026;17565.121743912754;17601.7359739604;6727.260001399842;6799.3200679931615;6861.1080559526945;6913.239543650195;7014.614196219257;748.8726916424112;865.5542395666237;937.7702462896634;957.8658987741721;1026.1431704526804;26460.206193814218;26693.866530667612;27258.5911211332;28288.85855570709;28657.57013644797;881.5107615273456;927.0821886332617;944.1691311645708;957.4446820843893;981.4405788700515;13371.665708357174;14045.578632641038;14340.856591434162;14494.275286235646;14500.274986250644;355113;357031;357240;357572;358171;45351.31973020407;45519;45552.3167152493;45702.314465283045;45717;1043.2801367056707;1108.146727020206;1143.428285857088;1185.7628474305172;1223.5534030078957;24429.877850611345;27089.322766930985;27435.86282068577;27534.44931101407;28214.43571128525;39378.60621393749;40000.3999940007;40003.59996400115;40018.39972400475;40111.3983290245;274412;274690;275833;275946;276771;20032.599348012667;20613.793862061186;21409.357719268446;23552.6467102997;23599.52800943937;36694.26611467809;37952.97869894079;38687.22625547417;38840.22319553536;39005.609943901334;32932.50601240935;33273.50089748704;33367.33265334728;33391.49912751359;33607.32785344328;32511.18722031968;32820.507692384155;33537.16157096092;33964.150896227795;34156.82921585376;33021.17447063843;33216.920440149835;33558.49662255019;33570.496442552896;33816.49275260824;28961.855190723913;30087.849560752056;30230;30601.693983059886;30610.540841886945;23446.413839654146;23476.295711128692;23524.294271171893;24136.275911721976;24187.274381768577 03:28:36 INFO - PROCESS | 27282 | |2;jquery.html;331.1984996308932;350.2277478160656;354.29848899179626;359.5200407456046;378.08692008798755;12170.330631815257;13225;15521.999999999985;16223.756643650326;17664.911675441635;16837.158142092907;16929;16937.491875243762;17076.658466830657;17416.738748918775;4307.138572285539;4581.541845815408;4888.560029597335;5110.386753589556;5112.36095488064;4856.878578035542;4979.775910084037;4980.153373926423;4992.251162325662;4994.850154495352;4770.260609605517;4951.504849515056;4958.107540642683;4962.727050012248;4966.379202599675;4926.876828079308;4996;4998.250262460624;5000.849974500771;5002.099622068026;4275.273203555403;4449.399331090293;4458.732476051415;4467.218236808546;4476.440444944382;20469.2835750748;20670.689939650918;20843.37469875906;20845.16619335225;20958.266460673956;1804.8375646191776;1875.8874467531991;1876.5121068522283;1947.8246957773727;2418.3349578865955;12857.4214160363;13190.472381104744;13283.86716132836;13843.100198487065;13912;1672.5985763416813;1692.280780668211;1701.387500499819;1723.8707096967778;1754.2544418622035;65827.67086164586;65884.67057664729;65907;66733.66633166852;66818.66590667065;8894;9179.954100229455;9530.857037144448;9537.570809313598;9626.133647971716;12560.309182995023;12569.308688022247;12593.307368094842;12598.181118227287;12604.495820167274;6799.32006799326;6882.139732533434;6922.2731613180895;7191.496595238283;7224.699554080316;6751.56114852533;6770.1537307836525;6792.152078085595;6955.582665040114;7025.332593403618;5805.187273781674;5837.620554663933;5883.14694369314;5914.319853216849;5943.970280148658;1597.3450885137038;1612.7500237463212;1616.5231256779277;1656.7680524726547;1679.6472740724341;834.9165083491723;835.4903508859591;855.9101294364002;896.820635872828;926.9351145419756;16437.91781041111;17152.142392880305;17734.20196091179;17929.551761206076;18084.095795210185;788.2826627768703;863.4171933944563;881.6341218394294;903.9965638141789;912.4251721415599;8293.170682931779;9526.714198574055;9552.331336806496;9694.806103877883;9699.224062075016;296368;386736;386831;388441;389029;76226.61886690531;78484.99999999886;79572;80048.59975700085;83081;416.10744952077624;432.5155825475488;432.53502484828937;432.77928256588734;435.938968544404;9307.72076837696;9387.577559009998;9567;9714.659986900424;9827.312088154047;24051.158209463283;25290.873545632156;33925.32149357048;36657.71697990664;36767;45747.54252457433;46703;46767;52850.73574632102;53361.7331913338;7026.613536255555;7553.848923021399;7599.962000189964;7799.259070388304;8181.959090204511;11117.610883619034;11412.258203216765;11675.416229188677;11694.532218711156;11724.472398741906;9421.104995025462;9484.57319420614;9562.414094714482;9684.176844968257;10009.69970900874;10110.140638045848;10283.434411107162;10416.479176041319;10448.477576121315;10467.528961196613;9646.276529260193;9684.32209745311;9785.116422146211;9862.556184971838;10188.337758045704;7550.8867366990635;7627.466077374531;7677.539347639159;7831.960840195762;7947.046354437504;7965.880511792444;9304.255659547085;9371.934726391744;9395.201407880406;9669.758256043655 03:28:36 INFO - PROCESS | 27282 | |3;mootools.html;1225.6751960730403;1378.1180044771345;1418.7659036259017;1485.688005518841;1729.2564197395122;6325;7307.671154798034;7506.437017223703;7511.849763004743;7730.922690773091;7769;7787.143414224445;7791.454598178129;7811.921880781205;7826.25650563197;2087.728595282611;2118.4492032071694;2130.595186914489;2131.360591822455;2135.7543882453483;2079.261862038977;2128.2976617716117;2158.417227348615;2158.773328800477;2160.4382860456317;2071.171531387442;2083.5728675621535;2089.3105275259127;2094.057674046685;2102.8317734581274;2054.979450205494;2059.6292667319876;2062.9071691773906;2063.2675400233;2072.896355182235;1991.8406527477766;2019.4850313170195;2019.5052212208102;2021.1511165310606;2029.8376129909573;7150.7497237596435;7727.459077864552;7736.690532378698;7801.21987801221;7807.414443916672;4433.312836510346;4562.041971186055;4564.657650676179;4565.543445655408;4581.037982023779;2783.3320003199287;2916.6937471565393;2969.124108388031;2969.836658983755;2979.582858399826;941.7692665297046;948.1514044929818;964.0985678390728;965.0205041882494;969.2488321550784;10042.497875106288;10428.061474467258;10430.113440357578;10459.738506537398;10483.161347092291;3875.379939209713;3884.8834534964;3936.4685767421606;3948.6446219840354;3977.2840888639744;8182.83634327322;8190.5904704764525;8209.384296177692;8214.055383630839;8224;4410.360497727812;4411.867643970686;4423.093265880487;4423.977880110579;4425.203463376559;3560.430331147004;3631.1829838286176;3677.8344974476213;4077.5922407758985;4132.855350062733;2887.63904511936;3269.8692052318115;3316.8673253070087;3325.767196296236;3330.766846320783;1018.4500369800224;1037.527924794217;1051.747580580655;1060.0565496707782;1065.7442213868617;801.358912869702;810.5055915891302;825.3933358981144;836.000978830292;837.9748607541784;4954.355933728592;5103.311053007871;5114.795408183705;5150.8969820604125;5303.549198318109;396.26295091130476;411.7899871065778;423.8389412023411;427.7625917615753;428.8434721326693;3521.3661540922367;3550.218951830593;3777.735558510878;3793.336166170909;3835.1754372809423;9326.626934922662;9327.160555550034;9375.953120234492;9409.623615055458;9530.475823829756;9240;9295.395799273025;9373.062693730571;9400.95299523498;9440.811183776286;6919.6540172991145;7030.402415794612;7073.292670732989;7084.220735719066;7084.256153103953;5174.7153906535505;5334.333208348957;5439.374471935778;5491.258680078138;5525.889482210414;8524.232819046316;8543.700970466252;8634.136586341316;8677.826443471222;8802.515861627671;8698.91301086981;8760.824783504422;8839.60221790034;8860.64557417696;8875.73372798817;5786.710664466676;5916.408359164049;6400.263969643551;6523.869522609426;6639.734410623714;7345.1553071397475;7379.040724705754;7379.225181356095;7395.260473952777;7427.405807535276;6482.546221764431;6578.605283682994;6616.933830661632;6666.733330666913;6668.466522678077;6387.776427825004;6493.123428337303;6537.542372034102;6547.738090476328;6552.443042341454;6145.600535965148;6175.228096487939;6244.5316601256;6246.562740608114;6266.342034086538;4262.46719160105;4288;4290.49832558602;4317.309230523227;4336.154449882369;4177.4778152730905;4295.8711238661635;4343.587359200871;4422.49141348749;4437.09039646878 03:28:36 INFO - PROCESS | 27282 | |4;prototype.html;286.5615608119577;288.69831026577225;292.1818907060231;292.71752758587945;297.2924439833197;4761.262274192341;4773.713577185371;4784.067106914154;4790.568848803607;4798.297668285083;4708.929366059503;4717.481077081518;4721.150192965265;4721.551452612005;4731.929021064687;3466.306738652267;3566.785992840425;3615.493830863681;3687.8340474678703;3729.179580492301;3709.1283548366114;3723.497327860745;3726.2920045191463;3728.0866187783895;3741.3452645787015;3688.409854423293;3689.1883785567265;3690.6862916652117;3696.0575053361354;3698.760915093447;3467.306538692259;3550.751447398683;3577.2308953575107;3661.462185881936;3678.981605091984;3258.283177700902;3259.4295998200455;3260.7717459777823;3266.3140740444537;3269.8038117713013;4586.334981427708;4592.7014744041535;4608.4700259470255;4611.054733779601;4612.308153776927;3894.80525973703;4123.484564429446;4218.093109981338;4223.767692776896;4230.76730779807;4894.804207831682;4896.926546101811;4897.33885925399;4902.338184345139;4916.70499770015;3441.82790860456;3445.1214940190343;3449.913752156191;3452.2922800825772;3458.8962331130106;5036.607611384599;5113.539781419653;5161.845144645667;5176.715280659562;5182.792688292464;3481.651834816498;3488.302339532104;3502.212002299513;3505.3515099706124;3508.7719298245534;3539.9646003539633;3543.8936831895085;3546.6985306248744;3552.2540266544315;3552.9644703552635;4092.6903390915218;4100.425940368351;4106.1582375612925;4115.300398932129;4131.669466442678;4727.078219747116;4915.65590408668;4935.605151587864;4936.827211047596;4965.1807451770055;1220.8840160184768;1243.9115773698015;1248.7502499499954;1251.1742250115062;1251.7621651886113;765.5330248548381;773.153397030251;793.1077537770009;799.7400844725488;802.5064585280128;4187.476565429321;4319.265724826787;4334.891627709269;4335.653147748172;4349.826006959686;4961.452561418603;5114.948850511447;5117.334746483008;5128.743562821844;5135.537801597874;4395.384646149541;4398.252297109499;4406.405135306757;4410.713303635253;4415.757133357632;2612.725663805311;2675.906343277976;2694.9595756063673;2712.5795501697266;2719.225020869043;4792.688475249098;4795.256735206049;4811.927821082687;4812.927806082912;4818.903621927612;5199.636025478256;5205.9219111713355;5215.53060224574;5226;5241.697730429805;4559.6124329431705;4859.1010663027455;4875.148038397577;4877.926831097608;4882.217990433537;5183.948160518497;5190.455002224712;5209.223313097974;5211.47885211491;5220.634555581225;4913.975430122827;5102.158143906214;5109.386873575195;5122.720389426819;5135.948640513697;4849.442314133919;4868.634852386014;4905.435874874435;4905.48492408292;4921.138800709933;3626.818659067089;3655.9451608225368;3662.963370366262;3667.0465678924206;3674.154944362865;5209.374875015023;5225.529702326809;5227.268182454383;5232.136697444879;5239.26650268955;4808.471068182567;5007.848194915263;5015.448300686849;5019.698818070928;5019.774110164978;5047.798088076436;5053.974730126326;5057.721825299644;5062.924056139087;5082.796688132434;4863.270509423614;4950.653454258168;5021.322121513549;5039.017391608748;5041;4819.807207711652;4953.455119936732;5027.84916452507;5057.216131499624;5095.541401273755;4840.757962101951;4983.177775666974;4983.775730092082;4993.501949415234;5007.39911210657 03:28:36 INFO - PROCESS | 27282 | |5;yui.html;602.2441835496453;680.4420375292256;698.5529261272783;705.7282946065766;712.2450202785049;12749.936250318748;13262.270575118364;13287.335633218338;13288.202707837536;13324.733505329888;13449.125806822549;13516.932415337935;13530.391132399041;13562.864371356283;13602.659933501667;624.7719582352454;629.232336549409;763.5647680821934;764.9541027538338;771.3173841150566;768.8193274580469;771.8957940678021;772.6407220642428;772.7836205862368;772.9845403091963;831.7504748575434;832.629479881453;834.0325222741621;834.5701963488777;834.7579202031403;666.3769375633774;679.3478260869571;681.7511608262998;685.1264637587067;827.2926647716206;507.47222888196234;599.469469519474;610.4597431273311;616.1097214525013;617.9351168127372;13191.934040329834;13325.333733313295;13328.266945318004;13356.73286534264;13360.33198340079;11947.940260298643;12399.75200495985;12692.555760548428;12909.225446473241;13474.124181928144;10838.187135964756;11366.479750778817;11611.593594224161;11722.765544689144;11731.296122232694;4050.958846689319;4059.6549293310104;4062.695297852673;4144.357624568197;4156.542780294165;60931.390686093015;60986.39013609852;61502.69248653773;61606.38393616051;61729.07406388863;10266.589336426608;10387.169026477864;10469.528871200815;10673.306235094695;10857.131429485622;18318.633627327377;18637.254509819726;18696.81303186978;18721.157547910378;18738.344157954405;6339.809805705836;6342.365763423621;6427.517936154713;6557.278699343068;6617.60294382329;3512.613612502623;3559.4482855157494;3571.5892672342493;3575.856965721394;3582.17609949713;2747.9420423137235;2819.915402537927;2837.1488553433887;2840.8153470024795;2847.0604700448803;462.6853739457134;471.8392753825559;473.62346934187406;479.9208130658472;488.9339939108246;474.48992333241904;515.9922601160986;578.6614830324223;590.5010266324948;592.9771144775228;6990.930090699129;7117.572945623279;7251.166115896739;7689.4232932530285;7949.920500795034;529.4308618235412;553.5267346418834;563.7294098832583;564.565284730755;582.6329412470117;3365.899023029313;3493.94759078614;3594.2272411431145;3619.167591453928;3721.5162028936065;88667;94535.52732236433;94835.52582237044;97113;97673;83817.58091209504;83901.58049209836;84957.57521212354;85140;89920.10079899117;67355.66322168357;76433.23566764261;76773;77049.22950770533;77865.61067194628;6608.976326498343;6780.38976492118;6928.376446119873;7081.4334853210585;7122;44714.3292850601;45682.31476527921;46811.29783053325;46813.2978005337;47455.22078415504;58499;65301;65705.67147164233;65774;68621.65689171522;8192.426530143071;8602.78493037679;8815.515146666738;8917.866232006654;9006.86489702668;10453.372797632166;10500.947495262475;10525.578976840841;10583.735406614896;10614.416207108683;9110.726678199664;9204.677836275698;9226.261899047926;9710.805783884141;9723.222142228746;9783.657571985232;9970.800583988424;10098;10294.536745846304;10314.690559283234;9163.862542062008;9239.353245272767;9469.242460603273;9501;9501.42991420517;8134.267915887362;8512.616932237941;8567.957160214159;8652.913470865462;8711.564421779012;8037.23646253605;8360.163983601591;8634.956825216084;8751.824963500821;9056.230220431074 03:28:36 INFO - PROCESS | 27282 | __end_tp_report 03:28:36 INFO - PROCESS | 27282 | __start_cc_report 03:28:36 INFO - PROCESS | 27282 | _x_x_mozilla_cycle_collect,1377 03:28:36 INFO - PROCESS | 27282 | __end_cc_report 03:28:36 INFO - PROCESS | 27282 | __startTimestamp1476700116689__endTimestamp 03:28:36 INFO - PROCESS | 27282 | 03:28:36 INFO - PROCESS | 27282 | ------- Summary: start ------- 03:28:36 INFO - PROCESS | 27282 | Number of tests: 6 03:28:36 INFO - PROCESS | 27282 | 03:28:36 INFO - PROCESS | 27282 | [#0] dojo.html Cycles:165 Average:4604.21 Median:4730.03 stddev:478.88 (10.1%) stddev-sans-first:452.86 03:28:36 INFO - PROCESS | 27282 | Values: 2565.8 2600.3 2621.2 2640.9 2656.7 4488.1 4553.0 4634.8 4655.0 4665.0 4606.9 4629.3 4674.1 4692.4 4738.4 4203.7 4209.0 4255.9 4286.9 4290.7 3937.6 4311.8 4362.1 4404.1 4455.4 4178.4 4343.1 4407.6 4416.0 4436.3 4216.3 4279.9 4280.8 4286.7 4287.5 4258.0 4258.5 4261.9 4264.9 4266.7 4545.1 4578.8 4583.0 4589.7 4666.8 4922.2 4926.0 4932.4 4934.1 4993.0 4869.6 4949.6 4956.8 4963.9 5002.6 4592.1 4641.7 4671.8 4673.8 4697.5 5100.4 5137.2 5138.8 5144.0 5198.2 4873.0 4916.9 4921.5 4927.3 4985.1 4826.0 4878.8 4882.0 4953.4 4982.2 4877.1 4914.8 4929.7 4932.3 4934.9 4881.5 4914.1 4916.0 4984.9 4988.3 4232.4 4241.2 4244.3 4297.8 4300.1 3648.6 3665.8 3691.5 3715.8 3762.0 4251.4 4280.8 4297.5 4311.8 4379.2 4946.4 4980.0 4996.0 5001.1 5064.0 4304.4 4305.1 4317.8 4324.5 4382.2 4382.2 4424.9 4429.2 4441.9 4491.4 4716.9 4718.1 4724.7 4725.7 4729.7 4960.8 4990.3 5001.3 5021.5 5067.2 4723.2 4730.0 4733.6 4774.2 4792.2 4900.6 4929.9 4938.0 4946.9 5009.1 4839.1 4865.4 4901.5 4907.8 4939.3 4848.2 4883.4 4891.8 4952.6 4958.3 4880.7 4886.5 4889.0 4894.0 4945.7 4659.0 4708.8 4780.2 4819.7 4889.6 4839.6 4876.8 4900.3 4926.1 4993.9 4808.2 4821.2 4827.3 4828.4 4876.5 03:28:36 INFO - PROCESS | 27282 | 03:28:36 INFO - PROCESS | 27282 | [#1] ext.html Cycles:180 Average:43442.03 Median:18816.17 stddev:77343.67 (411.0%) stddev-sans-first:77493.64 03:28:36 INFO - PROCESS | 27282 | Values: 565.1 573.0 579.9 581.7 591.3 26666.0 27408.0 29434.7 38024.2 39443.2 39672.0 40051.0 40083.6 40134.8 40238.2 7322.0 7469.1 7470.2 7475.1 7478.9 7483.1 7564.1 7565.4 7568.1 7576.9 7571.3 7600.9 7601.7 7608.5 7610.3 7540.4 7572.7 7575.7 7582.8 7585.2 7528.7 7584.5 7585.3 7591.8 7595.7 36464.6 36712.4 36744.0 36795.8 36819.6 3023.9 3158.8 3351.6 3381.9 3644.6 25845.7 28330.4 28385.9 28393.1 29926.3 3475.5 3523.9 3540.3 3550.9 3606.3 236497.0 236756.0 238502.0 238542.0 238684.0 52015.0 52375.0 52470.2 52514.0 52554.0 32279.7 33110.8 33290.8 34868.7 54855.7 14561.4 14687.9 14688.6 14775.5 14779.5 10947.8 11033.4 11043.3 11049.1 11052.2 17377.4 17516.4 17546.7 17565.1 17601.7 6727.3 6799.3 6861.1 6913.2 7014.6 748.9 865.6 937.8 957.9 1026.1 26460.2 26693.9 27258.6 28288.9 28657.6 881.5 927.1 944.2 957.4 981.4 13371.7 14045.6 14340.9 14494.3 14500.3 355113.0 357031.0 357240.0 357572.0 358171.0 45351.3 45519.0 45552.3 45702.3 45717.0 1043.3 1108.1 1143.4 1185.8 1223.6 24429.9 27089.3 27435.9 27534.4 28214.4 39378.6 40000.4 40003.6 40018.4 40111.4 274412.0 274690.0 275833.0 275946.0 276771.0 20032.6 20613.8 21409.4 23552.6 23599.5 36694.3 37953.0 38687.2 38840.2 39005.6 32932.5 33273.5 33367.3 33391.5 33607.3 32511.2 32820.5 33537.2 33964.2 34156.8 33021.2 33216.9 33558.5 33570.5 33816.5 28961.9 30087.8 30230.0 30601.7 30610.5 23446.4 23476.3 23524.3 24136.3 24187.3 03:28:36 INFO - PROCESS | 27282 | 03:28:36 INFO - PROCESS | 27282 | [#2] jquery.html Cycles:180 Average:23267.73 Median:4939.19 stddev:61466.34 (1244.5%) stddev-sans-first:61614.64 03:28:36 INFO - PROCESS | 27282 | Values: 331.2 350.2 354.3 359.5 378.1 12170.3 13225.0 15522.0 16223.8 17664.9 16837.2 16929.0 16937.5 17076.7 17416.7 4307.1 4581.5 4888.6 5110.4 5112.4 4856.9 4979.8 4980.2 4992.3 4994.9 4770.3 4951.5 4958.1 4962.7 4966.4 4926.9 4996.0 4998.3 5000.8 5002.1 4275.3 4449.4 4458.7 4467.2 4476.4 20469.3 20670.7 20843.4 20845.2 20958.3 1804.8 1875.9 1876.5 1947.8 2418.3 12857.4 13190.5 13283.9 13843.1 13912.0 1672.6 1692.3 1701.4 1723.9 1754.3 65827.7 65884.7 65907.0 66733.7 66818.7 8894.0 9180.0 9530.9 9537.6 9626.1 12560.3 12569.3 12593.3 12598.2 12604.5 6799.3 6882.1 6922.3 7191.5 7224.7 6751.6 6770.2 6792.2 6955.6 7025.3 5805.2 5837.6 5883.1 5914.3 5944.0 1597.3 1612.8 1616.5 1656.8 1679.6 834.9 835.5 855.9 896.8 926.9 16437.9 17152.1 17734.2 17929.6 18084.1 788.3 863.4 881.6 904.0 912.4 8293.2 9526.7 9552.3 9694.8 9699.2 296368.0 386736.0 386831.0 388441.0 389029.0 76226.6 78485.0 79572.0 80048.6 83081.0 416.1 432.5 432.5 432.8 435.9 9307.7 9387.6 9567.0 9714.7 9827.3 24051.2 25290.9 33925.3 36657.7 36767.0 45747.5 46703.0 46767.0 52850.7 53361.7 7026.6 7553.8 7600.0 7799.3 8182.0 11117.6 11412.3 11675.4 11694.5 11724.5 9421.1 9484.6 9562.4 9684.2 10009.7 10110.1 10283.4 10416.5 10448.5 10467.5 9646.3 9684.3 9785.1 9862.6 10188.3 7550.9 7627.5 7677.5 7832.0 7947.0 7965.9 9304.3 9371.9 9395.2 9669.8 03:28:36 INFO - PROCESS | 27282 | 03:28:36 INFO - PROCESS | 27282 | [#3] mootools.html Cycles:180 Average:4952.60 Median:5028.83 stddev:2807.89 (55.8%) stddev-sans-first:2801.80 03:28:36 INFO - PROCESS | 27282 | Values: 1225.7 1378.1 1418.8 1485.7 1729.3 6325.0 7307.7 7506.4 7511.8 7730.9 7769.0 7787.1 7791.5 7811.9 7826.3 2087.7 2118.4 2130.6 2131.4 2135.8 2079.3 2128.3 2158.4 2158.8 2160.4 2071.2 2083.6 2089.3 2094.1 2102.8 2055.0 2059.6 2062.9 2063.3 2072.9 1991.8 2019.5 2019.5 2021.2 2029.8 7150.7 7727.5 7736.7 7801.2 7807.4 4433.3 4562.0 4564.7 4565.5 4581.0 2783.3 2916.7 2969.1 2969.8 2979.6 941.8 948.2 964.1 965.0 969.2 10042.5 10428.1 10430.1 10459.7 10483.2 3875.4 3884.9 3936.5 3948.6 3977.3 8182.8 8190.6 8209.4 8214.1 8224.0 4410.4 4411.9 4423.1 4424.0 4425.2 3560.4 3631.2 3677.8 4077.6 4132.9 2887.6 3269.9 3316.9 3325.8 3330.8 1018.5 1037.5 1051.7 1060.1 1065.7 801.4 810.5 825.4 836.0 838.0 4954.4 5103.3 5114.8 5150.9 5303.5 396.3 411.8 423.8 427.8 428.8 3521.4 3550.2 3777.7 3793.3 3835.2 9326.6 9327.2 9376.0 9409.6 9530.5 9240.0 9295.4 9373.1 9401.0 9440.8 6919.7 7030.4 7073.3 7084.2 7084.3 5174.7 5334.3 5439.4 5491.3 5525.9 8524.2 8543.7 8634.1 8677.8 8802.5 8698.9 8760.8 8839.6 8860.6 8875.7 5786.7 5916.4 6400.3 6523.9 6639.7 7345.2 7379.0 7379.2 7395.3 7427.4 6482.5 6578.6 6616.9 6666.7 6668.5 6387.8 6493.1 6537.5 6547.7 6552.4 6145.6 6175.2 6244.5 6246.6 6266.3 4262.5 4288.0 4290.5 4317.3 4336.2 4177.5 4295.9 4343.6 4422.5 4437.1 03:28:36 INFO - PROCESS | 27282 | 03:28:36 INFO - PROCESS | 27282 | [#4] prototype.html Cycles:180 Average:4120.16 Median:4729.50 stddev:1221.56 (25.8%) stddev-sans-first:1190.62 03:28:36 INFO - PROCESS | 27282 | Values: 286.6 288.7 292.2 292.7 297.3 4761.3 4773.7 4784.1 4790.6 4798.3 4708.9 4717.5 4721.2 4721.6 4731.9 3466.3 3566.8 3615.5 3687.8 3729.2 3709.1 3723.5 3726.3 3728.1 3741.3 3688.4 3689.2 3690.7 3696.1 3698.8 3467.3 3550.8 3577.2 3661.5 3679.0 3258.3 3259.4 3260.8 3266.3 3269.8 4586.3 4592.7 4608.5 4611.1 4612.3 3894.8 4123.5 4218.1 4223.8 4230.8 4894.8 4896.9 4897.3 4902.3 4916.7 3441.8 3445.1 3449.9 3452.3 3458.9 5036.6 5113.5 5161.8 5176.7 5182.8 3481.7 3488.3 3502.2 3505.4 3508.8 3540.0 3543.9 3546.7 3552.3 3553.0 4092.7 4100.4 4106.2 4115.3 4131.7 4727.1 4915.7 4935.6 4936.8 4965.2 1220.9 1243.9 1248.8 1251.2 1251.8 765.5 773.2 793.1 799.7 802.5 4187.5 4319.3 4334.9 4335.7 4349.8 4961.5 5114.9 5117.3 5128.7 5135.5 4395.4 4398.3 4406.4 4410.7 4415.8 2612.7 2675.9 2695.0 2712.6 2719.2 4792.7 4795.3 4811.9 4812.9 4818.9 5199.6 5205.9 5215.5 5226.0 5241.7 4559.6 4859.1 4875.1 4877.9 4882.2 5183.9 5190.5 5209.2 5211.5 5220.6 4914.0 5102.2 5109.4 5122.7 5135.9 4849.4 4868.6 4905.4 4905.5 4921.1 3626.8 3655.9 3663.0 3667.0 3674.2 5209.4 5225.5 5227.3 5232.1 5239.3 4808.5 5007.8 5015.4 5019.7 5019.8 5047.8 5054.0 5057.7 5062.9 5082.8 4863.3 4950.7 5021.3 5039.0 5041.0 4819.8 4953.5 5027.8 5057.2 5095.5 4840.8 4983.2 4983.8 4993.5 5007.4 03:28:36 INFO - PROCESS | 27282 | 03:28:36 INFO - PROCESS | 27282 | [#5] yui.html Cycles:180 Average:17411.54 Median:31059.40 stddev:25471.38 (82.0%) stddev-sans-first:25511.57 03:28:36 INFO - PROCESS | 27282 | Values: 602.2 680.4 698.6 705.7 712.2 12749.9 13262.3 13287.3 13288.2 13324.7 13449.1 13516.9 13530.4 13562.9 13602.7 624.8 629.2 763.6 765.0 771.3 768.8 771.9 772.6 772.8 773.0 831.8 832.6 834.0 834.6 834.8 666.4 679.3 681.8 685.1 827.3 507.5 599.5 610.5 616.1 617.9 13191.9 13325.3 13328.3 13356.7 13360.3 11947.9 12399.8 12692.6 12909.2 13474.1 10838.2 11366.5 11611.6 11722.8 11731.3 4051.0 4059.7 4062.7 4144.4 4156.5 60931.4 60986.4 61502.7 61606.4 61729.1 10266.6 10387.2 10469.5 10673.3 10857.1 18318.6 18637.3 18696.8 18721.2 18738.3 6339.8 6342.4 6427.5 6557.3 6617.6 3512.6 3559.4 3571.6 3575.9 3582.2 2747.9 2819.9 2837.1 2840.8 2847.1 462.7 471.8 473.6 479.9 488.9 474.5 516.0 578.7 590.5 593.0 6990.9 7117.6 7251.2 7689.4 7949.9 529.4 553.5 563.7 564.6 582.6 3365.9 3493.9 3594.2 3619.2 3721.5 88667.0 94535.5 94835.5 97113.0 97673.0 83817.6 83901.6 84957.6 85140.0 89920.1 67355.7 76433.2 76773.0 77049.2 77865.6 6609.0 6780.4 6928.4 7081.4 7122.0 44714.3 45682.3 46811.3 46813.3 47455.2 58499.0 65301.0 65705.7 65774.0 68621.7 8192.4 8602.8 8815.5 8917.9 9006.9 10453.4 10500.9 10525.6 10583.7 10614.4 9110.7 9204.7 9226.3 9710.8 9723.2 9783.7 9970.8 10098.0 10294.5 10314.7 9163.9 9239.4 9469.2 9501.0 9501.4 8134.3 8512.6 8568.0 8652.9 8711.6 8037.2 8360.2 8635.0 8751.8 9056.2 03:28:36 INFO - PROCESS | 27282 | -------- Summary: end -------- 03:28:36 INFO - PROCESS | 27282 | 03:28:37 INFO - TEST-INFO | 27282: exit 0 03:28:37 INFO - TEST-OK | dromaeo_css | took 1122564ms 03:28:37 INFO - TEST-START | kraken 03:28:37 INFO - operating with platform_type : linux_ 03:28:37 INFO - Initialising browser for kraken test... 03:28:37 INFO - TEST-INFO | started process 27589 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpx6Y_oF/profile http://localhost:45739/getInfo.html) 03:28:42 INFO - PROCESS | 27589 | __metrics Screen width/height:1600/1200 03:28:42 INFO - PROCESS | 27589 | colorDepth:24 03:28:42 INFO - PROCESS | 27589 | Browser inner width/height: 1024/697 03:28:42 INFO - PROCESS | 27589 | __metrics 03:28:43 INFO - PROCESS | 27589 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:28:43 INFO - PROCESS | 27589 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:28:44 INFO - PROCESS | 27589 | console.error: PushService: 03:28:44 INFO - PROCESS | 27589 | stateChangeProcessEnqueue: Error transitioning state 03:28:44 INFO - PROCESS | 27589 | UnknownError 03:28:44 INFO - TEST-INFO | 27589: exit 0 03:28:44 INFO - Browser initialized. 03:28:44 INFO - Running cycle 1/1 for kraken test... 03:28:44 INFO - TEST-INFO | started process 27669 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpx6Y_oF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:28:57 INFO - PROCESS | 27669 | RSS: Main: 173543424 03:28:57 INFO - PROCESS | 27669 | 03:28:59 INFO - PROCESS | 27669 | Cycle 1(1): loaded http://localhost:45739/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45739/tests/kraken/driver.html?testName=audio-beat-detection) 03:29:00 INFO - PROCESS | 27669 | RSS: Main: 238346240 03:29:00 INFO - PROCESS | 27669 | 03:29:03 INFO - PROCESS | 27669 | Cycle 1(1): loaded http://localhost:45739/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45739/tests/kraken/driver.html?testName=audio-dft) 03:29:04 INFO - PROCESS | 27669 | RSS: Main: 217464832 03:29:04 INFO - PROCESS | 27669 | 03:29:07 INFO - PROCESS | 27669 | Cycle 1(1): loaded http://localhost:45739/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45739/tests/kraken/driver.html?testName=audio-fft) 03:29:08 INFO - PROCESS | 27669 | RSS: Main: 299552768 03:29:08 INFO - PROCESS | 27669 | 03:29:10 INFO - PROCESS | 27669 | Cycle 1(1): loaded http://localhost:45739/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45739/tests/kraken/driver.html?testName=audio-oscillator) 03:29:10 INFO - PROCESS | 27669 | RSS: Main: 210591744 03:29:10 INFO - PROCESS | 27669 | 03:29:12 INFO - PROCESS | 27669 | Cycle 1(1): loaded http://localhost:45739/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45739/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:29:13 INFO - PROCESS | 27669 | RSS: Main: 213094400 03:29:13 INFO - PROCESS | 27669 | 03:29:16 INFO - PROCESS | 27669 | Cycle 1(1): loaded http://localhost:45739/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45739/tests/kraken/driver.html?testName=imaging-darkroom) 03:29:17 INFO - PROCESS | 27669 | RSS: Main: 248692736 03:29:17 INFO - PROCESS | 27669 | 03:29:20 INFO - PROCESS | 27669 | Cycle 1(1): loaded http://localhost:45739/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45739/tests/kraken/driver.html?testName=imaging-desaturate) 03:29:21 INFO - PROCESS | 27669 | RSS: Main: 243134464 03:29:21 INFO - PROCESS | 27669 | 03:29:24 INFO - PROCESS | 27669 | Cycle 1(1): loaded http://localhost:45739/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45739/tests/kraken/driver.html?testName=json-parse-financial) 03:29:24 INFO - PROCESS | 27669 | RSS: Main: 245407744 03:29:24 INFO - PROCESS | 27669 | 03:29:26 INFO - PROCESS | 27669 | Cycle 1(1): loaded http://localhost:45739/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45739/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:29:27 INFO - PROCESS | 27669 | RSS: Main: 209018880 03:29:27 INFO - PROCESS | 27669 | 03:29:29 INFO - PROCESS | 27669 | Cycle 1(1): loaded http://localhost:45739/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45739/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:29:29 INFO - PROCESS | 27669 | RSS: Main: 216633344 03:29:29 INFO - PROCESS | 27669 | 03:29:31 INFO - PROCESS | 27669 | Cycle 1(1): loaded http://localhost:45739/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45739/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:29:32 INFO - PROCESS | 27669 | RSS: Main: 225841152 03:29:32 INFO - PROCESS | 27669 | 03:29:35 INFO - PROCESS | 27669 | Cycle 1(1): loaded http://localhost:45739/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45739/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:29:36 INFO - PROCESS | 27669 | RSS: Main: 234663936 03:29:36 INFO - PROCESS | 27669 | 03:29:39 INFO - PROCESS | 27669 | Cycle 1(1): loaded http://localhost:45739/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45739/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:29:39 INFO - PROCESS | 27669 | RSS: Main: 231546880 03:29:39 INFO - PROCESS | 27669 | 03:29:41 INFO - PROCESS | 27669 | Cycle 1(1): loaded http://localhost:45739/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45739/tests/kraken/driver.html?testName=ai-astar) 03:29:41 INFO - PROCESS | 27669 | RSS: Main: 282181632 03:29:41 INFO - PROCESS | 27669 | 03:29:41 INFO - PROCESS | 27669 | __start_tp_report 03:29:41 INFO - PROCESS | 27669 | _x_x_mozilla_page_load 03:29:41 INFO - PROCESS | 27669 | _x_x_mozilla_page_load_details 03:29:41 INFO - PROCESS | 27669 | |i|pagename|runs| 03:29:41 INFO - PROCESS | 27669 | |0;ai-astar;107;116;117;117;117;117;116;117;118;115 03:29:41 INFO - PROCESS | 27669 | |1;audio-beat-detection;148;125;127;160;131;128;129;127;157;127 03:29:41 INFO - PROCESS | 27669 | |2;audio-dft;162;163;163;164;161;162;161;162;162;161 03:29:41 INFO - PROCESS | 27669 | |3;audio-fft;87;75;75;106;78;78;77;76;101;76 03:29:41 INFO - PROCESS | 27669 | |4;audio-oscillator;83;83;122;83;84;84;110;83;83;115 03:29:41 INFO - PROCESS | 27669 | |5;imaging-gaussian-blur;126;117;117;117;117;117;117;117;117;117 03:29:41 INFO - PROCESS | 27669 | |6;imaging-darkroom;147;148;146;147;148;148;146;147;146;146 03:29:41 INFO - PROCESS | 27669 | |7;imaging-desaturate;84;84;84;84;84;84;84;84;84;85 03:29:41 INFO - PROCESS | 27669 | |8;json-parse-financial;65;63;64;64;65;66;66;67;65;66 03:29:41 INFO - PROCESS | 27669 | |9;json-stringify-tinderbox;68;67;67;67;68;67;67;70;67;67 03:29:41 INFO - PROCESS | 27669 | |10;stanford-crypto-aes;83;83;84;82;82;92;82;82;81;82 03:29:41 INFO - PROCESS | 27669 | |11;stanford-crypto-ccm;148;141;141;152;139;140;141;138;187;141 03:29:41 INFO - PROCESS | 27669 | |12;stanford-crypto-pbkdf2;184;178;183;176;175;177;179;181;180;176 03:29:41 INFO - PROCESS | 27669 | |13;stanford-crypto-sha256-iterative;74;71;73;73;70;70;70;70;70;68 03:29:41 INFO - PROCESS | 27669 | __end_tp_report 03:29:41 INFO - PROCESS | 27669 | __start_cc_report 03:29:41 INFO - PROCESS | 27669 | _x_x_mozilla_cycle_collect,1974 03:29:41 INFO - PROCESS | 27669 | __end_cc_report 03:29:41 INFO - PROCESS | 27669 | __startTimestamp1476700181736__endTimestamp 03:29:41 INFO - PROCESS | 27669 | 03:29:41 INFO - PROCESS | 27669 | ------- Summary: start ------- 03:29:41 INFO - PROCESS | 27669 | Number of tests: 14 03:29:41 INFO - PROCESS | 27669 | 03:29:41 INFO - PROCESS | 27669 | [#0] ai-astar Cycles:10 Average:115.70 Median:117.00 stddev:3.16 (2.7%) stddev-sans-first:0.87 03:29:41 INFO - PROCESS | 27669 | Values: 107.0 116.0 117.0 117.0 117.0 117.0 116.0 117.0 118.0 115.0 03:29:41 INFO - PROCESS | 27669 | 03:29:41 INFO - PROCESS | 27669 | [#1] audio-beat-detection Cycles:10 Average:135.90 Median:130.00 stddev:13.59 (10.5%) stddev-sans-first:13.69 03:29:41 INFO - PROCESS | 27669 | Values: 148.0 125.0 127.0 160.0 131.0 128.0 129.0 127.0 157.0 127.0 03:29:41 INFO - PROCESS | 27669 | 03:29:41 INFO - PROCESS | 27669 | [#2] audio-dft Cycles:10 Average:162.10 Median:162.00 stddev:0.99 (0.6%) stddev-sans-first:1.05 03:29:41 INFO - PROCESS | 27669 | Values: 162.0 163.0 163.0 164.0 161.0 162.0 161.0 162.0 162.0 161.0 03:29:41 INFO - PROCESS | 27669 | 03:29:41 INFO - PROCESS | 27669 | [#3] audio-fft Cycles:10 Average:82.90 Median:76.50 stddev:11.45 (15.0%) stddev-sans-first:12.05 03:29:41 INFO - PROCESS | 27669 | Values: 87.0 75.0 75.0 106.0 78.0 78.0 77.0 76.0 101.0 76.0 03:29:41 INFO - PROCESS | 27669 | 03:29:41 INFO - PROCESS | 27669 | [#4] audio-oscillator Cycles:10 Average:93.00 Median:83.00 stddev:15.90 (19.2%) stddev-sans-first:16.45 03:29:41 INFO - PROCESS | 27669 | Values: 83.0 83.0 122.0 83.0 84.0 84.0 110.0 83.0 83.0 115.0 03:29:41 INFO - PROCESS | 27669 | 03:29:41 INFO - PROCESS | 27669 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:117.00 stddev:2.85 (2.4%) stddev-sans-first:0.00 03:29:41 INFO - PROCESS | 27669 | Values: 126.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 03:29:41 INFO - PROCESS | 27669 | 03:29:41 INFO - PROCESS | 27669 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.88 (0.6%) stddev-sans-first:0.93 03:29:41 INFO - PROCESS | 27669 | Values: 147.0 148.0 146.0 147.0 148.0 148.0 146.0 147.0 146.0 146.0 03:29:41 INFO - PROCESS | 27669 | 03:29:41 INFO - PROCESS | 27669 | [#7] imaging-desaturate Cycles:10 Average:84.10 Median:84.00 stddev:0.32 (0.4%) stddev-sans-first:0.33 03:29:41 INFO - PROCESS | 27669 | Values: 84.0 84.0 84.0 84.0 84.0 84.0 84.0 84.0 84.0 85.0 03:29:41 INFO - PROCESS | 27669 | 03:29:41 INFO - PROCESS | 27669 | [#8] json-parse-financial Cycles:10 Average:65.10 Median:65.50 stddev:1.20 (1.8%) stddev-sans-first:1.27 03:29:41 INFO - PROCESS | 27669 | Values: 65.0 63.0 64.0 64.0 65.0 66.0 66.0 67.0 65.0 66.0 03:29:41 INFO - PROCESS | 27669 | 03:29:41 INFO - PROCESS | 27669 | [#9] json-stringify-tinderbox Cycles:10 Average:67.50 Median:67.00 stddev:0.97 (1.5%) stddev-sans-first:1.01 03:29:41 INFO - PROCESS | 27669 | Values: 68.0 67.0 67.0 67.0 68.0 67.0 67.0 70.0 67.0 67.0 03:29:41 INFO - PROCESS | 27669 | 03:29:41 INFO - PROCESS | 27669 | [#10] stanford-crypto-aes Cycles:10 Average:83.30 Median:82.50 stddev:3.16 (3.8%) stddev-sans-first:3.35 03:29:41 INFO - PROCESS | 27669 | Values: 83.0 83.0 84.0 82.0 82.0 92.0 82.0 82.0 81.0 82.0 03:29:41 INFO - PROCESS | 27669 | 03:29:41 INFO - PROCESS | 27669 | [#11] stanford-crypto-ccm Cycles:10 Average:146.80 Median:141.00 stddev:14.77 (10.5%) stddev-sans-first:15.66 03:29:41 INFO - PROCESS | 27669 | Values: 148.0 141.0 141.0 152.0 139.0 140.0 141.0 138.0 187.0 141.0 03:29:41 INFO - PROCESS | 27669 | 03:29:41 INFO - PROCESS | 27669 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.90 Median:179.50 stddev:3.07 (1.7%) stddev-sans-first:2.65 03:29:41 INFO - PROCESS | 27669 | Values: 184.0 178.0 183.0 176.0 175.0 177.0 179.0 181.0 180.0 176.0 03:29:41 INFO - PROCESS | 27669 | 03:29:41 INFO - PROCESS | 27669 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.90 Median:70.50 stddev:1.85 (2.6%) stddev-sans-first:1.59 03:29:41 INFO - PROCESS | 27669 | Values: 74.0 71.0 73.0 73.0 70.0 70.0 70.0 70.0 70.0 68.0 03:29:41 INFO - PROCESS | 27669 | -------- Summary: end -------- 03:29:41 INFO - PROCESS | 27669 | 03:29:43 INFO - TEST-INFO | 27669: exit 0 03:29:43 INFO - TEST-OK | kraken | took 65482ms 03:29:43 INFO - SUITE-END | took 1188s 03:29:43 INFO - Completed test suite (00:19:48) 03:29:43 INFO - javascript benchmark 03:29:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2565.846049237046, 2600.33691408691, 2621.213635909227, 2640.89436422543, 2656.7210442903506, 4488.124815660939, 4552.977235113828, 4634.837780677677, 4654.976725116374, 4665.04366604846, 4606.930896036553, 4629.328747331635, 4674.0651869626045, 4692.389989301395, 4738.360321356616, 4203.684723645723, 4208.97895510522, 4255.936160957588, 4286.935695964563, 4290.721103128302, 3937.606239376068, 4311.805968731399, 4362.083962367907, 4404.11917616478, 4455.443069616298, 4178.415021896937, 4343.131373725236, 4407.625351845097, 4415.955840441587, 4436.29019356903, 4216.304309788881, 4279.91440171198, 4280.764557949312, 4286.657067434598, 4287.48550173978, 4258.041940563379, 4258.488981322261, 4261.914761704779, 4264.936025959613, 4266.722663026924, 4545.136424079415, 4578.816847326103, 4582.95417045832, 4589.747563883985, 4666.836660716858, 4922.212446008622, 4926.0, 4932.408111026664, 4934.111859865223, 4992.950070499285, 4869.610431165534, 4949.604031677457, 4956.801727930879, 4963.92554111685, 5002.649814512985, 4592.05862798129, 4641.675082744176, 4671.789769460348, 4673.813047478131, 4697.506761790031, 5100.387953445536, 5137.17805151174, 5138.794448222104, 5144.022635699205, 5198.194279886624, 4873.02539492103, 4916.852494425173, 4921.532454416824, 4927.348119671249, 4985.127602669519, 4826.0, 4878.804847806048, 4881.975590122098, 4953.405591329064, 4982.202847544376, 4877.122118018719, 4914.827981020647, 4929.654924155275, 4932.284818701268, 4934.9013019739405, 4881.511848815161, 4914.0908931847725, 4916.0, 4984.850454486371, 4988.251762235621, 4232.386303985905, 4241.172971270635, 4244.299690551086, 4297.8495752648505, 4300.075483771005, 3648.5986541480415, 3665.7983810890123, 3691.53855768029, 3715.8327875245677, 3761.962380376216, 4251.383549385384, 4280.76455794928, 4297.527272000078, 4311.805968731414, 4379.189849877783, 4946.35697359341, 4980.0, 4995.950040499549, 5001.0998020355955, 5063.974680126649, 4304.440422745023, 4305.117450922553, 4317.84887528935, 4324.481062272547, 4382.233109205877, 4382.211201983673, 4424.911501769947, 4429.180601588717, 4441.889527618096, 4491.371208030879, 4716.882077948078, 4718.127146477913, 4724.740139292372, 4725.669203155883, 4729.716217026989, 4960.7767650456535, 4990.301357809837, 5001.299818025552, 5021.548060674557, 5067.239914012927, 4723.244280915037, 4730.030343779586, 4733.644976626836, 4774.212254978029, 4792.185328494094, 4900.607951363811, 4929.926051109308, 4938.037082768826, 4946.8763280918265, 5009.0983622948215, 4839.128956787671, 4865.391826021747, 4901.534354236342, 4907.803687852446, 4939.259111133359, 4848.248521479177, 4883.438404583376, 4891.828785992473, 4952.5542701157065, 4958.330625365674, 4880.682755620874, 4886.486918873609, 4888.95111048885, 4893.951060489492, 4945.703257804399, 4659.044895796286, 4708.788104535236, 4780.163471392562, 4819.662623616313, 4889.633277504273, 4839.588634965927, 4876.80492780299, 4900.338454308623, 4926.113299605962, 4993.875153121201, 4808.182608956556, 4821.228603423436, 4827.275908613736, 4828.444728856086, 4876.512348765095], "value": 4574.004800134089, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [565.1438071321945, 573.031576635486, 579.938712156753, 581.7120525339957, 591.2874985642304, 26666.0, 27408.040718574855, 29434.705652943463, 38024.239515209745, 39443.21113577727, 39672.0, 40051.0, 40083.59916400835, 40134.79932600333, 40238.19523609534, 7322.048133742619, 7469.066366704162, 7470.215627359104, 7475.140358858746, 7478.925210747904, 7483.064616922885, 7564.054493188351, 7565.394768418513, 7568.129665088502, 7576.924230757677, 7571.31858132768, 7600.923990760105, 7601.6579253933705, 7608.467407281492, 7610.277023682769, 7540.396768258526, 7572.659230334593, 7575.696972121109, 7582.8483430331635, 7585.1656317805, 7528.698852045966, 7584.54492730438, 7585.317321441097, 7591.772246832604, 7595.6961721531625, 36464.63535364639, 36712.449313260324, 36744.0, 36795.81602091972, 36819.631803682154, 3023.8790448382038, 3158.810471371702, 3351.5642966414453, 3381.8647254109806, 3644.5626524816926, 25845.74154258452, 28330.433391332263, 28385.858070709513, 28393.148205553865, 29926.251843703863, 3475.5134281200653, 3523.894283171509, 3540.3090904551314, 3550.946735798965, 3606.296772129436, 236497.0, 236756.0, 238502.0, 238542.0, 238684.0, 52015.0, 52375.0, 52470.21294680583, 52514.0, 52554.0, 32279.677203228137, 33110.83444582762, 33290.833545832116, 34868.65131348654, 54855.725721371935, 14561.417543298361, 14687.92656036713, 14688.55934321972, 14775.48285810013, 14779.482718104815, 10947.83578246327, 11033.448327583588, 11043.282186657842, 11049.116070714324, 11052.171087168334, 17377.391791287246, 17516.38692645751, 17546.736798948026, 17565.121743912754, 17601.7359739604, 6727.260001399842, 6799.3200679931615, 6861.1080559526945, 6913.239543650195, 7014.614196219257, 748.8726916424112, 865.5542395666237, 937.7702462896634, 957.8658987741721, 1026.1431704526804, 26460.206193814218, 26693.866530667612, 27258.5911211332, 28288.85855570709, 28657.57013644797, 881.5107615273456, 927.0821886332617, 944.1691311645708, 957.4446820843893, 981.4405788700515, 13371.665708357174, 14045.578632641038, 14340.856591434162, 14494.275286235646, 14500.274986250644, 355113.0, 357031.0, 357240.0, 357572.0, 358171.0, 45351.31973020407, 45519.0, 45552.3167152493, 45702.314465283045, 45717.0, 1043.2801367056707, 1108.146727020206, 1143.428285857088, 1185.7628474305172, 1223.5534030078957, 24429.877850611345, 27089.322766930985, 27435.86282068577, 27534.44931101407, 28214.43571128525, 39378.60621393749, 40000.3999940007, 40003.59996400115, 40018.39972400475, 40111.3983290245, 274412.0, 274690.0, 275833.0, 275946.0, 276771.0, 20032.599348012667, 20613.793862061186, 21409.357719268446, 23552.6467102997, 23599.52800943937, 36694.26611467809, 37952.97869894079, 38687.22625547417, 38840.22319553536, 39005.609943901334, 32932.50601240935, 33273.50089748704, 33367.33265334728, 33391.49912751359, 33607.32785344328, 32511.18722031968, 32820.507692384155, 33537.16157096092, 33964.150896227795, 34156.82921585376, 33021.17447063843, 33216.920440149835, 33558.49662255019, 33570.496442552896, 33816.49275260824, 28961.855190723913, 30087.849560752056, 30230.0, 30601.693983059886, 30610.540841886945, 23446.413839654146, 23476.295711128692, 23524.294271171893, 24136.275911721976, 24187.274381768577], "value": 16590.67999153205, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [331.1984996308932, 350.2277478160656, 354.29848899179626, 359.5200407456046, 378.08692008798755, 12170.330631815257, 13225.0, 15521.999999999985, 16223.756643650326, 17664.911675441635, 16837.158142092907, 16929.0, 16937.491875243762, 17076.658466830657, 17416.738748918775, 4307.138572285539, 4581.541845815408, 4888.560029597335, 5110.386753589556, 5112.36095488064, 4856.878578035542, 4979.775910084037, 4980.153373926423, 4992.251162325662, 4994.850154495352, 4770.260609605517, 4951.504849515056, 4958.107540642683, 4962.727050012248, 4966.379202599675, 4926.876828079308, 4996.0, 4998.250262460624, 5000.849974500771, 5002.099622068026, 4275.273203555403, 4449.399331090293, 4458.732476051415, 4467.218236808546, 4476.440444944382, 20469.2835750748, 20670.689939650918, 20843.37469875906, 20845.16619335225, 20958.266460673956, 1804.8375646191776, 1875.8874467531991, 1876.5121068522283, 1947.8246957773727, 2418.3349578865955, 12857.4214160363, 13190.472381104744, 13283.86716132836, 13843.100198487065, 13912.0, 1672.5985763416813, 1692.280780668211, 1701.387500499819, 1723.8707096967778, 1754.2544418622035, 65827.67086164586, 65884.67057664729, 65907.0, 66733.66633166852, 66818.66590667065, 8894.0, 9179.954100229455, 9530.857037144448, 9537.570809313598, 9626.133647971716, 12560.309182995023, 12569.308688022247, 12593.307368094842, 12598.181118227287, 12604.495820167274, 6799.32006799326, 6882.139732533434, 6922.2731613180895, 7191.496595238283, 7224.699554080316, 6751.56114852533, 6770.1537307836525, 6792.152078085595, 6955.582665040114, 7025.332593403618, 5805.187273781674, 5837.620554663933, 5883.14694369314, 5914.319853216849, 5943.970280148658, 1597.3450885137038, 1612.7500237463212, 1616.5231256779277, 1656.7680524726547, 1679.6472740724341, 834.9165083491723, 835.4903508859591, 855.9101294364002, 896.820635872828, 926.9351145419756, 16437.91781041111, 17152.142392880305, 17734.20196091179, 17929.551761206076, 18084.095795210185, 788.2826627768703, 863.4171933944563, 881.6341218394294, 903.9965638141789, 912.4251721415599, 8293.170682931779, 9526.714198574055, 9552.331336806496, 9694.806103877883, 9699.224062075016, 296368.0, 386736.0, 386831.0, 388441.0, 389029.0, 76226.61886690531, 78484.99999999886, 79572.0, 80048.59975700085, 83081.0, 416.10744952077624, 432.5155825475488, 432.53502484828937, 432.77928256588734, 435.938968544404, 9307.72076837696, 9387.577559009998, 9567.0, 9714.659986900424, 9827.312088154047, 24051.158209463283, 25290.873545632156, 33925.32149357048, 36657.71697990664, 36767.0, 45747.54252457433, 46703.0, 46767.0, 52850.73574632102, 53361.7331913338, 7026.613536255555, 7553.848923021399, 7599.962000189964, 7799.259070388304, 8181.959090204511, 11117.610883619034, 11412.258203216765, 11675.416229188677, 11694.532218711156, 11724.472398741906, 9421.104995025462, 9484.57319420614, 9562.414094714482, 9684.176844968257, 10009.69970900874, 10110.140638045848, 10283.434411107162, 10416.479176041319, 10448.477576121315, 10467.528961196613, 9646.276529260193, 9684.32209745311, 9785.116422146211, 9862.556184971838, 10188.337758045704, 7550.8867366990635, 7627.466077374531, 7677.539347639159, 7831.960840195762, 7947.046354437504, 7965.880511792444, 9304.255659547085, 9371.934726391744, 9395.201407880406, 9669.758256043655], "value": 7766.630519768578, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1225.6751960730403, 1378.1180044771345, 1418.7659036259017, 1485.688005518841, 1729.2564197395122, 6325.0, 7307.671154798034, 7506.437017223703, 7511.849763004743, 7730.922690773091, 7769.0, 7787.143414224445, 7791.454598178129, 7811.921880781205, 7826.25650563197, 2087.728595282611, 2118.4492032071694, 2130.595186914489, 2131.360591822455, 2135.7543882453483, 2079.261862038977, 2128.2976617716117, 2158.417227348615, 2158.773328800477, 2160.4382860456317, 2071.171531387442, 2083.5728675621535, 2089.3105275259127, 2094.057674046685, 2102.8317734581274, 2054.979450205494, 2059.6292667319876, 2062.9071691773906, 2063.2675400233, 2072.896355182235, 1991.8406527477766, 2019.4850313170195, 2019.5052212208102, 2021.1511165310606, 2029.8376129909573, 7150.7497237596435, 7727.459077864552, 7736.690532378698, 7801.21987801221, 7807.414443916672, 4433.312836510346, 4562.041971186055, 4564.657650676179, 4565.543445655408, 4581.037982023779, 2783.3320003199287, 2916.6937471565393, 2969.124108388031, 2969.836658983755, 2979.582858399826, 941.7692665297046, 948.1514044929818, 964.0985678390728, 965.0205041882494, 969.2488321550784, 10042.497875106288, 10428.061474467258, 10430.113440357578, 10459.738506537398, 10483.161347092291, 3875.379939209713, 3884.8834534964, 3936.4685767421606, 3948.6446219840354, 3977.2840888639744, 8182.83634327322, 8190.5904704764525, 8209.384296177692, 8214.055383630839, 8224.0, 4410.360497727812, 4411.867643970686, 4423.093265880487, 4423.977880110579, 4425.203463376559, 3560.430331147004, 3631.1829838286176, 3677.8344974476213, 4077.5922407758985, 4132.855350062733, 2887.63904511936, 3269.8692052318115, 3316.8673253070087, 3325.767196296236, 3330.766846320783, 1018.4500369800224, 1037.527924794217, 1051.747580580655, 1060.0565496707782, 1065.7442213868617, 801.358912869702, 810.5055915891302, 825.3933358981144, 836.000978830292, 837.9748607541784, 4954.355933728592, 5103.311053007871, 5114.795408183705, 5150.8969820604125, 5303.549198318109, 396.26295091130476, 411.7899871065778, 423.8389412023411, 427.7625917615753, 428.8434721326693, 3521.3661540922367, 3550.218951830593, 3777.735558510878, 3793.336166170909, 3835.1754372809423, 9326.626934922662, 9327.160555550034, 9375.953120234492, 9409.623615055458, 9530.475823829756, 9240.0, 9295.395799273025, 9373.062693730571, 9400.95299523498, 9440.811183776286, 6919.6540172991145, 7030.402415794612, 7073.292670732989, 7084.220735719066, 7084.256153103953, 5174.7153906535505, 5334.333208348957, 5439.374471935778, 5491.258680078138, 5525.889482210414, 8524.232819046316, 8543.700970466252, 8634.136586341316, 8677.826443471222, 8802.515861627671, 8698.91301086981, 8760.824783504422, 8839.60221790034, 8860.64557417696, 8875.73372798817, 5786.710664466676, 5916.408359164049, 6400.263969643551, 6523.869522609426, 6639.734410623714, 7345.1553071397475, 7379.040724705754, 7379.225181356095, 7395.260473952777, 7427.405807535276, 6482.546221764431, 6578.605283682994, 6616.933830661632, 6666.733330666913, 6668.466522678077, 6387.776427825004, 6493.123428337303, 6537.542372034102, 6547.738090476328, 6552.443042341454, 6145.600535965148, 6175.228096487939, 6244.5316601256, 6246.562740608114, 6266.342034086538, 4262.46719160105, 4288.0, 4290.49832558602, 4317.309230523227, 4336.154449882369, 4177.4778152730905, 4295.8711238661635, 4343.587359200871, 4422.49141348749, 4437.09039646878], "value": 3919.5981110734524, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [286.5615608119577, 288.69831026577225, 292.1818907060231, 292.71752758587945, 297.2924439833197, 4761.262274192341, 4773.713577185371, 4784.067106914154, 4790.568848803607, 4798.297668285083, 4708.929366059503, 4717.481077081518, 4721.150192965265, 4721.551452612005, 4731.929021064687, 3466.306738652267, 3566.785992840425, 3615.493830863681, 3687.8340474678703, 3729.179580492301, 3709.1283548366114, 3723.497327860745, 3726.2920045191463, 3728.0866187783895, 3741.3452645787015, 3688.409854423293, 3689.1883785567265, 3690.6862916652117, 3696.0575053361354, 3698.760915093447, 3467.306538692259, 3550.751447398683, 3577.2308953575107, 3661.462185881936, 3678.981605091984, 3258.283177700902, 3259.4295998200455, 3260.7717459777823, 3266.3140740444537, 3269.8038117713013, 4586.334981427708, 4592.7014744041535, 4608.4700259470255, 4611.054733779601, 4612.308153776927, 3894.80525973703, 4123.484564429446, 4218.093109981338, 4223.767692776896, 4230.76730779807, 4894.804207831682, 4896.926546101811, 4897.33885925399, 4902.338184345139, 4916.70499770015, 3441.82790860456, 3445.1214940190343, 3449.913752156191, 3452.2922800825772, 3458.8962331130106, 5036.607611384599, 5113.539781419653, 5161.845144645667, 5176.715280659562, 5182.792688292464, 3481.651834816498, 3488.302339532104, 3502.212002299513, 3505.3515099706124, 3508.7719298245534, 3539.9646003539633, 3543.8936831895085, 3546.6985306248744, 3552.2540266544315, 3552.9644703552635, 4092.6903390915218, 4100.425940368351, 4106.1582375612925, 4115.300398932129, 4131.669466442678, 4727.078219747116, 4915.65590408668, 4935.605151587864, 4936.827211047596, 4965.1807451770055, 1220.8840160184768, 1243.9115773698015, 1248.7502499499954, 1251.1742250115062, 1251.7621651886113, 765.5330248548381, 773.153397030251, 793.1077537770009, 799.7400844725488, 802.5064585280128, 4187.476565429321, 4319.265724826787, 4334.891627709269, 4335.653147748172, 4349.826006959686, 4961.452561418603, 5114.948850511447, 5117.334746483008, 5128.743562821844, 5135.537801597874, 4395.384646149541, 4398.252297109499, 4406.405135306757, 4410.713303635253, 4415.757133357632, 2612.725663805311, 2675.906343277976, 2694.9595756063673, 2712.5795501697266, 2719.225020869043, 4792.688475249098, 4795.256735206049, 4811.927821082687, 4812.927806082912, 4818.903621927612, 5199.636025478256, 5205.9219111713355, 5215.53060224574, 5226.0, 5241.697730429805, 4559.6124329431705, 4859.1010663027455, 4875.148038397577, 4877.926831097608, 4882.217990433537, 5183.948160518497, 5190.455002224712, 5209.223313097974, 5211.47885211491, 5220.634555581225, 4913.975430122827, 5102.158143906214, 5109.386873575195, 5122.720389426819, 5135.948640513697, 4849.442314133919, 4868.634852386014, 4905.435874874435, 4905.48492408292, 4921.138800709933, 3626.818659067089, 3655.9451608225368, 3662.963370366262, 3667.0465678924206, 3674.154944362865, 5209.374875015023, 5225.529702326809, 5227.268182454383, 5232.136697444879, 5239.26650268955, 4808.471068182567, 5007.848194915263, 5015.448300686849, 5019.698818070928, 5019.774110164978, 5047.798088076436, 5053.974730126326, 5057.721825299644, 5062.924056139087, 5082.796688132434, 4863.270509423614, 4950.653454258168, 5021.322121513549, 5039.017391608748, 5041.0, 4819.807207711652, 4953.455119936732, 5027.84916452507, 5057.216131499624, 5095.541401273755, 4840.757962101951, 4983.177775666974, 4983.775730092082, 4993.501949415234, 5007.39911210657], "value": 3727.328931072775, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [602.2441835496453, 680.4420375292256, 698.5529261272783, 705.7282946065766, 712.2450202785049, 12749.936250318748, 13262.270575118364, 13287.335633218338, 13288.202707837536, 13324.733505329888, 13449.125806822549, 13516.932415337935, 13530.391132399041, 13562.864371356283, 13602.659933501667, 624.7719582352454, 629.232336549409, 763.5647680821934, 764.9541027538338, 771.3173841150566, 768.8193274580469, 771.8957940678021, 772.6407220642428, 772.7836205862368, 772.9845403091963, 831.7504748575434, 832.629479881453, 834.0325222741621, 834.5701963488777, 834.7579202031403, 666.3769375633774, 679.3478260869571, 681.7511608262998, 685.1264637587067, 827.2926647716206, 507.47222888196234, 599.469469519474, 610.4597431273311, 616.1097214525013, 617.9351168127372, 13191.934040329834, 13325.333733313295, 13328.266945318004, 13356.73286534264, 13360.33198340079, 11947.940260298643, 12399.75200495985, 12692.555760548428, 12909.225446473241, 13474.124181928144, 10838.187135964756, 11366.479750778817, 11611.593594224161, 11722.765544689144, 11731.296122232694, 4050.958846689319, 4059.6549293310104, 4062.695297852673, 4144.357624568197, 4156.542780294165, 60931.390686093015, 60986.39013609852, 61502.69248653773, 61606.38393616051, 61729.07406388863, 10266.589336426608, 10387.169026477864, 10469.528871200815, 10673.306235094695, 10857.131429485622, 18318.633627327377, 18637.254509819726, 18696.81303186978, 18721.157547910378, 18738.344157954405, 6339.809805705836, 6342.365763423621, 6427.517936154713, 6557.278699343068, 6617.60294382329, 3512.613612502623, 3559.4482855157494, 3571.5892672342493, 3575.856965721394, 3582.17609949713, 2747.9420423137235, 2819.915402537927, 2837.1488553433887, 2840.8153470024795, 2847.0604700448803, 462.6853739457134, 471.8392753825559, 473.62346934187406, 479.9208130658472, 488.9339939108246, 474.48992333241904, 515.9922601160986, 578.6614830324223, 590.5010266324948, 592.9771144775228, 6990.930090699129, 7117.572945623279, 7251.166115896739, 7689.4232932530285, 7949.920500795034, 529.4308618235412, 553.5267346418834, 563.7294098832583, 564.565284730755, 582.6329412470117, 3365.899023029313, 3493.94759078614, 3594.2272411431145, 3619.167591453928, 3721.5162028936065, 88667.0, 94535.52732236433, 94835.52582237044, 97113.0, 97673.0, 83817.58091209504, 83901.58049209836, 84957.57521212354, 85140.0, 89920.10079899117, 67355.66322168357, 76433.23566764261, 76773.0, 77049.22950770533, 77865.61067194628, 6608.976326498343, 6780.38976492118, 6928.376446119873, 7081.4334853210585, 7122.0, 44714.3292850601, 45682.31476527921, 46811.29783053325, 46813.2978005337, 47455.22078415504, 58499.0, 65301.0, 65705.67147164233, 65774.0, 68621.65689171522, 8192.426530143071, 8602.78493037679, 8815.515146666738, 8917.866232006654, 9006.86489702668, 10453.372797632166, 10500.947495262475, 10525.578976840841, 10583.735406614896, 10614.416207108683, 9110.726678199664, 9204.677836275698, 9226.261899047926, 9710.805783884141, 9723.222142228746, 9783.657571985232, 9970.800583988424, 10098.0, 10294.536745846304, 10314.690559283234, 9163.862542062008, 9239.353245272767, 9469.242460603273, 9501.0, 9501.42991420517, 8134.267915887362, 8512.616932237941, 8567.957160214159, 8652.913470865462, 8711.564421779012, 8037.23646253605, 8360.163983601591, 8634.956825216084, 8751.824963500821, 9056.230220431074], "value": 6237.493056748706, "unit": "score"}], "name": "dromaeo_css", "value": 6142.550793405239, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 118.0, 115.0], "value": 115.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 125.0, 127.0, 160.0, 131.0, 128.0, 129.0, 127.0, 157.0, 127.0], "value": 135.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 163.0, 164.0, 161.0, 162.0, 161.0, 162.0, 162.0, 161.0], "value": 162.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 75.0, 75.0, 106.0, 78.0, 78.0, 77.0, 76.0, 101.0, 76.0], "value": 82.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 122.0, 83.0, 84.0, 84.0, 110.0, 83.0, 83.0, 115.0], "value": 93.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 146.0, 147.0, 148.0, 148.0, 146.0, 147.0, 146.0, 146.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 84.0, 84.0, 84.0, 84.0, 84.0, 84.0, 84.0, 85.0], "value": 84.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 64.0, 64.0, 65.0, 66.0, 66.0, 67.0, 65.0, 66.0], "value": 65.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 67.0, 67.0, 68.0, 67.0, 67.0, 70.0, 67.0, 67.0], "value": 67.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 84.0, 82.0, 82.0, 92.0, 82.0, 82.0, 81.0, 82.0], "value": 83.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 141.0, 141.0, 152.0, 139.0, 140.0, 141.0, 138.0, 187.0, 141.0], "value": 146.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 178.0, 183.0, 176.0, 175.0, 177.0, 179.0, 181.0, 180.0, 176.0], "value": 178.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 71.0, 73.0, 73.0, 70.0, 70.0, 70.0, 70.0, 70.0, 68.0], "value": 70.9, "unit": "score"}], "name": "kraken", "value": 1551.0, "alertThreshold": 2.0}]} 03:29:43 INFO - Return code: 0 03:29:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:29:43 INFO - # TBPL SUCCESS # 03:29:43 INFO - Running post-action listener: _resource_record_post_action 03:29:43 INFO - [mozharness: 2016-10-17 10:29:43.540168Z] Finished run-tests step (success) 03:29:43 INFO - Running post-run listener: _resource_record_post_run 03:29:43 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 4096; Write bytes: 399867904; Read time: 8; Write time: 556788 03:29:43 INFO - TinderboxPrint: CPU usage
13.0% 03:29:43 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 03:29:43 INFO - TinderboxPrint: I/O write bytes / time
399,867,904 / 556,788 03:29:43 INFO - TinderboxPrint: CPU idle
8,355.4 (87.0%) 03:29:43 INFO - TinderboxPrint: CPU user
1,199.3 (12.5%) 03:29:43 INFO - TinderboxPrint: Swap in / out
0 / 0 03:29:43 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 110374912; Read time: 0; Write time: 136608 03:29:43 INFO - run-tests - Wall time: 1189s; CPU: 13.0%; Read bytes: 0; Write bytes: 288595968; Read time: 0; Write time: 420160 03:29:44 INFO - Running post-run listener: _upload_blobber_files 03:29:44 INFO - Blob upload gear active. 03:29:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:29:44 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 03:29:44 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:29:44 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:29:44 INFO - (blobuploader) - INFO - Open directory for files ... 03:29:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:29:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:29:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:29:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:29:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:29:45 INFO - (blobuploader) - INFO - Done attempting. 03:29:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:29:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:29:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:29:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:29:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:29:48 INFO - (blobuploader) - INFO - Done attempting. 03:29:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:29:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:29:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:29:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:29:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:29:49 INFO - (blobuploader) - INFO - Done attempting. 03:29:49 INFO - (blobuploader) - INFO - Iteration through files over. 03:29:49 INFO - Return code: 0 03:29:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:29:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:29:49 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/46f9d0847b52b22ba7db0a4bb5d4f3d5dc947fe0112b02fb18d81d6f332b2f1e0e28eefe1ee134f94024957b3268c5b2bedf7782ac1d4d6478beec062103cc95", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/256e191768f793ee96c64d09dad6bd1b01cf61d0c9dd38313e1d997462577044ed30b5935125abd0d9d8b9202590ace10beebf65654b504ef318ee9f0c01cad2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1e22a53f6723b15275947333b72434c98346b5232e172fd53d6366df0cc3d5565eb9bbde089c77f323a959f2886ee523a4b1d98dcd976925718eac982e639e78"} 03:29:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:29:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:29:49 INFO - Contents: 03:29:49 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/46f9d0847b52b22ba7db0a4bb5d4f3d5dc947fe0112b02fb18d81d6f332b2f1e0e28eefe1ee134f94024957b3268c5b2bedf7782ac1d4d6478beec062103cc95", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/256e191768f793ee96c64d09dad6bd1b01cf61d0c9dd38313e1d997462577044ed30b5935125abd0d9d8b9202590ace10beebf65654b504ef318ee9f0c01cad2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1e22a53f6723b15275947333b72434c98346b5232e172fd53d6366df0cc3d5565eb9bbde089c77f323a959f2886ee523a4b1d98dcd976925718eac982e639e78"} 03:29:49 INFO - Running post-run listener: copy_logs_to_upload_dir 03:29:49 INFO - Copying logs to upload dir... 03:29:49 INFO - mkdir: /builds/slave/test/build/upload/logs 03:29:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.619070 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-10-17 03:29:48.486516) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-17 03:29:48.489680) ========= 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=8783db0840cc980e80bb0bd400000236-1476697705.653901-30023657 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/46f9d0847b52b22ba7db0a4bb5d4f3d5dc947fe0112b02fb18d81d6f332b2f1e0e28eefe1ee134f94024957b3268c5b2bedf7782ac1d4d6478beec062103cc95", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/256e191768f793ee96c64d09dad6bd1b01cf61d0c9dd38313e1d997462577044ed30b5935125abd0d9d8b9202590ace10beebf65654b504ef318ee9f0c01cad2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1e22a53f6723b15275947333b72434c98346b5232e172fd53d6366df0cc3d5565eb9bbde089c77f323a959f2886ee523a4b1d98dcd976925718eac982e639e78"} build_url:https://queue.taskcluster.net/v1/task/AIKHBGKwRiGO1JkDdVYN7g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011366 build_url: 'https://queue.taskcluster.net/v1/task/AIKHBGKwRiGO1JkDdVYN7g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/46f9d0847b52b22ba7db0a4bb5d4f3d5dc947fe0112b02fb18d81d6f332b2f1e0e28eefe1ee134f94024957b3268c5b2bedf7782ac1d4d6478beec062103cc95", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/256e191768f793ee96c64d09dad6bd1b01cf61d0c9dd38313e1d997462577044ed30b5935125abd0d9d8b9202590ace10beebf65654b504ef318ee9f0c01cad2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1e22a53f6723b15275947333b72434c98346b5232e172fd53d6366df0cc3d5565eb9bbde089c77f323a959f2886ee523a4b1d98dcd976925718eac982e639e78"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-17 03:29:48.515654) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 03:29:48.516014) ========= 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=8783db0840cc980e80bb0bd400000236-1476697705.653901-30023657 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004384 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 03:29:48.599385) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-17 03:29:48.599746) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-17 03:29:48.600099) ========= ========= Total master_lag: 0.18 =========