builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-020 starttime: 1475234398.75 results: success (0) buildid: 20160930025920 builduid: 4361e9d7d2684224bcdeb6a7812611a4 revision: 6f31b67533799bd84fe3b207681bcef2c78dac47 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-30 04:19:58.748310) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-30 04:19:58.748792) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-30 04:19:58.749106) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-30 04:19:58.794184) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 04:19:58.794456) ========= 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=af724c981e2a0f424dbabf99000001e7-1475232790.869015-665102860 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-30 04:19:58-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 229M=0s 2016-09-30 04:19:59 (229 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.200916 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 04:19:59.047467) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 04:19:59.047967) ========= 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=af724c981e2a0f424dbabf99000001e7-1475232790.869015-665102860 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015398 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 04:19:59.097734) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 04:19:59.098077) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 6f31b67533799bd84fe3b207681bcef2c78dac47 --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 6f31b67533799bd84fe3b207681bcef2c78dac47 --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=af724c981e2a0f424dbabf99000001e7-1475232790.869015-665102860 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-30 04:19:59,118 truncating revision to first 12 chars 2016-09-30 04:19:59,118 Setting DEBUG logging. 2016-09-30 04:19:59,118 attempt 1/10 2016-09-30 04:19:59,118 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/6f31b6753379?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-30 04:19:59,408 unpacking tar archive at: mozilla-central-6f31b6753379/testing/mozharness/ program finished with exit code 0 elapsedTime=0.633926 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 04:19:59.746068) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-30 04:19:59.746379) ========= script_repo_revision: 6f31b67533799bd84fe3b207681bcef2c78dac47 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-30 04:19:59.746753) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-30 04:19:59.747021) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-30 04:19:59.756658) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-09-30 04:19:59.757020) ========= /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=af724c981e2a0f424dbabf99000001e7-1475232790.869015-665102860 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:19:59 INFO - MultiFileLogger online at 20160930 04:19:59 in /builds/slave/test 04:19:59 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 04:19:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:19:59 INFO - {'append_to_log': False, 04:19:59 INFO - 'base_work_dir': '/builds/slave/test', 04:19:59 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:19:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:19:59 INFO - 'branch': 'Firefox-Non-PGO', 04:19:59 INFO - 'buildbot_json_path': 'buildprops.json', 04:19:59 INFO - 'config_files': ('talos/linux_config.py',), 04:19:59 INFO - 'default_actions': ('clobber', 04:19:59 INFO - 'read-buildbot-config', 04:19:59 INFO - 'download-and-extract', 04:19:59 INFO - 'populate-webroot', 04:19:59 INFO - 'create-virtualenv', 04:19:59 INFO - 'install', 04:19:59 INFO - 'run-tests'), 04:19:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:19:59 INFO - 'download_minidump_stackwalk': True, 04:19:59 INFO - 'download_symbols': 'ondemand', 04:19:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:19:59 INFO - 'tooltool.py': '/tools/tooltool.py', 04:19:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:19:59 INFO - '/tools/misc-python/virtualenv.py')}, 04:19:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:19:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:19:59 INFO - 'installer_path': 'installer.exe', 04:19:59 INFO - 'log_level': 'info', 04:19:59 INFO - 'log_name': 'talos', 04:19:59 INFO - 'log_to_console': True, 04:19:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:19:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:19:59 INFO - 'opt_config_files': (), 04:19:59 INFO - 'pip_index': False, 04:19:59 INFO - 'sps_profile': False, 04:19:59 INFO - 'sps_profile_interval': 0, 04:19:59 INFO - 'suite': 'dromaeojs', 04:19:59 INFO - 'system_bits': '32', 04:19:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:19:59 INFO - 'title': 'talos-linux64-ix-020', 04:19:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:19:59 INFO - 'use_talos_json': True, 04:19:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:19:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:19:59 INFO - 'work_dir': 'build'} 04:19:59 INFO - [mozharness: 2016-09-30 11:19:59.990307Z] Running clobber step. 04:19:59 INFO - Running pre-action listener: _resource_record_pre_action 04:19:59 INFO - Running main action method: clobber 04:19:59 INFO - rmtree: /builds/slave/test/build 04:19:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:20:00 INFO - Running post-action listener: _resource_record_post_action 04:20:00 INFO - [mozharness: 2016-09-30 11:20:00.414266Z] Finished clobber step (success) 04:20:00 INFO - [mozharness: 2016-09-30 11:20:00.414366Z] Running read-buildbot-config step. 04:20:00 INFO - Running pre-action listener: _resource_record_pre_action 04:20:00 INFO - Running main action method: read_buildbot_config 04:20:00 INFO - Using buildbot properties: 04:20:00 INFO - { 04:20:00 INFO - "project": "", 04:20:00 INFO - "product": "firefox", 04:20:00 INFO - "script_repo_revision": "production", 04:20:00 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 04:20:00 INFO - "repository": "", 04:20:00 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 04:20:00 INFO - "buildid": "20160930025920", 04:20:00 INFO - "pgo_build": "False", 04:20:00 INFO - "basedir": "/builds/slave/test", 04:20:00 INFO - "buildnumber": 224, 04:20:00 INFO - "slavename": "talos-linux64-ix-020", 04:20:00 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:20:00 INFO - "platform": "ubuntu64_hw", 04:20:00 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 04:20:00 INFO - "branch": "mozilla-central", 04:20:00 INFO - "repo_path": "mozilla-central", 04:20:00 INFO - "revision": "6f31b67533799bd84fe3b207681bcef2c78dac47", 04:20:00 INFO - "stage_platform": "linux64", 04:20:00 INFO - "builduid": "4361e9d7d2684224bcdeb6a7812611a4", 04:20:00 INFO - "slavebuilddir": "test" 04:20:00 INFO - } 04:20:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/S6cNpLi2TnaUUhiidnk5gw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 04:20:00 INFO - Running post-action listener: _resource_record_post_action 04:20:00 INFO - [mozharness: 2016-09-30 11:20:00.416752Z] Finished read-buildbot-config step (success) 04:20:00 INFO - [mozharness: 2016-09-30 11:20:00.416839Z] Running download-and-extract step. 04:20:00 INFO - Running pre-action listener: _resource_record_pre_action 04:20:00 INFO - Running main action method: download_and_extract 04:20:00 INFO - mkdir: /builds/slave/test/build/tests 04:20:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:20:00 INFO - trying https://queue.taskcluster.net/v1/task/S6cNpLi2TnaUUhiidnk5gw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 04:20:00 INFO - Downloading https://queue.taskcluster.net/v1/task/S6cNpLi2TnaUUhiidnk5gw/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 04:20:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/S6cNpLi2TnaUUhiidnk5gw/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 04:20:01 INFO - Downloaded 1361 bytes. 04:20:01 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 04:20:01 INFO - Using the following test package requirements: 04:20:01 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 04:20:01 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:20:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:20:01 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:20:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:20:01 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:20:01 INFO - u'jsshell-linux-x86_64.zip'], 04:20:01 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:20:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:20:01 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 04:20:01 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:20:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:20:01 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:20:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:20:01 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:20:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:20:01 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:20:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:20:01 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:20:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/S6cNpLi2TnaUUhiidnk5gw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 04:20:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/S6cNpLi2TnaUUhiidnk5gw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:20:01 INFO - Fetch https://queue.taskcluster.net/v1/task/S6cNpLi2TnaUUhiidnk5gw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 04:20:01 INFO - Http code: 200 04:20:01 INFO - via: 1.1 6cd88b9fd84ad5daa3b3867fb8c5c91a.cloudfront.net (CloudFront) 04:20:01 INFO - x-amz-cf-id: KdY236jIjKHClCfrJ7S0d6m3rfHwZeYsrwAb5aFvyDOsBAev3ewwEA== 04:20:01 INFO - x-amz-version-id: p_ChhN1SCD5jA5rRacql8riEgpKcaGfj 04:20:01 INFO - Expected file size: 20417367 04:20:01 INFO - Obtained file size: 20417367 04:20: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 04:20:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/S6cNpLi2TnaUUhiidnk5gw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 04:20:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/S6cNpLi2TnaUUhiidnk5gw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:20:06 INFO - Fetch https://queue.taskcluster.net/v1/task/S6cNpLi2TnaUUhiidnk5gw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 04:20:06 INFO - Http code: 200 04:20:06 INFO - via: 1.1 41b2ee7cbe95749816a7586d9ab4629d.cloudfront.net (CloudFront) 04:20:06 INFO - x-amz-cf-id: j4T5l4IzRJzR85KyhymOBumejGeGbZfdKSBQh2lFY3FA7tc1gMcl1g== 04:20:06 INFO - x-amz-version-id: p_ChhN1SCD5jA5rRacql8riEgpKcaGfj 04:20:06 INFO - Expected file size: 20417367 04:20:06 INFO - Obtained file size: 20417367 04:20:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/S6cNpLi2TnaUUhiidnk5gw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 04:20:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/S6cNpLi2TnaUUhiidnk5gw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:20:11 INFO - Fetch https://queue.taskcluster.net/v1/task/S6cNpLi2TnaUUhiidnk5gw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 04:20:12 INFO - Http code: 200 04:20:12 INFO - via: 1.1 7f9e159e8ac7593f5d3d995abc6d2db3.cloudfront.net (CloudFront) 04:20:12 INFO - x-amz-cf-id: v1pqXjQfPSAD7LyBZKxKCWYD_0qgVjHne_nS1MlgFqTVO2sdppqOIw== 04:20:12 INFO - x-amz-version-id: AOQrdFcM7qm0T0Qc6B5vLLiZEpJZkZbp 04:20:13 INFO - Expected file size: 14414067 04:20:13 INFO - Obtained file size: 14414067 04:20: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')]} 04:20:13 INFO - trying https://queue.taskcluster.net/v1/task/S6cNpLi2TnaUUhiidnk5gw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 04:20:13 INFO - Downloading https://queue.taskcluster.net/v1/task/S6cNpLi2TnaUUhiidnk5gw/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 04:20:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/S6cNpLi2TnaUUhiidnk5gw/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 04:20:15 INFO - Downloaded 55743559 bytes. 04:20:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/S6cNpLi2TnaUUhiidnk5gw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 04:20:15 INFO - mkdir: /builds/slave/test/properties 04:20:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:20:15 INFO - Writing to file /builds/slave/test/properties/build_url 04:20:15 INFO - Contents: 04:20:15 INFO - build_url:https://queue.taskcluster.net/v1/task/S6cNpLi2TnaUUhiidnk5gw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 04:20:16 INFO - Running post-action listener: _resource_record_post_action 04:20:16 INFO - Running post-action listener: set_extra_try_arguments 04:20:16 INFO - [mozharness: 2016-09-30 11:20:16.303810Z] Finished download-and-extract step (success) 04:20:16 INFO - [mozharness: 2016-09-30 11:20:16.304036Z] Running populate-webroot step. 04:20:16 INFO - Running pre-action listener: _resource_record_pre_action 04:20:16 INFO - Running main action method: populate_webroot 04:20:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:20:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:20:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:20:16 INFO - '--tppagecycles', 04:20:16 INFO - '7'], 04:20:16 INFO - 'tests': ['tsvgm']}}, 04:20:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:20:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:20:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:20:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:20:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:20:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:20:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:20:16 INFO - 'talos_options': ['--disable-e10s'], 04:20:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:20:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:20:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:20:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:20:16 INFO - 'talos_options': ['--disable-e10s'], 04:20:16 INFO - 'tests': ['damp', 'tps']}, 04:20:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:20:16 INFO - 'tests': ['damp', 'tps']}, 04:20:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:20:16 INFO - 'tests': ['dromaeo_dom']}, 04:20:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:20:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:20:16 INFO - 'tests': ['basic_compositor_video']}, 04:20:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:20:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:20:16 INFO - 'tests': ['a11yr', 04:20:16 INFO - 'ts_paint', 04:20:16 INFO - 'tpaint', 04:20:16 INFO - 'sessionrestore', 04:20:16 INFO - 'sessionrestore_no_auto_restore', 04:20:16 INFO - 'tabpaint']}, 04:20:16 INFO - 'other-e10s': {'tests': ['a11yr', 04:20:16 INFO - 'ts_paint', 04:20:16 INFO - 'tpaint', 04:20:16 INFO - 'sessionrestore', 04:20:16 INFO - 'sessionrestore_no_auto_restore', 04:20:16 INFO - 'tabpaint']}, 04:20:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:20:16 INFO - 'ts_paint', 04:20:16 INFO - 'tpaint', 04:20:16 INFO - 'sessionrestore', 04:20:16 INFO - 'sessionrestore_no_auto_restore', 04:20:16 INFO - 'tabpaint']}, 04:20:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:20:16 INFO - 'ts_paint', 04:20:16 INFO - 'tpaint', 04:20:16 INFO - 'sessionrestore', 04:20:16 INFO - 'sessionrestore_no_auto_restore', 04:20:16 INFO - 'tabpaint']}, 04:20:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:20:16 INFO - 'tests': ['a11yr', 04:20:16 INFO - 'ts_paint', 04:20:16 INFO - 'tpaint', 04:20:16 INFO - 'sessionrestore', 04:20:16 INFO - 'sessionrestore_no_auto_restore', 04:20:16 INFO - 'tabpaint']}, 04:20:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:20:16 INFO - 'tests': ['a11yr', 04:20:16 INFO - 'ts_paint', 04:20:16 INFO - 'tpaint', 04:20:16 INFO - 'sessionrestore', 04:20:16 INFO - 'sessionrestore_no_auto_restore', 04:20:16 INFO - 'tabpaint']}, 04:20:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:20:16 INFO - 'tests': ['tsvgx', 04:20:16 INFO - 'tsvgr_opacity', 04:20:16 INFO - 'tart', 04:20:16 INFO - 'tscrollx', 04:20:16 INFO - 'cart']}, 04:20:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:20:16 INFO - 'tsvgr_opacity', 04:20:16 INFO - 'tart', 04:20:16 INFO - 'tscrollx', 04:20:16 INFO - 'cart']}, 04:20:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:20:16 INFO - 'talos_options': ['--disable-e10s'], 04:20:16 INFO - 'tests': ['tp5o']}, 04:20:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:20:16 INFO - 'tests': ['tp5o']}, 04:20:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:20:16 INFO - 'talos_options': ['--disable-e10s', 04:20:16 INFO - '--xperf_path', 04:20:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:20:16 INFO - 'tests': ['tp5n']}, 04:20:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:20:16 INFO - 'talos_options': ['--xperf_path', 04:20:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:20:16 INFO - 'tests': ['tp5n']}}, 04:20:16 INFO - 'talos.zip': {'path': '', 04:20:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:20:16 INFO - Running post-action listener: _resource_record_post_action 04:20:16 INFO - [mozharness: 2016-09-30 11:20:16.325719Z] Finished populate-webroot step (success) 04:20:16 INFO - [mozharness: 2016-09-30 11:20:16.325805Z] Running create-virtualenv step. 04:20:16 INFO - Running pre-action listener: _resource_record_pre_action 04:20:16 INFO - Running main action method: create_virtualenv 04:20:16 INFO - Creating virtualenv /builds/slave/test/build/venv 04:20: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 04:20:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:20:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:20:16 INFO - Using real prefix '/usr' 04:20:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:20:17 INFO - Installing distribute.............................................................................................................................................................................................done. 04:20:19 INFO - Installing pip.................done. 04:20:19 INFO - Return code: 0 04:20:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:20:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:20:19 INFO - Reading from file tmpfile_stdout 04:20:19 INFO - Output received: 04:20: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) 04:20:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:20: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')]} 04:20:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20: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')]} 04:20:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20: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 0x7f8ec06d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2243ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2240f60>, '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 0x2241d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22421d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1475232790.869015-665102860', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:20: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 04:20: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 04:20:19 INFO - Using env: {'DISPLAY': ':0', 04:20:19 INFO - 'HOME': '/home/cltbld', 04:20:19 INFO - 'LANG': 'en_US.UTF-8', 04:20:19 INFO - 'LANGUAGE': 'en_US:en', 04:20:19 INFO - 'LOGNAME': 'cltbld', 04:20:19 INFO - 'MAIL': '/var/mail/cltbld', 04:20:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:19 INFO - 'MOZ_NO_REMOTE': '1', 04:20:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:19 INFO - 'NO_EM_RESTART': '1', 04:20:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:19 INFO - 'PWD': '/builds/slave/test', 04:20:19 INFO - 'SHELL': '/bin/bash', 04:20:19 INFO - 'SHLVL': '1', 04:20:19 INFO - 'TERM': 'linux', 04:20:19 INFO - 'TMOUT': '86400', 04:20:19 INFO - 'USER': 'cltbld', 04:20:19 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1475232790.869015-665102860', 04:20:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:19 INFO - '_': '/tools/buildbot/bin/python'} 04:20:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20: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 04:20:19 INFO - Cleaning up... 04:20:19 INFO - Return code: 0 04:20:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:20: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')]} 04:20:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20: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')]} 04:20:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20: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 0x7f8ec06d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2243ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2240f60>, '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 0x2241d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22421d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1475232790.869015-665102860', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:20: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 04:20: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 04:20:19 INFO - Using env: {'DISPLAY': ':0', 04:20:19 INFO - 'HOME': '/home/cltbld', 04:20:19 INFO - 'LANG': 'en_US.UTF-8', 04:20:19 INFO - 'LANGUAGE': 'en_US:en', 04:20:19 INFO - 'LOGNAME': 'cltbld', 04:20:19 INFO - 'MAIL': '/var/mail/cltbld', 04:20:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:19 INFO - 'MOZ_NO_REMOTE': '1', 04:20:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:19 INFO - 'NO_EM_RESTART': '1', 04:20:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:19 INFO - 'PWD': '/builds/slave/test', 04:20:19 INFO - 'SHELL': '/bin/bash', 04:20:19 INFO - 'SHLVL': '1', 04:20:19 INFO - 'TERM': 'linux', 04:20:19 INFO - 'TMOUT': '86400', 04:20:19 INFO - 'USER': 'cltbld', 04:20:19 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1475232790.869015-665102860', 04:20:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:19 INFO - '_': '/tools/buildbot/bin/python'} 04:20:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:19 INFO - Downloading/unpacking psutil>=3.1.1 04:20: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 04:20: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 04:20: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 04:20: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 04:20: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 04:20: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 04:20:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:20:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:20:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:20:21 INFO - Installing collected packages: psutil 04:20:21 INFO - Running setup.py install for psutil 04:20:21 INFO - building 'psutil._psutil_linux' extension 04:20: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 04:20:22 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:20:23 INFO - building 'psutil._psutil_posix' extension 04:20:23 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:20:23 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:20:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:20:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:20:23 INFO - Successfully installed psutil 04:20:23 INFO - Cleaning up... 04:20:23 INFO - Return code: 0 04:20:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:20:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:20:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:20:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ec06d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2243ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2240f60>, '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 0x2241d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22421d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1475232790.869015-665102860', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:20:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:20:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:20:23 INFO - Using env: {'DISPLAY': ':0', 04:20:23 INFO - 'HOME': '/home/cltbld', 04:20:23 INFO - 'LANG': 'en_US.UTF-8', 04:20:23 INFO - 'LANGUAGE': 'en_US:en', 04:20:23 INFO - 'LOGNAME': 'cltbld', 04:20:23 INFO - 'MAIL': '/var/mail/cltbld', 04:20:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:23 INFO - 'MOZ_NO_REMOTE': '1', 04:20:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:23 INFO - 'NO_EM_RESTART': '1', 04:20:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:23 INFO - 'PWD': '/builds/slave/test', 04:20:23 INFO - 'SHELL': '/bin/bash', 04:20:23 INFO - 'SHLVL': '1', 04:20:23 INFO - 'TERM': 'linux', 04:20:23 INFO - 'TMOUT': '86400', 04:20:23 INFO - 'USER': 'cltbld', 04:20:23 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1475232790.869015-665102860', 04:20:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:23 INFO - '_': '/tools/buildbot/bin/python'} 04:20:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:20:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:20:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:20:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:20:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:20:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:20:25 INFO - Installing collected packages: mozsystemmonitor 04:20:25 INFO - Running setup.py install for mozsystemmonitor 04:20:25 INFO - Successfully installed mozsystemmonitor 04:20:25 INFO - Cleaning up... 04:20:25 INFO - Return code: 0 04:20:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:20:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:20:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:20:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:26 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 0x7f8ec06d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2243ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2240f60>, '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 0x2241d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22421d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1475232790.869015-665102860', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:20:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:20:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:20:26 INFO - Using env: {'DISPLAY': ':0', 04:20:26 INFO - 'HOME': '/home/cltbld', 04:20:26 INFO - 'LANG': 'en_US.UTF-8', 04:20:26 INFO - 'LANGUAGE': 'en_US:en', 04:20:26 INFO - 'LOGNAME': 'cltbld', 04:20:26 INFO - 'MAIL': '/var/mail/cltbld', 04:20:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:26 INFO - 'MOZ_NO_REMOTE': '1', 04:20:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:26 INFO - 'NO_EM_RESTART': '1', 04:20:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:26 INFO - 'PWD': '/builds/slave/test', 04:20:26 INFO - 'SHELL': '/bin/bash', 04:20:26 INFO - 'SHLVL': '1', 04:20:26 INFO - 'TERM': 'linux', 04:20:26 INFO - 'TMOUT': '86400', 04:20:26 INFO - 'USER': 'cltbld', 04:20:26 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1475232790.869015-665102860', 04:20:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:26 INFO - '_': '/tools/buildbot/bin/python'} 04:20:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:26 INFO - Downloading/unpacking jsonschema==2.5.1 04:20:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:20:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:20:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:20:28 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:20:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:20:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:20:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:28 INFO - Downloading functools32-3.2.3-2.tar.gz 04:20:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:20:28 INFO - warning: no files found matching '*.txt' 04:20:28 INFO - no previously-included directories found matching 'build' 04:20:28 INFO - no previously-included directories found matching 'dist' 04:20:28 INFO - no previously-included directories found matching '.git*' 04:20:28 INFO - Installing collected packages: jsonschema, functools32 04:20:28 INFO - Running setup.py install for functools32 04:20:28 INFO - warning: no files found matching '*.txt' 04:20:28 INFO - no previously-included directories found matching 'build' 04:20:28 INFO - no previously-included directories found matching 'dist' 04:20:28 INFO - no previously-included directories found matching '.git*' 04:20:28 INFO - Successfully installed jsonschema functools32 04:20:28 INFO - Cleaning up... 04:20:28 INFO - Return code: 0 04:20:28 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:20:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:20:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:20:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f8ec06d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2243ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2240f60>, '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 0x2241d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22421d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1475232790.869015-665102860', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:20:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:20:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:20:28 INFO - Using env: {'DISPLAY': ':0', 04:20:28 INFO - 'HOME': '/home/cltbld', 04:20:28 INFO - 'LANG': 'en_US.UTF-8', 04:20:28 INFO - 'LANGUAGE': 'en_US:en', 04:20:28 INFO - 'LOGNAME': 'cltbld', 04:20:28 INFO - 'MAIL': '/var/mail/cltbld', 04:20:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:28 INFO - 'MOZ_NO_REMOTE': '1', 04:20:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:28 INFO - 'NO_EM_RESTART': '1', 04:20:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:28 INFO - 'PWD': '/builds/slave/test', 04:20:28 INFO - 'SHELL': '/bin/bash', 04:20:28 INFO - 'SHLVL': '1', 04:20:28 INFO - 'TERM': 'linux', 04:20:28 INFO - 'TMOUT': '86400', 04:20:28 INFO - 'USER': 'cltbld', 04:20:28 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1475232790.869015-665102860', 04:20:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:28 INFO - '_': '/tools/buildbot/bin/python'} 04:20:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:28 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:20:28 INFO - Cleaning up... 04:20:28 INFO - Return code: 0 04:20:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:20:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:20:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:20:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ec06d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2243ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2240f60>, '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 0x2241d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22421d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1475232790.869015-665102860', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:20:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:20:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:20:28 INFO - Using env: {'DISPLAY': ':0', 04:20:28 INFO - 'HOME': '/home/cltbld', 04:20:28 INFO - 'LANG': 'en_US.UTF-8', 04:20:28 INFO - 'LANGUAGE': 'en_US:en', 04:20:28 INFO - 'LOGNAME': 'cltbld', 04:20:28 INFO - 'MAIL': '/var/mail/cltbld', 04:20:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:28 INFO - 'MOZ_NO_REMOTE': '1', 04:20:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:28 INFO - 'NO_EM_RESTART': '1', 04:20:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:28 INFO - 'PWD': '/builds/slave/test', 04:20:28 INFO - 'SHELL': '/bin/bash', 04:20:28 INFO - 'SHLVL': '1', 04:20:28 INFO - 'TERM': 'linux', 04:20:28 INFO - 'TMOUT': '86400', 04:20:28 INFO - 'USER': 'cltbld', 04:20:28 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1475232790.869015-665102860', 04:20:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:28 INFO - '_': '/tools/buildbot/bin/python'} 04:20:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:29 INFO - Downloading/unpacking blobuploader==1.2.4 04:20: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 04:20: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 04:20: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 04:20: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 04:20: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 04:20: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 04:20:30 INFO - Downloading blobuploader-1.2.4.tar.gz 04:20:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:20:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:20:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:20:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:20:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:20:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:20:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:20:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:20:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:31 INFO - Downloading docopt-0.6.1.tar.gz 04:20:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:20:31 INFO - Installing collected packages: blobuploader, requests, docopt 04:20:31 INFO - Running setup.py install for blobuploader 04:20:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:20:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:20:31 INFO - Running setup.py install for requests 04:20:32 INFO - Running setup.py install for docopt 04:20:32 INFO - Successfully installed blobuploader requests docopt 04:20:32 INFO - Cleaning up... 04:20:32 INFO - Return code: 0 04:20:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:20:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:20:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:20:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:32 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 0x7f8ec06d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2243ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2240f60>, '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 0x2241d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22421d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1475232790.869015-665102860', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:20:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:20:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:20:32 INFO - Using env: {'DISPLAY': ':0', 04:20:32 INFO - 'HOME': '/home/cltbld', 04:20:32 INFO - 'LANG': 'en_US.UTF-8', 04:20:32 INFO - 'LANGUAGE': 'en_US:en', 04:20:32 INFO - 'LOGNAME': 'cltbld', 04:20:32 INFO - 'MAIL': '/var/mail/cltbld', 04:20:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:32 INFO - 'MOZ_NO_REMOTE': '1', 04:20:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:32 INFO - 'NO_EM_RESTART': '1', 04:20:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:32 INFO - 'PWD': '/builds/slave/test', 04:20:32 INFO - 'SHELL': '/bin/bash', 04:20:32 INFO - 'SHLVL': '1', 04:20:32 INFO - 'TERM': 'linux', 04:20:32 INFO - 'TMOUT': '86400', 04:20:32 INFO - 'USER': 'cltbld', 04:20:32 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1475232790.869015-665102860', 04:20:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:32 INFO - '_': '/tools/buildbot/bin/python'} 04:20:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:20:32 INFO - Running setup.py (path:/tmp/pip-5S7oGi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:20:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:20:32 INFO - Running setup.py (path:/tmp/pip-ThMM75-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:20:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:20:32 INFO - Running setup.py (path:/tmp/pip-jHOGij-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:20:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:20:32 INFO - Running setup.py (path:/tmp/pip-9x9XBX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:20:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:20:32 INFO - Running setup.py (path:/tmp/pip-O38APr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:20:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:20:32 INFO - Running setup.py (path:/tmp/pip-m5815r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:20:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:20:32 INFO - Running setup.py (path:/tmp/pip-lZnlpx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:20:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:20:33 INFO - Running setup.py (path:/tmp/pip-PAvMCt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:20:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:20:33 INFO - Running setup.py (path:/tmp/pip-CBBSpZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:20:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:20:33 INFO - Running setup.py (path:/tmp/pip-ZaCJYI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:20:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:20:33 INFO - Running setup.py (path:/tmp/pip-KQcf_F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:20:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:20:33 INFO - Running setup.py (path:/tmp/pip-iyE0Yw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:20:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:20:33 INFO - Running setup.py (path:/tmp/pip-0qAtWF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:20:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:20:33 INFO - Running setup.py (path:/tmp/pip-POwNZE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:20:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:20:33 INFO - Running setup.py (path:/tmp/pip-fvONR7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:20:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:20:33 INFO - Running setup.py (path:/tmp/pip-kBQItn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:20:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:20:33 INFO - Running setup.py (path:/tmp/pip-pTXMkO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:20:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:20:33 INFO - Running setup.py install for manifestparser 04:20:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:20:33 INFO - Running setup.py install for mozcrash 04:20:33 INFO - Running setup.py install for mozdebug 04:20:34 INFO - Running setup.py install for mozdevice 04:20:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:20:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:20:34 INFO - Running setup.py install for mozfile 04:20:34 INFO - Running setup.py install for mozhttpd 04:20:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:20:34 INFO - Running setup.py install for mozinfo 04:20:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:20:34 INFO - Running setup.py install for mozInstall 04:20:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:20:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:20:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:20:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:20:34 INFO - Running setup.py install for mozleak 04:20:34 INFO - Running setup.py install for mozlog 04:20:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:20:34 INFO - Running setup.py install for moznetwork 04:20:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:20:34 INFO - Running setup.py install for mozprocess 04:20:35 INFO - Running setup.py install for mozprofile 04:20:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:20:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:20:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:20:35 INFO - Running setup.py install for mozrunner 04:20:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:20:35 INFO - Running setup.py install for mozscreenshot 04:20:35 INFO - Running setup.py install for moztest 04:20:35 INFO - Running setup.py install for mozversion 04:20:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:20:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:20:35 INFO - Cleaning up... 04:20:35 INFO - Return code: 0 04:20:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:20:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:20:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:20:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:35 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 0x7f8ec06d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2243ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2240f60>, '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 0x2241d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22421d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1475232790.869015-665102860', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:20:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:20:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:20:35 INFO - Using env: {'DISPLAY': ':0', 04:20:35 INFO - 'HOME': '/home/cltbld', 04:20:35 INFO - 'LANG': 'en_US.UTF-8', 04:20:35 INFO - 'LANGUAGE': 'en_US:en', 04:20:35 INFO - 'LOGNAME': 'cltbld', 04:20:35 INFO - 'MAIL': '/var/mail/cltbld', 04:20:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:35 INFO - 'MOZ_NO_REMOTE': '1', 04:20:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:35 INFO - 'NO_EM_RESTART': '1', 04:20:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:35 INFO - 'PWD': '/builds/slave/test', 04:20:35 INFO - 'SHELL': '/bin/bash', 04:20:35 INFO - 'SHLVL': '1', 04:20:35 INFO - 'TERM': 'linux', 04:20:35 INFO - 'TMOUT': '86400', 04:20:35 INFO - 'USER': 'cltbld', 04:20:35 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1475232790.869015-665102860', 04:20:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:35 INFO - '_': '/tools/buildbot/bin/python'} 04:20:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:20:35 INFO - Running setup.py (path:/tmp/pip-YrXw0_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:20:35 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:20:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:20:35 INFO - Running setup.py (path:/tmp/pip-kWtUyD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:20:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:20:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:20:35 INFO - Running setup.py (path:/tmp/pip-vg9JCG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:20:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:20:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:20:36 INFO - Running setup.py (path:/tmp/pip-EtY21I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:20:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:20:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:20:36 INFO - Running setup.py (path:/tmp/pip-yJB6oK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:20:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:20:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:20:36 INFO - Running setup.py (path:/tmp/pip-VPLjbq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:20:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:20:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:20:36 INFO - Running setup.py (path:/tmp/pip-gtA3nI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:20:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:20:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:20:36 INFO - Running setup.py (path:/tmp/pip-sE_htU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:20:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:20:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:20:36 INFO - Running setup.py (path:/tmp/pip-ZSbT4W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:20:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:20:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:20:36 INFO - Running setup.py (path:/tmp/pip-qVh475-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:20:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:20:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:20:36 INFO - Running setup.py (path:/tmp/pip-_ulIp8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:20:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:20:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:20:36 INFO - Running setup.py (path:/tmp/pip-BENPnG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:20:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:20:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:20:36 INFO - Running setup.py (path:/tmp/pip-kLudIs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:20:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:20:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:20:36 INFO - Running setup.py (path:/tmp/pip-wbdtyd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:20:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:20:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:20:36 INFO - Running setup.py (path:/tmp/pip-CVHKhR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:20:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:20:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:20:36 INFO - Running setup.py (path:/tmp/pip-8FuegZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:20:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:20:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:20:36 INFO - Running setup.py (path:/tmp/pip-vv1O8L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:20:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:20:37 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)) 04:20:37 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)) 04:20:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:20:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:20:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:20:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:20:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:20:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:20:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:38 INFO - Downloading blessings-1.6.tar.gz 04:20:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:20:39 INFO - Installing collected packages: blessings 04:20:39 INFO - Running setup.py install for blessings 04:20:39 INFO - Successfully installed blessings 04:20:39 INFO - Cleaning up... 04:20:39 INFO - Return code: 0 04:20:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:20:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:20:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:20:39 INFO - Reading from file tmpfile_stdout 04:20:39 INFO - Current package versions: 04:20:39 INFO - argparse == 1.2.1 04:20:39 INFO - blessings == 1.6 04:20:39 INFO - blobuploader == 1.2.4 04:20:39 INFO - docopt == 0.6.1 04:20:39 INFO - functools32 == 3.2.3-2 04:20:39 INFO - jsonschema == 2.5.1 04:20:39 INFO - manifestparser == 1.1 04:20:39 INFO - mozInstall == 1.12 04:20:39 INFO - mozcrash == 0.17 04:20:39 INFO - mozdebug == 0.1 04:20:39 INFO - mozdevice == 0.48 04:20:39 INFO - mozfile == 1.2 04:20:39 INFO - mozhttpd == 0.7 04:20:39 INFO - mozinfo == 0.9 04:20:39 INFO - mozleak == 0.1 04:20:39 INFO - mozlog == 3.4 04:20:39 INFO - moznetwork == 0.27 04:20:39 INFO - mozprocess == 0.23 04:20:39 INFO - mozprofile == 0.28 04:20:39 INFO - mozrunner == 6.12 04:20:39 INFO - mozscreenshot == 0.1 04:20:39 INFO - mozsystemmonitor == 0.3 04:20:39 INFO - moztest == 0.7 04:20:39 INFO - mozversion == 1.4 04:20:39 INFO - psutil == 3.1.1 04:20:39 INFO - requests == 1.2.3 04:20:39 INFO - wsgiref == 0.1.2 04:20:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:20:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:20:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:20:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:39 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 0x7f8ec06d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2243ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2240f60>, '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 0x2241d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22421d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1475232790.869015-665102860', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:20:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:20:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:20:39 INFO - Using env: {'DISPLAY': ':0', 04:20:39 INFO - 'HOME': '/home/cltbld', 04:20:39 INFO - 'LANG': 'en_US.UTF-8', 04:20:39 INFO - 'LANGUAGE': 'en_US:en', 04:20:39 INFO - 'LOGNAME': 'cltbld', 04:20:39 INFO - 'MAIL': '/var/mail/cltbld', 04:20:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:39 INFO - 'MOZ_NO_REMOTE': '1', 04:20:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:39 INFO - 'NO_EM_RESTART': '1', 04:20:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:39 INFO - 'PWD': '/builds/slave/test', 04:20:39 INFO - 'SHELL': '/bin/bash', 04:20:39 INFO - 'SHLVL': '1', 04:20:39 INFO - 'TERM': 'linux', 04:20:39 INFO - 'TMOUT': '86400', 04:20:39 INFO - 'USER': 'cltbld', 04:20:39 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1475232790.869015-665102860', 04:20:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:39 INFO - '_': '/tools/buildbot/bin/python'} 04:20:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:20:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:20:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:20:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:20:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:20:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:20:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:20:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:20:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:20:39 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:20:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:20:39 INFO - Cleaning up... 04:20:39 INFO - Return code: 0 04:20:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:20:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:20:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:20:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ec06d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2243ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2240f60>, '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 0x2241d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22421d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1475232790.869015-665102860', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:20:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:20:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:20:39 INFO - Using env: {'DISPLAY': ':0', 04:20:39 INFO - 'HOME': '/home/cltbld', 04:20:39 INFO - 'LANG': 'en_US.UTF-8', 04:20:39 INFO - 'LANGUAGE': 'en_US:en', 04:20:39 INFO - 'LOGNAME': 'cltbld', 04:20:39 INFO - 'MAIL': '/var/mail/cltbld', 04:20:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:39 INFO - 'MOZ_NO_REMOTE': '1', 04:20:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:39 INFO - 'NO_EM_RESTART': '1', 04:20:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:39 INFO - 'PWD': '/builds/slave/test', 04:20:39 INFO - 'SHELL': '/bin/bash', 04:20:39 INFO - 'SHLVL': '1', 04:20:39 INFO - 'TERM': 'linux', 04:20:39 INFO - 'TMOUT': '86400', 04:20:39 INFO - 'USER': 'cltbld', 04:20:39 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1475232790.869015-665102860', 04:20:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:39 INFO - '_': '/tools/buildbot/bin/python'} 04:20:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:20:39 INFO - Cleaning up... 04:20:39 INFO - Return code: 0 04:20:39 INFO - Running post-action listener: _resource_record_post_action 04:20:39 INFO - Running post-action listener: _start_resource_monitoring 04:20:39 INFO - Starting resource monitoring. 04:20:39 INFO - [mozharness: 2016-09-30 11:20:39.949870Z] Finished create-virtualenv step (success) 04:20:39 INFO - [mozharness: 2016-09-30 11:20:39.950880Z] Running install step. 04:20:39 INFO - Running pre-action listener: _resource_record_pre_action 04:20:39 INFO - Running main action method: install 04:20:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:20:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:20:40 INFO - Reading from file tmpfile_stdout 04:20:40 INFO - Detecting whether we're running mozinstall >=1.0... 04:20:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:20:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:20:40 INFO - Reading from file tmpfile_stdout 04:20:40 INFO - Output received: 04:20:40 INFO - Usage: mozinstall [options] installer 04:20:40 INFO - Options: 04:20:40 INFO - -h, --help show this help message and exit 04:20:40 INFO - -d DEST, --destination=DEST 04:20:40 INFO - Directory to install application into. [default: 04:20:40 INFO - "/builds/slave/test"] 04:20:40 INFO - --app=APP Application being installed. [default: firefox] 04:20:40 INFO - mkdir: /builds/slave/test/build/application 04:20:40 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'] 04:20:40 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 04:20:56 INFO - Reading from file tmpfile_stdout 04:20:56 INFO - Output received: 04:20:56 INFO - /builds/slave/test/build/application/firefox/firefox 04:20:56 INFO - Running post-action listener: _resource_record_post_action 04:20:56 INFO - [mozharness: 2016-09-30 11:20:56.360085Z] Finished install step (success) 04:20:56 INFO - [mozharness: 2016-09-30 11:20:56.360331Z] Running run-tests step. 04:20:56 INFO - Running pre-action listener: _resource_record_pre_action 04:20:56 INFO - Running main action method: run_tests 04:20:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:20:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:20:56 INFO - Python 2.7.3 04:20:56 INFO - Return code: 0 04:20:56 INFO - grabbing minidump binary from tooltool 04:20:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:20:56 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2240f60>, '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 0x2241d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22421d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:20:56 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:20:56 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:20:56 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 04:20:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:20:56 INFO - Return code: 0 04:20:56 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:20:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:20:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:20:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:20:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:20:56 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/S6cNpLi2TnaUUhiidnk5gw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 04:20:56 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/S6cNpLi2TnaUUhiidnk5gw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-020 --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 04:20:56 INFO - Using env: {'DISPLAY': ':0', 04:20:56 INFO - 'HOME': '/home/cltbld', 04:20:56 INFO - 'LANG': 'en_US.UTF-8', 04:20:56 INFO - 'LANGUAGE': 'en_US:en', 04:20:56 INFO - 'LOGNAME': 'cltbld', 04:20:56 INFO - 'MAIL': '/var/mail/cltbld', 04:20:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:20:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:20:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:56 INFO - 'MOZ_NO_REMOTE': '1', 04:20:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:20:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:56 INFO - 'NO_EM_RESTART': '1', 04:20:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:56 INFO - 'PWD': '/builds/slave/test', 04:20:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:20:56 INFO - 'SHELL': '/bin/bash', 04:20:56 INFO - 'SHLVL': '1', 04:20:56 INFO - 'TERM': 'linux', 04:20:56 INFO - 'TMOUT': '86400', 04:20:56 INFO - 'USER': 'cltbld', 04:20:56 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1475232790.869015-665102860', 04:20:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:56 INFO - '_': '/tools/buildbot/bin/python'} 04:20:56 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/S6cNpLi2TnaUUhiidnk5gw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 04:20:57 INFO - mozversion application_buildid: 20160930025920 04:20:57 INFO - mozversion application_changeset: 6f31b67533799bd84fe3b207681bcef2c78dac47 04:20:57 INFO - mozversion application_display_name: Nightly 04:20:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:20:57 INFO - mozversion application_name: Firefox 04:20:57 INFO - mozversion application_remotingname: firefox 04:20:57 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:20:57 INFO - mozversion application_vendor: Mozilla 04:20:57 INFO - mozversion application_version: 52.0a1 04:20:57 INFO - mozversion platform_buildid: 20160930025920 04:20:57 INFO - mozversion platform_changeset: 6f31b67533799bd84fe3b207681bcef2c78dac47 04:20:57 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:20:57 INFO - mozversion platform_version: 52.0a1 04:20:57 INFO - using testdate: 1475234457 04:20:57 INFO - actual date: 1475234457 04:20:57 INFO - starting webserver on 'localhost:33272' 04:20:57 INFO - SUITE-START | Running 2 tests 04:20:57 INFO - TEST-START | dromaeo_css 04:20:57 INFO - operating with platform_type : linux_ 04:20:57 INFO - Initialising browser for dromaeo_css test... 04:20:57 INFO - TEST-INFO | started process 3348 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp28hdBg/profile http://localhost:33272/getInfo.html) 04:21:06 INFO - PROCESS | 3348 | __metrics Screen width/height:1600/1200 04:21:06 INFO - PROCESS | 3348 | colorDepth:24 04:21:06 INFO - PROCESS | 3348 | Browser inner width/height: 1024/697 04:21:06 INFO - PROCESS | 3348 | __metrics 04:21:06 INFO - PROCESS | 3348 | 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" 04:21:06 INFO - PROCESS | 3348 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:21:07 INFO - PROCESS | 3348 | console.error: PushService: 04:21:07 INFO - PROCESS | 3348 | stateChangeProcessEnqueue: Error transitioning state 04:21:07 INFO - PROCESS | 3348 | UnknownError 04:21:08 INFO - TEST-INFO | 3348: exit 0 04:21:08 INFO - Browser initialized. 04:21:08 INFO - Running cycle 1/1 for dromaeo_css test... 04:21:08 INFO - TEST-INFO | started process 3432 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp28hdBg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:21:20 INFO - PROCESS | 3432 | RSS: Main: 175448064 04:21:20 INFO - PROCESS | 3432 | 04:22:11 INFO - PROCESS | 3432 | 1475234531994 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:24:24 INFO - PROCESS | 3432 | Cycle 1(1): loaded http://localhost:33272/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33272/tests/dromaeo/cssquery-ext.html) 04:24:26 INFO - PROCESS | 3432 | RSS: Main: 324411392 04:24:26 INFO - PROCESS | 3432 | 04:27:28 INFO - PROCESS | 3432 | Cycle 1(1): loaded http://localhost:33272/tests/dromaeo/cssquery-ext.html (next: http://localhost:33272/tests/dromaeo/cssquery-jquery.html) 04:27:29 INFO - PROCESS | 3432 | RSS: Main: 287887360 04:27:29 INFO - PROCESS | 3432 | 04:30:31 INFO - PROCESS | 3432 | Cycle 1(1): loaded http://localhost:33272/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33272/tests/dromaeo/cssquery-mootools.html) 04:30:32 INFO - PROCESS | 3432 | RSS: Main: 221302784 04:30:32 INFO - PROCESS | 3432 | 04:33:34 INFO - PROCESS | 3432 | Cycle 1(1): loaded http://localhost:33272/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33272/tests/dromaeo/cssquery-prototype.html) 04:33:35 INFO - PROCESS | 3432 | RSS: Main: 241946624 04:33:35 INFO - PROCESS | 3432 | 04:36:38 INFO - PROCESS | 3432 | Cycle 1(1): loaded http://localhost:33272/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33272/tests/dromaeo/cssquery-yui.html) 04:36:38 INFO - PROCESS | 3432 | RSS: Main: 220790784 04:36:38 INFO - PROCESS | 3432 | 04:39:42 INFO - PROCESS | 3432 | Cycle 1(1): loaded http://localhost:33272/tests/dromaeo/cssquery-yui.html (next: http://localhost:33272/tests/dromaeo/cssquery-dojo.html) 04:39:42 INFO - PROCESS | 3432 | RSS: Main: 326131712 04:39:42 INFO - PROCESS | 3432 | 04:39:42 INFO - PROCESS | 3432 | __start_tp_report 04:39:42 INFO - PROCESS | 3432 | _x_x_mozilla_page_load 04:39:42 INFO - PROCESS | 3432 | _x_x_mozilla_page_load_details 04:39:42 INFO - PROCESS | 3432 | |i|pagename|runs| 04:39:42 INFO - PROCESS | 3432 | |0;dojo.html;2542.8855701493435;2557.5907854743245;2601.297649634598;2606.1269474725964;2620.908268210612;4342.3052311630145;4418.182636212303;4496.370508128861;4506.707064040839;4521.321801729738;4449.755263460508;4496.437945256843;4554.612857907082;4564.155631208228;4603.355530225771;4174.436451079111;4195.62239398454;4245.023644561753;4274.380214868842;4277;4271.743695378272;4283.37891005804;4310.430545888433;4330.372096046071;4368.912621747563;4154.5222299435645;4282.400463935051;4299.333603291495;4307.741535507879;4399.252127138394;4188.28799104153;4190.727602705814;4195.664346852244;4242.172776308621;4247.617714405687;4201.411802347674;4201.4538110045805;4208.032152604918;4259.382389553529;4265.424167737347;4544.8863778405475;4552.977235113836;4580.977095114503;4581.060882519076;4626.097910907374;4801.495842936476;4841.419029716457;4877.146499362633;4920.606351491872;4980.452150263468;4942.159832828428;4948.752562371867;4960.578350840183;4962.578180854595;4965.652404331662;4593.150267200579;4605.723656580616;4649.930251046237;4657.184992626277;4658.836940707059;5023.49765023502;5035.597152227813;5036.949630503721;5044.646874718735;5099;4825.5898248649255;4839.516048395132;4841.9031619367415;4845.854624361275;4846.079244943449;4753.524647535219;4782.210935195653;4785.425748910153;4890.486498917634;4919.581835544019;4886.29148773433;4896.2655601660035;4906.484819094015;4951.282064100686;4962.776675049631;4885.6335774817035;4900.436524547008;4901.681390709664;4903.950960490421;4953.8513844583995;4024.3561030235023;4099.426080348753;4111.013356794408;4150.626443620089;4154.875353739392;3614.801185934746;3651.6713495785507;3655.8354874030733;3657.1771351445714;3715.479832823407;4242.809073591696;4246.044639956047;4247.5964783345535;4293.549177336335;4303.1178608385835;4849.078675051729;4897.902041959141;4985.950140498621;4988.476209997971;4995.775190116454;4191.643710284599;4204.8528301509305;4219.957800421957;4235.301175306102;4290.2921018031675;4420.624246938982;4439.866803995886;4443.488998765119;4446.822127114944;4504.07666428388;4595.47152077502;4671.719696818202;4681.133990211685;4686.742229177428;4726.196546587088;4890.242012487928;4901.044296362175;4918.901621967469;4926.531979461945;4974.9502504975935;4656.068786242698;4657.417822772153;4667.556582124693;4696.0607878425135;4712.246040633482;4868.2210846264425;4868.926966095582;4878.9512104878495;4883.706977581356;4934.55588996992;4862.05189987949;4907.754612269444;4915.361003069578;4918.877028074184;4943.8516844494725;4724.811007559659;4730.172219861579;4744.715317080986;4823.855284341475;4835.6131509479865;4805.087033463631;4817.397825271841;4817.638677099301;4818.855434336975;4859.902801944012;4744.240921452551;4749.881252968704;4755.2153894607;4759.571638552547;4806.327114204084;4723.33873257751;4775.140474714584;4818.373611430492;4852.17513022794;4859.538343857328;4682.742449165328;4729.645276604199;4766.618670506282;4818.229083346648;4828.517148285144 04:39:42 INFO - PROCESS | 3432 | |1;ext.html;548.3365128194883;579.3250862744902;580.4079838564663;583.3320847629461;586.1647152807249;28042.158735237925;37798.811005945;38951.41572876402;39016.414753778714;42632;39262.21475570487;39708.205835883266;39732.602673973255;39802.800985995105;39854.40218396719;7614.086309642837;7752.302292793647;7756.922430775677;7764.417668674843;7768.611569421535;7614.428917831185;7686.500377475474;7703.961480192591;7705.383569314441;7706.306432421081;7664.578448185348;7730.652120654556;7732.922670773277;7737.767866964;7742.303192712655;7646.694132234704;7678.577678227695;7686.385089192851;7688.5386876787015;7688.577128257972;7598.126215485235;7599.962000189964;7684.577348245844;7688;7688.077430708351;37064.62935370639;37355.43966840499;37376.25247495062;37425.43861842075;37478.625213747786;3013.9095827125;3120.7035331643683;3254.2840575073446;3262.7226685731503;3667.963320366789;27072.45855082907;27305.590416143772;27701.307467313276;27725.306867328276;28773;3162.16202706283;3192.4892017277357;3293.670632936711;3296.604407471095;3355.1612096975755;242655;243340;244294.99999999822;244553;244825;30211.69788302089;49485.75257123692;49813;49873.25190122151;49934.75032624886;30918;32855.67144328574;32857;32859.3428131436;32885.83557082247;12063.457144428347;12271.38643067843;12278.693032674255;12281.631551053482;12286.139970202179;9702.126808587262;9878.259130565237;9886.456244906456;9888.20894328452;9889.159421449114;7683.807904802425;7693.6922523099565;7774.533527988338;7777.222277772177;7778.649960751666;3020.1392603108447;3067.9079627610763;3068.9232769180503;3080.4455198064115;3109.2638478139093;798.700487317256;868.6699054359303;925.7407925780792;928.0116675740315;946.9195118415012;26239.73760262373;26557;27447.451050979267;27766.778657707335;27805.582916256273;887.2591386192472;927.5918595817818;964.4550828781715;1005.3565717940523;1028.1517747858047;13528;14312;14519.491817786538;14661.560153195422;14752.483663071742;357261;359407;359833;361019;361862;47458;47955;47966.5203347969;47974.28038579424;48041.75979120082;1078.6009176604707;1092.7432053467428;1121.8765935747224;1143.302585422908;1151.3609946479785;26029.6095558563;27348.316292092062;28004.439911201254;28605.570916435852;28632.71367286384;39705.60294397019;40292.79853600713;40317.193656126125;40346;40354;290992;293468;293889.38603901886;294541;294727;22139.446513837283;22726.090956362223;23810.761892380855;24526;24700.876495617405;39293.607063929;39293.803530982164;39673.801630991664;40290.395644064774;41012.58987410088;33747.493787593696;33901.3219735599;33906.32187356288;33980;34091.488627671104;33135.83432082824;33323.500147497325;33621;33784.66215337913;34411.65588344084;34296;34499;34574.48138277877;34733.826330868185;35005.82497087498;27481.45037099207;27748.97639842252;32163;32164.19589510281;32466;23824.761752382256;24571.877140614182;24634.753652463245;24700.876495617405;25091.87454062718 04:39:42 INFO - PROCESS | 3432 | |2;jquery.html;339.9071983572813;349.83033228884005;351.9014675890751;357.33000623830327;378.2642759832126;12441.937790311047;15690.372385104596;16055;16496.670066598675;17448.82551174488;16909.1545422729;17146.485605431826;17163.656726865454;17219.91390043048;17332.913335433335;3946.9737868154343;5048.419431765348;5224.738763061831;5265.078611243036;5273.077211487994;4923.18767403378;5014.774335154909;5017.122003649365;5018.949810501903;5026.095302845486;4844.297576851354;5003.824866129687;5011.84964451067;5016.974915125437;5109.463506331837;5052.7726252318735;5087.872803179913;5088.363954505687;5093.923591146136;5098.26075219093;4349.739015659039;4601.608863246628;4603.608693261077;4613.76931153441;4617.8152873885;20434.489137771525;20542.486437839023;20667.379978600515;20773.16907323705;20794.16823327065;1815.5007372972407;1907.1322548240516;1992.9601407971759;2224.7552769195377;2387.4866903615634;12566.183198092094;12636.178648387826;12673.873261267361;13305.933470332684;13311.733765324736;1617.5228307649154;1636.1246732997788;1676.4467725650627;1712.546175263556;1727.2400143936627;70932;71387.49029831469;71703;71839;72268.6386568069;8892.955535222283;8969.820603587892;9036.32227582934;9644.132028117503;9668.323217374716;13099.541516047084;13102.868971310356;13117.672058198621;13121.212727236396;13140;6653.966730166415;6796.898046529306;6957.65211739411;6974.825629359307;7042.61265630385;6385.457236134887;6395.936040639627;6457.644829534421;6587.269075903994;6654.168228971379;5873.471387575053;6006.519478441714;6030.125631783367;6035.2154219952;6189.597676151036;1725.30125299254;1731.1171302635746;1740.2864825421516;1752.9211185496683;1801.2434777393264;818.4966245758816;827.962741676626;838.5681374092347;900.2842740021698;926.009170187906;17003.39117304874;17112.748577770184;17491.912540437217;17960.640787184184;18254.54363640893;823.7183299631288;862.2067697718114;865.2213008292587;866.956652167389;908.4413085952224;9198.172164505228;9547.856782148274;9658.517074146404;10273.332233404804;10457;385651;386633;391621;396299;397377;80225;81034;82155.5892220535;82245.58877205575;82366;392.7172435846243;408.63223099210353;410.1857812242696;412.15919524170954;412.397899067365;9228.215601673934;9511.857322140035;9597.184239339455;9775;9815.656452024145;33492.66507334895;33519.16202094967;33972;34357;37998;48118.51881481281;48442;48895.5110448891;49330;51999.480005200974;7356.66894989716;7398.075240594926;7423.257674232749;7561.054868141482;7585.431092668182;11668.88331116712;11781.941090294493;12031.578894738643;12147.574834880737;12492.188007779465;10197.13324367437;10296.433696146783;10368.118709909742;10508.579656813641;10690.358578485315;4656.115338085753;8139.860419541387;8386.245237928615;10029.29794914349;10734.946325268324;9807.803843922939;9889.604415823287;10193.694189174337;10445.791084178425;10710.143188545053;7358.1538123116525;7396.778096657109;7483.064616922885;7537.54774713519;7584.127825300161;9431.339806213498;9674.22606191489;9697.272704547328;10016.549255283384;10645.574177032831 04:39:42 INFO - PROCESS | 3432 | |3;mootools.html;1230.3294704386108;1341.0880601191193;1381.2334154544228;1434.4477376210164;1674.355373181325;6272.466840318572;7216.639168041596;7510.924890751091;7511.624418779066;7520.887186692197;7223.349898509133;7294.489385743;7299.306565876246;7304.3426091651745;7305.305995930391;2054.5479994401285;2066.152877320299;2076.14877900061;2077.854550181488;2079.9896000519975;2036.9694454583193;2049.938501844947;2053.537953960362;2060.7836177201402;2072.202202152175;2036.205879706908;2057.9897100514477;2060.103854823157;2063.659496183128;2071.8031786980287;2015.2845739762467;2023.3525271912847;2024.1397406102421;2028.6855537391727;2035.9694604580943;2013.3859172952243;2032.9288474903308;2051.4358551398336;2066.2354928676486;2069.5240094778133;7283.3809126223805;7400.592967386791;7411.925880741232;7415.221401752846;7415.295546923034;4334.696571240014;4468.173387923212;4473.597376236155;4477.70894891831;4481.887952801173;2611.556035473974;2705.8917643294244;2726.291164297277;2730.317420644839;2737.2335745991154;869.5217630303308;883.5052370672444;884.8893888263967;1648.4807285704965;1667.908265045422;9913.504324783731;9954.5022748863;9977.75055623608;10032.79934401308;10034.247431442598;3644.835982380799;3719.2189640175325;3727.589965103836;3807.8667246646787;3839.3665045267776;7886.763397098096;7887.369010479148;7891.921080789233;7894;7896.052473703192;4215.831366745358;4222.239996800606;4222.894427639334;4226.5139508956245;4227.598378154071;3540.362734707726;3654.744167908274;3907.3943538751537;3962.128331767007;3967.0479085019388;3019.833909134975;3062.3109800294756;3192.77078324842;3196.840157992091;3204.535342375389;904.8733177355175;906.0758026812614;907.7912080221586;915.3043686798081;916.6562539047857;643.5430844100741;703.8170075780334;769.3691173237892;790.5454363740872;811.111832543364;4794.9280760788615;4819.518048195152;4884;4920.458749537548;4975.875603109879;361.8624922529422;388.5900375104292;388.76868263383244;390.6406106382135;395.2352198495862;3225.5806745123455;3227.725643320297;3239.49787782894;3277.3281477297096;3377.4427219508507;8681.913180868236;8946.552672366355;9009.414388064755;9047.050059743764;9049.230815380635;9086.136817002374;9096.636134554676;9099.681511147079;9102.362834601647;9107.134822191882;6974.546654467545;7052.471064670171;7053.682584283617;7055.506114571931;7056.047433596399;4776.21192503233;4870.756462176806;4997.85006449807;5021.121303771898;5159.922601160911;7979.72070977513;8174.182581741778;8312.667493300441;8358.916410835815;8361.372897032625;8394;8480.10958849312;8531.91468085336;8550.657973680984;8643.913560864563;5680.545556355564;6332.588381755356;6444.097826304227;6455.709493072917;6457.580257283262;6392.360763923571;6437.259715132633;6564.343565643589;6608.273089960197;7034.226235114031;6237.75048998035;6309.1167236586;6414.358564143735;6584.901226481511;6617.404433600999;6503.089567460464;6570.441512471302;6586.2755096940255;6587.440067594116;6591.604503729792;5690.943090569207;5799.739011744397;5802.448767367094;5804.129380592776;5806.129080637938;4163.97918010408;4248.553901840386;4295.24833154203;4329.631981281626;4445.466544014739;4019.397090436458;4021.8592349267633;4066.4916885389325;4119.608637179464;4151.315033019639 04:39:42 INFO - PROCESS | 3432 | |4;prototype.html;276.2940686545876;281.3304335681079;289.77687180870714;290.77029146973894;292.11052345607624;4518.661100417466;4641.210994130997;4669.136209801185;4744.478107408187;4767.475577686451;4489.102179564092;4610.308453731942;4616.515265897083;4639.489656137831;4675.649326300524;3782.2624588205313;3786.110264087937;3791.071187559052;3791.6208379162;3794.3359912015426;3524.524189234459;3651.434027725707;3783.1109689223013;3790.6209379062147;3800.4679344891597;3627.510286111381;3705.925881482369;3721.3301605710963;3728.813559322037;3744.588095309514;3716;3720.720945929066;3731.440283957401;3738.6259725074774;3754.455603937414;3301.092199645093;3301.2077101495706;3302.1909632140278;3304.5373647689344;3305.1241421023446;4529.116822219668;4591.173588754023;4613.077384523075;4632.7802177486665;4651.3488111664055;4252.510961239466;4260.829566817323;4261.446012018418;4268.59448352406;4270.871873843789;4957.727324997124;4974.278729584226;4974.830914735035;4981.227909674007;4982.932083185474;3326.3513614845115;3499.020274323168;3587.157018100744;3592.4790905318846;3605.2789442111684;5193.37679478465;5203.4016088149965;5218;5225.399079105876;5227.189785583203;3591.51514545533;3596.604373518911;3598.8560457581925;3599;3604.9098772530897;3610.6028336882923;3611.837467313977;3631.763935344194;3639.8180090995343;3642.1805093853673;3928.8821335359985;4102.733322334098;4139.627433530996;4139.937900931488;4145.098431098243;4955.380577427822;4958.7024778513405;4962.73450270186;4966.15575352191;4967.130752118437;1154.677893811581;1183.798754211786;1219.9817002744967;1229.280870690638;1243.272685478987;845.8858054162732;846.1707526623943;864.7158968931133;865.1089377940731;865.2861389353683;4321.611055005064;4336.588024137702;4342.524760886327;4343.478782546114;4347.782650828691;5081.339425874613;5086.516780905808;5101.362329708786;5108.540231379194;5111.108889710757;4340.392345071693;4349.543297953669;4352.608265256142;4357.7385356878685;4363.258246098171;2327.8486898351553;2383.07060246504;2412.915547955813;2417.6373543968193;2421.5278020785777;4281.993731473101;4292.252958106814;4296.3555466680245;4302.483701955785;4324.891877703019;4619.214733495314;4620.214563524209;4621.128442980598;4639.396878405853;4657.5575320344515;4289.914201715948;4296.98041920297;4540.592416350942;4907.705537667752;4913.287573301923;5200.245964335226;5213.895722085613;5220.843374698765;5223.876866473574;5229.294045303835;5124.538791508782;5139.948600513947;5145.228215767665;5146.279520867007;5147.433782284021;4646.210144275549;4855.902881942412;4890.559849613552;4892.510748925079;4936.308916751729;3613.530241068644;3626.474161246552;3627.401478755976;3633.7638053526434;3642.927141457209;5179.792808287626;5181.689098654093;5182.455842136521;5187.766550505312;5188.118019936695;4657.371254880548;4809.687370320918;4866.902661946812;4986.401631804207;5008.173651347487;5036.84889453317;5042.697438153723;5042.9243561345875;5057.924131137962;5058.02736932604;4857.8299759508245;4990.575801056951;4995.500449954975;4997.475265097112;4999.175136102503;4997.725125118153;5031.471695472069;5068.467810879952;5097.770600323069;5100.974495127501;4975.726335051462;4986.753311672082;4986.975065124651;4988.42633097184;4990.1516742154645 04:39:42 INFO - PROCESS | 3432 | |5;yui.html;589.383178310699;644.1529388853654;645.9547831651785;657.2244751193592;664.232811103176;11862.228955117922;12837.1014029018;12842.678933026678;12887.355632218387;12918.224906505617;12208.633740987785;12334.136610437274;12345;12363.629091127257;12369.505219791221;614.8063360041594;631.1321932343028;729.212450553401;734.3501001613571;755.1165136789969;728.5483000539673;751.5302935665209;751.7105914223009;752.0674363788917;754.7320701151094;798.6086817459432;803.6865622407266;806.6612022950345;808.8584497712906;809.1908091908092;643.2152773616181;656.7504348347645;753.2467532467532;794.5550491724653;796.6056801883047;570.4666137161767;575.1803679756372;575.3699698829774;576.0869022599186;576.2652617912196;12333.013358931354;12343.814842777365;12381.876181238253;12393.814092788616;12409.689757756038;11293.548258069668;11407.714807129889;11569.53721851125;11654.76690466186;12295.446704898211;9096.63613455461;9302.511040003206;11355.943220283845;11461.713457163554;11657.533698652043;3968.265870813909;3997.34043882759;4016.4176194451934;4026.577209393001;4096.6649010064275;58376;59129.704351478395;59473.83683142182;59511.70244148751;59532.404675953556;9026.729198124067;9225.907740922505;9355.48544830041;9434.433933963985;9725.6596019139;16199.595010124842;16290.42983495572;16437.178141092896;16456.67086658284;16485.093319867283;6376.266729326094;6515.315891831289;6516.185476815398;6637.369449902251;6743.39309462141;3525.9647403525637;3527.647235276503;3640.3629364861044;3684.7604905681046;3699.648533389324;2615.320016795647;2732.4808286425514;2733;2735.6717193936456;2736.808423410382;488.9291052797396;514.2029853726708;520.2040877457496;526.9604779641542;527.4672580693527;487.52466345313036;565.8415643619793;594.135532799784;623.3953065526432;631.5831551176293;7567.848643027109;7576.886346704804;8189.754307370788;8390.412671112963;8542.402031857835;512.8358925143918;520.3833457353048;543.2367523629307;623.5416968528128;628.5694299404922;3836.657169990481;3901.6293452122004;4171.10321280926;4247.17180149874;4512.842050528216;95552.52223738837;99185;100373.49813250887;102246;107019.46490267654;85977;86402.27195456182;86813;88298.61163189486;91624;75757;76950;76951.61524192343;78301;78655;8140.470869393471;8333.37499687538;8414.368922330726;8464.068952415106;8602.956985215034;35708.28583428369;36333;38276.80861595785;39367.212655747295;45067.32399014083;37489.625103748614;37905.62094379021;49535.504644953086;57060.71469642625;58662;10883.836742449028;11045.171612128961;11265.155113366694;11903.571571411487;12066;11802.881971180179;12357.749479783577;13240.20558766477;13498.59504214875;13949.16305021702;9498.667546635834;11389.202755807013;11531.373584229088;11679.941600291944;12513.874861251272;11731.47208375608;11967.162298639012;12283.69290767738;12347.073969452147;12355.62933112008;9540.379875308083;9762.121409072934;10397.740056498647;10700.785984280115;10709.946450267698;10169.9491502542;10202.795944081225;10390.53207120915;10649.840252396376;10715.374733190418;9299.953500232456;9923.35498192644;10397.376157430579;10449.738756531147;10460.686179414326 04:39:42 INFO - PROCESS | 3432 | __end_tp_report 04:39:42 INFO - PROCESS | 3432 | __start_cc_report 04:39:42 INFO - PROCESS | 3432 | _x_x_mozilla_cycle_collect,1355 04:39:42 INFO - PROCESS | 3432 | __end_cc_report 04:39:42 INFO - PROCESS | 3432 | __startTimestamp1475235582284__endTimestamp 04:39:42 INFO - PROCESS | 3432 | 04:39:42 INFO - PROCESS | 3432 | ------- Summary: start ------- 04:39:42 INFO - PROCESS | 3432 | Number of tests: 6 04:39:42 INFO - PROCESS | 3432 | 04:39:42 INFO - PROCESS | 3432 | [#0] dojo.html Cycles:165 Average:4548.49 Median:4686.74 stddev:473.49 (10.1%) stddev-sans-first:448.04 04:39:42 INFO - PROCESS | 3432 | Values: 2542.9 2557.6 2601.3 2606.1 2620.9 4342.3 4418.2 4496.4 4506.7 4521.3 4449.8 4496.4 4554.6 4564.2 4603.4 4174.4 4195.6 4245.0 4274.4 4277.0 4271.7 4283.4 4310.4 4330.4 4368.9 4154.5 4282.4 4299.3 4307.7 4399.3 4188.3 4190.7 4195.7 4242.2 4247.6 4201.4 4201.5 4208.0 4259.4 4265.4 4544.9 4553.0 4581.0 4581.1 4626.1 4801.5 4841.4 4877.1 4920.6 4980.5 4942.2 4948.8 4960.6 4962.6 4965.7 4593.2 4605.7 4649.9 4657.2 4658.8 5023.5 5035.6 5036.9 5044.6 5099.0 4825.6 4839.5 4841.9 4845.9 4846.1 4753.5 4782.2 4785.4 4890.5 4919.6 4886.3 4896.3 4906.5 4951.3 4962.8 4885.6 4900.4 4901.7 4904.0 4953.9 4024.4 4099.4 4111.0 4150.6 4154.9 3614.8 3651.7 3655.8 3657.2 3715.5 4242.8 4246.0 4247.6 4293.5 4303.1 4849.1 4897.9 4986.0 4988.5 4995.8 4191.6 4204.9 4220.0 4235.3 4290.3 4420.6 4439.9 4443.5 4446.8 4504.1 4595.5 4671.7 4681.1 4686.7 4726.2 4890.2 4901.0 4918.9 4926.5 4975.0 4656.1 4657.4 4667.6 4696.1 4712.2 4868.2 4868.9 4879.0 4883.7 4934.6 4862.1 4907.8 4915.4 4918.9 4943.9 4724.8 4730.2 4744.7 4823.9 4835.6 4805.1 4817.4 4817.6 4818.9 4859.9 4744.2 4749.9 4755.2 4759.6 4806.3 4723.3 4775.1 4818.4 4852.2 4859.5 4682.7 4729.6 4766.6 4818.2 4828.5 04:39:42 INFO - PROCESS | 3432 | 04:39:42 INFO - PROCESS | 3432 | [#1] ext.html Cycles:180 Average:43808.69 Median:34654.15 stddev:79783.46 (230.2%) stddev-sans-first:79941.15 04:39:42 INFO - PROCESS | 3432 | Values: 548.3 579.3 580.4 583.3 586.2 28042.2 37798.8 38951.4 39016.4 42632.0 39262.2 39708.2 39732.6 39802.8 39854.4 7614.1 7752.3 7756.9 7764.4 7768.6 7614.4 7686.5 7704.0 7705.4 7706.3 7664.6 7730.7 7732.9 7737.8 7742.3 7646.7 7678.6 7686.4 7688.5 7688.6 7598.1 7600.0 7684.6 7688.0 7688.1 37064.6 37355.4 37376.3 37425.4 37478.6 3013.9 3120.7 3254.3 3262.7 3668.0 27072.5 27305.6 27701.3 27725.3 28773.0 3162.2 3192.5 3293.7 3296.6 3355.2 242655.0 243340.0 244295.0 244553.0 244825.0 30211.7 49485.8 49813.0 49873.3 49934.8 30918.0 32855.7 32857.0 32859.3 32885.8 12063.5 12271.4 12278.7 12281.6 12286.1 9702.1 9878.3 9886.5 9888.2 9889.2 7683.8 7693.7 7774.5 7777.2 7778.6 3020.1 3067.9 3068.9 3080.4 3109.3 798.7 868.7 925.7 928.0 946.9 26239.7 26557.0 27447.5 27766.8 27805.6 887.3 927.6 964.5 1005.4 1028.2 13528.0 14312.0 14519.5 14661.6 14752.5 357261.0 359407.0 359833.0 361019.0 361862.0 47458.0 47955.0 47966.5 47974.3 48041.8 1078.6 1092.7 1121.9 1143.3 1151.4 26029.6 27348.3 28004.4 28605.6 28632.7 39705.6 40292.8 40317.2 40346.0 40354.0 290992.0 293468.0 293889.4 294541.0 294727.0 22139.4 22726.1 23810.8 24526.0 24700.9 39293.6 39293.8 39673.8 40290.4 41012.6 33747.5 33901.3 33906.3 33980.0 34091.5 33135.8 33323.5 33621.0 33784.7 34411.7 34296.0 34499.0 34574.5 34733.8 35005.8 27481.5 27749.0 32163.0 32164.2 32466.0 23824.8 24571.9 24634.8 24700.9 25091.9 04:39:42 INFO - PROCESS | 3432 | 04:39:42 INFO - PROCESS | 3432 | [#2] jquery.html Cycles:180 Average:24229.83 Median:26387.32 stddev:64815.29 (245.6%) stddev-sans-first:64972.29 04:39:42 INFO - PROCESS | 3432 | Values: 339.9 349.8 351.9 357.3 378.3 12441.9 15690.4 16055.0 16496.7 17448.8 16909.2 17146.5 17163.7 17219.9 17332.9 3947.0 5048.4 5224.7 5265.1 5273.1 4923.2 5014.8 5017.1 5018.9 5026.1 4844.3 5003.8 5011.8 5017.0 5109.5 5052.8 5087.9 5088.4 5093.9 5098.3 4349.7 4601.6 4603.6 4613.8 4617.8 20434.5 20542.5 20667.4 20773.2 20794.2 1815.5 1907.1 1993.0 2224.8 2387.5 12566.2 12636.2 12673.9 13305.9 13311.7 1617.5 1636.1 1676.4 1712.5 1727.2 70932.0 71387.5 71703.0 71839.0 72268.6 8893.0 8969.8 9036.3 9644.1 9668.3 13099.5 13102.9 13117.7 13121.2 13140.0 6654.0 6796.9 6957.7 6974.8 7042.6 6385.5 6395.9 6457.6 6587.3 6654.2 5873.5 6006.5 6030.1 6035.2 6189.6 1725.3 1731.1 1740.3 1752.9 1801.2 818.5 828.0 838.6 900.3 926.0 17003.4 17112.7 17491.9 17960.6 18254.5 823.7 862.2 865.2 867.0 908.4 9198.2 9547.9 9658.5 10273.3 10457.0 385651.0 386633.0 391621.0 396299.0 397377.0 80225.0 81034.0 82155.6 82245.6 82366.0 392.7 408.6 410.2 412.2 412.4 9228.2 9511.9 9597.2 9775.0 9815.7 33492.7 33519.2 33972.0 34357.0 37998.0 48118.5 48442.0 48895.5 49330.0 51999.5 7356.7 7398.1 7423.3 7561.1 7585.4 11668.9 11781.9 12031.6 12147.6 12492.2 10197.1 10296.4 10368.1 10508.6 10690.4 4656.1 8139.9 8386.2 10029.3 10734.9 9807.8 9889.6 10193.7 10445.8 10710.1 7358.2 7396.8 7483.1 7537.5 7584.1 9431.3 9674.2 9697.3 10016.5 10645.6 04:39:42 INFO - PROCESS | 3432 | 04:39:42 INFO - PROCESS | 3432 | [#3] mootools.html Cycles:180 Average:4769.45 Median:4986.86 stddev:2697.56 (54.1%) stddev-sans-first:2692.01 04:39:42 INFO - PROCESS | 3432 | Values: 1230.3 1341.1 1381.2 1434.4 1674.4 6272.5 7216.6 7510.9 7511.6 7520.9 7223.3 7294.5 7299.3 7304.3 7305.3 2054.5 2066.2 2076.1 2077.9 2080.0 2037.0 2049.9 2053.5 2060.8 2072.2 2036.2 2058.0 2060.1 2063.7 2071.8 2015.3 2023.4 2024.1 2028.7 2036.0 2013.4 2032.9 2051.4 2066.2 2069.5 7283.4 7400.6 7411.9 7415.2 7415.3 4334.7 4468.2 4473.6 4477.7 4481.9 2611.6 2705.9 2726.3 2730.3 2737.2 869.5 883.5 884.9 1648.5 1667.9 9913.5 9954.5 9977.8 10032.8 10034.2 3644.8 3719.2 3727.6 3807.9 3839.4 7886.8 7887.4 7891.9 7894.0 7896.1 4215.8 4222.2 4222.9 4226.5 4227.6 3540.4 3654.7 3907.4 3962.1 3967.0 3019.8 3062.3 3192.8 3196.8 3204.5 904.9 906.1 907.8 915.3 916.7 643.5 703.8 769.4 790.5 811.1 4794.9 4819.5 4884.0 4920.5 4975.9 361.9 388.6 388.8 390.6 395.2 3225.6 3227.7 3239.5 3277.3 3377.4 8681.9 8946.6 9009.4 9047.1 9049.2 9086.1 9096.6 9099.7 9102.4 9107.1 6974.5 7052.5 7053.7 7055.5 7056.0 4776.2 4870.8 4997.9 5021.1 5159.9 7979.7 8174.2 8312.7 8358.9 8361.4 8394.0 8480.1 8531.9 8550.7 8643.9 5680.5 6332.6 6444.1 6455.7 6457.6 6392.4 6437.3 6564.3 6608.3 7034.2 6237.8 6309.1 6414.4 6584.9 6617.4 6503.1 6570.4 6586.3 6587.4 6591.6 5690.9 5799.7 5802.4 5804.1 5806.1 4164.0 4248.6 4295.2 4329.6 4445.5 4019.4 4021.9 4066.5 4119.6 4151.3 04:39:42 INFO - PROCESS | 3432 | 04:39:42 INFO - PROCESS | 3432 | [#4] prototype.html Cycles:180 Average:4093.41 Median:4565.88 stddev:1205.20 (26.4%) stddev-sans-first:1174.03 04:39:42 INFO - PROCESS | 3432 | Values: 276.3 281.3 289.8 290.8 292.1 4518.7 4641.2 4669.1 4744.5 4767.5 4489.1 4610.3 4616.5 4639.5 4675.6 3782.3 3786.1 3791.1 3791.6 3794.3 3524.5 3651.4 3783.1 3790.6 3800.5 3627.5 3705.9 3721.3 3728.8 3744.6 3716.0 3720.7 3731.4 3738.6 3754.5 3301.1 3301.2 3302.2 3304.5 3305.1 4529.1 4591.2 4613.1 4632.8 4651.3 4252.5 4260.8 4261.4 4268.6 4270.9 4957.7 4974.3 4974.8 4981.2 4982.9 3326.4 3499.0 3587.2 3592.5 3605.3 5193.4 5203.4 5218.0 5225.4 5227.2 3591.5 3596.6 3598.9 3599.0 3604.9 3610.6 3611.8 3631.8 3639.8 3642.2 3928.9 4102.7 4139.6 4139.9 4145.1 4955.4 4958.7 4962.7 4966.2 4967.1 1154.7 1183.8 1220.0 1229.3 1243.3 845.9 846.2 864.7 865.1 865.3 4321.6 4336.6 4342.5 4343.5 4347.8 5081.3 5086.5 5101.4 5108.5 5111.1 4340.4 4349.5 4352.6 4357.7 4363.3 2327.8 2383.1 2412.9 2417.6 2421.5 4282.0 4292.3 4296.4 4302.5 4324.9 4619.2 4620.2 4621.1 4639.4 4657.6 4289.9 4297.0 4540.6 4907.7 4913.3 5200.2 5213.9 5220.8 5223.9 5229.3 5124.5 5139.9 5145.2 5146.3 5147.4 4646.2 4855.9 4890.6 4892.5 4936.3 3613.5 3626.5 3627.4 3633.8 3642.9 5179.8 5181.7 5182.5 5187.8 5188.1 4657.4 4809.7 4866.9 4986.4 5008.2 5036.8 5042.7 5042.9 5057.9 5058.0 4857.8 4990.6 4995.5 4997.5 4999.2 4997.7 5031.5 5068.5 5097.8 5101.0 4975.7 4986.8 4987.0 4988.4 4990.2 04:39:42 INFO - PROCESS | 3432 | 04:39:42 INFO - PROCESS | 3432 | [#5] yui.html Cycles:180 Average:17210.31 Median:25024.17 stddev:25266.56 (101.0%) stddev-sans-first:25306.61 04:39:42 INFO - PROCESS | 3432 | Values: 589.4 644.2 646.0 657.2 664.2 11862.2 12837.1 12842.7 12887.4 12918.2 12208.6 12334.1 12345.0 12363.6 12369.5 614.8 631.1 729.2 734.4 755.1 728.5 751.5 751.7 752.1 754.7 798.6 803.7 806.7 808.9 809.2 643.2 656.8 753.2 794.6 796.6 570.5 575.2 575.4 576.1 576.3 12333.0 12343.8 12381.9 12393.8 12409.7 11293.5 11407.7 11569.5 11654.8 12295.4 9096.6 9302.5 11355.9 11461.7 11657.5 3968.3 3997.3 4016.4 4026.6 4096.7 58376.0 59129.7 59473.8 59511.7 59532.4 9026.7 9225.9 9355.5 9434.4 9725.7 16199.6 16290.4 16437.2 16456.7 16485.1 6376.3 6515.3 6516.2 6637.4 6743.4 3526.0 3527.6 3640.4 3684.8 3699.6 2615.3 2732.5 2733.0 2735.7 2736.8 488.9 514.2 520.2 527.0 527.5 487.5 565.8 594.1 623.4 631.6 7567.8 7576.9 8189.8 8390.4 8542.4 512.8 520.4 543.2 623.5 628.6 3836.7 3901.6 4171.1 4247.2 4512.8 95552.5 99185.0 100373.5 102246.0 107019.5 85977.0 86402.3 86813.0 88298.6 91624.0 75757.0 76950.0 76951.6 78301.0 78655.0 8140.5 8333.4 8414.4 8464.1 8603.0 35708.3 36333.0 38276.8 39367.2 45067.3 37489.6 37905.6 49535.5 57060.7 58662.0 10883.8 11045.2 11265.2 11903.6 12066.0 11802.9 12357.7 13240.2 13498.6 13949.2 9498.7 11389.2 11531.4 11679.9 12513.9 11731.5 11967.2 12283.7 12347.1 12355.6 9540.4 9762.1 10397.7 10700.8 10709.9 10169.9 10202.8 10390.5 10649.8 10715.4 9300.0 9923.4 10397.4 10449.7 10460.7 04:39:42 INFO - PROCESS | 3432 | -------- Summary: end -------- 04:39:42 INFO - PROCESS | 3432 | 04:39:43 INFO - TEST-INFO | 3432: exit 0 04:39:43 INFO - TEST-OK | dromaeo_css | took 1126263ms 04:39:43 INFO - TEST-START | kraken 04:39:43 INFO - operating with platform_type : linux_ 04:39:43 INFO - Initialising browser for kraken test... 04:39:43 INFO - TEST-INFO | started process 3736 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCXKEN1/profile http://localhost:33272/getInfo.html) 04:39:48 INFO - PROCESS | 3736 | __metrics Screen width/height:1600/1200 04:39:48 INFO - PROCESS | 3736 | colorDepth:24 04:39:48 INFO - PROCESS | 3736 | Browser inner width/height: 1024/697 04:39:48 INFO - PROCESS | 3736 | __metrics 04:39:49 INFO - PROCESS | 3736 | 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" 04:39:49 INFO - PROCESS | 3736 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:39:49 INFO - PROCESS | 3736 | console.error: PushService: 04:39:49 INFO - PROCESS | 3736 | stateChangeProcessEnqueue: Error transitioning state 04:39:49 INFO - PROCESS | 3736 | UnknownError 04:39:50 INFO - TEST-INFO | 3736: exit 0 04:39:50 INFO - Browser initialized. 04:39:50 INFO - Running cycle 1/1 for kraken test... 04:39:50 INFO - TEST-INFO | started process 3820 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCXKEN1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:40:02 INFO - PROCESS | 3820 | RSS: Main: 175013888 04:40:02 INFO - PROCESS | 3820 | 04:40:05 INFO - PROCESS | 3820 | Cycle 1(1): loaded http://localhost:33272/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33272/tests/kraken/driver.html?testName=audio-beat-detection) 04:40:06 INFO - PROCESS | 3820 | RSS: Main: 233857024 04:40:06 INFO - PROCESS | 3820 | 04:40:09 INFO - PROCESS | 3820 | Cycle 1(1): loaded http://localhost:33272/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33272/tests/kraken/driver.html?testName=audio-dft) 04:40:09 INFO - PROCESS | 3820 | RSS: Main: 217907200 04:40:09 INFO - PROCESS | 3820 | 04:40:12 INFO - PROCESS | 3820 | Cycle 1(1): loaded http://localhost:33272/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33272/tests/kraken/driver.html?testName=audio-fft) 04:40:13 INFO - PROCESS | 3820 | RSS: Main: 299982848 04:40:13 INFO - PROCESS | 3820 | 04:40:15 INFO - PROCESS | 3820 | Cycle 1(1): loaded http://localhost:33272/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33272/tests/kraken/driver.html?testName=audio-oscillator) 04:40:16 INFO - PROCESS | 3820 | RSS: Main: 209940480 04:40:16 INFO - PROCESS | 3820 | 04:40:18 INFO - PROCESS | 3820 | Cycle 1(1): loaded http://localhost:33272/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33272/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:40:19 INFO - PROCESS | 3820 | RSS: Main: 213516288 04:40:19 INFO - PROCESS | 3820 | 04:40:22 INFO - PROCESS | 3820 | Cycle 1(1): loaded http://localhost:33272/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33272/tests/kraken/driver.html?testName=imaging-darkroom) 04:40:23 INFO - PROCESS | 3820 | RSS: Main: 250204160 04:40:23 INFO - PROCESS | 3820 | 04:40:26 INFO - PROCESS | 3820 | Cycle 1(1): loaded http://localhost:33272/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33272/tests/kraken/driver.html?testName=imaging-desaturate) 04:40:27 INFO - PROCESS | 3820 | RSS: Main: 244510720 04:40:27 INFO - PROCESS | 3820 | 04:40:30 INFO - PROCESS | 3820 | Cycle 1(1): loaded http://localhost:33272/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33272/tests/kraken/driver.html?testName=json-parse-financial) 04:40:30 INFO - PROCESS | 3820 | RSS: Main: 247672832 04:40:30 INFO - PROCESS | 3820 | 04:40:32 INFO - PROCESS | 3820 | Cycle 1(1): loaded http://localhost:33272/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33272/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:40:33 INFO - PROCESS | 3820 | RSS: Main: 210604032 04:40:33 INFO - PROCESS | 3820 | 04:40:34 INFO - PROCESS | 3820 | Cycle 1(1): loaded http://localhost:33272/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33272/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:40:35 INFO - PROCESS | 3820 | RSS: Main: 218546176 04:40:35 INFO - PROCESS | 3820 | 04:40:38 INFO - PROCESS | 3820 | Cycle 1(1): loaded http://localhost:33272/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33272/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:40:38 INFO - PROCESS | 3820 | RSS: Main: 222572544 04:40:38 INFO - PROCESS | 3820 | 04:40:41 INFO - PROCESS | 3820 | Cycle 1(1): loaded http://localhost:33272/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:40:41 INFO - PROCESS | 3820 | RSS: Main: 222838784 04:40:41 INFO - PROCESS | 3820 | 04:40:44 INFO - PROCESS | 3820 | Cycle 1(1): loaded http://localhost:33272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:40:45 INFO - PROCESS | 3820 | RSS: Main: 221286400 04:40:45 INFO - PROCESS | 3820 | 04:40:47 INFO - PROCESS | 3820 | Cycle 1(1): loaded http://localhost:33272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33272/tests/kraken/driver.html?testName=ai-astar) 04:40:47 INFO - PROCESS | 3820 | RSS: Main: 272650240 04:40:47 INFO - PROCESS | 3820 | 04:40:47 INFO - PROCESS | 3820 | __start_tp_report 04:40:47 INFO - PROCESS | 3820 | _x_x_mozilla_page_load 04:40:47 INFO - PROCESS | 3820 | _x_x_mozilla_page_load_details 04:40:47 INFO - PROCESS | 3820 | |i|pagename|runs| 04:40:47 INFO - PROCESS | 3820 | |0;ai-astar;110;114;113;116;114;115;114;115;115;113 04:40:47 INFO - PROCESS | 3820 | |1;audio-beat-detection;153;131;123;162;127;122;125;122;163;123 04:40:47 INFO - PROCESS | 3820 | |2;audio-dft;163;161;161;162;162;161;160;161;160;161 04:40:47 INFO - PROCESS | 3820 | |3;audio-fft;76;76;82;112;77;76;76;75;100;77 04:40:47 INFO - PROCESS | 3820 | |4;audio-oscillator;84;83;122;85;83;84;110;84;84;114 04:40:47 INFO - PROCESS | 3820 | |5;imaging-gaussian-blur;118;117;116;117;117;117;117;117;117;117 04:40:47 INFO - PROCESS | 3820 | |6;imaging-darkroom;147;147;146;147;147;147;146;146;146;145 04:40:47 INFO - PROCESS | 3820 | |7;imaging-desaturate;96;95;94;94;95;95;95;95;95;95 04:40:47 INFO - PROCESS | 3820 | |8;json-parse-financial;64;63;64;63;65;65;65;66;65;65 04:40:47 INFO - PROCESS | 3820 | |9;json-stringify-tinderbox;66;67;66;67;66;66;67;66;67;68 04:40:47 INFO - PROCESS | 3820 | |10;stanford-crypto-aes;83;83;83;82;89;82;82;83;88;82 04:40:47 INFO - PROCESS | 3820 | |11;stanford-crypto-ccm;138;132;132;132;131;134;131;132;174;132 04:40:47 INFO - PROCESS | 3820 | |12;stanford-crypto-pbkdf2;173;171;175;173;173;172;171;170;174;171 04:40:47 INFO - PROCESS | 3820 | |13;stanford-crypto-sha256-iterative;71;68;69;69;69;68;71;68;68;69 04:40:47 INFO - PROCESS | 3820 | __end_tp_report 04:40:47 INFO - PROCESS | 3820 | __start_cc_report 04:40:47 INFO - PROCESS | 3820 | _x_x_mozilla_cycle_collect,1921 04:40:47 INFO - PROCESS | 3820 | __end_cc_report 04:40:47 INFO - PROCESS | 3820 | __startTimestamp1475235647498__endTimestamp 04:40:47 INFO - PROCESS | 3820 | 04:40:47 INFO - PROCESS | 3820 | ------- Summary: start ------- 04:40:47 INFO - PROCESS | 3820 | Number of tests: 14 04:40:47 INFO - PROCESS | 3820 | 04:40:47 INFO - PROCESS | 3820 | [#0] ai-astar Cycles:10 Average:113.90 Median:114.50 stddev:1.66 (1.5%) stddev-sans-first:1.00 04:40:47 INFO - PROCESS | 3820 | Values: 110.0 114.0 113.0 116.0 114.0 115.0 114.0 115.0 115.0 113.0 04:40:47 INFO - PROCESS | 3820 | 04:40:47 INFO - PROCESS | 3820 | [#1] audio-beat-detection Cycles:10 Average:135.10 Median:129.00 stddev:17.14 (13.3%) stddev-sans-first:16.91 04:40:47 INFO - PROCESS | 3820 | Values: 153.0 131.0 123.0 162.0 127.0 122.0 125.0 122.0 163.0 123.0 04:40:47 INFO - PROCESS | 3820 | 04:40:47 INFO - PROCESS | 3820 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:0.92 (0.6%) stddev-sans-first:0.71 04:40:47 INFO - PROCESS | 3820 | Values: 163.0 161.0 161.0 162.0 162.0 161.0 160.0 161.0 160.0 161.0 04:40:47 INFO - PROCESS | 3820 | 04:40:47 INFO - PROCESS | 3820 | [#3] audio-fft Cycles:10 Average:82.70 Median:76.00 stddev:12.75 (16.8%) stddev-sans-first:13.29 04:40:47 INFO - PROCESS | 3820 | Values: 76.0 76.0 82.0 112.0 77.0 76.0 76.0 75.0 100.0 77.0 04:40:47 INFO - PROCESS | 3820 | 04:40:47 INFO - PROCESS | 3820 | [#4] audio-oscillator Cycles:10 Average:93.30 Median:84.00 stddev:15.49 (18.4%) stddev-sans-first:16.05 04:40:47 INFO - PROCESS | 3820 | Values: 84.0 83.0 122.0 85.0 83.0 84.0 110.0 84.0 84.0 114.0 04:40:47 INFO - PROCESS | 3820 | 04:40:47 INFO - PROCESS | 3820 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.33 04:40:47 INFO - PROCESS | 3820 | Values: 118.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 04:40:47 INFO - PROCESS | 3820 | 04:40:47 INFO - PROCESS | 3820 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 04:40:47 INFO - PROCESS | 3820 | Values: 147.0 147.0 146.0 147.0 147.0 147.0 146.0 146.0 146.0 145.0 04:40:47 INFO - PROCESS | 3820 | 04:40:47 INFO - PROCESS | 3820 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.44 04:40:47 INFO - PROCESS | 3820 | Values: 96.0 95.0 94.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 04:40:47 INFO - PROCESS | 3820 | 04:40:47 INFO - PROCESS | 3820 | [#8] json-parse-financial Cycles:10 Average:64.50 Median:65.00 stddev:0.97 (1.5%) stddev-sans-first:1.01 04:40:47 INFO - PROCESS | 3820 | Values: 64.0 63.0 64.0 63.0 65.0 65.0 65.0 66.0 65.0 65.0 04:40:47 INFO - PROCESS | 3820 | 04:40:47 INFO - PROCESS | 3820 | [#9] json-stringify-tinderbox Cycles:10 Average:66.60 Median:67.00 stddev:0.70 (1.0%) stddev-sans-first:0.71 04:40:47 INFO - PROCESS | 3820 | Values: 66.0 67.0 66.0 67.0 66.0 66.0 67.0 66.0 67.0 68.0 04:40:47 INFO - PROCESS | 3820 | 04:40:47 INFO - PROCESS | 3820 | [#10] stanford-crypto-aes Cycles:10 Average:83.70 Median:83.00 stddev:2.58 (3.1%) stddev-sans-first:2.73 04:40:47 INFO - PROCESS | 3820 | Values: 83.0 83.0 83.0 82.0 89.0 82.0 82.0 83.0 88.0 82.0 04:40:47 INFO - PROCESS | 3820 | 04:40:47 INFO - PROCESS | 3820 | [#11] stanford-crypto-ccm Cycles:10 Average:136.80 Median:132.00 stddev:13.23 (10.0%) stddev-sans-first:14.03 04:40:47 INFO - PROCESS | 3820 | Values: 138.0 132.0 132.0 132.0 131.0 134.0 131.0 132.0 174.0 132.0 04:40:47 INFO - PROCESS | 3820 | 04:40:47 INFO - PROCESS | 3820 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.30 Median:173.00 stddev:1.57 (0.9%) stddev-sans-first:1.64 04:40:47 INFO - PROCESS | 3820 | Values: 173.0 171.0 175.0 173.0 173.0 172.0 171.0 170.0 174.0 171.0 04:40:47 INFO - PROCESS | 3820 | 04:40:47 INFO - PROCESS | 3820 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:69.00 stddev:1.15 (1.7%) stddev-sans-first:0.97 04:40:47 INFO - PROCESS | 3820 | Values: 71.0 68.0 69.0 69.0 69.0 68.0 71.0 68.0 68.0 69.0 04:40:47 INFO - PROCESS | 3820 | -------- Summary: end -------- 04:40:47 INFO - PROCESS | 3820 | 04:40:48 INFO - TEST-INFO | 3820: exit 0 04:40:48 INFO - TEST-OK | kraken | took 65540ms 04:40:48 INFO - SUITE-END | took 1191s 04:40:49 INFO - Completed test suite (00:19:52) 04:40:49 INFO - javascript benchmark 04:40:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2542.8855701493435, 2557.5907854743245, 2601.297649634598, 2606.1269474725964, 2620.908268210612, 4342.3052311630145, 4418.182636212303, 4496.370508128861, 4506.707064040839, 4521.321801729738, 4449.755263460508, 4496.437945256843, 4554.612857907082, 4564.155631208228, 4603.355530225771, 4174.436451079111, 4195.62239398454, 4245.023644561753, 4274.380214868842, 4277.0, 4271.743695378272, 4283.37891005804, 4310.430545888433, 4330.372096046071, 4368.912621747563, 4154.5222299435645, 4282.400463935051, 4299.333603291495, 4307.741535507879, 4399.252127138394, 4188.28799104153, 4190.727602705814, 4195.664346852244, 4242.172776308621, 4247.617714405687, 4201.411802347674, 4201.4538110045805, 4208.032152604918, 4259.382389553529, 4265.424167737347, 4544.8863778405475, 4552.977235113836, 4580.977095114503, 4581.060882519076, 4626.097910907374, 4801.495842936476, 4841.419029716457, 4877.146499362633, 4920.606351491872, 4980.452150263468, 4942.159832828428, 4948.752562371867, 4960.578350840183, 4962.578180854595, 4965.652404331662, 4593.150267200579, 4605.723656580616, 4649.930251046237, 4657.184992626277, 4658.836940707059, 5023.49765023502, 5035.597152227813, 5036.949630503721, 5044.646874718735, 5099.0, 4825.5898248649255, 4839.516048395132, 4841.9031619367415, 4845.854624361275, 4846.079244943449, 4753.524647535219, 4782.210935195653, 4785.425748910153, 4890.486498917634, 4919.581835544019, 4886.29148773433, 4896.2655601660035, 4906.484819094015, 4951.282064100686, 4962.776675049631, 4885.6335774817035, 4900.436524547008, 4901.681390709664, 4903.950960490421, 4953.8513844583995, 4024.3561030235023, 4099.426080348753, 4111.013356794408, 4150.626443620089, 4154.875353739392, 3614.801185934746, 3651.6713495785507, 3655.8354874030733, 3657.1771351445714, 3715.479832823407, 4242.809073591696, 4246.044639956047, 4247.5964783345535, 4293.549177336335, 4303.1178608385835, 4849.078675051729, 4897.902041959141, 4985.950140498621, 4988.476209997971, 4995.775190116454, 4191.643710284599, 4204.8528301509305, 4219.957800421957, 4235.301175306102, 4290.2921018031675, 4420.624246938982, 4439.866803995886, 4443.488998765119, 4446.822127114944, 4504.07666428388, 4595.47152077502, 4671.719696818202, 4681.133990211685, 4686.742229177428, 4726.196546587088, 4890.242012487928, 4901.044296362175, 4918.901621967469, 4926.531979461945, 4974.9502504975935, 4656.068786242698, 4657.417822772153, 4667.556582124693, 4696.0607878425135, 4712.246040633482, 4868.2210846264425, 4868.926966095582, 4878.9512104878495, 4883.706977581356, 4934.55588996992, 4862.05189987949, 4907.754612269444, 4915.361003069578, 4918.877028074184, 4943.8516844494725, 4724.811007559659, 4730.172219861579, 4744.715317080986, 4823.855284341475, 4835.6131509479865, 4805.087033463631, 4817.397825271841, 4817.638677099301, 4818.855434336975, 4859.902801944012, 4744.240921452551, 4749.881252968704, 4755.2153894607, 4759.571638552547, 4806.327114204084, 4723.33873257751, 4775.140474714584, 4818.373611430492, 4852.17513022794, 4859.538343857328, 4682.742449165328, 4729.645276604199, 4766.618670506282, 4818.229083346648, 4828.517148285144], "value": 4518.501858201952, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [548.3365128194883, 579.3250862744902, 580.4079838564663, 583.3320847629461, 586.1647152807249, 28042.158735237925, 37798.811005945, 38951.41572876402, 39016.414753778714, 42632.0, 39262.21475570487, 39708.205835883266, 39732.602673973255, 39802.800985995105, 39854.40218396719, 7614.086309642837, 7752.302292793647, 7756.922430775677, 7764.417668674843, 7768.611569421535, 7614.428917831185, 7686.500377475474, 7703.961480192591, 7705.383569314441, 7706.306432421081, 7664.578448185348, 7730.652120654556, 7732.922670773277, 7737.767866964, 7742.303192712655, 7646.694132234704, 7678.577678227695, 7686.385089192851, 7688.5386876787015, 7688.577128257972, 7598.126215485235, 7599.962000189964, 7684.577348245844, 7688.0, 7688.077430708351, 37064.62935370639, 37355.43966840499, 37376.25247495062, 37425.43861842075, 37478.625213747786, 3013.9095827125, 3120.7035331643683, 3254.2840575073446, 3262.7226685731503, 3667.963320366789, 27072.45855082907, 27305.590416143772, 27701.307467313276, 27725.306867328276, 28773.0, 3162.16202706283, 3192.4892017277357, 3293.670632936711, 3296.604407471095, 3355.1612096975755, 242655.0, 243340.0, 244294.99999999822, 244553.0, 244825.0, 30211.69788302089, 49485.75257123692, 49813.0, 49873.25190122151, 49934.75032624886, 30918.0, 32855.67144328574, 32857.0, 32859.3428131436, 32885.83557082247, 12063.457144428347, 12271.38643067843, 12278.693032674255, 12281.631551053482, 12286.139970202179, 9702.126808587262, 9878.259130565237, 9886.456244906456, 9888.20894328452, 9889.159421449114, 7683.807904802425, 7693.6922523099565, 7774.533527988338, 7777.222277772177, 7778.649960751666, 3020.1392603108447, 3067.9079627610763, 3068.9232769180503, 3080.4455198064115, 3109.2638478139093, 798.700487317256, 868.6699054359303, 925.7407925780792, 928.0116675740315, 946.9195118415012, 26239.73760262373, 26557.0, 27447.451050979267, 27766.778657707335, 27805.582916256273, 887.2591386192472, 927.5918595817818, 964.4550828781715, 1005.3565717940523, 1028.1517747858047, 13528.0, 14312.0, 14519.491817786538, 14661.560153195422, 14752.483663071742, 357261.0, 359407.0, 359833.0, 361019.0, 361862.0, 47458.0, 47955.0, 47966.5203347969, 47974.28038579424, 48041.75979120082, 1078.6009176604707, 1092.7432053467428, 1121.8765935747224, 1143.302585422908, 1151.3609946479785, 26029.6095558563, 27348.316292092062, 28004.439911201254, 28605.570916435852, 28632.71367286384, 39705.60294397019, 40292.79853600713, 40317.193656126125, 40346.0, 40354.0, 290992.0, 293468.0, 293889.38603901886, 294541.0, 294727.0, 22139.446513837283, 22726.090956362223, 23810.761892380855, 24526.0, 24700.876495617405, 39293.607063929, 39293.803530982164, 39673.801630991664, 40290.395644064774, 41012.58987410088, 33747.493787593696, 33901.3219735599, 33906.32187356288, 33980.0, 34091.488627671104, 33135.83432082824, 33323.500147497325, 33621.0, 33784.66215337913, 34411.65588344084, 34296.0, 34499.0, 34574.48138277877, 34733.826330868185, 35005.82497087498, 27481.45037099207, 27748.97639842252, 32163.0, 32164.19589510281, 32466.0, 23824.761752382256, 24571.877140614182, 24634.753652463245, 24700.876495617405, 25091.87454062718], "value": 15839.396132435953, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [339.9071983572813, 349.83033228884005, 351.9014675890751, 357.33000623830327, 378.2642759832126, 12441.937790311047, 15690.372385104596, 16055.0, 16496.670066598675, 17448.82551174488, 16909.1545422729, 17146.485605431826, 17163.656726865454, 17219.91390043048, 17332.913335433335, 3946.9737868154343, 5048.419431765348, 5224.738763061831, 5265.078611243036, 5273.077211487994, 4923.18767403378, 5014.774335154909, 5017.122003649365, 5018.949810501903, 5026.095302845486, 4844.297576851354, 5003.824866129687, 5011.84964451067, 5016.974915125437, 5109.463506331837, 5052.7726252318735, 5087.872803179913, 5088.363954505687, 5093.923591146136, 5098.26075219093, 4349.739015659039, 4601.608863246628, 4603.608693261077, 4613.76931153441, 4617.8152873885, 20434.489137771525, 20542.486437839023, 20667.379978600515, 20773.16907323705, 20794.16823327065, 1815.5007372972407, 1907.1322548240516, 1992.9601407971759, 2224.7552769195377, 2387.4866903615634, 12566.183198092094, 12636.178648387826, 12673.873261267361, 13305.933470332684, 13311.733765324736, 1617.5228307649154, 1636.1246732997788, 1676.4467725650627, 1712.546175263556, 1727.2400143936627, 70932.0, 71387.49029831469, 71703.0, 71839.0, 72268.6386568069, 8892.955535222283, 8969.820603587892, 9036.32227582934, 9644.132028117503, 9668.323217374716, 13099.541516047084, 13102.868971310356, 13117.672058198621, 13121.212727236396, 13140.0, 6653.966730166415, 6796.898046529306, 6957.65211739411, 6974.825629359307, 7042.61265630385, 6385.457236134887, 6395.936040639627, 6457.644829534421, 6587.269075903994, 6654.168228971379, 5873.471387575053, 6006.519478441714, 6030.125631783367, 6035.2154219952, 6189.597676151036, 1725.30125299254, 1731.1171302635746, 1740.2864825421516, 1752.9211185496683, 1801.2434777393264, 818.4966245758816, 827.962741676626, 838.5681374092347, 900.2842740021698, 926.009170187906, 17003.39117304874, 17112.748577770184, 17491.912540437217, 17960.640787184184, 18254.54363640893, 823.7183299631288, 862.2067697718114, 865.2213008292587, 866.956652167389, 908.4413085952224, 9198.172164505228, 9547.856782148274, 9658.517074146404, 10273.332233404804, 10457.0, 385651.0, 386633.0, 391621.0, 396299.0, 397377.0, 80225.0, 81034.0, 82155.5892220535, 82245.58877205575, 82366.0, 392.7172435846243, 408.63223099210353, 410.1857812242696, 412.15919524170954, 412.397899067365, 9228.215601673934, 9511.857322140035, 9597.184239339455, 9775.0, 9815.656452024145, 33492.66507334895, 33519.16202094967, 33972.0, 34357.0, 37998.0, 48118.51881481281, 48442.0, 48895.5110448891, 49330.0, 51999.480005200974, 7356.66894989716, 7398.075240594926, 7423.257674232749, 7561.054868141482, 7585.431092668182, 11668.88331116712, 11781.941090294493, 12031.578894738643, 12147.574834880737, 12492.188007779465, 10197.13324367437, 10296.433696146783, 10368.118709909742, 10508.579656813641, 10690.358578485315, 4656.115338085753, 8139.860419541387, 8386.245237928615, 10029.29794914349, 10734.946325268324, 9807.803843922939, 9889.604415823287, 10193.694189174337, 10445.791084178425, 10710.143188545053, 7358.1538123116525, 7396.778096657109, 7483.064616922885, 7537.54774713519, 7584.127825300161, 9431.339806213498, 9674.22606191489, 9697.272704547328, 10016.549255283384, 10645.574177032831], "value": 7856.082426690031, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1230.3294704386108, 1341.0880601191193, 1381.2334154544228, 1434.4477376210164, 1674.355373181325, 6272.466840318572, 7216.639168041596, 7510.924890751091, 7511.624418779066, 7520.887186692197, 7223.349898509133, 7294.489385743, 7299.306565876246, 7304.3426091651745, 7305.305995930391, 2054.5479994401285, 2066.152877320299, 2076.14877900061, 2077.854550181488, 2079.9896000519975, 2036.9694454583193, 2049.938501844947, 2053.537953960362, 2060.7836177201402, 2072.202202152175, 2036.205879706908, 2057.9897100514477, 2060.103854823157, 2063.659496183128, 2071.8031786980287, 2015.2845739762467, 2023.3525271912847, 2024.1397406102421, 2028.6855537391727, 2035.9694604580943, 2013.3859172952243, 2032.9288474903308, 2051.4358551398336, 2066.2354928676486, 2069.5240094778133, 7283.3809126223805, 7400.592967386791, 7411.925880741232, 7415.221401752846, 7415.295546923034, 4334.696571240014, 4468.173387923212, 4473.597376236155, 4477.70894891831, 4481.887952801173, 2611.556035473974, 2705.8917643294244, 2726.291164297277, 2730.317420644839, 2737.2335745991154, 869.5217630303308, 883.5052370672444, 884.8893888263967, 1648.4807285704965, 1667.908265045422, 9913.504324783731, 9954.5022748863, 9977.75055623608, 10032.79934401308, 10034.247431442598, 3644.835982380799, 3719.2189640175325, 3727.589965103836, 3807.8667246646787, 3839.3665045267776, 7886.763397098096, 7887.369010479148, 7891.921080789233, 7894.0, 7896.052473703192, 4215.831366745358, 4222.239996800606, 4222.894427639334, 4226.5139508956245, 4227.598378154071, 3540.362734707726, 3654.744167908274, 3907.3943538751537, 3962.128331767007, 3967.0479085019388, 3019.833909134975, 3062.3109800294756, 3192.77078324842, 3196.840157992091, 3204.535342375389, 904.8733177355175, 906.0758026812614, 907.7912080221586, 915.3043686798081, 916.6562539047857, 643.5430844100741, 703.8170075780334, 769.3691173237892, 790.5454363740872, 811.111832543364, 4794.9280760788615, 4819.518048195152, 4884.0, 4920.458749537548, 4975.875603109879, 361.8624922529422, 388.5900375104292, 388.76868263383244, 390.6406106382135, 395.2352198495862, 3225.5806745123455, 3227.725643320297, 3239.49787782894, 3277.3281477297096, 3377.4427219508507, 8681.913180868236, 8946.552672366355, 9009.414388064755, 9047.050059743764, 9049.230815380635, 9086.136817002374, 9096.636134554676, 9099.681511147079, 9102.362834601647, 9107.134822191882, 6974.546654467545, 7052.471064670171, 7053.682584283617, 7055.506114571931, 7056.047433596399, 4776.21192503233, 4870.756462176806, 4997.85006449807, 5021.121303771898, 5159.922601160911, 7979.72070977513, 8174.182581741778, 8312.667493300441, 8358.916410835815, 8361.372897032625, 8394.0, 8480.10958849312, 8531.91468085336, 8550.657973680984, 8643.913560864563, 5680.545556355564, 6332.588381755356, 6444.097826304227, 6455.709493072917, 6457.580257283262, 6392.360763923571, 6437.259715132633, 6564.343565643589, 6608.273089960197, 7034.226235114031, 6237.75048998035, 6309.1167236586, 6414.358564143735, 6584.901226481511, 6617.404433600999, 6503.089567460464, 6570.441512471302, 6586.2755096940255, 6587.440067594116, 6591.604503729792, 5690.943090569207, 5799.739011744397, 5802.448767367094, 5804.129380592776, 5806.129080637938, 4163.97918010408, 4248.553901840386, 4295.24833154203, 4329.631981281626, 4445.466544014739, 4019.397090436458, 4021.8592349267633, 4066.4916885389325, 4119.608637179464, 4151.315033019639], "value": 3781.5972595875983, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [276.2940686545876, 281.3304335681079, 289.77687180870714, 290.77029146973894, 292.11052345607624, 4518.661100417466, 4641.210994130997, 4669.136209801185, 4744.478107408187, 4767.475577686451, 4489.102179564092, 4610.308453731942, 4616.515265897083, 4639.489656137831, 4675.649326300524, 3782.2624588205313, 3786.110264087937, 3791.071187559052, 3791.6208379162, 3794.3359912015426, 3524.524189234459, 3651.434027725707, 3783.1109689223013, 3790.6209379062147, 3800.4679344891597, 3627.510286111381, 3705.925881482369, 3721.3301605710963, 3728.813559322037, 3744.588095309514, 3716.0, 3720.720945929066, 3731.440283957401, 3738.6259725074774, 3754.455603937414, 3301.092199645093, 3301.2077101495706, 3302.1909632140278, 3304.5373647689344, 3305.1241421023446, 4529.116822219668, 4591.173588754023, 4613.077384523075, 4632.7802177486665, 4651.3488111664055, 4252.510961239466, 4260.829566817323, 4261.446012018418, 4268.59448352406, 4270.871873843789, 4957.727324997124, 4974.278729584226, 4974.830914735035, 4981.227909674007, 4982.932083185474, 3326.3513614845115, 3499.020274323168, 3587.157018100744, 3592.4790905318846, 3605.2789442111684, 5193.37679478465, 5203.4016088149965, 5218.0, 5225.399079105876, 5227.189785583203, 3591.51514545533, 3596.604373518911, 3598.8560457581925, 3599.0, 3604.9098772530897, 3610.6028336882923, 3611.837467313977, 3631.763935344194, 3639.8180090995343, 3642.1805093853673, 3928.8821335359985, 4102.733322334098, 4139.627433530996, 4139.937900931488, 4145.098431098243, 4955.380577427822, 4958.7024778513405, 4962.73450270186, 4966.15575352191, 4967.130752118437, 1154.677893811581, 1183.798754211786, 1219.9817002744967, 1229.280870690638, 1243.272685478987, 845.8858054162732, 846.1707526623943, 864.7158968931133, 865.1089377940731, 865.2861389353683, 4321.611055005064, 4336.588024137702, 4342.524760886327, 4343.478782546114, 4347.782650828691, 5081.339425874613, 5086.516780905808, 5101.362329708786, 5108.540231379194, 5111.108889710757, 4340.392345071693, 4349.543297953669, 4352.608265256142, 4357.7385356878685, 4363.258246098171, 2327.8486898351553, 2383.07060246504, 2412.915547955813, 2417.6373543968193, 2421.5278020785777, 4281.993731473101, 4292.252958106814, 4296.3555466680245, 4302.483701955785, 4324.891877703019, 4619.214733495314, 4620.214563524209, 4621.128442980598, 4639.396878405853, 4657.5575320344515, 4289.914201715948, 4296.98041920297, 4540.592416350942, 4907.705537667752, 4913.287573301923, 5200.245964335226, 5213.895722085613, 5220.843374698765, 5223.876866473574, 5229.294045303835, 5124.538791508782, 5139.948600513947, 5145.228215767665, 5146.279520867007, 5147.433782284021, 4646.210144275549, 4855.902881942412, 4890.559849613552, 4892.510748925079, 4936.308916751729, 3613.530241068644, 3626.474161246552, 3627.401478755976, 3633.7638053526434, 3642.927141457209, 5179.792808287626, 5181.689098654093, 5182.455842136521, 5187.766550505312, 5188.118019936695, 4657.371254880548, 4809.687370320918, 4866.902661946812, 4986.401631804207, 5008.173651347487, 5036.84889453317, 5042.697438153723, 5042.9243561345875, 5057.924131137962, 5058.02736932604, 4857.8299759508245, 4990.575801056951, 4995.500449954975, 4997.475265097112, 4999.175136102503, 4997.725125118153, 5031.471695472069, 5068.467810879952, 5097.770600323069, 5100.974495127501, 4975.726335051462, 4986.753311672082, 4986.975065124651, 4988.42633097184, 4990.1516742154645], "value": 3707.991210623042, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [589.383178310699, 644.1529388853654, 645.9547831651785, 657.2244751193592, 664.232811103176, 11862.228955117922, 12837.1014029018, 12842.678933026678, 12887.355632218387, 12918.224906505617, 12208.633740987785, 12334.136610437274, 12345.0, 12363.629091127257, 12369.505219791221, 614.8063360041594, 631.1321932343028, 729.212450553401, 734.3501001613571, 755.1165136789969, 728.5483000539673, 751.5302935665209, 751.7105914223009, 752.0674363788917, 754.7320701151094, 798.6086817459432, 803.6865622407266, 806.6612022950345, 808.8584497712906, 809.1908091908092, 643.2152773616181, 656.7504348347645, 753.2467532467532, 794.5550491724653, 796.6056801883047, 570.4666137161767, 575.1803679756372, 575.3699698829774, 576.0869022599186, 576.2652617912196, 12333.013358931354, 12343.814842777365, 12381.876181238253, 12393.814092788616, 12409.689757756038, 11293.548258069668, 11407.714807129889, 11569.53721851125, 11654.76690466186, 12295.446704898211, 9096.63613455461, 9302.511040003206, 11355.943220283845, 11461.713457163554, 11657.533698652043, 3968.265870813909, 3997.34043882759, 4016.4176194451934, 4026.577209393001, 4096.6649010064275, 58376.0, 59129.704351478395, 59473.83683142182, 59511.70244148751, 59532.404675953556, 9026.729198124067, 9225.907740922505, 9355.48544830041, 9434.433933963985, 9725.6596019139, 16199.595010124842, 16290.42983495572, 16437.178141092896, 16456.67086658284, 16485.093319867283, 6376.266729326094, 6515.315891831289, 6516.185476815398, 6637.369449902251, 6743.39309462141, 3525.9647403525637, 3527.647235276503, 3640.3629364861044, 3684.7604905681046, 3699.648533389324, 2615.320016795647, 2732.4808286425514, 2733.0, 2735.6717193936456, 2736.808423410382, 488.9291052797396, 514.2029853726708, 520.2040877457496, 526.9604779641542, 527.4672580693527, 487.52466345313036, 565.8415643619793, 594.135532799784, 623.3953065526432, 631.5831551176293, 7567.848643027109, 7576.886346704804, 8189.754307370788, 8390.412671112963, 8542.402031857835, 512.8358925143918, 520.3833457353048, 543.2367523629307, 623.5416968528128, 628.5694299404922, 3836.657169990481, 3901.6293452122004, 4171.10321280926, 4247.17180149874, 4512.842050528216, 95552.52223738837, 99185.0, 100373.49813250887, 102246.0, 107019.46490267654, 85977.0, 86402.27195456182, 86813.0, 88298.61163189486, 91624.0, 75757.0, 76950.0, 76951.61524192343, 78301.0, 78655.0, 8140.470869393471, 8333.37499687538, 8414.368922330726, 8464.068952415106, 8602.956985215034, 35708.28583428369, 36333.0, 38276.80861595785, 39367.212655747295, 45067.32399014083, 37489.625103748614, 37905.62094379021, 49535.504644953086, 57060.71469642625, 58662.0, 10883.836742449028, 11045.171612128961, 11265.155113366694, 11903.571571411487, 12066.0, 11802.881971180179, 12357.749479783577, 13240.20558766477, 13498.59504214875, 13949.16305021702, 9498.667546635834, 11389.202755807013, 11531.373584229088, 11679.941600291944, 12513.874861251272, 11731.47208375608, 11967.162298639012, 12283.69290767738, 12347.073969452147, 12355.62933112008, 9540.379875308083, 9762.121409072934, 10397.740056498647, 10700.785984280115, 10709.946450267698, 10169.9491502542, 10202.795944081225, 10390.53207120915, 10649.840252396376, 10715.374733190418, 9299.953500232456, 9923.35498192644, 10397.376157430579, 10449.738756531147, 10460.686179414326], "value": 6360.126351699905, "unit": "score"}], "name": "dromaeo_css", "value": 6072.648313688067, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 114.0, 113.0, 116.0, 114.0, 115.0, 114.0, 115.0, 115.0, 113.0], "value": 113.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 131.0, 123.0, 162.0, 127.0, 122.0, 125.0, 122.0, 163.0, 123.0], "value": 135.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 161.0, 162.0, 162.0, 161.0, 160.0, 161.0, 160.0, 161.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 82.0, 112.0, 77.0, 76.0, 76.0, 75.0, 100.0, 77.0], "value": 82.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 122.0, 85.0, 83.0, 84.0, 110.0, 84.0, 84.0, 114.0], "value": 93.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 147.0, 147.0, 147.0, 146.0, 146.0, 146.0, 145.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 94.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 64.0, 63.0, 65.0, 65.0, 65.0, 66.0, 65.0, 65.0], "value": 64.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 66.0, 67.0, 66.0, 66.0, 67.0, 66.0, 67.0, 68.0], "value": 66.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 83.0, 82.0, 89.0, 82.0, 82.0, 83.0, 88.0, 82.0], "value": 83.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 132.0, 132.0, 132.0, 131.0, 134.0, 131.0, 132.0, 174.0, 132.0], "value": 136.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 171.0, 175.0, 173.0, 173.0, 172.0, 171.0, 170.0, 174.0, 171.0], "value": 172.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 68.0, 69.0, 69.0, 69.0, 68.0, 71.0, 68.0, 68.0, 69.0], "value": 69.0, "unit": "score"}], "name": "kraken", "value": 1537.3999999999999, "alertThreshold": 2.0}]} 04:40:49 INFO - Return code: 0 04:40:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:40:49 INFO - # TBPL SUCCESS # 04:40:49 INFO - Running post-action listener: _resource_record_post_action 04:40:49 INFO - [mozharness: 2016-09-30 11:40:49.312141Z] Finished run-tests step (success) 04:40:49 INFO - Running post-run listener: _resource_record_post_run 04:40:49 INFO - Total resource usage - Wall time: 1209s; CPU: 13.0%; Read bytes: 7843840; Write bytes: 415457280; Read time: 2532; Write time: 703124 04:40:49 INFO - TinderboxPrint: CPU usage
13.0% 04:40:49 INFO - TinderboxPrint: I/O read bytes / time
7,843,840 / 2,532 04:40:49 INFO - TinderboxPrint: I/O write bytes / time
415,457,280 / 703,124 04:40:49 INFO - TinderboxPrint: CPU idle
8,388.1 (86.9%) 04:40:49 INFO - TinderboxPrint: CPU user
1,200.9 (12.4%) 04:40:49 INFO - TinderboxPrint: Swap in / out
0 / 0 04:40:49 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 8974336; Read time: 0; Write time: 1408 04:40:49 INFO - run-tests - Wall time: 1193s; CPU: 13.0%; Read bytes: 5808128; Write bytes: 368197632; Read time: 2120; Write time: 658508 04:40:49 INFO - Running post-run listener: _upload_blobber_files 04:40:49 INFO - Blob upload gear active. 04:40:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:40:49 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 04:40:49 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'] 04:40:49 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 04:40:50 INFO - (blobuploader) - INFO - Open directory for files ... 04:40:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:40:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:40:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:40:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:40:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:40:53 INFO - (blobuploader) - INFO - Done attempting. 04:40:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:40:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:40:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:40:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:40:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:40:54 INFO - (blobuploader) - INFO - Done attempting. 04:40:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:40:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:40:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:40:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:40:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:40:55 INFO - (blobuploader) - INFO - Done attempting. 04:40:55 INFO - (blobuploader) - INFO - Iteration through files over. 04:40:55 INFO - Return code: 0 04:40:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:40:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:40:55 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8124427b2f4873864ada76f650044dee00ad307e5524fe975849334f5d479cfa2fb9c7168872f064e865fa71ed074179a206b5f4cad584334b87b3c019bdcfed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6780d225ffdf8fff323625897c1cb68e6a904ae2951267b862dff88e6cbb9940471faaec9aae6128d605e6868a35cfa65a192e6b1eeba81e1fbe2eaa4ae35a23", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6e873300962ae3c24de0a1cf6abad9a14d9cac9268974734424bd209efaad20337b7f016c2038b4abc010aa3f19e59f56efc67dc2e0269b54dcaab8e29f723d1"} 04:40:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:40:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:40:55 INFO - Contents: 04:40:55 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8124427b2f4873864ada76f650044dee00ad307e5524fe975849334f5d479cfa2fb9c7168872f064e865fa71ed074179a206b5f4cad584334b87b3c019bdcfed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6780d225ffdf8fff323625897c1cb68e6a904ae2951267b862dff88e6cbb9940471faaec9aae6128d605e6868a35cfa65a192e6b1eeba81e1fbe2eaa4ae35a23", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6e873300962ae3c24de0a1cf6abad9a14d9cac9268974734424bd209efaad20337b7f016c2038b4abc010aa3f19e59f56efc67dc2e0269b54dcaab8e29f723d1"} 04:40:55 INFO - Running post-run listener: copy_logs_to_upload_dir 04:40:55 INFO - Copying logs to upload dir... 04:40:55 INFO - mkdir: /builds/slave/test/build/upload/logs 04:40:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.599323 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-09-30 04:40:55.369093) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-30 04:40:55.372702) ========= 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=af724c981e2a0f424dbabf99000001e7-1475232790.869015-665102860 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/8124427b2f4873864ada76f650044dee00ad307e5524fe975849334f5d479cfa2fb9c7168872f064e865fa71ed074179a206b5f4cad584334b87b3c019bdcfed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6780d225ffdf8fff323625897c1cb68e6a904ae2951267b862dff88e6cbb9940471faaec9aae6128d605e6868a35cfa65a192e6b1eeba81e1fbe2eaa4ae35a23", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6e873300962ae3c24de0a1cf6abad9a14d9cac9268974734424bd209efaad20337b7f016c2038b4abc010aa3f19e59f56efc67dc2e0269b54dcaab8e29f723d1"} build_url:https://queue.taskcluster.net/v1/task/S6cNpLi2TnaUUhiidnk5gw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010971 build_url: 'https://queue.taskcluster.net/v1/task/S6cNpLi2TnaUUhiidnk5gw/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/8124427b2f4873864ada76f650044dee00ad307e5524fe975849334f5d479cfa2fb9c7168872f064e865fa71ed074179a206b5f4cad584334b87b3c019bdcfed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6780d225ffdf8fff323625897c1cb68e6a904ae2951267b862dff88e6cbb9940471faaec9aae6128d605e6868a35cfa65a192e6b1eeba81e1fbe2eaa4ae35a23", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6e873300962ae3c24de0a1cf6abad9a14d9cac9268974734424bd209efaad20337b7f016c2038b4abc010aa3f19e59f56efc67dc2e0269b54dcaab8e29f723d1"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-30 04:40:55.398407) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 04:40:55.398769) ========= 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=af724c981e2a0f424dbabf99000001e7-1475232790.869015-665102860 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004451 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 04:40:55.483624) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-30 04:40:55.483994) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-30 04:40:55.484396) ========= ========= Total master_lag: 0.21 =========