builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-060 starttime: 1480202617.53 results: success (0) buildid: 20161126152319 builduid: ba36d96e9ac741b8a19996a3490c9146 revision: 873a10f77413394e7e4c2374ffb966e96b533ca6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-26 15:23:37.534831) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-26 15:23:37.535321) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-26 15:23:37.535823) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-26 15:23:37.569379) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-26 15:23:37.569820) ========= 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=337fe3f4b1febe37b85fccc40000019e-1480192974.141195-1379483306 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-26 15:23:37-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 50.7M=0s 2016-11-26 15:23:37 (50.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.112671 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-26 15:23:37.718474) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-26 15:23:37.718804) ========= 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=337fe3f4b1febe37b85fccc40000019e-1480192974.141195-1379483306 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021473 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-26 15:23:37.792049) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-26 15:23:37.792384) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 873a10f77413394e7e4c2374ffb966e96b533ca6 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 873a10f77413394e7e4c2374ffb966e96b533ca6 --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=337fe3f4b1febe37b85fccc40000019e-1480192974.141195-1379483306 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-26 15:23:38,060 truncating revision to first 12 chars 2016-11-26 15:23:38,060 Setting DEBUG logging. 2016-11-26 15:23:38,060 attempt 1/10 2016-11-26 15:23:38,060 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/873a10f77413?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-26 15:23:38,506 unpacking tar archive at: mozilla-inbound-873a10f77413/testing/mozharness/ program finished with exit code 0 elapsedTime=0.744775 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-26 15:23:38.552436) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-26 15:23:38.552741) ========= script_repo_revision: 873a10f77413394e7e4c2374ffb966e96b533ca6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-26 15:23:38.553117) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-26 15:23:38.553439) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-26 15:23:38.563422) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-11-26 15:23:38.563681) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=337fe3f4b1febe37b85fccc40000019e-1480192974.141195-1379483306 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:23:38 INFO - MultiFileLogger online at 20161126 15:23:38 in /builds/slave/test 15:23:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 15:23:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:23:38 INFO - {'append_to_log': False, 15:23:38 INFO - 'base_work_dir': '/builds/slave/test', 15:23:38 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 15:23:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:23:38 INFO - 'branch': 'Mozilla-Inbound', 15:23:38 INFO - 'buildbot_json_path': 'buildprops.json', 15:23:38 INFO - 'config_files': ('talos/linux_config.py',), 15:23:38 INFO - 'default_actions': ('clobber', 15:23:38 INFO - 'read-buildbot-config', 15:23:38 INFO - 'download-and-extract', 15:23:38 INFO - 'populate-webroot', 15:23:38 INFO - 'create-virtualenv', 15:23:38 INFO - 'install', 15:23:38 INFO - 'run-tests'), 15:23:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:23:38 INFO - 'download_minidump_stackwalk': True, 15:23:38 INFO - 'download_symbols': 'ondemand', 15:23:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:23:38 INFO - 'tooltool.py': '/tools/tooltool.py', 15:23:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:23:38 INFO - '/tools/misc-python/virtualenv.py')}, 15:23:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:23:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:23:38 INFO - 'installer_path': 'installer.exe', 15:23:38 INFO - 'log_level': 'info', 15:23:38 INFO - 'log_name': 'talos', 15:23:38 INFO - 'log_to_console': True, 15:23:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:23:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:23:38 INFO - 'opt_config_files': (), 15:23:38 INFO - 'pip_index': False, 15:23:38 INFO - 'sps_profile': False, 15:23:38 INFO - 'sps_profile_interval': 0, 15:23:38 INFO - 'suite': 'dromaeojs', 15:23:38 INFO - 'system_bits': '32', 15:23:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:23:38 INFO - 'title': 'talos-linux64-ix-060', 15:23:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:23:38 INFO - 'use_talos_json': True, 15:23:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:23:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:23:38 INFO - 'work_dir': 'build'} 15:23:38 INFO - [mozharness: 2016-11-26 23:23:38.927450Z] Running clobber step. 15:23:38 INFO - Running pre-action listener: _resource_record_pre_action 15:23:38 INFO - Running main action method: clobber 15:23:38 INFO - rmtree: /builds/slave/test/build 15:23:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:23:39 INFO - Running post-action listener: _resource_record_post_action 15:23:39 INFO - [mozharness: 2016-11-26 23:23:39.383985Z] Finished clobber step (success) 15:23:39 INFO - [mozharness: 2016-11-26 23:23:39.384083Z] Running read-buildbot-config step. 15:23:39 INFO - Running pre-action listener: _resource_record_pre_action 15:23:39 INFO - Running main action method: read_buildbot_config 15:23:39 INFO - Using buildbot properties: 15:23:39 INFO - { 15:23:39 INFO - "project": "", 15:23:39 INFO - "product": "firefox", 15:23:39 INFO - "script_repo_revision": "production", 15:23:39 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 15:23:39 INFO - "repository": "", 15:23:39 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 15:23:39 INFO - "buildid": "20161126152319", 15:23:39 INFO - "stage_platform": "linux64-pgo", 15:23:39 INFO - "basedir": "/builds/slave/test", 15:23:39 INFO - "buildnumber": 2160, 15:23:39 INFO - "platform": "ubuntu64_hw", 15:23:39 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:23:39 INFO - "slavebuilddir": "test", 15:23:39 INFO - "branch": "mozilla-inbound", 15:23:39 INFO - "revision": "873a10f77413394e7e4c2374ffb966e96b533ca6", 15:23:39 INFO - "slavename": "talos-linux64-ix-060", 15:23:39 INFO - "builduid": "ba36d96e9ac741b8a19996a3490c9146", 15:23:39 INFO - "repo_path": "integration/mozilla-inbound" 15:23:39 INFO - } 15:23:39 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480192204/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 15:23:39 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480192204/firefox-53.0a1.en-US.linux-x86_64.test_packages.json. 15:23:39 INFO - Running post-action listener: _resource_record_post_action 15:23:39 INFO - [mozharness: 2016-11-26 23:23:39.386414Z] Finished read-buildbot-config step (success) 15:23:39 INFO - [mozharness: 2016-11-26 23:23:39.386502Z] Running download-and-extract step. 15:23:39 INFO - Running pre-action listener: _resource_record_pre_action 15:23:39 INFO - Running main action method: download_and_extract 15:23:39 INFO - mkdir: /builds/slave/test/build/tests 15:23:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:23:39 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480192204/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 15:23:39 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480192204/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 15:23:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480192204/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 15:23:39 INFO - Downloaded 1361 bytes. 15:23:39 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 15:23:39 INFO - Using the following test package requirements: 15:23:39 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 15:23:39 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 15:23:39 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:23:39 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 15:23:39 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:23:39 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 15:23:39 INFO - u'jsshell-linux-x86_64.zip'], 15:23:39 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 15:23:39 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:23:39 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 15:23:39 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 15:23:39 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:23:39 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 15:23:39 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:23:39 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 15:23:39 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:23:39 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 15:23:39 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:23:39 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:23:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480192204/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 15:23:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480192204/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:23:39 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480192204/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 15:23:39 INFO - Http code: 200 15:23:39 INFO - via: 1.1 455cf6ccbccc261c46d02110de1c0237.cloudfront.net (CloudFront) 15:23:39 INFO - x-amz-cf-id: -SEXnDnNfpGlQLlB7FlZaJXXXfgXueWfg_ZKVLnvzD-JPbPDK86vzQ== 15:23:39 INFO - x-amz-replication-status: COMPLETED 15:23:39 INFO - x-amz-version-id: HjoKhwMB359BkrH7ipMVtHNhHqXixkx0 15:23:42 INFO - Expected file size: 21771581 15:23:42 INFO - Obtained file size: 21771581 15:23:46 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:23:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480192204/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 15:23:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480192204/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:23:46 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480192204/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 15:23:46 INFO - Http code: 200 15:23:46 INFO - via: 1.1 23172d761378a3865feafcda78328053.cloudfront.net (CloudFront) 15:23:46 INFO - x-amz-cf-id: m2B-Z24bhJiKer0opYxcU9HVPDpavDO-KNF_BB5V-GwTlepu0wyvwA== 15:23:46 INFO - x-amz-replication-status: COMPLETED 15:23:46 INFO - x-amz-version-id: HjoKhwMB359BkrH7ipMVtHNhHqXixkx0 15:23:47 INFO - Expected file size: 21771581 15:23:47 INFO - Obtained file size: 21771581 15:23:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480192204/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 15:23:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480192204/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:23:51 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480192204/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 15:23:51 INFO - Http code: 200 15:23:51 INFO - via: 1.1 11dd60d1f68e8258294f92935b53a91f.cloudfront.net (CloudFront) 15:23:51 INFO - x-amz-cf-id: WB3dURKzNG0KhQttCDI1wrYTm6jHZ9GQ7NVwwAJ77u6ZLBGZcp-x3w== 15:23:51 INFO - x-amz-replication-status: COMPLETED 15:23:51 INFO - x-amz-version-id: kvEazRc1fNZJFG4mD_jLDLB5W1A9Z1cZ 15:23:54 INFO - Expected file size: 14409702 15:23:54 INFO - Obtained file size: 14409702 15:23: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')]} 15:23:55 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480192204/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 15:23:55 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480192204/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 15:23:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480192204/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:24:00 INFO - Downloaded 59820159 bytes. 15:24:00 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480192204/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 15:24:00 INFO - mkdir: /builds/slave/test/properties 15:24:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:24:00 INFO - Writing to file /builds/slave/test/properties/build_url 15:24:00 INFO - Contents: 15:24:00 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480192204/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 15:24:00 INFO - Running post-action listener: _resource_record_post_action 15:24:00 INFO - Running post-action listener: set_extra_try_arguments 15:24:00 INFO - [mozharness: 2016-11-26 23:24:00.496835Z] Finished download-and-extract step (success) 15:24:00 INFO - [mozharness: 2016-11-26 23:24:00.497062Z] Running populate-webroot step. 15:24:00 INFO - Running pre-action listener: _resource_record_pre_action 15:24:00 INFO - Running main action method: populate_webroot 15:24:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:24:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:24:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:24:00 INFO - '--tppagecycles', 15:24:00 INFO - '7'], 15:24:00 INFO - 'tests': ['tsvgm']}}, 15:24:00 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:24:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:24:00 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:24:00 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:24:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:24:00 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:24:00 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 15:24:00 INFO - 'talos_options': ['--disable-e10s'], 15:24:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:24:00 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:24:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:24:00 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 15:24:00 INFO - 'talos_options': ['--disable-e10s'], 15:24:00 INFO - 'tests': ['damp', 'tps']}, 15:24:00 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:24:00 INFO - 'tests': ['damp', 'tps']}, 15:24:00 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:24:00 INFO - 'tests': ['dromaeo_dom']}, 15:24:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:24:00 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:24:00 INFO - 'tests': ['basic_compositor_video']}, 15:24:00 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:24:00 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:24:00 INFO - 'tests': ['a11yr', 15:24:00 INFO - 'ts_paint', 15:24:00 INFO - 'tpaint', 15:24:00 INFO - 'sessionrestore', 15:24:00 INFO - 'sessionrestore_no_auto_restore', 15:24:00 INFO - 'tabpaint']}, 15:24:00 INFO - 'other-e10s': {'tests': ['a11yr', 15:24:00 INFO - 'ts_paint', 15:24:00 INFO - 'tpaint', 15:24:00 INFO - 'sessionrestore', 15:24:00 INFO - 'sessionrestore_no_auto_restore', 15:24:00 INFO - 'tabpaint']}, 15:24:00 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:24:00 INFO - 'ts_paint', 15:24:00 INFO - 'tpaint', 15:24:00 INFO - 'sessionrestore', 15:24:00 INFO - 'sessionrestore_no_auto_restore', 15:24:00 INFO - 'tabpaint']}, 15:24:00 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:24:00 INFO - 'ts_paint', 15:24:00 INFO - 'tpaint', 15:24:00 INFO - 'sessionrestore', 15:24:00 INFO - 'sessionrestore_no_auto_restore', 15:24:00 INFO - 'tabpaint']}, 15:24:00 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:24:00 INFO - 'tests': ['a11yr', 15:24:00 INFO - 'ts_paint', 15:24:00 INFO - 'tpaint', 15:24:00 INFO - 'sessionrestore', 15:24:00 INFO - 'sessionrestore_no_auto_restore', 15:24:00 INFO - 'tabpaint']}, 15:24:00 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:24:00 INFO - 'tests': ['a11yr', 15:24:00 INFO - 'ts_paint', 15:24:00 INFO - 'tpaint', 15:24:00 INFO - 'sessionrestore', 15:24:00 INFO - 'sessionrestore_no_auto_restore', 15:24:00 INFO - 'tabpaint']}, 15:24:00 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:24:00 INFO - 'tests': ['tsvgx', 15:24:00 INFO - 'tsvgr_opacity', 15:24:00 INFO - 'tart', 15:24:00 INFO - 'tscrollx', 15:24:00 INFO - 'cart', 15:24:00 INFO - 'tsvg_static']}, 15:24:00 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:24:00 INFO - 'tsvgr_opacity', 15:24:00 INFO - 'tart', 15:24:00 INFO - 'tscrollx', 15:24:00 INFO - 'cart', 15:24:00 INFO - 'tsvg_static']}, 15:24:00 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 15:24:00 INFO - 'talos_options': ['--disable-e10s'], 15:24:00 INFO - 'tests': ['tp5o']}, 15:24:00 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:24:00 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 15:24:00 INFO - 'talos_options': ['--disable-e10s', 15:24:00 INFO - '--xperf_path', 15:24:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:24:00 INFO - 'tests': ['tp5n']}, 15:24:00 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:24:00 INFO - 'talos_options': ['--xperf_path', 15:24:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:24:00 INFO - 'tests': ['tp5n']}}, 15:24:00 INFO - 'talos.zip': {'path': '', 15:24:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:24:00 INFO - Running post-action listener: _resource_record_post_action 15:24:00 INFO - [mozharness: 2016-11-26 23:24:00.518675Z] Finished populate-webroot step (success) 15:24:00 INFO - [mozharness: 2016-11-26 23:24:00.518762Z] Running create-virtualenv step. 15:24:00 INFO - Running pre-action listener: _resource_record_pre_action 15:24:00 INFO - Running main action method: create_virtualenv 15:24:00 INFO - Creating virtualenv /builds/slave/test/build/venv 15:24:00 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 15:24:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:24:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:24:00 INFO - Using real prefix '/usr' 15:24:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:24:01 INFO - Installing distribute.............................................................................................................................................................................................done. 15:24:03 INFO - Installing pip.................done. 15:24:03 INFO - Return code: 0 15:24:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:24:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:24:03 INFO - Reading from file tmpfile_stdout 15:24:03 INFO - Output received: 15:24:03 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) 15:24:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:24:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:24:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:24:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:24:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:24:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7805825e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d7b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1673130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1701fc0>, '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 0x1702ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1703350>, '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': '337fe3f4b1febe37b85fccc40000019e-1480192974.141195-1379483306', '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 15:24:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:24:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:24:03 INFO - Using env: {'DISPLAY': ':0', 15:24:03 INFO - 'HOME': '/home/cltbld', 15:24:03 INFO - 'LANG': 'en_US.UTF-8', 15:24:03 INFO - 'LANGUAGE': 'en_US:en', 15:24:03 INFO - 'LOGNAME': 'cltbld', 15:24:03 INFO - 'MAIL': '/var/mail/cltbld', 15:24:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:24:03 INFO - 'MOZ_NO_REMOTE': '1', 15:24:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:24:03 INFO - 'NO_EM_RESTART': '1', 15:24:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:24:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:24:03 INFO - 'PWD': '/builds/slave/test', 15:24:03 INFO - 'SHELL': '/bin/bash', 15:24:03 INFO - 'SHLVL': '1', 15:24:03 INFO - 'TERM': 'linux', 15:24:03 INFO - 'TMOUT': '86400', 15:24:03 INFO - 'USER': 'cltbld', 15:24:03 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1480192974.141195-1379483306', 15:24:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:24:03 INFO - '_': '/tools/buildbot/bin/python'} 15:24:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:24:03 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 15:24:03 INFO - Cleaning up... 15:24:03 INFO - Return code: 0 15:24:03 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:24:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:24:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:24:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:24:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:24:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f7805825e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d7b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1673130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1701fc0>, '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 0x1702ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1703350>, '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': '337fe3f4b1febe37b85fccc40000019e-1480192974.141195-1379483306', '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 15:24:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:24:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:24:03 INFO - Using env: {'DISPLAY': ':0', 15:24:03 INFO - 'HOME': '/home/cltbld', 15:24:03 INFO - 'LANG': 'en_US.UTF-8', 15:24:03 INFO - 'LANGUAGE': 'en_US:en', 15:24:03 INFO - 'LOGNAME': 'cltbld', 15:24:03 INFO - 'MAIL': '/var/mail/cltbld', 15:24:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:24:03 INFO - 'MOZ_NO_REMOTE': '1', 15:24:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:24:03 INFO - 'NO_EM_RESTART': '1', 15:24:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:24:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:24:03 INFO - 'PWD': '/builds/slave/test', 15:24:03 INFO - 'SHELL': '/bin/bash', 15:24:03 INFO - 'SHLVL': '1', 15:24:03 INFO - 'TERM': 'linux', 15:24:03 INFO - 'TMOUT': '86400', 15:24:03 INFO - 'USER': 'cltbld', 15:24:03 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1480192974.141195-1379483306', 15:24:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:24:03 INFO - '_': '/tools/buildbot/bin/python'} 15:24:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:24:03 INFO - Downloading/unpacking psutil>=3.1.1 15:24:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:24:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:24:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:24:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:24:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:24:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:24:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:24:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:24:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:24:05 INFO - Installing collected packages: psutil 15:24:05 INFO - Running setup.py install for psutil 15:24:05 INFO - building 'psutil._psutil_linux' extension 15:24:05 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 15:24:05 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 15:24:06 INFO - building 'psutil._psutil_posix' extension 15:24:06 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 15:24:06 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 15:24:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:24:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:24:06 INFO - Successfully installed psutil 15:24:06 INFO - Cleaning up... 15:24:06 INFO - Return code: 0 15:24:06 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:24:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:24:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:24:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:24:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:24:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:06 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 0x7f7805825e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d7b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1673130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1701fc0>, '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 0x1702ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1703350>, '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': '337fe3f4b1febe37b85fccc40000019e-1480192974.141195-1379483306', '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 15:24:06 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 15:24:06 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 15:24:06 INFO - Using env: {'DISPLAY': ':0', 15:24:06 INFO - 'HOME': '/home/cltbld', 15:24:06 INFO - 'LANG': 'en_US.UTF-8', 15:24:06 INFO - 'LANGUAGE': 'en_US:en', 15:24:06 INFO - 'LOGNAME': 'cltbld', 15:24:06 INFO - 'MAIL': '/var/mail/cltbld', 15:24:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:24:06 INFO - 'MOZ_NO_REMOTE': '1', 15:24:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:24:06 INFO - 'NO_EM_RESTART': '1', 15:24:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:24:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:24:06 INFO - 'PWD': '/builds/slave/test', 15:24:06 INFO - 'SHELL': '/bin/bash', 15:24:06 INFO - 'SHLVL': '1', 15:24:06 INFO - 'TERM': 'linux', 15:24:06 INFO - 'TMOUT': '86400', 15:24:06 INFO - 'USER': 'cltbld', 15:24:06 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1480192974.141195-1379483306', 15:24:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:24:06 INFO - '_': '/tools/buildbot/bin/python'} 15:24:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:24:06 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:24:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:24:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:24:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:24:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:24:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:24:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:24:08 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:24:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:24:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:24:08 INFO - Installing collected packages: mozsystemmonitor 15:24:08 INFO - Running setup.py install for mozsystemmonitor 15:24:08 INFO - Successfully installed mozsystemmonitor 15:24:08 INFO - Cleaning up... 15:24:08 INFO - Return code: 0 15:24:08 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:24:08 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')]} 15:24:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:24:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:08 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')]} 15:24:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:24:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:08 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 0x7f7805825e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d7b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1673130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1701fc0>, '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 0x1702ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1703350>, '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': '337fe3f4b1febe37b85fccc40000019e-1480192974.141195-1379483306', '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 15:24:08 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 15:24:08 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 15:24:08 INFO - Using env: {'DISPLAY': ':0', 15:24:08 INFO - 'HOME': '/home/cltbld', 15:24:08 INFO - 'LANG': 'en_US.UTF-8', 15:24:08 INFO - 'LANGUAGE': 'en_US:en', 15:24:08 INFO - 'LOGNAME': 'cltbld', 15:24:08 INFO - 'MAIL': '/var/mail/cltbld', 15:24:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:24:08 INFO - 'MOZ_NO_REMOTE': '1', 15:24:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:24:08 INFO - 'NO_EM_RESTART': '1', 15:24:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:24:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:24:08 INFO - 'PWD': '/builds/slave/test', 15:24:08 INFO - 'SHELL': '/bin/bash', 15:24:08 INFO - 'SHLVL': '1', 15:24:08 INFO - 'TERM': 'linux', 15:24:08 INFO - 'TMOUT': '86400', 15:24:08 INFO - 'USER': 'cltbld', 15:24:08 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1480192974.141195-1379483306', 15:24:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:24:08 INFO - '_': '/tools/buildbot/bin/python'} 15:24:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:24:08 INFO - Downloading/unpacking jsonschema==2.5.1 15:24:08 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 15:24:08 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 15:24:08 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 15:24:08 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 15:24:08 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 15:24:08 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 15:24:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:24:10 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:24:10 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 15:24:10 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 15:24:10 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 15:24:10 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 15:24:10 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 15:24:10 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 15:24:11 INFO - Downloading functools32-3.2.3-2.tar.gz 15:24:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:24:11 INFO - warning: no files found matching '*.txt' 15:24:11 INFO - no previously-included directories found matching 'build' 15:24:11 INFO - no previously-included directories found matching 'dist' 15:24:11 INFO - no previously-included directories found matching '.git*' 15:24:11 INFO - Installing collected packages: jsonschema, functools32 15:24:11 INFO - Running setup.py install for functools32 15:24:11 INFO - warning: no files found matching '*.txt' 15:24:11 INFO - no previously-included directories found matching 'build' 15:24:11 INFO - no previously-included directories found matching 'dist' 15:24:11 INFO - no previously-included directories found matching '.git*' 15:24:11 INFO - Successfully installed jsonschema functools32 15:24:11 INFO - Cleaning up... 15:24:11 INFO - Return code: 0 15:24:11 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:24:11 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')]} 15:24:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:24:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:11 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')]} 15:24:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:24:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:11 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 0x7f7805825e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d7b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1673130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1701fc0>, '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 0x1702ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1703350>, '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': '337fe3f4b1febe37b85fccc40000019e-1480192974.141195-1379483306', '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 15:24:11 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 15:24:11 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 15:24:11 INFO - Using env: {'DISPLAY': ':0', 15:24:11 INFO - 'HOME': '/home/cltbld', 15:24:11 INFO - 'LANG': 'en_US.UTF-8', 15:24:11 INFO - 'LANGUAGE': 'en_US:en', 15:24:11 INFO - 'LOGNAME': 'cltbld', 15:24:11 INFO - 'MAIL': '/var/mail/cltbld', 15:24:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:24:11 INFO - 'MOZ_NO_REMOTE': '1', 15:24:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:24:11 INFO - 'NO_EM_RESTART': '1', 15:24:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:24:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:24:11 INFO - 'PWD': '/builds/slave/test', 15:24:11 INFO - 'SHELL': '/bin/bash', 15:24:11 INFO - 'SHLVL': '1', 15:24:11 INFO - 'TERM': 'linux', 15:24:11 INFO - 'TMOUT': '86400', 15:24:11 INFO - 'USER': 'cltbld', 15:24:11 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1480192974.141195-1379483306', 15:24:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:24:11 INFO - '_': '/tools/buildbot/bin/python'} 15:24:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:24:11 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:24:11 INFO - Cleaning up... 15:24:11 INFO - Return code: 0 15:24:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:24:11 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')]} 15:24:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:24:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:11 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')]} 15:24:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:24:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:11 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 0x7f7805825e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d7b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1673130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1701fc0>, '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 0x1702ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1703350>, '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': '337fe3f4b1febe37b85fccc40000019e-1480192974.141195-1379483306', '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 15:24:11 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 15:24:11 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 15:24:11 INFO - Using env: {'DISPLAY': ':0', 15:24:11 INFO - 'HOME': '/home/cltbld', 15:24:11 INFO - 'LANG': 'en_US.UTF-8', 15:24:11 INFO - 'LANGUAGE': 'en_US:en', 15:24:11 INFO - 'LOGNAME': 'cltbld', 15:24:11 INFO - 'MAIL': '/var/mail/cltbld', 15:24:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:24:11 INFO - 'MOZ_NO_REMOTE': '1', 15:24:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:24:11 INFO - 'NO_EM_RESTART': '1', 15:24:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:24:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:24:11 INFO - 'PWD': '/builds/slave/test', 15:24:11 INFO - 'SHELL': '/bin/bash', 15:24:11 INFO - 'SHLVL': '1', 15:24:11 INFO - 'TERM': 'linux', 15:24:11 INFO - 'TMOUT': '86400', 15:24:11 INFO - 'USER': 'cltbld', 15:24:11 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1480192974.141195-1379483306', 15:24:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:24:11 INFO - '_': '/tools/buildbot/bin/python'} 15:24:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:24:11 INFO - Downloading/unpacking blobuploader==1.2.4 15:24:11 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 15:24:11 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 15:24:11 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 15:24:11 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 15:24:11 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 15:24:11 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 15:24:13 INFO - Downloading blobuploader-1.2.4.tar.gz 15:24:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:24:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:24:13 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 15:24:13 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 15:24:13 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 15:24:13 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 15:24:13 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 15:24:13 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 15:24:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:24:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:24:14 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 15:24:14 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 15:24:14 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 15:24:14 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 15:24:14 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 15:24:14 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 15:24:14 INFO - Downloading docopt-0.6.1.tar.gz 15:24:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:24:14 INFO - Installing collected packages: blobuploader, requests, docopt 15:24:14 INFO - Running setup.py install for blobuploader 15:24:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:24:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:24:14 INFO - Running setup.py install for requests 15:24:14 INFO - Running setup.py install for docopt 15:24:14 INFO - Successfully installed blobuploader requests docopt 15:24:14 INFO - Cleaning up... 15:24:15 INFO - Return code: 0 15:24:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:24:15 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')]} 15:24:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:24:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:15 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')]} 15:24:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:24:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:15 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 0x7f7805825e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d7b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1673130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1701fc0>, '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 0x1702ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1703350>, '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': '337fe3f4b1febe37b85fccc40000019e-1480192974.141195-1379483306', '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 15:24:15 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 15:24:15 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 15:24:15 INFO - Using env: {'DISPLAY': ':0', 15:24:15 INFO - 'HOME': '/home/cltbld', 15:24:15 INFO - 'LANG': 'en_US.UTF-8', 15:24:15 INFO - 'LANGUAGE': 'en_US:en', 15:24:15 INFO - 'LOGNAME': 'cltbld', 15:24:15 INFO - 'MAIL': '/var/mail/cltbld', 15:24:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:24:15 INFO - 'MOZ_NO_REMOTE': '1', 15:24:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:24:15 INFO - 'NO_EM_RESTART': '1', 15:24:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:24:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:24:15 INFO - 'PWD': '/builds/slave/test', 15:24:15 INFO - 'SHELL': '/bin/bash', 15:24:15 INFO - 'SHLVL': '1', 15:24:15 INFO - 'TERM': 'linux', 15:24:15 INFO - 'TMOUT': '86400', 15:24:15 INFO - 'USER': 'cltbld', 15:24:15 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1480192974.141195-1379483306', 15:24:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:24:15 INFO - '_': '/tools/buildbot/bin/python'} 15:24:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:24:15 INFO - Running setup.py (path:/tmp/pip-uytP0b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:24:15 INFO - Running setup.py (path:/tmp/pip-EhwfrK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:24:15 INFO - Running setup.py (path:/tmp/pip-OpzROt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:24:15 INFO - Running setup.py (path:/tmp/pip-JaqK6t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:24:15 INFO - Running setup.py (path:/tmp/pip-SIPEt9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:24:15 INFO - Running setup.py (path:/tmp/pip-KW1fzl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:24:15 INFO - Running setup.py (path:/tmp/pip-xpyww1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:24:15 INFO - Running setup.py (path:/tmp/pip-5dvduc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:24:15 INFO - Running setup.py (path:/tmp/pip-MbvsHT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:24:15 INFO - Running setup.py (path:/tmp/pip-bjMdtU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:24:15 INFO - Running setup.py (path:/tmp/pip-85_EfV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:24:16 INFO - Running setup.py (path:/tmp/pip-zXgtxY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:24:16 INFO - Running setup.py (path:/tmp/pip-LcCFbr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:24:16 INFO - Running setup.py (path:/tmp/pip-GsY0pa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:24:16 INFO - Running setup.py (path:/tmp/pip-L6igvm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:24:16 INFO - Running setup.py (path:/tmp/pip-Q8uBM5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:24:16 INFO - Running setup.py (path:/tmp/pip-c43zNQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:24:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:24:16 INFO - Running setup.py install for manifestparser 15:24:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:24:16 INFO - Running setup.py install for mozcrash 15:24:16 INFO - Running setup.py install for mozdebug 15:24:16 INFO - Running setup.py install for mozdevice 15:24:16 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:24:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:24:16 INFO - Running setup.py install for mozfile 15:24:17 INFO - Running setup.py install for mozhttpd 15:24:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:24:17 INFO - Running setup.py install for mozinfo 15:24:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:24:17 INFO - Running setup.py install for mozInstall 15:24:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:24:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:24:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:24:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:24:17 INFO - Running setup.py install for mozleak 15:24:17 INFO - Running setup.py install for mozlog 15:24:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:24:17 INFO - Running setup.py install for moznetwork 15:24:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:24:17 INFO - Running setup.py install for mozprocess 15:24:17 INFO - Running setup.py install for mozprofile 15:24:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:24:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:24:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:24:17 INFO - Running setup.py install for mozrunner 15:24:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:24:17 INFO - Running setup.py install for mozscreenshot 15:24:18 INFO - Running setup.py install for moztest 15:24:18 INFO - Running setup.py install for mozversion 15:24:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:24:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:24:18 INFO - Cleaning up... 15:24:18 INFO - Return code: 0 15:24:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:24: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')]} 15:24:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:24:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24: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')]} 15:24:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:24:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:18 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 0x7f7805825e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d7b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1673130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1701fc0>, '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 0x1702ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1703350>, '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': '337fe3f4b1febe37b85fccc40000019e-1480192974.141195-1379483306', '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 15:24:18 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 15:24:18 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 15:24:18 INFO - Using env: {'DISPLAY': ':0', 15:24:18 INFO - 'HOME': '/home/cltbld', 15:24:18 INFO - 'LANG': 'en_US.UTF-8', 15:24:18 INFO - 'LANGUAGE': 'en_US:en', 15:24:18 INFO - 'LOGNAME': 'cltbld', 15:24:18 INFO - 'MAIL': '/var/mail/cltbld', 15:24:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:24:18 INFO - 'MOZ_NO_REMOTE': '1', 15:24:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:24:18 INFO - 'NO_EM_RESTART': '1', 15:24:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:24:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:24:18 INFO - 'PWD': '/builds/slave/test', 15:24:18 INFO - 'SHELL': '/bin/bash', 15:24:18 INFO - 'SHLVL': '1', 15:24:18 INFO - 'TERM': 'linux', 15:24:18 INFO - 'TMOUT': '86400', 15:24:18 INFO - 'USER': 'cltbld', 15:24:18 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1480192974.141195-1379483306', 15:24:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:24:18 INFO - '_': '/tools/buildbot/bin/python'} 15:24:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:24:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:24:18 INFO - Running setup.py (path:/tmp/pip-p9WvWQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:24:18 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)) 15:24:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:24:18 INFO - Running setup.py (path:/tmp/pip-G8m8ZB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:24:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:24:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:24:18 INFO - Running setup.py (path:/tmp/pip-fEhScQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:24:18 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)) 15:24:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:24:18 INFO - Running setup.py (path:/tmp/pip-9RnlXi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:24:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 15:24:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:24:18 INFO - Running setup.py (path:/tmp/pip-uLasUM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:24:18 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)) 15:24:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:24:18 INFO - Running setup.py (path:/tmp/pip-ztmUgu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:24:18 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)) 15:24:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:24:18 INFO - Running setup.py (path:/tmp/pip-HK04tQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:24:19 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)) 15:24:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:24:19 INFO - Running setup.py (path:/tmp/pip-khwCA2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:24:19 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)) 15:24:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:24:19 INFO - Running setup.py (path:/tmp/pip-RtvK_7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:24:19 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)) 15:24:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:24:19 INFO - Running setup.py (path:/tmp/pip-wFsCE1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:24:19 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)) 15:24:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:24:19 INFO - Running setup.py (path:/tmp/pip-UQrQH4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:24:19 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)) 15:24:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:24:19 INFO - Running setup.py (path:/tmp/pip-bO56Sp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:24:19 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)) 15:24:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:24:19 INFO - Running setup.py (path:/tmp/pip-bD7EnJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:24:19 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)) 15:24:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:24:19 INFO - Running setup.py (path:/tmp/pip-kMLfiR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:24:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:24:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:24:19 INFO - Running setup.py (path:/tmp/pip-3nt9Dc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:24:19 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)) 15:24:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:24:19 INFO - Running setup.py (path:/tmp/pip-BtIi6R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:24:19 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)) 15:24:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:24:19 INFO - Running setup.py (path:/tmp/pip-oULlJH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:24:19 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)) 15:24:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:24:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:24:19 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)) 15:24:19 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:24:19 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:24:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:24: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 15:24: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 15:24: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 15:24: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 15:24: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 15:24: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 15:24:21 INFO - Downloading blessings-1.6.tar.gz 15:24:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:24:21 INFO - Installing collected packages: blessings 15:24:21 INFO - Running setup.py install for blessings 15:24:21 INFO - Successfully installed blessings 15:24:21 INFO - Cleaning up... 15:24:21 INFO - Return code: 0 15:24:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:24:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:24:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:24:22 INFO - Reading from file tmpfile_stdout 15:24:22 INFO - Current package versions: 15:24:22 INFO - argparse == 1.2.1 15:24:22 INFO - blessings == 1.6 15:24:22 INFO - blobuploader == 1.2.4 15:24:22 INFO - docopt == 0.6.1 15:24:22 INFO - functools32 == 3.2.3-2 15:24:22 INFO - jsonschema == 2.5.1 15:24:22 INFO - manifestparser == 1.1 15:24:22 INFO - mozInstall == 1.12 15:24:22 INFO - mozcrash == 1.0 15:24:22 INFO - mozdebug == 0.1 15:24:22 INFO - mozdevice == 0.49 15:24:22 INFO - mozfile == 1.2 15:24:22 INFO - mozhttpd == 0.7 15:24:22 INFO - mozinfo == 0.9 15:24:22 INFO - mozleak == 0.1 15:24:22 INFO - mozlog == 3.4 15:24:22 INFO - moznetwork == 0.27 15:24:22 INFO - mozprocess == 0.23 15:24:22 INFO - mozprofile == 0.28 15:24:22 INFO - mozrunner == 6.13 15:24:22 INFO - mozscreenshot == 0.1 15:24:22 INFO - mozsystemmonitor == 0.3 15:24:22 INFO - moztest == 0.7 15:24:22 INFO - mozversion == 1.4 15:24:22 INFO - psutil == 3.1.1 15:24:22 INFO - requests == 1.2.3 15:24:22 INFO - wsgiref == 0.1.2 15:24:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:24:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:24:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:24:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:24:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:24:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:22 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 0x7f7805825e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d7b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1673130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1701fc0>, '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 0x1702ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1703350>, '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': '337fe3f4b1febe37b85fccc40000019e-1480192974.141195-1379483306', '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 15:24:22 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 15:24:22 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 15:24:22 INFO - Using env: {'DISPLAY': ':0', 15:24:22 INFO - 'HOME': '/home/cltbld', 15:24:22 INFO - 'LANG': 'en_US.UTF-8', 15:24:22 INFO - 'LANGUAGE': 'en_US:en', 15:24:22 INFO - 'LOGNAME': 'cltbld', 15:24:22 INFO - 'MAIL': '/var/mail/cltbld', 15:24:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:24:22 INFO - 'MOZ_NO_REMOTE': '1', 15:24:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:24:22 INFO - 'NO_EM_RESTART': '1', 15:24:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:24:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:24:22 INFO - 'PWD': '/builds/slave/test', 15:24:22 INFO - 'SHELL': '/bin/bash', 15:24:22 INFO - 'SHLVL': '1', 15:24:22 INFO - 'TERM': 'linux', 15:24:22 INFO - 'TMOUT': '86400', 15:24:22 INFO - 'USER': 'cltbld', 15:24:22 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1480192974.141195-1379483306', 15:24:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:24:22 INFO - '_': '/tools/buildbot/bin/python'} 15:24:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:24:22 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)) 15:24:22 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)) 15:24:22 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)) 15:24:22 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)) 15:24:22 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)) 15:24:22 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)) 15:24:22 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)) 15:24:22 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)) 15:24:22 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)) 15:24:22 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)) 15:24:22 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)) 15:24:22 INFO - Cleaning up... 15:24:22 INFO - Return code: 0 15:24:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:24:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:24:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:24:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:24:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:24:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7805825e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d7b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1673130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1701fc0>, '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 0x1702ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1703350>, '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': '337fe3f4b1febe37b85fccc40000019e-1480192974.141195-1379483306', '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 15:24:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:24:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:24:22 INFO - Using env: {'DISPLAY': ':0', 15:24:22 INFO - 'HOME': '/home/cltbld', 15:24:22 INFO - 'LANG': 'en_US.UTF-8', 15:24:22 INFO - 'LANGUAGE': 'en_US:en', 15:24:22 INFO - 'LOGNAME': 'cltbld', 15:24:22 INFO - 'MAIL': '/var/mail/cltbld', 15:24:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:24:22 INFO - 'MOZ_NO_REMOTE': '1', 15:24:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:24:22 INFO - 'NO_EM_RESTART': '1', 15:24:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:24:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:24:22 INFO - 'PWD': '/builds/slave/test', 15:24:22 INFO - 'SHELL': '/bin/bash', 15:24:22 INFO - 'SHLVL': '1', 15:24:22 INFO - 'TERM': 'linux', 15:24:22 INFO - 'TMOUT': '86400', 15:24:22 INFO - 'USER': 'cltbld', 15:24:22 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1480192974.141195-1379483306', 15:24:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:24:22 INFO - '_': '/tools/buildbot/bin/python'} 15:24:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:24:22 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:24:22 INFO - Cleaning up... 15:24:22 INFO - Return code: 0 15:24:22 INFO - Running post-action listener: _resource_record_post_action 15:24:22 INFO - Running post-action listener: _start_resource_monitoring 15:24:22 INFO - Starting resource monitoring. 15:24:22 INFO - [mozharness: 2016-11-26 23:24:22.689600Z] Finished create-virtualenv step (success) 15:24:22 INFO - [mozharness: 2016-11-26 23:24:22.690066Z] Running install step. 15:24:22 INFO - Running pre-action listener: _resource_record_pre_action 15:24:22 INFO - Running main action method: install 15:24:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:24:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:24:22 INFO - Reading from file tmpfile_stdout 15:24:22 INFO - Detecting whether we're running mozinstall >=1.0... 15:24:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:24:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:24:22 INFO - Reading from file tmpfile_stdout 15:24:22 INFO - Output received: 15:24:22 INFO - Usage: mozinstall [options] installer 15:24:22 INFO - Options: 15:24:22 INFO - -h, --help show this help message and exit 15:24:22 INFO - -d DEST, --destination=DEST 15:24:22 INFO - Directory to install application into. [default: 15:24:22 INFO - "/builds/slave/test"] 15:24:22 INFO - --app=APP Application being installed. [default: firefox] 15:24:22 INFO - mkdir: /builds/slave/test/build/application 15:24:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:24:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 15:24:39 INFO - Reading from file tmpfile_stdout 15:24:39 INFO - Output received: 15:24:39 INFO - /builds/slave/test/build/application/firefox/firefox 15:24:39 INFO - Running post-action listener: _resource_record_post_action 15:24:39 INFO - [mozharness: 2016-11-26 23:24:39.952073Z] Finished install step (success) 15:24:39 INFO - [mozharness: 2016-11-26 23:24:39.952342Z] Running run-tests step. 15:24:39 INFO - Running pre-action listener: _resource_record_pre_action 15:24:39 INFO - Running main action method: run_tests 15:24:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:24:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:24:39 INFO - Python 2.7.3 15:24:39 INFO - Return code: 0 15:24:39 INFO - grabbing minidump binary from tooltool 15:24:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:24:39 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 0x1701fc0>, '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 0x1702ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1703350>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:24:39 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 15:24:39 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 15:24:39 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 15:24:40 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:24:40 INFO - Return code: 0 15:24:40 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:24:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:24:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:24:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:24:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:24:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480192204/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 15:24:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480192204/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-060 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 15:24:40 INFO - Using env: {'DISPLAY': ':0', 15:24:40 INFO - 'HOME': '/home/cltbld', 15:24:40 INFO - 'LANG': 'en_US.UTF-8', 15:24:40 INFO - 'LANGUAGE': 'en_US:en', 15:24:40 INFO - 'LOGNAME': 'cltbld', 15:24:40 INFO - 'MAIL': '/var/mail/cltbld', 15:24:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:24:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:24:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:24:40 INFO - 'MOZ_NO_REMOTE': '1', 15:24:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:24:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:24:40 INFO - 'NO_EM_RESTART': '1', 15:24:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:24:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:24:40 INFO - 'PWD': '/builds/slave/test', 15:24:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:24:40 INFO - 'SHELL': '/bin/bash', 15:24:40 INFO - 'SHLVL': '1', 15:24:40 INFO - 'TERM': 'linux', 15:24:40 INFO - 'TMOUT': '86400', 15:24:40 INFO - 'USER': 'cltbld', 15:24:40 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1480192974.141195-1379483306', 15:24:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:24:40 INFO - '_': '/tools/buildbot/bin/python'} 15:24:40 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480192204/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 15:24:40 INFO - mozversion application_buildid: 20161126123004 15:24:40 INFO - mozversion application_changeset: 873a10f77413394e7e4c2374ffb966e96b533ca6 15:24:40 INFO - mozversion application_display_name: Nightly 15:24:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:24:40 INFO - mozversion application_name: Firefox 15:24:40 INFO - mozversion application_remotingname: firefox 15:24:40 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 15:24:40 INFO - mozversion application_vendor: Mozilla 15:24:40 INFO - mozversion application_version: 53.0a1 15:24:40 INFO - mozversion platform_buildid: 20161126123004 15:24:40 INFO - mozversion platform_changeset: 873a10f77413394e7e4c2374ffb966e96b533ca6 15:24:40 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 15:24:40 INFO - mozversion platform_version: 53.0a1 15:24:40 INFO - using testdate: 1480202680 15:24:40 INFO - actual date: 1480202680 15:24:40 INFO - starting webserver on 'localhost:39392' 15:24:40 INFO - SUITE-START | Running 2 tests 15:24:40 INFO - TEST-START | dromaeo_css 15:24:40 INFO - operating with platform_type : linux_ 15:24:40 INFO - Initialising browser for dromaeo_css test... 15:24:40 INFO - TEST-INFO | started process 12509 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWLyI3_/profile http://localhost:39392/getInfo.html) 15:24:44 INFO - PROCESS | 12509 | __metrics Screen width/height:1600/1200 15:24:44 INFO - PROCESS | 12509 | colorDepth:24 15:24:44 INFO - PROCESS | 12509 | Browser inner width/height: 1024/697 15:24:44 INFO - PROCESS | 12509 | __metrics 15:24:44 INFO - PROCESS | 12509 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:24:44 INFO - PROCESS | 12509 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:24:45 INFO - PROCESS | 12509 | console.error: PushService: 15:24:45 INFO - PROCESS | 12509 | stateChangeProcessEnqueue: Error transitioning state 15:24:45 INFO - PROCESS | 12509 | UnknownError 15:24:46 INFO - TEST-INFO | 12509: exit 0 15:24:46 INFO - Browser initialized. 15:24:46 INFO - Running cycle 1/1 for dromaeo_css test... 15:24:46 INFO - TEST-INFO | started process 12594 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWLyI3_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:24:58 INFO - PROCESS | 12594 | RSS: Main: 173760512 15:24:58 INFO - PROCESS | 12594 | 15:25:50 INFO - PROCESS | 12594 | 1480202750004 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] 15:28:00 INFO - PROCESS | 12594 | Cycle 1(1): loaded http://localhost:39392/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39392/tests/dromaeo/cssquery-ext.html) 15:28:02 INFO - PROCESS | 12594 | RSS: Main: 286511104 15:28:02 INFO - PROCESS | 12594 | 15:31:04 INFO - PROCESS | 12594 | Cycle 1(1): loaded http://localhost:39392/tests/dromaeo/cssquery-ext.html (next: http://localhost:39392/tests/dromaeo/cssquery-jquery.html) 15:31:05 INFO - PROCESS | 12594 | RSS: Main: 279433216 15:31:05 INFO - PROCESS | 12594 | 15:34:07 INFO - PROCESS | 12594 | Cycle 1(1): loaded http://localhost:39392/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39392/tests/dromaeo/cssquery-mootools.html) 15:34:08 INFO - PROCESS | 12594 | RSS: Main: 222277632 15:34:08 INFO - PROCESS | 12594 | 15:37:10 INFO - PROCESS | 12594 | Cycle 1(1): loaded http://localhost:39392/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39392/tests/dromaeo/cssquery-prototype.html) 15:37:10 INFO - PROCESS | 12594 | RSS: Main: 240930816 15:37:10 INFO - PROCESS | 12594 | 15:40:13 INFO - PROCESS | 12594 | Cycle 1(1): loaded http://localhost:39392/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39392/tests/dromaeo/cssquery-yui.html) 15:40:14 INFO - PROCESS | 12594 | RSS: Main: 227110912 15:40:14 INFO - PROCESS | 12594 | 15:43:17 INFO - PROCESS | 12594 | Cycle 1(1): loaded http://localhost:39392/tests/dromaeo/cssquery-yui.html (next: http://localhost:39392/tests/dromaeo/cssquery-dojo.html) 15:43:17 INFO - PROCESS | 12594 | RSS: Main: 309137408 15:43:17 INFO - PROCESS | 12594 | 15:43:17 INFO - PROCESS | 12594 | __start_tp_report 15:43:17 INFO - PROCESS | 12594 | _x_x_mozilla_page_load 15:43:17 INFO - PROCESS | 12594 | _x_x_mozilla_page_load_details 15:43:17 INFO - PROCESS | 12594 | |i|pagename|runs| 15:43:17 INFO - PROCESS | 12594 | |0;dojo.html;3085.9537106943394;3099.194209505528;3126.5310203469476;3128.4681604127295;3132.6867313268676;5303.602229832759;5357.544608708255;5358.946410535894;5459.12653975364;5469.07025805613;5353.143497040474;5401.378841433237;5426.593005524582;5437.075697131488;5459.426760190182;4778.116048531016;4788.664793464459;4816.868036011534;4861.173600487908;4871.7076975381415;4885.804567817283;4925;4932.506749325074;4971;4981.5516603505675;4811.350467686852;4918.729469879156;4924.679895806797;4953.108440480712;5022.82420115296;4830.468648448667;4835.178019736653;4888.560029597354;4889.853304400874;4896.853094407174;4856.902861942776;4860.513948605111;4862.100511405401;4869.318295438641;4916.729579873106;5289.550388217006;5342.065138600729;5348.117560602496;5361.785528578852;5372.0330340538685;5563.193336966157;5570.136628822539;5573.6098473106895;5668.546516278688;5709.77160913563;5769.59612827098;5848.912266315966;5871.3541510433815;5876.706164691748;5884.558658100659;5424.1321388577635;5425.430329815392;5428.348598168205;5431.918521222185;5451.863703407446;5857;5919.289685237799;5928;5933.970330148321;5934.7922822701;5565.220869078333;5586.469285417878;5589.804356847572;5614.887702245932;5633.492985631231;5760.049591817387;5762.337331206881;5762.625429347079;5765.509931655773;5819.447152520504;5733;5733.598648094593;5734.799282025109;5736.913946290809;5739.971300143473;5654.434556544395;5691.743871525791;5693.743781529841;5738.426157384228;5767.019606666793;4428.335749637516;4450.888727781767;4455.5989960903025;4464.709793863389;4464.888377790517;3961.029547760759;3967.4643923070016;3997.6801855851463;4005.178938317696;4018.1561872006623;5511.173324001352;5518.586106042063;5524.889502209933;5525.723713814293;5527.806526771544;5694.914576281359;5704.401037891044;5768.682722450306;5813.302403711582;5818.330891947396;5404.78380864761;5418.295621569171;5443.101888188484;5504.394516603251;5548.639338443069;5020.071286811952;5022.522860328263;5033.370828646419;5037.093323201859;5074.974625126924;5849.444302791228;5933.465988061095;5990.430909063632;6006.519478441714;6009.128676341993;5694.003549378759;5707.1153971134545;5715.514181294637;5716;5818.418158184148;5935.9703201485445;5973.193618861398;5974.761009559569;5981.431763982415;5985.760569577343;5646.604737668324;5647.971760141173;5650.180723795109;5652;5662.348829884451;5690.743916523849;5697.914531281951;5701.8859622806485;5708.400617935223;5743.684097374685;5599.216109744721;5600.103983362643;5604.019296622993;5609.635373700697;5642;5574.721263936868;5585.5531557476115;5622.184783206494;5625.296837895263;5636.098224284259;5490.835274941758;5497.147942068986;5514.944850551604;5524.889502209853;5581.134924086773;5674.829755107354;5675.148727690879;5682.147677848356;5705.030144875464;5719.971400143139;5359.598030147677;5454.318210223722;5482.17767334903;5494.450554944474;5497.175423686479 15:43:17 INFO - PROCESS | 12594 | |1;ext.html;533.6184627990986;555.2892297858742;574.6063946196856;578.2425023219581;579.9333076696179;29349.11952641419;37002.444963325535;37767.43348849763;37768.81115594422;41038.58961410385;39880;40113.59886401135;40215.97300337458;40292.19415611686;40320.59679403205;8039.35685145187;8185.877211841827;8198.836023279531;8206.425550211488;8225.794355141139;7738.110117336522;7948.523088614673;9785.217182625373;10057.094861462467;10058.647947321846;10189.898101019005;10238.385696858213;10244.590216391372;10258.07677309042;10258.179345652366;10167.440790756506;10221.488925553693;10232.488375581192;10233.89766102337;10236.33463824849;10004.099631033241;10031.849522257173;10046.899531004743;10055.486128467883;10061.295709300352;26716.19851404461;26764.598531021857;26794.196174114808;26994.865025674942;27004.729952700418;3213.8714451421915;3240.643529211785;3257.657945915692;3286.5398844161837;3527.5943266524423;29071.273218169503;29366.412671746446;29630.40739185226;29710.70289297101;31081.067567972997;3979.303621866191;4017.4375587417494;4047.089404883907;4127.814248358831;4145.274576949022;340801;343842;344327;344439.2778036119;346316;53868.461315387125;53958.730206348715;54345.72827135918;55047;55090.449095508535;59334;59553.40446595565;59659.701701492086;59868.401315987154;60263;13686.384112714952;13738.931305343409;13743.931280343535;13745.587632371045;13759.312034398241;9785.315027947976;10380.532876020598;10393.58425662965;10404.635837745642;10508.579656813794;15924.92037539805;17240.65518689644;17472.078071412136;17601.383951561635;18083.18625661822;6548.869022619521;6776;6826.385625293748;6869.278725733826;6989.091418115612;845.1759534453859;939.3424602778083;995.9950200248952;1008.2992320337441;1028.5680014393972;29685.703142968727;30619.234519136753;30666.54000189999;30778.846105769775;30977.14137151778;1012.9848052279222;1060.6923992042375;1068.529846867376;1086.413336798136;1121.876593574706;14804.629884252765;15220.847791521943;15292.847071529142;15552.611184720472;15730.29213685364;487345;488479.57602119754;492640;494359;494809;51834;52819.47180528146;52865.47134528682;52937.47062529402;53001.46998530043;1113.9498722557505;1120.910327173824;1166.445938179375;1192.576635294458;1208.081857788105;24975.625365619166;27221.455570888866;27268.454630906876;27861.44277114487;27940.441191175654;39204.2159156821;39436.21127577375;39468.40797387984;39599;39822.004449888984;373683;373812;374690;375657;376896;38832.6116738829;38879.80560097181;39153;39470;39739.40390894197;40579.391309129795;41179.38230926479;41372;41929.580704192565;43559;36661.81669091638;36866.44700329444;37092.81453592715;37156.44265335968;37177.62822371742;36134.638653613125;36232.456513151796;36653;36827.26345473022;37070.8146459266;37040.81479592585;38256.426153607164;38305;39127.80436097915;39797.60202397939;31549.36901261916;33873.32253354968;34433.82783086068;34927.476087858195;34933.47599785955;27177.1846844595;32047.519287211177;32165.517517236793;32262.35475290528;34230.31539369249 15:43:17 INFO - PROCESS | 12594 | |2;jquery.html;365.3897990356105;377.42631200575124;390.1903550133472;393.4098851722416;415.4495293735801;13951.744717861062;15356;17588.208530616106;18700.958587807236;19106.140223689934;15277.618059548517;15278.38886444541;15325.310361033753;15403.152826594533;15413.460528881491;5390.8921821563445;5641.407652196522;5663.915041274384;5664.688442135681;5668.376478587352;5377.838664840042;5535.059039963196;5539.612227144102;5542.140968149923;5583.106702927533;5542.889142217154;5554.527865131468;5562.443755624446;5562.554995600342;5563.582731295169;5400.83797486076;5542.944570554283;5552.500274975251;5662.546996240291;5701.059325211335;5578.972105139489;5579.163125531162;5585.273914391144;5589.692566908819;5593.52455041322;13202.471901123943;13299.734005319937;13362.665933351647;13394.06241563091;15910.20448977558;2127.7659457459667;2146.0771868096713;2185.3771675072685;2504.173622704503;2520.218732193026;9004.8649270261;9420.62317507299;9818.116369526706;9926.305158638897;9990.600375984952;1837.349546599123;1844.2530775036132;1850.6576283387617;1881.7741870975572;1893.8863668179954;77199.6140019302;79378;79508;81454.59272703598;85871.57064214638;10500.31747936397;10815.783684326427;10952.945235273774;11071.391073490875;11080.61217857371;15179.544613661608;15198.772018419733;15223.695526089416;15233.23833808305;15235.085894846123;7110.964445177741;7322.780316590511;7460.738874139379;7537.886931696029;7563.773086807405;6704.161979752531;6728.798136055926;6736.494762892803;6932.202796678446;7009.61447120403;4618.861434156981;4661.137689527448;4679.181143299909;4690.202665546865;4780.832670856504;1874.5969616532238;1894.4790182699592;1922.8465316880327;1941.5825597496605;1975.1605567633699;770.5261264322402;876.750126214026;881.6693739847557;913.980911283927;951.7620594851287;17676.409123178717;17991.190396432194;18305;18450.630987380446;19049;872.0581771686564;875.2385424680441;881.8633111867671;883.5096521430668;922.2622199744152;9791.167750741124;10247.436390998566;10282.07461328484;10287.897121028695;10392.376457412429;348547;351592.0509936258;352162;462149;472143;68917.65541172262;71589;90698;93482;100699;904.2359206470522;952.6094301336419;955.302629080775;1010.6563768318807;1056.392574269798;16226.513204603882;16470.176491175633;17389.47831565055;17394.30422783125;17548.2103305349;42232.36651450169;42507.57492425036;42560;43032.35451468293;43093.569064308955;57682;58321.4167858316;58498.4150158493;58745.412545873995;59396.406035939086;7833.647485863035;7877.84244315099;7999.200079991954;8191.385646076449;8236.464629799044;9876.40741555509;11632.651020469399;11692.532298707956;11773.234739741889;11908.583199587973;10314.535845887103;10645.733856653645;10654.147668186371;10812.243142980231;10847.403392813156;10712.14302855754;10856.728581785519;10914.29057111317;10925.890741092806;10983.340999540053;10899.346039237671;11172.156594162198;11212.887871121184;11387.089032877184;11725.237859539102;6986.895196571953;7374.520656157332;7459.328660420588;7633.923660763321;8467.068622451648;10389.53247103867;11467.885321146681;11492.94253528727;11607.76784464289;11785.705357366134 15:43:17 INFO - PROCESS | 12594 | |3;mootools.html;1138.1179585820994;1263.6082814327558;1264.31095053196;1293.547258459539;1307.8888294494973;7140.107486564179;7956.08505021922;8189.8771518427275;8207.425480216387;8448.873266900986;8242.093369729326;8249.46378485398;8304.33565314775;8319.75040748777;8320.91679083209;1974.5754662747506;2217.81148602369;2247.4156719252946;2256.1088370093803;2257.7403598586206;2039.836813054952;2195.5938151442033;2251.0995601759346;2256.7856053674873;2260.5026894083358;2209.491816882118;2218.134927378324;2220.1119552179175;2227.2538699535676;2235.619944609412;2208.6134926387817;2226.76618955009;2229.375774783063;2241.775822417745;2242.876641784709;2130.2970019893396;2130.754963179223;2166.9133234670594;2167.306461932182;2168.7722789107233;8182.795430114235;8191.058028326759;8196.098429172785;8232.753017409488;8243.587820609006;4771;4903.436104847952;4906.092372911023;4907.1657818171;4909.828156014522;3173.3018735878068;3258.2994656148803;3283.688049635281;3333.033420308108;3341.298327351259;1062.54310646422;1136.125183608625;1142.7657330247362;1165.9766804663943;1168.5501082083374;11583.652490425216;11636.825447618208;11649.825252621218;11651.533938642444;11653.359065251409;4297.312430011183;4505.301678239878;4545.704529205591;4555.863324100283;4564.817407303671;9952.601895924226;9958.800823983625;9968.451735154491;9973.601055957826;9973.700788976343;4912.656114072052;4915.090708218991;4924.630652701062;4924.827631032968;4926.236433352836;3992.5208974922616;4144.8756537303925;4266.87199384019;4312.266914624522;4507.414036175276;3493.1965647900615;3609.3864043112208;3612.710983121344;3704.6107709608896;3818.205443441578;1283.5700040486354;1292.8319318488536;1293.624848793858;1303.7262174943178;1326.6285440076795;845.5983407881207;847.4999750147442;866.8786369908217;888.036480418753;888.2361169394316;5375.139977603643;5454.8909021819345;5540.584456165723;5618.4662457066515;5800.738966746507;827.437342607033;833.125218520551;850.8723691446332;858.4076986879033;866.9653213871501;3581.6239294874185;3608.0979755061235;3635.690966267897;3657.1040095176318;3755.661990420875;9775.951120244354;10249.590016399261;10253.84619230712;10293.330933489298;10310.587576497006;10040.146587539995;10159.542820573091;10284.434356110485;10284.588616455258;10302.896971030345;7439.293267139613;7589.392848572101;7590.620468976639;7593.126790419173;7609.619519024027;5314.415414304346;5371.623986321077;5424.783008679767;5431.456854314537;5466.535344495763;9025.458472491671;9054.954725226331;9129.224015958718;9280.071992800937;9494.667686630935;9254.444733315753;9308.348415610842;9558.665446709332;9584.808303834025;9694.660686875926;7346.191918889025;7367.1527774304495;7484.812879678052;7485.47601667878;7488.026556547614;6783.152105986752;6933.237343892269;7559.84544404842;7876.684932602631;7895.171007044178;6987.336203060701;7153.177384600629;7169.139703235645;7218.602976836114;7266.527675701062;6954.965225173842;6998.090248267693;7072.469564782559;7092.25531319204;7108.609026503592;6297.937020629918;6378.872422551616;6455.064015717789;6515.771947981798;6518.902216466662;4585.862424127282;4757.09615173116;4799.448063472606;4836.105320515716;4997.0505603935135;4892.706437613754;4927.457979622167;5119.513646203604;5122.743862806919;5174.767135478837 15:43:17 INFO - PROCESS | 12594 | |4;prototype.html;325.3915178615987;334.83258370814593;336.08081896014403;337.76356550414687;340.4501729706524;5163.302954101196;5226.634135610509;5307.628466007376;5321.733913304334;5322;5071.011152825201;5179.4561571035065;5210.7655155518;5213;5245.505031066147;4130.78141948126;4133.214689209056;4136.31750761124;4151.916961660765;4162.480694546492;3866.1107945172485;3886.300465916134;4145.129522800215;4166.999920019189;4170.475034587476;4087.9591204088024;4102.261592913274;4104.486939132608;4108.383742438643;4127.690423218271;4088.938665919984;4105.815238314283;4113.197926404352;4116.135611521584;4134.50385953686;3661.743677942545;3665.9450108248398;3666.3400587894166;3666.6883314918264;3681.318955993123;5013.448520662724;5068.921742085764;5079.466656001141;5092.26162206478;5099.4390617032095;4615.46922103959;4658.34783130362;4677.695949763254;4689.241534424591;4703.15343238217;5421.620486565942;5462.235287059815;5463.344398672145;5492.670439773587;5533.9839787315605;3837.6737977271964;3962.4546426893535;3978.622030907059;3978.6817054635558;3996.4205190247544;5615.298087739033;5616.971915140398;5629.425314925011;5636.774529018834;5671.461211184889;4075.9388609170887;4087.91824163521;4088.3049881520215;4093.8362465501045;4113.930378101655;4061.7969101545395;4120.855770048094;4123.793810309473;4127.855525056609;4145.253854306194;4658.836940707059;4670.486246512949;4687.882802929886;4711.764411779397;4717.575418212377;5465.316835395575;5507.815819598725;5533.1976863354585;5544.805931792368;5556.638623537178;1344.475654494748;1351.2838195756265;1358.843732970721;1369.452219112363;1373.3339330424735;970.5147426286857;972.0571046085286;983.8081574093127;985.2561316206362;986.4229425785852;5156.690598564098;5158.277841102249;5185.351831021122;5196.402413722395;5208.9739551302;5367.865803354869;5397.865053373618;5404.405515393303;5415.945840541544;5445.1832225166545;4979.875503112451;5188;5198.506141916512;5228.712420816815;5240.371155461369;2888.6678032026584;2889.6965818589165;2890.017394086021;2893.7974341796294;2896.724811142938;5636.478150899235;5670.914936275959;5673.234113394721;5693.373728889819;5726.4273572642405;5251.973740131351;5498.697571633518;5504.4770746778995;5522.502974732293;5594.1608758686525;5583.533173461215;5600.411956744565;5605.635633683797;5626.1842032905815;5645.350784659735;5151.25306830515;5395.487428694268;5424.403315635198;5464.398916119303;5467.305135408036;5361.410244872983;5418.729063546728;5423.891522169455;5424.457554244544;5440.238366628754;5613.382527921844;5644.294463192101;5647;5648.350439699487;5690.601657883908;3873.806309684561;3999.140184860269;4020.8592699255387;4024.8390064397095;4048.190361927685;5343.866403339947;5407.486288802557;5430.511253987002;5433.239346491573;5439;5254.422013578427;5285.814996475105;5303.284056652303;5319.6808191508635;5331.653442526223;5041.448484034768;5252.002119597264;5265.657732247391;5290;5293.564960118389;5192.922106168486;5196.558292545176;5222.817201397933;5226.850092979538;5244.396894357045;5235.790568377222;5332.360116786011;5359.571234301325;5368;5384.434634363335;4934.481879402611;5124.308218390619;5126.846194614168;5147.6654017488745;5168.431472537943 15:43:17 INFO - PROCESS | 12594 | |5;yui.html;645.90311453282;658.7727234104234;679.1137565477051;697.288157573158;699.4124935054554;11352.318860868354;12113.878861211397;12308.446119924602;12335.568255111073;12359.134860559741;11453.37006464644;11520.71198220045;11528.596499122532;11538.192326537124;12181.086418518602;633.616661919539;642.3383914568002;643.8583511627435;644.2655372874926;644.6841047886526;552.3206456059049;562.1371195215345;622.8287221014212;635.793367155674;637.8022812928007;669.2370697404962;669.6718607882127;674.8953912143601;689.5586824432368;711.3882061427169;665.4942243894626;665.7436886798569;665.9067730517731;672.4721093941257;679.9320067993161;427.2224551316605;449.63130233208784;486.4187296181065;489.82121525642884;511.4195388234344;11298.774024519545;11300.660980170607;11309.547618095266;11359.829602555885;11484.196106272564;12220.20568663043;12386.32784574089;12575.685607859785;12602.873971260262;12747.04397170216;12416.503339866395;12425.192362496498;12438.875611243953;12813.97488200951;13228.27244501552;4089.427480152781;4101.958980410217;4143.109231515239;4159.396887451303;4314.71954322968;80711;81291.9999999994;81662.59168704179;81968.18031819665;83824;9482.146606805421;9716.31985761004;9726.562304696306;9795.902040979641;9953.900460995297;16291.83708162927;16326.918365408097;16638.3344666212;16750.4137355192;16800.07599582035;7160.606166660884;7189.7483588074165;7252.782416527512;7381.11426628808;7385.963070184722;4042.939355909664;4127.669786417079;4167.708260421802;4177.770222637784;4191.832326706897;2837.716228377146;2918.620579324717;2922.1087568291873;2937.7796665250194;2966.391889662614;480.2771828398238;490.3625287126721;506.3923292049555;521.3561251853957;531.8537402214345;568.4542838874644;588.6056342250703;595.3867516458055;596.1296507099596;609.1289456077851;8861.955690221508;9259.907400926038;9271.397359171633;9311.860322095039;9515.762105947406;588.9676067816225;591.2934043817596;604.6251324179037;625.1778910732372;634.6255709131542;4585.518520555361;4601.4248218972625;4604.1712491751805;4680.3915490985955;4699.694519856198;82291.58854205691;84436.57781711176;84444.57777711072;88109.55945220361;88215.55892220497;73847.63076184691;75328.24671753212;77144.22855771483;80699;80731;70823;71841;73382.63308683422;74826;75867.62066189633;8676.175763302475;8913.598888049924;8935.106489351012;9107.726768196964;9271.162705540564;44227;46218;47784;47833.28250076321;50350.2447463281;52761.47238527566;53082.2037669443;54888;59864;60366.39633603608;11760.785776451572;11767.705807354885;11953.820692689791;11956.30585898709;12648.873511265137;14321.856781432052;14589.394044699318;14632.43157602919;15164.848351516344;15579.376824927329;13231.338433078115;13636.590902272948;13681.521146759816;13768.518101866386;14321.28393580296;13812.792808108088;13981.44074237019;14436.494722685076;14598;14914.925425372803;12815.679608009874;12822.935885320887;12999.740005200032;13498.122622029538;13606.727865442437;10085.546150423103;10521.105706015074;10578.41818699948;10613.681589552325;11174.888251117385;9145.954270228607;9532.618695252113;9804.55879485439;9989.200863931013;10352.896471035494 15:43:17 INFO - PROCESS | 12594 | __end_tp_report 15:43:17 INFO - PROCESS | 12594 | __start_cc_report 15:43:17 INFO - PROCESS | 12594 | _x_x_mozilla_cycle_collect,1064 15:43:17 INFO - PROCESS | 12594 | __end_cc_report 15:43:17 INFO - PROCESS | 12594 | __startTimestamp1480203797277__endTimestamp 15:43:17 INFO - PROCESS | 12594 | 15:43:17 INFO - PROCESS | 12594 | ------- Summary: start ------- 15:43:17 INFO - PROCESS | 12594 | Number of tests: 6 15:43:17 INFO - PROCESS | 12594 | 15:43:17 INFO - PROCESS | 12594 | [#0] dojo.html Cycles:165 Average:5347.22 Median:5527.81 stddev:596.49 (10.8%) stddev-sans-first:571.33 15:43:17 INFO - PROCESS | 12594 | Values: 3086.0 3099.2 3126.5 3128.5 3132.7 5303.6 5357.5 5358.9 5459.1 5469.1 5353.1 5401.4 5426.6 5437.1 5459.4 4778.1 4788.7 4816.9 4861.2 4871.7 4885.8 4925.0 4932.5 4971.0 4981.6 4811.4 4918.7 4924.7 4953.1 5022.8 4830.5 4835.2 4888.6 4889.9 4896.9 4856.9 4860.5 4862.1 4869.3 4916.7 5289.6 5342.1 5348.1 5361.8 5372.0 5563.2 5570.1 5573.6 5668.5 5709.8 5769.6 5848.9 5871.4 5876.7 5884.6 5424.1 5425.4 5428.3 5431.9 5451.9 5857.0 5919.3 5928.0 5934.0 5934.8 5565.2 5586.5 5589.8 5614.9 5633.5 5760.0 5762.3 5762.6 5765.5 5819.4 5733.0 5733.6 5734.8 5736.9 5740.0 5654.4 5691.7 5693.7 5738.4 5767.0 4428.3 4450.9 4455.6 4464.7 4464.9 3961.0 3967.5 3997.7 4005.2 4018.2 5511.2 5518.6 5524.9 5525.7 5527.8 5694.9 5704.4 5768.7 5813.3 5818.3 5404.8 5418.3 5443.1 5504.4 5548.6 5020.1 5022.5 5033.4 5037.1 5075.0 5849.4 5933.5 5990.4 6006.5 6009.1 5694.0 5707.1 5715.5 5716.0 5818.4 5936.0 5973.2 5974.8 5981.4 5985.8 5646.6 5648.0 5650.2 5652.0 5662.3 5690.7 5697.9 5701.9 5708.4 5743.7 5599.2 5600.1 5604.0 5609.6 5642.0 5574.7 5585.6 5622.2 5625.3 5636.1 5490.8 5497.1 5514.9 5524.9 5581.1 5674.8 5675.1 5682.1 5705.0 5720.0 5359.6 5454.3 5482.2 5494.5 5497.2 15:43:17 INFO - PROCESS | 12594 | 15:43:17 INFO - PROCESS | 12594 | [#1] ext.html Cycles:180 Average:55240.47 Median:36442.73 stddev:108152.11 (296.8%) stddev-sans-first:108377.51 15:43:17 INFO - PROCESS | 12594 | Values: 533.6 555.3 574.6 578.2 579.9 29349.1 37002.4 37767.4 37768.8 41038.6 39880.0 40113.6 40216.0 40292.2 40320.6 8039.4 8185.9 8198.8 8206.4 8225.8 7738.1 7948.5 9785.2 10057.1 10058.6 10189.9 10238.4 10244.6 10258.1 10258.2 10167.4 10221.5 10232.5 10233.9 10236.3 10004.1 10031.8 10046.9 10055.5 10061.3 26716.2 26764.6 26794.2 26994.9 27004.7 3213.9 3240.6 3257.7 3286.5 3527.6 29071.3 29366.4 29630.4 29710.7 31081.1 3979.3 4017.4 4047.1 4127.8 4145.3 340801.0 343842.0 344327.0 344439.3 346316.0 53868.5 53958.7 54345.7 55047.0 55090.4 59334.0 59553.4 59659.7 59868.4 60263.0 13686.4 13738.9 13743.9 13745.6 13759.3 9785.3 10380.5 10393.6 10404.6 10508.6 15924.9 17240.7 17472.1 17601.4 18083.2 6548.9 6776.0 6826.4 6869.3 6989.1 845.2 939.3 996.0 1008.3 1028.6 29685.7 30619.2 30666.5 30778.8 30977.1 1013.0 1060.7 1068.5 1086.4 1121.9 14804.6 15220.8 15292.8 15552.6 15730.3 487345.0 488479.6 492640.0 494359.0 494809.0 51834.0 52819.5 52865.5 52937.5 53001.5 1113.9 1120.9 1166.4 1192.6 1208.1 24975.6 27221.5 27268.5 27861.4 27940.4 39204.2 39436.2 39468.4 39599.0 39822.0 373683.0 373812.0 374690.0 375657.0 376896.0 38832.6 38879.8 39153.0 39470.0 39739.4 40579.4 41179.4 41372.0 41929.6 43559.0 36661.8 36866.4 37092.8 37156.4 37177.6 36134.6 36232.5 36653.0 36827.3 37070.8 37040.8 38256.4 38305.0 39127.8 39797.6 31549.4 33873.3 34433.8 34927.5 34933.5 27177.2 32047.5 32165.5 32262.4 34230.3 15:43:17 INFO - PROCESS | 12594 | 15:43:17 INFO - PROCESS | 12594 | [#2] jquery.html Cycles:180 Average:25520.57 Median:42533.79 stddev:66803.21 (157.1%) stddev-sans-first:66963.91 15:43:17 INFO - PROCESS | 12594 | Values: 365.4 377.4 390.2 393.4 415.4 13951.7 15356.0 17588.2 18701.0 19106.1 15277.6 15278.4 15325.3 15403.2 15413.5 5390.9 5641.4 5663.9 5664.7 5668.4 5377.8 5535.1 5539.6 5542.1 5583.1 5542.9 5554.5 5562.4 5562.6 5563.6 5400.8 5542.9 5552.5 5662.5 5701.1 5579.0 5579.2 5585.3 5589.7 5593.5 13202.5 13299.7 13362.7 13394.1 15910.2 2127.8 2146.1 2185.4 2504.2 2520.2 9004.9 9420.6 9818.1 9926.3 9990.6 1837.3 1844.3 1850.7 1881.8 1893.9 77199.6 79378.0 79508.0 81454.6 85871.6 10500.3 10815.8 10952.9 11071.4 11080.6 15179.5 15198.8 15223.7 15233.2 15235.1 7111.0 7322.8 7460.7 7537.9 7563.8 6704.2 6728.8 6736.5 6932.2 7009.6 4618.9 4661.1 4679.2 4690.2 4780.8 1874.6 1894.5 1922.8 1941.6 1975.2 770.5 876.8 881.7 914.0 951.8 17676.4 17991.2 18305.0 18450.6 19049.0 872.1 875.2 881.9 883.5 922.3 9791.2 10247.4 10282.1 10287.9 10392.4 348547.0 351592.1 352162.0 462149.0 472143.0 68917.7 71589.0 90698.0 93482.0 100699.0 904.2 952.6 955.3 1010.7 1056.4 16226.5 16470.2 17389.5 17394.3 17548.2 42232.4 42507.6 42560.0 43032.4 43093.6 57682.0 58321.4 58498.4 58745.4 59396.4 7833.6 7877.8 7999.2 8191.4 8236.5 9876.4 11632.7 11692.5 11773.2 11908.6 10314.5 10645.7 10654.1 10812.2 10847.4 10712.1 10856.7 10914.3 10925.9 10983.3 10899.3 11172.2 11212.9 11387.1 11725.2 6986.9 7374.5 7459.3 7633.9 8467.1 10389.5 11467.9 11492.9 11607.8 11785.7 15:43:17 INFO - PROCESS | 12594 | 15:43:17 INFO - PROCESS | 12594 | [#3] mootools.html Cycles:180 Average:5403.15 Median:4919.86 stddev:3075.62 (62.5%) stddev-sans-first:3067.54 15:43:17 INFO - PROCESS | 12594 | Values: 1138.1 1263.6 1264.3 1293.5 1307.9 7140.1 7956.1 8189.9 8207.4 8448.9 8242.1 8249.5 8304.3 8319.8 8320.9 1974.6 2217.8 2247.4 2256.1 2257.7 2039.8 2195.6 2251.1 2256.8 2260.5 2209.5 2218.1 2220.1 2227.3 2235.6 2208.6 2226.8 2229.4 2241.8 2242.9 2130.3 2130.8 2166.9 2167.3 2168.8 8182.8 8191.1 8196.1 8232.8 8243.6 4771.0 4903.4 4906.1 4907.2 4909.8 3173.3 3258.3 3283.7 3333.0 3341.3 1062.5 1136.1 1142.8 1166.0 1168.6 11583.7 11636.8 11649.8 11651.5 11653.4 4297.3 4505.3 4545.7 4555.9 4564.8 9952.6 9958.8 9968.5 9973.6 9973.7 4912.7 4915.1 4924.6 4924.8 4926.2 3992.5 4144.9 4266.9 4312.3 4507.4 3493.2 3609.4 3612.7 3704.6 3818.2 1283.6 1292.8 1293.6 1303.7 1326.6 845.6 847.5 866.9 888.0 888.2 5375.1 5454.9 5540.6 5618.5 5800.7 827.4 833.1 850.9 858.4 867.0 3581.6 3608.1 3635.7 3657.1 3755.7 9776.0 10249.6 10253.8 10293.3 10310.6 10040.1 10159.5 10284.4 10284.6 10302.9 7439.3 7589.4 7590.6 7593.1 7609.6 5314.4 5371.6 5424.8 5431.5 5466.5 9025.5 9055.0 9129.2 9280.1 9494.7 9254.4 9308.3 9558.7 9584.8 9694.7 7346.2 7367.2 7484.8 7485.5 7488.0 6783.2 6933.2 7559.8 7876.7 7895.2 6987.3 7153.2 7169.1 7218.6 7266.5 6955.0 6998.1 7072.5 7092.3 7108.6 6297.9 6378.9 6455.1 6515.8 6518.9 4585.9 4757.1 4799.4 4836.1 4997.1 4892.7 4927.5 5119.5 5122.7 5174.8 15:43:17 INFO - PROCESS | 12594 | 15:43:17 INFO - PROCESS | 12594 | [#4] prototype.html Cycles:180 Average:4551.69 Median:5194.66 stddev:1304.68 (25.1%) stddev-sans-first:1269.19 15:43:17 INFO - PROCESS | 12594 | Values: 325.4 334.8 336.1 337.8 340.5 5163.3 5226.6 5307.6 5321.7 5322.0 5071.0 5179.5 5210.8 5213.0 5245.5 4130.8 4133.2 4136.3 4151.9 4162.5 3866.1 3886.3 4145.1 4167.0 4170.5 4088.0 4102.3 4104.5 4108.4 4127.7 4088.9 4105.8 4113.2 4116.1 4134.5 3661.7 3665.9 3666.3 3666.7 3681.3 5013.4 5068.9 5079.5 5092.3 5099.4 4615.5 4658.3 4677.7 4689.2 4703.2 5421.6 5462.2 5463.3 5492.7 5534.0 3837.7 3962.5 3978.6 3978.7 3996.4 5615.3 5617.0 5629.4 5636.8 5671.5 4075.9 4087.9 4088.3 4093.8 4113.9 4061.8 4120.9 4123.8 4127.9 4145.3 4658.8 4670.5 4687.9 4711.8 4717.6 5465.3 5507.8 5533.2 5544.8 5556.6 1344.5 1351.3 1358.8 1369.5 1373.3 970.5 972.1 983.8 985.3 986.4 5156.7 5158.3 5185.4 5196.4 5209.0 5367.9 5397.9 5404.4 5415.9 5445.2 4979.9 5188.0 5198.5 5228.7 5240.4 2888.7 2889.7 2890.0 2893.8 2896.7 5636.5 5670.9 5673.2 5693.4 5726.4 5252.0 5498.7 5504.5 5522.5 5594.2 5583.5 5600.4 5605.6 5626.2 5645.4 5151.3 5395.5 5424.4 5464.4 5467.3 5361.4 5418.7 5423.9 5424.5 5440.2 5613.4 5644.3 5647.0 5648.4 5690.6 3873.8 3999.1 4020.9 4024.8 4048.2 5343.9 5407.5 5430.5 5433.2 5439.0 5254.4 5285.8 5303.3 5319.7 5331.7 5041.4 5252.0 5265.7 5290.0 5293.6 5192.9 5196.6 5222.8 5226.9 5244.4 5235.8 5332.4 5359.6 5368.0 5384.4 4934.5 5124.3 5126.8 5147.7 5168.4 15:43:17 INFO - PROCESS | 12594 | 15:43:17 INFO - PROCESS | 12594 | [#5] yui.html Cycles:180 Average:17877.39 Median:25420.30 stddev:24708.01 (97.2%) stddev-sans-first:24743.45 15:43:17 INFO - PROCESS | 12594 | Values: 645.9 658.8 679.1 697.3 699.4 11352.3 12113.9 12308.4 12335.6 12359.1 11453.4 11520.7 11528.6 11538.2 12181.1 633.6 642.3 643.9 644.3 644.7 552.3 562.1 622.8 635.8 637.8 669.2 669.7 674.9 689.6 711.4 665.5 665.7 665.9 672.5 679.9 427.2 449.6 486.4 489.8 511.4 11298.8 11300.7 11309.5 11359.8 11484.2 12220.2 12386.3 12575.7 12602.9 12747.0 12416.5 12425.2 12438.9 12814.0 13228.3 4089.4 4102.0 4143.1 4159.4 4314.7 80711.0 81292.0 81662.6 81968.2 83824.0 9482.1 9716.3 9726.6 9795.9 9953.9 16291.8 16326.9 16638.3 16750.4 16800.1 7160.6 7189.7 7252.8 7381.1 7386.0 4042.9 4127.7 4167.7 4177.8 4191.8 2837.7 2918.6 2922.1 2937.8 2966.4 480.3 490.4 506.4 521.4 531.9 568.5 588.6 595.4 596.1 609.1 8862.0 9259.9 9271.4 9311.9 9515.8 589.0 591.3 604.6 625.2 634.6 4585.5 4601.4 4604.2 4680.4 4699.7 82291.6 84436.6 84444.6 88109.6 88215.6 73847.6 75328.2 77144.2 80699.0 80731.0 70823.0 71841.0 73382.6 74826.0 75867.6 8676.2 8913.6 8935.1 9107.7 9271.2 44227.0 46218.0 47784.0 47833.3 50350.2 52761.5 53082.2 54888.0 59864.0 60366.4 11760.8 11767.7 11953.8 11956.3 12648.9 14321.9 14589.4 14632.4 15164.8 15579.4 13231.3 13636.6 13681.5 13768.5 14321.3 13812.8 13981.4 14436.5 14598.0 14914.9 12815.7 12822.9 12999.7 13498.1 13606.7 10085.5 10521.1 10578.4 10613.7 11174.9 9146.0 9532.6 9804.6 9989.2 10352.9 15:43:17 INFO - PROCESS | 12594 | -------- Summary: end -------- 15:43:17 INFO - PROCESS | 12594 | 15:43:18 INFO - TEST-INFO | 12594: exit 0 15:43:18 INFO - TEST-OK | dromaeo_css | took 1117913ms 15:43:18 INFO - TEST-START | kraken 15:43:18 INFO - operating with platform_type : linux_ 15:43:18 INFO - Initialising browser for kraken test... 15:43:18 INFO - TEST-INFO | started process 12898 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFnKjAS/profile http://localhost:39392/getInfo.html) 15:43:22 INFO - PROCESS | 12898 | __metrics Screen width/height:1600/1200 15:43:22 INFO - PROCESS | 12898 | colorDepth:24 15:43:22 INFO - PROCESS | 12898 | Browser inner width/height: 1024/697 15:43:22 INFO - PROCESS | 12898 | __metrics 15:43:22 INFO - PROCESS | 12898 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:43:22 INFO - PROCESS | 12898 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:43:23 INFO - PROCESS | 12898 | console.error: PushService: 15:43:23 INFO - PROCESS | 12898 | stateChangeProcessEnqueue: Error transitioning state 15:43:23 INFO - PROCESS | 12898 | UnknownError 15:43:23 INFO - TEST-INFO | 12898: exit 0 15:43:23 INFO - Browser initialized. 15:43:23 INFO - Running cycle 1/1 for kraken test... 15:43:23 INFO - TEST-INFO | started process 12979 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFnKjAS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:43:36 INFO - PROCESS | 12979 | RSS: Main: 173776896 15:43:36 INFO - PROCESS | 12979 | 15:43:38 INFO - PROCESS | 12979 | Cycle 1(1): loaded http://localhost:39392/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39392/tests/kraken/driver.html?testName=audio-beat-detection) 15:43:39 INFO - PROCESS | 12979 | RSS: Main: 234487808 15:43:39 INFO - PROCESS | 12979 | 15:43:42 INFO - PROCESS | 12979 | Cycle 1(1): loaded http://localhost:39392/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39392/tests/kraken/driver.html?testName=audio-dft) 15:43:42 INFO - PROCESS | 12979 | RSS: Main: 216969216 15:43:42 INFO - PROCESS | 12979 | 15:43:45 INFO - PROCESS | 12979 | Cycle 1(1): loaded http://localhost:39392/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39392/tests/kraken/driver.html?testName=audio-fft) 15:43:46 INFO - PROCESS | 12979 | RSS: Main: 299012096 15:43:46 INFO - PROCESS | 12979 | 15:43:48 INFO - PROCESS | 12979 | Cycle 1(1): loaded http://localhost:39392/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39392/tests/kraken/driver.html?testName=audio-oscillator) 15:43:49 INFO - PROCESS | 12979 | RSS: Main: 209432576 15:43:49 INFO - PROCESS | 12979 | 15:43:51 INFO - PROCESS | 12979 | Cycle 1(1): loaded http://localhost:39392/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39392/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:43:51 INFO - PROCESS | 12979 | RSS: Main: 214138880 15:43:51 INFO - PROCESS | 12979 | 15:43:54 INFO - PROCESS | 12979 | Cycle 1(1): loaded http://localhost:39392/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39392/tests/kraken/driver.html?testName=imaging-darkroom) 15:43:55 INFO - PROCESS | 12979 | RSS: Main: 252981248 15:43:55 INFO - PROCESS | 12979 | 15:43:58 INFO - PROCESS | 12979 | Cycle 1(1): loaded http://localhost:39392/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39392/tests/kraken/driver.html?testName=imaging-desaturate) 15:43:59 INFO - PROCESS | 12979 | RSS: Main: 253046784 15:43:59 INFO - PROCESS | 12979 | 15:44:02 INFO - PROCESS | 12979 | Cycle 1(1): loaded http://localhost:39392/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39392/tests/kraken/driver.html?testName=json-parse-financial) 15:44:02 INFO - PROCESS | 12979 | RSS: Main: 251310080 15:44:02 INFO - PROCESS | 12979 | 15:44:04 INFO - PROCESS | 12979 | Cycle 1(1): loaded http://localhost:39392/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39392/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:44:04 INFO - PROCESS | 12979 | RSS: Main: 213491712 15:44:04 INFO - PROCESS | 12979 | 15:44:06 INFO - PROCESS | 12979 | Cycle 1(1): loaded http://localhost:39392/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39392/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:44:07 INFO - PROCESS | 12979 | RSS: Main: 221614080 15:44:07 INFO - PROCESS | 12979 | 15:44:09 INFO - PROCESS | 12979 | Cycle 1(1): loaded http://localhost:39392/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39392/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:44:09 INFO - PROCESS | 12979 | RSS: Main: 229879808 15:44:09 INFO - PROCESS | 12979 | 15:44:12 INFO - PROCESS | 12979 | Cycle 1(1): loaded http://localhost:39392/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39392/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:44:13 INFO - PROCESS | 12979 | RSS: Main: 238456832 15:44:13 INFO - PROCESS | 12979 | 15:44:16 INFO - PROCESS | 12979 | Cycle 1(1): loaded http://localhost:39392/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39392/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:44:16 INFO - PROCESS | 12979 | RSS: Main: 235532288 15:44:16 INFO - PROCESS | 12979 | 15:44:18 INFO - PROCESS | 12979 | Cycle 1(1): loaded http://localhost:39392/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39392/tests/kraken/driver.html?testName=ai-astar) 15:44:18 INFO - PROCESS | 12979 | RSS: Main: 288165888 15:44:18 INFO - PROCESS | 12979 | 15:44:18 INFO - PROCESS | 12979 | __start_tp_report 15:44:18 INFO - PROCESS | 12979 | _x_x_mozilla_page_load 15:44:18 INFO - PROCESS | 12979 | _x_x_mozilla_page_load_details 15:44:18 INFO - PROCESS | 12979 | |i|pagename|runs| 15:44:18 INFO - PROCESS | 12979 | |0;ai-astar;105;111;112;111;113;113;112;111;111;111 15:44:18 INFO - PROCESS | 12979 | |1;audio-beat-detection;148;126;123;184;131;125;125;124;150;123 15:44:18 INFO - PROCESS | 12979 | |2;audio-dft;160;161;161;160;159;161;161;160;160;160 15:44:18 INFO - PROCESS | 12979 | |3;audio-fft;75;76;76;112;76;76;75;76;94;76 15:44:18 INFO - PROCESS | 12979 | |4;audio-oscillator;84;82;110;84;83;83;102;83;82;116 15:44:18 INFO - PROCESS | 12979 | |5;imaging-gaussian-blur;118;119;118;118;117;117;118;118;118;118 15:44:18 INFO - PROCESS | 12979 | |6;imaging-darkroom;147;146;145;145;146;147;146;146;147;148 15:44:18 INFO - PROCESS | 12979 | |7;imaging-desaturate;94;95;95;95;95;96;95;95;96;95 15:44:18 INFO - PROCESS | 12979 | |8;json-parse-financial;54;53;53;54;54;55;55;54;53;53 15:44:18 INFO - PROCESS | 12979 | |9;json-stringify-tinderbox;61;62;62;61;63;62;62;62;64;63 15:44:18 INFO - PROCESS | 12979 | |10;stanford-crypto-aes;82;83;81;81;80;84;86;87;80;89 15:44:18 INFO - PROCESS | 12979 | |11;stanford-crypto-ccm;142;143;132;144;133;133;133;134;179;131 15:44:18 INFO - PROCESS | 12979 | |12;stanford-crypto-pbkdf2;169;164;164;163;164;166;166;165;169;165 15:44:18 INFO - PROCESS | 12979 | |13;stanford-crypto-sha256-iterative;65;66;66;65;65;67;64;65;65;64 15:44:18 INFO - PROCESS | 12979 | __end_tp_report 15:44:18 INFO - PROCESS | 12979 | __start_cc_report 15:44:18 INFO - PROCESS | 12979 | _x_x_mozilla_cycle_collect,1666 15:44:18 INFO - PROCESS | 12979 | __end_cc_report 15:44:18 INFO - PROCESS | 12979 | __startTimestamp1480203858639__endTimestamp 15:44:18 INFO - PROCESS | 12979 | 15:44:18 INFO - PROCESS | 12979 | ------- Summary: start ------- 15:44:18 INFO - PROCESS | 12979 | Number of tests: 14 15:44:18 INFO - PROCESS | 12979 | 15:44:18 INFO - PROCESS | 12979 | [#0] ai-astar Cycles:10 Average:111.00 Median:111.50 stddev:2.26 (2.0%) stddev-sans-first:0.87 15:44:18 INFO - PROCESS | 12979 | Values: 105.0 111.0 112.0 111.0 113.0 113.0 112.0 111.0 111.0 111.0 15:44:18 INFO - PROCESS | 12979 | 15:44:18 INFO - PROCESS | 12979 | [#1] audio-beat-detection Cycles:10 Average:135.90 Median:128.50 stddev:19.70 (15.3%) stddev-sans-first:20.40 15:44:18 INFO - PROCESS | 12979 | Values: 148.0 126.0 123.0 184.0 131.0 125.0 125.0 124.0 150.0 123.0 15:44:18 INFO - PROCESS | 12979 | 15:44:18 INFO - PROCESS | 12979 | [#2] audio-dft Cycles:10 Average:160.30 Median:160.50 stddev:0.67 (0.4%) stddev-sans-first:0.71 15:44:18 INFO - PROCESS | 12979 | Values: 160.0 161.0 161.0 160.0 159.0 161.0 161.0 160.0 160.0 160.0 15:44:18 INFO - PROCESS | 12979 | 15:44:18 INFO - PROCESS | 12979 | [#3] audio-fft Cycles:10 Average:81.20 Median:76.00 stddev:12.25 (16.1%) stddev-sans-first:12.79 15:44:18 INFO - PROCESS | 12979 | Values: 75.0 76.0 76.0 112.0 76.0 76.0 75.0 76.0 94.0 76.0 15:44:18 INFO - PROCESS | 12979 | 15:44:18 INFO - PROCESS | 12979 | [#4] audio-oscillator Cycles:10 Average:90.90 Median:83.00 stddev:13.16 (15.9%) stddev-sans-first:13.72 15:44:18 INFO - PROCESS | 12979 | Values: 84.0 82.0 110.0 84.0 83.0 83.0 102.0 83.0 82.0 116.0 15:44:18 INFO - PROCESS | 12979 | 15:44:18 INFO - PROCESS | 12979 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 15:44:18 INFO - PROCESS | 12979 | Values: 118.0 119.0 118.0 118.0 117.0 117.0 118.0 118.0 118.0 118.0 15:44:18 INFO - PROCESS | 12979 | 15:44:18 INFO - PROCESS | 12979 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.50 stddev:0.95 (0.6%) stddev-sans-first:0.97 15:44:18 INFO - PROCESS | 12979 | Values: 147.0 146.0 145.0 145.0 146.0 147.0 146.0 146.0 147.0 148.0 15:44:18 INFO - PROCESS | 12979 | 15:44:18 INFO - PROCESS | 12979 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.44 15:44:18 INFO - PROCESS | 12979 | Values: 94.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 96.0 95.0 15:44:18 INFO - PROCESS | 12979 | 15:44:18 INFO - PROCESS | 12979 | [#8] json-parse-financial Cycles:10 Average:53.80 Median:54.00 stddev:0.79 (1.5%) stddev-sans-first:0.83 15:44:18 INFO - PROCESS | 12979 | Values: 54.0 53.0 53.0 54.0 54.0 55.0 55.0 54.0 53.0 53.0 15:44:18 INFO - PROCESS | 12979 | 15:44:18 INFO - PROCESS | 12979 | [#9] json-stringify-tinderbox Cycles:10 Average:62.20 Median:62.00 stddev:0.92 (1.5%) stddev-sans-first:0.87 15:44:18 INFO - PROCESS | 12979 | Values: 61.0 62.0 62.0 61.0 63.0 62.0 62.0 62.0 64.0 63.0 15:44:18 INFO - PROCESS | 12979 | 15:44:18 INFO - PROCESS | 12979 | [#10] stanford-crypto-aes Cycles:10 Average:83.30 Median:83.50 stddev:3.13 (3.7%) stddev-sans-first:3.28 15:44:18 INFO - PROCESS | 12979 | Values: 82.0 83.0 81.0 81.0 80.0 84.0 86.0 87.0 80.0 89.0 15:44:18 INFO - PROCESS | 12979 | 15:44:18 INFO - PROCESS | 12979 | [#11] stanford-crypto-ccm Cycles:10 Average:140.40 Median:138.00 stddev:14.44 (10.5%) stddev-sans-first:15.30 15:44:18 INFO - PROCESS | 12979 | Values: 142.0 143.0 132.0 144.0 133.0 133.0 133.0 134.0 179.0 131.0 15:44:18 INFO - PROCESS | 12979 | 15:44:18 INFO - PROCESS | 12979 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.50 Median:165.50 stddev:2.07 (1.2%) stddev-sans-first:1.76 15:44:18 INFO - PROCESS | 12979 | Values: 169.0 164.0 164.0 163.0 164.0 166.0 166.0 165.0 169.0 165.0 15:44:18 INFO - PROCESS | 12979 | 15:44:18 INFO - PROCESS | 12979 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.20 Median:65.00 stddev:0.92 (1.4%) stddev-sans-first:0.97 15:44:18 INFO - PROCESS | 12979 | Values: 65.0 66.0 66.0 65.0 65.0 67.0 64.0 65.0 65.0 64.0 15:44:18 INFO - PROCESS | 12979 | -------- Summary: end -------- 15:44:18 INFO - PROCESS | 12979 | 15:44:19 INFO - TEST-INFO | 12979: exit 0 15:44:19 INFO - TEST-OK | kraken | took 61765ms 15:44:19 INFO - SUITE-END | took 1179s 15:44:20 INFO - Completed test suite (00:19:40) 15:44:20 INFO - javascript benchmark 15:44:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3085.9537106943394, 3099.194209505528, 3126.5310203469476, 3128.4681604127295, 3132.6867313268676, 5303.602229832759, 5357.544608708255, 5358.946410535894, 5459.12653975364, 5469.07025805613, 5353.143497040474, 5401.378841433237, 5426.593005524582, 5437.075697131488, 5459.426760190182, 4778.116048531016, 4788.664793464459, 4816.868036011534, 4861.173600487908, 4871.7076975381415, 4885.804567817283, 4925.0, 4932.506749325074, 4971.0, 4981.5516603505675, 4811.350467686852, 4918.729469879156, 4924.679895806797, 4953.108440480712, 5022.82420115296, 4830.468648448667, 4835.178019736653, 4888.560029597354, 4889.853304400874, 4896.853094407174, 4856.902861942776, 4860.513948605111, 4862.100511405401, 4869.318295438641, 4916.729579873106, 5289.550388217006, 5342.065138600729, 5348.117560602496, 5361.785528578852, 5372.0330340538685, 5563.193336966157, 5570.136628822539, 5573.6098473106895, 5668.546516278688, 5709.77160913563, 5769.59612827098, 5848.912266315966, 5871.3541510433815, 5876.706164691748, 5884.558658100659, 5424.1321388577635, 5425.430329815392, 5428.348598168205, 5431.918521222185, 5451.863703407446, 5857.0, 5919.289685237799, 5928.0, 5933.970330148321, 5934.7922822701, 5565.220869078333, 5586.469285417878, 5589.804356847572, 5614.887702245932, 5633.492985631231, 5760.049591817387, 5762.337331206881, 5762.625429347079, 5765.509931655773, 5819.447152520504, 5733.0, 5733.598648094593, 5734.799282025109, 5736.913946290809, 5739.971300143473, 5654.434556544395, 5691.743871525791, 5693.743781529841, 5738.426157384228, 5767.019606666793, 4428.335749637516, 4450.888727781767, 4455.5989960903025, 4464.709793863389, 4464.888377790517, 3961.029547760759, 3967.4643923070016, 3997.6801855851463, 4005.178938317696, 4018.1561872006623, 5511.173324001352, 5518.586106042063, 5524.889502209933, 5525.723713814293, 5527.806526771544, 5694.914576281359, 5704.401037891044, 5768.682722450306, 5813.302403711582, 5818.330891947396, 5404.78380864761, 5418.295621569171, 5443.101888188484, 5504.394516603251, 5548.639338443069, 5020.071286811952, 5022.522860328263, 5033.370828646419, 5037.093323201859, 5074.974625126924, 5849.444302791228, 5933.465988061095, 5990.430909063632, 6006.519478441714, 6009.128676341993, 5694.003549378759, 5707.1153971134545, 5715.514181294637, 5716.0, 5818.418158184148, 5935.9703201485445, 5973.193618861398, 5974.761009559569, 5981.431763982415, 5985.760569577343, 5646.604737668324, 5647.971760141173, 5650.180723795109, 5652.0, 5662.348829884451, 5690.743916523849, 5697.914531281951, 5701.8859622806485, 5708.400617935223, 5743.684097374685, 5599.216109744721, 5600.103983362643, 5604.019296622993, 5609.635373700697, 5642.0, 5574.721263936868, 5585.5531557476115, 5622.184783206494, 5625.296837895263, 5636.098224284259, 5490.835274941758, 5497.147942068986, 5514.944850551604, 5524.889502209853, 5581.134924086773, 5674.829755107354, 5675.148727690879, 5682.147677848356, 5705.030144875464, 5719.971400143139, 5359.598030147677, 5454.318210223722, 5482.17767334903, 5494.450554944474, 5497.175423686479], "value": 5307.470661393667, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [533.6184627990986, 555.2892297858742, 574.6063946196856, 578.2425023219581, 579.9333076696179, 29349.11952641419, 37002.444963325535, 37767.43348849763, 37768.81115594422, 41038.58961410385, 39880.0, 40113.59886401135, 40215.97300337458, 40292.19415611686, 40320.59679403205, 8039.35685145187, 8185.877211841827, 8198.836023279531, 8206.425550211488, 8225.794355141139, 7738.110117336522, 7948.523088614673, 9785.217182625373, 10057.094861462467, 10058.647947321846, 10189.898101019005, 10238.385696858213, 10244.590216391372, 10258.07677309042, 10258.179345652366, 10167.440790756506, 10221.488925553693, 10232.488375581192, 10233.89766102337, 10236.33463824849, 10004.099631033241, 10031.849522257173, 10046.899531004743, 10055.486128467883, 10061.295709300352, 26716.19851404461, 26764.598531021857, 26794.196174114808, 26994.865025674942, 27004.729952700418, 3213.8714451421915, 3240.643529211785, 3257.657945915692, 3286.5398844161837, 3527.5943266524423, 29071.273218169503, 29366.412671746446, 29630.40739185226, 29710.70289297101, 31081.067567972997, 3979.303621866191, 4017.4375587417494, 4047.089404883907, 4127.814248358831, 4145.274576949022, 340801.0, 343842.0, 344327.0, 344439.2778036119, 346316.0, 53868.461315387125, 53958.730206348715, 54345.72827135918, 55047.0, 55090.449095508535, 59334.0, 59553.40446595565, 59659.701701492086, 59868.401315987154, 60263.0, 13686.384112714952, 13738.931305343409, 13743.931280343535, 13745.587632371045, 13759.312034398241, 9785.315027947976, 10380.532876020598, 10393.58425662965, 10404.635837745642, 10508.579656813794, 15924.92037539805, 17240.65518689644, 17472.078071412136, 17601.383951561635, 18083.18625661822, 6548.869022619521, 6776.0, 6826.385625293748, 6869.278725733826, 6989.091418115612, 845.1759534453859, 939.3424602778083, 995.9950200248952, 1008.2992320337441, 1028.5680014393972, 29685.703142968727, 30619.234519136753, 30666.54000189999, 30778.846105769775, 30977.14137151778, 1012.9848052279222, 1060.6923992042375, 1068.529846867376, 1086.413336798136, 1121.876593574706, 14804.629884252765, 15220.847791521943, 15292.847071529142, 15552.611184720472, 15730.29213685364, 487345.0, 488479.57602119754, 492640.0, 494359.0, 494809.0, 51834.0, 52819.47180528146, 52865.47134528682, 52937.47062529402, 53001.46998530043, 1113.9498722557505, 1120.910327173824, 1166.445938179375, 1192.576635294458, 1208.081857788105, 24975.625365619166, 27221.455570888866, 27268.454630906876, 27861.44277114487, 27940.441191175654, 39204.2159156821, 39436.21127577375, 39468.40797387984, 39599.0, 39822.004449888984, 373683.0, 373812.0, 374690.0, 375657.0, 376896.0, 38832.6116738829, 38879.80560097181, 39153.0, 39470.0, 39739.40390894197, 40579.391309129795, 41179.38230926479, 41372.0, 41929.580704192565, 43559.0, 36661.81669091638, 36866.44700329444, 37092.81453592715, 37156.44265335968, 37177.62822371742, 36134.638653613125, 36232.456513151796, 36653.0, 36827.26345473022, 37070.8146459266, 37040.81479592585, 38256.426153607164, 38305.0, 39127.80436097915, 39797.60202397939, 31549.36901261916, 33873.32253354968, 34433.82783086068, 34927.476087858195, 34933.47599785955, 27177.1846844595, 32047.519287211177, 32165.517517236793, 32262.35475290528, 34230.31539369249], "value": 18763.440159067628, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [365.3897990356105, 377.42631200575124, 390.1903550133472, 393.4098851722416, 415.4495293735801, 13951.744717861062, 15356.0, 17588.208530616106, 18700.958587807236, 19106.140223689934, 15277.618059548517, 15278.38886444541, 15325.310361033753, 15403.152826594533, 15413.460528881491, 5390.8921821563445, 5641.407652196522, 5663.915041274384, 5664.688442135681, 5668.376478587352, 5377.838664840042, 5535.059039963196, 5539.612227144102, 5542.140968149923, 5583.106702927533, 5542.889142217154, 5554.527865131468, 5562.443755624446, 5562.554995600342, 5563.582731295169, 5400.83797486076, 5542.944570554283, 5552.500274975251, 5662.546996240291, 5701.059325211335, 5578.972105139489, 5579.163125531162, 5585.273914391144, 5589.692566908819, 5593.52455041322, 13202.471901123943, 13299.734005319937, 13362.665933351647, 13394.06241563091, 15910.20448977558, 2127.7659457459667, 2146.0771868096713, 2185.3771675072685, 2504.173622704503, 2520.218732193026, 9004.8649270261, 9420.62317507299, 9818.116369526706, 9926.305158638897, 9990.600375984952, 1837.349546599123, 1844.2530775036132, 1850.6576283387617, 1881.7741870975572, 1893.8863668179954, 77199.6140019302, 79378.0, 79508.0, 81454.59272703598, 85871.57064214638, 10500.31747936397, 10815.783684326427, 10952.945235273774, 11071.391073490875, 11080.61217857371, 15179.544613661608, 15198.772018419733, 15223.695526089416, 15233.23833808305, 15235.085894846123, 7110.964445177741, 7322.780316590511, 7460.738874139379, 7537.886931696029, 7563.773086807405, 6704.161979752531, 6728.798136055926, 6736.494762892803, 6932.202796678446, 7009.61447120403, 4618.861434156981, 4661.137689527448, 4679.181143299909, 4690.202665546865, 4780.832670856504, 1874.5969616532238, 1894.4790182699592, 1922.8465316880327, 1941.5825597496605, 1975.1605567633699, 770.5261264322402, 876.750126214026, 881.6693739847557, 913.980911283927, 951.7620594851287, 17676.409123178717, 17991.190396432194, 18305.0, 18450.630987380446, 19049.0, 872.0581771686564, 875.2385424680441, 881.8633111867671, 883.5096521430668, 922.2622199744152, 9791.167750741124, 10247.436390998566, 10282.07461328484, 10287.897121028695, 10392.376457412429, 348547.0, 351592.0509936258, 352162.0, 462149.0, 472143.0, 68917.65541172262, 71589.0, 90698.0, 93482.0, 100699.0, 904.2359206470522, 952.6094301336419, 955.302629080775, 1010.6563768318807, 1056.392574269798, 16226.513204603882, 16470.176491175633, 17389.47831565055, 17394.30422783125, 17548.2103305349, 42232.36651450169, 42507.57492425036, 42560.0, 43032.35451468293, 43093.569064308955, 57682.0, 58321.4167858316, 58498.4150158493, 58745.412545873995, 59396.406035939086, 7833.647485863035, 7877.84244315099, 7999.200079991954, 8191.385646076449, 8236.464629799044, 9876.40741555509, 11632.651020469399, 11692.532298707956, 11773.234739741889, 11908.583199587973, 10314.535845887103, 10645.733856653645, 10654.147668186371, 10812.243142980231, 10847.403392813156, 10712.14302855754, 10856.728581785519, 10914.29057111317, 10925.890741092806, 10983.340999540053, 10899.346039237671, 11172.156594162198, 11212.887871121184, 11387.089032877184, 11725.237859539102, 6986.895196571953, 7374.520656157332, 7459.328660420588, 7633.923660763321, 8467.068622451648, 10389.53247103867, 11467.885321146681, 11492.94253528727, 11607.76784464289, 11785.705357366134], "value": 8574.25684005028, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1138.1179585820994, 1263.6082814327558, 1264.31095053196, 1293.547258459539, 1307.8888294494973, 7140.107486564179, 7956.08505021922, 8189.8771518427275, 8207.425480216387, 8448.873266900986, 8242.093369729326, 8249.46378485398, 8304.33565314775, 8319.75040748777, 8320.91679083209, 1974.5754662747506, 2217.81148602369, 2247.4156719252946, 2256.1088370093803, 2257.7403598586206, 2039.836813054952, 2195.5938151442033, 2251.0995601759346, 2256.7856053674873, 2260.5026894083358, 2209.491816882118, 2218.134927378324, 2220.1119552179175, 2227.2538699535676, 2235.619944609412, 2208.6134926387817, 2226.76618955009, 2229.375774783063, 2241.775822417745, 2242.876641784709, 2130.2970019893396, 2130.754963179223, 2166.9133234670594, 2167.306461932182, 2168.7722789107233, 8182.795430114235, 8191.058028326759, 8196.098429172785, 8232.753017409488, 8243.587820609006, 4771.0, 4903.436104847952, 4906.092372911023, 4907.1657818171, 4909.828156014522, 3173.3018735878068, 3258.2994656148803, 3283.688049635281, 3333.033420308108, 3341.298327351259, 1062.54310646422, 1136.125183608625, 1142.7657330247362, 1165.9766804663943, 1168.5501082083374, 11583.652490425216, 11636.825447618208, 11649.825252621218, 11651.533938642444, 11653.359065251409, 4297.312430011183, 4505.301678239878, 4545.704529205591, 4555.863324100283, 4564.817407303671, 9952.601895924226, 9958.800823983625, 9968.451735154491, 9973.601055957826, 9973.700788976343, 4912.656114072052, 4915.090708218991, 4924.630652701062, 4924.827631032968, 4926.236433352836, 3992.5208974922616, 4144.8756537303925, 4266.87199384019, 4312.266914624522, 4507.414036175276, 3493.1965647900615, 3609.3864043112208, 3612.710983121344, 3704.6107709608896, 3818.205443441578, 1283.5700040486354, 1292.8319318488536, 1293.624848793858, 1303.7262174943178, 1326.6285440076795, 845.5983407881207, 847.4999750147442, 866.8786369908217, 888.036480418753, 888.2361169394316, 5375.139977603643, 5454.8909021819345, 5540.584456165723, 5618.4662457066515, 5800.738966746507, 827.437342607033, 833.125218520551, 850.8723691446332, 858.4076986879033, 866.9653213871501, 3581.6239294874185, 3608.0979755061235, 3635.690966267897, 3657.1040095176318, 3755.661990420875, 9775.951120244354, 10249.590016399261, 10253.84619230712, 10293.330933489298, 10310.587576497006, 10040.146587539995, 10159.542820573091, 10284.434356110485, 10284.588616455258, 10302.896971030345, 7439.293267139613, 7589.392848572101, 7590.620468976639, 7593.126790419173, 7609.619519024027, 5314.415414304346, 5371.623986321077, 5424.783008679767, 5431.456854314537, 5466.535344495763, 9025.458472491671, 9054.954725226331, 9129.224015958718, 9280.071992800937, 9494.667686630935, 9254.444733315753, 9308.348415610842, 9558.665446709332, 9584.808303834025, 9694.660686875926, 7346.191918889025, 7367.1527774304495, 7484.812879678052, 7485.47601667878, 7488.026556547614, 6783.152105986752, 6933.237343892269, 7559.84544404842, 7876.684932602631, 7895.171007044178, 6987.336203060701, 7153.177384600629, 7169.139703235645, 7218.602976836114, 7266.527675701062, 6954.965225173842, 6998.090248267693, 7072.469564782559, 7092.25531319204, 7108.609026503592, 6297.937020629918, 6378.872422551616, 6455.064015717789, 6515.771947981798, 6518.902216466662, 4585.862424127282, 4757.09615173116, 4799.448063472606, 4836.105320515716, 4997.0505603935135, 4892.706437613754, 4927.457979622167, 5119.513646203604, 5122.743862806919, 5174.767135478837], "value": 4324.980534851701, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [325.3915178615987, 334.83258370814593, 336.08081896014403, 337.76356550414687, 340.4501729706524, 5163.302954101196, 5226.634135610509, 5307.628466007376, 5321.733913304334, 5322.0, 5071.011152825201, 5179.4561571035065, 5210.7655155518, 5213.0, 5245.505031066147, 4130.78141948126, 4133.214689209056, 4136.31750761124, 4151.916961660765, 4162.480694546492, 3866.1107945172485, 3886.300465916134, 4145.129522800215, 4166.999920019189, 4170.475034587476, 4087.9591204088024, 4102.261592913274, 4104.486939132608, 4108.383742438643, 4127.690423218271, 4088.938665919984, 4105.815238314283, 4113.197926404352, 4116.135611521584, 4134.50385953686, 3661.743677942545, 3665.9450108248398, 3666.3400587894166, 3666.6883314918264, 3681.318955993123, 5013.448520662724, 5068.921742085764, 5079.466656001141, 5092.26162206478, 5099.4390617032095, 4615.46922103959, 4658.34783130362, 4677.695949763254, 4689.241534424591, 4703.15343238217, 5421.620486565942, 5462.235287059815, 5463.344398672145, 5492.670439773587, 5533.9839787315605, 3837.6737977271964, 3962.4546426893535, 3978.622030907059, 3978.6817054635558, 3996.4205190247544, 5615.298087739033, 5616.971915140398, 5629.425314925011, 5636.774529018834, 5671.461211184889, 4075.9388609170887, 4087.91824163521, 4088.3049881520215, 4093.8362465501045, 4113.930378101655, 4061.7969101545395, 4120.855770048094, 4123.793810309473, 4127.855525056609, 4145.253854306194, 4658.836940707059, 4670.486246512949, 4687.882802929886, 4711.764411779397, 4717.575418212377, 5465.316835395575, 5507.815819598725, 5533.1976863354585, 5544.805931792368, 5556.638623537178, 1344.475654494748, 1351.2838195756265, 1358.843732970721, 1369.452219112363, 1373.3339330424735, 970.5147426286857, 972.0571046085286, 983.8081574093127, 985.2561316206362, 986.4229425785852, 5156.690598564098, 5158.277841102249, 5185.351831021122, 5196.402413722395, 5208.9739551302, 5367.865803354869, 5397.865053373618, 5404.405515393303, 5415.945840541544, 5445.1832225166545, 4979.875503112451, 5188.0, 5198.506141916512, 5228.712420816815, 5240.371155461369, 2888.6678032026584, 2889.6965818589165, 2890.017394086021, 2893.7974341796294, 2896.724811142938, 5636.478150899235, 5670.914936275959, 5673.234113394721, 5693.373728889819, 5726.4273572642405, 5251.973740131351, 5498.697571633518, 5504.4770746778995, 5522.502974732293, 5594.1608758686525, 5583.533173461215, 5600.411956744565, 5605.635633683797, 5626.1842032905815, 5645.350784659735, 5151.25306830515, 5395.487428694268, 5424.403315635198, 5464.398916119303, 5467.305135408036, 5361.410244872983, 5418.729063546728, 5423.891522169455, 5424.457554244544, 5440.238366628754, 5613.382527921844, 5644.294463192101, 5647.0, 5648.350439699487, 5690.601657883908, 3873.806309684561, 3999.140184860269, 4020.8592699255387, 4024.8390064397095, 4048.190361927685, 5343.866403339947, 5407.486288802557, 5430.511253987002, 5433.239346491573, 5439.0, 5254.422013578427, 5285.814996475105, 5303.284056652303, 5319.6808191508635, 5331.653442526223, 5041.448484034768, 5252.002119597264, 5265.657732247391, 5290.0, 5293.564960118389, 5192.922106168486, 5196.558292545176, 5222.817201397933, 5226.850092979538, 5244.396894357045, 5235.790568377222, 5332.360116786011, 5359.571234301325, 5368.0, 5384.434634363335, 4934.481879402611, 5124.308218390619, 5126.846194614168, 5147.6654017488745, 5168.431472537943], "value": 4140.068465037007, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [645.90311453282, 658.7727234104234, 679.1137565477051, 697.288157573158, 699.4124935054554, 11352.318860868354, 12113.878861211397, 12308.446119924602, 12335.568255111073, 12359.134860559741, 11453.37006464644, 11520.71198220045, 11528.596499122532, 11538.192326537124, 12181.086418518602, 633.616661919539, 642.3383914568002, 643.8583511627435, 644.2655372874926, 644.6841047886526, 552.3206456059049, 562.1371195215345, 622.8287221014212, 635.793367155674, 637.8022812928007, 669.2370697404962, 669.6718607882127, 674.8953912143601, 689.5586824432368, 711.3882061427169, 665.4942243894626, 665.7436886798569, 665.9067730517731, 672.4721093941257, 679.9320067993161, 427.2224551316605, 449.63130233208784, 486.4187296181065, 489.82121525642884, 511.4195388234344, 11298.774024519545, 11300.660980170607, 11309.547618095266, 11359.829602555885, 11484.196106272564, 12220.20568663043, 12386.32784574089, 12575.685607859785, 12602.873971260262, 12747.04397170216, 12416.503339866395, 12425.192362496498, 12438.875611243953, 12813.97488200951, 13228.27244501552, 4089.427480152781, 4101.958980410217, 4143.109231515239, 4159.396887451303, 4314.71954322968, 80711.0, 81291.9999999994, 81662.59168704179, 81968.18031819665, 83824.0, 9482.146606805421, 9716.31985761004, 9726.562304696306, 9795.902040979641, 9953.900460995297, 16291.83708162927, 16326.918365408097, 16638.3344666212, 16750.4137355192, 16800.07599582035, 7160.606166660884, 7189.7483588074165, 7252.782416527512, 7381.11426628808, 7385.963070184722, 4042.939355909664, 4127.669786417079, 4167.708260421802, 4177.770222637784, 4191.832326706897, 2837.716228377146, 2918.620579324717, 2922.1087568291873, 2937.7796665250194, 2966.391889662614, 480.2771828398238, 490.3625287126721, 506.3923292049555, 521.3561251853957, 531.8537402214345, 568.4542838874644, 588.6056342250703, 595.3867516458055, 596.1296507099596, 609.1289456077851, 8861.955690221508, 9259.907400926038, 9271.397359171633, 9311.860322095039, 9515.762105947406, 588.9676067816225, 591.2934043817596, 604.6251324179037, 625.1778910732372, 634.6255709131542, 4585.518520555361, 4601.4248218972625, 4604.1712491751805, 4680.3915490985955, 4699.694519856198, 82291.58854205691, 84436.57781711176, 84444.57777711072, 88109.55945220361, 88215.55892220497, 73847.63076184691, 75328.24671753212, 77144.22855771483, 80699.0, 80731.0, 70823.0, 71841.0, 73382.63308683422, 74826.0, 75867.62066189633, 8676.175763302475, 8913.598888049924, 8935.106489351012, 9107.726768196964, 9271.162705540564, 44227.0, 46218.0, 47784.0, 47833.28250076321, 50350.2447463281, 52761.47238527566, 53082.2037669443, 54888.0, 59864.0, 60366.39633603608, 11760.785776451572, 11767.705807354885, 11953.820692689791, 11956.30585898709, 12648.873511265137, 14321.856781432052, 14589.394044699318, 14632.43157602919, 15164.848351516344, 15579.376824927329, 13231.338433078115, 13636.590902272948, 13681.521146759816, 13768.518101866386, 14321.28393580296, 13812.792808108088, 13981.44074237019, 14436.494722685076, 14598.0, 14914.925425372803, 12815.679608009874, 12822.935885320887, 12999.740005200032, 13498.122622029538, 13606.727865442437, 10085.546150423103, 10521.105706015074, 10578.41818699948, 10613.681589552325, 11174.888251117385, 9145.954270228607, 9532.618695252113, 9804.55879485439, 9989.200863931013, 10352.896471035494], "value": 6590.8182563134615, "unit": "score"}], "name": "dromaeo_css", "value": 6821.7437625810035, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 111.0, 112.0, 111.0, 113.0, 113.0, 112.0, 111.0, 111.0, 111.0], "value": 111.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 126.0, 123.0, 184.0, 131.0, 125.0, 125.0, 124.0, 150.0, 123.0], "value": 135.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 161.0, 160.0, 159.0, 161.0, 161.0, 160.0, 160.0, 160.0], "value": 160.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 112.0, 76.0, 76.0, 75.0, 76.0, 94.0, 76.0], "value": 81.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 110.0, 84.0, 83.0, 83.0, 102.0, 83.0, 82.0, 116.0], "value": 90.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 119.0, 118.0, 118.0, 117.0, 117.0, 118.0, 118.0, 118.0, 118.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 145.0, 145.0, 146.0, 147.0, 146.0, 146.0, 147.0, 148.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 53.0, 54.0, 54.0, 55.0, 55.0, 54.0, 53.0, 53.0], "value": 53.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 62.0, 61.0, 63.0, 62.0, 62.0, 62.0, 64.0, 63.0], "value": 62.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 81.0, 81.0, 80.0, 84.0, 86.0, 87.0, 80.0, 89.0], "value": 83.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 143.0, 132.0, 144.0, 133.0, 133.0, 133.0, 134.0, 179.0, 131.0], "value": 140.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 164.0, 164.0, 163.0, 164.0, 166.0, 166.0, 165.0, 169.0, 165.0], "value": 165.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 65.0, 65.0, 67.0, 64.0, 65.0, 65.0, 64.0], "value": 65.2, "unit": "score"}], "name": "kraken", "value": 1509.0, "alertThreshold": 2.0}]} 15:44:20 INFO - Return code: 0 15:44:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:44:20 INFO - # TBPL SUCCESS # 15:44:20 INFO - Running post-action listener: _resource_record_post_action 15:44:20 INFO - [mozharness: 2016-11-26 23:44:20.458868Z] Finished run-tests step (success) 15:44:20 INFO - Running post-run listener: _resource_record_post_run 15:44:20 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 221184; Write bytes: 392290304; Read time: 28; Write time: 212556 15:44:20 INFO - TinderboxPrint: CPU usage
13.1% 15:44:20 INFO - TinderboxPrint: I/O read bytes / time
221,184 / 28 15:44:20 INFO - TinderboxPrint: I/O write bytes / time
392,290,304 / 212,556 15:44:20 INFO - TinderboxPrint: CPU idle
8,294.0 (86.8%) 15:44:20 INFO - TinderboxPrint: CPU user
1,207.2 (12.6%) 15:44:20 INFO - TinderboxPrint: Swap in / out
0 / 0 15:44:20 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103964672; Read time: 0; Write time: 55204 15:44:20 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 217088; Write bytes: 288325632; Read time: 28; Write time: 157352 15:44:21 INFO - Running post-run listener: _upload_blobber_files 15:44:21 INFO - Blob upload gear active. 15:44:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:44:21 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 15:44:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:44:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:44:21 INFO - (blobuploader) - INFO - Open directory for files ... 15:44:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:44:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:44:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:44:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:44:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:44:22 INFO - (blobuploader) - INFO - Done attempting. 15:44:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:44:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:44:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:44:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:44:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:44:23 INFO - (blobuploader) - INFO - Done attempting. 15:44:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:44:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:44:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:44:27 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:44:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:44:27 INFO - (blobuploader) - INFO - Done attempting. 15:44:27 INFO - (blobuploader) - INFO - Iteration through files over. 15:44:27 INFO - Return code: 0 15:44:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:44:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:44:27 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/dd096463d680c1aac4d268abdd23c1525d82f2b6b425a8f29c4d4d9f35f640ef1ac22612ab54db7495d81d081d0d0e4b0fd2da5635390e21990241d549afa6b6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9c94d19eb199af57abf7249d743c48b6b42108e0b343258c7225195c96aeb1cd3257e60195bc84181a702eef13f721addce6c6df5cb36d81ca227d8a4496797f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b308261e6efa526e7771c6a600c27063faecb3f273a80ce5b28ff14b4dac61bda58206c6bec90d4ae92998d47d566a3c816183ad8f62afda570caa1a3690b7e1"} 15:44:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:44:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:44:27 INFO - Contents: 15:44:27 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/dd096463d680c1aac4d268abdd23c1525d82f2b6b425a8f29c4d4d9f35f640ef1ac22612ab54db7495d81d081d0d0e4b0fd2da5635390e21990241d549afa6b6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9c94d19eb199af57abf7249d743c48b6b42108e0b343258c7225195c96aeb1cd3257e60195bc84181a702eef13f721addce6c6df5cb36d81ca227d8a4496797f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b308261e6efa526e7771c6a600c27063faecb3f273a80ce5b28ff14b4dac61bda58206c6bec90d4ae92998d47d566a3c816183ad8f62afda570caa1a3690b7e1"} 15:44:27 INFO - Running post-run listener: copy_logs_to_upload_dir 15:44:27 INFO - Copying logs to upload dir... 15:44:27 INFO - mkdir: /builds/slave/test/build/upload/logs 15:44:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.433893 ========= master_lag: 0.96 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-11-26 15:44:27.961641) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-26 15:44:27.964678) ========= 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=337fe3f4b1febe37b85fccc40000019e-1480192974.141195-1379483306 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/dd096463d680c1aac4d268abdd23c1525d82f2b6b425a8f29c4d4d9f35f640ef1ac22612ab54db7495d81d081d0d0e4b0fd2da5635390e21990241d549afa6b6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9c94d19eb199af57abf7249d743c48b6b42108e0b343258c7225195c96aeb1cd3257e60195bc84181a702eef13f721addce6c6df5cb36d81ca227d8a4496797f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b308261e6efa526e7771c6a600c27063faecb3f273a80ce5b28ff14b4dac61bda58206c6bec90d4ae92998d47d566a3c816183ad8f62afda570caa1a3690b7e1"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480192204/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011702 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480192204/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/dd096463d680c1aac4d268abdd23c1525d82f2b6b425a8f29c4d4d9f35f640ef1ac22612ab54db7495d81d081d0d0e4b0fd2da5635390e21990241d549afa6b6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9c94d19eb199af57abf7249d743c48b6b42108e0b343258c7225195c96aeb1cd3257e60195bc84181a702eef13f721addce6c6df5cb36d81ca227d8a4496797f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b308261e6efa526e7771c6a600c27063faecb3f273a80ce5b28ff14b4dac61bda58206c6bec90d4ae92998d47d566a3c816183ad8f62afda570caa1a3690b7e1"}' ========= master_lag: 0.06 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-26 15:44:28.037702) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-26 15:44:28.038010) ========= 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=337fe3f4b1febe37b85fccc40000019e-1480192974.141195-1379483306 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004653 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-26 15:44:28.088013) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-26 15:44:28.091353) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-26 15:44:28.091639) ========= ========= Total master_lag: 1.17 =========