builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-026 starttime: 1477359722.17 results: success (0) buildid: 20161024183304 builduid: f3117079ab0040009e247401ca205526 revision: b6571211c807e209e550833eb47dfc08a4c6ae53 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-24 18:42:02.165905) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-24 18:42:02.166418) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-24 18:42:02.166725) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-24 18:42:02.182138) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 18:42:02.182553) ========= 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=41bf3e9aed84707956354da8000001c5-1477359721.921871-20206468 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-24 18:42:02-- 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% 88.5M=0s 2016-10-24 18:42:02 (88.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.141865 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 18:42:02.338630) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 18:42:02.338984) ========= 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=41bf3e9aed84707956354da8000001c5-1477359721.921871-20206468 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015614 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 18:42:02.389293) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-24 18:42:02.389670) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev b6571211c807e209e550833eb47dfc08a4c6ae53 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev b6571211c807e209e550833eb47dfc08a4c6ae53 --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=41bf3e9aed84707956354da8000001c5-1477359721.921871-20206468 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-24 18:42:02,917 truncating revision to first 12 chars 2016-10-24 18:42:02,917 Setting DEBUG logging. 2016-10-24 18:42:02,917 attempt 1/10 2016-10-24 18:42:02,917 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/b6571211c807?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-24 18:42:04,109 unpacking tar archive at: fx-team-b6571211c807/testing/mozharness/ program finished with exit code 0 elapsedTime=1.493232 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-24 18:42:03.896367) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-24 18:42:03.896686) ========= script_repo_revision: b6571211c807e209e550833eb47dfc08a4c6ae53 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-24 18:42:03.897094) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-24 18:42:03.897388) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-24 18:42:03.909985) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-10-24 18:42:03.910403) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=41bf3e9aed84707956354da8000001c5-1477359721.921871-20206468 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:42:04 INFO - MultiFileLogger online at 20161024 18:42:04 in /builds/slave/test 18:42:04 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 18:42:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:42:04 INFO - {'append_to_log': False, 18:42:04 INFO - 'base_work_dir': '/builds/slave/test', 18:42:04 INFO - 'blob_upload_branch': 'Fx-Team', 18:42:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:42:04 INFO - 'branch': 'Fx-Team', 18:42:04 INFO - 'buildbot_json_path': 'buildprops.json', 18:42:04 INFO - 'config_files': ('talos/linux_config.py',), 18:42:04 INFO - 'default_actions': ('clobber', 18:42:04 INFO - 'read-buildbot-config', 18:42:04 INFO - 'download-and-extract', 18:42:04 INFO - 'populate-webroot', 18:42:04 INFO - 'create-virtualenv', 18:42:04 INFO - 'install', 18:42:04 INFO - 'run-tests'), 18:42:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:42:04 INFO - 'download_minidump_stackwalk': True, 18:42:04 INFO - 'download_symbols': 'ondemand', 18:42:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:42:04 INFO - 'tooltool.py': '/tools/tooltool.py', 18:42:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:42:04 INFO - '/tools/misc-python/virtualenv.py')}, 18:42:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:42:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:42:04 INFO - 'installer_path': 'installer.exe', 18:42:04 INFO - 'log_level': 'info', 18:42:04 INFO - 'log_name': 'talos', 18:42:04 INFO - 'log_to_console': True, 18:42:04 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:42:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:42:04 INFO - 'opt_config_files': (), 18:42:04 INFO - 'pip_index': False, 18:42:04 INFO - 'sps_profile': False, 18:42:04 INFO - 'sps_profile_interval': 0, 18:42:04 INFO - 'suite': 'dromaeojs-e10s', 18:42:04 INFO - 'system_bits': '32', 18:42:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:42:04 INFO - 'title': 'talos-linux64-ix-026', 18:42:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:42:04 INFO - 'use_talos_json': True, 18:42:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:42:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:42:04 INFO - 'work_dir': 'build'} 18:42:04 INFO - [mozharness: 2016-10-25 01:42:04.532323Z] Running clobber step. 18:42:04 INFO - Running pre-action listener: _resource_record_pre_action 18:42:04 INFO - Running main action method: clobber 18:42:04 INFO - rmtree: /builds/slave/test/build 18:42:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:42:04 INFO - Running post-action listener: _resource_record_post_action 18:42:04 INFO - [mozharness: 2016-10-25 01:42:04.994371Z] Finished clobber step (success) 18:42:04 INFO - [mozharness: 2016-10-25 01:42:04.994472Z] Running read-buildbot-config step. 18:42:04 INFO - Running pre-action listener: _resource_record_pre_action 18:42:04 INFO - Running main action method: read_buildbot_config 18:42:04 INFO - Using buildbot properties: 18:42:04 INFO - { 18:42:04 INFO - "project": "", 18:42:04 INFO - "product": "firefox", 18:42:04 INFO - "script_repo_revision": "production", 18:42:04 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 18:42:04 INFO - "repository": "", 18:42:04 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 18:42:04 INFO - "buildid": "20161024183304", 18:42:04 INFO - "stage_platform": "linux64-pgo", 18:42:04 INFO - "basedir": "/builds/slave/test", 18:42:04 INFO - "buildnumber": 845, 18:42:04 INFO - "platform": "ubuntu64_hw", 18:42:04 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 18:42:04 INFO - "slavebuilddir": "test", 18:42:04 INFO - "branch": "fx-team", 18:42:04 INFO - "revision": "b6571211c807e209e550833eb47dfc08a4c6ae53", 18:42:04 INFO - "slavename": "talos-linux64-ix-026", 18:42:04 INFO - "builduid": "f3117079ab0040009e247401ca205526", 18:42:04 INFO - "repo_path": "integration/fx-team" 18:42:04 INFO - } 18:42:04 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477348234/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 18:42:04 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477348234/firefox-52.0a1.en-US.linux-x86_64.test_packages.json. 18:42:04 INFO - Running post-action listener: _resource_record_post_action 18:42:04 INFO - [mozharness: 2016-10-25 01:42:04.996830Z] Finished read-buildbot-config step (success) 18:42:04 INFO - [mozharness: 2016-10-25 01:42:04.996916Z] Running download-and-extract step. 18:42:04 INFO - Running pre-action listener: _resource_record_pre_action 18:42:04 INFO - Running main action method: download_and_extract 18:42:04 INFO - mkdir: /builds/slave/test/build/tests 18:42:04 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')]} 18:42:04 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477348234/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 18:42:04 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477348234/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 18:42:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477348234/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 18:42:05 INFO - Downloaded 1361 bytes. 18:42:05 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 18:42:05 INFO - Using the following test package requirements: 18:42:05 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 18:42:05 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:42:05 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:42:05 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:42:05 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:42:05 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:42:05 INFO - u'jsshell-linux-x86_64.zip'], 18:42:05 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:42:05 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:42:05 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 18:42:05 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:42:05 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:42:05 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:42:05 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:42:05 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:42:05 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:42:05 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:42:05 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:42:05 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:42:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477348234/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 18:42:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477348234/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:42:05 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477348234/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 18:42:05 INFO - Http code: 200 18:42:05 INFO - via: 1.1 ae162f6796e551002447afd7c07ec67a.cloudfront.net (CloudFront) 18:42:05 INFO - x-amz-cf-id: H3NqKdQs8EGMoKQks0f1p8YbDu6OAZPRDA6_Wk7j8u9Axkz-2r1urw== 18:42:05 INFO - x-amz-replication-status: COMPLETED 18:42:05 INFO - x-amz-version-id: Ud.qfa84lm6eQ5BSOKfORghQ0SOoE81B 18:42:05 INFO - Expected file size: 22021843 18:42:05 INFO - Obtained file size: 22021843 18:42:09 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 18:42:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477348234/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 18:42:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477348234/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:42:09 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477348234/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 18:42:09 INFO - Http code: 200 18:42:09 INFO - via: 1.1 6cd88b9fd84ad5daa3b3867fb8c5c91a.cloudfront.net (CloudFront) 18:42:09 INFO - x-amz-cf-id: MLZ0VpdSP9sjVA4cdgMWFm1xB9VzHnW_8lysEJlLIbVHsyIVscLQdA== 18:42:09 INFO - x-amz-replication-status: COMPLETED 18:42:09 INFO - x-amz-version-id: Ud.qfa84lm6eQ5BSOKfORghQ0SOoE81B 18:42:09 INFO - Expected file size: 22021843 18:42:09 INFO - Obtained file size: 22021843 18:42:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477348234/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 18:42:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477348234/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 18:42:14 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477348234/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 18:42:14 INFO - Http code: 200 18:42:14 INFO - via: 1.1 24b0e5a3429d07ef12381da50e07f70f.cloudfront.net (CloudFront) 18:42:14 INFO - x-amz-cf-id: xVnFVEn7cZztfuou8uxoPnPTYz21Wgz0OcRRt3482pER6sFPH4vl_A== 18:42:14 INFO - x-amz-replication-status: COMPLETED 18:42:14 INFO - x-amz-version-id: oenI_sZRW87EdrewdmEEIPc75eIJqG54 18:42:14 INFO - Expected file size: 14409028 18:42:14 INFO - Obtained file size: 14409028 18:42: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')]} 18:42:14 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477348234/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:42:14 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477348234/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:42:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477348234/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 18:42:15 INFO - Downloaded 59396065 bytes. 18:42:15 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477348234/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:42:15 INFO - mkdir: /builds/slave/test/properties 18:42:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:42:15 INFO - Writing to file /builds/slave/test/properties/build_url 18:42:15 INFO - Contents: 18:42:15 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477348234/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:42:15 INFO - Running post-action listener: _resource_record_post_action 18:42:15 INFO - Running post-action listener: set_extra_try_arguments 18:42:15 INFO - [mozharness: 2016-10-25 01:42:15.974120Z] Finished download-and-extract step (success) 18:42:15 INFO - [mozharness: 2016-10-25 01:42:15.974345Z] Running populate-webroot step. 18:42:15 INFO - Running pre-action listener: _resource_record_pre_action 18:42:15 INFO - Running main action method: populate_webroot 18:42:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:42:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:42:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:42:15 INFO - '--tppagecycles', 18:42:15 INFO - '7'], 18:42:15 INFO - 'tests': ['tsvgm']}}, 18:42:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:42:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:42:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:42:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:42:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:42:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:42:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:42:15 INFO - 'talos_options': ['--disable-e10s'], 18:42:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:42:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:42:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:42:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:42:15 INFO - 'talos_options': ['--disable-e10s'], 18:42:15 INFO - 'tests': ['damp', 'tps']}, 18:42:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:42:15 INFO - 'tests': ['damp', 'tps']}, 18:42:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:42:15 INFO - 'tests': ['dromaeo_dom']}, 18:42:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:42:15 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:42:15 INFO - 'tests': ['basic_compositor_video']}, 18:42:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:42:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:42:15 INFO - 'tests': ['a11yr', 18:42:15 INFO - 'ts_paint', 18:42:15 INFO - 'tpaint', 18:42:15 INFO - 'sessionrestore', 18:42:15 INFO - 'sessionrestore_no_auto_restore', 18:42:15 INFO - 'tabpaint']}, 18:42:15 INFO - 'other-e10s': {'tests': ['a11yr', 18:42:15 INFO - 'ts_paint', 18:42:15 INFO - 'tpaint', 18:42:15 INFO - 'sessionrestore', 18:42:15 INFO - 'sessionrestore_no_auto_restore', 18:42:15 INFO - 'tabpaint']}, 18:42:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:42:15 INFO - 'ts_paint', 18:42:15 INFO - 'tpaint', 18:42:15 INFO - 'sessionrestore', 18:42:15 INFO - 'sessionrestore_no_auto_restore', 18:42:15 INFO - 'tabpaint']}, 18:42:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:42:15 INFO - 'ts_paint', 18:42:15 INFO - 'tpaint', 18:42:15 INFO - 'sessionrestore', 18:42:15 INFO - 'sessionrestore_no_auto_restore', 18:42:15 INFO - 'tabpaint']}, 18:42:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:42:15 INFO - 'tests': ['a11yr', 18:42:15 INFO - 'ts_paint', 18:42:15 INFO - 'tpaint', 18:42:15 INFO - 'sessionrestore', 18:42:15 INFO - 'sessionrestore_no_auto_restore', 18:42:15 INFO - 'tabpaint']}, 18:42:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:42:15 INFO - 'tests': ['a11yr', 18:42:15 INFO - 'ts_paint', 18:42:15 INFO - 'tpaint', 18:42:15 INFO - 'sessionrestore', 18:42:15 INFO - 'sessionrestore_no_auto_restore', 18:42:15 INFO - 'tabpaint']}, 18:42:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:42:15 INFO - 'tests': ['tsvgx', 18:42:15 INFO - 'tsvgr_opacity', 18:42:15 INFO - 'tart', 18:42:15 INFO - 'tscrollx', 18:42:15 INFO - 'cart']}, 18:42:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:42:15 INFO - 'tsvgr_opacity', 18:42:15 INFO - 'tart', 18:42:15 INFO - 'tscrollx', 18:42:15 INFO - 'cart']}, 18:42:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:42:15 INFO - 'talos_options': ['--disable-e10s'], 18:42:15 INFO - 'tests': ['tp5o']}, 18:42:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:42:15 INFO - 'tests': ['tp5o']}, 18:42:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:42:15 INFO - 'talos_options': ['--disable-e10s', 18:42:15 INFO - '--xperf_path', 18:42:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:42:15 INFO - 'tests': ['tp5n']}, 18:42:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:42:15 INFO - 'talos_options': ['--xperf_path', 18:42:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:42:15 INFO - 'tests': ['tp5n']}}, 18:42:15 INFO - 'talos.zip': {'path': '', 18:42:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:42:15 INFO - Running post-action listener: _resource_record_post_action 18:42:15 INFO - [mozharness: 2016-10-25 01:42:15.996115Z] Finished populate-webroot step (success) 18:42:15 INFO - [mozharness: 2016-10-25 01:42:15.996203Z] Running create-virtualenv step. 18:42:15 INFO - Running pre-action listener: _resource_record_pre_action 18:42:15 INFO - Running main action method: create_virtualenv 18:42:15 INFO - Creating virtualenv /builds/slave/test/build/venv 18:42:15 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 18:42:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:42:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:42:16 INFO - Using real prefix '/usr' 18:42:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:42:16 INFO - Installing distribute.............................................................................................................................................................................................done. 18:42:18 INFO - Installing pip.................done. 18:42:18 INFO - Return code: 0 18:42:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:42:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:42:18 INFO - Reading from file tmpfile_stdout 18:42:18 INFO - Output received: 18:42:18 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) 18:42:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:42:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:42:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:42:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:42:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:42:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:42:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:42:18 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 0x7f5d5e097f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14017b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1490790>, '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 0x1491690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1491b20>, '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': '41bf3e9aed84707956354da8000001c5-1477359721.921871-20206468', '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 18:42:18 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 18:42:18 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 18:42:18 INFO - Using env: {'DISPLAY': ':0', 18:42:18 INFO - 'HOME': '/home/cltbld', 18:42:18 INFO - 'LANG': 'en_US.UTF-8', 18:42:18 INFO - 'LANGUAGE': 'en_US:en', 18:42:18 INFO - 'LOGNAME': 'cltbld', 18:42:18 INFO - 'MAIL': '/var/mail/cltbld', 18:42:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:42:18 INFO - 'MOZ_NO_REMOTE': '1', 18:42:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:42:18 INFO - 'NO_EM_RESTART': '1', 18:42:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:42:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:42:18 INFO - 'PWD': '/builds/slave/test', 18:42:18 INFO - 'SHELL': '/bin/bash', 18:42:18 INFO - 'SHLVL': '1', 18:42:18 INFO - 'TERM': 'linux', 18:42:18 INFO - 'TMOUT': '86400', 18:42:18 INFO - 'USER': 'cltbld', 18:42:18 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1477359721.921871-20206468', 18:42:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:42:18 INFO - '_': '/tools/buildbot/bin/python'} 18:42:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:42:18 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 18:42:18 INFO - Cleaning up... 18:42:18 INFO - Return code: 0 18:42:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:42:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:42:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:42:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:42:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:42:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:42:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:42:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5d5e097f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14017b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1490790>, '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 0x1491690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1491b20>, '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': '41bf3e9aed84707956354da8000001c5-1477359721.921871-20206468', '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 18:42:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 18:42:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 18:42:19 INFO - Using env: {'DISPLAY': ':0', 18:42:19 INFO - 'HOME': '/home/cltbld', 18:42:19 INFO - 'LANG': 'en_US.UTF-8', 18:42:19 INFO - 'LANGUAGE': 'en_US:en', 18:42:19 INFO - 'LOGNAME': 'cltbld', 18:42:19 INFO - 'MAIL': '/var/mail/cltbld', 18:42:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:42:19 INFO - 'MOZ_NO_REMOTE': '1', 18:42:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:42:19 INFO - 'NO_EM_RESTART': '1', 18:42:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:42:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:42:19 INFO - 'PWD': '/builds/slave/test', 18:42:19 INFO - 'SHELL': '/bin/bash', 18:42:19 INFO - 'SHLVL': '1', 18:42:19 INFO - 'TERM': 'linux', 18:42:19 INFO - 'TMOUT': '86400', 18:42:19 INFO - 'USER': 'cltbld', 18:42:19 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1477359721.921871-20206468', 18:42:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:42:19 INFO - '_': '/tools/buildbot/bin/python'} 18:42:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:42:19 INFO - Downloading/unpacking psutil>=3.1.1 18:42:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:42:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:42:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:42:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:42:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:42:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:42:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:42:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:42:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:42:21 INFO - Installing collected packages: psutil 18:42:21 INFO - Running setup.py install for psutil 18:42:21 INFO - building 'psutil._psutil_linux' extension 18:42:21 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 18:42:21 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 18:42:21 INFO - building 'psutil._psutil_posix' extension 18:42:21 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 18:42:21 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 18:42:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:42:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:42:21 INFO - Successfully installed psutil 18:42:21 INFO - Cleaning up... 18:42:21 INFO - Return code: 0 18:42:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:42:21 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')]} 18:42:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:42:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:42:21 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')]} 18:42:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:42:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:42:21 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 0x7f5d5e097f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14017b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1490790>, '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 0x1491690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1491b20>, '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': '41bf3e9aed84707956354da8000001c5-1477359721.921871-20206468', '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 18:42:21 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 18:42:21 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 18:42:21 INFO - Using env: {'DISPLAY': ':0', 18:42:21 INFO - 'HOME': '/home/cltbld', 18:42:21 INFO - 'LANG': 'en_US.UTF-8', 18:42:21 INFO - 'LANGUAGE': 'en_US:en', 18:42:21 INFO - 'LOGNAME': 'cltbld', 18:42:21 INFO - 'MAIL': '/var/mail/cltbld', 18:42:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:42:21 INFO - 'MOZ_NO_REMOTE': '1', 18:42:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:42:21 INFO - 'NO_EM_RESTART': '1', 18:42:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:42:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:42:21 INFO - 'PWD': '/builds/slave/test', 18:42:21 INFO - 'SHELL': '/bin/bash', 18:42:21 INFO - 'SHLVL': '1', 18:42:21 INFO - 'TERM': 'linux', 18:42:21 INFO - 'TMOUT': '86400', 18:42:21 INFO - 'USER': 'cltbld', 18:42:21 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1477359721.921871-20206468', 18:42:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:42:21 INFO - '_': '/tools/buildbot/bin/python'} 18:42:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:42:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:42:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:42:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:42:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:42:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:42:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:42:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:42:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:42:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:42:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:42:24 INFO - Installing collected packages: mozsystemmonitor 18:42:24 INFO - Running setup.py install for mozsystemmonitor 18:42:24 INFO - Successfully installed mozsystemmonitor 18:42:24 INFO - Cleaning up... 18:42:24 INFO - Return code: 0 18:42:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:42:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:42:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:42:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:42:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:42:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:42:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:42:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5d5e097f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14017b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1490790>, '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 0x1491690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1491b20>, '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': '41bf3e9aed84707956354da8000001c5-1477359721.921871-20206468', '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 18:42:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 18:42:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 18:42:24 INFO - Using env: {'DISPLAY': ':0', 18:42:24 INFO - 'HOME': '/home/cltbld', 18:42:24 INFO - 'LANG': 'en_US.UTF-8', 18:42:24 INFO - 'LANGUAGE': 'en_US:en', 18:42:24 INFO - 'LOGNAME': 'cltbld', 18:42:24 INFO - 'MAIL': '/var/mail/cltbld', 18:42:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:42:24 INFO - 'MOZ_NO_REMOTE': '1', 18:42:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:42:24 INFO - 'NO_EM_RESTART': '1', 18:42:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:42:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:42:24 INFO - 'PWD': '/builds/slave/test', 18:42:24 INFO - 'SHELL': '/bin/bash', 18:42:24 INFO - 'SHLVL': '1', 18:42:24 INFO - 'TERM': 'linux', 18:42:24 INFO - 'TMOUT': '86400', 18:42:24 INFO - 'USER': 'cltbld', 18:42:24 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1477359721.921871-20206468', 18:42:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:42:24 INFO - '_': '/tools/buildbot/bin/python'} 18:42:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:42:24 INFO - Downloading/unpacking jsonschema==2.5.1 18:42:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:42:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:42:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:42:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:42:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:42:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:42:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:42:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:42:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:42:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:42:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:42:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:42:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:42:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:42:26 INFO - Downloading functools32-3.2.3-2.tar.gz 18:42:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:42:26 INFO - warning: no files found matching '*.txt' 18:42:26 INFO - no previously-included directories found matching 'build' 18:42:26 INFO - no previously-included directories found matching 'dist' 18:42:26 INFO - no previously-included directories found matching '.git*' 18:42:26 INFO - Installing collected packages: jsonschema, functools32 18:42:26 INFO - Running setup.py install for functools32 18:42:26 INFO - warning: no files found matching '*.txt' 18:42:26 INFO - no previously-included directories found matching 'build' 18:42:26 INFO - no previously-included directories found matching 'dist' 18:42:26 INFO - no previously-included directories found matching '.git*' 18:42:26 INFO - Successfully installed jsonschema functools32 18:42:26 INFO - Cleaning up... 18:42:26 INFO - Return code: 0 18:42:26 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:42:26 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')]} 18:42:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:42:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:42:26 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')]} 18:42:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:42:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:42:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f5d5e097f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14017b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1490790>, '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 0x1491690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1491b20>, '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': '41bf3e9aed84707956354da8000001c5-1477359721.921871-20206468', '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 18:42:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 18:42:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 18:42:26 INFO - Using env: {'DISPLAY': ':0', 18:42:26 INFO - 'HOME': '/home/cltbld', 18:42:26 INFO - 'LANG': 'en_US.UTF-8', 18:42:26 INFO - 'LANGUAGE': 'en_US:en', 18:42:26 INFO - 'LOGNAME': 'cltbld', 18:42:26 INFO - 'MAIL': '/var/mail/cltbld', 18:42:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:42:26 INFO - 'MOZ_NO_REMOTE': '1', 18:42:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:42:26 INFO - 'NO_EM_RESTART': '1', 18:42:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:42:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:42:26 INFO - 'PWD': '/builds/slave/test', 18:42:26 INFO - 'SHELL': '/bin/bash', 18:42:26 INFO - 'SHLVL': '1', 18:42:26 INFO - 'TERM': 'linux', 18:42:26 INFO - 'TMOUT': '86400', 18:42:26 INFO - 'USER': 'cltbld', 18:42:26 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1477359721.921871-20206468', 18:42:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:42:26 INFO - '_': '/tools/buildbot/bin/python'} 18:42:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:42:27 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:42:27 INFO - Cleaning up... 18:42:27 INFO - Return code: 0 18:42:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:42:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:42:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:42:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:42:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:42:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:42:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:42:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5d5e097f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14017b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1490790>, '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 0x1491690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1491b20>, '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': '41bf3e9aed84707956354da8000001c5-1477359721.921871-20206468', '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 18:42:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:42:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:42:27 INFO - Using env: {'DISPLAY': ':0', 18:42:27 INFO - 'HOME': '/home/cltbld', 18:42:27 INFO - 'LANG': 'en_US.UTF-8', 18:42:27 INFO - 'LANGUAGE': 'en_US:en', 18:42:27 INFO - 'LOGNAME': 'cltbld', 18:42:27 INFO - 'MAIL': '/var/mail/cltbld', 18:42:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:42:27 INFO - 'MOZ_NO_REMOTE': '1', 18:42:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:42:27 INFO - 'NO_EM_RESTART': '1', 18:42:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:42:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:42:27 INFO - 'PWD': '/builds/slave/test', 18:42:27 INFO - 'SHELL': '/bin/bash', 18:42:27 INFO - 'SHLVL': '1', 18:42:27 INFO - 'TERM': 'linux', 18:42:27 INFO - 'TMOUT': '86400', 18:42:27 INFO - 'USER': 'cltbld', 18:42:27 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1477359721.921871-20206468', 18:42:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:42:27 INFO - '_': '/tools/buildbot/bin/python'} 18:42:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:42:27 INFO - Downloading/unpacking blobuploader==1.2.4 18:42:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:42:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:42:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:42:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:42:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:42:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:42:29 INFO - Downloading blobuploader-1.2.4.tar.gz 18:42:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:42:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:42:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:42:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:42:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:42:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:42:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:42:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:42:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:42:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:42:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:42:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:42:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:42:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:42:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:42:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:42:30 INFO - Downloading docopt-0.6.1.tar.gz 18:42:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:42:30 INFO - Installing collected packages: blobuploader, requests, docopt 18:42:30 INFO - Running setup.py install for blobuploader 18:42:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:42:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:42:30 INFO - Running setup.py install for requests 18:42:30 INFO - Running setup.py install for docopt 18:42:30 INFO - Successfully installed blobuploader requests docopt 18:42:30 INFO - Cleaning up... 18:42:30 INFO - Return code: 0 18:42:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:42:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:42:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:42:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:42:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:42:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:42:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:42:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5d5e097f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14017b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1490790>, '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 0x1491690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1491b20>, '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': '41bf3e9aed84707956354da8000001c5-1477359721.921871-20206468', '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 18:42:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:42:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:42:30 INFO - Using env: {'DISPLAY': ':0', 18:42:30 INFO - 'HOME': '/home/cltbld', 18:42:30 INFO - 'LANG': 'en_US.UTF-8', 18:42:30 INFO - 'LANGUAGE': 'en_US:en', 18:42:30 INFO - 'LOGNAME': 'cltbld', 18:42:30 INFO - 'MAIL': '/var/mail/cltbld', 18:42:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:42:30 INFO - 'MOZ_NO_REMOTE': '1', 18:42:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:42:30 INFO - 'NO_EM_RESTART': '1', 18:42:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:42:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:42:30 INFO - 'PWD': '/builds/slave/test', 18:42:30 INFO - 'SHELL': '/bin/bash', 18:42:30 INFO - 'SHLVL': '1', 18:42:30 INFO - 'TERM': 'linux', 18:42:30 INFO - 'TMOUT': '86400', 18:42:30 INFO - 'USER': 'cltbld', 18:42:30 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1477359721.921871-20206468', 18:42:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:42:30 INFO - '_': '/tools/buildbot/bin/python'} 18:42:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:42:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:42:30 INFO - Running setup.py (path:/tmp/pip-W4Hj2o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:42:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:42:31 INFO - Running setup.py (path:/tmp/pip-k2ECrb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:42:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:42:31 INFO - Running setup.py (path:/tmp/pip-KbnPR6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:42:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:42:31 INFO - Running setup.py (path:/tmp/pip-DVoBWY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:42:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:42:31 INFO - Running setup.py (path:/tmp/pip-5YrdKV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:42:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:42:31 INFO - Running setup.py (path:/tmp/pip-HY45Iu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:42:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:42:31 INFO - Running setup.py (path:/tmp/pip-mpgEYu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:42:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:42:31 INFO - Running setup.py (path:/tmp/pip-TEU65i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:42:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:42:31 INFO - Running setup.py (path:/tmp/pip-qF5jwP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:42:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:42:31 INFO - Running setup.py (path:/tmp/pip-03YhSt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:42:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:42:31 INFO - Running setup.py (path:/tmp/pip-HiyMxF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:42:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:42:31 INFO - Running setup.py (path:/tmp/pip-rO5Hpt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:42:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:42:31 INFO - Running setup.py (path:/tmp/pip-bzbo6R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:42:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:42:31 INFO - Running setup.py (path:/tmp/pip-oI0FYL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:42:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:42:31 INFO - Running setup.py (path:/tmp/pip-n6pc7Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:42:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:42:32 INFO - Running setup.py (path:/tmp/pip-L_S2TN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:42:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:42:32 INFO - Running setup.py (path:/tmp/pip-NwlLEU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:42:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:42:32 INFO - Running setup.py install for manifestparser 18:42:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:42:32 INFO - Running setup.py install for mozcrash 18:42:32 INFO - Running setup.py install for mozdebug 18:42:32 INFO - Running setup.py install for mozdevice 18:42:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:42:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:42:32 INFO - Running setup.py install for mozfile 18:42:32 INFO - Running setup.py install for mozhttpd 18:42:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:42:32 INFO - Running setup.py install for mozinfo 18:42:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:42:32 INFO - Running setup.py install for mozInstall 18:42:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:42:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:42:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:42:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:42:33 INFO - Running setup.py install for mozleak 18:42:33 INFO - Running setup.py install for mozlog 18:42:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:42:33 INFO - Running setup.py install for moznetwork 18:42:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:42:33 INFO - Running setup.py install for mozprocess 18:42:33 INFO - Running setup.py install for mozprofile 18:42:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:42:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:42:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:42:33 INFO - Running setup.py install for mozrunner 18:42:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:42:33 INFO - Running setup.py install for mozscreenshot 18:42:33 INFO - Running setup.py install for moztest 18:42:33 INFO - Running setup.py install for mozversion 18:42:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:42:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:42:33 INFO - Cleaning up... 18:42:33 INFO - Return code: 0 18:42:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:42:33 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')]} 18:42:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:42:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:42:33 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')]} 18:42:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:42:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:42:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5d5e097f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14017b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1490790>, '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 0x1491690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1491b20>, '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': '41bf3e9aed84707956354da8000001c5-1477359721.921871-20206468', '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 18:42:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:42:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:42:34 INFO - Using env: {'DISPLAY': ':0', 18:42:34 INFO - 'HOME': '/home/cltbld', 18:42:34 INFO - 'LANG': 'en_US.UTF-8', 18:42:34 INFO - 'LANGUAGE': 'en_US:en', 18:42:34 INFO - 'LOGNAME': 'cltbld', 18:42:34 INFO - 'MAIL': '/var/mail/cltbld', 18:42:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:42:34 INFO - 'MOZ_NO_REMOTE': '1', 18:42:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:42:34 INFO - 'NO_EM_RESTART': '1', 18:42:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:42:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:42:34 INFO - 'PWD': '/builds/slave/test', 18:42:34 INFO - 'SHELL': '/bin/bash', 18:42:34 INFO - 'SHLVL': '1', 18:42:34 INFO - 'TERM': 'linux', 18:42:34 INFO - 'TMOUT': '86400', 18:42:34 INFO - 'USER': 'cltbld', 18:42:34 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1477359721.921871-20206468', 18:42:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:42:34 INFO - '_': '/tools/buildbot/bin/python'} 18:42:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:42:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:42:34 INFO - Running setup.py (path:/tmp/pip-AhXbhk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:42:34 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 18:42:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:42:34 INFO - Running setup.py (path:/tmp/pip-06MxVF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:42:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:42:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:42:34 INFO - Running setup.py (path:/tmp/pip-qP8RNC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:42:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:42:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:42:34 INFO - Running setup.py (path:/tmp/pip-IAZT8g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:42:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:42:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:42:34 INFO - Running setup.py (path:/tmp/pip-aOkhr8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:42:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 18:42:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:42:34 INFO - Running setup.py (path:/tmp/pip-1fg9rb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:42:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 18:42:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:42:34 INFO - Running setup.py (path:/tmp/pip-PF4fOx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:42:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 18:42:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:42:34 INFO - Running setup.py (path:/tmp/pip-YW9emD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:42:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 18:42:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:42:34 INFO - Running setup.py (path:/tmp/pip-ekv2wU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:42:34 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)) 18:42:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:42:34 INFO - Running setup.py (path:/tmp/pip-OUCL8f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:42:34 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)) 18:42:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:42:34 INFO - Running setup.py (path:/tmp/pip-r11EoI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:42:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 18:42:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:42:35 INFO - Running setup.py (path:/tmp/pip-TzyNEC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:42:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 18:42:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:42:35 INFO - Running setup.py (path:/tmp/pip-3TONbh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:42:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 18:42:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:42:35 INFO - Running setup.py (path:/tmp/pip-y1kIy0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:42:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 18:42:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:42:35 INFO - Running setup.py (path:/tmp/pip-5OebE5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:42:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 18:42:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:42:35 INFO - Running setup.py (path:/tmp/pip-XGgtJ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:42:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 18:42:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:42:35 INFO - Running setup.py (path:/tmp/pip-lcQEjc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:42:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 18:42:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:42:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:42:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:42:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:42:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:42:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:42:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:42:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:42:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:42:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:42:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:42:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:42:37 INFO - Downloading blessings-1.6.tar.gz 18:42:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:42:37 INFO - Installing collected packages: blessings 18:42:37 INFO - Running setup.py install for blessings 18:42:37 INFO - Successfully installed blessings 18:42:37 INFO - Cleaning up... 18:42:37 INFO - Return code: 0 18:42:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:42:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:42:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:42:37 INFO - Reading from file tmpfile_stdout 18:42:37 INFO - Current package versions: 18:42:37 INFO - argparse == 1.2.1 18:42:37 INFO - blessings == 1.6 18:42:37 INFO - blobuploader == 1.2.4 18:42:37 INFO - docopt == 0.6.1 18:42:37 INFO - functools32 == 3.2.3-2 18:42:37 INFO - jsonschema == 2.5.1 18:42:37 INFO - manifestparser == 1.1 18:42:37 INFO - mozInstall == 1.12 18:42:37 INFO - mozcrash == 0.17 18:42:37 INFO - mozdebug == 0.1 18:42:37 INFO - mozdevice == 0.48 18:42:37 INFO - mozfile == 1.2 18:42:37 INFO - mozhttpd == 0.7 18:42:37 INFO - mozinfo == 0.9 18:42:37 INFO - mozleak == 0.1 18:42:37 INFO - mozlog == 3.4 18:42:37 INFO - moznetwork == 0.27 18:42:37 INFO - mozprocess == 0.23 18:42:37 INFO - mozprofile == 0.28 18:42:37 INFO - mozrunner == 6.12 18:42:37 INFO - mozscreenshot == 0.1 18:42:37 INFO - mozsystemmonitor == 0.3 18:42:37 INFO - moztest == 0.7 18:42:37 INFO - mozversion == 1.4 18:42:37 INFO - psutil == 3.1.1 18:42:37 INFO - requests == 1.2.3 18:42:37 INFO - wsgiref == 0.1.2 18:42:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:42:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:42:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:42:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:42:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:42:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:42:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:42:37 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 0x7f5d5e097f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14017b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1490790>, '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 0x1491690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1491b20>, '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': '41bf3e9aed84707956354da8000001c5-1477359721.921871-20206468', '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 18:42:37 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 18:42:37 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 18:42:37 INFO - Using env: {'DISPLAY': ':0', 18:42:37 INFO - 'HOME': '/home/cltbld', 18:42:37 INFO - 'LANG': 'en_US.UTF-8', 18:42:37 INFO - 'LANGUAGE': 'en_US:en', 18:42:37 INFO - 'LOGNAME': 'cltbld', 18:42:37 INFO - 'MAIL': '/var/mail/cltbld', 18:42:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:42:37 INFO - 'MOZ_NO_REMOTE': '1', 18:42:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:42:37 INFO - 'NO_EM_RESTART': '1', 18:42:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:42:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:42:37 INFO - 'PWD': '/builds/slave/test', 18:42:37 INFO - 'SHELL': '/bin/bash', 18:42:37 INFO - 'SHLVL': '1', 18:42:37 INFO - 'TERM': 'linux', 18:42:37 INFO - 'TMOUT': '86400', 18:42:37 INFO - 'USER': 'cltbld', 18:42:37 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1477359721.921871-20206468', 18:42:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:42:37 INFO - '_': '/tools/buildbot/bin/python'} 18:42:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:42:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:42:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 18:42:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 18:42:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:42:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 18:42:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 18:42:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 18:42:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 18:42:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 18:42:38 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:42:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:42:38 INFO - Cleaning up... 18:42:38 INFO - Return code: 0 18:42:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:42:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:42:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:42:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:42:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:42:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:42:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:42:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5d5e097f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14017b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1490790>, '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 0x1491690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1491b20>, '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': '41bf3e9aed84707956354da8000001c5-1477359721.921871-20206468', '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 18:42:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:42:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:42:38 INFO - Using env: {'DISPLAY': ':0', 18:42:38 INFO - 'HOME': '/home/cltbld', 18:42:38 INFO - 'LANG': 'en_US.UTF-8', 18:42:38 INFO - 'LANGUAGE': 'en_US:en', 18:42:38 INFO - 'LOGNAME': 'cltbld', 18:42:38 INFO - 'MAIL': '/var/mail/cltbld', 18:42:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:42:38 INFO - 'MOZ_NO_REMOTE': '1', 18:42:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:42:38 INFO - 'NO_EM_RESTART': '1', 18:42:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:42:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:42:38 INFO - 'PWD': '/builds/slave/test', 18:42:38 INFO - 'SHELL': '/bin/bash', 18:42:38 INFO - 'SHLVL': '1', 18:42:38 INFO - 'TERM': 'linux', 18:42:38 INFO - 'TMOUT': '86400', 18:42:38 INFO - 'USER': 'cltbld', 18:42:38 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1477359721.921871-20206468', 18:42:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:42:38 INFO - '_': '/tools/buildbot/bin/python'} 18:42:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:42:38 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:42:38 INFO - Cleaning up... 18:42:38 INFO - Return code: 0 18:42:38 INFO - Running post-action listener: _resource_record_post_action 18:42:38 INFO - Running post-action listener: _start_resource_monitoring 18:42:38 INFO - Starting resource monitoring. 18:42:38 INFO - [mozharness: 2016-10-25 01:42:38.368845Z] Finished create-virtualenv step (success) 18:42:38 INFO - [mozharness: 2016-10-25 01:42:38.369351Z] Running install step. 18:42:38 INFO - Running pre-action listener: _resource_record_pre_action 18:42:38 INFO - Running main action method: install 18:42:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:42:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:42:38 INFO - Reading from file tmpfile_stdout 18:42:38 INFO - Detecting whether we're running mozinstall >=1.0... 18:42:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:42:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:42:38 INFO - Reading from file tmpfile_stdout 18:42:38 INFO - Output received: 18:42:38 INFO - Usage: mozinstall [options] installer 18:42:38 INFO - Options: 18:42:38 INFO - -h, --help show this help message and exit 18:42:38 INFO - -d DEST, --destination=DEST 18:42:38 INFO - Directory to install application into. [default: 18:42:38 INFO - "/builds/slave/test"] 18:42:38 INFO - --app=APP Application being installed. [default: firefox] 18:42:38 INFO - mkdir: /builds/slave/test/build/application 18:42:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 18:42:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 18:42:55 INFO - Reading from file tmpfile_stdout 18:42:55 INFO - Output received: 18:42:55 INFO - /builds/slave/test/build/application/firefox/firefox 18:42:55 INFO - Running post-action listener: _resource_record_post_action 18:42:55 INFO - [mozharness: 2016-10-25 01:42:55.592251Z] Finished install step (success) 18:42:55 INFO - [mozharness: 2016-10-25 01:42:55.592527Z] Running run-tests step. 18:42:55 INFO - Running pre-action listener: _resource_record_pre_action 18:42:55 INFO - Running main action method: run_tests 18:42:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:42:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:42:55 INFO - Python 2.7.3 18:42:55 INFO - Return code: 0 18:42:55 INFO - grabbing minidump binary from tooltool 18:42: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')]} 18:42:55 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 0x1490790>, '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 0x1491690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1491b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:42:55 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 18:42:55 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 18:42:55 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 18:42:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:42:55 INFO - Return code: 0 18:42:55 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:42:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:42:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:42:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:42:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:42:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477348234/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 18:42:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477348234/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-026 --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 18:42:55 INFO - Using env: {'DISPLAY': ':0', 18:42:55 INFO - 'HOME': '/home/cltbld', 18:42:55 INFO - 'LANG': 'en_US.UTF-8', 18:42:55 INFO - 'LANGUAGE': 'en_US:en', 18:42:55 INFO - 'LOGNAME': 'cltbld', 18:42:55 INFO - 'MAIL': '/var/mail/cltbld', 18:42:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:42:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:42:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:42:55 INFO - 'MOZ_NO_REMOTE': '1', 18:42:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:42:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:42:55 INFO - 'NO_EM_RESTART': '1', 18:42:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:42:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:42:55 INFO - 'PWD': '/builds/slave/test', 18:42:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:42:55 INFO - 'SHELL': '/bin/bash', 18:42:55 INFO - 'SHLVL': '1', 18:42:55 INFO - 'TERM': 'linux', 18:42:55 INFO - 'TMOUT': '86400', 18:42:55 INFO - 'USER': 'cltbld', 18:42:55 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1477359721.921871-20206468', 18:42:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:42:55 INFO - '_': '/tools/buildbot/bin/python'} 18:42:55 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477348234/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 18:42:55 INFO - mozversion application_buildid: 20161024153034 18:42:55 INFO - mozversion application_changeset: b6571211c807e209e550833eb47dfc08a4c6ae53 18:42:55 INFO - mozversion application_display_name: Nightly 18:42:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:42:55 INFO - mozversion application_name: Firefox 18:42:55 INFO - mozversion application_remotingname: firefox 18:42:55 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 18:42:55 INFO - mozversion application_vendor: Mozilla 18:42:55 INFO - mozversion application_version: 52.0a1 18:42:55 INFO - mozversion platform_buildid: 20161024153034 18:42:55 INFO - mozversion platform_changeset: b6571211c807e209e550833eb47dfc08a4c6ae53 18:42:55 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 18:42:55 INFO - mozversion platform_version: 52.0a1 18:42:55 INFO - using testdate: 1477359775 18:42:55 INFO - actual date: 1477359775 18:42:55 INFO - starting webserver on 'localhost:57104' 18:42:55 INFO - SUITE-START | Running 2 tests 18:42:55 INFO - TEST-START | dromaeo_css 18:42:55 INFO - operating with platform_type : linux_ 18:42:55 INFO - Initialising browser for dromaeo_css test... 18:42:55 INFO - TEST-INFO | started process 14527 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0bWDoz/profile http://localhost:57104/getInfo.html) 18:43:00 INFO - PROCESS | 14527 | __metrics Screen width/height:1600/1200 18:43:00 INFO - PROCESS | 14527 | colorDepth:24 18:43:00 INFO - PROCESS | 14527 | Browser inner width/height: 1024/697 18:43:00 INFO - PROCESS | 14527 | __metrics 18:43:01 ERROR - PROCESS | 14527 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3097: TypeError: this.tabs is undefined 18:43:01 INFO - TEST-INFO | 14527: exit 0 18:43:01 INFO - Browser initialized. 18:43:01 INFO - Running cycle 1/1 for dromaeo_css test... 18:43:01 INFO - TEST-INFO | started process 14647 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0bWDoz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:43:14 INFO - PROCESS | 14647 | RSS: Main: 182132736 18:43:14 INFO - PROCESS | 14647 | 18:44:03 INFO - PROCESS | 14647 | 1477359843646 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 18:46:14 INFO - PROCESS | 14647 | Cycle 1(1): loaded http://localhost:57104/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57104/tests/dromaeo/cssquery-ext.html) 18:46:16 INFO - PROCESS | 14647 | RSS: Main: 196407296 18:46:16 INFO - PROCESS | 14647 | 18:49:18 INFO - PROCESS | 14647 | Cycle 1(1): loaded http://localhost:57104/tests/dromaeo/cssquery-ext.html (next: http://localhost:57104/tests/dromaeo/cssquery-jquery.html) 18:49:19 INFO - PROCESS | 14647 | RSS: Main: 194420736 18:49:19 INFO - PROCESS | 14647 | 18:52:21 INFO - PROCESS | 14647 | Cycle 1(1): loaded http://localhost:57104/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57104/tests/dromaeo/cssquery-mootools.html) 18:52:21 INFO - PROCESS | 14647 | RSS: Main: 196542464 18:52:21 INFO - PROCESS | 14647 | 18:55:23 INFO - PROCESS | 14647 | Cycle 1(1): loaded http://localhost:57104/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57104/tests/dromaeo/cssquery-prototype.html) 18:55:24 INFO - PROCESS | 14647 | RSS: Main: 192921600 18:55:24 INFO - PROCESS | 14647 | 18:58:26 INFO - PROCESS | 14647 | Cycle 1(1): loaded http://localhost:57104/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57104/tests/dromaeo/cssquery-yui.html) 18:58:27 INFO - PROCESS | 14647 | RSS: Main: 196177920 18:58:27 INFO - PROCESS | 14647 | 19:01:30 INFO - PROCESS | 14647 | Cycle 1(1): loaded http://localhost:57104/tests/dromaeo/cssquery-yui.html (next: http://localhost:57104/tests/dromaeo/cssquery-dojo.html) 19:01:31 INFO - PROCESS | 14647 | RSS: Main: 196100096 19:01:31 INFO - PROCESS | 14647 | 19:01:31 INFO - PROCESS | 14647 | __start_tp_report 19:01:31 INFO - PROCESS | 14647 | _x_x_mozilla_page_load 19:01:31 INFO - PROCESS | 14647 | _x_x_mozilla_page_load_details 19:01:31 INFO - PROCESS | 14647 | |i|pagename|runs| 19:01:31 INFO - PROCESS | 14647 | |0;dojo.html;3093.9944518031643;3097.2566584019837;3112.0352690665886;3112.2219445138717;3119.1578273866057;5343.278657381257;5351.464853514642;5392.973035134829;5403.594730395222;5550.5282051025715;5433.103537916249;5479.260299859528;5538.529225015868;5585.720713964296;5624.803131890385;4897.0695567842085;4943.357363542752;4947.752612369385;4960.925586116211;4975.9004819903585;4570.981294529824;4977;5133.383993920735;5144.819931302405;5188.766505507242;4901.068796928572;5056.873578160538;5074.112030394685;5113.923291150599;5146.099432599299;4905.2151655734915;4924.532169443897;4936.654434189608;4968.080905032581;5045.5459008689395;4871.732054736988;4893.388326459192;4906.411230652309;4916.532929371704;4950.851474455736;5363.463653634644;5370.409254981988;5394.757235924393;5419.187121931742;5432.266644003088;5647.915281270784;5695.088785794253;5763.827085187451;5842.444967728059;5853.414658534155;5906;5906.26171728534;5908.261467316585;5915.733791979371;5964.433378829004;5469.617126801126;5475.123980163155;5481.314835645584;5481.342238931354;5484.972575137099;5814.389489103668;5867.501262392744;5877.177195192677;5904.468597826216;5988.161657367972;5647.971760141173;5705.572082093777;5713.171590119493;5777.740001699934;5778.7688492460675;5740.425957404226;5757.884842303214;5784.508316793035;5784.942150578525;5794.739236734357;5732.3407808101765;5790.826275211751;5795.594308398456;5831.679257640785;5857.062869940789;5837.0368889132815;5875.265591801025;5888.293404791367;5889.381614930457;5897.233359663216;4488.035072459437;4489.842855500107;4491.236489796743;4537.2059889519205;4539.251023581072;3993.7603743775467;3994.8402063917697;3997.5802540733384;4002.039510517455;4043.231785960717;5435.0488664483555;5455.454454554592;5489.094299440628;5578.581606379537;5647.943520564741;5801.7389217485315;5853.590248682636;5858.414158584193;5910.586258961831;5912.467877890925;5426.050441172779;5468.125099983983;5468.589855760754;5474.616776825584;5496.422875598085;4963.081829861487;4979.203327467588;4989.226669866177;5024.120778863684;5049.166887463527;5976.163337132805;5976.641401515923;5992.43071908168;6032.487238584682;6044.84887877789;5776.364599894092;5785.611453251274;5791.362950075572;5848.736806843787;5856.238688970577;6012.759489620366;6024.096385542204;6025.096235564701;6029.457348838626;6036.69816509164;5757.309122905278;5784.623999440023;5787.623804452697;5832.62087964281;5839.0949402842625;5872.324682661549;5896.852578685567;5922.851928701817;5964.403559644001;5980.073088671263;5618.634788738719;5684.175794509855;5810.389909059488;5811.070228763378;5816.243888294494;5658.632188907708;5663.66018038919;5693.772249109989;5708.942910570841;5730.08318669011;5575.77696892136;5605.962896864094;5657;5670.914936275876;5673.631213971079;5623.325200975909;5712.11462223356;5733.799317023884;5737.426257374229;5747.626404283708;5574.386817449996;5697.515711164598;5736.569757268138;5763.51010164124;5772 19:01:31 INFO - PROCESS | 14647 | |1;ext.html;576.124291077562;586.8914250863593;590.5157770628082;592.493418127501;594.9315828679701;40228.396574051374;42042.7897860511;42107.368389474184;45383.54616453835;45535.54464455354;42831.14337713244;43457.34813977785;43703;43742.56257437425;43847.780761096146;8261.91738082619;8504.02203746571;8539.188777066169;8572.399932004762;8588.8711669325;8780.824383512327;8857.689980850671;8897.68858089967;8905;8932.062133475989;8940.32947528938;8968.596413161391;8990.865137022916;9014.774630634254;9016.504092274923;8802.911970880274;8870.778230544223;8883.955580222122;8885.866711999326;8886.911130888673;8833.11668833118;8892.421992570527;8899.510526921016;8901.688440904602;8911.554422278925;41066;41750.79124604358;41808;41830.79084604588;41877;3331.583552055993;3361.1429085583263;3518.9824050879583;3635.72732045095;3814.5422549294262;30305;30638;31243.68756312453;31327;31484;4174;4208.936865947013;4265.594768496988;4413.3159360299205;4425.8229670813125;321954;324623;326914.9999999976;329846;330048;53252.201216981775;53581.196282055804;53713.731431342596;53757.73121134369;53814.73092634512;56952.71523642355;57181.14228286579;57269.71365143148;57395.71302143546;57405;14387;14586.416543338148;14618.853811461962;14758.040727352687;14805.555833325017;11276.041536469493;11301.15241356885;11351.205415620827;11366.545338186545;11370.658880233606;13266.142740016405;15488.148151851756;15533.922330388275;15601.297941592655;15854.603634908988;6023.247094113236;6219.222597175353;6250.718717657716;6303.464205542488;6481.870362592722;884.4118661090431;936;1071.393010056753;1082.3073233130644;1129.4409267412684;28452.715472845008;30847;30987.380252394825;31095;31643.683563164534;1065.5098654618807;1076.434871692352;1106.8727096383857;1114.8940850619178;1129.6441620889393;15550.688986220212;16255.59361015984;16365.836341636432;16433.424830130887;16517.752233716503;434785;438887;439115;439532;440423;54303.18545221825;54403.45596544063;54573.45426545763;54729.726351367986;54924;1275.9744805103846;1276.585109839306;1285.8071289306492;1289.8839104480642;1312.1143228321037;28792;29355.706442935298;30592.541111883784;30786.230344240677;31087.533686995164;46931.061378772916;47010.764946176416;47310;47358.76320618375;47468.98089363148;401318;404021;404371;405701;406643;26627;26882.193534194004;26963.595546067216;26978.73021269762;27083.72916270812;44439.33340999823;45200.54799452095;45330.32004519869;46618.13527458864;47086.52913470822;37503.624963750015;38684.13881939089;39419.01452463711;39755.40366894441;40893.59106408898;38626.61373386343;39209.215815684096;39245.41131883081;39704.2059158821;40531;39403.40894886522;40430.19139617132;40561.79719101386;40629.39055914223;43194.35208471813;30017.399652007276;34124.65875341215;35190.824045879606;36315.45526817153;36388.454173186896;27369.45261094727;28157.71842281551;28236.49388369248;28502.714972850004;28600.284992874513 19:01:31 INFO - PROCESS | 14647 | |2;jquery.html;384.70570013939357;388.74925672940935;393.8385262042562;400.9198160367927;421.39740171554666;17856.375026874062;19063.142158602863;19376.9031154844;19404;19844.50388740282;18541.25834966603;18802.15390307436;18887.811121888775;19002;19077.427677169708;5638.379778224402;5709.486146246837;5844.824655260349;5898.439648233432;5917.615355001933;5803.361630220672;5875.412458754112;5881;5884.76460941564;5902.763889444439;5593.496585307322;5805.709714514279;5829.300483941933;5830.4169583041785;5831.096180092092;5704.201411802351;5729.226554415142;5786.1610066540325;5790.218320526759;5833.416658334175;5023.748812559357;5151.201563757586;5175.896482070375;5183.50756678115;5185;22411.55176896469;22480.887595562082;22547.661785073236;22851.542969140522;22857.31428057144;2273.533925545259;2277.5672622201896;2333.428310064028;2527.0902475108946;2535.4168541235435;13885;14424.927875360661;14518.201498917555;14654.340554675066;15132.773008404773;1874.1659961317218;1924.3361040441025;1928.358208955224;1932.6134773045308;2016.0927582587894;74417.62791186063;75100.62449687772;75834.24165758328;77479.61260193663;77709.61145194237;10193.388396696222;10245.948770256251;10286.27996040285;10460.372377657364;10693.732656683645;14410.279486025656;14471.85528144726;14492.97098406224;14500;14557.272136393138;7513;7625.847483050419;7714.437615212252;7738.458307918391;7756.263155000266;7351.77944661661;7388;7554.131274903347;7580.279873412017;7630.694772209049;6339.809805705836;6409.903851442232;6500.804975850732;6514.869702606016;6695.665216739144;1874.7656542932134;1904.6666833304116;1923.7787654419922;1944.931927382535;1961.6852114504736;964.6961207219704;972.7324985628867;1007.0634310091539;1039.2361614213546;1064.4411683865878;18118.369346758856;18983.20988640195;19778;19782;19893.701594476093;996.9750756231152;1011.4993078426226;1016.2479764973866;1021.1830535571662;1029.1972261635935;10578.52396642153;11359;11415.086793056536;11428.2000259981;11441.828372574419;427600;434487;437089;438440;438469;72088;74401.89604543298;74768.62615686886;76641;77399.2260077392;1001.2628090263387;1004.2116938203475;1031.1338475680463;1033.421284080917;1040.7242080848582;15944;17225.65548688994;17304.826951730825;17585.912070439565;17794.110294485483;41269.58730412657;41344.586554134075;41742;41803.10248809034;42373.57626423697;54872;56372;57081.14378284412;58018.4198158013;58555.12167317579;6995.545289556163;7482.962585187257;8029.8394032120195;8064.072631647201;8132.6746930122135;11157.330560166416;12968.675783105498;13151.408186631434;13319.733605328032;13388.19670819754;10805.891941080803;11273;11368.431578421212;11378;11593.942030289794;6294.779682711083;10074.748131296776;10084.798304034024;10184.592616295562;11209.103271738404;11180.329180249211;11186.944065279622;11386.94306528462;11393.373364465035;11931.940340298243;7441.62791860394;7574.204708505527;7666.156722760604;7836.138024817152;7987.041555013436;9995.100440960348;10766.900454411314;11112.944435277772;11131.944340278247;11384.43077846121 19:01:31 INFO - PROCESS | 14647 | |3;mootools.html;1483.8590333918273;1498.0412535976977;1668.3410053029054;1773.1134432783608;1794.398876376413;8065.354771618271;8365.91634083659;8693.47839129652;9360.765980850481;9388.953055234715;8700.608472618731;9101.726948191565;9134.223590994758;9361.110694484014;9381.81236375272;2337.1118974789556;2351.541449417364;2354.7174339079334;2368.431576421655;2371.7509661485556;2316.2587971849016;2322.5238826040704;2347.4718188407555;2364.18435639704;2368.632861906399;2323.337848713117;2340.2979106268135;2350.6003979323555;2353.7642737562746;2372.1223147435385;2290.6564015397657;2311.872846993415;2318.142287353673;2323.361075704178;2323.8838058097026;2248.9775102249096;2255.492514184312;2259.164109279577;2261.819054475638;2270.25081723031;9083.182513573744;9201.723948281562;9270.351075424724;9294;9303.162715355651;5297.311349524575;5420.295361603005;5422.75597598109;5426.403095659474;5430.728463576845;3235.094173631387;3295.888802256289;3397.405454045532;3411.9147021324416;3420.811855347955;999.5701848205268;1050.721558786922;1055.7044027672264;1077.1113831089303;1106.778644271149;12840.486380544768;12977.41601627929;12985.22088674692;13018.283994380305;13054.2820144892;4528.615067719281;4668.95331046692;4832.420109586872;4864.464908860023;4879.902401951941;10667.946660266804;10701.625443109453;10708.946455267675;10722.303050301705;10745.40900250478;5469.343678758574;5478.205660179252;5483.341998960071;5494.532964697965;5503;4411.669124815651;4571.474280457724;4844.75776211188;4997.575206107449;5067.189249720027;3848.5958974307855;3983.780892050907;4072.0634254121123;4086.9182616348103;4150.211459822624;1301.5704817410233;1303.178997231757;1324.6886981559326;1332.3471498965437;1352.0468070010618;903.2367649336301;916.1572786076855;924.1451657217182;940.4263399326405;954.4750387286964;5737;6072;6077.878442431127;6091.51267898567;6294.307626161119;970.3062310447923;1013.4679293371039;1033.9017793309774;1046.7697106636529;1067.588978243382;3968.4245784361106;4178.91642167155;4195.202911446815;4196.160767846443;4198.286291330481;11373.37446440437;11630.069594432594;11710.297382157098;11729.706757331134;11765.235259708092;11667.891550302707;11671.88328116725;11695.947364737214;11698.532058717727;11704.765904681859;7951.324137448266;8395.034571024411;8403.621837017348;8580.785480363042;8687.26158276541;6028.939710603014;6147.784827531015;6171.629702217701;6206.968965155145;6233.376662333731;10079.596816127272;10099.848502272325;10105;10109.545070471699;10162.18702503783;10152.137068349273;10626.946865265625;10650.946745266225;10773.838392424277;10926.235163538793;7073.540219885691;7335.303146201102;7887.723929662434;8006.479578827358;8056.033276006917;8800.471971681463;8969.37214394986;8980.595873185592;8982.910170898207;8987.595558200028;7806.0632724073475;7854.175311592429;7936.563489007929;8024.518528888286;8076.555789431638;7773.961130194313;7775.066991961001;7810.867424223569;7840.294373506412;7851;7285.052943117361;7393.482456228013;7403.222661620668;7404.6667899945705;7414.592197429193;4981.3026176334615;5159.896802064013;5179.81870634526;5289.867753306198;5497.725113744376;5321.627486075938;5329.333833270841;5422.376426710979;5479.369872464717;5549.750261238173 19:01:31 INFO - PROCESS | 14647 | |4;prototype.html;319.5621997862927;326.58913493707195;331.129130387082;333.6130089096648;335.8690110856765;5371.677699338033;5480.534154596864;5501.477359650832;5532.727472681281;5554.389017208109;5240.947590524093;5313.38896026957;5349.5185433311;5362.184852952202;5452.59105567082;4209.768462734548;4211.8525851595205;4216.79523562092;4221.641160501361;4224.70427070106;4129.793510324487;4218.578142185787;4234.428352172448;4246.2356775780345;4248.553901840309;4234.9364759528635;4238.449001629784;4242.724222925515;4245.150969806035;4253.744775313491;4194.790260486963;4217.135487225111;4233;4243.61807437329;4244.36591912113;3715.5912849586525;3759.981200094009;3803.334416477133;3813.4470501777364;3827.885163445101;5215.843524694265;5237;5246.554042906358;5257.631965762398;5284.9735751320995;4818.494058123882;4853.733044682541;4854.965646470956;4859.1331114642535;4864.246041863482;5422.105352616813;5671.517920976722;5675.2054712340305;5681.914771278434;5684.232628595169;4128.277551428518;4163.5628259032665;4165.312723400635;4166.6250037496775;4167.1457351242925;5973.492253158487;5992.041273396279;6002.309734380515;6034.0948857671265;6038.728257228479;4036.8990775230855;4282.073067119809;4286.89282767927;4303.956960430418;4339.284018137035;4303.612674859278;4306.504751953566;4338.978305108518;4342.891427714332;4347.978260108679;4927.359443272423;4960.900781984412;4975.875603109879;4977.203647416396;4992.176290912032;5564.638298510584;5760.683162426107;5812.622179558315;5901.852453688693;5913.467787899023;1495.5588101510082;1516.294922860853;1516.408600645749;1517.332373755544;1517.7495713207418;949.7008442340641;965.2085290062222;972.3679608254549;977.5454413697664;993.2550587059706;4895.478828403375;4918.877028074256;4922.483139270325;4927.802887884444;4937.23472861707;5142.254373115952;5203.271541984125;5221.686698798084;5268.076217699214;5295.549878260314;4671.719696818202;4914.100680598464;4967.4784147664695;4981.42713587942;4988.451270360258;2764.7097054808955;2777.652793400825;2783.8029647251874;2784.4152727926958;2806.975453959331;5312.442193569696;5314.342828585707;5320.201969704498;5338.9466105339225;5339.439358867341;5279.1817268323475;5293.3647962244;5575.1915972184615;6048.304444988795;6077.17958075663;6070.180525629072;6075.908861367083;6083.7870674526175;6085.148079268817;6190.535709821691;5683.77264909399;5992.8801423972145;5996.340402555628;6014.188084608697;6024.337322894566;5890.204822348928;5913.615614985012;5923.763049477972;5927.851803704942;5937.228160339301;6106.72519736604;6134.5033331000905;6174.536909731878;6176.66028368444;6199.380061993765;3968.40473928913;4049.8177582008293;4113.4858142732155;4156.147989662051;4183.39340795589;5921.230240068763;5921.881562368814;5956.76172953077;5973.432523910222;5992.13114098462;5606.85982850432;5776.19133321327;5844.503217226414;5844.590878638454;5873.9412605873395;5708.57185711065;5712.885742285048;5732.394929419769;5737.6188881615335;5764.884702306014;5748.942510575008;5770.769169233352;5774.105013722879;5778.27771528559;5789.652620842763;5532.944670553243;5764.596478246483;5766.855828604318;5811.099279611667;5819.854503637443;5676.375598684059;5682.943170568242;5695.316562012585;5710.771569137188;5713.600047996601 19:01:31 INFO - PROCESS | 14647 | |5;yui.html;713.1620346093341;743.7917383132725;796;798.9081255655598;809.1706001348617;14171.645708857272;14887.776683349759;14959.476418325361;14987;15068.09591424514;14849.480268190615;14970.625734356647;15007.474738384159;15021.399144034225;15037.548873533784;658.2397331082607;683.1324218242829;769.6305773228853;789.6525528767338;794.6702118620766;800.995995020027;805.9838803223932;811.4887620798888;812.1675282835082;814.1410811593767;844.5397258494136;846.4202021615182;847.9491230526188;848.8217474330398;851.1743608699552;843.5571325054395;844.3161039557947;845.6575087089739;846.8941382327209;846.8941382327209;618.026608092252;624.1605041219552;624.188554878656;624.2633692243152;624.9250089989231;13705.794413083811;13812.792808107886;13830.515931942333;13844.723105537832;13979.510717124953;14112.858871411257;14386.92806535971;14426.206558639271;14494.492692755703;14505.41978320866;11472.77054458906;11636.12729045325;11743.412829358584;11796.705082372924;12357.443915023845;3688.6495782900583;3818.3890577507464;3923.117298607819;3927.6465118139504;3941.467901833273;72030;72056;73963;74744.25255747428;75253.24746752573;11308.434578271053;11349.716257093638;11403.258788178742;11505.13711471643;11924.523019079139;22263.888680556494;22605.687663399087;22633.660495092587;22636.660450093263;22664.206752763905;7189;7224.927750722531;7376.409887209011;7385.3722433592675;7438.814029649302;4372.103718737651;4402.031553058322;4429.335599660077;4540.025089086258;4636.026434448803;3489.1277180704824;3586.1751797086818;3591.048372181374;3598.8020658864016;3599.6220396858475;580.8605934575756;597.1958623567814;600.4475882188398;601.0953514960045;610.8503416662858;655.924568674599;661.7849199010341;728.1553398058227;734.3574372424129;741.2365263778318;8945.418547794372;9553.808923821623;9617;9778.75553111178;10098.495075246208;673.5857447669648;696.951213415056;705.9713827679301;729.3727394440776;765.3915137465729;4322.783860806947;4388.890277743082;4557.498675145731;4572.060515788994;4807.519248075165;63248.367516324244;71781.64109179421;83689.58155209185;123412;124499.37750311372;57018.42981570131;57158.142627860616;86948.56525717331;93611;93986.53006734923;66086.66956665186;85935.57032214924;88951.55524222337;89620.55189724009;89981.55009224912;8904.421212621159;9037.277017838689;9071.319651026068;9107.812265706949;9122.224610908148;50642.74678626583;51009.489905100476;52500.212496811815;52510.73744631252;52788;61368.69315653393;62580.374196259276;73134.63432682803;73206.26793731995;74866.62566687132;12083.39583020828;12111.45498452554;12193.634190974284;12622.747545048864;13054.673633158867;14022.719545609234;14333.498327558485;14600.926995364955;14618.195999220145;14675.706485870436;13280.601581952556;13315;13613.387397566936;13982.790258145933;14219.786703199667;13498.59504214875;13648.727025459633;13764.31178441094;14350.784738228725;14454.253691798525;13596.388162532907;13653.385597648328;13780.448782048607;14107.788383174466;14324.57026289213;10305.433201174008;10581.788364232827;10713.785724285626;10805.944612446296;10892.346459212473;9927.950360248153;9993.758854006786;10282.714660667416;11365.659030229106;11403.714907127389 19:01:31 INFO - PROCESS | 14647 | __end_tp_report 19:01:31 INFO - PROCESS | 14647 | __start_cc_report 19:01:31 INFO - PROCESS | 14647 | _x_x_mozilla_cycle_collect,328 19:01:31 INFO - PROCESS | 14647 | __end_cc_report 19:01:31 INFO - PROCESS | 14647 | __startTimestamp1477360891194__endTimestamp 19:01:31 INFO - PROCESS | 14647 | 19:01:31 INFO - PROCESS | 14647 | ------- Summary: start ------- 19:01:31 INFO - PROCESS | 14647 | Number of tests: 6 19:01:31 INFO - PROCESS | 14647 | 19:01:31 INFO - PROCESS | 14647 | [#0] dojo.html Cycles:165 Average:5423.51 Median:5657.00 stddev:618.09 (10.9%) stddev-sans-first:592.35 19:01:31 INFO - PROCESS | 14647 | Values: 3094.0 3097.3 3112.0 3112.2 3119.2 5343.3 5351.5 5393.0 5403.6 5550.5 5433.1 5479.3 5538.5 5585.7 5624.8 4897.1 4943.4 4947.8 4960.9 4975.9 4571.0 4977.0 5133.4 5144.8 5188.8 4901.1 5056.9 5074.1 5113.9 5146.1 4905.2 4924.5 4936.7 4968.1 5045.5 4871.7 4893.4 4906.4 4916.5 4950.9 5363.5 5370.4 5394.8 5419.2 5432.3 5647.9 5695.1 5763.8 5842.4 5853.4 5906.0 5906.3 5908.3 5915.7 5964.4 5469.6 5475.1 5481.3 5481.3 5485.0 5814.4 5867.5 5877.2 5904.5 5988.2 5648.0 5705.6 5713.2 5777.7 5778.8 5740.4 5757.9 5784.5 5784.9 5794.7 5732.3 5790.8 5795.6 5831.7 5857.1 5837.0 5875.3 5888.3 5889.4 5897.2 4488.0 4489.8 4491.2 4537.2 4539.3 3993.8 3994.8 3997.6 4002.0 4043.2 5435.0 5455.5 5489.1 5578.6 5647.9 5801.7 5853.6 5858.4 5910.6 5912.5 5426.1 5468.1 5468.6 5474.6 5496.4 4963.1 4979.2 4989.2 5024.1 5049.2 5976.2 5976.6 5992.4 6032.5 6044.8 5776.4 5785.6 5791.4 5848.7 5856.2 6012.8 6024.1 6025.1 6029.5 6036.7 5757.3 5784.6 5787.6 5832.6 5839.1 5872.3 5896.9 5922.9 5964.4 5980.1 5618.6 5684.2 5810.4 5811.1 5816.2 5658.6 5663.7 5693.8 5708.9 5730.1 5575.8 5606.0 5657.0 5670.9 5673.6 5623.3 5712.1 5733.8 5737.4 5747.6 5574.4 5697.5 5736.6 5763.5 5772.0 19:01:31 INFO - PROCESS | 14647 | 19:01:31 INFO - PROCESS | 14647 | [#1] ext.html Cycles:180 Average:54905.05 Median:223636.20 stddev:103649.80 (46.3%) stddev-sans-first:103860.30 19:01:31 INFO - PROCESS | 14647 | Values: 576.1 586.9 590.5 592.5 594.9 40228.4 42042.8 42107.4 45383.5 45535.5 42831.1 43457.3 43703.0 43742.6 43847.8 8261.9 8504.0 8539.2 8572.4 8588.9 8780.8 8857.7 8897.7 8905.0 8932.1 8940.3 8968.6 8990.9 9014.8 9016.5 8802.9 8870.8 8884.0 8885.9 8886.9 8833.1 8892.4 8899.5 8901.7 8911.6 41066.0 41750.8 41808.0 41830.8 41877.0 3331.6 3361.1 3519.0 3635.7 3814.5 30305.0 30638.0 31243.7 31327.0 31484.0 4174.0 4208.9 4265.6 4413.3 4425.8 321954.0 324623.0 326915.0 329846.0 330048.0 53252.2 53581.2 53713.7 53757.7 53814.7 56952.7 57181.1 57269.7 57395.7 57405.0 14387.0 14586.4 14618.9 14758.0 14805.6 11276.0 11301.2 11351.2 11366.5 11370.7 13266.1 15488.1 15533.9 15601.3 15854.6 6023.2 6219.2 6250.7 6303.5 6481.9 884.4 936.0 1071.4 1082.3 1129.4 28452.7 30847.0 30987.4 31095.0 31643.7 1065.5 1076.4 1106.9 1114.9 1129.6 15550.7 16255.6 16365.8 16433.4 16517.8 434785.0 438887.0 439115.0 439532.0 440423.0 54303.2 54403.5 54573.5 54729.7 54924.0 1276.0 1276.6 1285.8 1289.9 1312.1 28792.0 29355.7 30592.5 30786.2 31087.5 46931.1 47010.8 47310.0 47358.8 47469.0 401318.0 404021.0 404371.0 405701.0 406643.0 26627.0 26882.2 26963.6 26978.7 27083.7 44439.3 45200.5 45330.3 46618.1 47086.5 37503.6 38684.1 39419.0 39755.4 40893.6 38626.6 39209.2 39245.4 39704.2 40531.0 39403.4 40430.2 40561.8 40629.4 43194.4 30017.4 34124.7 35190.8 36315.5 36388.5 27369.5 28157.7 28236.5 28502.7 28600.3 19:01:31 INFO - PROCESS | 14647 | 19:01:31 INFO - PROCESS | 14647 | [#2] jquery.html Cycles:180 Average:26774.63 Median:22854.43 stddev:71630.91 (313.4%) stddev-sans-first:71804.45 19:01:31 INFO - PROCESS | 14647 | Values: 384.7 388.7 393.8 400.9 421.4 17856.4 19063.1 19376.9 19404.0 19844.5 18541.3 18802.2 18887.8 19002.0 19077.4 5638.4 5709.5 5844.8 5898.4 5917.6 5803.4 5875.4 5881.0 5884.8 5902.8 5593.5 5805.7 5829.3 5830.4 5831.1 5704.2 5729.2 5786.2 5790.2 5833.4 5023.7 5151.2 5175.9 5183.5 5185.0 22411.6 22480.9 22547.7 22851.5 22857.3 2273.5 2277.6 2333.4 2527.1 2535.4 13885.0 14424.9 14518.2 14654.3 15132.8 1874.2 1924.3 1928.4 1932.6 2016.1 74417.6 75100.6 75834.2 77479.6 77709.6 10193.4 10245.9 10286.3 10460.4 10693.7 14410.3 14471.9 14493.0 14500.0 14557.3 7513.0 7625.8 7714.4 7738.5 7756.3 7351.8 7388.0 7554.1 7580.3 7630.7 6339.8 6409.9 6500.8 6514.9 6695.7 1874.8 1904.7 1923.8 1944.9 1961.7 964.7 972.7 1007.1 1039.2 1064.4 18118.4 18983.2 19778.0 19782.0 19893.7 997.0 1011.5 1016.2 1021.2 1029.2 10578.5 11359.0 11415.1 11428.2 11441.8 427600.0 434487.0 437089.0 438440.0 438469.0 72088.0 74401.9 74768.6 76641.0 77399.2 1001.3 1004.2 1031.1 1033.4 1040.7 15944.0 17225.7 17304.8 17585.9 17794.1 41269.6 41344.6 41742.0 41803.1 42373.6 54872.0 56372.0 57081.1 58018.4 58555.1 6995.5 7483.0 8029.8 8064.1 8132.7 11157.3 12968.7 13151.4 13319.7 13388.2 10805.9 11273.0 11368.4 11378.0 11593.9 6294.8 10074.7 10084.8 10184.6 11209.1 11180.3 11186.9 11386.9 11393.4 11931.9 7441.6 7574.2 7666.2 7836.1 7987.0 9995.1 10766.9 11112.9 11131.9 11384.4 19:01:31 INFO - PROCESS | 14647 | 19:01:31 INFO - PROCESS | 14647 | [#3] mootools.html Cycles:180 Average:5984.52 Median:4620.21 stddev:3468.18 (75.1%) stddev-sans-first:3461.42 19:01:31 INFO - PROCESS | 14647 | Values: 1483.9 1498.0 1668.3 1773.1 1794.4 8065.4 8365.9 8693.5 9360.8 9389.0 8700.6 9101.7 9134.2 9361.1 9381.8 2337.1 2351.5 2354.7 2368.4 2371.8 2316.3 2322.5 2347.5 2364.2 2368.6 2323.3 2340.3 2350.6 2353.8 2372.1 2290.7 2311.9 2318.1 2323.4 2323.9 2249.0 2255.5 2259.2 2261.8 2270.3 9083.2 9201.7 9270.4 9294.0 9303.2 5297.3 5420.3 5422.8 5426.4 5430.7 3235.1 3295.9 3397.4 3411.9 3420.8 999.6 1050.7 1055.7 1077.1 1106.8 12840.5 12977.4 12985.2 13018.3 13054.3 4528.6 4669.0 4832.4 4864.5 4879.9 10667.9 10701.6 10708.9 10722.3 10745.4 5469.3 5478.2 5483.3 5494.5 5503.0 4411.7 4571.5 4844.8 4997.6 5067.2 3848.6 3983.8 4072.1 4086.9 4150.2 1301.6 1303.2 1324.7 1332.3 1352.0 903.2 916.2 924.1 940.4 954.5 5737.0 6072.0 6077.9 6091.5 6294.3 970.3 1013.5 1033.9 1046.8 1067.6 3968.4 4178.9 4195.2 4196.2 4198.3 11373.4 11630.1 11710.3 11729.7 11765.2 11667.9 11671.9 11695.9 11698.5 11704.8 7951.3 8395.0 8403.6 8580.8 8687.3 6028.9 6147.8 6171.6 6207.0 6233.4 10079.6 10099.8 10105.0 10109.5 10162.2 10152.1 10626.9 10650.9 10773.8 10926.2 7073.5 7335.3 7887.7 8006.5 8056.0 8800.5 8969.4 8980.6 8982.9 8987.6 7806.1 7854.2 7936.6 8024.5 8076.6 7774.0 7775.1 7810.9 7840.3 7851.0 7285.1 7393.5 7403.2 7404.7 7414.6 4981.3 5159.9 5179.8 5289.9 5497.7 5321.6 5329.3 5422.4 5479.4 5549.8 19:01:31 INFO - PROCESS | 14647 | 19:01:31 INFO - PROCESS | 14647 | [#4] prototype.html Cycles:180 Average:4757.46 Median:5289.17 stddev:1405.49 (26.6%) stddev-sans-first:1369.39 19:01:31 INFO - PROCESS | 14647 | Values: 319.6 326.6 331.1 333.6 335.9 5371.7 5480.5 5501.5 5532.7 5554.4 5240.9 5313.4 5349.5 5362.2 5452.6 4209.8 4211.9 4216.8 4221.6 4224.7 4129.8 4218.6 4234.4 4246.2 4248.6 4234.9 4238.4 4242.7 4245.2 4253.7 4194.8 4217.1 4233.0 4243.6 4244.4 3715.6 3760.0 3803.3 3813.4 3827.9 5215.8 5237.0 5246.6 5257.6 5285.0 4818.5 4853.7 4855.0 4859.1 4864.2 5422.1 5671.5 5675.2 5681.9 5684.2 4128.3 4163.6 4165.3 4166.6 4167.1 5973.5 5992.0 6002.3 6034.1 6038.7 4036.9 4282.1 4286.9 4304.0 4339.3 4303.6 4306.5 4339.0 4342.9 4348.0 4927.4 4960.9 4975.9 4977.2 4992.2 5564.6 5760.7 5812.6 5901.9 5913.5 1495.6 1516.3 1516.4 1517.3 1517.7 949.7 965.2 972.4 977.5 993.3 4895.5 4918.9 4922.5 4927.8 4937.2 5142.3 5203.3 5221.7 5268.1 5295.5 4671.7 4914.1 4967.5 4981.4 4988.5 2764.7 2777.7 2783.8 2784.4 2807.0 5312.4 5314.3 5320.2 5338.9 5339.4 5279.2 5293.4 5575.2 6048.3 6077.2 6070.2 6075.9 6083.8 6085.1 6190.5 5683.8 5992.9 5996.3 6014.2 6024.3 5890.2 5913.6 5923.8 5927.9 5937.2 6106.7 6134.5 6174.5 6176.7 6199.4 3968.4 4049.8 4113.5 4156.1 4183.4 5921.2 5921.9 5956.8 5973.4 5992.1 5606.9 5776.2 5844.5 5844.6 5873.9 5708.6 5712.9 5732.4 5737.6 5764.9 5748.9 5770.8 5774.1 5778.3 5789.7 5532.9 5764.6 5766.9 5811.1 5819.9 5676.4 5682.9 5695.3 5710.8 5713.6 19:01:31 INFO - PROCESS | 14647 | 19:01:31 INFO - PROCESS | 14647 | [#5] yui.html Cycles:180 Average:19230.20 Median:27725.13 stddev:26719.75 (96.4%) stddev-sans-first:26758.53 19:01:31 INFO - PROCESS | 14647 | Values: 713.2 743.8 796.0 798.9 809.2 14171.6 14887.8 14959.5 14987.0 15068.1 14849.5 14970.6 15007.5 15021.4 15037.5 658.2 683.1 769.6 789.7 794.7 801.0 806.0 811.5 812.2 814.1 844.5 846.4 847.9 848.8 851.2 843.6 844.3 845.7 846.9 846.9 618.0 624.2 624.2 624.3 624.9 13705.8 13812.8 13830.5 13844.7 13979.5 14112.9 14386.9 14426.2 14494.5 14505.4 11472.8 11636.1 11743.4 11796.7 12357.4 3688.6 3818.4 3923.1 3927.6 3941.5 72030.0 72056.0 73963.0 74744.3 75253.2 11308.4 11349.7 11403.3 11505.1 11924.5 22263.9 22605.7 22633.7 22636.7 22664.2 7189.0 7224.9 7376.4 7385.4 7438.8 4372.1 4402.0 4429.3 4540.0 4636.0 3489.1 3586.2 3591.0 3598.8 3599.6 580.9 597.2 600.4 601.1 610.9 655.9 661.8 728.2 734.4 741.2 8945.4 9553.8 9617.0 9778.8 10098.5 673.6 697.0 706.0 729.4 765.4 4322.8 4388.9 4557.5 4572.1 4807.5 63248.4 71781.6 83689.6 123412.0 124499.4 57018.4 57158.1 86948.6 93611.0 93986.5 66086.7 85935.6 88951.6 89620.6 89981.6 8904.4 9037.3 9071.3 9107.8 9122.2 50642.7 51009.5 52500.2 52510.7 52788.0 61368.7 62580.4 73134.6 73206.3 74866.6 12083.4 12111.5 12193.6 12622.7 13054.7 14022.7 14333.5 14600.9 14618.2 14675.7 13280.6 13315.0 13613.4 13982.8 14219.8 13498.6 13648.7 13764.3 14350.8 14454.3 13596.4 13653.4 13780.4 14107.8 14324.6 10305.4 10581.8 10713.8 10805.9 10892.3 9928.0 9993.8 10282.7 11365.7 11403.7 19:01:31 INFO - PROCESS | 14647 | -------- Summary: end -------- 19:01:31 INFO - PROCESS | 14647 | 19:01:32 INFO - TEST-INFO | 14647: exit 0 19:01:32 INFO - TEST-OK | dromaeo_css | took 1116353ms 19:01:32 INFO - TEST-START | kraken 19:01:32 INFO - operating with platform_type : linux_ 19:01:32 INFO - Initialising browser for kraken test... 19:01:32 INFO - TEST-INFO | started process 15001 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpurjYOb/profile http://localhost:57104/getInfo.html) 19:01:36 INFO - PROCESS | 15001 | __metrics Screen width/height:1600/1200 19:01:36 INFO - PROCESS | 15001 | colorDepth:24 19:01:36 INFO - PROCESS | 15001 | Browser inner width/height: 1024/697 19:01:36 INFO - PROCESS | 15001 | __metrics 19:01:36 ERROR - PROCESS | 15001 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3097: TypeError: this.tabs is undefined 19:01:37 INFO - TEST-INFO | 15001: exit 0 19:01:37 INFO - Browser initialized. 19:01:37 INFO - Running cycle 1/1 for kraken test... 19:01:37 INFO - TEST-INFO | started process 15127 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpurjYOb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:01:50 INFO - PROCESS | 15127 | RSS: Main: 182837248 19:01:50 INFO - PROCESS | 15127 | 19:01:52 INFO - PROCESS | 15127 | Cycle 1(1): loaded http://localhost:57104/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57104/tests/kraken/driver.html?testName=audio-beat-detection) 19:01:53 INFO - PROCESS | 15127 | RSS: Main: 197054464 19:01:53 INFO - PROCESS | 15127 | 19:01:56 INFO - PROCESS | 15127 | Cycle 1(1): loaded http://localhost:57104/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57104/tests/kraken/driver.html?testName=audio-dft) 19:01:57 INFO - PROCESS | 15127 | RSS: Main: 194117632 19:01:57 INFO - PROCESS | 15127 | 19:01:59 INFO - PROCESS | 15127 | Cycle 1(1): loaded http://localhost:57104/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57104/tests/kraken/driver.html?testName=audio-fft) 19:02:00 INFO - PROCESS | 15127 | RSS: Main: 190869504 19:02:00 INFO - PROCESS | 15127 | 19:02:02 INFO - PROCESS | 15127 | Cycle 1(1): loaded http://localhost:57104/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57104/tests/kraken/driver.html?testName=audio-oscillator) 19:02:03 INFO - PROCESS | 15127 | RSS: Main: 191361024 19:02:03 INFO - PROCESS | 15127 | 19:02:05 INFO - PROCESS | 15127 | Cycle 1(1): loaded http://localhost:57104/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57104/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:02:06 INFO - PROCESS | 15127 | RSS: Main: 191688704 19:02:06 INFO - PROCESS | 15127 | 19:02:09 INFO - PROCESS | 15127 | Cycle 1(1): loaded http://localhost:57104/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57104/tests/kraken/driver.html?testName=imaging-darkroom) 19:02:09 INFO - PROCESS | 15127 | RSS: Main: 192208896 19:02:09 INFO - PROCESS | 15127 | 19:02:13 INFO - PROCESS | 15127 | Cycle 1(1): loaded http://localhost:57104/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57104/tests/kraken/driver.html?testName=imaging-desaturate) 19:02:13 INFO - PROCESS | 15127 | RSS: Main: 190152704 19:02:13 INFO - PROCESS | 15127 | 19:02:16 INFO - PROCESS | 15127 | Cycle 1(1): loaded http://localhost:57104/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57104/tests/kraken/driver.html?testName=json-parse-financial) 19:02:17 INFO - PROCESS | 15127 | RSS: Main: 191328256 19:02:17 INFO - PROCESS | 15127 | 19:02:18 INFO - PROCESS | 15127 | Cycle 1(1): loaded http://localhost:57104/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57104/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:02:19 INFO - PROCESS | 15127 | RSS: Main: 191651840 19:02:19 INFO - PROCESS | 15127 | 19:02:21 INFO - PROCESS | 15127 | Cycle 1(1): loaded http://localhost:57104/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57104/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:02:21 INFO - PROCESS | 15127 | RSS: Main: 191442944 19:02:21 INFO - PROCESS | 15127 | 19:02:23 INFO - PROCESS | 15127 | Cycle 1(1): loaded http://localhost:57104/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57104/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:02:24 INFO - PROCESS | 15127 | RSS: Main: 191574016 19:02:24 INFO - PROCESS | 15127 | 19:02:27 INFO - PROCESS | 15127 | Cycle 1(1): loaded http://localhost:57104/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57104/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:02:28 INFO - PROCESS | 15127 | RSS: Main: 192290816 19:02:28 INFO - PROCESS | 15127 | 19:02:30 INFO - PROCESS | 15127 | Cycle 1(1): loaded http://localhost:57104/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57104/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:02:31 INFO - PROCESS | 15127 | RSS: Main: 192225280 19:02:31 INFO - PROCESS | 15127 | 19:02:33 INFO - PROCESS | 15127 | Cycle 1(1): loaded http://localhost:57104/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57104/tests/kraken/driver.html?testName=ai-astar) 19:02:33 INFO - PROCESS | 15127 | RSS: Main: 193622016 19:02:33 INFO - PROCESS | 15127 | 19:02:33 INFO - PROCESS | 15127 | __start_tp_report 19:02:33 INFO - PROCESS | 15127 | _x_x_mozilla_page_load 19:02:33 INFO - PROCESS | 15127 | _x_x_mozilla_page_load_details 19:02:33 INFO - PROCESS | 15127 | |i|pagename|runs| 19:02:33 INFO - PROCESS | 15127 | |0;ai-astar;107;114;113;113;113;112;112;112;111;112 19:02:33 INFO - PROCESS | 15127 | |1;audio-beat-detection;153;125;127;164;130;134;132;129;148;125 19:02:33 INFO - PROCESS | 15127 | |2;audio-dft;165;163;167;169;167;163;163;164;165;164 19:02:33 INFO - PROCESS | 15127 | |3;audio-fft;77;77;78;114;76;78;76;77;103;76 19:02:33 INFO - PROCESS | 15127 | |4;audio-oscillator;84;83;114;83;84;85;105;84;83;109 19:02:33 INFO - PROCESS | 15127 | |5;imaging-gaussian-blur;118;117;118;119;117;118;118;117;117;117 19:02:33 INFO - PROCESS | 15127 | |6;imaging-darkroom;147;148;147;147;148;148;147;147;148;147 19:02:33 INFO - PROCESS | 15127 | |7;imaging-desaturate;85;86;86;85;85;85;85;85;85;84 19:02:33 INFO - PROCESS | 15127 | |8;json-parse-financial;54;53;53;58;54;55;55;55;61;55 19:02:33 INFO - PROCESS | 15127 | |9;json-stringify-tinderbox;60;59;59;60;60;60;58;60;60;61 19:02:33 INFO - PROCESS | 15127 | |10;stanford-crypto-aes;80;82;80;82;87;81;82;86;84;82 19:02:33 INFO - PROCESS | 15127 | |11;stanford-crypto-ccm;150;157;139;145;140;137;141;138;176;153 19:02:33 INFO - PROCESS | 15127 | |12;stanford-crypto-pbkdf2;168;166;168;166;169;168;167;168;169;164 19:02:33 INFO - PROCESS | 15127 | |13;stanford-crypto-sha256-iterative;66;67;66;71;65;67;69;67;71;67 19:02:33 INFO - PROCESS | 15127 | __end_tp_report 19:02:33 INFO - PROCESS | 15127 | __start_cc_report 19:02:33 INFO - PROCESS | 15127 | _x_x_mozilla_cycle_collect,815 19:02:33 INFO - PROCESS | 15127 | __end_cc_report 19:02:33 INFO - PROCESS | 15127 | __startTimestamp1477360953410__endTimestamp 19:02:33 INFO - PROCESS | 15127 | 19:02:33 INFO - PROCESS | 15127 | ------- Summary: start ------- 19:02:33 INFO - PROCESS | 15127 | Number of tests: 14 19:02:33 INFO - PROCESS | 15127 | 19:02:33 INFO - PROCESS | 15127 | [#0] ai-astar Cycles:10 Average:111.90 Median:112.50 stddev:1.91 (1.7%) stddev-sans-first:0.88 19:02:33 INFO - PROCESS | 15127 | Values: 107.0 114.0 113.0 113.0 113.0 112.0 112.0 112.0 111.0 112.0 19:02:33 INFO - PROCESS | 15127 | 19:02:33 INFO - PROCESS | 15127 | [#1] audio-beat-detection Cycles:10 Average:136.70 Median:133.00 stddev:13.50 (10.1%) stddev-sans-first:12.97 19:02:33 INFO - PROCESS | 15127 | Values: 153.0 125.0 127.0 164.0 130.0 134.0 132.0 129.0 148.0 125.0 19:02:33 INFO - PROCESS | 15127 | 19:02:33 INFO - PROCESS | 15127 | [#2] audio-dft Cycles:10 Average:165.00 Median:165.00 stddev:2.05 (1.2%) stddev-sans-first:2.18 19:02:33 INFO - PROCESS | 15127 | Values: 165.0 163.0 167.0 169.0 167.0 163.0 163.0 164.0 165.0 164.0 19:02:33 INFO - PROCESS | 15127 | 19:02:33 INFO - PROCESS | 15127 | [#3] audio-fft Cycles:10 Average:83.20 Median:77.00 stddev:13.60 (17.7%) stddev-sans-first:14.24 19:02:33 INFO - PROCESS | 15127 | Values: 77.0 77.0 78.0 114.0 76.0 78.0 76.0 77.0 103.0 76.0 19:02:33 INFO - PROCESS | 15127 | 19:02:33 INFO - PROCESS | 15127 | [#4] audio-oscillator Cycles:10 Average:91.40 Median:83.50 stddev:12.57 (15.1%) stddev-sans-first:13.05 19:02:33 INFO - PROCESS | 15127 | Values: 84.0 83.0 114.0 83.0 84.0 85.0 105.0 84.0 83.0 109.0 19:02:33 INFO - PROCESS | 15127 | 19:02:33 INFO - PROCESS | 15127 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 19:02:33 INFO - PROCESS | 15127 | Values: 118.0 117.0 118.0 119.0 117.0 118.0 118.0 117.0 117.0 117.0 19:02:33 INFO - PROCESS | 15127 | 19:02:33 INFO - PROCESS | 15127 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 19:02:33 INFO - PROCESS | 15127 | Values: 147.0 148.0 147.0 147.0 148.0 148.0 147.0 147.0 148.0 147.0 19:02:33 INFO - PROCESS | 15127 | 19:02:33 INFO - PROCESS | 15127 | [#7] imaging-desaturate Cycles:10 Average:85.10 Median:85.00 stddev:0.57 (0.7%) stddev-sans-first:0.60 19:02:33 INFO - PROCESS | 15127 | Values: 85.0 86.0 86.0 85.0 85.0 85.0 85.0 85.0 85.0 84.0 19:02:33 INFO - PROCESS | 15127 | 19:02:33 INFO - PROCESS | 15127 | [#8] json-parse-financial Cycles:10 Average:55.30 Median:55.00 stddev:2.45 (4.5%) stddev-sans-first:2.55 19:02:33 INFO - PROCESS | 15127 | Values: 54.0 53.0 53.0 58.0 54.0 55.0 55.0 55.0 61.0 55.0 19:02:33 INFO - PROCESS | 15127 | 19:02:33 INFO - PROCESS | 15127 | [#9] json-stringify-tinderbox Cycles:10 Average:59.70 Median:60.00 stddev:0.82 (1.4%) stddev-sans-first:0.87 19:02:33 INFO - PROCESS | 15127 | Values: 60.0 59.0 59.0 60.0 60.0 60.0 58.0 60.0 60.0 61.0 19:02:33 INFO - PROCESS | 15127 | 19:02:33 INFO - PROCESS | 15127 | [#10] stanford-crypto-aes Cycles:10 Average:82.60 Median:82.00 stddev:2.37 (2.9%) stddev-sans-first:2.32 19:02:33 INFO - PROCESS | 15127 | Values: 80.0 82.0 80.0 82.0 87.0 81.0 82.0 86.0 84.0 82.0 19:02:33 INFO - PROCESS | 15127 | 19:02:33 INFO - PROCESS | 15127 | [#11] stanford-crypto-ccm Cycles:10 Average:147.60 Median:147.50 stddev:12.09 (8.2%) stddev-sans-first:12.80 19:02:33 INFO - PROCESS | 15127 | Values: 150.0 157.0 139.0 145.0 140.0 137.0 141.0 138.0 176.0 153.0 19:02:33 INFO - PROCESS | 15127 | 19:02:33 INFO - PROCESS | 15127 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.30 Median:168.00 stddev:1.57 (0.9%) stddev-sans-first:1.64 19:02:33 INFO - PROCESS | 15127 | Values: 168.0 166.0 168.0 166.0 169.0 168.0 167.0 168.0 169.0 164.0 19:02:33 INFO - PROCESS | 15127 | 19:02:33 INFO - PROCESS | 15127 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:67.00 stddev:2.07 (3.1%) stddev-sans-first:2.11 19:02:33 INFO - PROCESS | 15127 | Values: 66.0 67.0 66.0 71.0 65.0 67.0 69.0 67.0 71.0 67.0 19:02:33 INFO - PROCESS | 15127 | -------- Summary: end -------- 19:02:33 INFO - PROCESS | 15127 | 19:02:34 INFO - TEST-INFO | 15127: exit 0 19:02:34 INFO - TEST-OK | kraken | took 62394ms 19:02:34 INFO - SUITE-END | took 1178s 19:02:35 INFO - Completed test suite (00:19:39) 19:02:35 INFO - javascript benchmark 19:02:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7207.89709075235, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3093.9944518031643, 3097.2566584019837, 3112.0352690665886, 3112.2219445138717, 3119.1578273866057, 5343.278657381257, 5351.464853514642, 5392.973035134829, 5403.594730395222, 5550.5282051025715, 5433.103537916249, 5479.260299859528, 5538.529225015868, 5585.720713964296, 5624.803131890385, 4897.0695567842085, 4943.357363542752, 4947.752612369385, 4960.925586116211, 4975.9004819903585, 4570.981294529824, 4977.0, 5133.383993920735, 5144.819931302405, 5188.766505507242, 4901.068796928572, 5056.873578160538, 5074.112030394685, 5113.923291150599, 5146.099432599299, 4905.2151655734915, 4924.532169443897, 4936.654434189608, 4968.080905032581, 5045.5459008689395, 4871.732054736988, 4893.388326459192, 4906.411230652309, 4916.532929371704, 4950.851474455736, 5363.463653634644, 5370.409254981988, 5394.757235924393, 5419.187121931742, 5432.266644003088, 5647.915281270784, 5695.088785794253, 5763.827085187451, 5842.444967728059, 5853.414658534155, 5906.0, 5906.26171728534, 5908.261467316585, 5915.733791979371, 5964.433378829004, 5469.617126801126, 5475.123980163155, 5481.314835645584, 5481.342238931354, 5484.972575137099, 5814.389489103668, 5867.501262392744, 5877.177195192677, 5904.468597826216, 5988.161657367972, 5647.971760141173, 5705.572082093777, 5713.171590119493, 5777.740001699934, 5778.7688492460675, 5740.425957404226, 5757.884842303214, 5784.508316793035, 5784.942150578525, 5794.739236734357, 5732.3407808101765, 5790.826275211751, 5795.594308398456, 5831.679257640785, 5857.062869940789, 5837.0368889132815, 5875.265591801025, 5888.293404791367, 5889.381614930457, 5897.233359663216, 4488.035072459437, 4489.842855500107, 4491.236489796743, 4537.2059889519205, 4539.251023581072, 3993.7603743775467, 3994.8402063917697, 3997.5802540733384, 4002.039510517455, 4043.231785960717, 5435.0488664483555, 5455.454454554592, 5489.094299440628, 5578.581606379537, 5647.943520564741, 5801.7389217485315, 5853.590248682636, 5858.414158584193, 5910.586258961831, 5912.467877890925, 5426.050441172779, 5468.125099983983, 5468.589855760754, 5474.616776825584, 5496.422875598085, 4963.081829861487, 4979.203327467588, 4989.226669866177, 5024.120778863684, 5049.166887463527, 5976.163337132805, 5976.641401515923, 5992.43071908168, 6032.487238584682, 6044.84887877789, 5776.364599894092, 5785.611453251274, 5791.362950075572, 5848.736806843787, 5856.238688970577, 6012.759489620366, 6024.096385542204, 6025.096235564701, 6029.457348838626, 6036.69816509164, 5757.309122905278, 5784.623999440023, 5787.623804452697, 5832.62087964281, 5839.0949402842625, 5872.324682661549, 5896.852578685567, 5922.851928701817, 5964.403559644001, 5980.073088671263, 5618.634788738719, 5684.175794509855, 5810.389909059488, 5811.070228763378, 5816.243888294494, 5658.632188907708, 5663.66018038919, 5693.772249109989, 5708.942910570841, 5730.08318669011, 5575.77696892136, 5605.962896864094, 5657.0, 5670.914936275876, 5673.631213971079, 5623.325200975909, 5712.11462223356, 5733.799317023884, 5737.426257374229, 5747.626404283708, 5574.386817449996, 5697.515711164598, 5736.569757268138, 5763.51010164124, 5772.0], "value": 5381.356122231935, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [576.124291077562, 586.8914250863593, 590.5157770628082, 592.493418127501, 594.9315828679701, 40228.396574051374, 42042.7897860511, 42107.368389474184, 45383.54616453835, 45535.54464455354, 42831.14337713244, 43457.34813977785, 43703.0, 43742.56257437425, 43847.780761096146, 8261.91738082619, 8504.02203746571, 8539.188777066169, 8572.399932004762, 8588.8711669325, 8780.824383512327, 8857.689980850671, 8897.68858089967, 8905.0, 8932.062133475989, 8940.32947528938, 8968.596413161391, 8990.865137022916, 9014.774630634254, 9016.504092274923, 8802.911970880274, 8870.778230544223, 8883.955580222122, 8885.866711999326, 8886.911130888673, 8833.11668833118, 8892.421992570527, 8899.510526921016, 8901.688440904602, 8911.554422278925, 41066.0, 41750.79124604358, 41808.0, 41830.79084604588, 41877.0, 3331.583552055993, 3361.1429085583263, 3518.9824050879583, 3635.72732045095, 3814.5422549294262, 30305.0, 30638.0, 31243.68756312453, 31327.0, 31484.0, 4174.0, 4208.936865947013, 4265.594768496988, 4413.3159360299205, 4425.8229670813125, 321954.0, 324623.0, 326914.9999999976, 329846.0, 330048.0, 53252.201216981775, 53581.196282055804, 53713.731431342596, 53757.73121134369, 53814.73092634512, 56952.71523642355, 57181.14228286579, 57269.71365143148, 57395.71302143546, 57405.0, 14387.0, 14586.416543338148, 14618.853811461962, 14758.040727352687, 14805.555833325017, 11276.041536469493, 11301.15241356885, 11351.205415620827, 11366.545338186545, 11370.658880233606, 13266.142740016405, 15488.148151851756, 15533.922330388275, 15601.297941592655, 15854.603634908988, 6023.247094113236, 6219.222597175353, 6250.718717657716, 6303.464205542488, 6481.870362592722, 884.4118661090431, 936.0, 1071.393010056753, 1082.3073233130644, 1129.4409267412684, 28452.715472845008, 30847.0, 30987.380252394825, 31095.0, 31643.683563164534, 1065.5098654618807, 1076.434871692352, 1106.8727096383857, 1114.8940850619178, 1129.6441620889393, 15550.688986220212, 16255.59361015984, 16365.836341636432, 16433.424830130887, 16517.752233716503, 434785.0, 438887.0, 439115.0, 439532.0, 440423.0, 54303.18545221825, 54403.45596544063, 54573.45426545763, 54729.726351367986, 54924.0, 1275.9744805103846, 1276.585109839306, 1285.8071289306492, 1289.8839104480642, 1312.1143228321037, 28792.0, 29355.706442935298, 30592.541111883784, 30786.230344240677, 31087.533686995164, 46931.061378772916, 47010.764946176416, 47310.0, 47358.76320618375, 47468.98089363148, 401318.0, 404021.0, 404371.0, 405701.0, 406643.0, 26627.0, 26882.193534194004, 26963.595546067216, 26978.73021269762, 27083.72916270812, 44439.33340999823, 45200.54799452095, 45330.32004519869, 46618.13527458864, 47086.52913470822, 37503.624963750015, 38684.13881939089, 39419.01452463711, 39755.40366894441, 40893.59106408898, 38626.61373386343, 39209.215815684096, 39245.41131883081, 39704.2059158821, 40531.0, 39403.40894886522, 40430.19139617132, 40561.79719101386, 40629.39055914223, 43194.35208471813, 30017.399652007276, 34124.65875341215, 35190.824045879606, 36315.45526817153, 36388.454173186896, 27369.45261094727, 28157.71842281551, 28236.49388369248, 28502.714972850004, 28600.284992874513], "value": 19120.247757184923, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.70570013939357, 388.74925672940935, 393.8385262042562, 400.9198160367927, 421.39740171554666, 17856.375026874062, 19063.142158602863, 19376.9031154844, 19404.0, 19844.50388740282, 18541.25834966603, 18802.15390307436, 18887.811121888775, 19002.0, 19077.427677169708, 5638.379778224402, 5709.486146246837, 5844.824655260349, 5898.439648233432, 5917.615355001933, 5803.361630220672, 5875.412458754112, 5881.0, 5884.76460941564, 5902.763889444439, 5593.496585307322, 5805.709714514279, 5829.300483941933, 5830.4169583041785, 5831.096180092092, 5704.201411802351, 5729.226554415142, 5786.1610066540325, 5790.218320526759, 5833.416658334175, 5023.748812559357, 5151.201563757586, 5175.896482070375, 5183.50756678115, 5185.0, 22411.55176896469, 22480.887595562082, 22547.661785073236, 22851.542969140522, 22857.31428057144, 2273.533925545259, 2277.5672622201896, 2333.428310064028, 2527.0902475108946, 2535.4168541235435, 13885.0, 14424.927875360661, 14518.201498917555, 14654.340554675066, 15132.773008404773, 1874.1659961317218, 1924.3361040441025, 1928.358208955224, 1932.6134773045308, 2016.0927582587894, 74417.62791186063, 75100.62449687772, 75834.24165758328, 77479.61260193663, 77709.61145194237, 10193.388396696222, 10245.948770256251, 10286.27996040285, 10460.372377657364, 10693.732656683645, 14410.279486025656, 14471.85528144726, 14492.97098406224, 14500.0, 14557.272136393138, 7513.0, 7625.847483050419, 7714.437615212252, 7738.458307918391, 7756.263155000266, 7351.77944661661, 7388.0, 7554.131274903347, 7580.279873412017, 7630.694772209049, 6339.809805705836, 6409.903851442232, 6500.804975850732, 6514.869702606016, 6695.665216739144, 1874.7656542932134, 1904.6666833304116, 1923.7787654419922, 1944.931927382535, 1961.6852114504736, 964.6961207219704, 972.7324985628867, 1007.0634310091539, 1039.2361614213546, 1064.4411683865878, 18118.369346758856, 18983.20988640195, 19778.0, 19782.0, 19893.701594476093, 996.9750756231152, 1011.4993078426226, 1016.2479764973866, 1021.1830535571662, 1029.1972261635935, 10578.52396642153, 11359.0, 11415.086793056536, 11428.2000259981, 11441.828372574419, 427600.0, 434487.0, 437089.0, 438440.0, 438469.0, 72088.0, 74401.89604543298, 74768.62615686886, 76641.0, 77399.2260077392, 1001.2628090263387, 1004.2116938203475, 1031.1338475680463, 1033.421284080917, 1040.7242080848582, 15944.0, 17225.65548688994, 17304.826951730825, 17585.912070439565, 17794.110294485483, 41269.58730412657, 41344.586554134075, 41742.0, 41803.10248809034, 42373.57626423697, 54872.0, 56372.0, 57081.14378284412, 58018.4198158013, 58555.12167317579, 6995.545289556163, 7482.962585187257, 8029.8394032120195, 8064.072631647201, 8132.6746930122135, 11157.330560166416, 12968.675783105498, 13151.408186631434, 13319.733605328032, 13388.19670819754, 10805.891941080803, 11273.0, 11368.431578421212, 11378.0, 11593.942030289794, 6294.779682711083, 10074.748131296776, 10084.798304034024, 10184.592616295562, 11209.103271738404, 11180.329180249211, 11186.944065279622, 11386.94306528462, 11393.373364465035, 11931.940340298243, 7441.62791860394, 7574.204708505527, 7666.156722760604, 7836.138024817152, 7987.041555013436, 9995.100440960348, 10766.900454411314, 11112.944435277772, 11131.944340278247, 11384.43077846121], "value": 9092.828852792793, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1483.8590333918273, 1498.0412535976977, 1668.3410053029054, 1773.1134432783608, 1794.398876376413, 8065.354771618271, 8365.91634083659, 8693.47839129652, 9360.765980850481, 9388.953055234715, 8700.608472618731, 9101.726948191565, 9134.223590994758, 9361.110694484014, 9381.81236375272, 2337.1118974789556, 2351.541449417364, 2354.7174339079334, 2368.431576421655, 2371.7509661485556, 2316.2587971849016, 2322.5238826040704, 2347.4718188407555, 2364.18435639704, 2368.632861906399, 2323.337848713117, 2340.2979106268135, 2350.6003979323555, 2353.7642737562746, 2372.1223147435385, 2290.6564015397657, 2311.872846993415, 2318.142287353673, 2323.361075704178, 2323.8838058097026, 2248.9775102249096, 2255.492514184312, 2259.164109279577, 2261.819054475638, 2270.25081723031, 9083.182513573744, 9201.723948281562, 9270.351075424724, 9294.0, 9303.162715355651, 5297.311349524575, 5420.295361603005, 5422.75597598109, 5426.403095659474, 5430.728463576845, 3235.094173631387, 3295.888802256289, 3397.405454045532, 3411.9147021324416, 3420.811855347955, 999.5701848205268, 1050.721558786922, 1055.7044027672264, 1077.1113831089303, 1106.778644271149, 12840.486380544768, 12977.41601627929, 12985.22088674692, 13018.283994380305, 13054.2820144892, 4528.615067719281, 4668.95331046692, 4832.420109586872, 4864.464908860023, 4879.902401951941, 10667.946660266804, 10701.625443109453, 10708.946455267675, 10722.303050301705, 10745.40900250478, 5469.343678758574, 5478.205660179252, 5483.341998960071, 5494.532964697965, 5503.0, 4411.669124815651, 4571.474280457724, 4844.75776211188, 4997.575206107449, 5067.189249720027, 3848.5958974307855, 3983.780892050907, 4072.0634254121123, 4086.9182616348103, 4150.211459822624, 1301.5704817410233, 1303.178997231757, 1324.6886981559326, 1332.3471498965437, 1352.0468070010618, 903.2367649336301, 916.1572786076855, 924.1451657217182, 940.4263399326405, 954.4750387286964, 5737.0, 6072.0, 6077.878442431127, 6091.51267898567, 6294.307626161119, 970.3062310447923, 1013.4679293371039, 1033.9017793309774, 1046.7697106636529, 1067.588978243382, 3968.4245784361106, 4178.91642167155, 4195.202911446815, 4196.160767846443, 4198.286291330481, 11373.37446440437, 11630.069594432594, 11710.297382157098, 11729.706757331134, 11765.235259708092, 11667.891550302707, 11671.88328116725, 11695.947364737214, 11698.532058717727, 11704.765904681859, 7951.324137448266, 8395.034571024411, 8403.621837017348, 8580.785480363042, 8687.26158276541, 6028.939710603014, 6147.784827531015, 6171.629702217701, 6206.968965155145, 6233.376662333731, 10079.596816127272, 10099.848502272325, 10105.0, 10109.545070471699, 10162.18702503783, 10152.137068349273, 10626.946865265625, 10650.946745266225, 10773.838392424277, 10926.235163538793, 7073.540219885691, 7335.303146201102, 7887.723929662434, 8006.479578827358, 8056.033276006917, 8800.471971681463, 8969.37214394986, 8980.595873185592, 8982.910170898207, 8987.595558200028, 7806.0632724073475, 7854.175311592429, 7936.563489007929, 8024.518528888286, 8076.555789431638, 7773.961130194313, 7775.066991961001, 7810.867424223569, 7840.294373506412, 7851.0, 7285.052943117361, 7393.482456228013, 7403.222661620668, 7404.6667899945705, 7414.592197429193, 4981.3026176334615, 5159.896802064013, 5179.81870634526, 5289.867753306198, 5497.725113744376, 5321.627486075938, 5329.333833270841, 5422.376426710979, 5479.369872464717, 5549.750261238173], "value": 4753.020360306931, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [319.5621997862927, 326.58913493707195, 331.129130387082, 333.6130089096648, 335.8690110856765, 5371.677699338033, 5480.534154596864, 5501.477359650832, 5532.727472681281, 5554.389017208109, 5240.947590524093, 5313.38896026957, 5349.5185433311, 5362.184852952202, 5452.59105567082, 4209.768462734548, 4211.8525851595205, 4216.79523562092, 4221.641160501361, 4224.70427070106, 4129.793510324487, 4218.578142185787, 4234.428352172448, 4246.2356775780345, 4248.553901840309, 4234.9364759528635, 4238.449001629784, 4242.724222925515, 4245.150969806035, 4253.744775313491, 4194.790260486963, 4217.135487225111, 4233.0, 4243.61807437329, 4244.36591912113, 3715.5912849586525, 3759.981200094009, 3803.334416477133, 3813.4470501777364, 3827.885163445101, 5215.843524694265, 5237.0, 5246.554042906358, 5257.631965762398, 5284.9735751320995, 4818.494058123882, 4853.733044682541, 4854.965646470956, 4859.1331114642535, 4864.246041863482, 5422.105352616813, 5671.517920976722, 5675.2054712340305, 5681.914771278434, 5684.232628595169, 4128.277551428518, 4163.5628259032665, 4165.312723400635, 4166.6250037496775, 4167.1457351242925, 5973.492253158487, 5992.041273396279, 6002.309734380515, 6034.0948857671265, 6038.728257228479, 4036.8990775230855, 4282.073067119809, 4286.89282767927, 4303.956960430418, 4339.284018137035, 4303.612674859278, 4306.504751953566, 4338.978305108518, 4342.891427714332, 4347.978260108679, 4927.359443272423, 4960.900781984412, 4975.875603109879, 4977.203647416396, 4992.176290912032, 5564.638298510584, 5760.683162426107, 5812.622179558315, 5901.852453688693, 5913.467787899023, 1495.5588101510082, 1516.294922860853, 1516.408600645749, 1517.332373755544, 1517.7495713207418, 949.7008442340641, 965.2085290062222, 972.3679608254549, 977.5454413697664, 993.2550587059706, 4895.478828403375, 4918.877028074256, 4922.483139270325, 4927.802887884444, 4937.23472861707, 5142.254373115952, 5203.271541984125, 5221.686698798084, 5268.076217699214, 5295.549878260314, 4671.719696818202, 4914.100680598464, 4967.4784147664695, 4981.42713587942, 4988.451270360258, 2764.7097054808955, 2777.652793400825, 2783.8029647251874, 2784.4152727926958, 2806.975453959331, 5312.442193569696, 5314.342828585707, 5320.201969704498, 5338.9466105339225, 5339.439358867341, 5279.1817268323475, 5293.3647962244, 5575.1915972184615, 6048.304444988795, 6077.17958075663, 6070.180525629072, 6075.908861367083, 6083.7870674526175, 6085.148079268817, 6190.535709821691, 5683.77264909399, 5992.8801423972145, 5996.340402555628, 6014.188084608697, 6024.337322894566, 5890.204822348928, 5913.615614985012, 5923.763049477972, 5927.851803704942, 5937.228160339301, 6106.72519736604, 6134.5033331000905, 6174.536909731878, 6176.66028368444, 6199.380061993765, 3968.40473928913, 4049.8177582008293, 4113.4858142732155, 4156.147989662051, 4183.39340795589, 5921.230240068763, 5921.881562368814, 5956.76172953077, 5973.432523910222, 5992.13114098462, 5606.85982850432, 5776.19133321327, 5844.503217226414, 5844.590878638454, 5873.9412605873395, 5708.57185711065, 5712.885742285048, 5732.394929419769, 5737.6188881615335, 5764.884702306014, 5748.942510575008, 5770.769169233352, 5774.105013722879, 5778.27771528559, 5789.652620842763, 5532.944670553243, 5764.596478246483, 5766.855828604318, 5811.099279611667, 5819.854503637443, 5676.375598684059, 5682.943170568242, 5695.316562012585, 5710.771569137188, 5713.600047996601], "value": 4309.895427785404, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [713.1620346093341, 743.7917383132725, 796.0, 798.9081255655598, 809.1706001348617, 14171.645708857272, 14887.776683349759, 14959.476418325361, 14987.0, 15068.09591424514, 14849.480268190615, 14970.625734356647, 15007.474738384159, 15021.399144034225, 15037.548873533784, 658.2397331082607, 683.1324218242829, 769.6305773228853, 789.6525528767338, 794.6702118620766, 800.995995020027, 805.9838803223932, 811.4887620798888, 812.1675282835082, 814.1410811593767, 844.5397258494136, 846.4202021615182, 847.9491230526188, 848.8217474330398, 851.1743608699552, 843.5571325054395, 844.3161039557947, 845.6575087089739, 846.8941382327209, 846.8941382327209, 618.026608092252, 624.1605041219552, 624.188554878656, 624.2633692243152, 624.9250089989231, 13705.794413083811, 13812.792808107886, 13830.515931942333, 13844.723105537832, 13979.510717124953, 14112.858871411257, 14386.92806535971, 14426.206558639271, 14494.492692755703, 14505.41978320866, 11472.77054458906, 11636.12729045325, 11743.412829358584, 11796.705082372924, 12357.443915023845, 3688.6495782900583, 3818.3890577507464, 3923.117298607819, 3927.6465118139504, 3941.467901833273, 72030.0, 72056.0, 73963.0, 74744.25255747428, 75253.24746752573, 11308.434578271053, 11349.716257093638, 11403.258788178742, 11505.13711471643, 11924.523019079139, 22263.888680556494, 22605.687663399087, 22633.660495092587, 22636.660450093263, 22664.206752763905, 7189.0, 7224.927750722531, 7376.409887209011, 7385.3722433592675, 7438.814029649302, 4372.103718737651, 4402.031553058322, 4429.335599660077, 4540.025089086258, 4636.026434448803, 3489.1277180704824, 3586.1751797086818, 3591.048372181374, 3598.8020658864016, 3599.6220396858475, 580.8605934575756, 597.1958623567814, 600.4475882188398, 601.0953514960045, 610.8503416662858, 655.924568674599, 661.7849199010341, 728.1553398058227, 734.3574372424129, 741.2365263778318, 8945.418547794372, 9553.808923821623, 9617.0, 9778.75553111178, 10098.495075246208, 673.5857447669648, 696.951213415056, 705.9713827679301, 729.3727394440776, 765.3915137465729, 4322.783860806947, 4388.890277743082, 4557.498675145731, 4572.060515788994, 4807.519248075165, 63248.367516324244, 71781.64109179421, 83689.58155209185, 123412.0, 124499.37750311372, 57018.42981570131, 57158.142627860616, 86948.56525717331, 93611.0, 93986.53006734923, 66086.66956665186, 85935.57032214924, 88951.55524222337, 89620.55189724009, 89981.55009224912, 8904.421212621159, 9037.277017838689, 9071.319651026068, 9107.812265706949, 9122.224610908148, 50642.74678626583, 51009.489905100476, 52500.212496811815, 52510.73744631252, 52788.0, 61368.69315653393, 62580.374196259276, 73134.63432682803, 73206.26793731995, 74866.62566687132, 12083.39583020828, 12111.45498452554, 12193.634190974284, 12622.747545048864, 13054.673633158867, 14022.719545609234, 14333.498327558485, 14600.926995364955, 14618.195999220145, 14675.706485870436, 13280.601581952556, 13315.0, 13613.387397566936, 13982.790258145933, 14219.786703199667, 13498.59504214875, 13648.727025459633, 13764.31178441094, 14350.784738228725, 14454.253691798525, 13596.388162532907, 13653.385597648328, 13780.448782048607, 14107.788383174466, 14324.57026289213, 10305.433201174008, 10581.788364232827, 10713.785724285626, 10805.944612446296, 10892.346459212473, 9927.950360248153, 9993.758854006786, 10282.714660667416, 11365.659030229106, 11403.714907127389], "value": 7316.268566912083, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1518.3999999999996, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 114.0, 113.0, 113.0, 113.0, 112.0, 112.0, 112.0, 111.0, 112.0], "value": 111.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 125.0, 127.0, 164.0, 130.0, 134.0, 132.0, 129.0, 148.0, 125.0], "value": 136.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 163.0, 167.0, 169.0, 167.0, 163.0, 163.0, 164.0, 165.0, 164.0], "value": 165.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 78.0, 114.0, 76.0, 78.0, 76.0, 77.0, 103.0, 76.0], "value": 83.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 114.0, 83.0, 84.0, 85.0, 105.0, 84.0, 83.0, 109.0], "value": 91.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 119.0, 117.0, 118.0, 118.0, 117.0, 117.0, 117.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 147.0, 147.0, 148.0, 148.0, 147.0, 147.0, 148.0, 147.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 86.0, 85.0, 85.0, 85.0, 85.0, 85.0, 85.0, 84.0], "value": 85.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 53.0, 58.0, 54.0, 55.0, 55.0, 55.0, 61.0, 55.0], "value": 55.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 59.0, 59.0, 60.0, 60.0, 60.0, 58.0, 60.0, 60.0, 61.0], "value": 59.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 82.0, 80.0, 82.0, 87.0, 81.0, 82.0, 86.0, 84.0, 82.0], "value": 82.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 157.0, 139.0, 145.0, 140.0, 137.0, 141.0, 138.0, 176.0, 153.0], "value": 147.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 166.0, 168.0, 166.0, 169.0, 168.0, 167.0, 168.0, 169.0, 164.0], "value": 167.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 66.0, 71.0, 65.0, 67.0, 69.0, 67.0, 71.0, 67.0], "value": 67.6, "unit": "score"}]}]} 19:02:35 INFO - Return code: 0 19:02:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:02:35 ERROR - # TBPL SUCCESS # 19:02:35 INFO - Running post-action listener: _resource_record_post_action 19:02:35 INFO - [mozharness: 2016-10-25 02:02:35.245366Z] Finished run-tests step (success) 19:02:35 INFO - Running post-run listener: _resource_record_post_run 19:02:35 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 0; Write bytes: 392159232; Read time: 0; Write time: 252444 19:02:35 INFO - TinderboxPrint: CPU usage
13.4% 19:02:35 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 19:02:35 INFO - TinderboxPrint: I/O write bytes / time
392,159,232 / 252,444 19:02:35 INFO - TinderboxPrint: CPU idle
8,255.2 (86.6%) 19:02:35 INFO - TinderboxPrint: CPU user
1,219.7 (12.8%) 19:02:35 INFO - TinderboxPrint: Swap in / out
0 / 0 19:02:35 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103804928; Read time: 0; Write time: 93848 19:02:35 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 288014336; Read time: 0; Write time: 158596 19:02:35 INFO - Running post-run listener: _upload_blobber_files 19:02:35 INFO - Blob upload gear active. 19:02:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:02:35 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 19:02:35 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:02:35 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:02:36 INFO - (blobuploader) - INFO - Open directory for files ... 19:02:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:02:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:02:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:02:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:02:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:02:37 INFO - (blobuploader) - INFO - Done attempting. 19:02:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:02:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:02:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:02:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:02:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:02:38 INFO - (blobuploader) - INFO - Done attempting. 19:02:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:02:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:02:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:02:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:02:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:02:41 INFO - (blobuploader) - INFO - Done attempting. 19:02:41 INFO - (blobuploader) - INFO - Iteration through files over. 19:02:41 INFO - Return code: 0 19:02:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:02:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:02:41 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c0958a826f1b1a77d746c33f5c322723a3910b91862555e04d7bb65b5332840e0f370c2d39a4d5f1ef00f59f88108868ed3764bb70d404f3fdf2768694e67fe3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f00ccf663b4cc4400f162aa2500cfe6ef071c031cef169b2ea6f4f382fdc91696443a8145a584432779ce588f351d77a0ebba57a52f1461811e08dd4eb473b20", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/477156ad891fae46b501664563ddf082b94d023e9c0d257a3174ec4eab299745b1c56917691e756e444ec7df9014121f4c9a42cc12185af5524c39f1c2ecdae3"} 19:02:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:02:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:02:41 INFO - Contents: 19:02:41 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c0958a826f1b1a77d746c33f5c322723a3910b91862555e04d7bb65b5332840e0f370c2d39a4d5f1ef00f59f88108868ed3764bb70d404f3fdf2768694e67fe3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f00ccf663b4cc4400f162aa2500cfe6ef071c031cef169b2ea6f4f382fdc91696443a8145a584432779ce588f351d77a0ebba57a52f1461811e08dd4eb473b20", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/477156ad891fae46b501664563ddf082b94d023e9c0d257a3174ec4eab299745b1c56917691e756e444ec7df9014121f4c9a42cc12185af5524c39f1c2ecdae3"} 19:02:41 INFO - Running post-run listener: copy_logs_to_upload_dir 19:02:41 INFO - Copying logs to upload dir... 19:02:41 INFO - mkdir: /builds/slave/test/build/upload/logs 19:02:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.275265 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-10-24 19:02:41.200177) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-24 19:02:41.203847) ========= 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=41bf3e9aed84707956354da8000001c5-1477359721.921871-20206468 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/Fx-Team/sha512/c0958a826f1b1a77d746c33f5c322723a3910b91862555e04d7bb65b5332840e0f370c2d39a4d5f1ef00f59f88108868ed3764bb70d404f3fdf2768694e67fe3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f00ccf663b4cc4400f162aa2500cfe6ef071c031cef169b2ea6f4f382fdc91696443a8145a584432779ce588f351d77a0ebba57a52f1461811e08dd4eb473b20", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/477156ad891fae46b501664563ddf082b94d023e9c0d257a3174ec4eab299745b1c56917691e756e444ec7df9014121f4c9a42cc12185af5524c39f1c2ecdae3"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477348234/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011334 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477348234/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c0958a826f1b1a77d746c33f5c322723a3910b91862555e04d7bb65b5332840e0f370c2d39a4d5f1ef00f59f88108868ed3764bb70d404f3fdf2768694e67fe3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f00ccf663b4cc4400f162aa2500cfe6ef071c031cef169b2ea6f4f382fdc91696443a8145a584432779ce588f351d77a0ebba57a52f1461811e08dd4eb473b20", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/477156ad891fae46b501664563ddf082b94d023e9c0d257a3174ec4eab299745b1c56917691e756e444ec7df9014121f4c9a42cc12185af5524c39f1c2ecdae3"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-24 19:02:41.229752) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 19:02:41.230083) ========= 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=41bf3e9aed84707956354da8000001c5-1477359721.921871-20206468 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004398 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 19:02:41.313338) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-24 19:02:41.313647) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-24 19:02:41.313943) ========= ========= Total master_lag: 0.17 =========