builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-030 starttime: 1483809336.86 results: success (0) buildid: 20170107073256 builduid: 6aeb6334eea3492897794b1e9920a0ed revision: 9a9493b6820804ccb4d2089f337179341b151133 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-07 09:15:36.858764) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-07 09:15:36.859231) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-07 09:15:36.859525) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-07 09:15:36.873806) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-07 09:15:36.874099) ========= 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=3836458cccd887f2d2de3cf1000001de-1483809336.140793-1983133787 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-07 09:15:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 112M=0s 2017-01-07 09:15:36 (112 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.088920 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-07 09:15:36.976380) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-07 09:15:36.976706) ========= 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=3836458cccd887f2d2de3cf1000001de-1483809336.140793-1983133787 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018103 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-07 09:15:37.026885) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-07 09:15:37.027269) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 9a9493b6820804ccb4d2089f337179341b151133 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 9a9493b6820804ccb4d2089f337179341b151133 --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=3836458cccd887f2d2de3cf1000001de-1483809336.140793-1983133787 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-07 09:15:37,104 truncating revision to first 12 chars 2017-01-07 09:15:37,104 Setting DEBUG logging. 2017-01-07 09:15:37,104 attempt 1/10 2017-01-07 09:15:37,104 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/9a9493b68208?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-07 09:15:37,683 unpacking tar archive at: mozilla-aurora-9a9493b68208/testing/mozharness/ program finished with exit code 0 elapsedTime=0.880380 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-07 09:15:37.921698) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-07 09:15:37.922021) ========= script_repo_revision: 9a9493b6820804ccb4d2089f337179341b151133 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-07 09:15:37.922417) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-07 09:15:37.922695) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-07 09:15:37.931362) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2017-01-07 09:15:37.931648) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=3836458cccd887f2d2de3cf1000001de-1483809336.140793-1983133787 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:15:38 INFO - MultiFileLogger online at 20170107 09:15:38 in /builds/slave/test 09:15:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 09:15:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:15:38 INFO - {'append_to_log': False, 09:15:38 INFO - 'base_work_dir': '/builds/slave/test', 09:15:38 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:15:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:15:38 INFO - 'branch': 'Mozilla-Aurora', 09:15:38 INFO - 'buildbot_json_path': 'buildprops.json', 09:15:38 INFO - 'config_files': ('talos/linux_config.py',), 09:15:38 INFO - 'default_actions': ('clobber', 09:15:38 INFO - 'read-buildbot-config', 09:15:38 INFO - 'download-and-extract', 09:15:38 INFO - 'populate-webroot', 09:15:38 INFO - 'create-virtualenv', 09:15:38 INFO - 'install', 09:15:38 INFO - 'run-tests'), 09:15:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:15:38 INFO - 'download_minidump_stackwalk': True, 09:15:38 INFO - 'download_symbols': 'ondemand', 09:15:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:15:38 INFO - 'tooltool.py': '/tools/tooltool.py', 09:15:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:15:38 INFO - '/tools/misc-python/virtualenv.py')}, 09:15:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:15:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:15:38 INFO - 'installer_path': 'installer.exe', 09:15:38 INFO - 'log_level': 'info', 09:15:38 INFO - 'log_name': 'talos', 09:15:38 INFO - 'log_to_console': True, 09:15:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:15:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:15:38 INFO - 'opt_config_files': (), 09:15:38 INFO - 'pip_index': False, 09:15:38 INFO - 'sps_profile': False, 09:15:38 INFO - 'sps_profile_interval': 0, 09:15:38 INFO - 'suite': 'dromaeojs-e10s', 09:15:38 INFO - 'system_bits': '32', 09:15:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:15:38 INFO - 'title': 'talos-linux64-ix-030', 09:15:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:15:38 INFO - 'use_talos_json': True, 09:15:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:15:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:15:38 INFO - 'work_dir': 'build'} 09:15:38 INFO - [mozharness: 2017-01-07 17:15:38.112311Z] Running clobber step. 09:15:38 INFO - Running pre-action listener: _resource_record_pre_action 09:15:38 INFO - Running main action method: clobber 09:15:38 INFO - rmtree: /builds/slave/test/build 09:15:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:15:39 INFO - Running post-action listener: _resource_record_post_action 09:15:39 INFO - [mozharness: 2017-01-07 17:15:39.074355Z] Finished clobber step (success) 09:15:39 INFO - [mozharness: 2017-01-07 17:15:39.074454Z] Running read-buildbot-config step. 09:15:39 INFO - Running pre-action listener: _resource_record_pre_action 09:15:39 INFO - Running main action method: read_buildbot_config 09:15:39 INFO - Using buildbot properties: 09:15:39 INFO - { 09:15:39 INFO - "project": "", 09:15:39 INFO - "product": "firefox", 09:15:39 INFO - "script_repo_revision": "production", 09:15:39 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 09:15:39 INFO - "repository": "", 09:15:39 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 09:15:39 INFO - "buildid": "20170107073256", 09:15:39 INFO - "pgo_build": "True", 09:15:39 INFO - "basedir": "/builds/slave/test", 09:15:39 INFO - "buildnumber": 794, 09:15:39 INFO - "slavename": "talos-linux64-ix-030", 09:15:39 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:15:39 INFO - "platform": "ubuntu64_hw", 09:15:39 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 09:15:39 INFO - "branch": "mozilla-aurora", 09:15:39 INFO - "repo_path": "releases/mozilla-aurora", 09:15:39 INFO - "revision": "9a9493b6820804ccb4d2089f337179341b151133", 09:15:39 INFO - "stage_platform": "linux64-pgo", 09:15:39 INFO - "builduid": "6aeb6334eea3492897794b1e9920a0ed", 09:15:39 INFO - "slavebuilddir": "test" 09:15:39 INFO - } 09:15:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/Q1l_5u-vRHummv2lizuMBg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 09:15:39 INFO - Running post-action listener: _resource_record_post_action 09:15:39 INFO - [mozharness: 2017-01-07 17:15:39.076883Z] Finished read-buildbot-config step (success) 09:15:39 INFO - [mozharness: 2017-01-07 17:15:39.076972Z] Running download-and-extract step. 09:15:39 INFO - Running pre-action listener: _resource_record_pre_action 09:15:39 INFO - Running main action method: download_and_extract 09:15:39 INFO - mkdir: /builds/slave/test/build/tests 09:15: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')]} 09:15:39 INFO - trying https://queue.taskcluster.net/v1/task/Q1l_5u-vRHummv2lizuMBg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 09:15:39 INFO - Downloading https://queue.taskcluster.net/v1/task/Q1l_5u-vRHummv2lizuMBg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 09:15:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q1l_5u-vRHummv2lizuMBg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:15:39 INFO - Downloaded 1361 bytes. 09:15:39 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 09:15:39 INFO - Using the following test package requirements: 09:15:39 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 09:15:39 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:15:39 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 09:15:39 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:15:39 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 09:15:39 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:15:39 INFO - u'jsshell-linux-x86_64.zip'], 09:15:39 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:15:39 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 09:15:39 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 09:15:39 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:15:39 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 09:15:39 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:15:39 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 09:15:39 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:15:39 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 09:15:39 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:15:39 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 09:15:39 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:15:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Q1l_5u-vRHummv2lizuMBg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 09:15:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q1l_5u-vRHummv2lizuMBg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:15:39 INFO - Fetch https://queue.taskcluster.net/v1/task/Q1l_5u-vRHummv2lizuMBg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 09:15:40 INFO - Http code: 200 09:15:40 INFO - via: 1.1 b9a8ce441329f20cea895e08f19f1ec8.cloudfront.net (CloudFront) 09:15:40 INFO - x-amz-cf-id: ZLxMN_X3q0do_hpPRG4ggF2lHOjlKhMi5dbJiHuEYh6ndFqKwDR-mw== 09:15:40 INFO - x-amz-version-id: OLZqfLKk7qFqqG_4AR7DNNUS0z43poFC 09:15:40 INFO - Expected file size: 21943198 09:15:40 INFO - Obtained file size: 21943198 09:15:44 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:15:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Q1l_5u-vRHummv2lizuMBg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 09:15:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q1l_5u-vRHummv2lizuMBg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:15:44 INFO - Fetch https://queue.taskcluster.net/v1/task/Q1l_5u-vRHummv2lizuMBg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 09:15:44 INFO - Http code: 200 09:15:44 INFO - via: 1.1 ccaa055c9a26ce13da709353563e04a5.cloudfront.net (CloudFront) 09:15:44 INFO - x-amz-cf-id: tEUZb5rXiNLP0eho22zKeE3swirBnsOh3Us5Gri0i5Q8w6ZrEgWa9A== 09:15:44 INFO - x-amz-version-id: OLZqfLKk7qFqqG_4AR7DNNUS0z43poFC 09:15:45 INFO - Expected file size: 21943198 09:15:45 INFO - Obtained file size: 21943198 09:15:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Q1l_5u-vRHummv2lizuMBg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 09:15:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q1l_5u-vRHummv2lizuMBg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:15:49 INFO - Fetch https://queue.taskcluster.net/v1/task/Q1l_5u-vRHummv2lizuMBg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 09:15:50 INFO - Http code: 200 09:15:50 INFO - via: 1.1 5ed093c37d643652e278a198e0556a40.cloudfront.net (CloudFront) 09:15:50 INFO - x-amz-cf-id: XNv41c0WyFf57LtfOgcmorLZ5Rc-qbyT5ae9TA7CNALArqgpB3M8eg== 09:15:50 INFO - x-amz-version-id: c8x.s4_jKqn4bFRoISJLNSyFwMampamQ 09:15:50 INFO - Expected file size: 14409038 09:15:50 INFO - Obtained file size: 14409038 09:15:50 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')]} 09:15:50 INFO - trying https://queue.taskcluster.net/v1/task/Q1l_5u-vRHummv2lizuMBg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 09:15:50 INFO - Downloading https://queue.taskcluster.net/v1/task/Q1l_5u-vRHummv2lizuMBg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 09:15:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q1l_5u-vRHummv2lizuMBg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:15:51 INFO - Downloaded 64064122 bytes. 09:15:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Q1l_5u-vRHummv2lizuMBg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 09:15:51 INFO - mkdir: /builds/slave/test/properties 09:15:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:15:51 INFO - Writing to file /builds/slave/test/properties/build_url 09:15:51 INFO - Contents: 09:15:51 INFO - build_url:https://queue.taskcluster.net/v1/task/Q1l_5u-vRHummv2lizuMBg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 09:15:52 INFO - Running post-action listener: _resource_record_post_action 09:15:52 INFO - Running post-action listener: set_extra_try_arguments 09:15:52 INFO - [mozharness: 2017-01-07 17:15:52.408480Z] Finished download-and-extract step (success) 09:15:52 INFO - [mozharness: 2017-01-07 17:15:52.408708Z] Running populate-webroot step. 09:15:52 INFO - Running pre-action listener: _resource_record_pre_action 09:15:52 INFO - Running main action method: populate_webroot 09:15:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:15:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:15:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:15:52 INFO - '--tppagecycles', 09:15:52 INFO - '7'], 09:15:52 INFO - 'tests': ['tsvgm']}}, 09:15:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:15:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:15:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:15:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:15:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:15:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:15:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:15:52 INFO - 'talos_options': ['--disable-e10s'], 09:15:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:15:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:15:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:15:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:15:52 INFO - 'talos_options': ['--disable-e10s'], 09:15:52 INFO - 'tests': ['damp', 'tps']}, 09:15:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:15:52 INFO - 'tests': ['damp', 'tps']}, 09:15:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:15:52 INFO - 'tests': ['dromaeo_dom']}, 09:15:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:15:52 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:15:52 INFO - 'tests': ['basic_compositor_video']}, 09:15:52 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:15:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:15:52 INFO - 'tests': ['a11yr', 09:15:52 INFO - 'ts_paint', 09:15:52 INFO - 'tpaint', 09:15:52 INFO - 'sessionrestore', 09:15:52 INFO - 'sessionrestore_no_auto_restore', 09:15:52 INFO - 'tabpaint']}, 09:15:52 INFO - 'other-e10s': {'tests': ['a11yr', 09:15:52 INFO - 'ts_paint', 09:15:52 INFO - 'tpaint', 09:15:52 INFO - 'sessionrestore', 09:15:52 INFO - 'sessionrestore_no_auto_restore', 09:15:52 INFO - 'tabpaint']}, 09:15:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:15:52 INFO - 'ts_paint', 09:15:52 INFO - 'tpaint', 09:15:52 INFO - 'sessionrestore', 09:15:52 INFO - 'sessionrestore_no_auto_restore', 09:15:52 INFO - 'tabpaint']}, 09:15:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:15:52 INFO - 'ts_paint', 09:15:52 INFO - 'tpaint', 09:15:52 INFO - 'sessionrestore', 09:15:52 INFO - 'sessionrestore_no_auto_restore', 09:15:52 INFO - 'tabpaint']}, 09:15:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:15:52 INFO - 'tests': ['a11yr', 09:15:52 INFO - 'ts_paint', 09:15:52 INFO - 'tpaint', 09:15:52 INFO - 'sessionrestore', 09:15:52 INFO - 'sessionrestore_no_auto_restore', 09:15:52 INFO - 'tabpaint']}, 09:15:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:15:52 INFO - 'tests': ['a11yr', 09:15:52 INFO - 'ts_paint', 09:15:52 INFO - 'tpaint', 09:15:52 INFO - 'sessionrestore', 09:15:52 INFO - 'sessionrestore_no_auto_restore', 09:15:52 INFO - 'tabpaint']}, 09:15:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:15:52 INFO - 'tests': ['tsvgx', 09:15:52 INFO - 'tsvgr_opacity', 09:15:52 INFO - 'tart', 09:15:52 INFO - 'tscrollx', 09:15:52 INFO - 'cart']}, 09:15:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:15:52 INFO - 'tsvgr_opacity', 09:15:52 INFO - 'tart', 09:15:52 INFO - 'tscrollx', 09:15:52 INFO - 'cart']}, 09:15:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:15:52 INFO - 'talos_options': ['--disable-e10s'], 09:15:52 INFO - 'tests': ['tp5o']}, 09:15:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:15:52 INFO - 'tests': ['tp5o']}, 09:15:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:15:52 INFO - 'talos_options': ['--disable-e10s', 09:15:52 INFO - '--xperf_path', 09:15:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:15:52 INFO - 'tests': ['tp5n']}, 09:15:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:15:52 INFO - 'talos_options': ['--xperf_path', 09:15:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:15:52 INFO - 'tests': ['tp5n']}}, 09:15:52 INFO - 'talos.zip': {'path': '', 09:15:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:15:52 INFO - Running post-action listener: _resource_record_post_action 09:15:52 INFO - [mozharness: 2017-01-07 17:15:52.426872Z] Finished populate-webroot step (success) 09:15:52 INFO - [mozharness: 2017-01-07 17:15:52.426960Z] Running create-virtualenv step. 09:15:52 INFO - Running pre-action listener: _resource_record_pre_action 09:15:52 INFO - Running main action method: create_virtualenv 09:15:52 INFO - Creating virtualenv /builds/slave/test/build/venv 09:15:52 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 09:15:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:15:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:15:52 INFO - Using real prefix '/usr' 09:15:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:15:53 INFO - Installing distribute.............................................................................................................................................................................................done. 09:15:54 INFO - Installing pip.................done. 09:15:54 INFO - Return code: 0 09:15:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:15:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:15:55 INFO - Reading from file tmpfile_stdout 09:15:55 INFO - Output received: 09:15:55 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) 09:15:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:15:55 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')]} 09:15:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:15:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:55 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')]} 09:15:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:15:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:55 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 0x7f9722b8ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f5bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f58f60>, '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 0x1f59d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f5a1d0>, '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': '3836458cccd887f2d2de3cf1000001de-1483809336.140793-1983133787', '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 09:15:55 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 09:15:55 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 09:15:55 INFO - Using env: {'DISPLAY': ':0', 09:15:55 INFO - 'HOME': '/home/cltbld', 09:15:55 INFO - 'LANG': 'en_US.UTF-8', 09:15:55 INFO - 'LANGUAGE': 'en_US:en', 09:15:55 INFO - 'LOGNAME': 'cltbld', 09:15:55 INFO - 'MAIL': '/var/mail/cltbld', 09:15:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:55 INFO - 'MOZ_NO_REMOTE': '1', 09:15:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:15:55 INFO - 'NO_EM_RESTART': '1', 09:15:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:15:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:15:55 INFO - 'PWD': '/builds/slave/test', 09:15:55 INFO - 'SHELL': '/bin/bash', 09:15:55 INFO - 'SHLVL': '1', 09:15:55 INFO - 'TERM': 'linux', 09:15:55 INFO - 'TMOUT': '86400', 09:15:55 INFO - 'USER': 'cltbld', 09:15:55 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1483809336.140793-1983133787', 09:15:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:55 INFO - '_': '/tools/buildbot/bin/python'} 09:15:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:15:55 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 09:15:55 INFO - Cleaning up... 09:15:55 INFO - Return code: 0 09:15:55 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:15:55 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')]} 09:15:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:15:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:55 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')]} 09:15:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:15:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:55 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 0x7f9722b8ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f5bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f58f60>, '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 0x1f59d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f5a1d0>, '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': '3836458cccd887f2d2de3cf1000001de-1483809336.140793-1983133787', '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 09:15:55 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 09:15:55 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 09:15:55 INFO - Using env: {'DISPLAY': ':0', 09:15:55 INFO - 'HOME': '/home/cltbld', 09:15:55 INFO - 'LANG': 'en_US.UTF-8', 09:15:55 INFO - 'LANGUAGE': 'en_US:en', 09:15:55 INFO - 'LOGNAME': 'cltbld', 09:15:55 INFO - 'MAIL': '/var/mail/cltbld', 09:15:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:55 INFO - 'MOZ_NO_REMOTE': '1', 09:15:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:15:55 INFO - 'NO_EM_RESTART': '1', 09:15:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:15:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:15:55 INFO - 'PWD': '/builds/slave/test', 09:15:55 INFO - 'SHELL': '/bin/bash', 09:15:55 INFO - 'SHLVL': '1', 09:15:55 INFO - 'TERM': 'linux', 09:15:55 INFO - 'TMOUT': '86400', 09:15:55 INFO - 'USER': 'cltbld', 09:15:55 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1483809336.140793-1983133787', 09:15:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:55 INFO - '_': '/tools/buildbot/bin/python'} 09:15:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:15:55 INFO - Downloading/unpacking psutil>=3.1.1 09:15:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:15:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:15:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:15:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:15:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:15:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:15:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:15:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:15:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:15:57 INFO - Installing collected packages: psutil 09:15:57 INFO - Running setup.py install for psutil 09:15:57 INFO - building 'psutil._psutil_linux' extension 09:15:57 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 09:15:57 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 09:15:58 INFO - building 'psutil._psutil_posix' extension 09:15:58 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 09:15:58 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 09:15:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:15:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:15:58 INFO - Successfully installed psutil 09:15:58 INFO - Cleaning up... 09:15:58 INFO - Return code: 0 09:15:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:15:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:15:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:15:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:15:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:15:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:58 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 0x7f9722b8ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f5bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f58f60>, '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 0x1f59d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f5a1d0>, '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': '3836458cccd887f2d2de3cf1000001de-1483809336.140793-1983133787', '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 09:15:58 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 09:15:58 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 09:15:58 INFO - Using env: {'DISPLAY': ':0', 09:15:58 INFO - 'HOME': '/home/cltbld', 09:15:58 INFO - 'LANG': 'en_US.UTF-8', 09:15:58 INFO - 'LANGUAGE': 'en_US:en', 09:15:58 INFO - 'LOGNAME': 'cltbld', 09:15:58 INFO - 'MAIL': '/var/mail/cltbld', 09:15:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:58 INFO - 'MOZ_NO_REMOTE': '1', 09:15:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:15:58 INFO - 'NO_EM_RESTART': '1', 09:15:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:15:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:15:58 INFO - 'PWD': '/builds/slave/test', 09:15:58 INFO - 'SHELL': '/bin/bash', 09:15:58 INFO - 'SHLVL': '1', 09:15:58 INFO - 'TERM': 'linux', 09:15:58 INFO - 'TMOUT': '86400', 09:15:58 INFO - 'USER': 'cltbld', 09:15:58 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1483809336.140793-1983133787', 09:15:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:58 INFO - '_': '/tools/buildbot/bin/python'} 09:15:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:15:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:15:58 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 09:15:58 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 09:15:58 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 09:15:58 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 09:15:58 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 09:15:58 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 09:16:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:16:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:16:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:16:00 INFO - Installing collected packages: mozsystemmonitor 09:16:00 INFO - Running setup.py install for mozsystemmonitor 09:16:00 INFO - Successfully installed mozsystemmonitor 09:16:00 INFO - Cleaning up... 09:16:00 INFO - Return code: 0 09:16:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:16: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')]} 09:16:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16: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')]} 09:16:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f9722b8ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f5bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f58f60>, '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 0x1f59d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f5a1d0>, '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': '3836458cccd887f2d2de3cf1000001de-1483809336.140793-1983133787', '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 09:16:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:16:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:16:00 INFO - Using env: {'DISPLAY': ':0', 09:16:00 INFO - 'HOME': '/home/cltbld', 09:16:00 INFO - 'LANG': 'en_US.UTF-8', 09:16:00 INFO - 'LANGUAGE': 'en_US:en', 09:16:00 INFO - 'LOGNAME': 'cltbld', 09:16:00 INFO - 'MAIL': '/var/mail/cltbld', 09:16:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:00 INFO - 'MOZ_NO_REMOTE': '1', 09:16:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:16:00 INFO - 'NO_EM_RESTART': '1', 09:16:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:16:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:00 INFO - 'PWD': '/builds/slave/test', 09:16:00 INFO - 'SHELL': '/bin/bash', 09:16:00 INFO - 'SHLVL': '1', 09:16:00 INFO - 'TERM': 'linux', 09:16:00 INFO - 'TMOUT': '86400', 09:16:00 INFO - 'USER': 'cltbld', 09:16:00 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1483809336.140793-1983133787', 09:16:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:00 INFO - '_': '/tools/buildbot/bin/python'} 09:16:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:00 INFO - Downloading/unpacking jsonschema==2.5.1 09:16:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:16:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:16:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:03 INFO - Downloading functools32-3.2.3-2.tar.gz 09:16:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:16:03 INFO - warning: no files found matching '*.txt' 09:16:03 INFO - no previously-included directories found matching 'build' 09:16:03 INFO - no previously-included directories found matching 'dist' 09:16:03 INFO - no previously-included directories found matching '.git*' 09:16:03 INFO - Installing collected packages: jsonschema, functools32 09:16:03 INFO - Running setup.py install for functools32 09:16:03 INFO - warning: no files found matching '*.txt' 09:16:03 INFO - no previously-included directories found matching 'build' 09:16:03 INFO - no previously-included directories found matching 'dist' 09:16:03 INFO - no previously-included directories found matching '.git*' 09:16:03 INFO - Successfully installed jsonschema functools32 09:16:03 INFO - Cleaning up... 09:16:03 INFO - Return code: 0 09:16:03 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:16:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:03 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 0x7f9722b8ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f5bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f58f60>, '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 0x1f59d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f5a1d0>, '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': '3836458cccd887f2d2de3cf1000001de-1483809336.140793-1983133787', '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 09:16:03 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 09:16:03 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 09:16:03 INFO - Using env: {'DISPLAY': ':0', 09:16:03 INFO - 'HOME': '/home/cltbld', 09:16:03 INFO - 'LANG': 'en_US.UTF-8', 09:16:03 INFO - 'LANGUAGE': 'en_US:en', 09:16:03 INFO - 'LOGNAME': 'cltbld', 09:16:03 INFO - 'MAIL': '/var/mail/cltbld', 09:16:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:03 INFO - 'MOZ_NO_REMOTE': '1', 09:16:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:16:03 INFO - 'NO_EM_RESTART': '1', 09:16:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:16:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:03 INFO - 'PWD': '/builds/slave/test', 09:16:03 INFO - 'SHELL': '/bin/bash', 09:16:03 INFO - 'SHLVL': '1', 09:16:03 INFO - 'TERM': 'linux', 09:16:03 INFO - 'TMOUT': '86400', 09:16:03 INFO - 'USER': 'cltbld', 09:16:03 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1483809336.140793-1983133787', 09:16:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:03 INFO - '_': '/tools/buildbot/bin/python'} 09:16:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:03 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:16:03 INFO - Cleaning up... 09:16:03 INFO - Return code: 0 09:16:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:16:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:03 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 0x7f9722b8ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f5bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f58f60>, '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 0x1f59d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f5a1d0>, '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': '3836458cccd887f2d2de3cf1000001de-1483809336.140793-1983133787', '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 09:16:03 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 09:16:03 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 09:16:03 INFO - Using env: {'DISPLAY': ':0', 09:16:03 INFO - 'HOME': '/home/cltbld', 09:16:03 INFO - 'LANG': 'en_US.UTF-8', 09:16:03 INFO - 'LANGUAGE': 'en_US:en', 09:16:03 INFO - 'LOGNAME': 'cltbld', 09:16:03 INFO - 'MAIL': '/var/mail/cltbld', 09:16:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:03 INFO - 'MOZ_NO_REMOTE': '1', 09:16:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:16:03 INFO - 'NO_EM_RESTART': '1', 09:16:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:16:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:03 INFO - 'PWD': '/builds/slave/test', 09:16:03 INFO - 'SHELL': '/bin/bash', 09:16:03 INFO - 'SHLVL': '1', 09:16:03 INFO - 'TERM': 'linux', 09:16:03 INFO - 'TMOUT': '86400', 09:16:03 INFO - 'USER': 'cltbld', 09:16:03 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1483809336.140793-1983133787', 09:16:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:03 INFO - '_': '/tools/buildbot/bin/python'} 09:16:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:03 INFO - Downloading/unpacking blobuploader==1.2.4 09:16:03 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 09:16:03 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 09:16:03 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 09:16:03 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 09:16:03 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 09:16:03 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 09:16:05 INFO - Downloading blobuploader-1.2.4.tar.gz 09:16:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:16:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:16:05 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 09:16:05 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 09:16:05 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 09:16:05 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 09:16:05 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 09:16:05 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 09:16:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:16:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:16:06 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 09:16:06 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 09:16:06 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 09:16:06 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 09:16:06 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 09:16:06 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 09:16:06 INFO - Downloading docopt-0.6.1.tar.gz 09:16:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:16:06 INFO - Installing collected packages: blobuploader, requests, docopt 09:16:06 INFO - Running setup.py install for blobuploader 09:16:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:16:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:16:06 INFO - Running setup.py install for requests 09:16:07 INFO - Running setup.py install for docopt 09:16:07 INFO - Successfully installed blobuploader requests docopt 09:16:07 INFO - Cleaning up... 09:16:07 INFO - Return code: 0 09:16:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:16:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:07 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 0x7f9722b8ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f5bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f58f60>, '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 0x1f59d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f5a1d0>, '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': '3836458cccd887f2d2de3cf1000001de-1483809336.140793-1983133787', '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 09:16:07 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 09:16:07 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 09:16:07 INFO - Using env: {'DISPLAY': ':0', 09:16:07 INFO - 'HOME': '/home/cltbld', 09:16:07 INFO - 'LANG': 'en_US.UTF-8', 09:16:07 INFO - 'LANGUAGE': 'en_US:en', 09:16:07 INFO - 'LOGNAME': 'cltbld', 09:16:07 INFO - 'MAIL': '/var/mail/cltbld', 09:16:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:07 INFO - 'MOZ_NO_REMOTE': '1', 09:16:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:16:07 INFO - 'NO_EM_RESTART': '1', 09:16:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:16:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:07 INFO - 'PWD': '/builds/slave/test', 09:16:07 INFO - 'SHELL': '/bin/bash', 09:16:07 INFO - 'SHLVL': '1', 09:16:07 INFO - 'TERM': 'linux', 09:16:07 INFO - 'TMOUT': '86400', 09:16:07 INFO - 'USER': 'cltbld', 09:16:07 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1483809336.140793-1983133787', 09:16:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:07 INFO - '_': '/tools/buildbot/bin/python'} 09:16:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:16:07 INFO - Running setup.py (path:/tmp/pip-tg58i1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:16:07 INFO - Running setup.py (path:/tmp/pip-cICNB1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:16:07 INFO - Running setup.py (path:/tmp/pip-4o5ioT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:16:07 INFO - Running setup.py (path:/tmp/pip-ICYzUV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:16:07 INFO - Running setup.py (path:/tmp/pip-zfix9E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:16:07 INFO - Running setup.py (path:/tmp/pip-660xAm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:16:07 INFO - Running setup.py (path:/tmp/pip-XjAXso-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:16:07 INFO - Running setup.py (path:/tmp/pip-gkMrHp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:16:08 INFO - Running setup.py (path:/tmp/pip-VUCIFI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:16:08 INFO - Running setup.py (path:/tmp/pip-M1AxXt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:16:08 INFO - Running setup.py (path:/tmp/pip-kt4KH9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:16:08 INFO - Running setup.py (path:/tmp/pip-nNuZ2X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:16:08 INFO - Running setup.py (path:/tmp/pip-1E5yWX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:16:08 INFO - Running setup.py (path:/tmp/pip-itSaao-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:16:08 INFO - Running setup.py (path:/tmp/pip-riJYL7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:16:08 INFO - Running setup.py (path:/tmp/pip-1TLVMS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:16:08 INFO - Running setup.py (path:/tmp/pip-ES6lmR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:16:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:16:08 INFO - Running setup.py install for manifestparser 09:16:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:16:08 INFO - Running setup.py install for mozcrash 09:16:08 INFO - Running setup.py install for mozdebug 09:16:09 INFO - Running setup.py install for mozdevice 09:16:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:16:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:16:09 INFO - Running setup.py install for mozfile 09:16:09 INFO - Running setup.py install for mozhttpd 09:16:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:16:09 INFO - Running setup.py install for mozinfo 09:16:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:16:09 INFO - Running setup.py install for mozInstall 09:16:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:16:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:16:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:16:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:16:09 INFO - Running setup.py install for mozleak 09:16:09 INFO - Running setup.py install for mozlog 09:16:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:16:09 INFO - Running setup.py install for moznetwork 09:16:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:16:09 INFO - Running setup.py install for mozprocess 09:16:09 INFO - Running setup.py install for mozprofile 09:16:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:16:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:16:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:16:10 INFO - Running setup.py install for mozrunner 09:16:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:16:10 INFO - Running setup.py install for mozscreenshot 09:16:10 INFO - Running setup.py install for moztest 09:16:10 INFO - Running setup.py install for mozversion 09:16:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:16:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:16:10 INFO - Cleaning up... 09:16:10 INFO - Return code: 0 09:16:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:16:10 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')]} 09:16:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:10 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')]} 09:16:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:10 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 0x7f9722b8ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f5bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f58f60>, '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 0x1f59d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f5a1d0>, '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': '3836458cccd887f2d2de3cf1000001de-1483809336.140793-1983133787', '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 09:16:10 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 09:16:10 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 09:16:10 INFO - Using env: {'DISPLAY': ':0', 09:16:10 INFO - 'HOME': '/home/cltbld', 09:16:10 INFO - 'LANG': 'en_US.UTF-8', 09:16:10 INFO - 'LANGUAGE': 'en_US:en', 09:16:10 INFO - 'LOGNAME': 'cltbld', 09:16:10 INFO - 'MAIL': '/var/mail/cltbld', 09:16:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:10 INFO - 'MOZ_NO_REMOTE': '1', 09:16:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:16:10 INFO - 'NO_EM_RESTART': '1', 09:16:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:16:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:10 INFO - 'PWD': '/builds/slave/test', 09:16:10 INFO - 'SHELL': '/bin/bash', 09:16:10 INFO - 'SHLVL': '1', 09:16:10 INFO - 'TERM': 'linux', 09:16:10 INFO - 'TMOUT': '86400', 09:16:10 INFO - 'USER': 'cltbld', 09:16:10 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1483809336.140793-1983133787', 09:16:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:10 INFO - '_': '/tools/buildbot/bin/python'} 09:16:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:16:10 INFO - Running setup.py (path:/tmp/pip-_FqInb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:16:10 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)) 09:16:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:16:10 INFO - Running setup.py (path:/tmp/pip-WCkyG3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:16:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:16:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:16:10 INFO - Running setup.py (path:/tmp/pip-Ay6kKp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:16:10 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)) 09:16:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:16:10 INFO - Running setup.py (path:/tmp/pip-l3OgCo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:16:11 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)) 09:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:16:11 INFO - Running setup.py (path:/tmp/pip-7DXIET-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:16:11 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)) 09:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:16:11 INFO - Running setup.py (path:/tmp/pip-0SFqGg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:16:11 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)) 09:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:16:11 INFO - Running setup.py (path:/tmp/pip-5KM6fx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:16:11 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)) 09:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:16:11 INFO - Running setup.py (path:/tmp/pip-cWjXEb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:16:11 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)) 09:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:16:11 INFO - Running setup.py (path:/tmp/pip-JHRJHZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:16:11 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)) 09:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:16:11 INFO - Running setup.py (path:/tmp/pip-ND_Udz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:16:11 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)) 09:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:16:11 INFO - Running setup.py (path:/tmp/pip-7d4R9x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:16:11 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)) 09:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:16:11 INFO - Running setup.py (path:/tmp/pip-3IMvXr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:16:11 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)) 09:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:16:11 INFO - Running setup.py (path:/tmp/pip-zM9ah5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:16:11 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)) 09:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:16:11 INFO - Running setup.py (path:/tmp/pip-wRMegI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:16:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:16:11 INFO - Running setup.py (path:/tmp/pip-XfOjpY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:16:11 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)) 09:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:16:11 INFO - Running setup.py (path:/tmp/pip-MQddlX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:16:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:16:11 INFO - Running setup.py (path:/tmp/pip-66WeFz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:16:12 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)) 09:16:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:16:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:16:12 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)) 09:16:12 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)) 09:16:12 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)) 09:16:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:16:12 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 09:16:12 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 09:16:12 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 09:16:12 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 09:16:12 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 09:16:12 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 09:16:13 INFO - Downloading blessings-1.6.tar.gz 09:16:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:16:14 INFO - Installing collected packages: blessings 09:16:14 INFO - Running setup.py install for blessings 09:16:14 INFO - Successfully installed blessings 09:16:14 INFO - Cleaning up... 09:16:14 INFO - Return code: 0 09:16:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:16:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:16:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:16:14 INFO - Reading from file tmpfile_stdout 09:16:14 INFO - Current package versions: 09:16:14 INFO - argparse == 1.2.1 09:16:14 INFO - blessings == 1.6 09:16:14 INFO - blobuploader == 1.2.4 09:16:14 INFO - docopt == 0.6.1 09:16:14 INFO - functools32 == 3.2.3-2 09:16:14 INFO - jsonschema == 2.5.1 09:16:14 INFO - manifestparser == 1.1 09:16:14 INFO - mozInstall == 1.12 09:16:14 INFO - mozcrash == 1.0 09:16:14 INFO - mozdebug == 0.1 09:16:14 INFO - mozdevice == 0.48 09:16:14 INFO - mozfile == 1.2 09:16:14 INFO - mozhttpd == 0.7 09:16:14 INFO - mozinfo == 0.9 09:16:14 INFO - mozleak == 0.1 09:16:14 INFO - mozlog == 3.4 09:16:14 INFO - moznetwork == 0.27 09:16:14 INFO - mozprocess == 0.23 09:16:14 INFO - mozprofile == 0.28 09:16:14 INFO - mozrunner == 6.13 09:16:14 INFO - mozscreenshot == 0.1 09:16:14 INFO - mozsystemmonitor == 0.3 09:16:14 INFO - moztest == 0.8 09:16:14 INFO - mozversion == 1.4 09:16:14 INFO - psutil == 3.1.1 09:16:14 INFO - requests == 1.2.3 09:16:14 INFO - wsgiref == 0.1.2 09:16:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:16:14 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')]} 09:16:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:14 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')]} 09:16:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:14 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 0x7f9722b8ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f5bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f58f60>, '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 0x1f59d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f5a1d0>, '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': '3836458cccd887f2d2de3cf1000001de-1483809336.140793-1983133787', '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 09:16:14 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 09:16:14 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 09:16:14 INFO - Using env: {'DISPLAY': ':0', 09:16:14 INFO - 'HOME': '/home/cltbld', 09:16:14 INFO - 'LANG': 'en_US.UTF-8', 09:16:14 INFO - 'LANGUAGE': 'en_US:en', 09:16:14 INFO - 'LOGNAME': 'cltbld', 09:16:14 INFO - 'MAIL': '/var/mail/cltbld', 09:16:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:14 INFO - 'MOZ_NO_REMOTE': '1', 09:16:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:16:14 INFO - 'NO_EM_RESTART': '1', 09:16:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:16:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:14 INFO - 'PWD': '/builds/slave/test', 09:16:14 INFO - 'SHELL': '/bin/bash', 09:16:14 INFO - 'SHLVL': '1', 09:16:14 INFO - 'TERM': 'linux', 09:16:14 INFO - 'TMOUT': '86400', 09:16:14 INFO - 'USER': 'cltbld', 09:16:14 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1483809336.140793-1983133787', 09:16:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:14 INFO - '_': '/tools/buildbot/bin/python'} 09:16:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:14 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)) 09:16:14 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)) 09:16:14 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)) 09:16:14 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)) 09:16:14 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)) 09:16:14 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)) 09:16:14 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)) 09:16:14 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)) 09:16:14 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)) 09:16:14 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)) 09:16:14 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)) 09:16:14 INFO - Cleaning up... 09:16:14 INFO - Return code: 0 09:16:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:16:14 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')]} 09:16:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:14 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')]} 09:16:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:14 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 0x7f9722b8ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f5bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f58f60>, '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 0x1f59d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f5a1d0>, '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': '3836458cccd887f2d2de3cf1000001de-1483809336.140793-1983133787', '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 09:16:14 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 09:16:14 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 09:16:14 INFO - Using env: {'DISPLAY': ':0', 09:16:14 INFO - 'HOME': '/home/cltbld', 09:16:14 INFO - 'LANG': 'en_US.UTF-8', 09:16:14 INFO - 'LANGUAGE': 'en_US:en', 09:16:14 INFO - 'LOGNAME': 'cltbld', 09:16:14 INFO - 'MAIL': '/var/mail/cltbld', 09:16:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:14 INFO - 'MOZ_NO_REMOTE': '1', 09:16:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:16:14 INFO - 'NO_EM_RESTART': '1', 09:16:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:16:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:14 INFO - 'PWD': '/builds/slave/test', 09:16:14 INFO - 'SHELL': '/bin/bash', 09:16:14 INFO - 'SHLVL': '1', 09:16:14 INFO - 'TERM': 'linux', 09:16:14 INFO - 'TMOUT': '86400', 09:16:14 INFO - 'USER': 'cltbld', 09:16:14 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1483809336.140793-1983133787', 09:16:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:14 INFO - '_': '/tools/buildbot/bin/python'} 09:16:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:16:14 INFO - Cleaning up... 09:16:14 INFO - Return code: 0 09:16:14 INFO - Running post-action listener: _resource_record_post_action 09:16:14 INFO - Running post-action listener: _start_resource_monitoring 09:16:14 INFO - Starting resource monitoring. 09:16:14 INFO - [mozharness: 2017-01-07 17:16:14.972183Z] Finished create-virtualenv step (success) 09:16:14 INFO - [mozharness: 2017-01-07 17:16:14.972629Z] Running install step. 09:16:14 INFO - Running pre-action listener: _resource_record_pre_action 09:16:14 INFO - Running main action method: install 09:16:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:16:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:16:15 INFO - Reading from file tmpfile_stdout 09:16:15 INFO - Detecting whether we're running mozinstall >=1.0... 09:16:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:16:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:16:15 INFO - Reading from file tmpfile_stdout 09:16:15 INFO - Output received: 09:16:15 INFO - Usage: mozinstall [options] installer 09:16:15 INFO - Options: 09:16:15 INFO - -h, --help show this help message and exit 09:16:15 INFO - -d DEST, --destination=DEST 09:16:15 INFO - Directory to install application into. [default: 09:16:15 INFO - "/builds/slave/test"] 09:16:15 INFO - --app=APP Application being installed. [default: firefox] 09:16:15 INFO - mkdir: /builds/slave/test/build/application 09:16:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:16:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:16:31 INFO - Reading from file tmpfile_stdout 09:16:31 INFO - Output received: 09:16:31 INFO - /builds/slave/test/build/application/firefox/firefox 09:16:31 INFO - Running post-action listener: _resource_record_post_action 09:16:31 INFO - [mozharness: 2017-01-07 17:16:31.206347Z] Finished install step (success) 09:16:31 INFO - [mozharness: 2017-01-07 17:16:31.206589Z] Running run-tests step. 09:16:31 INFO - Running pre-action listener: _resource_record_pre_action 09:16:31 INFO - Running main action method: run_tests 09:16:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:16:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:16:31 INFO - Python 2.7.3 09:16:31 INFO - Return code: 0 09:16:31 INFO - grabbing minidump binary from tooltool 09:16:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:31 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 0x1f58f60>, '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 0x1f59d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f5a1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:16:31 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 09:16:31 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 09:16:31 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 09:16:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:16:31 INFO - Return code: 0 09:16:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:16:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:16:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:16:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:16:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:16:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Q1l_5u-vRHummv2lizuMBg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 09:16:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Q1l_5u-vRHummv2lizuMBg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-030 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 09:16:31 INFO - Using env: {'DISPLAY': ':0', 09:16:31 INFO - 'HOME': '/home/cltbld', 09:16:31 INFO - 'LANG': 'en_US.UTF-8', 09:16:31 INFO - 'LANGUAGE': 'en_US:en', 09:16:31 INFO - 'LOGNAME': 'cltbld', 09:16:31 INFO - 'MAIL': '/var/mail/cltbld', 09:16:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:16:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:16:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:31 INFO - 'MOZ_NO_REMOTE': '1', 09:16:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:16:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:16:31 INFO - 'NO_EM_RESTART': '1', 09:16:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:16:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:31 INFO - 'PWD': '/builds/slave/test', 09:16:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:16:31 INFO - 'SHELL': '/bin/bash', 09:16:31 INFO - 'SHLVL': '1', 09:16:31 INFO - 'TERM': 'linux', 09:16:31 INFO - 'TMOUT': '86400', 09:16:31 INFO - 'USER': 'cltbld', 09:16:31 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1483809336.140793-1983133787', 09:16:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:31 INFO - '_': '/tools/buildbot/bin/python'} 09:16:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Q1l_5u-vRHummv2lizuMBg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 09:16:31 INFO - mozversion application_buildid: 20170107073256 09:16:31 INFO - mozversion application_changeset: 9a9493b6820804ccb4d2089f337179341b151133 09:16:31 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:16:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:16:31 INFO - mozversion application_name: Firefox 09:16:31 INFO - mozversion application_remotingname: firefox-dev 09:16:31 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:16:31 INFO - mozversion application_vendor: Mozilla 09:16:31 INFO - mozversion application_version: 52.0a2 09:16:31 INFO - mozversion platform_buildid: 20170107073256 09:16:31 INFO - mozversion platform_changeset: 9a9493b6820804ccb4d2089f337179341b151133 09:16:31 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:16:31 INFO - mozversion platform_version: 52.0a2 09:16:31 INFO - using testdate: 1483809391 09:16:31 INFO - actual date: 1483809391 09:16:31 INFO - starting webserver on 'localhost:50840' 09:16:31 INFO - SUITE-START | Running 2 tests 09:16:31 INFO - TEST-START | dromaeo_css 09:16:31 INFO - operating with platform_type : linux_ 09:16:31 INFO - Initialising browser for dromaeo_css test... 09:16:31 INFO - TEST-INFO | started process 12602 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsiD1Nk/profile http://localhost:50840/getInfo.html) 09:16:36 INFO - PROCESS | 12602 | __metrics Screen width/height:1600/1200 09:16:36 INFO - PROCESS | 12602 | colorDepth:24 09:16:36 INFO - PROCESS | 12602 | Browser inner width/height: 1024/697 09:16:36 INFO - PROCESS | 12602 | __metrics 09:16:36 ERROR - PROCESS | 12602 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 09:16:37 INFO - TEST-INFO | 12602: exit 0 09:16:37 INFO - Browser initialized. 09:16:37 INFO - Running cycle 1/1 for dromaeo_css test... 09:16:37 INFO - TEST-INFO | started process 12729 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsiD1Nk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:16:49 INFO - PROCESS | 12729 | RSS: Main: 151695360 09:16:49 INFO - PROCESS | 12729 | 09:19:49 INFO - PROCESS | 12729 | Cycle 1(1): loaded http://localhost:50840/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50840/tests/dromaeo/cssquery-ext.html) 09:19:51 INFO - PROCESS | 12729 | RSS: Main: 155578368 09:19:51 INFO - PROCESS | 12729 | 09:22:53 INFO - PROCESS | 12729 | Cycle 1(1): loaded http://localhost:50840/tests/dromaeo/cssquery-ext.html (next: http://localhost:50840/tests/dromaeo/cssquery-jquery.html) 09:22:53 INFO - PROCESS | 12729 | RSS: Main: 153231360 09:22:53 INFO - PROCESS | 12729 | 09:25:55 INFO - PROCESS | 12729 | Cycle 1(1): loaded http://localhost:50840/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50840/tests/dromaeo/cssquery-mootools.html) 09:25:56 INFO - PROCESS | 12729 | RSS: Main: 153604096 09:25:56 INFO - PROCESS | 12729 | 09:28:58 INFO - PROCESS | 12729 | Cycle 1(1): loaded http://localhost:50840/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50840/tests/dromaeo/cssquery-prototype.html) 09:28:58 INFO - PROCESS | 12729 | RSS: Main: 151973888 09:28:58 INFO - PROCESS | 12729 | 09:32:01 INFO - PROCESS | 12729 | Cycle 1(1): loaded http://localhost:50840/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50840/tests/dromaeo/cssquery-yui.html) 09:32:01 INFO - PROCESS | 12729 | RSS: Main: 154791936 09:32:01 INFO - PROCESS | 12729 | 09:35:04 INFO - PROCESS | 12729 | Cycle 1(1): loaded http://localhost:50840/tests/dromaeo/cssquery-yui.html (next: http://localhost:50840/tests/dromaeo/cssquery-dojo.html) 09:35:04 INFO - PROCESS | 12729 | RSS: Main: 155521024 09:35:04 INFO - PROCESS | 12729 | 09:35:04 INFO - PROCESS | 12729 | __start_tp_report 09:35:04 INFO - PROCESS | 12729 | _x_x_mozilla_page_load 09:35:04 INFO - PROCESS | 12729 | _x_x_mozilla_page_load_details 09:35:04 INFO - PROCESS | 12729 | |i|pagename|runs| 09:35:04 INFO - PROCESS | 12729 | |0;dojo.html;3251.447253966826;3262.200760813601;3268.689474499923;3282.3927573398914;3287.09604858664;5687.345955215152;5747.568932330071;5749.137629355599;5750.626209296403;5751.367349591542;5741.971290143554;5746.454086861752;5789.855253618662;5809.128630705396;5826.941730582693;5197.064528384889;5241.737913104349;5257.7108259045735;5283.8150664726745;5296.993571221475;5302.496262855023;5305.257263983045;5305.814296499623;5313.0967735485065;5336.91994620081;5152.587792976572;5166.5866730661455;5299.470052994689;5304.177852432879;5316;5203.765830537635;5210.999999999981;5250.81622143227;5252.658577192489;5290.0477913975465;5187.533122019036;5204.557612602934;5208;5225.973870130663;5316.3620365556;5719.256496655408;5759.740811663485;5815.505682017034;5824.0390335594575;5847.06446968483;6079.939200608026;6123.557162997608;6135.569531795964;6231.719572619243;6248.531360147962;6130.816075517741;6144.477719393857;6162.198914141178;6174.5060395168275;6191.566590338678;5635.69003704792;5662.37713851476;5769.884602307972;5780.653160810365;5805.216295800097;6200.193974783249;6281.466075383643;6288.465480434214;6374.490040796818;6389.233292004897;6062.969685151546;6091;6092.786752463642;6100.908486372708;6127.662978536134;5979.431953964367;6185.721642526097;6201.782937597162;6203.906941395882;6210.472109870621;5955.910661340084;6044.939550604526;6059.030555111161;6076.088586712029;6133.2734575755485;6111.95640283616;6171.9691401542705;6176.258848938156;6178.876422471525;6182.474489668339;4772.785224664898;4775.355327030807;4776.641751868624;4777.976110119496;4795.424549054136;4130.690198235085;4135.958640413617;4190.099128687286;4191.580841915845;4252.936205956913;5959.1657167995645;5963.0459126539545;5965.254343207099;5977.402259774075;6014.308354539196;6013;6251.187345645128;6258.123862659231;6280.152179455807;6281.937180628227;5666.546676265889;5702.914456283159;5726.713664316851;5771.451712087345;5920.674362910081;5237.9476205238225;5274.7626356814035;5276.419593844674;5284;5287.312649355559;6387.712552935036;6392.0411938209645;6408.2630497492455;6416.101745755598;6418.29398766126;5913.793017244376;6028.125921741411;6076.3012253591405;6110.57225994194;6126.969365153146;6397.072424498515;6419.903701444388;6422.229332480132;6425.9036114457385;6442.806715798533;6084.178635884099;6093.2078829751845;6096.390360963868;6102.298235702951;6103.206583144163;5854.677992710442;5986.850328741816;6122.97760420812;6153.046277826944;6248.12526246335;6117.309816958451;6121.696863452088;6137.616878446366;6140.166841500682;6147.200863887666;6092.208012958287;6095.939040609537;6116.8776624468155;6121.479674227562;6123;5858.443447872616;5879.529637628894;5959.344472107978;6032.155498230163;6085.513158947185;6100.176476175659;6126.264848218242;6143.447089761943;6153.077038444269;6176.722047507783;5998.850028749316;6011.098335249748;6011.098335249748;6035.698215089315;6044.365341639064 09:35:04 INFO - PROCESS | 12729 | |1;ext.html;633.2211380002595;638.4541217259242;678.0710426715398;687.7799104286627;711.7366574367485;41163.58836411639;44989.10021799562;45011.999999999956;45221.09557808846;45389.092218155616;45706.54293457073;46054.539454605445;46108.53891461084;46413.535864641344;46459.76770116144;8759.649614015447;8851.513166775825;8895.866562001574;8909.777255568597;8913.68802091927;8686.913130868674;8807.911920880773;8864.246539044188;8871.157240062184;8877.422967507091;8835.823283534326;8849.33629977751;8865.601047952858;8868.201861832435;8902.510361930092;8784.692535761249;8848.115188481164;8853.24747396472;8873.600687969025;8875.600597973074;8779.868301975475;8840.115988401172;8844.42511236774;8847.380683352168;8849.734507964771;42401.151976960595;42482.36276455856;42667.146657066995;42773.57226427758;42783.35824962628;3468.6357932417236;3525.189206482498;3542.964570354315;3546.7871927684164;3620.7646502977223;33169.83415082933;33397.53714826129;33766;33779.6622033779;33803.4929476058;3872.206197729487;3983.50206224222;3986.9401958970348;4019.41718450823;4083.2854250506043;360767;360772;360966.1951690251;361345;361686;64125.67937160378;64273;64435.35564644387;64451;64801.67599161974;66465.33534664591;66515.66742166258;66605.66697166483;66824;66937;19184.61630767377;19244.61510769777;19287.132079056475;19393;19500.414987550397;14804.481843135654;14885;14949.626259343386;15028.474003410047;15039.924800375928;17923.226296954534;18951.62096758057;18964.43106706801;18990.43028709141;19088.809111908704;6436.420722135031;6621.86756264872;6622.602643841288;6745.797626071226;6778.627175505296;1013.3919648211162;1055.1875056206677;1058.7829494953517;1147.9897690032717;1148.7587606602708;34007.82996085053;34094.65905340965;34216.31567368639;34379;34439.139021524665;962.2686758063921;1135.6990397544657;1152.8962393384636;1174.9412529373496;1217.9829842081783;17435.73846392305;17843;17933.910330448525;18045.7293140603;18072.457826265232;491220;491891;494365;494773;497612;63345;63574.046389304196;63646.6817665918;63671;63698.36301636924;1391.506015364531;1396.76255036644;1414.7736362182002;1427.4789701758784;1434.8349939756645;32202.35595288128;33367.66632333645;33534.832325838215;33617;34056.829715852255;55664.721676392975;55999.44000559942;56132.71933640305;56150.71924640514;56167.71916140393;431623;433807;433956;435018;435232;43142.35286470642;44179.77910110429;44763.55236447594;45296;45324.773376134224;50642;50986.745066275915;51051.48948510616;51248.48751512437;52855.73572132115;42940.570594294906;43062.35406468843;43885.34171987359;44599.77700111479;45819.541804581524;42723;42924.14151716886;43119.56880431156;43322;44348.33477497775;44580.77709611431;47342.52657473519;48485;48588;49980;42300.78849605855;42692.35961460643;43469;45871;47251.291230632254;35472.46284669846;36615;36736.63263367332;36757.08107297339;38548 09:35:04 INFO - PROCESS | 12729 | |2;jquery.html;397.60636969400264;405.8011574328578;425.3810705423609;434.96520278377733;438.44317716500046;18515.35196268131;19845.900770496162;20094.89952550237;20321.49196270094;20848.374548763524;19858.205671773147;19904.303349382775;20147.798522014775;20339.28812491563;20547.589048219026;5496.890062198753;5813.360530341659;5817.563682723791;5823.475887170154;5829;4449.644028477714;5196.8826702259;5708.343540492834;5740.225069615591;6380.808575742735;6442.516811239152;6446.967765161167;6500.6099634021875;6502.9349706503035;6508.284088750233;5900.380460051697;5923.496502797268;5935.465808077251;5993.670348130851;6476.676166191695;5768.394318596529;5773.566982476331;5774.855628609276;5776.046952252873;5776.768929242825;14188.716225675533;15449.38202471911;22707.772922270895;23303.53392932149;23424.126069914368;2375.643653451996;2478.008796481404;2490.3898544856625;2772.057500449857;2995.086498617921;10215.897841021644;10793.244472886901;11311.604093856675;11391.316521008683;11977.520899164023;1953.9706904396446;1962.578045720177;1980.366282789508;2065.855390122692;2069.7619773726065;85178.5741071297;89693.55153224258;91010.5449472755;92273.53863230709;92525.53737231271;11029.944850275697;11209.719757005976;11226.887731122748;11770.17608767378;12438.440270187863;16740.6651866962;16823.15884205785;16845.83154168467;16861.241244144043;16891.831081689026;8664;8813.955930220307;8872.112788721077;8873.645054197888;9063.909360906438;8465.957670211732;8664.436811607226;8693.695720649746;8712.738617841474;8724.476531408136;5079.822206222764;5097.6941383517105;5132.538071573576;5150.562202212854;5177.068127737043;2063.2469148760592;2067.379786064175;2114.714513540683;2124.585705787357;2126.362091372582;917.3440989692402;935.1863878425677;1014.1329163565193;1032.2361452525226;1038.382162613244;18516.444506664553;18856.245750170114;19328.806711932983;19764.70352944707;19856.00719963996;960.870282511852;983.2871168402851;986.713852982627;1000.2498126405196;1022.601185537641;8894.243989260856;10929.672109836718;11000.22998390121;11204.439778011067;11216.270942388881;518962;524656;527422;547953;551863.5495897122;96042.51978740061;100132.49933750284;100143.49928250312;101657.49171254097;102053.48973255235;1024.8667673202435;1028.5063169678597;1035.435687550287;1095.3482677806692;1100.1089117814436;17920.820791791914;18004.90997545004;18513.166907489463;18545.07274636236;18859.15133818954;43536.78231608822;43665.56334436615;44072.55927440813;45909.540904591864;46701;60595.697021514614;60833.695831520556;61100.38899610947;62296.37703622906;62548.11200975802;8709.782255443664;8939.508327042075;9036.367454278137;9057.501837399006;9187.540622968958;7877;11251.718707032389;11487.8276825846;12054;12389.93805030969;10673.252872298865;10719.24965252456;10964.451777411257;10965.61620343284;11078.446077695922;10560.577576896838;10769.784604307713;10771;10973.23187376876;11045.889541104807;11171.776564468502;11314.377709226072;11433.428328583705;11457.656270311903;11587.88412115868;7697.576633285223;8096.797580060545;8926.68756593516;9237.907620923974;9239.676611318571;11139.33164010162;11173.776524469302;11182.32906025641;11279.718007049889;11416.885831141582 09:35:04 INFO - PROCESS | 12729 | |3;mootools.html;1514.136941943092;1544.7837302777614;1684.2252563820641;1777.884437511561;1825.224279681136;8134.105248422668;8258.50448973062;8376.329893608512;8703.347248956323;8708.43395179313;8568.528730919797;8868.512231827246;8870.645174193025;9141.360104792668;9164.908350916505;2466.358746725851;2482.5407299649623;2487.502499500098;2496.051500429843;2498.362917456046;2407.2296865003204;2478.39279376553;2486.428121532049;2510.535550923085;2514.208024472285;2423.260905423845;2427.4416884116663;2461.8153638477097;2464.149868295435;2474.3690358958443;2412.831101822864;2437.5856104462196;2448.8490409507504;2453.276283496373;2457.8033757299463;2418.697662792151;2433.2943446400523;2452.5340185364726;2457.0908763757348;2463.6304554316816;8917;8955.955220223923;9016.549172541412;9130.31522635805;9147.496887671176;5503.257060296849;5602.635828671164;5611.242482264924;5613.915791263134;5623.297087864017;3491.3640201647845;3541.9291614167573;3551.6093229744706;3595.982020089883;3618.023133753898;1065.7016035509992;1069.7539565899808;1095.1348434736549;1099.6261271167841;1108.174410064499;12654.746905061847;12749.553765618159;12759.234445933274;12796.040296977764;12803.871961280454;4749.857504274877;4775.948630440993;4796.088743138793;4900.607951363882;4971.105201063771;10624.734381640521;10652.786944261072;10686.091682206945;10709.303895246783;10720.35677859331;5568.888622227614;5645.915311270334;5674.574406919498;5701.543876489871;5703.372629010805;4964.652474326835;5099.974500127476;5149.356330458692;5157.6647517911215;5175.715335656575;3811.4663947047434;3951.6245956634075;3953.920921581552;3964;3984.362501999666;1192.9164958452998;1194.50428072349;1195.384377045822;1209.848768903887;1211.9030477561773;967.2987084363921;1007.5919252702668;1012.6961911426542;1015.3095894791466;1021.7190272675074;5969.970150149222;5996.430339117864;5996.640201587918;6160.537959653044;6239.532035097295;470.33212837770446;476.6067993905042;477.4413935695245;487.7707477485576;489.3345050731003;4050.8987275317763;4093.89765255871;4128.277551428488;4140.482439695038;4142.378643203483;10839.349639021526;11252;11412.087033037336;11441.828372574419;11467.713307167222;11014.834777478345;11062.502187401586;11174.66476005721;11185.832212516818;11188;8311.085780564134;8428.0729119798;8429.620667069996;8565.743027709053;8636.956815215884;5843;5873.177755114373;5902.321233058254;5968.194293770285;5995;10062.547185376528;10069.899301006895;10183.083522482715;10223.642172523925;10259;10258.333208341433;10355.171586272929;10356.689299321033;10487.475626218811;10574.154067674413;7486.7005319786595;7534.133574638768;7577.280158384945;7623.047119110111;7668.194839541991;8277.62750676233;8393.412461127662;8429.283510901396;8440.704575339834;8442.915570844212;7774.766756997299;7853.293203611703;7862.410319225966;7950.085740139958;7962.960185199037;7520.435967302365;7587.975623291006;7598.924010759822;7638.732644357421;7764.378849691898;6940.063091482787;6982.197047339621;7034.894476582957;7038.331358520933;7271.454640901848;5175.560077393313;5254.343207099113;5348.384935732441;5382.058139825594;5395.379531353788;5259.8422047338645;5329.7868085277705;5377.623566350474;5388.892222155457;5413.025655382069 09:35:04 INFO - PROCESS | 12729 | |4;prototype.html;357.75315032627486;360.24348867378507;360.49170669356215;361.13868423809225;362.2736413490951;5644.153376993453;5674.779922316701;5675.51758100562;5689.4879460848615;5695.373508914016;5611.382747897728;5634;5655.943440565593;5665;5700.857478563038;4212.283911735005;4297.935530967038;4353.651707863379;4358.150160718661;4388.210122178007;4336.7181133226395;4338.2191205582985;4352.586504282088;4357.782110894458;4376;4312.892177695551;4323.524412314643;4342.804573794187;4356.617555281512;4362.367456718774;4075.4905636795547;4329.112531930978;4363.123856741599;4368.825246990116;4375.365571992043;3843.327417701891;3851.903702407434;3857.209272099241;3869.4195870619633;3871.457995880579;5413.404525502192;5454.945450545523;5456.699881506555;5457.754401051922;5489.87457571201;4946.752662366867;4970.676906001098;4984.825531106394;4996.100701873661;5032.4967503249745;5805.564582656318;5806.2451881255165;5809.92516384466;5821.563382746311;5827.35899051104;4204.894877628053;4241.384999175102;4247.8300867965245;4273.658107351435;4321.114171594815;5818.41815818419;5850.9414905851245;5959.702014899238;6048.485878700316;6155.322914479404;4147.212029714345;4262.445882035316;4269.402283680287;4292.785360732013;4298.398224248608;4331.6318112960125;4343.630791382705;4354.216241076573;4358.259095953696;4362.345648152739;4895.632827537949;4904;4947.282644016669;4953.628477864103;4989.975050124799;5838.5329173666005;5845.1232315153065;5856.94143058564;5868.325142608569;5909.349971503131;1439.2659743530664;1446.2985452055746;1448.7826825975976;1451.9400837388555;1453.978190327146;970.96601618943;998;998.4308943901906;1007.5591903577954;1020.698893826323;5433.576846586625;5459.481349271813;5465;5472.452754724496;5515.889682206333;5760.337561180434;5800.216970708901;5800.837254843193;5804.477597016289;5819.214406055213;5354.571634269249;5451.509364157245;5529.263014807696;5698.8290351289525;5730.942690573124;3102.6968673156875;3107.021288294225;3124.7656425767705;3150.401423729484;3164.7784655074383;5938.8218353449465;6020.1036673447725;6139.26328840542;6167.629942203482;6198.078595635277;6135.233095863017;6135.386461353829;6148.077788331786;6152.3540028297275;6160.845978850564;6227.003679411272;6291.678747462993;6347.429291137097;6360.936390636127;6365.713542890581;5933.643981361132;5983.730732116978;5990.891685038282;5993.550483713826;6022.307434645072;5933.288005439203;5982.205338398376;5987.251593550806;5989.251343582052;6056.939430605637;6148.231471066117;6249.96875015622;6256.874862502816;6307.590006649553;6424.229092508929;4298.785060747013;4339;4354.2162410765095;4369.344598310279;4372.759498227628;5821.650700957956;6139.171211886338;6156.815295540961;6158.860610787019;6160.753569857335;5874.500667443144;5924.763009479572;5935.584509084322;5937.732802023833;5947.256592925884;5883.794067207627;5911.556633252438;5950.672713000827;5966.463018328372;6021.066734656135;5705.7432415542235;5831.35855055935;5839.8832023358445;5870.735816888336;5885;5900.350961394329;5926.644401335933;5929.6145750526075;5936.13925980739;5964.910526342195;5632.408597097409;5806.854828629149;5820.476157145878;5862.501687356452;5864.208331875313 09:35:04 INFO - PROCESS | 12729 | |5;yui.html;737.697544006957;754.630231186718;764.9349805266555;780.8711562592172;896.9058248883865;15268.92365538172;16049.919750401232;16208.108554029524;16291.51125466235;16333.754993675104;14898;15115.84884151161;15243.923780381083;15583.688326233469;15628;854.0647990450462;870.2254993056185;871.7471933139382;871.7733389318792;871.8561437362828;831.0899564976341;853;858.2618947704968;859.7807559072428;868.6395146014396;897.1432282170545;899.7525680437899;901.7520181949983;903;903.0202230579796;881.066069965835;886.7738726624734;888.3736965439382;893.2496702769705;895.5164211325877;653.9149910511651;654.754467074847;656.1633916756174;657.9868402631921;658.8254112660148;12863.807042894365;12923.418446169944;12940.547080852219;12980.221186728826;13745.24401157936;11343;13728.970327225397;13926.721465570632;14252.928735356361;14321.212333321662;11514.424278786028;11672.474738636782;11844.763104737944;12015.639530814089;12159.696007599792;3809.5428548574073;3829.8276577554075;3862.092408284051;3872.7482713623526;3929.4105884117325;66856.33143668549;66877.66561167211;67985.32014679839;68699.31300687029;71842.12631494734;9758.268129890286;9942.552585133686;10168.440735759605;10216.948915255376;10603.840942385716;18958.810411895705;19036.42890713281;19136.61726765457;19277.22891084341;19529.316473923343;7965;7979.800504987422;8090.555019473868;8141.4708043978135;8156.0620528639965;4617.561331673485;4700.153972285021;4704.670673052922;4711.505291944297;4724.740139292372;3621.4386770050683;3634.23681026982;3659.688926441282;3688.0226739913946;3695.464157697119;607.3289015637657;609.2475792396386;618.0667192539298;619.3991827926903;626.8808926303988;678.6538865178695;704.3766266853769;755.8261599831959;777.9105402878628;787.5353541410595;9376.203022743006;9387.5306234688;9395.62417503306;9426.717198484057;9547.997460266712;746.7461063238525;762.4738930138187;778.8325510015261;780.1940049296308;789.9960500197462;4545.545445455428;4573.931391029138;4578.153041687298;4702.27114797207;4741.217699079613;73442.63278683572;76589.23410765933;80862.19137808665;83861.58069209615;86237.5688121568;71108.64445677842;71897.64051179815;72426.275737243;73144.90282645765;73823;68882;68982.3101768986;70818.64590677117;71846.99999999895;73595;9721.173700235558;9920.553575088994;10051.547680354548;10153.84769228477;10307.639232626821;46126;47047.764761175975;47212.055758883944;47598;48752;64780.35219647743;64952;65314;66770.33229667641;66989.33010669831;12024.879751202376;12812;13197.604071877859;13343.66640833987;13804.240766757523;13841.723165536834;14077.577672669837;14171.787423188454;15067.397304107713;15173.772393414329;12397.814032789334;13009.674758131123;13381.996350273963;13442.663933401744;13476.393562289917;14096.788548171991;14099.647508812363;14200.076994995292;14820.629484262548;15236.695266094837;12660.620181394574;12673.429695663901;12828.230306181658;13324.933375333061;13686.247256400993;11232.55069797199;11299.265547739371;11568.652940411464;11728.530858765555;11848.940755296167;10817.729556761144;11309.604163854226;11371.943140284246;11399.601013964802;11555.768884622092 09:35:04 INFO - PROCESS | 12729 | __end_tp_report 09:35:04 INFO - PROCESS | 12729 | __start_cc_report 09:35:04 INFO - PROCESS | 12729 | _x_x_mozilla_cycle_collect,313 09:35:04 INFO - PROCESS | 12729 | __end_cc_report 09:35:04 INFO - PROCESS | 12729 | __startTimestamp1483810504473__endTimestamp 09:35:04 INFO - PROCESS | 12729 | 09:35:04 INFO - PROCESS | 12729 | ------- Summary: start ------- 09:35:04 INFO - PROCESS | 12729 | Number of tests: 6 09:35:04 INFO - PROCESS | 12729 | 09:35:04 INFO - PROCESS | 12729 | [#0] dojo.html Cycles:165 Average:5736.23 Median:5998.85 stddev:660.32 (11.0%) stddev-sans-first:632.92 09:35:04 INFO - PROCESS | 12729 | Values: 3251.4 3262.2 3268.7 3282.4 3287.1 5687.3 5747.6 5749.1 5750.6 5751.4 5742.0 5746.5 5789.9 5809.1 5826.9 5197.1 5241.7 5257.7 5283.8 5297.0 5302.5 5305.3 5305.8 5313.1 5336.9 5152.6 5166.6 5299.5 5304.2 5316.0 5203.8 5211.0 5250.8 5252.7 5290.0 5187.5 5204.6 5208.0 5226.0 5316.4 5719.3 5759.7 5815.5 5824.0 5847.1 6079.9 6123.6 6135.6 6231.7 6248.5 6130.8 6144.5 6162.2 6174.5 6191.6 5635.7 5662.4 5769.9 5780.7 5805.2 6200.2 6281.5 6288.5 6374.5 6389.2 6063.0 6091.0 6092.8 6100.9 6127.7 5979.4 6185.7 6201.8 6203.9 6210.5 5955.9 6044.9 6059.0 6076.1 6133.3 6112.0 6172.0 6176.3 6178.9 6182.5 4772.8 4775.4 4776.6 4778.0 4795.4 4130.7 4136.0 4190.1 4191.6 4252.9 5959.2 5963.0 5965.3 5977.4 6014.3 6013.0 6251.2 6258.1 6280.2 6281.9 5666.5 5702.9 5726.7 5771.5 5920.7 5237.9 5274.8 5276.4 5284.0 5287.3 6387.7 6392.0 6408.3 6416.1 6418.3 5913.8 6028.1 6076.3 6110.6 6127.0 6397.1 6419.9 6422.2 6425.9 6442.8 6084.2 6093.2 6096.4 6102.3 6103.2 5854.7 5986.9 6123.0 6153.0 6248.1 6117.3 6121.7 6137.6 6140.2 6147.2 6092.2 6095.9 6116.9 6121.5 6123.0 5858.4 5879.5 5959.3 6032.2 6085.5 6100.2 6126.3 6143.4 6153.1 6176.7 5998.9 6011.1 6011.1 6035.7 6044.4 09:35:04 INFO - PROCESS | 12729 | 09:35:04 INFO - PROCESS | 12729 | [#1] ext.html Cycles:180 Average:61660.90 Median:44032.56 stddev:114179.98 (259.3%) stddev-sans-first:114408.35 09:35:04 INFO - PROCESS | 12729 | Values: 633.2 638.5 678.1 687.8 711.7 41163.6 44989.1 45012.0 45221.1 45389.1 45706.5 46054.5 46108.5 46413.5 46459.8 8759.6 8851.5 8895.9 8909.8 8913.7 8686.9 8807.9 8864.2 8871.2 8877.4 8835.8 8849.3 8865.6 8868.2 8902.5 8784.7 8848.1 8853.2 8873.6 8875.6 8779.9 8840.1 8844.4 8847.4 8849.7 42401.2 42482.4 42667.1 42773.6 42783.4 3468.6 3525.2 3543.0 3546.8 3620.8 33169.8 33397.5 33766.0 33779.7 33803.5 3872.2 3983.5 3986.9 4019.4 4083.3 360767.0 360772.0 360966.2 361345.0 361686.0 64125.7 64273.0 64435.4 64451.0 64801.7 66465.3 66515.7 66605.7 66824.0 66937.0 19184.6 19244.6 19287.1 19393.0 19500.4 14804.5 14885.0 14949.6 15028.5 15039.9 17923.2 18951.6 18964.4 18990.4 19088.8 6436.4 6621.9 6622.6 6745.8 6778.6 1013.4 1055.2 1058.8 1148.0 1148.8 34007.8 34094.7 34216.3 34379.0 34439.1 962.3 1135.7 1152.9 1174.9 1218.0 17435.7 17843.0 17933.9 18045.7 18072.5 491220.0 491891.0 494365.0 494773.0 497612.0 63345.0 63574.0 63646.7 63671.0 63698.4 1391.5 1396.8 1414.8 1427.5 1434.8 32202.4 33367.7 33534.8 33617.0 34056.8 55664.7 55999.4 56132.7 56150.7 56167.7 431623.0 433807.0 433956.0 435018.0 435232.0 43142.4 44179.8 44763.6 45296.0 45324.8 50642.0 50986.7 51051.5 51248.5 52855.7 42940.6 43062.4 43885.3 44599.8 45819.5 42723.0 42924.1 43119.6 43322.0 44348.3 44580.8 47342.5 48485.0 48588.0 49980.0 42300.8 42692.4 43469.0 45871.0 47251.3 35472.5 36615.0 36736.6 36757.1 38548.0 09:35:04 INFO - PROCESS | 12729 | 09:35:04 INFO - PROCESS | 12729 | [#2] jquery.html Cycles:180 Average:30933.29 Median:23363.83 stddev:88234.20 (377.7%) stddev-sans-first:88451.93 09:35:04 INFO - PROCESS | 12729 | Values: 397.6 405.8 425.4 435.0 438.4 18515.4 19845.9 20094.9 20321.5 20848.4 19858.2 19904.3 20147.8 20339.3 20547.6 5496.9 5813.4 5817.6 5823.5 5829.0 4449.6 5196.9 5708.3 5740.2 6380.8 6442.5 6447.0 6500.6 6502.9 6508.3 5900.4 5923.5 5935.5 5993.7 6476.7 5768.4 5773.6 5774.9 5776.0 5776.8 14188.7 15449.4 22707.8 23303.5 23424.1 2375.6 2478.0 2490.4 2772.1 2995.1 10215.9 10793.2 11311.6 11391.3 11977.5 1954.0 1962.6 1980.4 2065.9 2069.8 85178.6 89693.6 91010.5 92273.5 92525.5 11029.9 11209.7 11226.9 11770.2 12438.4 16740.7 16823.2 16845.8 16861.2 16891.8 8664.0 8814.0 8872.1 8873.6 9063.9 8466.0 8664.4 8693.7 8712.7 8724.5 5079.8 5097.7 5132.5 5150.6 5177.1 2063.2 2067.4 2114.7 2124.6 2126.4 917.3 935.2 1014.1 1032.2 1038.4 18516.4 18856.2 19328.8 19764.7 19856.0 960.9 983.3 986.7 1000.2 1022.6 8894.2 10929.7 11000.2 11204.4 11216.3 518962.0 524656.0 527422.0 547953.0 551863.5 96042.5 100132.5 100143.5 101657.5 102053.5 1024.9 1028.5 1035.4 1095.3 1100.1 17920.8 18004.9 18513.2 18545.1 18859.2 43536.8 43665.6 44072.6 45909.5 46701.0 60595.7 60833.7 61100.4 62296.4 62548.1 8709.8 8939.5 9036.4 9057.5 9187.5 7877.0 11251.7 11487.8 12054.0 12389.9 10673.3 10719.2 10964.5 10965.6 11078.4 10560.6 10769.8 10771.0 10973.2 11045.9 11171.8 11314.4 11433.4 11457.7 11587.9 7697.6 8096.8 8926.7 9237.9 9239.7 11139.3 11173.8 11182.3 11279.7 11416.9 09:35:04 INFO - PROCESS | 12729 | 09:35:04 INFO - PROCESS | 12729 | [#3] mootools.html Cycles:180 Average:5916.79 Median:2613.23 stddev:3362.84 (128.7%) stddev-sans-first:3355.99 09:35:04 INFO - PROCESS | 12729 | Values: 1514.1 1544.8 1684.2 1777.9 1825.2 8134.1 8258.5 8376.3 8703.3 8708.4 8568.5 8868.5 8870.6 9141.4 9164.9 2466.4 2482.5 2487.5 2496.1 2498.4 2407.2 2478.4 2486.4 2510.5 2514.2 2423.3 2427.4 2461.8 2464.1 2474.4 2412.8 2437.6 2448.8 2453.3 2457.8 2418.7 2433.3 2452.5 2457.1 2463.6 8917.0 8956.0 9016.5 9130.3 9147.5 5503.3 5602.6 5611.2 5613.9 5623.3 3491.4 3541.9 3551.6 3596.0 3618.0 1065.7 1069.8 1095.1 1099.6 1108.2 12654.7 12749.6 12759.2 12796.0 12803.9 4749.9 4775.9 4796.1 4900.6 4971.1 10624.7 10652.8 10686.1 10709.3 10720.4 5568.9 5645.9 5674.6 5701.5 5703.4 4964.7 5100.0 5149.4 5157.7 5175.7 3811.5 3951.6 3953.9 3964.0 3984.4 1192.9 1194.5 1195.4 1209.8 1211.9 967.3 1007.6 1012.7 1015.3 1021.7 5970.0 5996.4 5996.6 6160.5 6239.5 470.3 476.6 477.4 487.8 489.3 4050.9 4093.9 4128.3 4140.5 4142.4 10839.3 11252.0 11412.1 11441.8 11467.7 11014.8 11062.5 11174.7 11185.8 11188.0 8311.1 8428.1 8429.6 8565.7 8637.0 5843.0 5873.2 5902.3 5968.2 5995.0 10062.5 10069.9 10183.1 10223.6 10259.0 10258.3 10355.2 10356.7 10487.5 10574.2 7486.7 7534.1 7577.3 7623.0 7668.2 8277.6 8393.4 8429.3 8440.7 8442.9 7774.8 7853.3 7862.4 7950.1 7963.0 7520.4 7588.0 7598.9 7638.7 7764.4 6940.1 6982.2 7034.9 7038.3 7271.5 5175.6 5254.3 5348.4 5382.1 5395.4 5259.8 5329.8 5377.6 5388.9 5413.0 09:35:04 INFO - PROCESS | 12729 | 09:35:04 INFO - PROCESS | 12729 | [#4] prototype.html Cycles:180 Average:4939.34 Median:5669.89 stddev:1459.34 (25.7%) stddev-sans-first:1422.34 09:35:04 INFO - PROCESS | 12729 | Values: 357.8 360.2 360.5 361.1 362.3 5644.2 5674.8 5675.5 5689.5 5695.4 5611.4 5634.0 5655.9 5665.0 5700.9 4212.3 4297.9 4353.7 4358.2 4388.2 4336.7 4338.2 4352.6 4357.8 4376.0 4312.9 4323.5 4342.8 4356.6 4362.4 4075.5 4329.1 4363.1 4368.8 4375.4 3843.3 3851.9 3857.2 3869.4 3871.5 5413.4 5454.9 5456.7 5457.8 5489.9 4946.8 4970.7 4984.8 4996.1 5032.5 5805.6 5806.2 5809.9 5821.6 5827.4 4204.9 4241.4 4247.8 4273.7 4321.1 5818.4 5850.9 5959.7 6048.5 6155.3 4147.2 4262.4 4269.4 4292.8 4298.4 4331.6 4343.6 4354.2 4358.3 4362.3 4895.6 4904.0 4947.3 4953.6 4990.0 5838.5 5845.1 5856.9 5868.3 5909.3 1439.3 1446.3 1448.8 1451.9 1454.0 971.0 998.0 998.4 1007.6 1020.7 5433.6 5459.5 5465.0 5472.5 5515.9 5760.3 5800.2 5800.8 5804.5 5819.2 5354.6 5451.5 5529.3 5698.8 5730.9 3102.7 3107.0 3124.8 3150.4 3164.8 5938.8 6020.1 6139.3 6167.6 6198.1 6135.2 6135.4 6148.1 6152.4 6160.8 6227.0 6291.7 6347.4 6360.9 6365.7 5933.6 5983.7 5990.9 5993.6 6022.3 5933.3 5982.2 5987.3 5989.3 6056.9 6148.2 6250.0 6256.9 6307.6 6424.2 4298.8 4339.0 4354.2 4369.3 4372.8 5821.7 6139.2 6156.8 6158.9 6160.8 5874.5 5924.8 5935.6 5937.7 5947.3 5883.8 5911.6 5950.7 5966.5 6021.1 5705.7 5831.4 5839.9 5870.7 5885.0 5900.4 5926.6 5929.6 5936.1 5964.9 5632.4 5806.9 5820.5 5862.5 5864.2 09:35:04 INFO - PROCESS | 12729 | 09:35:04 INFO - PROCESS | 12729 | [#5] yui.html Cycles:180 Average:17961.29 Median:25961.78 stddev:23250.99 (89.6%) stddev-sans-first:23280.25 09:35:04 INFO - PROCESS | 12729 | Values: 737.7 754.6 764.9 780.9 896.9 15268.9 16049.9 16208.1 16291.5 16333.8 14898.0 15115.8 15243.9 15583.7 15628.0 854.1 870.2 871.7 871.8 871.9 831.1 853.0 858.3 859.8 868.6 897.1 899.8 901.8 903.0 903.0 881.1 886.8 888.4 893.2 895.5 653.9 654.8 656.2 658.0 658.8 12863.8 12923.4 12940.5 12980.2 13745.2 11343.0 13729.0 13926.7 14252.9 14321.2 11514.4 11672.5 11844.8 12015.6 12159.7 3809.5 3829.8 3862.1 3872.7 3929.4 66856.3 66877.7 67985.3 68699.3 71842.1 9758.3 9942.6 10168.4 10216.9 10603.8 18958.8 19036.4 19136.6 19277.2 19529.3 7965.0 7979.8 8090.6 8141.5 8156.1 4617.6 4700.2 4704.7 4711.5 4724.7 3621.4 3634.2 3659.7 3688.0 3695.5 607.3 609.2 618.1 619.4 626.9 678.7 704.4 755.8 777.9 787.5 9376.2 9387.5 9395.6 9426.7 9548.0 746.7 762.5 778.8 780.2 790.0 4545.5 4573.9 4578.2 4702.3 4741.2 73442.6 76589.2 80862.2 83861.6 86237.6 71108.6 71897.6 72426.3 73144.9 73823.0 68882.0 68982.3 70818.6 71847.0 73595.0 9721.2 9920.6 10051.5 10153.8 10307.6 46126.0 47047.8 47212.1 47598.0 48752.0 64780.4 64952.0 65314.0 66770.3 66989.3 12024.9 12812.0 13197.6 13343.7 13804.2 13841.7 14077.6 14171.8 15067.4 15173.8 12397.8 13009.7 13382.0 13442.7 13476.4 14096.8 14099.6 14200.1 14820.6 15236.7 12660.6 12673.4 12828.2 13324.9 13686.2 11232.6 11299.3 11568.7 11728.5 11848.9 10817.7 11309.6 11371.9 11399.6 11555.8 09:35:04 INFO - PROCESS | 12729 | -------- Summary: end -------- 09:35:04 INFO - PROCESS | 12729 | 09:35:05 INFO - TEST-INFO | 12729: exit 0 09:35:05 INFO - TEST-OK | dromaeo_css | took 1113728ms 09:35:05 INFO - TEST-START | kraken 09:35:05 INFO - operating with platform_type : linux_ 09:35:05 INFO - Initialising browser for kraken test... 09:35:05 INFO - TEST-INFO | started process 13106 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBP9F_4/profile http://localhost:50840/getInfo.html) 09:35:09 INFO - PROCESS | 13106 | __metrics Screen width/height:1600/1200 09:35:09 INFO - PROCESS | 13106 | colorDepth:24 09:35:09 INFO - PROCESS | 13106 | Browser inner width/height: 1024/697 09:35:09 INFO - PROCESS | 13106 | __metrics 09:35:10 ERROR - PROCESS | 13106 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 09:35:10 INFO - TEST-INFO | 13106: exit 0 09:35:10 INFO - Browser initialized. 09:35:10 INFO - Running cycle 1/1 for kraken test... 09:35:10 INFO - TEST-INFO | started process 13236 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBP9F_4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:35:22 INFO - PROCESS | 13236 | RSS: Main: 151384064 09:35:22 INFO - PROCESS | 13236 | 09:35:25 INFO - PROCESS | 13236 | Cycle 1(1): loaded http://localhost:50840/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50840/tests/kraken/driver.html?testName=audio-beat-detection) 09:35:26 INFO - PROCESS | 13236 | RSS: Main: 156905472 09:35:26 INFO - PROCESS | 13236 | 09:35:28 INFO - PROCESS | 13236 | Cycle 1(1): loaded http://localhost:50840/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50840/tests/kraken/driver.html?testName=audio-dft) 09:35:29 INFO - PROCESS | 13236 | RSS: Main: 154693632 09:35:29 INFO - PROCESS | 13236 | 09:35:32 INFO - PROCESS | 13236 | Cycle 1(1): loaded http://localhost:50840/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50840/tests/kraken/driver.html?testName=audio-fft) 09:35:33 INFO - PROCESS | 13236 | RSS: Main: 155328512 09:35:33 INFO - PROCESS | 13236 | 09:35:35 INFO - PROCESS | 13236 | Cycle 1(1): loaded http://localhost:50840/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50840/tests/kraken/driver.html?testName=audio-oscillator) 09:35:35 INFO - PROCESS | 13236 | RSS: Main: 155127808 09:35:35 INFO - PROCESS | 13236 | 09:35:37 INFO - PROCESS | 13236 | Cycle 1(1): loaded http://localhost:50840/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50840/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:35:38 INFO - PROCESS | 13236 | RSS: Main: 155295744 09:35:38 INFO - PROCESS | 13236 | 09:35:41 INFO - PROCESS | 13236 | Cycle 1(1): loaded http://localhost:50840/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50840/tests/kraken/driver.html?testName=imaging-darkroom) 09:35:41 INFO - PROCESS | 13236 | RSS: Main: 158216192 09:35:41 INFO - PROCESS | 13236 | 09:35:45 INFO - PROCESS | 13236 | Cycle 1(1): loaded http://localhost:50840/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50840/tests/kraken/driver.html?testName=imaging-desaturate) 09:35:45 INFO - PROCESS | 13236 | RSS: Main: 158158848 09:35:45 INFO - PROCESS | 13236 | 09:35:48 INFO - PROCESS | 13236 | Cycle 1(1): loaded http://localhost:50840/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50840/tests/kraken/driver.html?testName=json-parse-financial) 09:35:49 INFO - PROCESS | 13236 | RSS: Main: 157900800 09:35:49 INFO - PROCESS | 13236 | 09:35:50 INFO - PROCESS | 13236 | Cycle 1(1): loaded http://localhost:50840/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50840/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:35:51 INFO - PROCESS | 13236 | RSS: Main: 157356032 09:35:51 INFO - PROCESS | 13236 | 09:35:53 INFO - PROCESS | 13236 | Cycle 1(1): loaded http://localhost:50840/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50840/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:35:53 INFO - PROCESS | 13236 | RSS: Main: 157089792 09:35:53 INFO - PROCESS | 13236 | 09:35:55 INFO - PROCESS | 13236 | Cycle 1(1): loaded http://localhost:50840/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50840/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:35:56 INFO - PROCESS | 13236 | RSS: Main: 157097984 09:35:56 INFO - PROCESS | 13236 | 09:35:58 INFO - PROCESS | 13236 | Cycle 1(1): loaded http://localhost:50840/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50840/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:35:59 INFO - PROCESS | 13236 | RSS: Main: 157855744 09:35:59 INFO - PROCESS | 13236 | 09:36:02 INFO - PROCESS | 13236 | Cycle 1(1): loaded http://localhost:50840/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50840/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:36:03 INFO - PROCESS | 13236 | RSS: Main: 158027776 09:36:03 INFO - PROCESS | 13236 | 09:36:04 INFO - PROCESS | 13236 | Cycle 1(1): loaded http://localhost:50840/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50840/tests/kraken/driver.html?testName=ai-astar) 09:36:04 INFO - PROCESS | 13236 | RSS: Main: 159604736 09:36:04 INFO - PROCESS | 13236 | 09:36:04 INFO - PROCESS | 13236 | __start_tp_report 09:36:04 INFO - PROCESS | 13236 | _x_x_mozilla_page_load 09:36:04 INFO - PROCESS | 13236 | _x_x_mozilla_page_load_details 09:36:04 INFO - PROCESS | 13236 | |i|pagename|runs| 09:36:04 INFO - PROCESS | 13236 | |0;ai-astar;104;113;112;113;112;114;112;112;112;113 09:36:04 INFO - PROCESS | 13236 | |1;audio-beat-detection;152;121;118;157;120;120;118;118;152;120 09:36:04 INFO - PROCESS | 13236 | |2;audio-dft;161;162;163;161;164;162;162;162;163;163 09:36:04 INFO - PROCESS | 13236 | |3;audio-fft;76;76;74;106;76;75;76;76;103;76 09:36:04 INFO - PROCESS | 13236 | |4;audio-oscillator;81;80;111;82;82;80;96;81;82;107 09:36:04 INFO - PROCESS | 13236 | |5;imaging-gaussian-blur;117;118;118;118;117;117;118;118;117;117 09:36:04 INFO - PROCESS | 13236 | |6;imaging-darkroom;147;148;146;148;147;147;148;147;158;148 09:36:04 INFO - PROCESS | 13236 | |7;imaging-desaturate;85;85;85;85;87;85;88;85;85;84 09:36:04 INFO - PROCESS | 13236 | |8;json-parse-financial;51;52;52;54;51;53;57;51;51;53 09:36:04 INFO - PROCESS | 13236 | |9;json-stringify-tinderbox;58;59;58;58;59;58;58;58;62;59 09:36:04 INFO - PROCESS | 13236 | |10;stanford-crypto-aes;75;76;75;81;75;81;74;75;75;82 09:36:04 INFO - PROCESS | 13236 | |11;stanford-crypto-ccm;145;123;126;130;121;123;121;140;172;135 09:36:04 INFO - PROCESS | 13236 | |12;stanford-crypto-pbkdf2;151;150;155;150;149;151;154;153;153;153 09:36:04 INFO - PROCESS | 13236 | |13;stanford-crypto-sha256-iterative;67;61;63;64;71;62;63;61;63;61 09:36:04 INFO - PROCESS | 13236 | __end_tp_report 09:36:04 INFO - PROCESS | 13236 | __start_cc_report 09:36:04 INFO - PROCESS | 13236 | _x_x_mozilla_cycle_collect,809 09:36:04 INFO - PROCESS | 13236 | __end_cc_report 09:36:04 INFO - PROCESS | 13236 | __startTimestamp1483810564922__endTimestamp 09:36:04 INFO - PROCESS | 13236 | 09:36:04 INFO - PROCESS | 13236 | ------- Summary: start ------- 09:36:04 INFO - PROCESS | 13236 | Number of tests: 14 09:36:04 INFO - PROCESS | 13236 | 09:36:04 INFO - PROCESS | 13236 | [#0] ai-astar Cycles:10 Average:111.70 Median:112.50 stddev:2.79 (2.5%) stddev-sans-first:0.73 09:36:04 INFO - PROCESS | 13236 | Values: 104.0 113.0 112.0 113.0 112.0 114.0 112.0 112.0 112.0 113.0 09:36:04 INFO - PROCESS | 13236 | 09:36:04 INFO - PROCESS | 13236 | [#1] audio-beat-detection Cycles:10 Average:129.60 Median:120.50 stddev:16.69 (13.9%) stddev-sans-first:15.62 09:36:04 INFO - PROCESS | 13236 | Values: 152.0 121.0 118.0 157.0 120.0 120.0 118.0 118.0 152.0 120.0 09:36:04 INFO - PROCESS | 13236 | 09:36:04 INFO - PROCESS | 13236 | [#2] audio-dft Cycles:10 Average:162.30 Median:162.50 stddev:0.95 (0.6%) stddev-sans-first:0.88 09:36:04 INFO - PROCESS | 13236 | Values: 161.0 162.0 163.0 161.0 164.0 162.0 162.0 162.0 163.0 163.0 09:36:04 INFO - PROCESS | 13236 | 09:36:04 INFO - PROCESS | 13236 | [#3] audio-fft Cycles:10 Average:81.40 Median:76.00 stddev:12.21 (16.1%) stddev-sans-first:12.80 09:36:04 INFO - PROCESS | 13236 | Values: 76.0 76.0 74.0 106.0 76.0 75.0 76.0 76.0 103.0 76.0 09:36:04 INFO - PROCESS | 13236 | 09:36:04 INFO - PROCESS | 13236 | [#4] audio-oscillator Cycles:10 Average:88.20 Median:81.50 stddev:11.96 (14.7%) stddev-sans-first:12.40 09:36:04 INFO - PROCESS | 13236 | Values: 81.0 80.0 111.0 82.0 82.0 80.0 96.0 81.0 82.0 107.0 09:36:04 INFO - PROCESS | 13236 | 09:36:04 INFO - PROCESS | 13236 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 09:36:04 INFO - PROCESS | 13236 | Values: 117.0 118.0 118.0 118.0 117.0 117.0 118.0 118.0 117.0 117.0 09:36:04 INFO - PROCESS | 13236 | 09:36:04 INFO - PROCESS | 13236 | [#6] imaging-darkroom Cycles:10 Average:148.40 Median:148.00 stddev:3.44 (2.3%) stddev-sans-first:3.61 09:36:04 INFO - PROCESS | 13236 | Values: 147.0 148.0 146.0 148.0 147.0 147.0 148.0 147.0 158.0 148.0 09:36:04 INFO - PROCESS | 13236 | 09:36:04 INFO - PROCESS | 13236 | [#7] imaging-desaturate Cycles:10 Average:85.40 Median:85.00 stddev:1.17 (1.4%) stddev-sans-first:1.24 09:36:04 INFO - PROCESS | 13236 | Values: 85.0 85.0 85.0 85.0 87.0 85.0 88.0 85.0 85.0 84.0 09:36:04 INFO - PROCESS | 13236 | 09:36:04 INFO - PROCESS | 13236 | [#8] json-parse-financial Cycles:10 Average:52.50 Median:52.50 stddev:1.90 (3.6%) stddev-sans-first:1.94 09:36:04 INFO - PROCESS | 13236 | Values: 51.0 52.0 52.0 54.0 51.0 53.0 57.0 51.0 51.0 53.0 09:36:04 INFO - PROCESS | 13236 | 09:36:04 INFO - PROCESS | 13236 | [#9] json-stringify-tinderbox Cycles:10 Average:58.70 Median:58.50 stddev:1.25 (2.1%) stddev-sans-first:1.30 09:36:04 INFO - PROCESS | 13236 | Values: 58.0 59.0 58.0 58.0 59.0 58.0 58.0 58.0 62.0 59.0 09:36:04 INFO - PROCESS | 13236 | 09:36:04 INFO - PROCESS | 13236 | [#10] stanford-crypto-aes Cycles:10 Average:76.90 Median:75.50 stddev:3.11 (4.1%) stddev-sans-first:3.22 09:36:04 INFO - PROCESS | 13236 | Values: 75.0 76.0 75.0 81.0 75.0 81.0 74.0 75.0 75.0 82.0 09:36:04 INFO - PROCESS | 13236 | 09:36:04 INFO - PROCESS | 13236 | [#11] stanford-crypto-ccm Cycles:10 Average:133.60 Median:132.50 stddev:15.85 (12.0%) stddev-sans-first:16.26 09:36:04 INFO - PROCESS | 13236 | Values: 145.0 123.0 126.0 130.0 121.0 123.0 121.0 140.0 172.0 135.0 09:36:04 INFO - PROCESS | 13236 | 09:36:04 INFO - PROCESS | 13236 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.90 Median:153.00 stddev:1.97 (1.3%) stddev-sans-first:2.06 09:36:04 INFO - PROCESS | 13236 | Values: 151.0 150.0 155.0 150.0 149.0 151.0 154.0 153.0 153.0 153.0 09:36:04 INFO - PROCESS | 13236 | 09:36:04 INFO - PROCESS | 13236 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.60 Median:63.00 stddev:3.17 (5.0%) stddev-sans-first:3.11 09:36:04 INFO - PROCESS | 13236 | Values: 67.0 61.0 63.0 64.0 71.0 62.0 63.0 61.0 63.0 61.0 09:36:04 INFO - PROCESS | 13236 | -------- Summary: end -------- 09:36:04 INFO - PROCESS | 13236 | 09:36:05 INFO - TEST-INFO | 13236: exit 0 09:36:05 INFO - TEST-OK | kraken | took 60764ms 09:36:05 INFO - SUITE-END | took 1174s 09:36:06 INFO - Completed test suite (00:19:34) 09:36:06 INFO - javascript benchmark 09:36:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7491.390771386808, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3251.447253966826, 3262.200760813601, 3268.689474499923, 3282.3927573398914, 3287.09604858664, 5687.345955215152, 5747.568932330071, 5749.137629355599, 5750.626209296403, 5751.367349591542, 5741.971290143554, 5746.454086861752, 5789.855253618662, 5809.128630705396, 5826.941730582693, 5197.064528384889, 5241.737913104349, 5257.7108259045735, 5283.8150664726745, 5296.993571221475, 5302.496262855023, 5305.257263983045, 5305.814296499623, 5313.0967735485065, 5336.91994620081, 5152.587792976572, 5166.5866730661455, 5299.470052994689, 5304.177852432879, 5316.0, 5203.765830537635, 5210.999999999981, 5250.81622143227, 5252.658577192489, 5290.0477913975465, 5187.533122019036, 5204.557612602934, 5208.0, 5225.973870130663, 5316.3620365556, 5719.256496655408, 5759.740811663485, 5815.505682017034, 5824.0390335594575, 5847.06446968483, 6079.939200608026, 6123.557162997608, 6135.569531795964, 6231.719572619243, 6248.531360147962, 6130.816075517741, 6144.477719393857, 6162.198914141178, 6174.5060395168275, 6191.566590338678, 5635.69003704792, 5662.37713851476, 5769.884602307972, 5780.653160810365, 5805.216295800097, 6200.193974783249, 6281.466075383643, 6288.465480434214, 6374.490040796818, 6389.233292004897, 6062.969685151546, 6091.0, 6092.786752463642, 6100.908486372708, 6127.662978536134, 5979.431953964367, 6185.721642526097, 6201.782937597162, 6203.906941395882, 6210.472109870621, 5955.910661340084, 6044.939550604526, 6059.030555111161, 6076.088586712029, 6133.2734575755485, 6111.95640283616, 6171.9691401542705, 6176.258848938156, 6178.876422471525, 6182.474489668339, 4772.785224664898, 4775.355327030807, 4776.641751868624, 4777.976110119496, 4795.424549054136, 4130.690198235085, 4135.958640413617, 4190.099128687286, 4191.580841915845, 4252.936205956913, 5959.1657167995645, 5963.0459126539545, 5965.254343207099, 5977.402259774075, 6014.308354539196, 6013.0, 6251.187345645128, 6258.123862659231, 6280.152179455807, 6281.937180628227, 5666.546676265889, 5702.914456283159, 5726.713664316851, 5771.451712087345, 5920.674362910081, 5237.9476205238225, 5274.7626356814035, 5276.419593844674, 5284.0, 5287.312649355559, 6387.712552935036, 6392.0411938209645, 6408.2630497492455, 6416.101745755598, 6418.29398766126, 5913.793017244376, 6028.125921741411, 6076.3012253591405, 6110.57225994194, 6126.969365153146, 6397.072424498515, 6419.903701444388, 6422.229332480132, 6425.9036114457385, 6442.806715798533, 6084.178635884099, 6093.2078829751845, 6096.390360963868, 6102.298235702951, 6103.206583144163, 5854.677992710442, 5986.850328741816, 6122.97760420812, 6153.046277826944, 6248.12526246335, 6117.309816958451, 6121.696863452088, 6137.616878446366, 6140.166841500682, 6147.200863887666, 6092.208012958287, 6095.939040609537, 6116.8776624468155, 6121.479674227562, 6123.0, 5858.443447872616, 5879.529637628894, 5959.344472107978, 6032.155498230163, 6085.513158947185, 6100.176476175659, 6126.264848218242, 6143.447089761943, 6153.077038444269, 6176.722047507783, 5998.850028749316, 6011.098335249748, 6011.098335249748, 6035.698215089315, 6044.365341639064], "value": 5690.507499674316, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [633.2211380002595, 638.4541217259242, 678.0710426715398, 687.7799104286627, 711.7366574367485, 41163.58836411639, 44989.10021799562, 45011.999999999956, 45221.09557808846, 45389.092218155616, 45706.54293457073, 46054.539454605445, 46108.53891461084, 46413.535864641344, 46459.76770116144, 8759.649614015447, 8851.513166775825, 8895.866562001574, 8909.777255568597, 8913.68802091927, 8686.913130868674, 8807.911920880773, 8864.246539044188, 8871.157240062184, 8877.422967507091, 8835.823283534326, 8849.33629977751, 8865.601047952858, 8868.201861832435, 8902.510361930092, 8784.692535761249, 8848.115188481164, 8853.24747396472, 8873.600687969025, 8875.600597973074, 8779.868301975475, 8840.115988401172, 8844.42511236774, 8847.380683352168, 8849.734507964771, 42401.151976960595, 42482.36276455856, 42667.146657066995, 42773.57226427758, 42783.35824962628, 3468.6357932417236, 3525.189206482498, 3542.964570354315, 3546.7871927684164, 3620.7646502977223, 33169.83415082933, 33397.53714826129, 33766.0, 33779.6622033779, 33803.4929476058, 3872.206197729487, 3983.50206224222, 3986.9401958970348, 4019.41718450823, 4083.2854250506043, 360767.0, 360772.0, 360966.1951690251, 361345.0, 361686.0, 64125.67937160378, 64273.0, 64435.35564644387, 64451.0, 64801.67599161974, 66465.33534664591, 66515.66742166258, 66605.66697166483, 66824.0, 66937.0, 19184.61630767377, 19244.61510769777, 19287.132079056475, 19393.0, 19500.414987550397, 14804.481843135654, 14885.0, 14949.626259343386, 15028.474003410047, 15039.924800375928, 17923.226296954534, 18951.62096758057, 18964.43106706801, 18990.43028709141, 19088.809111908704, 6436.420722135031, 6621.86756264872, 6622.602643841288, 6745.797626071226, 6778.627175505296, 1013.3919648211162, 1055.1875056206677, 1058.7829494953517, 1147.9897690032717, 1148.7587606602708, 34007.82996085053, 34094.65905340965, 34216.31567368639, 34379.0, 34439.139021524665, 962.2686758063921, 1135.6990397544657, 1152.8962393384636, 1174.9412529373496, 1217.9829842081783, 17435.73846392305, 17843.0, 17933.910330448525, 18045.7293140603, 18072.457826265232, 491220.0, 491891.0, 494365.0, 494773.0, 497612.0, 63345.0, 63574.046389304196, 63646.6817665918, 63671.0, 63698.36301636924, 1391.506015364531, 1396.76255036644, 1414.7736362182002, 1427.4789701758784, 1434.8349939756645, 32202.35595288128, 33367.66632333645, 33534.832325838215, 33617.0, 34056.829715852255, 55664.721676392975, 55999.44000559942, 56132.71933640305, 56150.71924640514, 56167.71916140393, 431623.0, 433807.0, 433956.0, 435018.0, 435232.0, 43142.35286470642, 44179.77910110429, 44763.55236447594, 45296.0, 45324.773376134224, 50642.0, 50986.745066275915, 51051.48948510616, 51248.48751512437, 52855.73572132115, 42940.570594294906, 43062.35406468843, 43885.34171987359, 44599.77700111479, 45819.541804581524, 42723.0, 42924.14151716886, 43119.56880431156, 43322.0, 44348.33477497775, 44580.77709611431, 47342.52657473519, 48485.0, 48588.0, 49980.0, 42300.78849605855, 42692.35961460643, 43469.0, 45871.0, 47251.291230632254, 35472.46284669846, 36615.0, 36736.63263367332, 36757.08107297339, 38548.0], "value": 21390.424573311866, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [397.60636969400264, 405.8011574328578, 425.3810705423609, 434.96520278377733, 438.44317716500046, 18515.35196268131, 19845.900770496162, 20094.89952550237, 20321.49196270094, 20848.374548763524, 19858.205671773147, 19904.303349382775, 20147.798522014775, 20339.28812491563, 20547.589048219026, 5496.890062198753, 5813.360530341659, 5817.563682723791, 5823.475887170154, 5829.0, 4449.644028477714, 5196.8826702259, 5708.343540492834, 5740.225069615591, 6380.808575742735, 6442.516811239152, 6446.967765161167, 6500.6099634021875, 6502.9349706503035, 6508.284088750233, 5900.380460051697, 5923.496502797268, 5935.465808077251, 5993.670348130851, 6476.676166191695, 5768.394318596529, 5773.566982476331, 5774.855628609276, 5776.046952252873, 5776.768929242825, 14188.716225675533, 15449.38202471911, 22707.772922270895, 23303.53392932149, 23424.126069914368, 2375.643653451996, 2478.008796481404, 2490.3898544856625, 2772.057500449857, 2995.086498617921, 10215.897841021644, 10793.244472886901, 11311.604093856675, 11391.316521008683, 11977.520899164023, 1953.9706904396446, 1962.578045720177, 1980.366282789508, 2065.855390122692, 2069.7619773726065, 85178.5741071297, 89693.55153224258, 91010.5449472755, 92273.53863230709, 92525.53737231271, 11029.944850275697, 11209.719757005976, 11226.887731122748, 11770.17608767378, 12438.440270187863, 16740.6651866962, 16823.15884205785, 16845.83154168467, 16861.241244144043, 16891.831081689026, 8664.0, 8813.955930220307, 8872.112788721077, 8873.645054197888, 9063.909360906438, 8465.957670211732, 8664.436811607226, 8693.695720649746, 8712.738617841474, 8724.476531408136, 5079.822206222764, 5097.6941383517105, 5132.538071573576, 5150.562202212854, 5177.068127737043, 2063.2469148760592, 2067.379786064175, 2114.714513540683, 2124.585705787357, 2126.362091372582, 917.3440989692402, 935.1863878425677, 1014.1329163565193, 1032.2361452525226, 1038.382162613244, 18516.444506664553, 18856.245750170114, 19328.806711932983, 19764.70352944707, 19856.00719963996, 960.870282511852, 983.2871168402851, 986.713852982627, 1000.2498126405196, 1022.601185537641, 8894.243989260856, 10929.672109836718, 11000.22998390121, 11204.439778011067, 11216.270942388881, 518962.0, 524656.0, 527422.0, 547953.0, 551863.5495897122, 96042.51978740061, 100132.49933750284, 100143.49928250312, 101657.49171254097, 102053.48973255235, 1024.8667673202435, 1028.5063169678597, 1035.435687550287, 1095.3482677806692, 1100.1089117814436, 17920.820791791914, 18004.90997545004, 18513.166907489463, 18545.07274636236, 18859.15133818954, 43536.78231608822, 43665.56334436615, 44072.55927440813, 45909.540904591864, 46701.0, 60595.697021514614, 60833.695831520556, 61100.38899610947, 62296.37703622906, 62548.11200975802, 8709.782255443664, 8939.508327042075, 9036.367454278137, 9057.501837399006, 9187.540622968958, 7877.0, 11251.718707032389, 11487.8276825846, 12054.0, 12389.93805030969, 10673.252872298865, 10719.24965252456, 10964.451777411257, 10965.61620343284, 11078.446077695922, 10560.577576896838, 10769.784604307713, 10771.0, 10973.23187376876, 11045.889541104807, 11171.776564468502, 11314.377709226072, 11433.428328583705, 11457.656270311903, 11587.88412115868, 7697.576633285223, 8096.797580060545, 8926.68756593516, 9237.907620923974, 9239.676611318571, 11139.33164010162, 11173.776524469302, 11182.32906025641, 11279.718007049889, 11416.885831141582], "value": 9487.466229811775, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1514.136941943092, 1544.7837302777614, 1684.2252563820641, 1777.884437511561, 1825.224279681136, 8134.105248422668, 8258.50448973062, 8376.329893608512, 8703.347248956323, 8708.43395179313, 8568.528730919797, 8868.512231827246, 8870.645174193025, 9141.360104792668, 9164.908350916505, 2466.358746725851, 2482.5407299649623, 2487.502499500098, 2496.051500429843, 2498.362917456046, 2407.2296865003204, 2478.39279376553, 2486.428121532049, 2510.535550923085, 2514.208024472285, 2423.260905423845, 2427.4416884116663, 2461.8153638477097, 2464.149868295435, 2474.3690358958443, 2412.831101822864, 2437.5856104462196, 2448.8490409507504, 2453.276283496373, 2457.8033757299463, 2418.697662792151, 2433.2943446400523, 2452.5340185364726, 2457.0908763757348, 2463.6304554316816, 8917.0, 8955.955220223923, 9016.549172541412, 9130.31522635805, 9147.496887671176, 5503.257060296849, 5602.635828671164, 5611.242482264924, 5613.915791263134, 5623.297087864017, 3491.3640201647845, 3541.9291614167573, 3551.6093229744706, 3595.982020089883, 3618.023133753898, 1065.7016035509992, 1069.7539565899808, 1095.1348434736549, 1099.6261271167841, 1108.174410064499, 12654.746905061847, 12749.553765618159, 12759.234445933274, 12796.040296977764, 12803.871961280454, 4749.857504274877, 4775.948630440993, 4796.088743138793, 4900.607951363882, 4971.105201063771, 10624.734381640521, 10652.786944261072, 10686.091682206945, 10709.303895246783, 10720.35677859331, 5568.888622227614, 5645.915311270334, 5674.574406919498, 5701.543876489871, 5703.372629010805, 4964.652474326835, 5099.974500127476, 5149.356330458692, 5157.6647517911215, 5175.715335656575, 3811.4663947047434, 3951.6245956634075, 3953.920921581552, 3964.0, 3984.362501999666, 1192.9164958452998, 1194.50428072349, 1195.384377045822, 1209.848768903887, 1211.9030477561773, 967.2987084363921, 1007.5919252702668, 1012.6961911426542, 1015.3095894791466, 1021.7190272675074, 5969.970150149222, 5996.430339117864, 5996.640201587918, 6160.537959653044, 6239.532035097295, 470.33212837770446, 476.6067993905042, 477.4413935695245, 487.7707477485576, 489.3345050731003, 4050.8987275317763, 4093.89765255871, 4128.277551428488, 4140.482439695038, 4142.378643203483, 10839.349639021526, 11252.0, 11412.087033037336, 11441.828372574419, 11467.713307167222, 11014.834777478345, 11062.502187401586, 11174.66476005721, 11185.832212516818, 11188.0, 8311.085780564134, 8428.0729119798, 8429.620667069996, 8565.743027709053, 8636.956815215884, 5843.0, 5873.177755114373, 5902.321233058254, 5968.194293770285, 5995.0, 10062.547185376528, 10069.899301006895, 10183.083522482715, 10223.642172523925, 10259.0, 10258.333208341433, 10355.171586272929, 10356.689299321033, 10487.475626218811, 10574.154067674413, 7486.7005319786595, 7534.133574638768, 7577.280158384945, 7623.047119110111, 7668.194839541991, 8277.62750676233, 8393.412461127662, 8429.283510901396, 8440.704575339834, 8442.915570844212, 7774.766756997299, 7853.293203611703, 7862.410319225966, 7950.085740139958, 7962.960185199037, 7520.435967302365, 7587.975623291006, 7598.924010759822, 7638.732644357421, 7764.378849691898, 6940.063091482787, 6982.197047339621, 7034.894476582957, 7038.331358520933, 7271.454640901848, 5175.560077393313, 5254.343207099113, 5348.384935732441, 5382.058139825594, 5395.379531353788, 5259.8422047338645, 5329.7868085277705, 5377.623566350474, 5388.892222155457, 5413.025655382069], "value": 4668.3574497860955, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.75315032627486, 360.24348867378507, 360.49170669356215, 361.13868423809225, 362.2736413490951, 5644.153376993453, 5674.779922316701, 5675.51758100562, 5689.4879460848615, 5695.373508914016, 5611.382747897728, 5634.0, 5655.943440565593, 5665.0, 5700.857478563038, 4212.283911735005, 4297.935530967038, 4353.651707863379, 4358.150160718661, 4388.210122178007, 4336.7181133226395, 4338.2191205582985, 4352.586504282088, 4357.782110894458, 4376.0, 4312.892177695551, 4323.524412314643, 4342.804573794187, 4356.617555281512, 4362.367456718774, 4075.4905636795547, 4329.112531930978, 4363.123856741599, 4368.825246990116, 4375.365571992043, 3843.327417701891, 3851.903702407434, 3857.209272099241, 3869.4195870619633, 3871.457995880579, 5413.404525502192, 5454.945450545523, 5456.699881506555, 5457.754401051922, 5489.87457571201, 4946.752662366867, 4970.676906001098, 4984.825531106394, 4996.100701873661, 5032.4967503249745, 5805.564582656318, 5806.2451881255165, 5809.92516384466, 5821.563382746311, 5827.35899051104, 4204.894877628053, 4241.384999175102, 4247.8300867965245, 4273.658107351435, 4321.114171594815, 5818.41815818419, 5850.9414905851245, 5959.702014899238, 6048.485878700316, 6155.322914479404, 4147.212029714345, 4262.445882035316, 4269.402283680287, 4292.785360732013, 4298.398224248608, 4331.6318112960125, 4343.630791382705, 4354.216241076573, 4358.259095953696, 4362.345648152739, 4895.632827537949, 4904.0, 4947.282644016669, 4953.628477864103, 4989.975050124799, 5838.5329173666005, 5845.1232315153065, 5856.94143058564, 5868.325142608569, 5909.349971503131, 1439.2659743530664, 1446.2985452055746, 1448.7826825975976, 1451.9400837388555, 1453.978190327146, 970.96601618943, 998.0, 998.4308943901906, 1007.5591903577954, 1020.698893826323, 5433.576846586625, 5459.481349271813, 5465.0, 5472.452754724496, 5515.889682206333, 5760.337561180434, 5800.216970708901, 5800.837254843193, 5804.477597016289, 5819.214406055213, 5354.571634269249, 5451.509364157245, 5529.263014807696, 5698.8290351289525, 5730.942690573124, 3102.6968673156875, 3107.021288294225, 3124.7656425767705, 3150.401423729484, 3164.7784655074383, 5938.8218353449465, 6020.1036673447725, 6139.26328840542, 6167.629942203482, 6198.078595635277, 6135.233095863017, 6135.386461353829, 6148.077788331786, 6152.3540028297275, 6160.845978850564, 6227.003679411272, 6291.678747462993, 6347.429291137097, 6360.936390636127, 6365.713542890581, 5933.643981361132, 5983.730732116978, 5990.891685038282, 5993.550483713826, 6022.307434645072, 5933.288005439203, 5982.205338398376, 5987.251593550806, 5989.251343582052, 6056.939430605637, 6148.231471066117, 6249.96875015622, 6256.874862502816, 6307.590006649553, 6424.229092508929, 4298.785060747013, 4339.0, 4354.2162410765095, 4369.344598310279, 4372.759498227628, 5821.650700957956, 6139.171211886338, 6156.815295540961, 6158.860610787019, 6160.753569857335, 5874.500667443144, 5924.763009479572, 5935.584509084322, 5937.732802023833, 5947.256592925884, 5883.794067207627, 5911.556633252438, 5950.672713000827, 5966.463018328372, 6021.066734656135, 5705.7432415542235, 5831.35855055935, 5839.8832023358445, 5870.735816888336, 5885.0, 5900.350961394329, 5926.644401335933, 5929.6145750526075, 5936.13925980739, 5964.910526342195, 5632.408597097409, 5806.854828629149, 5820.476157145878, 5862.501687356452, 5864.208331875313], "value": 4474.9790588207925, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [737.697544006957, 754.630231186718, 764.9349805266555, 780.8711562592172, 896.9058248883865, 15268.92365538172, 16049.919750401232, 16208.108554029524, 16291.51125466235, 16333.754993675104, 14898.0, 15115.84884151161, 15243.923780381083, 15583.688326233469, 15628.0, 854.0647990450462, 870.2254993056185, 871.7471933139382, 871.7733389318792, 871.8561437362828, 831.0899564976341, 853.0, 858.2618947704968, 859.7807559072428, 868.6395146014396, 897.1432282170545, 899.7525680437899, 901.7520181949983, 903.0, 903.0202230579796, 881.066069965835, 886.7738726624734, 888.3736965439382, 893.2496702769705, 895.5164211325877, 653.9149910511651, 654.754467074847, 656.1633916756174, 657.9868402631921, 658.8254112660148, 12863.807042894365, 12923.418446169944, 12940.547080852219, 12980.221186728826, 13745.24401157936, 11343.0, 13728.970327225397, 13926.721465570632, 14252.928735356361, 14321.212333321662, 11514.424278786028, 11672.474738636782, 11844.763104737944, 12015.639530814089, 12159.696007599792, 3809.5428548574073, 3829.8276577554075, 3862.092408284051, 3872.7482713623526, 3929.4105884117325, 66856.33143668549, 66877.66561167211, 67985.32014679839, 68699.31300687029, 71842.12631494734, 9758.268129890286, 9942.552585133686, 10168.440735759605, 10216.948915255376, 10603.840942385716, 18958.810411895705, 19036.42890713281, 19136.61726765457, 19277.22891084341, 19529.316473923343, 7965.0, 7979.800504987422, 8090.555019473868, 8141.4708043978135, 8156.0620528639965, 4617.561331673485, 4700.153972285021, 4704.670673052922, 4711.505291944297, 4724.740139292372, 3621.4386770050683, 3634.23681026982, 3659.688926441282, 3688.0226739913946, 3695.464157697119, 607.3289015637657, 609.2475792396386, 618.0667192539298, 619.3991827926903, 626.8808926303988, 678.6538865178695, 704.3766266853769, 755.8261599831959, 777.9105402878628, 787.5353541410595, 9376.203022743006, 9387.5306234688, 9395.62417503306, 9426.717198484057, 9547.997460266712, 746.7461063238525, 762.4738930138187, 778.8325510015261, 780.1940049296308, 789.9960500197462, 4545.545445455428, 4573.931391029138, 4578.153041687298, 4702.27114797207, 4741.217699079613, 73442.63278683572, 76589.23410765933, 80862.19137808665, 83861.58069209615, 86237.5688121568, 71108.64445677842, 71897.64051179815, 72426.275737243, 73144.90282645765, 73823.0, 68882.0, 68982.3101768986, 70818.64590677117, 71846.99999999895, 73595.0, 9721.173700235558, 9920.553575088994, 10051.547680354548, 10153.84769228477, 10307.639232626821, 46126.0, 47047.764761175975, 47212.055758883944, 47598.0, 48752.0, 64780.35219647743, 64952.0, 65314.0, 66770.33229667641, 66989.33010669831, 12024.879751202376, 12812.0, 13197.604071877859, 13343.66640833987, 13804.240766757523, 13841.723165536834, 14077.577672669837, 14171.787423188454, 15067.397304107713, 15173.772393414329, 12397.814032789334, 13009.674758131123, 13381.996350273963, 13442.663933401744, 13476.393562289917, 14096.788548171991, 14099.647508812363, 14200.076994995292, 14820.629484262548, 15236.695266094837, 12660.620181394574, 12673.429695663901, 12828.230306181658, 13324.933375333061, 13686.247256400993, 11232.55069797199, 11299.265547739371, 11568.652940411464, 11728.530858765555, 11848.940755296167, 10817.729556761144, 11309.604163854226, 11371.943140284246, 11399.601013964802, 11555.768884622092], "value": 7325.799680785022, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1461.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 113.0, 112.0, 113.0, 112.0, 114.0, 112.0, 112.0, 112.0, 113.0], "value": 111.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 121.0, 118.0, 157.0, 120.0, 120.0, 118.0, 118.0, 152.0, 120.0], "value": 129.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 163.0, 161.0, 164.0, 162.0, 162.0, 162.0, 163.0, 163.0], "value": 162.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 74.0, 106.0, 76.0, 75.0, 76.0, 76.0, 103.0, 76.0], "value": 81.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 111.0, 82.0, 82.0, 80.0, 96.0, 81.0, 82.0, 107.0], "value": 88.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 118.0, 117.0, 117.0, 118.0, 118.0, 117.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 146.0, 148.0, 147.0, 147.0, 148.0, 147.0, 158.0, 148.0], "value": 148.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 85.0, 85.0, 87.0, 85.0, 88.0, 85.0, 85.0, 84.0], "value": 85.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 52.0, 52.0, 54.0, 51.0, 53.0, 57.0, 51.0, 51.0, 53.0], "value": 52.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 58.0, 58.0, 59.0, 58.0, 58.0, 58.0, 62.0, 59.0], "value": 58.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 81.0, 75.0, 81.0, 74.0, 75.0, 75.0, 82.0], "value": 76.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 123.0, 126.0, 130.0, 121.0, 123.0, 121.0, 140.0, 172.0, 135.0], "value": 133.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 150.0, 155.0, 150.0, 149.0, 151.0, 154.0, 153.0, 153.0, 153.0], "value": 151.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 61.0, 63.0, 64.0, 71.0, 62.0, 63.0, 61.0, 63.0, 61.0], "value": 63.6, "unit": "score"}]}]} 09:36:06 INFO - Return code: 0 09:36:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:36:06 ERROR - # TBPL SUCCESS # 09:36:06 INFO - Running post-action listener: _resource_record_post_action 09:36:06 INFO - [mozharness: 2017-01-07 17:36:06.235780Z] Finished run-tests step (success) 09:36:06 INFO - Running post-run listener: _resource_record_post_run 09:36:06 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 577536; Write bytes: 355733504; Read time: 76; Write time: 256732 09:36:06 INFO - TinderboxPrint: CPU usage
13.3% 09:36:06 INFO - TinderboxPrint: I/O read bytes / time
577,536 / 76 09:36:06 INFO - TinderboxPrint: I/O write bytes / time
355,733,504 / 256,732 09:36:06 INFO - TinderboxPrint: CPU idle
8,237.2 (86.7%) 09:36:06 INFO - TinderboxPrint: CPU user
1,206.5 (12.7%) 09:36:06 INFO - TinderboxPrint: Swap in / out
0 / 0 09:36:06 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 107593728; Read time: 0; Write time: 103856 09:36:06 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 573440; Write bytes: 247234560; Read time: 64; Write time: 152840 09:36:06 INFO - Running post-run listener: _upload_blobber_files 09:36:06 INFO - Blob upload gear active. 09:36:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:36:06 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 09:36:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:36:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:36:07 INFO - (blobuploader) - INFO - Open directory for files ... 09:36:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:36:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:36:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:36:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:36:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:36:10 INFO - (blobuploader) - INFO - Done attempting. 09:36:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:36:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:36:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:36:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:36:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:36:12 INFO - (blobuploader) - INFO - Done attempting. 09:36:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:36:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:36:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:36:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:36:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:36:12 INFO - (blobuploader) - INFO - Done attempting. 09:36:12 INFO - (blobuploader) - INFO - Iteration through files over. 09:36:12 INFO - Return code: 0 09:36:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:36:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:36:12 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f8b9c0f6ead58707d56c140020f6797dbc1e013c6197132e1ad8329b9908a8eb3ee5255f1ee6b5a57e20a7a27ab2501452b34d6e4aa2126c955942709cafab68", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/70af15fe2415526bba55f5c0ddb0eaf30588e9a07ce744c5b8a3bdcc9ccb895c2aa396fe74678c78cc909325790c97ea872e56056cad248814afe757bda08d5f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/401907c40c069252377fe85167ba397c726db13b760ae391e1b67b368ca8c90c7da594f3c4a2b6588a37e530b280c6b614fe367922b373940be41250bfbdbf99"} 09:36:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:36:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:36:12 INFO - Contents: 09:36:12 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f8b9c0f6ead58707d56c140020f6797dbc1e013c6197132e1ad8329b9908a8eb3ee5255f1ee6b5a57e20a7a27ab2501452b34d6e4aa2126c955942709cafab68", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/70af15fe2415526bba55f5c0ddb0eaf30588e9a07ce744c5b8a3bdcc9ccb895c2aa396fe74678c78cc909325790c97ea872e56056cad248814afe757bda08d5f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/401907c40c069252377fe85167ba397c726db13b760ae391e1b67b368ca8c90c7da594f3c4a2b6588a37e530b280c6b614fe367922b373940be41250bfbdbf99"} 09:36:12 INFO - Running post-run listener: copy_logs_to_upload_dir 09:36:12 INFO - Copying logs to upload dir... 09:36:12 INFO - mkdir: /builds/slave/test/build/upload/logs 09:36:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.063870 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2017-01-07 09:36:13.017834) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-07 09:36:13.021014) ========= 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=3836458cccd887f2d2de3cf1000001de-1483809336.140793-1983133787 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f8b9c0f6ead58707d56c140020f6797dbc1e013c6197132e1ad8329b9908a8eb3ee5255f1ee6b5a57e20a7a27ab2501452b34d6e4aa2126c955942709cafab68", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/70af15fe2415526bba55f5c0ddb0eaf30588e9a07ce744c5b8a3bdcc9ccb895c2aa396fe74678c78cc909325790c97ea872e56056cad248814afe757bda08d5f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/401907c40c069252377fe85167ba397c726db13b760ae391e1b67b368ca8c90c7da594f3c4a2b6588a37e530b280c6b614fe367922b373940be41250bfbdbf99"} build_url:https://queue.taskcluster.net/v1/task/Q1l_5u-vRHummv2lizuMBg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011490 build_url: 'https://queue.taskcluster.net/v1/task/Q1l_5u-vRHummv2lizuMBg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f8b9c0f6ead58707d56c140020f6797dbc1e013c6197132e1ad8329b9908a8eb3ee5255f1ee6b5a57e20a7a27ab2501452b34d6e4aa2126c955942709cafab68", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/70af15fe2415526bba55f5c0ddb0eaf30588e9a07ce744c5b8a3bdcc9ccb895c2aa396fe74678c78cc909325790c97ea872e56056cad248814afe757bda08d5f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/401907c40c069252377fe85167ba397c726db13b760ae391e1b67b368ca8c90c7da594f3c4a2b6588a37e530b280c6b614fe367922b373940be41250bfbdbf99"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-07 09:36:13.046591) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-07 09:36:13.046962) ========= 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=3836458cccd887f2d2de3cf1000001de-1483809336.140793-1983133787 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004480 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-07 09:36:13.131026) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-07 09:36:13.131348) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-07 09:36:13.131814) ========= ========= Total master_lag: 0.18 =========