builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-036 starttime: 1479177660.06 results: success (0) buildid: 20161114182935 builduid: 5ed8d1883bc544fbb1f23ffb71e74ba1 revision: be95aa5249cf8d1cf33434273f7c789e332b886d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-14 18:41:00.057299) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-14 18:41:00.057884) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-14 18:41:00.058278) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-14 18:41:00.073639) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 18:41:00.074055) ========= 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=14ef55db36f7623abb31b9cf000001d5-1479177659.525153-1720934038 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-14 18:41:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 220M=0s 2016-11-14 18:41:00 (220 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.083131 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 18:41:00.171839) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 18:41:00.172230) ========= 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=14ef55db36f7623abb31b9cf000001d5-1479177659.525153-1720934038 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019201 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 18:41:00.222609) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 18:41:00.223026) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev be95aa5249cf8d1cf33434273f7c789e332b886d --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 be95aa5249cf8d1cf33434273f7c789e332b886d --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=14ef55db36f7623abb31b9cf000001d5-1479177659.525153-1720934038 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-14 18:41:00,472 truncating revision to first 12 chars 2016-11-14 18:41:00,472 Setting DEBUG logging. 2016-11-14 18:41:00,472 attempt 1/10 2016-11-14 18:41:00,472 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/be95aa5249cf?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-14 18:41:00,784 unpacking tar archive at: mozilla-inbound-be95aa5249cf/testing/mozharness/ program finished with exit code 0 elapsedTime=0.615123 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 18:41:00.853886) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-14 18:41:00.854326) ========= script_repo_revision: be95aa5249cf8d1cf33434273f7c789e332b886d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-14 18:41:00.854975) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-14 18:41:00.855332) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-14 18:41:00.864720) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-11-14 18:41:00.865088) ========= /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=14ef55db36f7623abb31b9cf000001d5-1479177659.525153-1720934038 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:41:01 INFO - MultiFileLogger online at 20161114 18:41:01 in /builds/slave/test 18:41:01 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 18:41:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:41:01 INFO - {'append_to_log': False, 18:41:01 INFO - 'base_work_dir': '/builds/slave/test', 18:41:01 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 18:41:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:41:01 INFO - 'branch': 'Mozilla-Inbound', 18:41:01 INFO - 'buildbot_json_path': 'buildprops.json', 18:41:01 INFO - 'config_files': ('talos/linux_config.py',), 18:41:01 INFO - 'default_actions': ('clobber', 18:41:01 INFO - 'read-buildbot-config', 18:41:01 INFO - 'download-and-extract', 18:41:01 INFO - 'populate-webroot', 18:41:01 INFO - 'create-virtualenv', 18:41:01 INFO - 'install', 18:41:01 INFO - 'run-tests'), 18:41:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:41:01 INFO - 'download_minidump_stackwalk': True, 18:41:01 INFO - 'download_symbols': 'ondemand', 18:41:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:41:01 INFO - 'tooltool.py': '/tools/tooltool.py', 18:41:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:41:01 INFO - '/tools/misc-python/virtualenv.py')}, 18:41:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:41:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:41:01 INFO - 'installer_path': 'installer.exe', 18:41:01 INFO - 'log_level': 'info', 18:41:01 INFO - 'log_name': 'talos', 18:41:01 INFO - 'log_to_console': True, 18:41:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:41:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:41:01 INFO - 'opt_config_files': (), 18:41:01 INFO - 'pip_index': False, 18:41:01 INFO - 'sps_profile': False, 18:41:01 INFO - 'sps_profile_interval': 0, 18:41:01 INFO - 'suite': 'dromaeojs', 18:41:01 INFO - 'system_bits': '32', 18:41:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:41:01 INFO - 'title': 'talos-linux64-ix-036', 18:41:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:41:01 INFO - 'use_talos_json': True, 18:41:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:41:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:41:01 INFO - 'work_dir': 'build'} 18:41:01 INFO - [mozharness: 2016-11-15 02:41:01.208455Z] Running clobber step. 18:41:01 INFO - Running pre-action listener: _resource_record_pre_action 18:41:01 INFO - Running main action method: clobber 18:41:01 INFO - rmtree: /builds/slave/test/build 18:41:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:41:01 INFO - Running post-action listener: _resource_record_post_action 18:41:01 INFO - [mozharness: 2016-11-15 02:41:01.717736Z] Finished clobber step (success) 18:41:01 INFO - [mozharness: 2016-11-15 02:41:01.717835Z] Running read-buildbot-config step. 18:41:01 INFO - Running pre-action listener: _resource_record_pre_action 18:41:01 INFO - Running main action method: read_buildbot_config 18:41:01 INFO - Using buildbot properties: 18:41:01 INFO - { 18:41:01 INFO - "project": "", 18:41:01 INFO - "product": "firefox", 18:41:01 INFO - "script_repo_revision": "production", 18:41:01 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 18:41:01 INFO - "repository": "", 18:41:01 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 18:41:01 INFO - "buildid": "20161114182935", 18:41:01 INFO - "stage_platform": "linux64-pgo", 18:41:01 INFO - "basedir": "/builds/slave/test", 18:41:01 INFO - "buildnumber": 2052, 18:41:01 INFO - "platform": "ubuntu64_hw", 18:41:01 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 18:41:01 INFO - "slavebuilddir": "test", 18:41:01 INFO - "branch": "mozilla-inbound", 18:41:01 INFO - "revision": "be95aa5249cf8d1cf33434273f7c789e332b886d", 18:41:01 INFO - "slavename": "talos-linux64-ix-036", 18:41:01 INFO - "builduid": "5ed8d1883bc544fbb1f23ffb71e74ba1", 18:41:01 INFO - "repo_path": "integration/mozilla-inbound" 18:41:01 INFO - } 18:41:01 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479166498/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 18:41:01 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479166498/firefox-52.0a1.en-US.linux-x86_64.test_packages.json. 18:41:01 INFO - Running post-action listener: _resource_record_post_action 18:41:01 INFO - [mozharness: 2016-11-15 02:41:01.720287Z] Finished read-buildbot-config step (success) 18:41:01 INFO - [mozharness: 2016-11-15 02:41:01.720375Z] Running download-and-extract step. 18:41:01 INFO - Running pre-action listener: _resource_record_pre_action 18:41:01 INFO - Running main action method: download_and_extract 18:41:01 INFO - mkdir: /builds/slave/test/build/tests 18:41:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:41:01 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479166498/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 18:41:01 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479166498/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 18:41:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479166498/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 18:41:01 INFO - Downloaded 1361 bytes. 18:41:01 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 18:41:01 INFO - Using the following test package requirements: 18:41:01 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 18:41:01 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:41:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:41:01 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:41:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:41:01 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:41:01 INFO - u'jsshell-linux-x86_64.zip'], 18:41:01 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:41:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:41:01 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 18:41:01 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:41:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:41:01 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:41:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:41:01 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:41:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:41:01 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:41:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:41:01 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:41:01 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/1479166498/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 18:41:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479166498/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:41:01 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479166498/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 18:41:01 INFO - Http code: 200 18:41:01 INFO - via: 1.1 c0740de9f16cf32ffedfd2f9806b8483.cloudfront.net (CloudFront) 18:41:01 INFO - x-amz-cf-id: 4azkg0xRZnQbzDkPaM742eMjCINNCmT6ZdVVe0StU81da6M5NOuGIA== 18:41:01 INFO - x-amz-replication-status: COMPLETED 18:41:01 INFO - x-amz-version-id: F06opw1mk0cTccY5IzzvARnMe28HN6jn 18:41:02 INFO - Expected file size: 21970222 18:41:02 INFO - Obtained file size: 21970222 18:41:06 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 18:41:06 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/1479166498/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 18:41:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479166498/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:41:06 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479166498/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 18:41:06 INFO - Http code: 200 18:41:06 INFO - via: 1.1 455cf6ccbccc261c46d02110de1c0237.cloudfront.net (CloudFront) 18:41:06 INFO - x-amz-cf-id: 6VMEBKApx7jwIbL7ASMkG5Hb_z14HDOMdZQJF9RjZBoseS8_aCuw-A== 18:41:06 INFO - x-amz-replication-status: COMPLETED 18:41:06 INFO - x-amz-version-id: F06opw1mk0cTccY5IzzvARnMe28HN6jn 18:41:06 INFO - Expected file size: 21970222 18:41:06 INFO - Obtained file size: 21970222 18:41:10 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/1479166498/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 18:41:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479166498/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 18:41:10 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479166498/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 18:41:11 INFO - Http code: 200 18:41:11 INFO - via: 1.1 37af14ee951b12568cf1cc160d08abe6.cloudfront.net (CloudFront) 18:41:11 INFO - x-amz-cf-id: ruHFwVT29H2o9Qtt5gai-qaIj7TmMxROSYEY4UAO15BsKU7VT2Y7tg== 18:41:11 INFO - x-amz-replication-status: COMPLETED 18:41:11 INFO - x-amz-version-id: _32TKuwHTU.cDdI44OJODilxNaLXx4He 18:41:11 INFO - Expected file size: 14409038 18:41:11 INFO - Obtained file size: 14409038 18:41: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')]} 18:41:11 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479166498/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:41:11 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479166498/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:41:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479166498/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 18:41:12 INFO - Downloaded 59527219 bytes. 18:41:12 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479166498/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:41:12 INFO - mkdir: /builds/slave/test/properties 18:41:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:41:12 INFO - Writing to file /builds/slave/test/properties/build_url 18:41:12 INFO - Contents: 18:41:12 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479166498/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:41:12 INFO - Running post-action listener: _resource_record_post_action 18:41:12 INFO - Running post-action listener: set_extra_try_arguments 18:41:12 INFO - [mozharness: 2016-11-15 02:41:12.449317Z] Finished download-and-extract step (success) 18:41:12 INFO - [mozharness: 2016-11-15 02:41:12.449545Z] Running populate-webroot step. 18:41:12 INFO - Running pre-action listener: _resource_record_pre_action 18:41:12 INFO - Running main action method: populate_webroot 18:41:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:41:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:41:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:41:12 INFO - '--tppagecycles', 18:41:12 INFO - '7'], 18:41:12 INFO - 'tests': ['tsvgm']}}, 18:41:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:41:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:41:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:41:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:41:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:41:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:41:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:41:12 INFO - 'talos_options': ['--disable-e10s'], 18:41:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:41:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:41:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:41:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:41:12 INFO - 'talos_options': ['--disable-e10s'], 18:41:12 INFO - 'tests': ['damp', 'tps']}, 18:41:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:41:12 INFO - 'tests': ['damp', 'tps']}, 18:41:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:41:12 INFO - 'tests': ['dromaeo_dom']}, 18:41:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:41:12 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:41:12 INFO - 'tests': ['basic_compositor_video']}, 18:41:12 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:41:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:41:12 INFO - 'tests': ['a11yr', 18:41:12 INFO - 'ts_paint', 18:41:12 INFO - 'tpaint', 18:41:12 INFO - 'sessionrestore', 18:41:12 INFO - 'sessionrestore_no_auto_restore', 18:41:12 INFO - 'tabpaint']}, 18:41:12 INFO - 'other-e10s': {'tests': ['a11yr', 18:41:12 INFO - 'ts_paint', 18:41:12 INFO - 'tpaint', 18:41:12 INFO - 'sessionrestore', 18:41:12 INFO - 'sessionrestore_no_auto_restore', 18:41:12 INFO - 'tabpaint']}, 18:41:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:41:12 INFO - 'ts_paint', 18:41:12 INFO - 'tpaint', 18:41:12 INFO - 'sessionrestore', 18:41:12 INFO - 'sessionrestore_no_auto_restore', 18:41:12 INFO - 'tabpaint']}, 18:41:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:41:12 INFO - 'ts_paint', 18:41:12 INFO - 'tpaint', 18:41:12 INFO - 'sessionrestore', 18:41:12 INFO - 'sessionrestore_no_auto_restore', 18:41:12 INFO - 'tabpaint']}, 18:41:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:41:12 INFO - 'tests': ['a11yr', 18:41:12 INFO - 'ts_paint', 18:41:12 INFO - 'tpaint', 18:41:12 INFO - 'sessionrestore', 18:41:12 INFO - 'sessionrestore_no_auto_restore', 18:41:12 INFO - 'tabpaint']}, 18:41:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:41:12 INFO - 'tests': ['a11yr', 18:41:12 INFO - 'ts_paint', 18:41:12 INFO - 'tpaint', 18:41:12 INFO - 'sessionrestore', 18:41:12 INFO - 'sessionrestore_no_auto_restore', 18:41:12 INFO - 'tabpaint']}, 18:41:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:41:12 INFO - 'tests': ['tsvgx', 18:41:12 INFO - 'tsvgr_opacity', 18:41:12 INFO - 'tart', 18:41:12 INFO - 'tscrollx', 18:41:12 INFO - 'cart']}, 18:41:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:41:12 INFO - 'tsvgr_opacity', 18:41:12 INFO - 'tart', 18:41:12 INFO - 'tscrollx', 18:41:12 INFO - 'cart']}, 18:41:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:41:12 INFO - 'talos_options': ['--disable-e10s'], 18:41:12 INFO - 'tests': ['tp5o']}, 18:41:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:41:12 INFO - 'tests': ['tp5o']}, 18:41:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:41:12 INFO - 'talos_options': ['--disable-e10s', 18:41:12 INFO - '--xperf_path', 18:41:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:41:12 INFO - 'tests': ['tp5n']}, 18:41:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:41:12 INFO - 'talos_options': ['--xperf_path', 18:41:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:41:12 INFO - 'tests': ['tp5n']}}, 18:41:12 INFO - 'talos.zip': {'path': '', 18:41:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:41:12 INFO - Running post-action listener: _resource_record_post_action 18:41:12 INFO - [mozharness: 2016-11-15 02:41:12.469393Z] Finished populate-webroot step (success) 18:41:12 INFO - [mozharness: 2016-11-15 02:41:12.469481Z] Running create-virtualenv step. 18:41:12 INFO - Running pre-action listener: _resource_record_pre_action 18:41:12 INFO - Running main action method: create_virtualenv 18:41:12 INFO - Creating virtualenv /builds/slave/test/build/venv 18:41:12 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 18:41:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:41:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:41:12 INFO - Using real prefix '/usr' 18:41:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:41:13 INFO - Installing distribute.............................................................................................................................................................................................done. 18:41:15 INFO - Installing pip.................done. 18:41:15 INFO - Return code: 0 18:41:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:41:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:41:15 INFO - Reading from file tmpfile_stdout 18:41:15 INFO - Output received: 18:41:15 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 18:41:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:41: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')]} 18:41:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:41:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41: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')]} 18:41:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:41:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:15 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 0x7f490e2edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19b9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b6f60>, '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 0x19b7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19b81d0>, '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': '14ef55db36f7623abb31b9cf000001d5-1479177659.525153-1720934038', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:41:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:41:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:41:15 INFO - Using env: {'DISPLAY': ':0', 18:41:15 INFO - 'HOME': '/home/cltbld', 18:41:15 INFO - 'LANG': 'en_US.UTF-8', 18:41:15 INFO - 'LANGUAGE': 'en_US:en', 18:41:15 INFO - 'LOGNAME': 'cltbld', 18:41:15 INFO - 'MAIL': '/var/mail/cltbld', 18:41:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:41:15 INFO - 'MOZ_NO_REMOTE': '1', 18:41:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:41:15 INFO - 'NO_EM_RESTART': '1', 18:41:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:41:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:41:15 INFO - 'PWD': '/builds/slave/test', 18:41:15 INFO - 'SHELL': '/bin/bash', 18:41:15 INFO - 'SHLVL': '1', 18:41:15 INFO - 'TERM': 'linux', 18:41:15 INFO - 'TMOUT': '86400', 18:41:15 INFO - 'USER': 'cltbld', 18:41:15 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1479177659.525153-1720934038', 18:41:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:41:15 INFO - '_': '/tools/buildbot/bin/python'} 18:41:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:41:15 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 18:41:15 INFO - Cleaning up... 18:41:15 INFO - Return code: 0 18:41:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:41: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')]} 18:41:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:41:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41: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')]} 18:41:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:41:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:15 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 0x7f490e2edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19b9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b6f60>, '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 0x19b7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19b81d0>, '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': '14ef55db36f7623abb31b9cf000001d5-1479177659.525153-1720934038', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:41:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 18:41:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 18:41:15 INFO - Using env: {'DISPLAY': ':0', 18:41:15 INFO - 'HOME': '/home/cltbld', 18:41:15 INFO - 'LANG': 'en_US.UTF-8', 18:41:15 INFO - 'LANGUAGE': 'en_US:en', 18:41:15 INFO - 'LOGNAME': 'cltbld', 18:41:15 INFO - 'MAIL': '/var/mail/cltbld', 18:41:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:41:15 INFO - 'MOZ_NO_REMOTE': '1', 18:41:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:41:15 INFO - 'NO_EM_RESTART': '1', 18:41:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:41:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:41:15 INFO - 'PWD': '/builds/slave/test', 18:41:15 INFO - 'SHELL': '/bin/bash', 18:41:15 INFO - 'SHLVL': '1', 18:41:15 INFO - 'TERM': 'linux', 18:41:15 INFO - 'TMOUT': '86400', 18:41:15 INFO - 'USER': 'cltbld', 18:41:15 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1479177659.525153-1720934038', 18:41:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:41:15 INFO - '_': '/tools/buildbot/bin/python'} 18:41:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:41:15 INFO - Downloading/unpacking psutil>=3.1.1 18:41:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:41:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:41:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:41:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:41:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:41:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:41:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:41:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:41:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:41:17 INFO - Installing collected packages: psutil 18:41:17 INFO - Running setup.py install for psutil 18:41:17 INFO - building 'psutil._psutil_linux' extension 18:41:17 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 18:41:17 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 18:41:17 INFO - building 'psutil._psutil_posix' extension 18:41:17 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 18:41:18 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 18:41:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:41:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:41:18 INFO - Successfully installed psutil 18:41:18 INFO - Cleaning up... 18:41:18 INFO - Return code: 0 18:41:18 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:41:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:41:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:41:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:41:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:41:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f490e2edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19b9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b6f60>, '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 0x19b7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19b81d0>, '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': '14ef55db36f7623abb31b9cf000001d5-1479177659.525153-1720934038', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:41:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 18:41:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 18:41:18 INFO - Using env: {'DISPLAY': ':0', 18:41:18 INFO - 'HOME': '/home/cltbld', 18:41:18 INFO - 'LANG': 'en_US.UTF-8', 18:41:18 INFO - 'LANGUAGE': 'en_US:en', 18:41:18 INFO - 'LOGNAME': 'cltbld', 18:41:18 INFO - 'MAIL': '/var/mail/cltbld', 18:41:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:41:18 INFO - 'MOZ_NO_REMOTE': '1', 18:41:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:41:18 INFO - 'NO_EM_RESTART': '1', 18:41:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:41:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:41:18 INFO - 'PWD': '/builds/slave/test', 18:41:18 INFO - 'SHELL': '/bin/bash', 18:41:18 INFO - 'SHLVL': '1', 18:41:18 INFO - 'TERM': 'linux', 18:41:18 INFO - 'TMOUT': '86400', 18:41:18 INFO - 'USER': 'cltbld', 18:41:18 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1479177659.525153-1720934038', 18:41:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:41:18 INFO - '_': '/tools/buildbot/bin/python'} 18:41:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:41:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:41:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:41:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:41:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:41:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:41:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:41:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:41:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:41:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:41:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:41:20 INFO - Installing collected packages: mozsystemmonitor 18:41:20 INFO - Running setup.py install for mozsystemmonitor 18:41:20 INFO - Successfully installed mozsystemmonitor 18:41:20 INFO - Cleaning up... 18:41:20 INFO - Return code: 0 18:41:20 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:41:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:41:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:41:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:41:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:41:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:20 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 0x7f490e2edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19b9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b6f60>, '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 0x19b7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19b81d0>, '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': '14ef55db36f7623abb31b9cf000001d5-1479177659.525153-1720934038', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:41:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 18:41:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 18:41:20 INFO - Using env: {'DISPLAY': ':0', 18:41:20 INFO - 'HOME': '/home/cltbld', 18:41:20 INFO - 'LANG': 'en_US.UTF-8', 18:41:20 INFO - 'LANGUAGE': 'en_US:en', 18:41:20 INFO - 'LOGNAME': 'cltbld', 18:41:20 INFO - 'MAIL': '/var/mail/cltbld', 18:41:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:41:20 INFO - 'MOZ_NO_REMOTE': '1', 18:41:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:41:20 INFO - 'NO_EM_RESTART': '1', 18:41:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:41:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:41:20 INFO - 'PWD': '/builds/slave/test', 18:41:20 INFO - 'SHELL': '/bin/bash', 18:41:20 INFO - 'SHLVL': '1', 18:41:20 INFO - 'TERM': 'linux', 18:41:20 INFO - 'TMOUT': '86400', 18:41:20 INFO - 'USER': 'cltbld', 18:41:20 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1479177659.525153-1720934038', 18:41:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:41:20 INFO - '_': '/tools/buildbot/bin/python'} 18:41:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:41:20 INFO - Downloading/unpacking jsonschema==2.5.1 18:41:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:41:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:41:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:41:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:41:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:41:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:41:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:41:22 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:41:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:41:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:41:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:41:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:41:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:41:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:41:22 INFO - Downloading functools32-3.2.3-2.tar.gz 18:41:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:41:23 INFO - warning: no files found matching '*.txt' 18:41:23 INFO - no previously-included directories found matching 'build' 18:41:23 INFO - no previously-included directories found matching 'dist' 18:41:23 INFO - no previously-included directories found matching '.git*' 18:41:23 INFO - Installing collected packages: jsonschema, functools32 18:41:23 INFO - Running setup.py install for functools32 18:41:23 INFO - warning: no files found matching '*.txt' 18:41:23 INFO - no previously-included directories found matching 'build' 18:41:23 INFO - no previously-included directories found matching 'dist' 18:41:23 INFO - no previously-included directories found matching '.git*' 18:41:23 INFO - Successfully installed jsonschema functools32 18:41:23 INFO - Cleaning up... 18:41:23 INFO - Return code: 0 18:41:23 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:41:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:41:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:41:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:41:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:41:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f490e2edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19b9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b6f60>, '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 0x19b7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19b81d0>, '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': '14ef55db36f7623abb31b9cf000001d5-1479177659.525153-1720934038', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:41:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 18:41:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 18:41:23 INFO - Using env: {'DISPLAY': ':0', 18:41:23 INFO - 'HOME': '/home/cltbld', 18:41:23 INFO - 'LANG': 'en_US.UTF-8', 18:41:23 INFO - 'LANGUAGE': 'en_US:en', 18:41:23 INFO - 'LOGNAME': 'cltbld', 18:41:23 INFO - 'MAIL': '/var/mail/cltbld', 18:41:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:41:23 INFO - 'MOZ_NO_REMOTE': '1', 18:41:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:41:23 INFO - 'NO_EM_RESTART': '1', 18:41:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:41:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:41:23 INFO - 'PWD': '/builds/slave/test', 18:41:23 INFO - 'SHELL': '/bin/bash', 18:41:23 INFO - 'SHLVL': '1', 18:41:23 INFO - 'TERM': 'linux', 18:41:23 INFO - 'TMOUT': '86400', 18:41:23 INFO - 'USER': 'cltbld', 18:41:23 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1479177659.525153-1720934038', 18:41:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:41:23 INFO - '_': '/tools/buildbot/bin/python'} 18:41:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:41:23 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:41:23 INFO - Cleaning up... 18:41:23 INFO - Return code: 0 18:41:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:41:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:41:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:41:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:41:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:41:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f490e2edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19b9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b6f60>, '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 0x19b7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19b81d0>, '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': '14ef55db36f7623abb31b9cf000001d5-1479177659.525153-1720934038', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:41:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:41:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:41:23 INFO - Using env: {'DISPLAY': ':0', 18:41:23 INFO - 'HOME': '/home/cltbld', 18:41:23 INFO - 'LANG': 'en_US.UTF-8', 18:41:23 INFO - 'LANGUAGE': 'en_US:en', 18:41:23 INFO - 'LOGNAME': 'cltbld', 18:41:23 INFO - 'MAIL': '/var/mail/cltbld', 18:41:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:41:23 INFO - 'MOZ_NO_REMOTE': '1', 18:41:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:41:23 INFO - 'NO_EM_RESTART': '1', 18:41:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:41:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:41:23 INFO - 'PWD': '/builds/slave/test', 18:41:23 INFO - 'SHELL': '/bin/bash', 18:41:23 INFO - 'SHLVL': '1', 18:41:23 INFO - 'TERM': 'linux', 18:41:23 INFO - 'TMOUT': '86400', 18:41:23 INFO - 'USER': 'cltbld', 18:41:23 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1479177659.525153-1720934038', 18:41:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:41:23 INFO - '_': '/tools/buildbot/bin/python'} 18:41:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:41:23 INFO - Downloading/unpacking blobuploader==1.2.4 18:41:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:41:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:41:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:41:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:41:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:41:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:41:25 INFO - Downloading blobuploader-1.2.4.tar.gz 18:41:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:41:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:41:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:41:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:41:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:41:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:41:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:41:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:41:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:41:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:41:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:41:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:41:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:41:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:41:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:41:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:41:26 INFO - Downloading docopt-0.6.1.tar.gz 18:41:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:41:26 INFO - Installing collected packages: blobuploader, requests, docopt 18:41:26 INFO - Running setup.py install for blobuploader 18:41:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:41:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:41:26 INFO - Running setup.py install for requests 18:41:26 INFO - Running setup.py install for docopt 18:41:26 INFO - Successfully installed blobuploader requests docopt 18:41:26 INFO - Cleaning up... 18:41:26 INFO - Return code: 0 18:41:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:41:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:41:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:41:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:41:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:41:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:26 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 0x7f490e2edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19b9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b6f60>, '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 0x19b7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19b81d0>, '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': '14ef55db36f7623abb31b9cf000001d5-1479177659.525153-1720934038', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:41:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:41:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:41:26 INFO - Using env: {'DISPLAY': ':0', 18:41:26 INFO - 'HOME': '/home/cltbld', 18:41:26 INFO - 'LANG': 'en_US.UTF-8', 18:41:26 INFO - 'LANGUAGE': 'en_US:en', 18:41:26 INFO - 'LOGNAME': 'cltbld', 18:41:26 INFO - 'MAIL': '/var/mail/cltbld', 18:41:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:41:26 INFO - 'MOZ_NO_REMOTE': '1', 18:41:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:41:26 INFO - 'NO_EM_RESTART': '1', 18:41:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:41:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:41:26 INFO - 'PWD': '/builds/slave/test', 18:41:26 INFO - 'SHELL': '/bin/bash', 18:41:26 INFO - 'SHLVL': '1', 18:41:26 INFO - 'TERM': 'linux', 18:41:26 INFO - 'TMOUT': '86400', 18:41:26 INFO - 'USER': 'cltbld', 18:41:26 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1479177659.525153-1720934038', 18:41:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:41:26 INFO - '_': '/tools/buildbot/bin/python'} 18:41:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:41:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:41:27 INFO - Running setup.py (path:/tmp/pip-ls4JFk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:41:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:41:27 INFO - Running setup.py (path:/tmp/pip-PNmUGo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:41:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:41:27 INFO - Running setup.py (path:/tmp/pip-0Dzm3y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:41:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:41:27 INFO - Running setup.py (path:/tmp/pip-ZRsKjU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:41:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:41:27 INFO - Running setup.py (path:/tmp/pip-itvtJs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:41:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:41:27 INFO - Running setup.py (path:/tmp/pip-k5Huzm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:41:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:41:27 INFO - Running setup.py (path:/tmp/pip-pVZy2V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:41:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:41:27 INFO - Running setup.py (path:/tmp/pip-F9oShO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:41:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:41:27 INFO - Running setup.py (path:/tmp/pip-brUT0V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:41:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:41:27 INFO - Running setup.py (path:/tmp/pip-TgAl0Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:41:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:41:27 INFO - Running setup.py (path:/tmp/pip-T9VPGZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:41:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:41:27 INFO - Running setup.py (path:/tmp/pip-8p1L4L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:41:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:41:28 INFO - Running setup.py (path:/tmp/pip-B1m6jK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:41:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:41:28 INFO - Running setup.py (path:/tmp/pip-xpG1xs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:41:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:41:28 INFO - Running setup.py (path:/tmp/pip-t80Qyj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:41:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:41:28 INFO - Running setup.py (path:/tmp/pip-gfV421-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:41:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:41:28 INFO - Running setup.py (path:/tmp/pip-fbObG0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:41:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:41:28 INFO - Running setup.py install for manifestparser 18:41:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:41:28 INFO - Running setup.py install for mozcrash 18:41:28 INFO - Running setup.py install for mozdebug 18:41:28 INFO - Running setup.py install for mozdevice 18:41:28 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:41:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:41:28 INFO - Running setup.py install for mozfile 18:41:28 INFO - Running setup.py install for mozhttpd 18:41:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:41:29 INFO - Running setup.py install for mozinfo 18:41:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:41:29 INFO - Running setup.py install for mozInstall 18:41:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:41:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:41:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:41:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:41:29 INFO - Running setup.py install for mozleak 18:41:29 INFO - Running setup.py install for mozlog 18:41:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:41:29 INFO - Running setup.py install for moznetwork 18:41:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:41:29 INFO - Running setup.py install for mozprocess 18:41:29 INFO - Running setup.py install for mozprofile 18:41:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:41:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:41:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:41:29 INFO - Running setup.py install for mozrunner 18:41:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:41:29 INFO - Running setup.py install for mozscreenshot 18:41:30 INFO - Running setup.py install for moztest 18:41:30 INFO - Running setup.py install for mozversion 18:41:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:41:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:41:30 INFO - Cleaning up... 18:41:30 INFO - Return code: 0 18:41:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:41:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:41:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:41:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:41:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:41:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:30 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 0x7f490e2edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19b9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b6f60>, '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 0x19b7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19b81d0>, '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': '14ef55db36f7623abb31b9cf000001d5-1479177659.525153-1720934038', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:41:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:41:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:41:30 INFO - Using env: {'DISPLAY': ':0', 18:41:30 INFO - 'HOME': '/home/cltbld', 18:41:30 INFO - 'LANG': 'en_US.UTF-8', 18:41:30 INFO - 'LANGUAGE': 'en_US:en', 18:41:30 INFO - 'LOGNAME': 'cltbld', 18:41:30 INFO - 'MAIL': '/var/mail/cltbld', 18:41:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:41:30 INFO - 'MOZ_NO_REMOTE': '1', 18:41:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:41:30 INFO - 'NO_EM_RESTART': '1', 18:41:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:41:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:41:30 INFO - 'PWD': '/builds/slave/test', 18:41:30 INFO - 'SHELL': '/bin/bash', 18:41:30 INFO - 'SHLVL': '1', 18:41:30 INFO - 'TERM': 'linux', 18:41:30 INFO - 'TMOUT': '86400', 18:41:30 INFO - 'USER': 'cltbld', 18:41:30 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1479177659.525153-1720934038', 18:41:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:41:30 INFO - '_': '/tools/buildbot/bin/python'} 18:41:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:41:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:41:30 INFO - Running setup.py (path:/tmp/pip-2_f0Ws-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:41:30 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 18:41:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:41:30 INFO - Running setup.py (path:/tmp/pip-p42CSV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:41:30 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)) 18:41:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:41:30 INFO - Running setup.py (path:/tmp/pip-DIpiNG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:41:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:41:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:41:30 INFO - Running setup.py (path:/tmp/pip-Vjv_r6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:41:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:41:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:41:30 INFO - Running setup.py (path:/tmp/pip-qQjSmk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:41:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 18:41:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:41:30 INFO - Running setup.py (path:/tmp/pip-Ihe0U3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:41:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 18:41:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:41:30 INFO - Running setup.py (path:/tmp/pip-WsZ6J_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:41:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 18:41:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:41:30 INFO - Running setup.py (path:/tmp/pip-YlbEI6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:41:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 18:41:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:41:31 INFO - Running setup.py (path:/tmp/pip-fL6MVy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:41:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 18:41:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:41:31 INFO - Running setup.py (path:/tmp/pip-PDhM71-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:41:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:41:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:41:31 INFO - Running setup.py (path:/tmp/pip-hPJoBH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:41:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 18:41:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:41:31 INFO - Running setup.py (path:/tmp/pip-SUCUjv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:41:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 18:41:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:41:31 INFO - Running setup.py (path:/tmp/pip-lg87x3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:41:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 18:41:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:41:31 INFO - Running setup.py (path:/tmp/pip-iaqKdK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:41:31 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)) 18:41:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:41:31 INFO - Running setup.py (path:/tmp/pip-6Jfz8F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:41:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 18:41:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:41:31 INFO - Running setup.py (path:/tmp/pip-xTTNXo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:41:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 18:41:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:41:31 INFO - Running setup.py (path:/tmp/pip-QJbAi1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:41:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 18:41:31 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)) 18:41:31 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)) 18:41:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:41:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:41:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:41:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:41:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:41:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:41:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:41:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:41:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:41:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:41:33 INFO - Downloading blessings-1.6.tar.gz 18:41:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:41:33 INFO - Installing collected packages: blessings 18:41:33 INFO - Running setup.py install for blessings 18:41:33 INFO - Successfully installed blessings 18:41:33 INFO - Cleaning up... 18:41:33 INFO - Return code: 0 18:41:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:41:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:41:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:41:34 INFO - Reading from file tmpfile_stdout 18:41:34 INFO - Current package versions: 18:41:34 INFO - argparse == 1.2.1 18:41:34 INFO - blessings == 1.6 18:41:34 INFO - blobuploader == 1.2.4 18:41:34 INFO - docopt == 0.6.1 18:41:34 INFO - functools32 == 3.2.3-2 18:41:34 INFO - jsonschema == 2.5.1 18:41:34 INFO - manifestparser == 1.1 18:41:34 INFO - mozInstall == 1.12 18:41:34 INFO - mozcrash == 1.0 18:41:34 INFO - mozdebug == 0.1 18:41:34 INFO - mozdevice == 0.48 18:41:34 INFO - mozfile == 1.2 18:41:34 INFO - mozhttpd == 0.7 18:41:34 INFO - mozinfo == 0.9 18:41:34 INFO - mozleak == 0.1 18:41:34 INFO - mozlog == 3.4 18:41:34 INFO - moznetwork == 0.27 18:41:34 INFO - mozprocess == 0.23 18:41:34 INFO - mozprofile == 0.28 18:41:34 INFO - mozrunner == 6.13 18:41:34 INFO - mozscreenshot == 0.1 18:41:34 INFO - mozsystemmonitor == 0.3 18:41:34 INFO - moztest == 0.7 18:41:34 INFO - mozversion == 1.4 18:41:34 INFO - psutil == 3.1.1 18:41:34 INFO - requests == 1.2.3 18:41:34 INFO - wsgiref == 0.1.2 18:41:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:41:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:41:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:41:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:41:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:41:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:34 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 0x7f490e2edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19b9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b6f60>, '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 0x19b7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19b81d0>, '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': '14ef55db36f7623abb31b9cf000001d5-1479177659.525153-1720934038', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:41:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 18:41:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:41:34 INFO - Using env: {'DISPLAY': ':0', 18:41:34 INFO - 'HOME': '/home/cltbld', 18:41:34 INFO - 'LANG': 'en_US.UTF-8', 18:41:34 INFO - 'LANGUAGE': 'en_US:en', 18:41:34 INFO - 'LOGNAME': 'cltbld', 18:41:34 INFO - 'MAIL': '/var/mail/cltbld', 18:41:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:41:34 INFO - 'MOZ_NO_REMOTE': '1', 18:41:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:41:34 INFO - 'NO_EM_RESTART': '1', 18:41:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:41:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:41:34 INFO - 'PWD': '/builds/slave/test', 18:41:34 INFO - 'SHELL': '/bin/bash', 18:41:34 INFO - 'SHLVL': '1', 18:41:34 INFO - 'TERM': 'linux', 18:41:34 INFO - 'TMOUT': '86400', 18:41:34 INFO - 'USER': 'cltbld', 18:41:34 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1479177659.525153-1720934038', 18:41:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:41:34 INFO - '_': '/tools/buildbot/bin/python'} 18:41:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:41:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:41:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 18:41:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 18:41:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:41:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 18:41:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 18:41:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 18:41:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 18:41:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 18:41:34 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:41:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:41:34 INFO - Cleaning up... 18:41:34 INFO - Return code: 0 18:41:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:41:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:41:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:41:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:41:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:41:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:34 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 0x7f490e2edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19b9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b6f60>, '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 0x19b7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19b81d0>, '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': '14ef55db36f7623abb31b9cf000001d5-1479177659.525153-1720934038', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:41:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:41:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:41:34 INFO - Using env: {'DISPLAY': ':0', 18:41:34 INFO - 'HOME': '/home/cltbld', 18:41:34 INFO - 'LANG': 'en_US.UTF-8', 18:41:34 INFO - 'LANGUAGE': 'en_US:en', 18:41:34 INFO - 'LOGNAME': 'cltbld', 18:41:34 INFO - 'MAIL': '/var/mail/cltbld', 18:41:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:41:34 INFO - 'MOZ_NO_REMOTE': '1', 18:41:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:41:34 INFO - 'NO_EM_RESTART': '1', 18:41:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:41:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:41:34 INFO - 'PWD': '/builds/slave/test', 18:41:34 INFO - 'SHELL': '/bin/bash', 18:41:34 INFO - 'SHLVL': '1', 18:41:34 INFO - 'TERM': 'linux', 18:41:34 INFO - 'TMOUT': '86400', 18:41:34 INFO - 'USER': 'cltbld', 18:41:34 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1479177659.525153-1720934038', 18:41:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:41:34 INFO - '_': '/tools/buildbot/bin/python'} 18:41:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:41:34 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:41:34 INFO - Cleaning up... 18:41:34 INFO - Return code: 0 18:41:34 INFO - Running post-action listener: _resource_record_post_action 18:41:34 INFO - Running post-action listener: _start_resource_monitoring 18:41:34 INFO - Starting resource monitoring. 18:41:34 INFO - [mozharness: 2016-11-15 02:41:34.601797Z] Finished create-virtualenv step (success) 18:41:34 INFO - [mozharness: 2016-11-15 02:41:34.602307Z] Running install step. 18:41:34 INFO - Running pre-action listener: _resource_record_pre_action 18:41:34 INFO - Running main action method: install 18:41:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:41:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:41:34 INFO - Reading from file tmpfile_stdout 18:41:34 INFO - Detecting whether we're running mozinstall >=1.0... 18:41:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:41:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:41:34 INFO - Reading from file tmpfile_stdout 18:41:34 INFO - Output received: 18:41:34 INFO - Usage: mozinstall [options] installer 18:41:34 INFO - Options: 18:41:34 INFO - -h, --help show this help message and exit 18:41:34 INFO - -d DEST, --destination=DEST 18:41:34 INFO - Directory to install application into. [default: 18:41:34 INFO - "/builds/slave/test"] 18:41:34 INFO - --app=APP Application being installed. [default: firefox] 18:41:34 INFO - mkdir: /builds/slave/test/build/application 18:41:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 18:41:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 18:41:51 INFO - Reading from file tmpfile_stdout 18:41:51 INFO - Output received: 18:41:51 INFO - /builds/slave/test/build/application/firefox/firefox 18:41:51 INFO - Running post-action listener: _resource_record_post_action 18:41:51 INFO - [mozharness: 2016-11-15 02:41:51.790661Z] Finished install step (success) 18:41:51 INFO - [mozharness: 2016-11-15 02:41:51.790936Z] Running run-tests step. 18:41:51 INFO - Running pre-action listener: _resource_record_pre_action 18:41:51 INFO - Running main action method: run_tests 18:41:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:41:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:41:51 INFO - Python 2.7.3 18:41:51 INFO - Return code: 0 18:41:51 INFO - grabbing minidump binary from tooltool 18:41:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:41:51 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 0x19b6f60>, '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 0x19b7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19b81d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:41:51 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 18:41:51 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 18:41:51 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 18:41:51 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:41:51 INFO - Return code: 0 18:41:51 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:41:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:41:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:41:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:41:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:41:51 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/1479166498/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--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 18:41:51 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/1479166498/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-036 --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 18:41:51 INFO - Using env: {'DISPLAY': ':0', 18:41:51 INFO - 'HOME': '/home/cltbld', 18:41:51 INFO - 'LANG': 'en_US.UTF-8', 18:41:51 INFO - 'LANGUAGE': 'en_US:en', 18:41:51 INFO - 'LOGNAME': 'cltbld', 18:41:51 INFO - 'MAIL': '/var/mail/cltbld', 18:41:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:41:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:41:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:41:51 INFO - 'MOZ_NO_REMOTE': '1', 18:41:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:41:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:41:51 INFO - 'NO_EM_RESTART': '1', 18:41:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:41:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:41:51 INFO - 'PWD': '/builds/slave/test', 18:41:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:41:51 INFO - 'SHELL': '/bin/bash', 18:41:51 INFO - 'SHLVL': '1', 18:41:51 INFO - 'TERM': 'linux', 18:41:51 INFO - 'TMOUT': '86400', 18:41:51 INFO - 'USER': 'cltbld', 18:41:51 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1479177659.525153-1720934038', 18:41:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:41:51 INFO - '_': '/tools/buildbot/bin/python'} 18:41:51 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/1479166498/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--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 18:41:52 INFO - mozversion application_buildid: 20161114153458 18:41:52 INFO - mozversion application_changeset: be95aa5249cf8d1cf33434273f7c789e332b886d 18:41:52 INFO - mozversion application_display_name: Nightly 18:41:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:41:52 INFO - mozversion application_name: Firefox 18:41:52 INFO - mozversion application_remotingname: firefox 18:41:52 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 18:41:52 INFO - mozversion application_vendor: Mozilla 18:41:52 INFO - mozversion application_version: 52.0a1 18:41:52 INFO - mozversion platform_buildid: 20161114153458 18:41:52 INFO - mozversion platform_changeset: be95aa5249cf8d1cf33434273f7c789e332b886d 18:41:52 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 18:41:52 INFO - mozversion platform_version: 52.0a1 18:41:52 INFO - using testdate: 1479177712 18:41:52 INFO - actual date: 1479177712 18:41:52 INFO - starting webserver on 'localhost:52397' 18:41:52 INFO - SUITE-START | Running 2 tests 18:41:52 INFO - TEST-START | dromaeo_css 18:41:52 INFO - operating with platform_type : linux_ 18:41:52 INFO - Initialising browser for dromaeo_css test... 18:41:52 INFO - TEST-INFO | started process 13709 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkDO6sz/profile http://localhost:52397/getInfo.html) 18:41:56 INFO - PROCESS | 13709 | __metrics Screen width/height:1600/1200 18:41:56 INFO - PROCESS | 13709 | colorDepth:24 18:41:56 INFO - PROCESS | 13709 | Browser inner width/height: 1024/697 18:41:56 INFO - PROCESS | 13709 | __metrics 18:41:57 INFO - PROCESS | 13709 | 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" 18:41:57 INFO - PROCESS | 13709 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:41:57 INFO - PROCESS | 13709 | console.error: PushService: 18:41:57 INFO - PROCESS | 13709 | stateChangeProcessEnqueue: Error transitioning state 18:41:57 INFO - PROCESS | 13709 | UnknownError 18:41:58 INFO - TEST-INFO | 13709: exit 0 18:41:58 INFO - Browser initialized. 18:41:58 INFO - Running cycle 1/1 for dromaeo_css test... 18:41:58 INFO - TEST-INFO | started process 13792 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkDO6sz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:42:10 INFO - PROCESS | 13792 | RSS: Main: 173453312 18:42:10 INFO - PROCESS | 13792 | 18:43:02 INFO - PROCESS | 13792 | 1479177782207 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 18:45:12 INFO - PROCESS | 13792 | Cycle 1(1): loaded http://localhost:52397/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52397/tests/dromaeo/cssquery-ext.html) 18:45:15 INFO - PROCESS | 13792 | RSS: Main: 439095296 18:45:15 INFO - PROCESS | 13792 | 18:48:17 INFO - PROCESS | 13792 | Cycle 1(1): loaded http://localhost:52397/tests/dromaeo/cssquery-ext.html (next: http://localhost:52397/tests/dromaeo/cssquery-jquery.html) 18:48:18 INFO - PROCESS | 13792 | RSS: Main: 285454336 18:48:18 INFO - PROCESS | 13792 | 18:51:20 INFO - PROCESS | 13792 | Cycle 1(1): loaded http://localhost:52397/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52397/tests/dromaeo/cssquery-mootools.html) 18:51:21 INFO - PROCESS | 13792 | RSS: Main: 262258688 18:51:21 INFO - PROCESS | 13792 | 18:54:23 INFO - PROCESS | 13792 | Cycle 1(1): loaded http://localhost:52397/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52397/tests/dromaeo/cssquery-prototype.html) 18:54:23 INFO - PROCESS | 13792 | RSS: Main: 264687616 18:54:23 INFO - PROCESS | 13792 | 18:57:26 INFO - PROCESS | 13792 | Cycle 1(1): loaded http://localhost:52397/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52397/tests/dromaeo/cssquery-yui.html) 18:57:27 INFO - PROCESS | 13792 | RSS: Main: 225787904 18:57:27 INFO - PROCESS | 13792 | 19:00:30 INFO - PROCESS | 13792 | Cycle 1(1): loaded http://localhost:52397/tests/dromaeo/cssquery-yui.html (next: http://localhost:52397/tests/dromaeo/cssquery-dojo.html) 19:00:30 INFO - PROCESS | 13792 | RSS: Main: 317136896 19:00:30 INFO - PROCESS | 13792 | 19:00:30 INFO - PROCESS | 13792 | __start_tp_report 19:00:30 INFO - PROCESS | 13792 | _x_x_mozilla_page_load 19:00:30 INFO - PROCESS | 13792 | _x_x_mozilla_page_load_details 19:00:30 INFO - PROCESS | 13792 | |i|pagename|runs| 19:00:30 INFO - PROCESS | 13792 | |0;dojo.html;3140.1521589170916;3140.5603215549827;3147.685231476851;3179.618445786503;3193.5848339715835;5319.574434045277;5324.307839980806;5385.246065550826;5422.024035673582;5423.728813559321;5345.599080068991;5433.918491222635;5434.755436005379;5466;5556.805511807078;4849.272609108627;4910.877228069309;4919.11455937931;4937.061958227925;5009.649324547283;4901.950980490185;4963.106640804654;4977.228529577921;5010.899782004358;5035.748212589374;4979.203327467624;4989.426215985171;5018.59851211904;5045.243213517983;5074.238864170367;4824.179889418807;4862.489438608965;4867.610591152699;4886.218205087204;4951.653384263103;4934.062528119682;4936.259561065833;4951.356323677935;4985.202367621199;4991.5258050485145;5391.676499410009;5439.184122381635;5451.836444906619;5473.75368108436;5506.724663766796;5665.093585026376;5706.201131841545;5720.513756330717;5842.883142337129;5844.912326315109;5795.275590551181;5843.649381037151;5862.589618726691;5872.647641141545;5875.471207591295;5447.264619276387;5452.482014208644;5453.700046497481;5454.509094181542;5459.69971651559;5814.156947242626;5814.476697097281;5940;5948.851278718067;5950.375210602911;5669.489745922887;5719.8570035749435;5756.366799652035;5757.596968212269;5760.164776107441;5803.47768700819;5828.53371730269;5840.2991641003355;5843.094320380348;5897.675627840425;5817.941820581825;5819.359870414251;5820.679862607512;5827.708614569255;5837.211976383219;5639.830805075854;5706.600537962303;5708.286464191976;5776.711164441761;5883;4422.955770442254;4489.393931819228;4496.595306422438;4515.0518391137575;4559.908801824011;4025.054112283611;4044.373122166069;4045.37296719009;4070.1859628074503;4077.4903137107863;5347.171188465794;5584.720763961785;5593.636413633182;5601.467860553241;5605.411431799684;5773.480386765212;5775.249217601685;5818.5054270386645;5822.475977162076;5912.852178695481;5526.309211348582;5546.69493177871;5565.165225216169;5568.582356323292;5576.749046292926;5054.393472783216;5054.873628159252;5060.5951523878;5060.797568097309;5102.591792656579;5928.525717942554;5983.623766533635;5994.100884867217;6016.849578760566;6051.4553690168095;5878.353381128158;5881.147233651182;5882.49998750111;5884.58807883444;5916.526677865674;6060.272767267956;6103.481204097701;6107.053406721965;6111.694415279129;6124;5587.1339942309005;5622.690752008679;5624.718764061862;5730.283714535683;5766.538676905753;5763.7118144093465;5793.159991801081;5793.710314484343;5802.767889284381;5807.94192058074;5635.690037048002;5676.460736230051;5678.3186017678145;5684.744186511534;5685.374608792947;5664.405237450173;5664.660120392789;5668.858278543069;5673.8297851064535;5675.120356344773;5589.888202235851;5602.2717046783655;5605.103183490622;5613.522850557748;5614.63504872182;5716.857078573069;5754.4533269339345;5755.223044888887;5756.913646295226;5764.904668113045;5500.669959802424;5580.079286917613;5580.609357344947;5583.050881350261;5630.211770352072 19:00:30 INFO - PROCESS | 13792 | |1;ext.html;597.766870920341;611.3763960760025;615.1695211464522;640.2125385775496;643.2827397451842;41452.58547414525;42522.362164567516;42615.14769704608;46533.7673311633;46613.173353330836;43976.56023439765;44268.11463770723;44477.7776111119;44534.10931781362;44661.55338446615;8465.957670211656;8512.361572882028;8558.186972237627;8575.185357391038;8616.526091064989;8535.103814099522;8598.527081010541;8630.784230394227;8681.34889883258;8687.131286871294;8652.610632521551;8681.956590217073;8686.522241276727;8690.4351217171;8690.86963695542;8623.137686231357;8675.305975521944;8681.652733890636;8689.695860644848;8692.695755648521;8517.403781735282;8582.313414926792;8583.313334933191;8584.31325493959;8585.699500517514;41130;41458;41474.377884331756;41596.1680766386;41620.37569436461;3300.985331711816;3460.8615655373756;3527.1005893496995;3575.106223444139;3585.748997570171;31018.20431953374;31111.533327000114;31727.206819829687;32004.199895002577;32115.678843211503;4141.852192333818;4248.256555102876;4378.408914796525;4422.823087076513;4467.128909862578;328297;328311;328554.9999999976;328948;330231;58371.70814145902;59298.22105336847;59338;59460.70269648624;59465.70267148637;61918;62042.68978655078;62251;62267;62302.68848655728;16906.915465422593;17094.572635684206;17099.23053462597;17144.742828857576;17147.657046858993;12333.753324933452;12336;12348.506059757508;12356.62930112098;12363;16655.41706040283;18143.455696328867;18153.636927261647;18183.545411364557;18321.51891140679;6179.28938172107;6227.844303892349;6265.310815810257;6319.33646967071;6358.300586935434;930.1767935377104;940.4357385568604;972.6887396033202;1093.9398333091756;1138.6390125818098;29585.704142958726;30576;30820.69179308223;31112;31759.424955262413;1072.1208608940594;1085;1093.3986307530827;1109.628274528026;1142.308903113621;15644.608884777745;16323.673526529403;16417;16498.17509124539;16847.578810529834;471074;472390;474521;476712;477265;57322.42677573254;57475;57543.42456575464;57554.7122264386;57578.42421575815;1232.1744431231098;1283.0954177304977;1320.8150858879571;1345.327336331834;1390.4994202087241;30145.698543015165;31247.687523125387;32237.131544214844;32582.348353032332;35431.82284088563;54474.7276263632;56403.43596564146;60880.695596521735;60888;61032.389676104445;366785;369584;369609;369726;369823;25373.873130634227;25400.74599253984;25843.741562584135;27400.451990960468;27775.30561735973;46187.3071903915;46814.531854681016;48056.27915581199;49948.75025624849;50409;36828.631713682524;40033.599664002984;40812.71554955742;41376.79311603423;41897.37153942754;39622.80188599038;40071.19857602773;40573.39139912845;41090;42354.364684530374;36752;37785.433218502294;37907.43138852864;37912.05219869525;41666.79166604148;34814.12964675904;36321.81839090788;36577.63422365742;36772;37147;27803.44393112167;27926.44147117087;28046.579301310903;28180.43639127247;28262.85868570644 19:00:30 INFO - PROCESS | 13792 | |2;jquery.html;376.49925598953394;392.34086734286404;402.31606269342115;403.34859202388134;416.1095256151834;12962;15125.655523393878;15950.361985520565;18843.62312753744;19366.225350985944;18442.446726598224;18655.06724663765;18862.151203195855;18929.24283028677;18949.810501894975;5456.454354564532;5673.6879471629045;5678.176664383662;5680.204771332017;5681.687507187103;5314.92027619586;5586.24585680932;5602.635828671123;5607.158926161088;5608.355039170507;5571.721413929287;5577.5498370423575;5602.579806514507;5603.943960560383;5605.943940560604;5306.681599104047;5566.777328906859;5595.832125036255;5670.432956704338;5680.261565996435;5302.655327403745;5458.344998600153;5496.697681627509;5506.311711036121;5510.008198524264;13686.110402823784;13939.930300348535;20445;21259.574808503745;21625.134994600197;2211.303439416579;2292.2091878302126;2314.271004633535;2432.3797431654993;2818.3236023354452;9385.765355866159;9639.951800240953;9744;9954.701358959242;10266.178705703525;1833.4316361927845;1842.8065053169491;1875.6835308394122;1876.9906150469296;1932.371979106782;78719.21280787177;79480.60259698665;79822;81492.59253703694;83293.16706832914;10054.54754536033;10366.533505992249;10402.843957340647;10660.520276587573;10768.623098191525;14323.498677546237;14324.57026289213;14327.212003339917;14336.856631433553;14347.426102955973;7568.318851303409;7863.960680196677;7880.223744875709;7980.281774640194;8032.959835200787;7796.844063118706;7829.530228186327;7908.130105688369;8139.959300203461;8163.79590510242;4234.449521562177;4322.783860806947;4329.155814616182;4366.083122544302;4379.284843397114;1732.4629364896923;1930.8165724256173;1958.8922609256342;1975.4666240115089;2018.68710349896;442.45136031321573;748.2996581902548;754.6340025087828;925.1858364639209;987.1214618989105;10796.838047429295;11636.941815291038;11737.413129343498;11793.469293881795;12142.089343299287;475.72268459187194;483.3619622098796;489.18062245738247;505.73196206010874;516.367449873909;6340.968295158495;6391.712372943229;6485.319041500669;6512.706928188243;6692.564983276169;451091;453211;454532;462435;463537;61232;98045;98417;103646;105741.47129264305;479.62828807674333;491.52813299232423;493.96295277855023;495.22250067393844;495.38324785642106;8875.73372798817;10952.233343665866;11044.558217671203;11786.174967752175;11914.225575337576;40042.19915601613;40328;44710.3293450605;44853;45806;59378;59427.70286148541;59696;60010.39989600223;61033.389666104544;7995.2804247618;8414.831703365777;8471;8708.17272359125;8882.777930551789;10746.892531074589;13027.544035958696;13042.478300868239;13118.672033199246;13148.474061037452;11568.595099171489;11703.531858725555;11771.705707357385;11898.167128301282;12192.268463892195;11259.662210133709;11505.367204803817;11620.88379116198;11695.76608467843;11764.647060588197;11543.711407214887;11722.238054526428;11739.295642261492;11842.644720658394;12402.5659101931;8285.130061343712;8538.231559159705;8626.82746345057;11461.426928653367;11727.237729547553;10820.729481763019;11132;11520.366379849189;11989.76020479568;12930.806037909251 19:00:30 INFO - PROCESS | 13792 | |3;mootools.html;1448.4930274403957;1493.059372595265;1627.4059968111635;1694.5848267174545;1779.8843075200102;7534.886976695354;7770.650320735566;8126.6749330026805;8685.522296273703;8688.044315125331;8086.231807978247;8313.418060735736;8332.500049997005;8553.74338769838;8560.229579337858;2335.4161459635134;2363.9881800590974;2367;2367.124164059292;2367.9408014799683;2095.7170781944396;2164.2749678857604;2327.534493101378;2371.0634299451795;2391.784739373456;2250.85369450986;2328.0571368595747;2335.1943579465055;2340.1341503643675;2349.612313968193;2304.020791163757;2310.202979971924;2319.5592837360846;2354.281944007077;2360.138549429446;2324.9883750581307;2341.391238278043;2342.8242881783935;2345.8592484450987;2411.2163546847346;8428.83142337156;8601.95699021507;8618.26744726699;8620.051794302623;8622.223999839982;5138;5260.342457192851;5266.657667251617;5276.498732620395;5282.286891269668;3383.678550537695;3570.517980072683;3602.819859007039;3644.7995360255177;3675.1363429594026;1082.5561519776854;1126.054114543779;1167.0721776187952;1181.5628217559558;1200.951961921522;12043.638690839289;12052.999999999913;12066.396680165957;12085.214461060003;12090.516379344816;4678.672492925462;4692.976535117371;4751.619870410359;4803.687760295639;4857.975710121426;10214.693559193236;10288.2798204125;10288.845667314996;10291;10296.536655850505;5308.840734777963;5349.170878513836;5361.731913404315;5403.918941215885;5407.486288802636;4714.104320179155;4840.394950631171;4886.120498310338;4898.069366820364;4899.804007839646;3745.6816170625257;3859.5368555772925;3902.8829135125993;3953;3955.4660120883887;1189.1259923956059;1235.123062625546;1251.6432816647211;1267.5880338889897;1291.9741605167844;834.6869923778584;841.6338892581747;948.8861336639509;980.3578655980202;981.6367943860818;5888.087346461305;5896.498797602252;5943.435373639497;6213.720382582795;6254.2807577129215;880.8282384934876;901.693424235763;914.7987442762582;958.8274110660149;975.6780262513354;3857.7106716996336;3870.9806450967567;3922.490076290064;4104.240715467648;4152.6055024772595;10302.896971030194;10737.570497180182;10791.352518848737;10792.51433685486;10806.567737290577;10653.017155196558;10679.092277156373;10680.198985076151;10688.732781680364;10693.9465302673;7491.325780679765;7679.500832445985;7727.574983375968;7939.166387529226;8093.797655058553;5871.2073870027;5874.825034993104;5921.348651648229;5987.700614969322;6088.360722124113;9355.906440935776;9500.382475139093;9560;9833.852492212765;9877.506124693593;9694.321397502106;9921.751956200864;9981.650642227487;9991.500424978867;10051.547680354548;7469.178390376946;7574.431917606092;7629.2752188542;7634.312911837961;7644.961775191088;8090.352771778362;8127.634256458356;8181.754547363588;8184.631691573774;8198;7242.311980361857;7252.41980641558;7301.379382752525;7326.523775954546;7435.591042492715;7122.786316410516;7129.643517824192;7144.428445724434;7207.315305046012;7215.891761623475;6718.294579069323;6819.5908245505425;6829.078074460083;6831.89752153728;6834.393917429499;4983.6760610560195;5227.268182454535;5273.288106105627;5333.4133245343755;5449.754761035683;5254.238135470259;5351.759170837244;5386.461353864583;5428.511433970962;5443.156310771837 19:00:30 INFO - PROCESS | 13792 | |4;prototype.html;328.0849650852179;342.874850679502;343.40247968534754;346.623913054336;347.87302634538395;5118.820841270556;5186.766595503202;5255.636392708665;5291.417944026159;5296.549793267572;5070.391553013635;5123.487651234875;5142.254373115896;5149.433562308143;5162.638615296931;4084.693647976399;4099.282625540533;4105.794710264489;4108.979455102728;4114.6091121343425;3861.5366156061314;4039.899002524931;4109.897252568695;4118.526369467505;4125.979370103145;4049.858254961077;4051.4530538377385;4052.7770972596495;4062.939055914164;4067.755934643916;4043.2722110020186;4068.105016896278;4072.6741860651077;4072.9796351018203;4111.465509483778;3602.0814692253307;3604.8824864292155;3607.7113830893727;3622.492851000862;3625.456181572759;5032.672876263031;5063.544281014726;5086.262491938685;5104.923426148611;5107.540321371094;4603.5856772890265;4618.353430519696;4630.768461576941;4637.976810115962;4641.002184530342;5431.864203394907;5443.488949627468;5458.77177635029;5461.836144915659;5473.370562385297;3855.768653880776;3925.391564307537;3926.960730392688;3928.8428462861452;3932.3118454270675;5589.245451864028;5616.775328986836;5638.633488823254;5647.943520564783;5652.34997975234;4026.8791936241373;4027.234825383168;4033.40680431228;4035.858744943913;4056.6146216109423;3858.594847541024;3985.5815139410524;3992.5608183099835;4117.629413352813;4119;4582.312653101994;4586.243269860435;4596.598037598565;4596.7931443085145;4597.7011494252765;5446.210299506629;5451.781928722886;5467.261919640877;5471.480209380103;5482.91775623366;1318.8351456067992;1324.0665330941663;1339.8745054154556;1356.6540532164236;1362.346073884541;909.5179554835947;946.5125460387906;947.7014740356766;950.1733491862125;953.2326477185793;5097.337346144977;5107.259447380184;5129.435762066169;5159.74201289934;5162.638615296968;5426.860359324586;5434.293541839615;5440.564754819605;5457.345118585795;5463.617546771768;4929.728864912393;5145.897082058338;5172.741362931838;5177.922331165036;5189.197833170046;2838.4748821467683;2862.341661417844;2867.4659057404187;2873.367859071001;2873.8302581550797;5544.390117087117;5565.358219325309;5584.664920104726;5587.832365029056;5606.887862242814;5229.581633469314;5297.337832770903;5341.412444631087;5349.331333583302;5430.83707488776;5471.890562188734;5494.945050549523;5528.530074943675;5536.7785288588;5538.889222215614;5344.652597581145;5344.9732751336;5346.652467589594;5350.100714246387;5350.839474815762;5254.15933450646;5574.888502230014;5577.498025177753;5595.608307418604;5611.971940140274;5820.388859169726;5824.718561916372;5836.358000619844;5855.2973643163095;5855.385184555731;4005.2189822985406;4033.5764744702556;4071.959280407158;4073.2668119737546;4082.897927551835;5299.284596579412;5608.38307786135;5618.185363122243;5629.380768115586;5637.182608521824;5309.973450132725;5366.302380690485;5420.620556561003;5451.918221226605;5485.6434331768305;5428.37573679032;5488.560915126701;5507.917381239365;5529.4470552944385;5538.6399884007415;5261.868453288545;5437.4562543745305;5445.83662490126;5458.089668615953;5481.808136715196;5527.291627102611;5544.500994910478;5547.556195504269;5548.085910360919;5551.666899986014;5355.758990845499;5427.472143106854;5431.212474191299;5444.6188766785945;5445.891082178414 19:00:30 INFO - PROCESS | 13792 | |5;yui.html;695.6452209373219;714.731975509184;732.9377002954745;763.7365109037383;783.4907310248336;12857.871421285785;13847.238401887893;13921.44314227431;13977.79033314501;14453.277336133178;13568.185908845477;13736.969727270445;13853.099548529339;13883.930580347109;13886.4445422183;776.227653484782;787.7479206653844;787.7715462515863;788.2826627768732;788.996055019724;678.4843518925603;701.824543864034;783.7021931665959;796;810.4448452809814;843.0557775291682;843.784834867108;847.1232274595794;847.3644766425181;847.5550336073549;840.315143158324;840.6511297811401;841.20506121715;841.2680967558202;841.6212704283097;518.8443466959897;532.3771187710388;597.3638075449633;609.9176611157482;614.2904944788776;12633.178843375152;12689.23864568129;12696.047796415305;12696.80954785679;12705;12834.486620535261;12899.419526121346;13314;13444.126131801499;13549.661258468617;11531.76936461266;11582;11610.76778464426;11675.416229188506;11772.587959421464;4100.36444351126;4120.587941205886;4202.138561594866;4209.663226941868;4230.02709376842;59973;60137.79035467519;60174;60849;63060.36939630637;10118.848217276747;10323.63867264642;10372.170226381872;10491.639381139183;10806.78386432267;18131;19143.61712765737;19251.32620358309;19389.321373751853;19445.31941382045;7658.73194438192;7784.571848548271;7806.687732490636;7902.0912595052305;8040.15578364275;4023.758574485482;4027;4152.937705934413;4160.292750232467;4318.52496225415;3263.983680081632;3353.765236433475;3362.2434952135573;3374.746893982961;3378.6452422495286;588.2088590845307;597.7608956417381;606.5208485296655;611.3458599298708;625.8091282158895;603.3092109534558;609.3632154398664;616.3651439017818;659.1760299625469;681.9693113809791;9122.407043542149;9294.90705092954;9411.764705882408;9552.952235238918;9613.807723845484;631.2961048430966;644.577801539992;656.0028756290412;682.1711620381261;690.5787469643514;4389.363542286351;4433.467983841895;4492.685512014127;4539.6368290536675;4572.497025327211;84799;87251;87616.56191719;87633.5618321917;87826;50828.491715082375;62239.688801555705;75718.62140689371;77902;80738.19261807424;45976;58003.709981450666;67790.66104669445;67974.66012670004;68600;8381.203785640355;8543.786405339917;8564.700235491728;8570.571471426529;8668.869966950628;36620;45788;45962.08075838532;46258;47968.28047579359;46704;60877;61307.386926130166;61747;64099.67950160219;10282.434466104436;10806.405647689138;10893.673189804318;11130.721731956766;11170.162237832032;12064.45709943037;12153.513859445877;12272.570460033856;12473;12530.93734531358;11863.060109835842;11875.82186267224;12079;12278.877211228131;12868.678283042998;10171.440570768384;11472.94263528677;11526.250793698719;12407.379631018593;12441.93779031099;12311.507539698312;12489.687757806127;12596.874031259937;12695.746085078063;13247.138935969131;10141.239407044353;10274.948625256826;10662.73343166427;10883.238173328107;10958.945205273923;10909.672709818718;11072.667819965414;11085.778284434105;11409.60066397672;11508.42457877086 19:00:30 INFO - PROCESS | 13792 | __end_tp_report 19:00:30 INFO - PROCESS | 13792 | __start_cc_report 19:00:30 INFO - PROCESS | 13792 | _x_x_mozilla_cycle_collect,2793 19:00:30 INFO - PROCESS | 13792 | __end_cc_report 19:00:30 INFO - PROCESS | 13792 | __startTimestamp1479178830301__endTimestamp 19:00:30 INFO - PROCESS | 13792 | 19:00:30 INFO - PROCESS | 13792 | ------- Summary: start ------- 19:00:30 INFO - PROCESS | 13792 | Number of tests: 6 19:00:30 INFO - PROCESS | 13792 | 19:00:30 INFO - PROCESS | 13792 | [#0] dojo.html Cycles:165 Average:5410.54 Median:5605.41 stddev:602.06 (10.7%) stddev-sans-first:576.96 19:00:30 INFO - PROCESS | 13792 | Values: 3140.2 3140.6 3147.7 3179.6 3193.6 5319.6 5324.3 5385.2 5422.0 5423.7 5345.6 5433.9 5434.8 5466.0 5556.8 4849.3 4910.9 4919.1 4937.1 5009.6 4902.0 4963.1 4977.2 5010.9 5035.7 4979.2 4989.4 5018.6 5045.2 5074.2 4824.2 4862.5 4867.6 4886.2 4951.7 4934.1 4936.3 4951.4 4985.2 4991.5 5391.7 5439.2 5451.8 5473.8 5506.7 5665.1 5706.2 5720.5 5842.9 5844.9 5795.3 5843.6 5862.6 5872.6 5875.5 5447.3 5452.5 5453.7 5454.5 5459.7 5814.2 5814.5 5940.0 5948.9 5950.4 5669.5 5719.9 5756.4 5757.6 5760.2 5803.5 5828.5 5840.3 5843.1 5897.7 5817.9 5819.4 5820.7 5827.7 5837.2 5639.8 5706.6 5708.3 5776.7 5883.0 4423.0 4489.4 4496.6 4515.1 4559.9 4025.1 4044.4 4045.4 4070.2 4077.5 5347.2 5584.7 5593.6 5601.5 5605.4 5773.5 5775.2 5818.5 5822.5 5912.9 5526.3 5546.7 5565.2 5568.6 5576.7 5054.4 5054.9 5060.6 5060.8 5102.6 5928.5 5983.6 5994.1 6016.8 6051.5 5878.4 5881.1 5882.5 5884.6 5916.5 6060.3 6103.5 6107.1 6111.7 6124.0 5587.1 5622.7 5624.7 5730.3 5766.5 5763.7 5793.2 5793.7 5802.8 5807.9 5635.7 5676.5 5678.3 5684.7 5685.4 5664.4 5664.7 5668.9 5673.8 5675.1 5589.9 5602.3 5605.1 5613.5 5614.6 5716.9 5754.5 5755.2 5756.9 5764.9 5500.7 5580.1 5580.6 5583.1 5630.2 19:00:30 INFO - PROCESS | 13792 | 19:00:30 INFO - PROCESS | 13792 | [#1] ext.html Cycles:180 Average:56046.51 Median:22797.22 stddev:104438.62 (458.1%) stddev-sans-first:104648.62 19:00:30 INFO - PROCESS | 13792 | Values: 597.8 611.4 615.2 640.2 643.3 41452.6 42522.4 42615.1 46533.8 46613.2 43976.6 44268.1 44477.8 44534.1 44661.6 8466.0 8512.4 8558.2 8575.2 8616.5 8535.1 8598.5 8630.8 8681.3 8687.1 8652.6 8682.0 8686.5 8690.4 8690.9 8623.1 8675.3 8681.7 8689.7 8692.7 8517.4 8582.3 8583.3 8584.3 8585.7 41130.0 41458.0 41474.4 41596.2 41620.4 3301.0 3460.9 3527.1 3575.1 3585.7 31018.2 31111.5 31727.2 32004.2 32115.7 4141.9 4248.3 4378.4 4422.8 4467.1 328297.0 328311.0 328555.0 328948.0 330231.0 58371.7 59298.2 59338.0 59460.7 59465.7 61918.0 62042.7 62251.0 62267.0 62302.7 16906.9 17094.6 17099.2 17144.7 17147.7 12333.8 12336.0 12348.5 12356.6 12363.0 16655.4 18143.5 18153.6 18183.5 18321.5 6179.3 6227.8 6265.3 6319.3 6358.3 930.2 940.4 972.7 1093.9 1138.6 29585.7 30576.0 30820.7 31112.0 31759.4 1072.1 1085.0 1093.4 1109.6 1142.3 15644.6 16323.7 16417.0 16498.2 16847.6 471074.0 472390.0 474521.0 476712.0 477265.0 57322.4 57475.0 57543.4 57554.7 57578.4 1232.2 1283.1 1320.8 1345.3 1390.5 30145.7 31247.7 32237.1 32582.3 35431.8 54474.7 56403.4 60880.7 60888.0 61032.4 366785.0 369584.0 369609.0 369726.0 369823.0 25373.9 25400.7 25843.7 27400.5 27775.3 46187.3 46814.5 48056.3 49948.8 50409.0 36828.6 40033.6 40812.7 41376.8 41897.4 39622.8 40071.2 40573.4 41090.0 42354.4 36752.0 37785.4 37907.4 37912.1 41666.8 34814.1 36321.8 36577.6 36772.0 37147.0 27803.4 27926.4 28046.6 28180.4 28262.9 19:00:30 INFO - PROCESS | 13792 | 19:00:30 INFO - PROCESS | 13792 | [#2] jquery.html Cycles:180 Average:27363.39 Median:2410.87 stddev:75801.60 (3144.2%) stddev-sans-first:75987.16 19:00:30 INFO - PROCESS | 13792 | Values: 376.5 392.3 402.3 403.3 416.1 12962.0 15125.7 15950.4 18843.6 19366.2 18442.4 18655.1 18862.2 18929.2 18949.8 5456.5 5673.7 5678.2 5680.2 5681.7 5314.9 5586.2 5602.6 5607.2 5608.4 5571.7 5577.5 5602.6 5603.9 5605.9 5306.7 5566.8 5595.8 5670.4 5680.3 5302.7 5458.3 5496.7 5506.3 5510.0 13686.1 13939.9 20445.0 21259.6 21625.1 2211.3 2292.2 2314.3 2432.4 2818.3 9385.8 9640.0 9744.0 9954.7 10266.2 1833.4 1842.8 1875.7 1877.0 1932.4 78719.2 79480.6 79822.0 81492.6 83293.2 10054.5 10366.5 10402.8 10660.5 10768.6 14323.5 14324.6 14327.2 14336.9 14347.4 7568.3 7864.0 7880.2 7980.3 8033.0 7796.8 7829.5 7908.1 8140.0 8163.8 4234.4 4322.8 4329.2 4366.1 4379.3 1732.5 1930.8 1958.9 1975.5 2018.7 442.5 748.3 754.6 925.2 987.1 10796.8 11636.9 11737.4 11793.5 12142.1 475.7 483.4 489.2 505.7 516.4 6341.0 6391.7 6485.3 6512.7 6692.6 451091.0 453211.0 454532.0 462435.0 463537.0 61232.0 98045.0 98417.0 103646.0 105741.5 479.6 491.5 494.0 495.2 495.4 8875.7 10952.2 11044.6 11786.2 11914.2 40042.2 40328.0 44710.3 44853.0 45806.0 59378.0 59427.7 59696.0 60010.4 61033.4 7995.3 8414.8 8471.0 8708.2 8882.8 10746.9 13027.5 13042.5 13118.7 13148.5 11568.6 11703.5 11771.7 11898.2 12192.3 11259.7 11505.4 11620.9 11695.8 11764.6 11543.7 11722.2 11739.3 11842.6 12402.6 8285.1 8538.2 8626.8 11461.4 11727.2 10820.7 11132.0 11520.4 11989.8 12930.8 19:00:30 INFO - PROCESS | 13792 | 19:00:30 INFO - PROCESS | 13792 | [#3] mootools.html Cycles:180 Average:5692.83 Median:5263.50 stddev:3168.32 (60.2%) stddev-sans-first:3161.15 19:00:30 INFO - PROCESS | 13792 | Values: 1448.5 1493.1 1627.4 1694.6 1779.9 7534.9 7770.7 8126.7 8685.5 8688.0 8086.2 8313.4 8332.5 8553.7 8560.2 2335.4 2364.0 2367.0 2367.1 2367.9 2095.7 2164.3 2327.5 2371.1 2391.8 2250.9 2328.1 2335.2 2340.1 2349.6 2304.0 2310.2 2319.6 2354.3 2360.1 2325.0 2341.4 2342.8 2345.9 2411.2 8428.8 8602.0 8618.3 8620.1 8622.2 5138.0 5260.3 5266.7 5276.5 5282.3 3383.7 3570.5 3602.8 3644.8 3675.1 1082.6 1126.1 1167.1 1181.6 1201.0 12043.6 12053.0 12066.4 12085.2 12090.5 4678.7 4693.0 4751.6 4803.7 4858.0 10214.7 10288.3 10288.8 10291.0 10296.5 5308.8 5349.2 5361.7 5403.9 5407.5 4714.1 4840.4 4886.1 4898.1 4899.8 3745.7 3859.5 3902.9 3953.0 3955.5 1189.1 1235.1 1251.6 1267.6 1292.0 834.7 841.6 948.9 980.4 981.6 5888.1 5896.5 5943.4 6213.7 6254.3 880.8 901.7 914.8 958.8 975.7 3857.7 3871.0 3922.5 4104.2 4152.6 10302.9 10737.6 10791.4 10792.5 10806.6 10653.0 10679.1 10680.2 10688.7 10693.9 7491.3 7679.5 7727.6 7939.2 8093.8 5871.2 5874.8 5921.3 5987.7 6088.4 9355.9 9500.4 9560.0 9833.9 9877.5 9694.3 9921.8 9981.7 9991.5 10051.5 7469.2 7574.4 7629.3 7634.3 7645.0 8090.4 8127.6 8181.8 8184.6 8198.0 7242.3 7252.4 7301.4 7326.5 7435.6 7122.8 7129.6 7144.4 7207.3 7215.9 6718.3 6819.6 6829.1 6831.9 6834.4 4983.7 5227.3 5273.3 5333.4 5449.8 5254.2 5351.8 5386.5 5428.5 5443.2 19:00:30 INFO - PROCESS | 13792 | 19:00:30 INFO - PROCESS | 13792 | [#4] prototype.html Cycles:180 Average:4563.34 Median:5187.98 stddev:1329.94 (25.6%) stddev-sans-first:1295.12 19:00:30 INFO - PROCESS | 13792 | Values: 328.1 342.9 343.4 346.6 347.9 5118.8 5186.8 5255.6 5291.4 5296.5 5070.4 5123.5 5142.3 5149.4 5162.6 4084.7 4099.3 4105.8 4109.0 4114.6 3861.5 4039.9 4109.9 4118.5 4126.0 4049.9 4051.5 4052.8 4062.9 4067.8 4043.3 4068.1 4072.7 4073.0 4111.5 3602.1 3604.9 3607.7 3622.5 3625.5 5032.7 5063.5 5086.3 5104.9 5107.5 4603.6 4618.4 4630.8 4638.0 4641.0 5431.9 5443.5 5458.8 5461.8 5473.4 3855.8 3925.4 3927.0 3928.8 3932.3 5589.2 5616.8 5638.6 5647.9 5652.3 4026.9 4027.2 4033.4 4035.9 4056.6 3858.6 3985.6 3992.6 4117.6 4119.0 4582.3 4586.2 4596.6 4596.8 4597.7 5446.2 5451.8 5467.3 5471.5 5482.9 1318.8 1324.1 1339.9 1356.7 1362.3 909.5 946.5 947.7 950.2 953.2 5097.3 5107.3 5129.4 5159.7 5162.6 5426.9 5434.3 5440.6 5457.3 5463.6 4929.7 5145.9 5172.7 5177.9 5189.2 2838.5 2862.3 2867.5 2873.4 2873.8 5544.4 5565.4 5584.7 5587.8 5606.9 5229.6 5297.3 5341.4 5349.3 5430.8 5471.9 5494.9 5528.5 5536.8 5538.9 5344.7 5345.0 5346.7 5350.1 5350.8 5254.2 5574.9 5577.5 5595.6 5612.0 5820.4 5824.7 5836.4 5855.3 5855.4 4005.2 4033.6 4072.0 4073.3 4082.9 5299.3 5608.4 5618.2 5629.4 5637.2 5310.0 5366.3 5420.6 5451.9 5485.6 5428.4 5488.6 5507.9 5529.4 5538.6 5261.9 5437.5 5445.8 5458.1 5481.8 5527.3 5544.5 5547.6 5548.1 5551.7 5355.8 5427.5 5431.2 5444.6 5445.9 19:00:30 INFO - PROCESS | 13792 | 19:00:30 INFO - PROCESS | 13792 | [#5] yui.html Cycles:180 Average:16857.52 Median:25180.25 stddev:22400.52 (89.0%) stddev-sans-first:22430.48 19:00:30 INFO - PROCESS | 13792 | Values: 695.6 714.7 732.9 763.7 783.5 12857.9 13847.2 13921.4 13977.8 14453.3 13568.2 13737.0 13853.1 13883.9 13886.4 776.2 787.7 787.8 788.3 789.0 678.5 701.8 783.7 796.0 810.4 843.1 843.8 847.1 847.4 847.6 840.3 840.7 841.2 841.3 841.6 518.8 532.4 597.4 609.9 614.3 12633.2 12689.2 12696.0 12696.8 12705.0 12834.5 12899.4 13314.0 13444.1 13549.7 11531.8 11582.0 11610.8 11675.4 11772.6 4100.4 4120.6 4202.1 4209.7 4230.0 59973.0 60137.8 60174.0 60849.0 63060.4 10118.8 10323.6 10372.2 10491.6 10806.8 18131.0 19143.6 19251.3 19389.3 19445.3 7658.7 7784.6 7806.7 7902.1 8040.2 4023.8 4027.0 4152.9 4160.3 4318.5 3264.0 3353.8 3362.2 3374.7 3378.6 588.2 597.8 606.5 611.3 625.8 603.3 609.4 616.4 659.2 682.0 9122.4 9294.9 9411.8 9553.0 9613.8 631.3 644.6 656.0 682.2 690.6 4389.4 4433.5 4492.7 4539.6 4572.5 84799.0 87251.0 87616.6 87633.6 87826.0 50828.5 62239.7 75718.6 77902.0 80738.2 45976.0 58003.7 67790.7 67974.7 68600.0 8381.2 8543.8 8564.7 8570.6 8668.9 36620.0 45788.0 45962.1 46258.0 47968.3 46704.0 60877.0 61307.4 61747.0 64099.7 10282.4 10806.4 10893.7 11130.7 11170.2 12064.5 12153.5 12272.6 12473.0 12530.9 11863.1 11875.8 12079.0 12278.9 12868.7 10171.4 11472.9 11526.3 12407.4 12441.9 12311.5 12489.7 12596.9 12695.7 13247.1 10141.2 10274.9 10662.7 10883.2 10958.9 10909.7 11072.7 11085.8 11409.6 11508.4 19:00:30 INFO - PROCESS | 13792 | -------- Summary: end -------- 19:00:30 INFO - PROCESS | 13792 | 19:00:31 INFO - TEST-INFO | 13792: exit 0 19:00:31 INFO - TEST-OK | dromaeo_css | took 1119092ms 19:00:31 INFO - TEST-START | kraken 19:00:31 INFO - operating with platform_type : linux_ 19:00:31 INFO - Initialising browser for kraken test... 19:00:31 INFO - TEST-INFO | started process 14095 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpU_kibU/profile http://localhost:52397/getInfo.html) 19:00:35 INFO - PROCESS | 14095 | __metrics Screen width/height:1600/1200 19:00:35 INFO - PROCESS | 14095 | colorDepth:24 19:00:35 INFO - PROCESS | 14095 | Browser inner width/height: 1024/697 19:00:35 INFO - PROCESS | 14095 | __metrics 19:00:35 INFO - PROCESS | 14095 | 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" 19:00:35 INFO - PROCESS | 14095 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:00:36 INFO - PROCESS | 14095 | console.error: PushService: 19:00:36 INFO - PROCESS | 14095 | stateChangeProcessEnqueue: Error transitioning state 19:00:36 INFO - PROCESS | 14095 | UnknownError 19:00:37 INFO - TEST-INFO | 14095: exit 0 19:00:37 INFO - Browser initialized. 19:00:37 INFO - Running cycle 1/1 for kraken test... 19:00:37 INFO - TEST-INFO | started process 14178 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpU_kibU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:00:49 INFO - PROCESS | 14178 | RSS: Main: 173780992 19:00:49 INFO - PROCESS | 14178 | 19:00:51 INFO - PROCESS | 14178 | Cycle 1(1): loaded http://localhost:52397/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52397/tests/kraken/driver.html?testName=audio-beat-detection) 19:00:52 INFO - PROCESS | 14178 | RSS: Main: 230219776 19:00:52 INFO - PROCESS | 14178 | 19:00:55 INFO - PROCESS | 14178 | Cycle 1(1): loaded http://localhost:52397/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52397/tests/kraken/driver.html?testName=audio-dft) 19:00:56 INFO - PROCESS | 14178 | RSS: Main: 216563712 19:00:56 INFO - PROCESS | 14178 | 19:00:59 INFO - PROCESS | 14178 | Cycle 1(1): loaded http://localhost:52397/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52397/tests/kraken/driver.html?testName=audio-fft) 19:00:59 INFO - PROCESS | 14178 | RSS: Main: 297316352 19:00:59 INFO - PROCESS | 14178 | 19:01:01 INFO - PROCESS | 14178 | Cycle 1(1): loaded http://localhost:52397/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52397/tests/kraken/driver.html?testName=audio-oscillator) 19:01:02 INFO - PROCESS | 14178 | RSS: Main: 210042880 19:01:02 INFO - PROCESS | 14178 | 19:01:04 INFO - PROCESS | 14178 | Cycle 1(1): loaded http://localhost:52397/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52397/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:01:05 INFO - PROCESS | 14178 | RSS: Main: 213471232 19:01:05 INFO - PROCESS | 14178 | 19:01:08 INFO - PROCESS | 14178 | Cycle 1(1): loaded http://localhost:52397/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52397/tests/kraken/driver.html?testName=imaging-darkroom) 19:01:08 INFO - PROCESS | 14178 | RSS: Main: 252583936 19:01:08 INFO - PROCESS | 14178 | 19:01:12 INFO - PROCESS | 14178 | Cycle 1(1): loaded http://localhost:52397/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52397/tests/kraken/driver.html?testName=imaging-desaturate) 19:01:12 INFO - PROCESS | 14178 | RSS: Main: 251940864 19:01:12 INFO - PROCESS | 14178 | 19:01:15 INFO - PROCESS | 14178 | Cycle 1(1): loaded http://localhost:52397/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52397/tests/kraken/driver.html?testName=json-parse-financial) 19:01:16 INFO - PROCESS | 14178 | RSS: Main: 250773504 19:01:16 INFO - PROCESS | 14178 | 19:01:17 INFO - PROCESS | 14178 | Cycle 1(1): loaded http://localhost:52397/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52397/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:01:18 INFO - PROCESS | 14178 | RSS: Main: 212901888 19:01:18 INFO - PROCESS | 14178 | 19:01:20 INFO - PROCESS | 14178 | Cycle 1(1): loaded http://localhost:52397/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52397/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:01:20 INFO - PROCESS | 14178 | RSS: Main: 219615232 19:01:20 INFO - PROCESS | 14178 | 19:01:22 INFO - PROCESS | 14178 | Cycle 1(1): loaded http://localhost:52397/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52397/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:01:23 INFO - PROCESS | 14178 | RSS: Main: 228970496 19:01:23 INFO - PROCESS | 14178 | 19:01:26 INFO - PROCESS | 14178 | Cycle 1(1): loaded http://localhost:52397/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52397/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:01:26 INFO - PROCESS | 14178 | RSS: Main: 233328640 19:01:26 INFO - PROCESS | 14178 | 19:01:29 INFO - PROCESS | 14178 | Cycle 1(1): loaded http://localhost:52397/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52397/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:01:30 INFO - PROCESS | 14178 | RSS: Main: 235409408 19:01:30 INFO - PROCESS | 14178 | 19:01:31 INFO - PROCESS | 14178 | Cycle 1(1): loaded http://localhost:52397/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52397/tests/kraken/driver.html?testName=ai-astar) 19:01:32 INFO - PROCESS | 14178 | RSS: Main: 286400512 19:01:32 INFO - PROCESS | 14178 | 19:01:32 INFO - PROCESS | 14178 | __start_tp_report 19:01:32 INFO - PROCESS | 14178 | _x_x_mozilla_page_load 19:01:32 INFO - PROCESS | 14178 | _x_x_mozilla_page_load_details 19:01:32 INFO - PROCESS | 14178 | |i|pagename|runs| 19:01:32 INFO - PROCESS | 14178 | |0;ai-astar;114;114;113;113;113;114;114;114;114;112 19:01:32 INFO - PROCESS | 14178 | |1;audio-beat-detection;151;123;121;161;122;123;125;125;154;126 19:01:32 INFO - PROCESS | 14178 | |2;audio-dft;162;163;163;164;161;162;161;163;161;165 19:01:32 INFO - PROCESS | 14178 | |3;audio-fft;77;75;76;110;77;76;77;75;110;85 19:01:32 INFO - PROCESS | 14178 | |4;audio-oscillator;82;81;123;82;82;82;109;83;83;115 19:01:32 INFO - PROCESS | 14178 | |5;imaging-gaussian-blur;116;117;117;116;117;117;117;117;117;116 19:01:32 INFO - PROCESS | 14178 | |6;imaging-darkroom;146;145;145;147;146;145;146;146;147;145 19:01:32 INFO - PROCESS | 14178 | |7;imaging-desaturate;96;95;96;96;96;96;95;95;96;96 19:01:32 INFO - PROCESS | 14178 | |8;json-parse-financial;51;51;50;51;51;53;53;52;51;52 19:01:32 INFO - PROCESS | 14178 | |9;json-stringify-tinderbox;63;63;63;63;64;63;63;64;63;72 19:01:32 INFO - PROCESS | 14178 | |10;stanford-crypto-aes;80;79;79;80;79;80;79;83;79;78 19:01:32 INFO - PROCESS | 14178 | |11;stanford-crypto-ccm;133;131;131;130;129;140;132;131;211;130 19:01:32 INFO - PROCESS | 14178 | |12;stanford-crypto-pbkdf2;167;168;167;166;166;169;169;166;162;170 19:01:32 INFO - PROCESS | 14178 | |13;stanford-crypto-sha256-iterative;67;65;65;63;65;65;64;67;64;63 19:01:32 INFO - PROCESS | 14178 | __end_tp_report 19:01:32 INFO - PROCESS | 14178 | __start_cc_report 19:01:32 INFO - PROCESS | 14178 | _x_x_mozilla_cycle_collect,1700 19:01:32 INFO - PROCESS | 14178 | __end_cc_report 19:01:32 INFO - PROCESS | 14178 | __startTimestamp1479178892114__endTimestamp 19:01:32 INFO - PROCESS | 14178 | 19:01:32 INFO - PROCESS | 14178 | ------- Summary: start ------- 19:01:32 INFO - PROCESS | 14178 | Number of tests: 14 19:01:32 INFO - PROCESS | 14178 | 19:01:32 INFO - PROCESS | 14178 | [#0] ai-astar Cycles:10 Average:113.50 Median:114.00 stddev:0.71 (0.6%) stddev-sans-first:0.73 19:01:32 INFO - PROCESS | 14178 | Values: 114.0 114.0 113.0 113.0 113.0 114.0 114.0 114.0 114.0 112.0 19:01:32 INFO - PROCESS | 14178 | 19:01:32 INFO - PROCESS | 14178 | [#1] audio-beat-detection Cycles:10 Average:133.10 Median:125.50 stddev:15.60 (12.4%) stddev-sans-first:15.14 19:01:32 INFO - PROCESS | 14178 | Values: 151.0 123.0 121.0 161.0 122.0 123.0 125.0 125.0 154.0 126.0 19:01:32 INFO - PROCESS | 14178 | 19:01:32 INFO - PROCESS | 14178 | [#2] audio-dft Cycles:10 Average:162.50 Median:163.00 stddev:1.35 (0.8%) stddev-sans-first:1.42 19:01:32 INFO - PROCESS | 14178 | Values: 162.0 163.0 163.0 164.0 161.0 162.0 161.0 163.0 161.0 165.0 19:01:32 INFO - PROCESS | 14178 | 19:01:32 INFO - PROCESS | 14178 | [#3] audio-fft Cycles:10 Average:83.80 Median:76.50 stddev:14.10 (18.4%) stddev-sans-first:14.74 19:01:32 INFO - PROCESS | 14178 | Values: 77.0 75.0 76.0 110.0 77.0 76.0 77.0 75.0 110.0 85.0 19:01:32 INFO - PROCESS | 14178 | 19:01:32 INFO - PROCESS | 14178 | [#4] audio-oscillator Cycles:10 Average:92.20 Median:82.00 stddev:16.54 (20.2%) stddev-sans-first:17.12 19:01:32 INFO - PROCESS | 14178 | Values: 82.0 81.0 123.0 82.0 82.0 82.0 109.0 83.0 83.0 115.0 19:01:32 INFO - PROCESS | 14178 | 19:01:32 INFO - PROCESS | 14178 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 19:01:32 INFO - PROCESS | 14178 | Values: 116.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 116.0 19:01:32 INFO - PROCESS | 14178 | 19:01:32 INFO - PROCESS | 14178 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 19:01:32 INFO - PROCESS | 14178 | Values: 146.0 145.0 145.0 147.0 146.0 145.0 146.0 146.0 147.0 145.0 19:01:32 INFO - PROCESS | 14178 | 19:01:32 INFO - PROCESS | 14178 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 19:01:32 INFO - PROCESS | 14178 | Values: 96.0 95.0 96.0 96.0 96.0 96.0 95.0 95.0 96.0 96.0 19:01:32 INFO - PROCESS | 14178 | 19:01:32 INFO - PROCESS | 14178 | [#8] json-parse-financial Cycles:10 Average:51.50 Median:51.50 stddev:0.97 (1.9%) stddev-sans-first:1.01 19:01:32 INFO - PROCESS | 14178 | Values: 51.0 51.0 50.0 51.0 51.0 53.0 53.0 52.0 51.0 52.0 19:01:32 INFO - PROCESS | 14178 | 19:01:32 INFO - PROCESS | 14178 | [#9] json-stringify-tinderbox Cycles:10 Average:64.10 Median:63.00 stddev:2.81 (4.5%) stddev-sans-first:2.95 19:01:32 INFO - PROCESS | 14178 | Values: 63.0 63.0 63.0 63.0 64.0 63.0 63.0 64.0 63.0 72.0 19:01:32 INFO - PROCESS | 14178 | 19:01:32 INFO - PROCESS | 14178 | [#10] stanford-crypto-aes Cycles:10 Average:79.60 Median:79.50 stddev:1.35 (1.7%) stddev-sans-first:1.42 19:01:32 INFO - PROCESS | 14178 | Values: 80.0 79.0 79.0 80.0 79.0 80.0 79.0 83.0 79.0 78.0 19:01:32 INFO - PROCESS | 14178 | 19:01:32 INFO - PROCESS | 14178 | [#11] stanford-crypto-ccm Cycles:10 Average:139.80 Median:131.50 stddev:25.20 (19.2%) stddev-sans-first:26.61 19:01:32 INFO - PROCESS | 14178 | Values: 133.0 131.0 131.0 130.0 129.0 140.0 132.0 131.0 211.0 130.0 19:01:32 INFO - PROCESS | 14178 | 19:01:32 INFO - PROCESS | 14178 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.00 Median:167.50 stddev:2.26 (1.3%) stddev-sans-first:2.40 19:01:32 INFO - PROCESS | 14178 | Values: 167.0 168.0 167.0 166.0 166.0 169.0 169.0 166.0 162.0 170.0 19:01:32 INFO - PROCESS | 14178 | 19:01:32 INFO - PROCESS | 14178 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.80 Median:65.00 stddev:1.40 (2.2%) stddev-sans-first:1.24 19:01:32 INFO - PROCESS | 14178 | Values: 67.0 65.0 65.0 63.0 65.0 65.0 64.0 67.0 64.0 63.0 19:01:32 INFO - PROCESS | 14178 | -------- Summary: end -------- 19:01:32 INFO - PROCESS | 14178 | 19:01:33 INFO - TEST-INFO | 14178: exit 0 19:01:33 INFO - TEST-OK | kraken | took 62267ms 19:01:33 INFO - SUITE-END | took 1181s 19:01:33 INFO - Completed test suite (00:19:41) 19:01:33 INFO - javascript benchmark 19:01:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3140.1521589170916, 3140.5603215549827, 3147.685231476851, 3179.618445786503, 3193.5848339715835, 5319.574434045277, 5324.307839980806, 5385.246065550826, 5422.024035673582, 5423.728813559321, 5345.599080068991, 5433.918491222635, 5434.755436005379, 5466.0, 5556.805511807078, 4849.272609108627, 4910.877228069309, 4919.11455937931, 4937.061958227925, 5009.649324547283, 4901.950980490185, 4963.106640804654, 4977.228529577921, 5010.899782004358, 5035.748212589374, 4979.203327467624, 4989.426215985171, 5018.59851211904, 5045.243213517983, 5074.238864170367, 4824.179889418807, 4862.489438608965, 4867.610591152699, 4886.218205087204, 4951.653384263103, 4934.062528119682, 4936.259561065833, 4951.356323677935, 4985.202367621199, 4991.5258050485145, 5391.676499410009, 5439.184122381635, 5451.836444906619, 5473.75368108436, 5506.724663766796, 5665.093585026376, 5706.201131841545, 5720.513756330717, 5842.883142337129, 5844.912326315109, 5795.275590551181, 5843.649381037151, 5862.589618726691, 5872.647641141545, 5875.471207591295, 5447.264619276387, 5452.482014208644, 5453.700046497481, 5454.509094181542, 5459.69971651559, 5814.156947242626, 5814.476697097281, 5940.0, 5948.851278718067, 5950.375210602911, 5669.489745922887, 5719.8570035749435, 5756.366799652035, 5757.596968212269, 5760.164776107441, 5803.47768700819, 5828.53371730269, 5840.2991641003355, 5843.094320380348, 5897.675627840425, 5817.941820581825, 5819.359870414251, 5820.679862607512, 5827.708614569255, 5837.211976383219, 5639.830805075854, 5706.600537962303, 5708.286464191976, 5776.711164441761, 5883.0, 4422.955770442254, 4489.393931819228, 4496.595306422438, 4515.0518391137575, 4559.908801824011, 4025.054112283611, 4044.373122166069, 4045.37296719009, 4070.1859628074503, 4077.4903137107863, 5347.171188465794, 5584.720763961785, 5593.636413633182, 5601.467860553241, 5605.411431799684, 5773.480386765212, 5775.249217601685, 5818.5054270386645, 5822.475977162076, 5912.852178695481, 5526.309211348582, 5546.69493177871, 5565.165225216169, 5568.582356323292, 5576.749046292926, 5054.393472783216, 5054.873628159252, 5060.5951523878, 5060.797568097309, 5102.591792656579, 5928.525717942554, 5983.623766533635, 5994.100884867217, 6016.849578760566, 6051.4553690168095, 5878.353381128158, 5881.147233651182, 5882.49998750111, 5884.58807883444, 5916.526677865674, 6060.272767267956, 6103.481204097701, 6107.053406721965, 6111.694415279129, 6124.0, 5587.1339942309005, 5622.690752008679, 5624.718764061862, 5730.283714535683, 5766.538676905753, 5763.7118144093465, 5793.159991801081, 5793.710314484343, 5802.767889284381, 5807.94192058074, 5635.690037048002, 5676.460736230051, 5678.3186017678145, 5684.744186511534, 5685.374608792947, 5664.405237450173, 5664.660120392789, 5668.858278543069, 5673.8297851064535, 5675.120356344773, 5589.888202235851, 5602.2717046783655, 5605.103183490622, 5613.522850557748, 5614.63504872182, 5716.857078573069, 5754.4533269339345, 5755.223044888887, 5756.913646295226, 5764.904668113045, 5500.669959802424, 5580.079286917613, 5580.609357344947, 5583.050881350261, 5630.211770352072], "value": 5370.645805526761, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [597.766870920341, 611.3763960760025, 615.1695211464522, 640.2125385775496, 643.2827397451842, 41452.58547414525, 42522.362164567516, 42615.14769704608, 46533.7673311633, 46613.173353330836, 43976.56023439765, 44268.11463770723, 44477.7776111119, 44534.10931781362, 44661.55338446615, 8465.957670211656, 8512.361572882028, 8558.186972237627, 8575.185357391038, 8616.526091064989, 8535.103814099522, 8598.527081010541, 8630.784230394227, 8681.34889883258, 8687.131286871294, 8652.610632521551, 8681.956590217073, 8686.522241276727, 8690.4351217171, 8690.86963695542, 8623.137686231357, 8675.305975521944, 8681.652733890636, 8689.695860644848, 8692.695755648521, 8517.403781735282, 8582.313414926792, 8583.313334933191, 8584.31325493959, 8585.699500517514, 41130.0, 41458.0, 41474.377884331756, 41596.1680766386, 41620.37569436461, 3300.985331711816, 3460.8615655373756, 3527.1005893496995, 3575.106223444139, 3585.748997570171, 31018.20431953374, 31111.533327000114, 31727.206819829687, 32004.199895002577, 32115.678843211503, 4141.852192333818, 4248.256555102876, 4378.408914796525, 4422.823087076513, 4467.128909862578, 328297.0, 328311.0, 328554.9999999976, 328948.0, 330231.0, 58371.70814145902, 59298.22105336847, 59338.0, 59460.70269648624, 59465.70267148637, 61918.0, 62042.68978655078, 62251.0, 62267.0, 62302.68848655728, 16906.915465422593, 17094.572635684206, 17099.23053462597, 17144.742828857576, 17147.657046858993, 12333.753324933452, 12336.0, 12348.506059757508, 12356.62930112098, 12363.0, 16655.41706040283, 18143.455696328867, 18153.636927261647, 18183.545411364557, 18321.51891140679, 6179.28938172107, 6227.844303892349, 6265.310815810257, 6319.33646967071, 6358.300586935434, 930.1767935377104, 940.4357385568604, 972.6887396033202, 1093.9398333091756, 1138.6390125818098, 29585.704142958726, 30576.0, 30820.69179308223, 31112.0, 31759.424955262413, 1072.1208608940594, 1085.0, 1093.3986307530827, 1109.628274528026, 1142.308903113621, 15644.608884777745, 16323.673526529403, 16417.0, 16498.17509124539, 16847.578810529834, 471074.0, 472390.0, 474521.0, 476712.0, 477265.0, 57322.42677573254, 57475.0, 57543.42456575464, 57554.7122264386, 57578.42421575815, 1232.1744431231098, 1283.0954177304977, 1320.8150858879571, 1345.327336331834, 1390.4994202087241, 30145.698543015165, 31247.687523125387, 32237.131544214844, 32582.348353032332, 35431.82284088563, 54474.7276263632, 56403.43596564146, 60880.695596521735, 60888.0, 61032.389676104445, 366785.0, 369584.0, 369609.0, 369726.0, 369823.0, 25373.873130634227, 25400.74599253984, 25843.741562584135, 27400.451990960468, 27775.30561735973, 46187.3071903915, 46814.531854681016, 48056.27915581199, 49948.75025624849, 50409.0, 36828.631713682524, 40033.599664002984, 40812.71554955742, 41376.79311603423, 41897.37153942754, 39622.80188599038, 40071.19857602773, 40573.39139912845, 41090.0, 42354.364684530374, 36752.0, 37785.433218502294, 37907.43138852864, 37912.05219869525, 41666.79166604148, 34814.12964675904, 36321.81839090788, 36577.63422365742, 36772.0, 37147.0, 27803.44393112167, 27926.44147117087, 28046.579301310903, 28180.43639127247, 28262.85868570644], "value": 19670.486647348924, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.49925598953394, 392.34086734286404, 402.31606269342115, 403.34859202388134, 416.1095256151834, 12962.0, 15125.655523393878, 15950.361985520565, 18843.62312753744, 19366.225350985944, 18442.446726598224, 18655.06724663765, 18862.151203195855, 18929.24283028677, 18949.810501894975, 5456.454354564532, 5673.6879471629045, 5678.176664383662, 5680.204771332017, 5681.687507187103, 5314.92027619586, 5586.24585680932, 5602.635828671123, 5607.158926161088, 5608.355039170507, 5571.721413929287, 5577.5498370423575, 5602.579806514507, 5603.943960560383, 5605.943940560604, 5306.681599104047, 5566.777328906859, 5595.832125036255, 5670.432956704338, 5680.261565996435, 5302.655327403745, 5458.344998600153, 5496.697681627509, 5506.311711036121, 5510.008198524264, 13686.110402823784, 13939.930300348535, 20445.0, 21259.574808503745, 21625.134994600197, 2211.303439416579, 2292.2091878302126, 2314.271004633535, 2432.3797431654993, 2818.3236023354452, 9385.765355866159, 9639.951800240953, 9744.0, 9954.701358959242, 10266.178705703525, 1833.4316361927845, 1842.8065053169491, 1875.6835308394122, 1876.9906150469296, 1932.371979106782, 78719.21280787177, 79480.60259698665, 79822.0, 81492.59253703694, 83293.16706832914, 10054.54754536033, 10366.533505992249, 10402.843957340647, 10660.520276587573, 10768.623098191525, 14323.498677546237, 14324.57026289213, 14327.212003339917, 14336.856631433553, 14347.426102955973, 7568.318851303409, 7863.960680196677, 7880.223744875709, 7980.281774640194, 8032.959835200787, 7796.844063118706, 7829.530228186327, 7908.130105688369, 8139.959300203461, 8163.79590510242, 4234.449521562177, 4322.783860806947, 4329.155814616182, 4366.083122544302, 4379.284843397114, 1732.4629364896923, 1930.8165724256173, 1958.8922609256342, 1975.4666240115089, 2018.68710349896, 442.45136031321573, 748.2996581902548, 754.6340025087828, 925.1858364639209, 987.1214618989105, 10796.838047429295, 11636.941815291038, 11737.413129343498, 11793.469293881795, 12142.089343299287, 475.72268459187194, 483.3619622098796, 489.18062245738247, 505.73196206010874, 516.367449873909, 6340.968295158495, 6391.712372943229, 6485.319041500669, 6512.706928188243, 6692.564983276169, 451091.0, 453211.0, 454532.0, 462435.0, 463537.0, 61232.0, 98045.0, 98417.0, 103646.0, 105741.47129264305, 479.62828807674333, 491.52813299232423, 493.96295277855023, 495.22250067393844, 495.38324785642106, 8875.73372798817, 10952.233343665866, 11044.558217671203, 11786.174967752175, 11914.225575337576, 40042.19915601613, 40328.0, 44710.3293450605, 44853.0, 45806.0, 59378.0, 59427.70286148541, 59696.0, 60010.39989600223, 61033.389666104544, 7995.2804247618, 8414.831703365777, 8471.0, 8708.17272359125, 8882.777930551789, 10746.892531074589, 13027.544035958696, 13042.478300868239, 13118.672033199246, 13148.474061037452, 11568.595099171489, 11703.531858725555, 11771.705707357385, 11898.167128301282, 12192.268463892195, 11259.662210133709, 11505.367204803817, 11620.88379116198, 11695.76608467843, 11764.647060588197, 11543.711407214887, 11722.238054526428, 11739.295642261492, 11842.644720658394, 12402.5659101931, 8285.130061343712, 8538.231559159705, 8626.82746345057, 11461.426928653367, 11727.237729547553, 10820.729481763019, 11132.0, 11520.366379849189, 11989.76020479568, 12930.806037909251], "value": 8279.345205464086, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1448.4930274403957, 1493.059372595265, 1627.4059968111635, 1694.5848267174545, 1779.8843075200102, 7534.886976695354, 7770.650320735566, 8126.6749330026805, 8685.522296273703, 8688.044315125331, 8086.231807978247, 8313.418060735736, 8332.500049997005, 8553.74338769838, 8560.229579337858, 2335.4161459635134, 2363.9881800590974, 2367.0, 2367.124164059292, 2367.9408014799683, 2095.7170781944396, 2164.2749678857604, 2327.534493101378, 2371.0634299451795, 2391.784739373456, 2250.85369450986, 2328.0571368595747, 2335.1943579465055, 2340.1341503643675, 2349.612313968193, 2304.020791163757, 2310.202979971924, 2319.5592837360846, 2354.281944007077, 2360.138549429446, 2324.9883750581307, 2341.391238278043, 2342.8242881783935, 2345.8592484450987, 2411.2163546847346, 8428.83142337156, 8601.95699021507, 8618.26744726699, 8620.051794302623, 8622.223999839982, 5138.0, 5260.342457192851, 5266.657667251617, 5276.498732620395, 5282.286891269668, 3383.678550537695, 3570.517980072683, 3602.819859007039, 3644.7995360255177, 3675.1363429594026, 1082.5561519776854, 1126.054114543779, 1167.0721776187952, 1181.5628217559558, 1200.951961921522, 12043.638690839289, 12052.999999999913, 12066.396680165957, 12085.214461060003, 12090.516379344816, 4678.672492925462, 4692.976535117371, 4751.619870410359, 4803.687760295639, 4857.975710121426, 10214.693559193236, 10288.2798204125, 10288.845667314996, 10291.0, 10296.536655850505, 5308.840734777963, 5349.170878513836, 5361.731913404315, 5403.918941215885, 5407.486288802636, 4714.104320179155, 4840.394950631171, 4886.120498310338, 4898.069366820364, 4899.804007839646, 3745.6816170625257, 3859.5368555772925, 3902.8829135125993, 3953.0, 3955.4660120883887, 1189.1259923956059, 1235.123062625546, 1251.6432816647211, 1267.5880338889897, 1291.9741605167844, 834.6869923778584, 841.6338892581747, 948.8861336639509, 980.3578655980202, 981.6367943860818, 5888.087346461305, 5896.498797602252, 5943.435373639497, 6213.720382582795, 6254.2807577129215, 880.8282384934876, 901.693424235763, 914.7987442762582, 958.8274110660149, 975.6780262513354, 3857.7106716996336, 3870.9806450967567, 3922.490076290064, 4104.240715467648, 4152.6055024772595, 10302.896971030194, 10737.570497180182, 10791.352518848737, 10792.51433685486, 10806.567737290577, 10653.017155196558, 10679.092277156373, 10680.198985076151, 10688.732781680364, 10693.9465302673, 7491.325780679765, 7679.500832445985, 7727.574983375968, 7939.166387529226, 8093.797655058553, 5871.2073870027, 5874.825034993104, 5921.348651648229, 5987.700614969322, 6088.360722124113, 9355.906440935776, 9500.382475139093, 9560.0, 9833.852492212765, 9877.506124693593, 9694.321397502106, 9921.751956200864, 9981.650642227487, 9991.500424978867, 10051.547680354548, 7469.178390376946, 7574.431917606092, 7629.2752188542, 7634.312911837961, 7644.961775191088, 8090.352771778362, 8127.634256458356, 8181.754547363588, 8184.631691573774, 8198.0, 7242.311980361857, 7252.41980641558, 7301.379382752525, 7326.523775954546, 7435.591042492715, 7122.786316410516, 7129.643517824192, 7144.428445724434, 7207.315305046012, 7215.891761623475, 6718.294579069323, 6819.5908245505425, 6829.078074460083, 6831.89752153728, 6834.393917429499, 4983.6760610560195, 5227.268182454535, 5273.288106105627, 5333.4133245343755, 5449.754761035683, 5254.238135470259, 5351.759170837244, 5386.461353864583, 5428.511433970962, 5443.156310771837], "value": 4589.30337638274, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [328.0849650852179, 342.874850679502, 343.40247968534754, 346.623913054336, 347.87302634538395, 5118.820841270556, 5186.766595503202, 5255.636392708665, 5291.417944026159, 5296.549793267572, 5070.391553013635, 5123.487651234875, 5142.254373115896, 5149.433562308143, 5162.638615296931, 4084.693647976399, 4099.282625540533, 4105.794710264489, 4108.979455102728, 4114.6091121343425, 3861.5366156061314, 4039.899002524931, 4109.897252568695, 4118.526369467505, 4125.979370103145, 4049.858254961077, 4051.4530538377385, 4052.7770972596495, 4062.939055914164, 4067.755934643916, 4043.2722110020186, 4068.105016896278, 4072.6741860651077, 4072.9796351018203, 4111.465509483778, 3602.0814692253307, 3604.8824864292155, 3607.7113830893727, 3622.492851000862, 3625.456181572759, 5032.672876263031, 5063.544281014726, 5086.262491938685, 5104.923426148611, 5107.540321371094, 4603.5856772890265, 4618.353430519696, 4630.768461576941, 4637.976810115962, 4641.002184530342, 5431.864203394907, 5443.488949627468, 5458.77177635029, 5461.836144915659, 5473.370562385297, 3855.768653880776, 3925.391564307537, 3926.960730392688, 3928.8428462861452, 3932.3118454270675, 5589.245451864028, 5616.775328986836, 5638.633488823254, 5647.943520564783, 5652.34997975234, 4026.8791936241373, 4027.234825383168, 4033.40680431228, 4035.858744943913, 4056.6146216109423, 3858.594847541024, 3985.5815139410524, 3992.5608183099835, 4117.629413352813, 4119.0, 4582.312653101994, 4586.243269860435, 4596.598037598565, 4596.7931443085145, 4597.7011494252765, 5446.210299506629, 5451.781928722886, 5467.261919640877, 5471.480209380103, 5482.91775623366, 1318.8351456067992, 1324.0665330941663, 1339.8745054154556, 1356.6540532164236, 1362.346073884541, 909.5179554835947, 946.5125460387906, 947.7014740356766, 950.1733491862125, 953.2326477185793, 5097.337346144977, 5107.259447380184, 5129.435762066169, 5159.74201289934, 5162.638615296968, 5426.860359324586, 5434.293541839615, 5440.564754819605, 5457.345118585795, 5463.617546771768, 4929.728864912393, 5145.897082058338, 5172.741362931838, 5177.922331165036, 5189.197833170046, 2838.4748821467683, 2862.341661417844, 2867.4659057404187, 2873.367859071001, 2873.8302581550797, 5544.390117087117, 5565.358219325309, 5584.664920104726, 5587.832365029056, 5606.887862242814, 5229.581633469314, 5297.337832770903, 5341.412444631087, 5349.331333583302, 5430.83707488776, 5471.890562188734, 5494.945050549523, 5528.530074943675, 5536.7785288588, 5538.889222215614, 5344.652597581145, 5344.9732751336, 5346.652467589594, 5350.100714246387, 5350.839474815762, 5254.15933450646, 5574.888502230014, 5577.498025177753, 5595.608307418604, 5611.971940140274, 5820.388859169726, 5824.718561916372, 5836.358000619844, 5855.2973643163095, 5855.385184555731, 4005.2189822985406, 4033.5764744702556, 4071.959280407158, 4073.2668119737546, 4082.897927551835, 5299.284596579412, 5608.38307786135, 5618.185363122243, 5629.380768115586, 5637.182608521824, 5309.973450132725, 5366.302380690485, 5420.620556561003, 5451.918221226605, 5485.6434331768305, 5428.37573679032, 5488.560915126701, 5507.917381239365, 5529.4470552944385, 5538.6399884007415, 5261.868453288545, 5437.4562543745305, 5445.83662490126, 5458.089668615953, 5481.808136715196, 5527.291627102611, 5544.500994910478, 5547.556195504269, 5548.085910360919, 5551.666899986014, 5355.758990845499, 5427.472143106854, 5431.212474191299, 5444.6188766785945, 5445.891082178414], "value": 4142.788581942278, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [695.6452209373219, 714.731975509184, 732.9377002954745, 763.7365109037383, 783.4907310248336, 12857.871421285785, 13847.238401887893, 13921.44314227431, 13977.79033314501, 14453.277336133178, 13568.185908845477, 13736.969727270445, 13853.099548529339, 13883.930580347109, 13886.4445422183, 776.227653484782, 787.7479206653844, 787.7715462515863, 788.2826627768732, 788.996055019724, 678.4843518925603, 701.824543864034, 783.7021931665959, 796.0, 810.4448452809814, 843.0557775291682, 843.784834867108, 847.1232274595794, 847.3644766425181, 847.5550336073549, 840.315143158324, 840.6511297811401, 841.20506121715, 841.2680967558202, 841.6212704283097, 518.8443466959897, 532.3771187710388, 597.3638075449633, 609.9176611157482, 614.2904944788776, 12633.178843375152, 12689.23864568129, 12696.047796415305, 12696.80954785679, 12705.0, 12834.486620535261, 12899.419526121346, 13314.0, 13444.126131801499, 13549.661258468617, 11531.76936461266, 11582.0, 11610.76778464426, 11675.416229188506, 11772.587959421464, 4100.36444351126, 4120.587941205886, 4202.138561594866, 4209.663226941868, 4230.02709376842, 59973.0, 60137.79035467519, 60174.0, 60849.0, 63060.36939630637, 10118.848217276747, 10323.63867264642, 10372.170226381872, 10491.639381139183, 10806.78386432267, 18131.0, 19143.61712765737, 19251.32620358309, 19389.321373751853, 19445.31941382045, 7658.73194438192, 7784.571848548271, 7806.687732490636, 7902.0912595052305, 8040.15578364275, 4023.758574485482, 4027.0, 4152.937705934413, 4160.292750232467, 4318.52496225415, 3263.983680081632, 3353.765236433475, 3362.2434952135573, 3374.746893982961, 3378.6452422495286, 588.2088590845307, 597.7608956417381, 606.5208485296655, 611.3458599298708, 625.8091282158895, 603.3092109534558, 609.3632154398664, 616.3651439017818, 659.1760299625469, 681.9693113809791, 9122.407043542149, 9294.90705092954, 9411.764705882408, 9552.952235238918, 9613.807723845484, 631.2961048430966, 644.577801539992, 656.0028756290412, 682.1711620381261, 690.5787469643514, 4389.363542286351, 4433.467983841895, 4492.685512014127, 4539.6368290536675, 4572.497025327211, 84799.0, 87251.0, 87616.56191719, 87633.5618321917, 87826.0, 50828.491715082375, 62239.688801555705, 75718.62140689371, 77902.0, 80738.19261807424, 45976.0, 58003.709981450666, 67790.66104669445, 67974.66012670004, 68600.0, 8381.203785640355, 8543.786405339917, 8564.700235491728, 8570.571471426529, 8668.869966950628, 36620.0, 45788.0, 45962.08075838532, 46258.0, 47968.28047579359, 46704.0, 60877.0, 61307.386926130166, 61747.0, 64099.67950160219, 10282.434466104436, 10806.405647689138, 10893.673189804318, 11130.721731956766, 11170.162237832032, 12064.45709943037, 12153.513859445877, 12272.570460033856, 12473.0, 12530.93734531358, 11863.060109835842, 11875.82186267224, 12079.0, 12278.877211228131, 12868.678283042998, 10171.440570768384, 11472.94263528677, 11526.250793698719, 12407.379631018593, 12441.93779031099, 12311.507539698312, 12489.687757806127, 12596.874031259937, 12695.746085078063, 13247.138935969131, 10141.239407044353, 10274.948625256826, 10662.73343166427, 10883.238173328107, 10958.945205273923, 10909.672709818718, 11072.667819965414, 11085.778284434105, 11409.60066397672, 11508.42457877086], "value": 6799.567090000368, "unit": "score"}], "name": "dromaeo_css", "value": 6953.984775300747, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 113.0, 113.0, 113.0, 114.0, 114.0, 114.0, 114.0, 112.0], "value": 113.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 123.0, 121.0, 161.0, 122.0, 123.0, 125.0, 125.0, 154.0, 126.0], "value": 133.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 163.0, 164.0, 161.0, 162.0, 161.0, 163.0, 161.0, 165.0], "value": 162.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 76.0, 110.0, 77.0, 76.0, 77.0, 75.0, 110.0, 85.0], "value": 83.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 123.0, 82.0, 82.0, 82.0, 109.0, 83.0, 83.0, 115.0], "value": 92.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 145.0, 147.0, 146.0, 145.0, 146.0, 146.0, 147.0, 145.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0, 96.0, 96.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 50.0, 51.0, 51.0, 53.0, 53.0, 52.0, 51.0, 52.0], "value": 51.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 63.0, 64.0, 63.0, 63.0, 64.0, 63.0, 72.0], "value": 64.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 79.0, 80.0, 79.0, 80.0, 79.0, 83.0, 79.0, 78.0], "value": 79.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 131.0, 131.0, 130.0, 129.0, 140.0, 132.0, 131.0, 211.0, 130.0], "value": 139.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 168.0, 167.0, 166.0, 166.0, 169.0, 169.0, 166.0, 162.0, 170.0], "value": 167.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 65.0, 63.0, 65.0, 65.0, 64.0, 67.0, 64.0, 63.0], "value": 64.8, "unit": "score"}], "name": "kraken", "value": 1510.1, "alertThreshold": 2.0}]} 19:01:33 INFO - Return code: 0 19:01:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:01:33 INFO - # TBPL SUCCESS # 19:01:33 INFO - Running post-action listener: _resource_record_post_action 19:01:33 INFO - [mozharness: 2016-11-15 03:01:33.946246Z] Finished run-tests step (success) 19:01:33 INFO - Running post-run listener: _resource_record_post_run 19:01:34 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 0; Write bytes: 402403328; Read time: 0; Write time: 299000 19:01:34 INFO - TinderboxPrint: CPU usage
13.1% 19:01:34 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 19:01:34 INFO - TinderboxPrint: I/O write bytes / time
402,403,328 / 299,000 19:01:34 INFO - TinderboxPrint: CPU idle
8,313.3 (86.9%) 19:01:34 INFO - TinderboxPrint: CPU user
1,201.7 (12.6%) 19:01:34 INFO - TinderboxPrint: Swap in / out
0 / 0 19:01:34 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 114470912; Read time: 0; Write time: 103088 19:01:34 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 0; Write bytes: 286990336; Read time: 0; Write time: 195908 19:01:34 INFO - Running post-run listener: _upload_blobber_files 19:01:34 INFO - Blob upload gear active. 19:01:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:01:34 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 19:01:34 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'] 19:01:34 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 19:01:35 INFO - (blobuploader) - INFO - Open directory for files ... 19:01:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:01:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:01:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:01:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:01:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:01:35 INFO - (blobuploader) - INFO - Done attempting. 19:01:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:01:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:01:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:01:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:01:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:01:36 INFO - (blobuploader) - INFO - Done attempting. 19:01:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:01:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:01:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:01:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:01:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:01:40 INFO - (blobuploader) - INFO - Done attempting. 19:01:40 INFO - (blobuploader) - INFO - Iteration through files over. 19:01:40 INFO - Return code: 0 19:01:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:01:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:01:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f4a095c73ff4bdc81fa4888aa1c20c11503d61c540a38290faa4c211d3ae2fe77b0a7aa9dbc5aba8c109ac0802b5bd955b58e8934231e54d3136ac869102a194", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0a8d0e04f939bfaf49f45e004eb91b1d59531ee24e66d3e8c0ab37b8303715853c8fcbfcb025ff4c4bf146adccaf3860b9aac2ab356179da400cd12aaf41a8bb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2a4078553d0c08152880f4b9c09e30f46bbfae7b3505834018fb9608dd7fd6f0747f318801ed70ca99758396452c62045ef85042bff51098a664c0368530e5bf"} 19:01:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:01:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:01:40 INFO - Contents: 19:01:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f4a095c73ff4bdc81fa4888aa1c20c11503d61c540a38290faa4c211d3ae2fe77b0a7aa9dbc5aba8c109ac0802b5bd955b58e8934231e54d3136ac869102a194", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0a8d0e04f939bfaf49f45e004eb91b1d59531ee24e66d3e8c0ab37b8303715853c8fcbfcb025ff4c4bf146adccaf3860b9aac2ab356179da400cd12aaf41a8bb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2a4078553d0c08152880f4b9c09e30f46bbfae7b3505834018fb9608dd7fd6f0747f318801ed70ca99758396452c62045ef85042bff51098a664c0368530e5bf"} 19:01:40 INFO - Running post-run listener: copy_logs_to_upload_dir 19:01:40 INFO - Copying logs to upload dir... 19:01:40 INFO - mkdir: /builds/slave/test/build/upload/logs 19:01:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.097646 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-11-14 19:01:39.986136) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-14 19:01:39.989580) ========= 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=14ef55db36f7623abb31b9cf000001d5-1479177659.525153-1720934038 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/f4a095c73ff4bdc81fa4888aa1c20c11503d61c540a38290faa4c211d3ae2fe77b0a7aa9dbc5aba8c109ac0802b5bd955b58e8934231e54d3136ac869102a194", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0a8d0e04f939bfaf49f45e004eb91b1d59531ee24e66d3e8c0ab37b8303715853c8fcbfcb025ff4c4bf146adccaf3860b9aac2ab356179da400cd12aaf41a8bb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2a4078553d0c08152880f4b9c09e30f46bbfae7b3505834018fb9608dd7fd6f0747f318801ed70ca99758396452c62045ef85042bff51098a664c0368530e5bf"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479166498/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011597 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479166498/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f4a095c73ff4bdc81fa4888aa1c20c11503d61c540a38290faa4c211d3ae2fe77b0a7aa9dbc5aba8c109ac0802b5bd955b58e8934231e54d3136ac869102a194", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0a8d0e04f939bfaf49f45e004eb91b1d59531ee24e66d3e8c0ab37b8303715853c8fcbfcb025ff4c4bf146adccaf3860b9aac2ab356179da400cd12aaf41a8bb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2a4078553d0c08152880f4b9c09e30f46bbfae7b3505834018fb9608dd7fd6f0747f318801ed70ca99758396452c62045ef85042bff51098a664c0368530e5bf"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-14 19:01:40.016038) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 19:01:40.016470) ========= 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=14ef55db36f7623abb31b9cf000001d5-1479177659.525153-1720934038 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004452 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 19:01:40.101700) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-14 19:01:40.102114) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-14 19:01:40.102484) ========= ========= Total master_lag: 0.18 =========