builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-026 starttime: 1477832058.43 results: success (0) buildid: 20161030053706 builduid: 48f5d38462ed465a8ce2d6f2acc6d644 revision: 94d5d14da6bac6f013d6cc1187ac218092cea05e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-30 05:54:18.425979) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-30 05:54:18.426478) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-30 05:54:18.426762) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-30 05:54:18.442310) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-30 05:54:18.442745) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41bf3e9aed84707956354da8000001c5-1477832058.329704-471705509 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-30 05:54:19-- 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% 46.2M=0s 2016-10-30 05:54:19 (46.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.072764 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-30 05:54:18.529854) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-30 05:54:18.530171) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41bf3e9aed84707956354da8000001c5-1477832058.329704-471705509 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014398 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-30 05:54:18.579264) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-30 05:54:18.579650) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 94d5d14da6bac6f013d6cc1187ac218092cea05e --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 94d5d14da6bac6f013d6cc1187ac218092cea05e --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41bf3e9aed84707956354da8000001c5-1477832058.329704-471705509 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-30 05:54:19,256 truncating revision to first 12 chars 2016-10-30 05:54:19,256 Setting DEBUG logging. 2016-10-30 05:54:19,256 attempt 1/10 2016-10-30 05:54:19,256 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/94d5d14da6ba?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-30 05:54:20,734 unpacking tar archive at: mozilla-inbound-94d5d14da6ba/testing/mozharness/ program finished with exit code 0 elapsedTime=1.823206 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-30 05:54:20.417241) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-30 05:54:20.417600) ========= script_repo_revision: 94d5d14da6bac6f013d6cc1187ac218092cea05e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-30 05:54:20.417989) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-30 05:54:20.418325) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-30 05:54:20.428668) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-10-30 05:54:20.429056) ========= /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=41bf3e9aed84707956354da8000001c5-1477832058.329704-471705509 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:54:21 INFO - MultiFileLogger online at 20161030 05:54:21 in /builds/slave/test 05:54:21 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 05:54:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:54:21 INFO - {'append_to_log': False, 05:54:21 INFO - 'base_work_dir': '/builds/slave/test', 05:54:21 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 05:54:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:54:21 INFO - 'branch': 'Mozilla-Inbound', 05:54:21 INFO - 'buildbot_json_path': 'buildprops.json', 05:54:21 INFO - 'config_files': ('talos/linux_config.py',), 05:54:21 INFO - 'default_actions': ('clobber', 05:54:21 INFO - 'read-buildbot-config', 05:54:21 INFO - 'download-and-extract', 05:54:21 INFO - 'populate-webroot', 05:54:21 INFO - 'create-virtualenv', 05:54:21 INFO - 'install', 05:54:21 INFO - 'run-tests'), 05:54:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:54:21 INFO - 'download_minidump_stackwalk': True, 05:54:21 INFO - 'download_symbols': 'ondemand', 05:54:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:54:21 INFO - 'tooltool.py': '/tools/tooltool.py', 05:54:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:54:21 INFO - '/tools/misc-python/virtualenv.py')}, 05:54:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:54:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:54:21 INFO - 'installer_path': 'installer.exe', 05:54:21 INFO - 'log_level': 'info', 05:54:21 INFO - 'log_name': 'talos', 05:54:21 INFO - 'log_to_console': True, 05:54:21 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:54:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:54:21 INFO - 'opt_config_files': (), 05:54:21 INFO - 'pip_index': False, 05:54:21 INFO - 'sps_profile': False, 05:54:21 INFO - 'sps_profile_interval': 0, 05:54:21 INFO - 'suite': 'dromaeojs', 05:54:21 INFO - 'system_bits': '32', 05:54:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:54:21 INFO - 'title': 'talos-linux64-ix-026', 05:54:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:54:21 INFO - 'use_talos_json': True, 05:54:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:54:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:54:21 INFO - 'work_dir': 'build'} 05:54:21 INFO - [mozharness: 2016-10-30 12:54:21.205283Z] Running clobber step. 05:54:21 INFO - Running pre-action listener: _resource_record_pre_action 05:54:21 INFO - Running main action method: clobber 05:54:21 INFO - rmtree: /builds/slave/test/build 05:54:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:54:21 INFO - Running post-action listener: _resource_record_post_action 05:54:21 INFO - [mozharness: 2016-10-30 12:54:21.667016Z] Finished clobber step (success) 05:54:21 INFO - [mozharness: 2016-10-30 12:54:21.667116Z] Running read-buildbot-config step. 05:54:21 INFO - Running pre-action listener: _resource_record_pre_action 05:54:21 INFO - Running main action method: read_buildbot_config 05:54:21 INFO - Using buildbot properties: 05:54:21 INFO - { 05:54:21 INFO - "project": "", 05:54:21 INFO - "product": "firefox", 05:54:21 INFO - "script_repo_revision": "production", 05:54:21 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 05:54:21 INFO - "repository": "", 05:54:21 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 05:54:21 INFO - "buildid": "20161030053706", 05:54:21 INFO - "stage_platform": "linux64-pgo", 05:54:21 INFO - "basedir": "/builds/slave/test", 05:54:21 INFO - "buildnumber": 1863, 05:54:21 INFO - "platform": "ubuntu64_hw", 05:54:21 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:54:21 INFO - "slavebuilddir": "test", 05:54:21 INFO - "branch": "mozilla-inbound", 05:54:21 INFO - "revision": "94d5d14da6bac6f013d6cc1187ac218092cea05e", 05:54:21 INFO - "slavename": "talos-linux64-ix-026", 05:54:21 INFO - "builduid": "48f5d38462ed465a8ce2d6f2acc6d644", 05:54:21 INFO - "repo_path": "integration/mozilla-inbound" 05:54:21 INFO - } 05:54:21 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477683089/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 05:54:21 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477683089/firefox-52.0a1.en-US.linux-x86_64.test_packages.json. 05:54:21 INFO - Running post-action listener: _resource_record_post_action 05:54:21 INFO - [mozharness: 2016-10-30 12:54:21.669448Z] Finished read-buildbot-config step (success) 05:54:21 INFO - [mozharness: 2016-10-30 12:54:21.669534Z] Running download-and-extract step. 05:54:21 INFO - Running pre-action listener: _resource_record_pre_action 05:54:21 INFO - Running main action method: download_and_extract 05:54:21 INFO - mkdir: /builds/slave/test/build/tests 05:54:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:21 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477683089/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 05:54:21 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477683089/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 05:54:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477683089/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 05:54:21 INFO - Downloaded 1361 bytes. 05:54:21 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 05:54:21 INFO - Using the following test package requirements: 05:54:21 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 05:54:21 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:54:21 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:54:21 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:54:21 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:54:21 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:54:21 INFO - u'jsshell-linux-x86_64.zip'], 05:54:21 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:54:21 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:54:21 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 05:54:21 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:54:21 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:54:21 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:54:21 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:54:21 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:54:21 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:54:21 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:54:21 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:54:21 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:54:21 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/1477683089/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 05:54:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477683089/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:54:21 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477683089/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 05:54:21 INFO - Http code: 200 05:54:21 INFO - via: 1.1 0cf1d7257c633ae75623c5e75bf3805e.cloudfront.net (CloudFront) 05:54:21 INFO - x-amz-cf-id: pFnxNr4gN1yZ23EXPVHK3n2k_sv3-pyGRxaJtq1yfONywD_w0Jk33A== 05:54:21 INFO - x-amz-replication-status: PENDING 05:54:21 INFO - x-amz-version-id: Oee3ztsHDgXMLOBMu9aIc_Dg40Lf3A2k 05:54:22 INFO - Expected file size: 22005815 05:54:22 INFO - Obtained file size: 22005815 05:54:26 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 05:54:26 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/1477683089/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 05:54:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477683089/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:54:26 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477683089/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 05:54:26 INFO - Http code: 200 05:54:26 INFO - via: 1.1 0302e8c462515ae281b72d9c815a5698.cloudfront.net (CloudFront) 05:54:26 INFO - x-amz-cf-id: eMiqU2bIq2iozyNcgypeReIf7U3z1244rcqp352pIcef8rAWMEWlSg== 05:54:26 INFO - x-amz-replication-status: PENDING 05:54:26 INFO - x-amz-version-id: Oee3ztsHDgXMLOBMu9aIc_Dg40Lf3A2k 05:54:26 INFO - Expected file size: 22005815 05:54:26 INFO - Obtained file size: 22005815 05:54:30 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/1477683089/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 05:54:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477683089/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:54:30 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477683089/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 05:54:30 INFO - Http code: 200 05:54:30 INFO - via: 1.1 1b52a5dd431f9e3c81753e61dfdf467a.cloudfront.net (CloudFront) 05:54:30 INFO - x-amz-cf-id: yFnL92cLAL8hqrGrsB0CqwlZQthUehU0povV6JE2l68D_oFBywsAfQ== 05:54:30 INFO - x-amz-replication-status: PENDING 05:54:30 INFO - x-amz-version-id: AYMC0.XxpNIzkjrTtsNUJv2GfzEPylNS 05:54:31 INFO - Expected file size: 14409030 05:54:31 INFO - Obtained file size: 14409030 05:54:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:31 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477683089/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 05:54:31 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477683089/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 05:54:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477683089/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 05:54:31 INFO - Downloaded 59394791 bytes. 05:54:31 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477683089/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 05:54:31 INFO - mkdir: /builds/slave/test/properties 05:54:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:54:31 INFO - Writing to file /builds/slave/test/properties/build_url 05:54:31 INFO - Contents: 05:54:31 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477683089/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 05:54:32 INFO - Running post-action listener: _resource_record_post_action 05:54:32 INFO - Running post-action listener: set_extra_try_arguments 05:54:32 INFO - [mozharness: 2016-10-30 12:54:32.311934Z] Finished download-and-extract step (success) 05:54:32 INFO - [mozharness: 2016-10-30 12:54:32.312161Z] Running populate-webroot step. 05:54:32 INFO - Running pre-action listener: _resource_record_pre_action 05:54:32 INFO - Running main action method: populate_webroot 05:54:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:54:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:54:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:54:32 INFO - '--tppagecycles', 05:54:32 INFO - '7'], 05:54:32 INFO - 'tests': ['tsvgm']}}, 05:54:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:54:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:54:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:54:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:54:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:54:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:54:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:32 INFO - 'talos_options': ['--disable-e10s'], 05:54:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:54:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:54:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:32 INFO - 'talos_options': ['--disable-e10s'], 05:54:32 INFO - 'tests': ['damp', 'tps']}, 05:54:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:32 INFO - 'tests': ['damp', 'tps']}, 05:54:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:54:32 INFO - 'tests': ['dromaeo_dom']}, 05:54:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:54:32 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:54:32 INFO - 'tests': ['basic_compositor_video']}, 05:54:32 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:54:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:54:32 INFO - 'tests': ['a11yr', 05:54:32 INFO - 'ts_paint', 05:54:32 INFO - 'tpaint', 05:54:32 INFO - 'sessionrestore', 05:54:32 INFO - 'sessionrestore_no_auto_restore', 05:54:32 INFO - 'tabpaint']}, 05:54:32 INFO - 'other-e10s': {'tests': ['a11yr', 05:54:32 INFO - 'ts_paint', 05:54:32 INFO - 'tpaint', 05:54:32 INFO - 'sessionrestore', 05:54:32 INFO - 'sessionrestore_no_auto_restore', 05:54:32 INFO - 'tabpaint']}, 05:54:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:54:32 INFO - 'ts_paint', 05:54:32 INFO - 'tpaint', 05:54:32 INFO - 'sessionrestore', 05:54:32 INFO - 'sessionrestore_no_auto_restore', 05:54:32 INFO - 'tabpaint']}, 05:54:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:54:32 INFO - 'ts_paint', 05:54:32 INFO - 'tpaint', 05:54:32 INFO - 'sessionrestore', 05:54:32 INFO - 'sessionrestore_no_auto_restore', 05:54:32 INFO - 'tabpaint']}, 05:54:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:54:32 INFO - 'tests': ['a11yr', 05:54:32 INFO - 'ts_paint', 05:54:32 INFO - 'tpaint', 05:54:32 INFO - 'sessionrestore', 05:54:32 INFO - 'sessionrestore_no_auto_restore', 05:54:32 INFO - 'tabpaint']}, 05:54:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:54:32 INFO - 'tests': ['a11yr', 05:54:32 INFO - 'ts_paint', 05:54:32 INFO - 'tpaint', 05:54:32 INFO - 'sessionrestore', 05:54:32 INFO - 'sessionrestore_no_auto_restore', 05:54:32 INFO - 'tabpaint']}, 05:54:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:54:32 INFO - 'tests': ['tsvgx', 05:54:32 INFO - 'tsvgr_opacity', 05:54:32 INFO - 'tart', 05:54:32 INFO - 'tscrollx', 05:54:32 INFO - 'cart']}, 05:54:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:54:32 INFO - 'tsvgr_opacity', 05:54:32 INFO - 'tart', 05:54:32 INFO - 'tscrollx', 05:54:32 INFO - 'cart']}, 05:54:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:32 INFO - 'talos_options': ['--disable-e10s'], 05:54:32 INFO - 'tests': ['tp5o']}, 05:54:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:32 INFO - 'tests': ['tp5o']}, 05:54:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:32 INFO - 'talos_options': ['--disable-e10s', 05:54:32 INFO - '--xperf_path', 05:54:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:54:32 INFO - 'tests': ['tp5n']}, 05:54:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:32 INFO - 'talos_options': ['--xperf_path', 05:54:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:54:32 INFO - 'tests': ['tp5n']}}, 05:54:32 INFO - 'talos.zip': {'path': '', 05:54:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:54:32 INFO - Running post-action listener: _resource_record_post_action 05:54:32 INFO - [mozharness: 2016-10-30 12:54:32.334751Z] Finished populate-webroot step (success) 05:54:32 INFO - [mozharness: 2016-10-30 12:54:32.334839Z] Running create-virtualenv step. 05:54:32 INFO - Running pre-action listener: _resource_record_pre_action 05:54:32 INFO - Running main action method: create_virtualenv 05:54:32 INFO - Creating virtualenv /builds/slave/test/build/venv 05:54:32 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 05:54:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:54:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:54:32 INFO - Using real prefix '/usr' 05:54:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:54:32 INFO - Installing distribute.............................................................................................................................................................................................done. 05:54:34 INFO - Installing pip.................done. 05:54:34 INFO - Return code: 0 05:54:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:54:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:54:35 INFO - Reading from file tmpfile_stdout 05:54:35 INFO - Output received: 05:54:35 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) 05:54:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:54:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:35 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 0x7f008be9ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x157d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x164aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1647f60>, '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 0x1648d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16491d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1477832058.329704-471705509', '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 05:54:35 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 05:54:35 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 05:54:35 INFO - Using env: {'DISPLAY': ':0', 05:54:35 INFO - 'HOME': '/home/cltbld', 05:54:35 INFO - 'LANG': 'en_US.UTF-8', 05:54:35 INFO - 'LANGUAGE': 'en_US:en', 05:54:35 INFO - 'LOGNAME': 'cltbld', 05:54:35 INFO - 'MAIL': '/var/mail/cltbld', 05:54:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:35 INFO - 'MOZ_NO_REMOTE': '1', 05:54:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:54:35 INFO - 'NO_EM_RESTART': '1', 05:54:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:54:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:35 INFO - 'PWD': '/builds/slave/test', 05:54:35 INFO - 'SHELL': '/bin/bash', 05:54:35 INFO - 'SHLVL': '1', 05:54:35 INFO - 'TERM': 'linux', 05:54:35 INFO - 'TMOUT': '86400', 05:54:35 INFO - 'USER': 'cltbld', 05:54:35 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1477832058.329704-471705509', 05:54:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:35 INFO - '_': '/tools/buildbot/bin/python'} 05:54:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:35 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 05:54:35 INFO - Cleaning up... 05:54:35 INFO - Return code: 0 05:54:35 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:54:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:35 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 0x7f008be9ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x157d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x164aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1647f60>, '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 0x1648d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16491d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1477832058.329704-471705509', '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 05:54:35 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 05:54:35 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 05:54:35 INFO - Using env: {'DISPLAY': ':0', 05:54:35 INFO - 'HOME': '/home/cltbld', 05:54:35 INFO - 'LANG': 'en_US.UTF-8', 05:54:35 INFO - 'LANGUAGE': 'en_US:en', 05:54:35 INFO - 'LOGNAME': 'cltbld', 05:54:35 INFO - 'MAIL': '/var/mail/cltbld', 05:54:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:35 INFO - 'MOZ_NO_REMOTE': '1', 05:54:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:54:35 INFO - 'NO_EM_RESTART': '1', 05:54:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:54:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:35 INFO - 'PWD': '/builds/slave/test', 05:54:35 INFO - 'SHELL': '/bin/bash', 05:54:35 INFO - 'SHLVL': '1', 05:54:35 INFO - 'TERM': 'linux', 05:54:35 INFO - 'TMOUT': '86400', 05:54:35 INFO - 'USER': 'cltbld', 05:54:35 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1477832058.329704-471705509', 05:54:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:35 INFO - '_': '/tools/buildbot/bin/python'} 05:54:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:35 INFO - Downloading/unpacking psutil>=3.1.1 05:54:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:54:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:54:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:54:37 INFO - Installing collected packages: psutil 05:54:37 INFO - Running setup.py install for psutil 05:54:37 INFO - building 'psutil._psutil_linux' extension 05:54:37 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 05:54:37 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 05:54:37 INFO - building 'psutil._psutil_posix' extension 05:54:37 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 05:54:37 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 05:54:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:54:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:54:38 INFO - Successfully installed psutil 05:54:38 INFO - Cleaning up... 05:54:38 INFO - Return code: 0 05:54:38 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:54:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f008be9ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x157d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x164aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1647f60>, '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 0x1648d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16491d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1477832058.329704-471705509', '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 05:54:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:54:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:54:38 INFO - Using env: {'DISPLAY': ':0', 05:54:38 INFO - 'HOME': '/home/cltbld', 05:54:38 INFO - 'LANG': 'en_US.UTF-8', 05:54:38 INFO - 'LANGUAGE': 'en_US:en', 05:54:38 INFO - 'LOGNAME': 'cltbld', 05:54:38 INFO - 'MAIL': '/var/mail/cltbld', 05:54:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:38 INFO - 'MOZ_NO_REMOTE': '1', 05:54:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:54:38 INFO - 'NO_EM_RESTART': '1', 05:54:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:54:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:38 INFO - 'PWD': '/builds/slave/test', 05:54:38 INFO - 'SHELL': '/bin/bash', 05:54:38 INFO - 'SHLVL': '1', 05:54:38 INFO - 'TERM': 'linux', 05:54:38 INFO - 'TMOUT': '86400', 05:54:38 INFO - 'USER': 'cltbld', 05:54:38 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1477832058.329704-471705509', 05:54:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:38 INFO - '_': '/tools/buildbot/bin/python'} 05:54:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:38 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:54:38 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 05:54:38 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 05:54:38 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 05:54:38 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 05:54:38 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 05:54:38 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 05:54:40 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:54:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:54:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:54:40 INFO - Installing collected packages: mozsystemmonitor 05:54:40 INFO - Running setup.py install for mozsystemmonitor 05:54:40 INFO - Successfully installed mozsystemmonitor 05:54:40 INFO - Cleaning up... 05:54:40 INFO - Return code: 0 05:54:40 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:54:40 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')]} 05:54:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:40 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')]} 05:54:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:40 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 0x7f008be9ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x157d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x164aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1647f60>, '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 0x1648d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16491d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1477832058.329704-471705509', '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 05:54:40 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 05:54:40 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 05:54:40 INFO - Using env: {'DISPLAY': ':0', 05:54:40 INFO - 'HOME': '/home/cltbld', 05:54:40 INFO - 'LANG': 'en_US.UTF-8', 05:54:40 INFO - 'LANGUAGE': 'en_US:en', 05:54:40 INFO - 'LOGNAME': 'cltbld', 05:54:40 INFO - 'MAIL': '/var/mail/cltbld', 05:54:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:40 INFO - 'MOZ_NO_REMOTE': '1', 05:54:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:54:40 INFO - 'NO_EM_RESTART': '1', 05:54:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:54:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:40 INFO - 'PWD': '/builds/slave/test', 05:54:40 INFO - 'SHELL': '/bin/bash', 05:54:40 INFO - 'SHLVL': '1', 05:54:40 INFO - 'TERM': 'linux', 05:54:40 INFO - 'TMOUT': '86400', 05:54:40 INFO - 'USER': 'cltbld', 05:54:40 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1477832058.329704-471705509', 05:54:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:40 INFO - '_': '/tools/buildbot/bin/python'} 05:54:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:40 INFO - Downloading/unpacking jsonschema==2.5.1 05:54:40 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 05:54:40 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 05:54:40 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 05:54:40 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 05:54:40 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 05:54:40 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 05:54:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:54:42 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:54:42 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 05:54:42 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 05:54:42 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 05:54:42 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 05:54:42 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 05:54:42 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 05:54:42 INFO - Downloading functools32-3.2.3-2.tar.gz 05:54:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:54:42 INFO - warning: no files found matching '*.txt' 05:54:42 INFO - no previously-included directories found matching 'build' 05:54:42 INFO - no previously-included directories found matching 'dist' 05:54:42 INFO - no previously-included directories found matching '.git*' 05:54:42 INFO - Installing collected packages: jsonschema, functools32 05:54:42 INFO - Running setup.py install for functools32 05:54:43 INFO - warning: no files found matching '*.txt' 05:54:43 INFO - no previously-included directories found matching 'build' 05:54:43 INFO - no previously-included directories found matching 'dist' 05:54:43 INFO - no previously-included directories found matching '.git*' 05:54:43 INFO - Successfully installed jsonschema functools32 05:54:43 INFO - Cleaning up... 05:54:43 INFO - Return code: 0 05:54:43 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:54:43 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')]} 05:54:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:43 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')]} 05:54:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:43 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 0x7f008be9ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x157d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x164aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1647f60>, '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 0x1648d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16491d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1477832058.329704-471705509', '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 05:54:43 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 05:54:43 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 05:54:43 INFO - Using env: {'DISPLAY': ':0', 05:54:43 INFO - 'HOME': '/home/cltbld', 05:54:43 INFO - 'LANG': 'en_US.UTF-8', 05:54:43 INFO - 'LANGUAGE': 'en_US:en', 05:54:43 INFO - 'LOGNAME': 'cltbld', 05:54:43 INFO - 'MAIL': '/var/mail/cltbld', 05:54:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:43 INFO - 'MOZ_NO_REMOTE': '1', 05:54:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:54:43 INFO - 'NO_EM_RESTART': '1', 05:54:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:54:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:43 INFO - 'PWD': '/builds/slave/test', 05:54:43 INFO - 'SHELL': '/bin/bash', 05:54:43 INFO - 'SHLVL': '1', 05:54:43 INFO - 'TERM': 'linux', 05:54:43 INFO - 'TMOUT': '86400', 05:54:43 INFO - 'USER': 'cltbld', 05:54:43 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1477832058.329704-471705509', 05:54:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:43 INFO - '_': '/tools/buildbot/bin/python'} 05:54:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:43 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:54:43 INFO - Cleaning up... 05:54:43 INFO - Return code: 0 05:54:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:54:43 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')]} 05:54:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:43 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')]} 05:54:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:43 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 0x7f008be9ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x157d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x164aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1647f60>, '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 0x1648d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16491d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1477832058.329704-471705509', '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 05:54:43 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 05:54:43 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 05:54:43 INFO - Using env: {'DISPLAY': ':0', 05:54:43 INFO - 'HOME': '/home/cltbld', 05:54:43 INFO - 'LANG': 'en_US.UTF-8', 05:54:43 INFO - 'LANGUAGE': 'en_US:en', 05:54:43 INFO - 'LOGNAME': 'cltbld', 05:54:43 INFO - 'MAIL': '/var/mail/cltbld', 05:54:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:43 INFO - 'MOZ_NO_REMOTE': '1', 05:54:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:54:43 INFO - 'NO_EM_RESTART': '1', 05:54:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:54:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:43 INFO - 'PWD': '/builds/slave/test', 05:54:43 INFO - 'SHELL': '/bin/bash', 05:54:43 INFO - 'SHLVL': '1', 05:54:43 INFO - 'TERM': 'linux', 05:54:43 INFO - 'TMOUT': '86400', 05:54:43 INFO - 'USER': 'cltbld', 05:54:43 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1477832058.329704-471705509', 05:54:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:43 INFO - '_': '/tools/buildbot/bin/python'} 05:54:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:43 INFO - Downloading/unpacking blobuploader==1.2.4 05:54:43 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 05:54:43 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 05:54:43 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 05:54:43 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 05:54:43 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 05:54:43 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 05:54:45 INFO - Downloading blobuploader-1.2.4.tar.gz 05:54:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:54:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:54:45 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 05:54:45 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 05:54:45 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 05:54:45 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 05:54:45 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 05:54:45 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 05:54:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:54:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:54:46 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 05:54:46 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 05:54:46 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 05:54:46 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 05:54:46 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 05:54:46 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 05:54:46 INFO - Downloading docopt-0.6.1.tar.gz 05:54:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:54:46 INFO - Installing collected packages: blobuploader, requests, docopt 05:54:46 INFO - Running setup.py install for blobuploader 05:54:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:54:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:54:46 INFO - Running setup.py install for requests 05:54:46 INFO - Running setup.py install for docopt 05:54:46 INFO - Successfully installed blobuploader requests docopt 05:54:46 INFO - Cleaning up... 05:54:47 INFO - Return code: 0 05:54:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:54:47 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')]} 05:54:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:47 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')]} 05:54:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:47 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 0x7f008be9ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x157d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x164aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1647f60>, '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 0x1648d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16491d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1477832058.329704-471705509', '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 05:54:47 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 05:54:47 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 05:54:47 INFO - Using env: {'DISPLAY': ':0', 05:54:47 INFO - 'HOME': '/home/cltbld', 05:54:47 INFO - 'LANG': 'en_US.UTF-8', 05:54:47 INFO - 'LANGUAGE': 'en_US:en', 05:54:47 INFO - 'LOGNAME': 'cltbld', 05:54:47 INFO - 'MAIL': '/var/mail/cltbld', 05:54:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:47 INFO - 'MOZ_NO_REMOTE': '1', 05:54:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:54:47 INFO - 'NO_EM_RESTART': '1', 05:54:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:54:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:47 INFO - 'PWD': '/builds/slave/test', 05:54:47 INFO - 'SHELL': '/bin/bash', 05:54:47 INFO - 'SHLVL': '1', 05:54:47 INFO - 'TERM': 'linux', 05:54:47 INFO - 'TMOUT': '86400', 05:54:47 INFO - 'USER': 'cltbld', 05:54:47 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1477832058.329704-471705509', 05:54:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:47 INFO - '_': '/tools/buildbot/bin/python'} 05:54:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:54:47 INFO - Running setup.py (path:/tmp/pip-WF1JN9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:54:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:54:47 INFO - Running setup.py (path:/tmp/pip-Hp3mnw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:54:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:54:47 INFO - Running setup.py (path:/tmp/pip-o4C6Ez-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:54:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:54:47 INFO - Running setup.py (path:/tmp/pip-Oq3ary-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:54:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:54:47 INFO - Running setup.py (path:/tmp/pip-Gv4w78-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:54:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:54:47 INFO - Running setup.py (path:/tmp/pip-8ySqB2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:54:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:54:47 INFO - Running setup.py (path:/tmp/pip-rwrs2q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:54:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:54:47 INFO - Running setup.py (path:/tmp/pip-6w5bGv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:54:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:54:47 INFO - Running setup.py (path:/tmp/pip-YOahxi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:54:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:54:47 INFO - Running setup.py (path:/tmp/pip-MO78x0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:54:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:54:47 INFO - Running setup.py (path:/tmp/pip-iVym3l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:54:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:54:48 INFO - Running setup.py (path:/tmp/pip-7_3fjP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:54:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:54:48 INFO - Running setup.py (path:/tmp/pip-ADIOnO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:54:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:54:48 INFO - Running setup.py (path:/tmp/pip-sbbcLU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:54:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:54:48 INFO - Running setup.py (path:/tmp/pip-UoIadY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:54:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:54:48 INFO - Running setup.py (path:/tmp/pip-eXc3LK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:54:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:54:48 INFO - Running setup.py (path:/tmp/pip-cZz8QK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:54:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:54:48 INFO - Running setup.py install for manifestparser 05:54:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:54:48 INFO - Running setup.py install for mozcrash 05:54:48 INFO - Running setup.py install for mozdebug 05:54:48 INFO - Running setup.py install for mozdevice 05:54:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:54:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:54:48 INFO - Running setup.py install for mozfile 05:54:49 INFO - Running setup.py install for mozhttpd 05:54:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:54:49 INFO - Running setup.py install for mozinfo 05:54:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:54:49 INFO - Running setup.py install for mozInstall 05:54:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:54:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:54:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:54:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:54:49 INFO - Running setup.py install for mozleak 05:54:49 INFO - Running setup.py install for mozlog 05:54:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:54:49 INFO - Running setup.py install for moznetwork 05:54:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:54:49 INFO - Running setup.py install for mozprocess 05:54:49 INFO - Running setup.py install for mozprofile 05:54:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:54:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:54:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:54:49 INFO - Running setup.py install for mozrunner 05:54:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:54:50 INFO - Running setup.py install for mozscreenshot 05:54:50 INFO - Running setup.py install for moztest 05:54:50 INFO - Running setup.py install for mozversion 05:54:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:54:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:54:50 INFO - Cleaning up... 05:54:50 INFO - Return code: 0 05:54:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:54:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:50 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 0x7f008be9ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x157d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x164aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1647f60>, '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 0x1648d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16491d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1477832058.329704-471705509', '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 05:54:50 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 05:54:50 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 05:54:50 INFO - Using env: {'DISPLAY': ':0', 05:54:50 INFO - 'HOME': '/home/cltbld', 05:54:50 INFO - 'LANG': 'en_US.UTF-8', 05:54:50 INFO - 'LANGUAGE': 'en_US:en', 05:54:50 INFO - 'LOGNAME': 'cltbld', 05:54:50 INFO - 'MAIL': '/var/mail/cltbld', 05:54:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:50 INFO - 'MOZ_NO_REMOTE': '1', 05:54:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:54:50 INFO - 'NO_EM_RESTART': '1', 05:54:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:54:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:50 INFO - 'PWD': '/builds/slave/test', 05:54:50 INFO - 'SHELL': '/bin/bash', 05:54:50 INFO - 'SHLVL': '1', 05:54:50 INFO - 'TERM': 'linux', 05:54:50 INFO - 'TMOUT': '86400', 05:54:50 INFO - 'USER': 'cltbld', 05:54:50 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1477832058.329704-471705509', 05:54:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:50 INFO - '_': '/tools/buildbot/bin/python'} 05:54:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:54:50 INFO - Running setup.py (path:/tmp/pip-RZhv0a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:54:50 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)) 05:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:54:50 INFO - Running setup.py (path:/tmp/pip-_BfbGH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:54:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:54:50 INFO - Running setup.py (path:/tmp/pip-3D96S9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:54:50 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)) 05:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:54:50 INFO - Running setup.py (path:/tmp/pip-sqxmot-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:54:50 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)) 05:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:54:50 INFO - Running setup.py (path:/tmp/pip-LFUajA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:54:50 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)) 05:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:54:50 INFO - Running setup.py (path:/tmp/pip-tC0kXJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:54:50 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)) 05:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:54:50 INFO - Running setup.py (path:/tmp/pip-f5zbuz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:54:51 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)) 05:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:54:51 INFO - Running setup.py (path:/tmp/pip-pukCQ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:54:51 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)) 05:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:54:51 INFO - Running setup.py (path:/tmp/pip-ZNZ8_C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:54:51 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)) 05:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:54:51 INFO - Running setup.py (path:/tmp/pip-3c_9EK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:54:51 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)) 05:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:54:51 INFO - Running setup.py (path:/tmp/pip-3lzn47-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:54:51 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)) 05:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:54:51 INFO - Running setup.py (path:/tmp/pip-Z_2jA2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:54:51 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)) 05:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:54:51 INFO - Running setup.py (path:/tmp/pip-ZS6Qbn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:54:51 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)) 05:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:54:51 INFO - Running setup.py (path:/tmp/pip-9CjZvM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:54:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:54:51 INFO - Running setup.py (path:/tmp/pip-GsYJ0S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:54:51 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)) 05:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:54:51 INFO - Running setup.py (path:/tmp/pip-Euh9V9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:54:51 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)) 05:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:54:51 INFO - Running setup.py (path:/tmp/pip-bdg916-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:54:51 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)) 05:54:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:54:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:54:51 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)) 05:54:51 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)) 05:54:51 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)) 05:54:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:54:51 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 05:54:51 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 05:54:51 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 05:54:51 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 05:54:51 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 05:54:51 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 05:54:53 INFO - Downloading blessings-1.6.tar.gz 05:54:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:54:53 INFO - Installing collected packages: blessings 05:54:53 INFO - Running setup.py install for blessings 05:54:53 INFO - Successfully installed blessings 05:54:53 INFO - Cleaning up... 05:54:54 INFO - Return code: 0 05:54:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:54:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:54:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:54:54 INFO - Reading from file tmpfile_stdout 05:54:54 INFO - Current package versions: 05:54:54 INFO - argparse == 1.2.1 05:54:54 INFO - blessings == 1.6 05:54:54 INFO - blobuploader == 1.2.4 05:54:54 INFO - docopt == 0.6.1 05:54:54 INFO - functools32 == 3.2.3-2 05:54:54 INFO - jsonschema == 2.5.1 05:54:54 INFO - manifestparser == 1.1 05:54:54 INFO - mozInstall == 1.12 05:54:54 INFO - mozcrash == 0.17 05:54:54 INFO - mozdebug == 0.1 05:54:54 INFO - mozdevice == 0.48 05:54:54 INFO - mozfile == 1.2 05:54:54 INFO - mozhttpd == 0.7 05:54:54 INFO - mozinfo == 0.9 05:54:54 INFO - mozleak == 0.1 05:54:54 INFO - mozlog == 3.4 05:54:54 INFO - moznetwork == 0.27 05:54:54 INFO - mozprocess == 0.23 05:54:54 INFO - mozprofile == 0.28 05:54:54 INFO - mozrunner == 6.12 05:54:54 INFO - mozscreenshot == 0.1 05:54:54 INFO - mozsystemmonitor == 0.3 05:54:54 INFO - moztest == 0.7 05:54:54 INFO - mozversion == 1.4 05:54:54 INFO - psutil == 3.1.1 05:54:54 INFO - requests == 1.2.3 05:54:54 INFO - wsgiref == 0.1.2 05:54:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:54:54 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')]} 05:54:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:54 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')]} 05:54:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:54 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 0x7f008be9ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x157d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x164aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1647f60>, '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 0x1648d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16491d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1477832058.329704-471705509', '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 05:54:54 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 05:54:54 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 05:54:54 INFO - Using env: {'DISPLAY': ':0', 05:54:54 INFO - 'HOME': '/home/cltbld', 05:54:54 INFO - 'LANG': 'en_US.UTF-8', 05:54:54 INFO - 'LANGUAGE': 'en_US:en', 05:54:54 INFO - 'LOGNAME': 'cltbld', 05:54:54 INFO - 'MAIL': '/var/mail/cltbld', 05:54:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:54 INFO - 'MOZ_NO_REMOTE': '1', 05:54:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:54:54 INFO - 'NO_EM_RESTART': '1', 05:54:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:54:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:54 INFO - 'PWD': '/builds/slave/test', 05:54:54 INFO - 'SHELL': '/bin/bash', 05:54:54 INFO - 'SHLVL': '1', 05:54:54 INFO - 'TERM': 'linux', 05:54:54 INFO - 'TMOUT': '86400', 05:54:54 INFO - 'USER': 'cltbld', 05:54:54 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1477832058.329704-471705509', 05:54:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:54 INFO - '_': '/tools/buildbot/bin/python'} 05:54:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:54 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)) 05:54:54 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)) 05:54:54 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)) 05:54:54 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)) 05:54:54 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)) 05:54:54 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)) 05:54:54 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)) 05:54:54 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)) 05:54:54 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)) 05:54:54 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)) 05:54:54 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)) 05:54:54 INFO - Cleaning up... 05:54:54 INFO - Return code: 0 05:54:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:54:54 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')]} 05:54:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:54 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')]} 05:54:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:54 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 0x7f008be9ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x157d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x164aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1647f60>, '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 0x1648d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16491d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1477832058.329704-471705509', '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 05:54:54 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 05:54:54 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 05:54:54 INFO - Using env: {'DISPLAY': ':0', 05:54:54 INFO - 'HOME': '/home/cltbld', 05:54:54 INFO - 'LANG': 'en_US.UTF-8', 05:54:54 INFO - 'LANGUAGE': 'en_US:en', 05:54:54 INFO - 'LOGNAME': 'cltbld', 05:54:54 INFO - 'MAIL': '/var/mail/cltbld', 05:54:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:54 INFO - 'MOZ_NO_REMOTE': '1', 05:54:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:54:54 INFO - 'NO_EM_RESTART': '1', 05:54:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:54:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:54 INFO - 'PWD': '/builds/slave/test', 05:54:54 INFO - 'SHELL': '/bin/bash', 05:54:54 INFO - 'SHLVL': '1', 05:54:54 INFO - 'TERM': 'linux', 05:54:54 INFO - 'TMOUT': '86400', 05:54:54 INFO - 'USER': 'cltbld', 05:54:54 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1477832058.329704-471705509', 05:54:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:54 INFO - '_': '/tools/buildbot/bin/python'} 05:54:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:54 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:54:54 INFO - Cleaning up... 05:54:54 INFO - Return code: 0 05:54:54 INFO - Running post-action listener: _resource_record_post_action 05:54:54 INFO - Running post-action listener: _start_resource_monitoring 05:54:54 INFO - Starting resource monitoring. 05:54:54 INFO - [mozharness: 2016-10-30 12:54:54.723067Z] Finished create-virtualenv step (success) 05:54:54 INFO - [mozharness: 2016-10-30 12:54:54.723529Z] Running install step. 05:54:54 INFO - Running pre-action listener: _resource_record_pre_action 05:54:54 INFO - Running main action method: install 05:54:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:54:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:54:54 INFO - Reading from file tmpfile_stdout 05:54:54 INFO - Detecting whether we're running mozinstall >=1.0... 05:54:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:54:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:54:55 INFO - Reading from file tmpfile_stdout 05:54:55 INFO - Output received: 05:54:55 INFO - Usage: mozinstall [options] installer 05:54:55 INFO - Options: 05:54:55 INFO - -h, --help show this help message and exit 05:54:55 INFO - -d DEST, --destination=DEST 05:54:55 INFO - Directory to install application into. [default: 05:54:55 INFO - "/builds/slave/test"] 05:54:55 INFO - --app=APP Application being installed. [default: firefox] 05:54:55 INFO - mkdir: /builds/slave/test/build/application 05:54:55 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'] 05:54:55 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 05:55:11 INFO - Reading from file tmpfile_stdout 05:55:11 INFO - Output received: 05:55:11 INFO - /builds/slave/test/build/application/firefox/firefox 05:55:11 INFO - Running post-action listener: _resource_record_post_action 05:55:11 INFO - [mozharness: 2016-10-30 12:55:11.897794Z] Finished install step (success) 05:55:11 INFO - [mozharness: 2016-10-30 12:55:11.898072Z] Running run-tests step. 05:55:11 INFO - Running pre-action listener: _resource_record_pre_action 05:55:11 INFO - Running main action method: run_tests 05:55:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:55:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:55:11 INFO - Python 2.7.3 05:55:11 INFO - Return code: 0 05:55:11 INFO - grabbing minidump binary from tooltool 05:55: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')]} 05:55:11 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 0x1647f60>, '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 0x1648d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16491d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:55:11 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 05:55:11 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 05:55:11 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 05:55:11 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:55:11 INFO - Return code: 0 05:55:11 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:55:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:55:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:55:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:55:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:55:11 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/1477683089/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 05:55:11 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/1477683089/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-026 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 05:55:11 INFO - Using env: {'DISPLAY': ':0', 05:55:11 INFO - 'HOME': '/home/cltbld', 05:55:11 INFO - 'LANG': 'en_US.UTF-8', 05:55:11 INFO - 'LANGUAGE': 'en_US:en', 05:55:11 INFO - 'LOGNAME': 'cltbld', 05:55:11 INFO - 'MAIL': '/var/mail/cltbld', 05:55:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:55:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:55:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:11 INFO - 'MOZ_NO_REMOTE': '1', 05:55:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:55:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:55:11 INFO - 'NO_EM_RESTART': '1', 05:55:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:55:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:11 INFO - 'PWD': '/builds/slave/test', 05:55:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:55:11 INFO - 'SHELL': '/bin/bash', 05:55:11 INFO - 'SHLVL': '1', 05:55:11 INFO - 'TERM': 'linux', 05:55:11 INFO - 'TMOUT': '86400', 05:55:11 INFO - 'USER': 'cltbld', 05:55:11 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1477832058.329704-471705509', 05:55:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:11 INFO - '_': '/tools/buildbot/bin/python'} 05:55:11 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/1477683089/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:55:12 INFO - mozversion application_buildid: 20161028123129 05:55:12 INFO - mozversion application_changeset: 94d5d14da6bac6f013d6cc1187ac218092cea05e 05:55:12 INFO - mozversion application_display_name: Nightly 05:55:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:55:12 INFO - mozversion application_name: Firefox 05:55:12 INFO - mozversion application_remotingname: firefox 05:55:12 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 05:55:12 INFO - mozversion application_vendor: Mozilla 05:55:12 INFO - mozversion application_version: 52.0a1 05:55:12 INFO - mozversion platform_buildid: 20161028123129 05:55:12 INFO - mozversion platform_changeset: 94d5d14da6bac6f013d6cc1187ac218092cea05e 05:55:12 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 05:55:12 INFO - mozversion platform_version: 52.0a1 05:55:12 INFO - using testdate: 1477832112 05:55:12 INFO - actual date: 1477832112 05:55:12 INFO - starting webserver on 'localhost:52884' 05:55:12 INFO - SUITE-START | Running 2 tests 05:55:12 INFO - TEST-START | dromaeo_css 05:55:12 INFO - operating with platform_type : linux_ 05:55:12 INFO - Initialising browser for dromaeo_css test... 05:55:12 INFO - TEST-INFO | started process 650 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfhWfM_/profile http://localhost:52884/getInfo.html) 05:55:16 INFO - PROCESS | 650 | __metrics Screen width/height:1600/1200 05:55:16 INFO - PROCESS | 650 | colorDepth:24 05:55:16 INFO - PROCESS | 650 | Browser inner width/height: 1024/697 05:55:16 INFO - PROCESS | 650 | __metrics 05:55:16 INFO - PROCESS | 650 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:55:16 INFO - PROCESS | 650 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 205: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:55:17 INFO - PROCESS | 650 | console.error: PushService: 05:55:17 INFO - PROCESS | 650 | stateChangeProcessEnqueue: Error transitioning state 05:55:17 INFO - PROCESS | 650 | UnknownError 05:55:17 INFO - TEST-INFO | 650: exit 0 05:55:17 INFO - Browser initialized. 05:55:17 INFO - Running cycle 1/1 for dromaeo_css test... 05:55:17 INFO - TEST-INFO | started process 736 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfhWfM_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:55:29 INFO - PROCESS | 736 | RSS: Main: 172900352 05:55:29 INFO - PROCESS | 736 | 05:56:20 INFO - PROCESS | 736 | 1477832180964 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] 05:58:31 INFO - PROCESS | 736 | Cycle 1(1): loaded http://localhost:52884/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52884/tests/dromaeo/cssquery-ext.html) 05:58:33 INFO - PROCESS | 736 | RSS: Main: 414912512 05:58:33 INFO - PROCESS | 736 | 06:01:36 INFO - PROCESS | 736 | Cycle 1(1): loaded http://localhost:52884/tests/dromaeo/cssquery-ext.html (next: http://localhost:52884/tests/dromaeo/cssquery-jquery.html) 06:01:37 INFO - PROCESS | 736 | RSS: Main: 283406336 06:01:37 INFO - PROCESS | 736 | 06:04:39 INFO - PROCESS | 736 | Cycle 1(1): loaded http://localhost:52884/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52884/tests/dromaeo/cssquery-mootools.html) 06:04:39 INFO - PROCESS | 736 | RSS: Main: 249356288 06:04:39 INFO - PROCESS | 736 | 06:07:41 INFO - PROCESS | 736 | Cycle 1(1): loaded http://localhost:52884/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52884/tests/dromaeo/cssquery-prototype.html) 06:07:42 INFO - PROCESS | 736 | RSS: Main: 256585728 06:07:42 INFO - PROCESS | 736 | 06:10:45 INFO - PROCESS | 736 | Cycle 1(1): loaded http://localhost:52884/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52884/tests/dromaeo/cssquery-yui.html) 06:10:45 INFO - PROCESS | 736 | RSS: Main: 219779072 06:10:45 INFO - PROCESS | 736 | 06:13:48 INFO - PROCESS | 736 | Cycle 1(1): loaded http://localhost:52884/tests/dromaeo/cssquery-yui.html (next: http://localhost:52884/tests/dromaeo/cssquery-dojo.html) 06:13:48 INFO - PROCESS | 736 | RSS: Main: 318726144 06:13:48 INFO - PROCESS | 736 | 06:13:48 INFO - PROCESS | 736 | __start_tp_report 06:13:48 INFO - PROCESS | 736 | _x_x_mozilla_page_load 06:13:48 INFO - PROCESS | 736 | _x_x_mozilla_page_load_details 06:13:48 INFO - PROCESS | 736 | |i|pagename|runs| 06:13:48 INFO - PROCESS | 736 | |0;dojo.html;3036.6963303669627;3070.094322174958;3095.102420298114;3113.1283240692615;3120.2355422921373;5287.233351164088;5393.406725260218;5398.055340315449;5429.429909859467;5463.535599474039;5406.135018397057;5421.078416669166;5431.348238211411;5432;5437.374701909282;4891.951080489203;4911.656184067117;4935.506449355072;4982.651214414992;4983.501649835006;4953.578945789613;5025.773840177182;5030.622703297249;5032.094223039851;5032.874178145539;4931.137051016058;4945.7774400152075;4977.651564390494;4989.525995030466;5020.196768517038;4998.850034498989;5031.320771695848;5034.748262586892;5036.647434679574;5097.2608971699265;4794.400699912511;4827.782749776268;4843.66094373394;4926.2118061110405;4930.852074437773;5322;5338.279332290169;5354.678719276856;5361;5431.511163995259;5701.657900525982;5745.425457454263;5747.281589801275;5762.394948530386;5769.019266724625;5673.404292549264;5734.655920644775;5798.072308430631;5803.303603567557;5819.53443724501;5454.61817672763;5462.2079798429;5463.535599474009;5523.364813046471;5539.418361072069;5918.73365698536;5925.259342582177;5930.1994230779155;5931.9406805931385;5951.553633477506;5507.614466987273;5539.335279766454;5726.484616384462;5727.656340619576;5741.8564535886935;5754.165645981309;5773.451522105393;5786.450287222707;5792.507636850914;5871.735771890275;5739.339975902824;5747.453991870766;5776.393478684761;5792.189093526909;5793.8841223175305;5658.321001479767;5813.767449302065;5828.446297601721;5830.416958304136;5898.380670029671;4398.75806830621;4409.889752756207;4430;4435.3125265583885;4468.709533880287;3949.624785645359;3949.980250098731;3997.1006523531973;4002.3596224603925;4009.51885773709;5486.561075114061;5499.615026948075;5500.697461639648;5502.312210973629;5502.449755024546;5635.830925072254;5687.658740475502;5689.260396148474;5821.679807610537;5903.35063143054;5392.245085688007;5455.945440545624;5481.780728770805;5545.3622833374675;5562.082256427725;4972.428170760337;5002.874928126826;5013.974930125399;5017.473165317662;5046.798128074909;5946.4053594641055;5991.910121348184;6012.068019747617;6030.005049166838;6068.393160683896;5642.266505354278;5692;5769.567282453749;5816.5055970243;5842.444967728059;5974.492168165581;5974.551908606785;5986.191864098465;6027.156198132177;6044.425779550936;5708.942910570841;5715.885682286248;5720;5720.2849643794525;5723.599348045764;5584;5645.745941432728;5649.858753531194;5758.078707406795;5813.244278243801;5528.281323428089;5568.470995255444;5581.6930068846605;5581.804636837691;5584.664920104807;5561;5564.387917329172;5570.749316280858;5571.05292100352;5573.080441727232;5536.640118392292;5544.223808666709;5550.028744969533;5554.1391084381985;5558;5547.5007249347755;5616.915746263728;5624.606277560531;5626.774929002794;5629.296337957755;5526.668399895858;5550.611457197957;5556.111022236584;5556.499915007668;5565.8051968182535 06:13:48 INFO - PROCESS | 736 | |1;ext.html;602.942720441558;620.9629918036879;624.1262232873976;643.2184895352146;646.6055706019328;31273.99999999997;34103;34220.31559368811;34478.48282275765;34684.47973280403;35003.299934001305;42890.7855460723;43807.78096109523;43869.341959870624;47867;8695.91301087364;8815.250703690162;8820.823583528325;8823.161799629024;8824.735257942271;8708.912910870873;8859.20267175954;8890.333225008118;8893.644254229823;8893.73318800437;7950.045994480642;8120.75637730869;8129.390295727814;8323.25090741833;8324.375671824608;10457.320274182153;10696.679099626985;10719.356838589709;10895.509702063426;11010.284331518425;10538.262321637489;10622.25644204906;10623.41571213583;10626.734331641694;10628.94685526575;40418;40625;40631.7968410156;40636.35863668882;40650.79674601638;3483.1292176955762;3559.519464872235;3877.4377715231417;4012.6694843280006;4039.9596004039877;31205;31417.8429107853;31456.842715786275;31497.37005259905;31536.526952095737;4297.419848320468;4324.437823083011;4332.241857674926;4400.713953593006;4535.115652447774;293145;294268;295722.99999999785;295777;297989;57588.71205644029;58262;58476;58652.70673646605;58707.70646146742;60402.77180597316;61201;61335.693321533996;61361;61572.69213653903;16041.598960026093;16241.106739129225;16263.837361626232;16264.593385165228;16265.83734162667;10938.070264027647;10953.288036277616;10960.890391096147;10978.670639880816;11000.724981875357;16257.349706011864;17241.56896077608;17701.725180841586;17869.821301787077;18117.909410452863;5465.234867118606;6295.150154729053;6420.1974753155855;6535.215774107042;6542.771003014872;945.8250223708636;1023.3910823060268;1037.5797801890246;1123.2025262063862;1149.3910313723206;31503.684963150532;32044;32045.359092818013;32226.67773322237;32762.83618581892;1082.4416620653003;1094.7208461842179;1107.9335239885634;1111.2554588425774;1124.775044991005;16320.510384688478;16913;16941;16977.405790797264;17085.48743537696;495078;500353;501238;501309;502222;55712.16431753527;55724.16413753797;55944;55967.72016139893;55969.720151398986;1204.4700331853956;1262.103906226571;1294.5404381444453;1325.9469621215044;1339.80572816941;28858.27854303659;33041.66958330482;33132.171695706835;33165.50251746274;33459.27396792274;49553.75223123861;50247.49752502574;50310;50373;50388.24417633665;362793;365389;366252;366270;367398.44511661195;25970.22089337323;26807;26888.731112689406;41555.792221038704;41571;45990.770046149555;46536.767316163205;46880.53119468762;47395.28907066466;47432.76283618698;39750;40000.396799809445;40069.5888657825;41217.793911030254;41347;38695.80652096721;39467.40798888076;39546.40680389854;39983.80008099941;41564.58435415607;40089.997750056486;40499.59500404958;41614;41774.791126044176;41869.371959421245;31584.684153158174;35352.46971295381;35707.46438803368;36187.638123618424;36274.8186259067;27541.586876196474;27703.212712885474;27755.861220694576;27977.44045119127;27982.580261296505 06:13:48 INFO - PROCESS | 736 | |2;jquery.html;363.68722898307465;377.6223776223776;388.854179682619;389.4178203585639;416.6354439865118;14125.152490850543;17905.462836114923;18301.816981830194;18835;20060.89969550154;18686.71969920452;18702.251909923587;19152.521186970298;19217.90391048043;19328.4201473956;5539.9169012464745;5816.534677225812;5819.941800582003;5822.446867547597;5824.912626310609;5687.943120568803;5710.200571919934;5812.953668339697;5937.495312898409;5969.940300596982;6027.09593560965;6033.668148251844;6035.60768550045;6035.818925432244;6037.75848966043;5779.104238842986;5850.531957443394;5880.558958078162;5880.764769409218;5969.403059694039;5582.385937546866;5672.9432705672825;5708.914366284509;5710.457506536873;5710.971445142789;22411.21560745366;22872.31383058511;23060.077596896102;23081.422964425856;23433.531329373487;2178.8474806763534;2279.9316020519245;2301.217586020761;2407.723111842143;2461.8645974471397;9106.499142547158;9739.951300243525;9891.653792117242;10143.704130376487;10445;1841.604055128154;1899.5156235160084;1940.1463356123402;1946.7858535561077;1967.8622496425255;78268.21731782667;79033.81449278323;79757.60121199356;80607.19392806056;81025;10665.84001239982;10718.464076796285;10818.350898946088;11136.944315278533;11149.108071354272;15173.772393414107;15175.392984280505;15211.391544338103;15213.847861521464;15236.542903712907;7321.890171647429;7437.293457121565;7484.663190156456;7655.311022007934;7681.692732290758;6814.931850681529;6875.5874647521305;6967.756128535477;7045.11936007999;7166.068411106523;4584;4604.148232576984;4634.629229661687;4686.95313046872;4690.906181876343;1893.4414347767442;1896.4310706788185;1908.3988543608718;1959.4513536209884;1988.721578978944;972.6449845806371;983.2478154212033;986.7977064701719;1002.9648962286285;1066.4880857188439;18473.261069557335;19586.70619940702;19644.61549996257;19737.901310493642;20010.199592016448;917.000469488261;945.4894357047255;963.5086106085946;965.8985806490358;993.2550587059706;10171.237157213238;10587;10979.121670266359;10991.945040274748;11051.834222486668;431061;432859;441526;447938;449421;81887.590562048;85781;87863.56068219747;88081;88118;1004.5128112865254;1007.219404961161;1007.6322142417964;1010.7119470950744;1041.7447725307347;16352.754708679142;16519.83480165183;16648;16955.152242388078;17685.82314176842;37955;38920;39327.2134557313;43275.78362108169;43898.78050609854;50344.496555033984;54339.913201736534;54654.72672636611;54917.1762423556;55674.44325556693;8062.435629505878;8412.284955778827;8582.742517724479;8604.827903442021;8816;12347.506099756269;13405;13537.187768733907;13612.455501779817;13634.181949083088;10995.945020274847;11107.333559986426;11505.942470287595;11524.654260372203;12270.711575284824;10154.796904062025;10659.733506662396;10906.890931090587;11262.380569068451;11673;11523.884761152281;11649.650510484698;11894.464749086485;11904.880951190724;12025.939870300592;8459.577021148794;8678.349123815613;8780.604872780612;8805.867911981453;8869.73390798277;10674.519646615765;10690.465476725976;10977.615783447542;11617.941910290394;11803.940980295387 06:13:48 INFO - PROCESS | 736 | |3;mootools.html;1370.2669072046458;1473.3590887963737;1494.2976800903577;1627.9337034242576;1759.5864971731642;7175.174854891689;8075.232852878975;8407.873881891777;8425.70510032149;8435.451695639787;8282.503049817;8351.83296334073;8358.498490090598;8358.582070896462;8370.037445693732;2212.9889350553226;2243.6522339037474;2244.3267019893965;2249.3589327041796;2254.3124347074136;2215.6787265846524;2257.3566533537946;2276.1350686739015;2288.7711228877147;2297.9885100574556;2228.7882651148198;2275.670027845961;2292.3925159832656;2296.8621882687007;2303.4356582637192;2155.170259450123;2173.3154056472163;2192.353255789546;2201.6147174244525;2202.6916231727573;2128.180650449588;2141.325482473016;2147.914083436661;2148.666956621726;2153.364757396556;8215.424920255584;8223.095459499451;8269.793255168608;8306.377021723334;8383.95808020962;5035.169197082477;5212.192110222922;5214.713190774506;5230.581553475713;5232.450592687751;3256.3812875553567;3309.3050459403553;3408.659134086596;3477.791332520057;3497;999.1756800639429;1012.3369193178406;1013.9036791504795;1032.3702541449709;1039.2413538117141;11391.202615816896;11400;11531.365774882379;11533.884661153365;11538.88461115395;4131.772752498641;4328.653707703376;4358.542353052884;4470.083632855257;4480.977595112069;8734.65061397537;8743.737687869374;8750.168733970262;8752.29981601483;8761.167689069529;5033.0688822567945;5039.370078740158;5042.974785126051;5043.193089105725;5047.848564543069;3908.2378936107184;4125.793710314472;4150.8547200848425;4722.102800467969;4727.196376615983;3511.754177207622;3531.417316142859;3624.836882340301;3641.5448068991377;3669.082729317671;1119.8320251962107;1124.6176300058019;1126.2285334545697;1129.7796929598815;1130.9830352544718;842.2293601354814;950.0119875329718;980.8136454073704;981.6956743409565;1013.6350913671073;5469.480399362054;5574.358948720868;5582.525485333792;5656.349519805192;5981.820545383645;434.52636626077094;441.6775753699817;441.97569133697954;443.14694213638614;452.36894532127496;3716.6655001049494;3745.250949810049;3745.9250814983548;3830.3105441020884;4025.6376926076796;9627;9856.704298871045;10112.988701129829;10119.797604047877;10128.189744820396;9904.851427228597;10055.497225138713;10076.143527800072;10151.593936242467;10386.948065259625;7634.580098094658;7781.338586220235;7798.883016754753;7806.102298235775;7819.726309579138;5478.616496845342;5500.4499550044675;5559.11054231321;5570.303712035996;5789.3921138279875;9298.163165315154;9340.906590934004;9365.063493650852;9382.81234375295;9397.85903211466;8500.70247541333;9361.859572106288;9525.714228573153;9686.467244301632;9693.176080033276;6375.936240637534;6598.934010659832;6613.900791488035;6627.1716035495565;6773.288804675438;8052.436329456882;8080.2727754502375;8113.472624279403;8192.877106843283;8221.424500284922;7170.103737032871;7219.422446204396;7221.061262035902;7249;7295.963520182365;7190.316919892811;7209.891851622335;7304.050473438419;7477.738279160203;7553.055868016498;6706.295838936841;6734.4949128816515;6770.289119642367;6778.186617605918;6931.757388491378;5054.924176137288;5123.462036486116;5215.6609820361555;5245.947540524546;5286.947130528645;5164.8192313268855;5196.7401629917595;5204.141316682705;5228.372595288438;5335.706536140394 06:13:48 INFO - PROCESS | 736 | |4;prototype.html;325.2584108233229;326.5624063754568;335.9563256776619;338.81703879904853;339.1842618502499;5285.814996475124;5300.363956325246;5310.309659744233;5340.946590534103;5342.759575819087;4972.751362431873;5046.394432668076;5111.539961403473;5152.1498952672855;5197.350331208599;4085.836566537335;4105.507339119295;4139.130782535656;4151.709380343377;4174.749515029101;4071.7353372030725;4092.3247664135383;4093.5087789465306;4098.774567398792;4101.220768054075;3750.774953502785;3879.398693202558;3979.422983667381;4002.2395744808537;4069;4000.259951908877;4006.8196931138023;4007.899802504961;4009.51885773709;4010.598940105995;3519.0469289544294;3525.6121826599056;3531.982340088309;3534.4344904815107;3542.36237477254;4788.497207793166;4988.90022199554;5020.397552293748;5038.622103342264;5061.569766569846;4569.405977222939;4573.542645735433;4591.862244132682;4592.15045216636;4593.219152744042;5386.892262154735;5401.648892821954;5409.24270602116;5437.374701909252;5439.700816455093;3786.2427514497213;3809.676177524914;3907.765534067965;3913.706472014582;3924.156306394139;5453.363990802783;5484.780608775644;5523.696196709219;5537.179346251074;5548.611597188198;3894.240623078529;3895.9805200973815;3898.6101389860787;3900.239453306578;3904.1215726461887;3952.9327081687784;3964.5440774311323;3974.324364857981;3974.503187101612;3991.201759648082;4387.714798538085;4487.753173575485;4514.390557274792;4536.251518499411;4540.250858608359;5381.973090134525;5384.192371144281;5394.62237643369;5403.189521571796;5416.83749487516;1367.8221831161886;1373.2172661582802;1375.917444953306;1376.8141300924447;1380.0960370957039;888.1562515610196;901.9413738107002;956.7416797464784;965.9275554333453;975.1175186456269;5162.690238585622;5168.8449346519665;5173.249878767633;5175.663581867167;5186.974065129726;5416.756245968941;5422.349318081777;5431.044823863406;5435;5442.455754424526;5025.422076461181;5046.561124809601;5075.857931965352;5131.948680513222;5135.871603209875;2877.956830647542;2892.248015515981;2895.30512676956;2899.362140329124;2905.5205891028168;5426.457354264542;5564.8330550083565;5579.358373787067;5625.8593535161945;5660.235868157746;5598.188262701886;5627.311806458046;5634.7182640867795;5649.915251271234;5652.660840349592;5715.428457154251;5735.741891614887;5749.223854779551;5751.626144300691;5758.539316854725;5262.815801447084;5489.39616642161;5512.862178445411;5563.471470210324;5585.916211256916;5444.673319600836;5472.549774309731;5488.615796894179;5491.979411323836;5500.724963751716;5603.971980140073;5707.429257074426;5731.398203188772;5732.197492351158;5747.655140691572;3893.124047089382;3904.219156168721;3905.628965248297;3908.8241029154324;3918.2555314490155;5507.228987941611;5513.696746678811;5517.862053448696;5528.861778455571;5531.446855314436;5330.360356757059;5404.7297635118875;5416.593755468277;5445.618806683653;5455.208994695826;5336.973315133399;5359.3032905722;5391.676499410048;5393.568514518751;5425.674459532441;5199.428062913152;5319.25530425733;5391.29913111293;5399.946000539944;5416.4041955385665;5286.841394758163;5422.240886276003;5436.429174936733;5475.260839786737;5477.096279114061;5338.46615338463;5349.197620356822;5357.142857142839;5365.865853353541;5384.4346343634925 06:13:48 INFO - PROCESS | 736 | |5;yui.html;733.8679037773201;743.9776806695801;778;782.8982232309799;791.9406044546661;13896.652583685413;14375.496857609985;14459.92770036151;14575.927120364397;14613.196274204902;13188.604341869735;13195.802062969064;13201.339933003335;13252.867471325284;13291.468341266338;796.434531482648;805.9798505037392;810.5784991804259;812.5043723328765;814.0191069760924;794.8608993426157;803.2770506544127;803.6825453945688;804.1315379390273;813.0081300812999;848.0713618587637;856.1224744636766;856.2807241916788;856.3577317012241;856.7258477287271;848.3933987199182;849.8470275350435;850.1668365002301;850.421713235;850.5024560632038;625.9311475737711;631.9936800631981;632.0645444741808;632.6741728010079;632.89873620221;13357.866421335759;13386.665333366647;13400.664983375396;13405.195688258638;13418;10413.427261500614;10522.105621022223;10624.840627390595;10628.893711062869;10869.619563315246;10048.145907597864;10157.436783727415;10158.39049657023;10366.533505992249;10710.143188544898;3729.4219395993664;3730.123420996064;3774.1508160663907;3788.242351529705;3848.692104631623;58110.70944645292;59418.22315739083;60467.09299360513;60866.391336086956;62112;10019.849702254473;10740;10969.890301096886;10976.945115274531;11129.944350278196;19926.90036549808;20094.69857952132;20123.993800310218;20239.4940126498;20361.694574581394;7678.270564296383;8083.757487275391;8093.109757926623;8181.918180818235;8378.162183781573;4549.499555048942;4559.202139625552;4560.749158796231;4621.514740952151;4652.744099074515;3361.09250502363;3430;3479.5128681984543;3482.0946553895665;3489.3370259650587;633.5850018238061;639.8144538083997;640.6188317950812;640.8878446271884;651.8272657745702;635.5170070746174;695.4957655699577;713.350850725837;734.2510639148039;742.6509540515949;9219.631214751469;9289.16397524226;9631.759206019906;9647.614095436244;9863.457509837028;681.3356976947437;701.7017767448814;718.4144921888644;732.1945859554447;739.0798455922411;4130.979345103316;4333.371661109121;4461.888452788641;4558.247889098328;4578.725276483422;63777.36222637714;85833.57083214544;89748;91336.71658208466;92844;66701.33298666951;71748;73246.63376683189;74977;75420;67489.32510674928;69193.3080669197;69350;69482.30517694859;71132.2886771136;8895.199432051146;9068.863967040368;9104.362694611315;9110.180083792226;9123.15408748489;46572.54839225843;47525.28712069253;47919.76040119777;48160.75919620379;49370.259446109056;61822;63292.36707633049;63314.366856330846;65744.34255657574;65802.68394631984;10755.569777208824;11030.195558831938;11413;12021.09841761854;12090.516379344728;12455.314957677414;12728.6817829555;12904.935475322563;13055.543055992996;13820.37808298649;12032.578859739868;12247;12512.499500019898;12628.152807915072;12883.80674289905;11287.20989530725;11334.773304534028;11885.465154067915;12122.212056216318;12132.393380331125;11782.469788859351;12127.45426455794;12298.142189212018;12305.446254918372;12512;9559.926446770984;9698.175655069399;9763.658271960447;9852.162566181954;9959.302848800515;8541.316694664287;8781.780455488664;9600.231981441608;9612.327137100336;9645.27660425485 06:13:48 INFO - PROCESS | 736 | __end_tp_report 06:13:48 INFO - PROCESS | 736 | __start_cc_report 06:13:48 INFO - PROCESS | 736 | _x_x_mozilla_cycle_collect,2574 06:13:48 INFO - PROCESS | 736 | __end_cc_report 06:13:48 INFO - PROCESS | 736 | __startTimestamp1477833228703__endTimestamp 06:13:48 INFO - PROCESS | 736 | 06:13:48 INFO - PROCESS | 736 | ------- Summary: start ------- 06:13:48 INFO - PROCESS | 736 | Number of tests: 6 06:13:48 INFO - PROCESS | 736 | 06:13:48 INFO - PROCESS | 736 | [#0] dojo.html Cycles:165 Average:5370.44 Median:5550.61 stddev:600.98 (10.8%) stddev-sans-first:574.26 06:13:48 INFO - PROCESS | 736 | Values: 3036.7 3070.1 3095.1 3113.1 3120.2 5287.2 5393.4 5398.1 5429.4 5463.5 5406.1 5421.1 5431.3 5432.0 5437.4 4892.0 4911.7 4935.5 4982.7 4983.5 4953.6 5025.8 5030.6 5032.1 5032.9 4931.1 4945.8 4977.7 4989.5 5020.2 4998.9 5031.3 5034.7 5036.6 5097.3 4794.4 4827.8 4843.7 4926.2 4930.9 5322.0 5338.3 5354.7 5361.0 5431.5 5701.7 5745.4 5747.3 5762.4 5769.0 5673.4 5734.7 5798.1 5803.3 5819.5 5454.6 5462.2 5463.5 5523.4 5539.4 5918.7 5925.3 5930.2 5931.9 5951.6 5507.6 5539.3 5726.5 5727.7 5741.9 5754.2 5773.5 5786.5 5792.5 5871.7 5739.3 5747.5 5776.4 5792.2 5793.9 5658.3 5813.8 5828.4 5830.4 5898.4 4398.8 4409.9 4430.0 4435.3 4468.7 3949.6 3950.0 3997.1 4002.4 4009.5 5486.6 5499.6 5500.7 5502.3 5502.4 5635.8 5687.7 5689.3 5821.7 5903.4 5392.2 5455.9 5481.8 5545.4 5562.1 4972.4 5002.9 5014.0 5017.5 5046.8 5946.4 5991.9 6012.1 6030.0 6068.4 5642.3 5692.0 5769.6 5816.5 5842.4 5974.5 5974.6 5986.2 6027.2 6044.4 5708.9 5715.9 5720.0 5720.3 5723.6 5584.0 5645.7 5649.9 5758.1 5813.2 5528.3 5568.5 5581.7 5581.8 5584.7 5561.0 5564.4 5570.7 5571.1 5573.1 5536.6 5544.2 5550.0 5554.1 5558.0 5547.5 5616.9 5624.6 5626.8 5629.3 5526.7 5550.6 5556.1 5556.5 5565.8 06:13:48 INFO - PROCESS | 736 | 06:13:48 INFO - PROCESS | 736 | [#1] ext.html Cycles:180 Average:55287.60 Median:21286.62 stddev:104794.53 (492.3%) stddev-sans-first:105008.08 06:13:48 INFO - PROCESS | 736 | Values: 602.9 621.0 624.1 643.2 646.6 31274.0 34103.0 34220.3 34478.5 34684.5 35003.3 42890.8 43807.8 43869.3 47867.0 8695.9 8815.3 8820.8 8823.2 8824.7 8708.9 8859.2 8890.3 8893.6 8893.7 7950.0 8120.8 8129.4 8323.3 8324.4 10457.3 10696.7 10719.4 10895.5 11010.3 10538.3 10622.3 10623.4 10626.7 10628.9 40418.0 40625.0 40631.8 40636.4 40650.8 3483.1 3559.5 3877.4 4012.7 4040.0 31205.0 31417.8 31456.8 31497.4 31536.5 4297.4 4324.4 4332.2 4400.7 4535.1 293145.0 294268.0 295723.0 295777.0 297989.0 57588.7 58262.0 58476.0 58652.7 58707.7 60402.8 61201.0 61335.7 61361.0 61572.7 16041.6 16241.1 16263.8 16264.6 16265.8 10938.1 10953.3 10960.9 10978.7 11000.7 16257.3 17241.6 17701.7 17869.8 18117.9 5465.2 6295.2 6420.2 6535.2 6542.8 945.8 1023.4 1037.6 1123.2 1149.4 31503.7 32044.0 32045.4 32226.7 32762.8 1082.4 1094.7 1107.9 1111.3 1124.8 16320.5 16913.0 16941.0 16977.4 17085.5 495078.0 500353.0 501238.0 501309.0 502222.0 55712.2 55724.2 55944.0 55967.7 55969.7 1204.5 1262.1 1294.5 1325.9 1339.8 28858.3 33041.7 33132.2 33165.5 33459.3 49553.8 50247.5 50310.0 50373.0 50388.2 362793.0 365389.0 366252.0 366270.0 367398.4 25970.2 26807.0 26888.7 41555.8 41571.0 45990.8 46536.8 46880.5 47395.3 47432.8 39750.0 40000.4 40069.6 41217.8 41347.0 38695.8 39467.4 39546.4 39983.8 41564.6 40090.0 40499.6 41614.0 41774.8 41869.4 31584.7 35352.5 35707.5 36187.6 36274.8 27541.6 27703.2 27755.9 27977.4 27982.6 06:13:48 INFO - PROCESS | 736 | 06:13:48 INFO - PROCESS | 736 | [#2] jquery.html Cycles:180 Average:27164.18 Median:19166.31 stddev:72770.15 (379.7%) stddev-sans-first:72946.46 06:13:48 INFO - PROCESS | 736 | Values: 363.7 377.6 388.9 389.4 416.6 14125.2 17905.5 18301.8 18835.0 20060.9 18686.7 18702.3 19152.5 19217.9 19328.4 5539.9 5816.5 5819.9 5822.4 5824.9 5687.9 5710.2 5813.0 5937.5 5969.9 6027.1 6033.7 6035.6 6035.8 6037.8 5779.1 5850.5 5880.6 5880.8 5969.4 5582.4 5672.9 5708.9 5710.5 5711.0 22411.2 22872.3 23060.1 23081.4 23433.5 2178.8 2279.9 2301.2 2407.7 2461.9 9106.5 9740.0 9891.7 10143.7 10445.0 1841.6 1899.5 1940.1 1946.8 1967.9 78268.2 79033.8 79757.6 80607.2 81025.0 10665.8 10718.5 10818.4 11136.9 11149.1 15173.8 15175.4 15211.4 15213.8 15236.5 7321.9 7437.3 7484.7 7655.3 7681.7 6814.9 6875.6 6967.8 7045.1 7166.1 4584.0 4604.1 4634.6 4687.0 4690.9 1893.4 1896.4 1908.4 1959.5 1988.7 972.6 983.2 986.8 1003.0 1066.5 18473.3 19586.7 19644.6 19737.9 20010.2 917.0 945.5 963.5 965.9 993.3 10171.2 10587.0 10979.1 10991.9 11051.8 431061.0 432859.0 441526.0 447938.0 449421.0 81887.6 85781.0 87863.6 88081.0 88118.0 1004.5 1007.2 1007.6 1010.7 1041.7 16352.8 16519.8 16648.0 16955.2 17685.8 37955.0 38920.0 39327.2 43275.8 43898.8 50344.5 54339.9 54654.7 54917.2 55674.4 8062.4 8412.3 8582.7 8604.8 8816.0 12347.5 13405.0 13537.2 13612.5 13634.2 10995.9 11107.3 11505.9 11524.7 12270.7 10154.8 10659.7 10906.9 11262.4 11673.0 11523.9 11649.7 11894.5 11904.9 12025.9 8459.6 8678.3 8780.6 8805.9 8869.7 10674.5 10690.5 10977.6 11617.9 11803.9 06:13:48 INFO - PROCESS | 736 | 06:13:48 INFO - PROCESS | 736 | [#3] mootools.html Cycles:180 Average:5421.20 Median:5180.78 stddev:3039.41 (58.7%) stddev-sans-first:3032.69 06:13:48 INFO - PROCESS | 736 | Values: 1370.3 1473.4 1494.3 1627.9 1759.6 7175.2 8075.2 8407.9 8425.7 8435.5 8282.5 8351.8 8358.5 8358.6 8370.0 2213.0 2243.7 2244.3 2249.4 2254.3 2215.7 2257.4 2276.1 2288.8 2298.0 2228.8 2275.7 2292.4 2296.9 2303.4 2155.2 2173.3 2192.4 2201.6 2202.7 2128.2 2141.3 2147.9 2148.7 2153.4 8215.4 8223.1 8269.8 8306.4 8384.0 5035.2 5212.2 5214.7 5230.6 5232.5 3256.4 3309.3 3408.7 3477.8 3497.0 999.2 1012.3 1013.9 1032.4 1039.2 11391.2 11400.0 11531.4 11533.9 11538.9 4131.8 4328.7 4358.5 4470.1 4481.0 8734.7 8743.7 8750.2 8752.3 8761.2 5033.1 5039.4 5043.0 5043.2 5047.8 3908.2 4125.8 4150.9 4722.1 4727.2 3511.8 3531.4 3624.8 3641.5 3669.1 1119.8 1124.6 1126.2 1129.8 1131.0 842.2 950.0 980.8 981.7 1013.6 5469.5 5574.4 5582.5 5656.3 5981.8 434.5 441.7 442.0 443.1 452.4 3716.7 3745.3 3745.9 3830.3 4025.6 9627.0 9856.7 10113.0 10119.8 10128.2 9904.9 10055.5 10076.1 10151.6 10386.9 7634.6 7781.3 7798.9 7806.1 7819.7 5478.6 5500.4 5559.1 5570.3 5789.4 9298.2 9340.9 9365.1 9382.8 9397.9 8500.7 9361.9 9525.7 9686.5 9693.2 6375.9 6598.9 6613.9 6627.2 6773.3 8052.4 8080.3 8113.5 8192.9 8221.4 7170.1 7219.4 7221.1 7249.0 7296.0 7190.3 7209.9 7304.1 7477.7 7553.1 6706.3 6734.5 6770.3 6778.2 6931.8 5054.9 5123.5 5215.7 5245.9 5286.9 5164.8 5196.7 5204.1 5228.4 5335.7 06:13:48 INFO - PROCESS | 736 | 06:13:48 INFO - PROCESS | 736 | [#4] prototype.html Cycles:180 Average:4539.04 Median:5231.12 stddev:1331.72 (25.5%) stddev-sans-first:1297.35 06:13:48 INFO - PROCESS | 736 | Values: 325.3 326.6 336.0 338.8 339.2 5285.8 5300.4 5310.3 5340.9 5342.8 4972.8 5046.4 5111.5 5152.1 5197.4 4085.8 4105.5 4139.1 4151.7 4174.7 4071.7 4092.3 4093.5 4098.8 4101.2 3750.8 3879.4 3979.4 4002.2 4069.0 4000.3 4006.8 4007.9 4009.5 4010.6 3519.0 3525.6 3532.0 3534.4 3542.4 4788.5 4988.9 5020.4 5038.6 5061.6 4569.4 4573.5 4591.9 4592.2 4593.2 5386.9 5401.6 5409.2 5437.4 5439.7 3786.2 3809.7 3907.8 3913.7 3924.2 5453.4 5484.8 5523.7 5537.2 5548.6 3894.2 3896.0 3898.6 3900.2 3904.1 3952.9 3964.5 3974.3 3974.5 3991.2 4387.7 4487.8 4514.4 4536.3 4540.3 5382.0 5384.2 5394.6 5403.2 5416.8 1367.8 1373.2 1375.9 1376.8 1380.1 888.2 901.9 956.7 965.9 975.1 5162.7 5168.8 5173.2 5175.7 5187.0 5416.8 5422.3 5431.0 5435.0 5442.5 5025.4 5046.6 5075.9 5131.9 5135.9 2878.0 2892.2 2895.3 2899.4 2905.5 5426.5 5564.8 5579.4 5625.9 5660.2 5598.2 5627.3 5634.7 5649.9 5652.7 5715.4 5735.7 5749.2 5751.6 5758.5 5262.8 5489.4 5512.9 5563.5 5585.9 5444.7 5472.5 5488.6 5492.0 5500.7 5604.0 5707.4 5731.4 5732.2 5747.7 3893.1 3904.2 3905.6 3908.8 3918.3 5507.2 5513.7 5517.9 5528.9 5531.4 5330.4 5404.7 5416.6 5445.6 5455.2 5337.0 5359.3 5391.7 5393.6 5425.7 5199.4 5319.3 5391.3 5399.9 5416.4 5286.8 5422.2 5436.4 5475.3 5477.1 5338.5 5349.2 5357.1 5365.9 5384.4 06:13:48 INFO - PROCESS | 736 | 06:13:48 INFO - PROCESS | 736 | [#5] yui.html Cycles:180 Average:17247.88 Median:31368.97 stddev:23157.62 (73.8%) stddev-sans-first:23189.38 06:13:48 INFO - PROCESS | 736 | Values: 733.9 744.0 778.0 782.9 791.9 13896.7 14375.5 14459.9 14575.9 14613.2 13188.6 13195.8 13201.3 13252.9 13291.5 796.4 806.0 810.6 812.5 814.0 794.9 803.3 803.7 804.1 813.0 848.1 856.1 856.3 856.4 856.7 848.4 849.8 850.2 850.4 850.5 625.9 632.0 632.1 632.7 632.9 13357.9 13386.7 13400.7 13405.2 13418.0 10413.4 10522.1 10624.8 10628.9 10869.6 10048.1 10157.4 10158.4 10366.5 10710.1 3729.4 3730.1 3774.2 3788.2 3848.7 58110.7 59418.2 60467.1 60866.4 62112.0 10019.8 10740.0 10969.9 10976.9 11129.9 19926.9 20094.7 20124.0 20239.5 20361.7 7678.3 8083.8 8093.1 8181.9 8378.2 4549.5 4559.2 4560.7 4621.5 4652.7 3361.1 3430.0 3479.5 3482.1 3489.3 633.6 639.8 640.6 640.9 651.8 635.5 695.5 713.4 734.3 742.7 9219.6 9289.2 9631.8 9647.6 9863.5 681.3 701.7 718.4 732.2 739.1 4131.0 4333.4 4461.9 4558.2 4578.7 63777.4 85833.6 89748.0 91336.7 92844.0 66701.3 71748.0 73246.6 74977.0 75420.0 67489.3 69193.3 69350.0 69482.3 71132.3 8895.2 9068.9 9104.4 9110.2 9123.2 46572.5 47525.3 47919.8 48160.8 49370.3 61822.0 63292.4 63314.4 65744.3 65802.7 10755.6 11030.2 11413.0 12021.1 12090.5 12455.3 12728.7 12904.9 13055.5 13820.4 12032.6 12247.0 12512.5 12628.2 12883.8 11287.2 11334.8 11885.5 12122.2 12132.4 11782.5 12127.5 12298.1 12305.4 12512.0 9559.9 9698.2 9763.7 9852.2 9959.3 8541.3 8781.8 9600.2 9612.3 9645.3 06:13:48 INFO - PROCESS | 736 | -------- Summary: end -------- 06:13:48 INFO - PROCESS | 736 | 06:13:49 INFO - TEST-INFO | 736: exit 0 06:13:49 INFO - TEST-OK | dromaeo_css | took 1117467ms 06:13:49 INFO - TEST-START | kraken 06:13:49 INFO - operating with platform_type : linux_ 06:13:49 INFO - Initialising browser for kraken test... 06:13:49 INFO - TEST-INFO | started process 1056 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptB58_5/profile http://localhost:52884/getInfo.html) 06:13:53 INFO - PROCESS | 1056 | __metrics Screen width/height:1600/1200 06:13:53 INFO - PROCESS | 1056 | colorDepth:24 06:13:53 INFO - PROCESS | 1056 | Browser inner width/height: 1024/697 06:13:53 INFO - PROCESS | 1056 | __metrics 06:13:54 INFO - PROCESS | 1056 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:13:54 INFO - PROCESS | 1056 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 205: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:13:55 INFO - PROCESS | 1056 | console.error: PushService: 06:13:55 INFO - PROCESS | 1056 | stateChangeProcessEnqueue: Error transitioning state 06:13:55 INFO - PROCESS | 1056 | UnknownError 06:13:55 INFO - TEST-INFO | 1056: exit 0 06:13:55 INFO - Browser initialized. 06:13:55 INFO - Running cycle 1/1 for kraken test... 06:13:55 INFO - TEST-INFO | started process 1152 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptB58_5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:14:07 INFO - PROCESS | 1152 | RSS: Main: 172625920 06:14:07 INFO - PROCESS | 1152 | 06:14:10 INFO - PROCESS | 1152 | Cycle 1(1): loaded http://localhost:52884/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52884/tests/kraken/driver.html?testName=audio-beat-detection) 06:14:11 INFO - PROCESS | 1152 | RSS: Main: 229462016 06:14:11 INFO - PROCESS | 1152 | 06:14:13 INFO - PROCESS | 1152 | Cycle 1(1): loaded http://localhost:52884/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52884/tests/kraken/driver.html?testName=audio-dft) 06:14:14 INFO - PROCESS | 1152 | RSS: Main: 216346624 06:14:14 INFO - PROCESS | 1152 | 06:14:17 INFO - PROCESS | 1152 | Cycle 1(1): loaded http://localhost:52884/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52884/tests/kraken/driver.html?testName=audio-fft) 06:14:18 INFO - PROCESS | 1152 | RSS: Main: 298541056 06:14:18 INFO - PROCESS | 1152 | 06:14:20 INFO - PROCESS | 1152 | Cycle 1(1): loaded http://localhost:52884/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52884/tests/kraken/driver.html?testName=audio-oscillator) 06:14:20 INFO - PROCESS | 1152 | RSS: Main: 206774272 06:14:20 INFO - PROCESS | 1152 | 06:14:23 INFO - PROCESS | 1152 | Cycle 1(1): loaded http://localhost:52884/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52884/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:14:23 INFO - PROCESS | 1152 | RSS: Main: 211537920 06:14:23 INFO - PROCESS | 1152 | 06:14:26 INFO - PROCESS | 1152 | Cycle 1(1): loaded http://localhost:52884/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52884/tests/kraken/driver.html?testName=imaging-darkroom) 06:14:27 INFO - PROCESS | 1152 | RSS: Main: 248553472 06:14:27 INFO - PROCESS | 1152 | 06:14:30 INFO - PROCESS | 1152 | Cycle 1(1): loaded http://localhost:52884/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52884/tests/kraken/driver.html?testName=imaging-desaturate) 06:14:31 INFO - PROCESS | 1152 | RSS: Main: 246775808 06:14:31 INFO - PROCESS | 1152 | 06:14:33 INFO - PROCESS | 1152 | Cycle 1(1): loaded http://localhost:52884/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52884/tests/kraken/driver.html?testName=json-parse-financial) 06:14:34 INFO - PROCESS | 1152 | RSS: Main: 246652928 06:14:34 INFO - PROCESS | 1152 | 06:14:35 INFO - PROCESS | 1152 | Cycle 1(1): loaded http://localhost:52884/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52884/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:14:36 INFO - PROCESS | 1152 | RSS: Main: 209154048 06:14:36 INFO - PROCESS | 1152 | 06:14:38 INFO - PROCESS | 1152 | Cycle 1(1): loaded http://localhost:52884/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52884/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:14:38 INFO - PROCESS | 1152 | RSS: Main: 216186880 06:14:38 INFO - PROCESS | 1152 | 06:14:40 INFO - PROCESS | 1152 | Cycle 1(1): loaded http://localhost:52884/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52884/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:14:41 INFO - PROCESS | 1152 | RSS: Main: 225189888 06:14:41 INFO - PROCESS | 1152 | 06:14:44 INFO - PROCESS | 1152 | Cycle 1(1): loaded http://localhost:52884/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52884/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:14:44 INFO - PROCESS | 1152 | RSS: Main: 235016192 06:14:44 INFO - PROCESS | 1152 | 06:14:47 INFO - PROCESS | 1152 | Cycle 1(1): loaded http://localhost:52884/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52884/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:14:48 INFO - PROCESS | 1152 | RSS: Main: 231854080 06:14:48 INFO - PROCESS | 1152 | 06:14:49 INFO - PROCESS | 1152 | Cycle 1(1): loaded http://localhost:52884/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52884/tests/kraken/driver.html?testName=ai-astar) 06:14:50 INFO - PROCESS | 1152 | RSS: Main: 282591232 06:14:50 INFO - PROCESS | 1152 | 06:14:50 INFO - PROCESS | 1152 | __start_tp_report 06:14:50 INFO - PROCESS | 1152 | _x_x_mozilla_page_load 06:14:50 INFO - PROCESS | 1152 | _x_x_mozilla_page_load_details 06:14:50 INFO - PROCESS | 1152 | |i|pagename|runs| 06:14:50 INFO - PROCESS | 1152 | |0;ai-astar;107;111;113;111;110;109;112;110;111;110 06:14:50 INFO - PROCESS | 1152 | |1;audio-beat-detection;156;121;122;168;130;130;127;121;151;122 06:14:50 INFO - PROCESS | 1152 | |2;audio-dft;161;161;162;162;162;162;161;162;161;162 06:14:50 INFO - PROCESS | 1152 | |3;audio-fft;75;76;75;102;77;80;79;77;103;75 06:14:50 INFO - PROCESS | 1152 | |4;audio-oscillator;83;83;108;82;82;82;106;83;82;116 06:14:50 INFO - PROCESS | 1152 | |5;imaging-gaussian-blur;117;117;117;118;117;118;117;117;117;117 06:14:50 INFO - PROCESS | 1152 | |6;imaging-darkroom;146;145;147;146;146;146;146;145;145;146 06:14:50 INFO - PROCESS | 1152 | |7;imaging-desaturate;85;85;85;85;85;85;85;84;84;85 06:14:50 INFO - PROCESS | 1152 | |8;json-parse-financial;53;52;52;51;51;53;53;53;55;53 06:14:50 INFO - PROCESS | 1152 | |9;json-stringify-tinderbox;61;61;60;60;70;60;59;60;64;60 06:14:50 INFO - PROCESS | 1152 | |10;stanford-crypto-aes;80;79;79;79;79;78;80;79;88;80 06:14:50 INFO - PROCESS | 1152 | |11;stanford-crypto-ccm;131;139;133;132;137;135;139;134;167;135 06:14:50 INFO - PROCESS | 1152 | |12;stanford-crypto-pbkdf2;166;165;168;163;165;164;163;163;164;164 06:14:50 INFO - PROCESS | 1152 | |13;stanford-crypto-sha256-iterative;68;65;65;63;67;63;63;62;63;63 06:14:50 INFO - PROCESS | 1152 | __end_tp_report 06:14:50 INFO - PROCESS | 1152 | __start_cc_report 06:14:50 INFO - PROCESS | 1152 | _x_x_mozilla_cycle_collect,1712 06:14:50 INFO - PROCESS | 1152 | __end_cc_report 06:14:50 INFO - PROCESS | 1152 | __startTimestamp1477833290225__endTimestamp 06:14:50 INFO - PROCESS | 1152 | 06:14:50 INFO - PROCESS | 1152 | ------- Summary: start ------- 06:14:50 INFO - PROCESS | 1152 | Number of tests: 14 06:14:50 INFO - PROCESS | 1152 | 06:14:50 INFO - PROCESS | 1152 | [#0] ai-astar Cycles:10 Average:110.40 Median:111.00 stddev:1.65 (1.5%) stddev-sans-first:1.20 06:14:50 INFO - PROCESS | 1152 | Values: 107.0 111.0 113.0 111.0 110.0 109.0 112.0 110.0 111.0 110.0 06:14:50 INFO - PROCESS | 1152 | 06:14:50 INFO - PROCESS | 1152 | [#1] audio-beat-detection Cycles:10 Average:134.80 Median:130.00 stddev:17.09 (13.1%) stddev-sans-first:16.32 06:14:50 INFO - PROCESS | 1152 | Values: 156.0 121.0 122.0 168.0 130.0 130.0 127.0 121.0 151.0 122.0 06:14:50 INFO - PROCESS | 1152 | 06:14:50 INFO - PROCESS | 1152 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:0.52 (0.3%) stddev-sans-first:0.50 06:14:50 INFO - PROCESS | 1152 | Values: 161.0 161.0 162.0 162.0 162.0 162.0 161.0 162.0 161.0 162.0 06:14:50 INFO - PROCESS | 1152 | 06:14:50 INFO - PROCESS | 1152 | [#3] audio-fft Cycles:10 Average:81.90 Median:76.50 stddev:10.99 (14.4%) stddev-sans-first:11.37 06:14:50 INFO - PROCESS | 1152 | Values: 75.0 76.0 75.0 102.0 77.0 80.0 79.0 77.0 103.0 75.0 06:14:50 INFO - PROCESS | 1152 | 06:14:50 INFO - PROCESS | 1152 | [#4] audio-oscillator Cycles:10 Average:90.70 Median:82.00 stddev:13.56 (16.5%) stddev-sans-first:14.09 06:14:50 INFO - PROCESS | 1152 | Values: 83.0 83.0 108.0 82.0 82.0 82.0 106.0 83.0 82.0 116.0 06:14:50 INFO - PROCESS | 1152 | 06:14:50 INFO - PROCESS | 1152 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 06:14:50 INFO - PROCESS | 1152 | Values: 117.0 117.0 117.0 118.0 117.0 118.0 117.0 117.0 117.0 117.0 06:14:50 INFO - PROCESS | 1152 | 06:14:50 INFO - PROCESS | 1152 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 06:14:50 INFO - PROCESS | 1152 | Values: 146.0 145.0 147.0 146.0 146.0 146.0 146.0 145.0 145.0 146.0 06:14:50 INFO - PROCESS | 1152 | 06:14:50 INFO - PROCESS | 1152 | [#7] imaging-desaturate Cycles:10 Average:84.80 Median:85.00 stddev:0.42 (0.5%) stddev-sans-first:0.44 06:14:50 INFO - PROCESS | 1152 | Values: 85.0 85.0 85.0 85.0 85.0 85.0 85.0 84.0 84.0 85.0 06:14:50 INFO - PROCESS | 1152 | 06:14:50 INFO - PROCESS | 1152 | [#8] json-parse-financial Cycles:10 Average:52.60 Median:53.00 stddev:1.17 (2.2%) stddev-sans-first:1.24 06:14:50 INFO - PROCESS | 1152 | Values: 53.0 52.0 52.0 51.0 51.0 53.0 53.0 53.0 55.0 53.0 06:14:50 INFO - PROCESS | 1152 | 06:14:50 INFO - PROCESS | 1152 | [#9] json-stringify-tinderbox Cycles:10 Average:61.50 Median:60.50 stddev:3.27 (5.4%) stddev-sans-first:3.47 06:14:50 INFO - PROCESS | 1152 | Values: 61.0 61.0 60.0 60.0 70.0 60.0 59.0 60.0 64.0 60.0 06:14:50 INFO - PROCESS | 1152 | 06:14:50 INFO - PROCESS | 1152 | [#10] stanford-crypto-aes Cycles:10 Average:80.10 Median:79.50 stddev:2.85 (3.6%) stddev-sans-first:3.02 06:14:50 INFO - PROCESS | 1152 | Values: 80.0 79.0 79.0 79.0 79.0 78.0 80.0 79.0 88.0 80.0 06:14:50 INFO - PROCESS | 1152 | 06:14:50 INFO - PROCESS | 1152 | [#11] stanford-crypto-ccm Cycles:10 Average:138.20 Median:136.00 stddev:10.48 (7.7%) stddev-sans-first:10.78 06:14:50 INFO - PROCESS | 1152 | Values: 131.0 139.0 133.0 132.0 137.0 135.0 139.0 134.0 167.0 135.0 06:14:50 INFO - PROCESS | 1152 | 06:14:50 INFO - PROCESS | 1152 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.50 Median:164.50 stddev:1.58 (1.0%) stddev-sans-first:1.58 06:14:50 INFO - PROCESS | 1152 | Values: 166.0 165.0 168.0 163.0 165.0 164.0 163.0 163.0 164.0 164.0 06:14:50 INFO - PROCESS | 1152 | 06:14:50 INFO - PROCESS | 1152 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.20 Median:64.00 stddev:1.99 (3.1%) stddev-sans-first:1.56 06:14:50 INFO - PROCESS | 1152 | Values: 68.0 65.0 65.0 63.0 67.0 63.0 63.0 62.0 63.0 63.0 06:14:50 INFO - PROCESS | 1152 | -------- Summary: end -------- 06:14:50 INFO - PROCESS | 1152 | 06:14:51 INFO - TEST-INFO | 1152: exit 0 06:14:51 INFO - TEST-OK | kraken | took 61812ms 06:14:51 INFO - SUITE-END | took 1179s 06:14:51 INFO - Completed test suite (00:19:39) 06:14:51 INFO - javascript benchmark 06:14:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3036.6963303669627, 3070.094322174958, 3095.102420298114, 3113.1283240692615, 3120.2355422921373, 5287.233351164088, 5393.406725260218, 5398.055340315449, 5429.429909859467, 5463.535599474039, 5406.135018397057, 5421.078416669166, 5431.348238211411, 5432.0, 5437.374701909282, 4891.951080489203, 4911.656184067117, 4935.506449355072, 4982.651214414992, 4983.501649835006, 4953.578945789613, 5025.773840177182, 5030.622703297249, 5032.094223039851, 5032.874178145539, 4931.137051016058, 4945.7774400152075, 4977.651564390494, 4989.525995030466, 5020.196768517038, 4998.850034498989, 5031.320771695848, 5034.748262586892, 5036.647434679574, 5097.2608971699265, 4794.400699912511, 4827.782749776268, 4843.66094373394, 4926.2118061110405, 4930.852074437773, 5322.0, 5338.279332290169, 5354.678719276856, 5361.0, 5431.511163995259, 5701.657900525982, 5745.425457454263, 5747.281589801275, 5762.394948530386, 5769.019266724625, 5673.404292549264, 5734.655920644775, 5798.072308430631, 5803.303603567557, 5819.53443724501, 5454.61817672763, 5462.2079798429, 5463.535599474009, 5523.364813046471, 5539.418361072069, 5918.73365698536, 5925.259342582177, 5930.1994230779155, 5931.9406805931385, 5951.553633477506, 5507.614466987273, 5539.335279766454, 5726.484616384462, 5727.656340619576, 5741.8564535886935, 5754.165645981309, 5773.451522105393, 5786.450287222707, 5792.507636850914, 5871.735771890275, 5739.339975902824, 5747.453991870766, 5776.393478684761, 5792.189093526909, 5793.8841223175305, 5658.321001479767, 5813.767449302065, 5828.446297601721, 5830.416958304136, 5898.380670029671, 4398.75806830621, 4409.889752756207, 4430.0, 4435.3125265583885, 4468.709533880287, 3949.624785645359, 3949.980250098731, 3997.1006523531973, 4002.3596224603925, 4009.51885773709, 5486.561075114061, 5499.615026948075, 5500.697461639648, 5502.312210973629, 5502.449755024546, 5635.830925072254, 5687.658740475502, 5689.260396148474, 5821.679807610537, 5903.35063143054, 5392.245085688007, 5455.945440545624, 5481.780728770805, 5545.3622833374675, 5562.082256427725, 4972.428170760337, 5002.874928126826, 5013.974930125399, 5017.473165317662, 5046.798128074909, 5946.4053594641055, 5991.910121348184, 6012.068019747617, 6030.005049166838, 6068.393160683896, 5642.266505354278, 5692.0, 5769.567282453749, 5816.5055970243, 5842.444967728059, 5974.492168165581, 5974.551908606785, 5986.191864098465, 6027.156198132177, 6044.425779550936, 5708.942910570841, 5715.885682286248, 5720.0, 5720.2849643794525, 5723.599348045764, 5584.0, 5645.745941432728, 5649.858753531194, 5758.078707406795, 5813.244278243801, 5528.281323428089, 5568.470995255444, 5581.6930068846605, 5581.804636837691, 5584.664920104807, 5561.0, 5564.387917329172, 5570.749316280858, 5571.05292100352, 5573.080441727232, 5536.640118392292, 5544.223808666709, 5550.028744969533, 5554.1391084381985, 5558.0, 5547.5007249347755, 5616.915746263728, 5624.606277560531, 5626.774929002794, 5629.296337957755, 5526.668399895858, 5550.611457197957, 5556.111022236584, 5556.499915007668, 5565.8051968182535], "value": 5329.935907108309, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [602.942720441558, 620.9629918036879, 624.1262232873976, 643.2184895352146, 646.6055706019328, 31273.99999999997, 34103.0, 34220.31559368811, 34478.48282275765, 34684.47973280403, 35003.299934001305, 42890.7855460723, 43807.78096109523, 43869.341959870624, 47867.0, 8695.91301087364, 8815.250703690162, 8820.823583528325, 8823.161799629024, 8824.735257942271, 8708.912910870873, 8859.20267175954, 8890.333225008118, 8893.644254229823, 8893.73318800437, 7950.045994480642, 8120.75637730869, 8129.390295727814, 8323.25090741833, 8324.375671824608, 10457.320274182153, 10696.679099626985, 10719.356838589709, 10895.509702063426, 11010.284331518425, 10538.262321637489, 10622.25644204906, 10623.41571213583, 10626.734331641694, 10628.94685526575, 40418.0, 40625.0, 40631.7968410156, 40636.35863668882, 40650.79674601638, 3483.1292176955762, 3559.519464872235, 3877.4377715231417, 4012.6694843280006, 4039.9596004039877, 31205.0, 31417.8429107853, 31456.842715786275, 31497.37005259905, 31536.526952095737, 4297.419848320468, 4324.437823083011, 4332.241857674926, 4400.713953593006, 4535.115652447774, 293145.0, 294268.0, 295722.99999999785, 295777.0, 297989.0, 57588.71205644029, 58262.0, 58476.0, 58652.70673646605, 58707.70646146742, 60402.77180597316, 61201.0, 61335.693321533996, 61361.0, 61572.69213653903, 16041.598960026093, 16241.106739129225, 16263.837361626232, 16264.593385165228, 16265.83734162667, 10938.070264027647, 10953.288036277616, 10960.890391096147, 10978.670639880816, 11000.724981875357, 16257.349706011864, 17241.56896077608, 17701.725180841586, 17869.821301787077, 18117.909410452863, 5465.234867118606, 6295.150154729053, 6420.1974753155855, 6535.215774107042, 6542.771003014872, 945.8250223708636, 1023.3910823060268, 1037.5797801890246, 1123.2025262063862, 1149.3910313723206, 31503.684963150532, 32044.0, 32045.359092818013, 32226.67773322237, 32762.83618581892, 1082.4416620653003, 1094.7208461842179, 1107.9335239885634, 1111.2554588425774, 1124.775044991005, 16320.510384688478, 16913.0, 16941.0, 16977.405790797264, 17085.48743537696, 495078.0, 500353.0, 501238.0, 501309.0, 502222.0, 55712.16431753527, 55724.16413753797, 55944.0, 55967.72016139893, 55969.720151398986, 1204.4700331853956, 1262.103906226571, 1294.5404381444453, 1325.9469621215044, 1339.80572816941, 28858.27854303659, 33041.66958330482, 33132.171695706835, 33165.50251746274, 33459.27396792274, 49553.75223123861, 50247.49752502574, 50310.0, 50373.0, 50388.24417633665, 362793.0, 365389.0, 366252.0, 366270.0, 367398.44511661195, 25970.22089337323, 26807.0, 26888.731112689406, 41555.792221038704, 41571.0, 45990.770046149555, 46536.767316163205, 46880.53119468762, 47395.28907066466, 47432.76283618698, 39750.0, 40000.396799809445, 40069.5888657825, 41217.793911030254, 41347.0, 38695.80652096721, 39467.40798888076, 39546.40680389854, 39983.80008099941, 41564.58435415607, 40089.997750056486, 40499.59500404958, 41614.0, 41774.791126044176, 41869.371959421245, 31584.684153158174, 35352.46971295381, 35707.46438803368, 36187.638123618424, 36274.8186259067, 27541.586876196474, 27703.212712885474, 27755.861220694576, 27977.44045119127, 27982.580261296505], "value": 19670.5031324173, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [363.68722898307465, 377.6223776223776, 388.854179682619, 389.4178203585639, 416.6354439865118, 14125.152490850543, 17905.462836114923, 18301.816981830194, 18835.0, 20060.89969550154, 18686.71969920452, 18702.251909923587, 19152.521186970298, 19217.90391048043, 19328.4201473956, 5539.9169012464745, 5816.534677225812, 5819.941800582003, 5822.446867547597, 5824.912626310609, 5687.943120568803, 5710.200571919934, 5812.953668339697, 5937.495312898409, 5969.940300596982, 6027.09593560965, 6033.668148251844, 6035.60768550045, 6035.818925432244, 6037.75848966043, 5779.104238842986, 5850.531957443394, 5880.558958078162, 5880.764769409218, 5969.403059694039, 5582.385937546866, 5672.9432705672825, 5708.914366284509, 5710.457506536873, 5710.971445142789, 22411.21560745366, 22872.31383058511, 23060.077596896102, 23081.422964425856, 23433.531329373487, 2178.8474806763534, 2279.9316020519245, 2301.217586020761, 2407.723111842143, 2461.8645974471397, 9106.499142547158, 9739.951300243525, 9891.653792117242, 10143.704130376487, 10445.0, 1841.604055128154, 1899.5156235160084, 1940.1463356123402, 1946.7858535561077, 1967.8622496425255, 78268.21731782667, 79033.81449278323, 79757.60121199356, 80607.19392806056, 81025.0, 10665.84001239982, 10718.464076796285, 10818.350898946088, 11136.944315278533, 11149.108071354272, 15173.772393414107, 15175.392984280505, 15211.391544338103, 15213.847861521464, 15236.542903712907, 7321.890171647429, 7437.293457121565, 7484.663190156456, 7655.311022007934, 7681.692732290758, 6814.931850681529, 6875.5874647521305, 6967.756128535477, 7045.11936007999, 7166.068411106523, 4584.0, 4604.148232576984, 4634.629229661687, 4686.95313046872, 4690.906181876343, 1893.4414347767442, 1896.4310706788185, 1908.3988543608718, 1959.4513536209884, 1988.721578978944, 972.6449845806371, 983.2478154212033, 986.7977064701719, 1002.9648962286285, 1066.4880857188439, 18473.261069557335, 19586.70619940702, 19644.61549996257, 19737.901310493642, 20010.199592016448, 917.000469488261, 945.4894357047255, 963.5086106085946, 965.8985806490358, 993.2550587059706, 10171.237157213238, 10587.0, 10979.121670266359, 10991.945040274748, 11051.834222486668, 431061.0, 432859.0, 441526.0, 447938.0, 449421.0, 81887.590562048, 85781.0, 87863.56068219747, 88081.0, 88118.0, 1004.5128112865254, 1007.219404961161, 1007.6322142417964, 1010.7119470950744, 1041.7447725307347, 16352.754708679142, 16519.83480165183, 16648.0, 16955.152242388078, 17685.82314176842, 37955.0, 38920.0, 39327.2134557313, 43275.78362108169, 43898.78050609854, 50344.496555033984, 54339.913201736534, 54654.72672636611, 54917.1762423556, 55674.44325556693, 8062.435629505878, 8412.284955778827, 8582.742517724479, 8604.827903442021, 8816.0, 12347.506099756269, 13405.0, 13537.187768733907, 13612.455501779817, 13634.181949083088, 10995.945020274847, 11107.333559986426, 11505.942470287595, 11524.654260372203, 12270.711575284824, 10154.796904062025, 10659.733506662396, 10906.890931090587, 11262.380569068451, 11673.0, 11523.884761152281, 11649.650510484698, 11894.464749086485, 11904.880951190724, 12025.939870300592, 8459.577021148794, 8678.349123815613, 8780.604872780612, 8805.867911981453, 8869.73390798277, 10674.519646615765, 10690.465476725976, 10977.615783447542, 11617.941910290394, 11803.940980295387], "value": 9037.266352463732, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1370.2669072046458, 1473.3590887963737, 1494.2976800903577, 1627.9337034242576, 1759.5864971731642, 7175.174854891689, 8075.232852878975, 8407.873881891777, 8425.70510032149, 8435.451695639787, 8282.503049817, 8351.83296334073, 8358.498490090598, 8358.582070896462, 8370.037445693732, 2212.9889350553226, 2243.6522339037474, 2244.3267019893965, 2249.3589327041796, 2254.3124347074136, 2215.6787265846524, 2257.3566533537946, 2276.1350686739015, 2288.7711228877147, 2297.9885100574556, 2228.7882651148198, 2275.670027845961, 2292.3925159832656, 2296.8621882687007, 2303.4356582637192, 2155.170259450123, 2173.3154056472163, 2192.353255789546, 2201.6147174244525, 2202.6916231727573, 2128.180650449588, 2141.325482473016, 2147.914083436661, 2148.666956621726, 2153.364757396556, 8215.424920255584, 8223.095459499451, 8269.793255168608, 8306.377021723334, 8383.95808020962, 5035.169197082477, 5212.192110222922, 5214.713190774506, 5230.581553475713, 5232.450592687751, 3256.3812875553567, 3309.3050459403553, 3408.659134086596, 3477.791332520057, 3497.0, 999.1756800639429, 1012.3369193178406, 1013.9036791504795, 1032.3702541449709, 1039.2413538117141, 11391.202615816896, 11400.0, 11531.365774882379, 11533.884661153365, 11538.88461115395, 4131.772752498641, 4328.653707703376, 4358.542353052884, 4470.083632855257, 4480.977595112069, 8734.65061397537, 8743.737687869374, 8750.168733970262, 8752.29981601483, 8761.167689069529, 5033.0688822567945, 5039.370078740158, 5042.974785126051, 5043.193089105725, 5047.848564543069, 3908.2378936107184, 4125.793710314472, 4150.8547200848425, 4722.102800467969, 4727.196376615983, 3511.754177207622, 3531.417316142859, 3624.836882340301, 3641.5448068991377, 3669.082729317671, 1119.8320251962107, 1124.6176300058019, 1126.2285334545697, 1129.7796929598815, 1130.9830352544718, 842.2293601354814, 950.0119875329718, 980.8136454073704, 981.6956743409565, 1013.6350913671073, 5469.480399362054, 5574.358948720868, 5582.525485333792, 5656.349519805192, 5981.820545383645, 434.52636626077094, 441.6775753699817, 441.97569133697954, 443.14694213638614, 452.36894532127496, 3716.6655001049494, 3745.250949810049, 3745.9250814983548, 3830.3105441020884, 4025.6376926076796, 9627.0, 9856.704298871045, 10112.988701129829, 10119.797604047877, 10128.189744820396, 9904.851427228597, 10055.497225138713, 10076.143527800072, 10151.593936242467, 10386.948065259625, 7634.580098094658, 7781.338586220235, 7798.883016754753, 7806.102298235775, 7819.726309579138, 5478.616496845342, 5500.4499550044675, 5559.11054231321, 5570.303712035996, 5789.3921138279875, 9298.163165315154, 9340.906590934004, 9365.063493650852, 9382.81234375295, 9397.85903211466, 8500.70247541333, 9361.859572106288, 9525.714228573153, 9686.467244301632, 9693.176080033276, 6375.936240637534, 6598.934010659832, 6613.900791488035, 6627.1716035495565, 6773.288804675438, 8052.436329456882, 8080.2727754502375, 8113.472624279403, 8192.877106843283, 8221.424500284922, 7170.103737032871, 7219.422446204396, 7221.061262035902, 7249.0, 7295.963520182365, 7190.316919892811, 7209.891851622335, 7304.050473438419, 7477.738279160203, 7553.055868016498, 6706.295838936841, 6734.4949128816515, 6770.289119642367, 6778.186617605918, 6931.757388491378, 5054.924176137288, 5123.462036486116, 5215.6609820361555, 5245.947540524546, 5286.947130528645, 5164.8192313268855, 5196.7401629917595, 5204.141316682705, 5228.372595288438, 5335.706536140394], "value": 4291.621978413967, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [325.2584108233229, 326.5624063754568, 335.9563256776619, 338.81703879904853, 339.1842618502499, 5285.814996475124, 5300.363956325246, 5310.309659744233, 5340.946590534103, 5342.759575819087, 4972.751362431873, 5046.394432668076, 5111.539961403473, 5152.1498952672855, 5197.350331208599, 4085.836566537335, 4105.507339119295, 4139.130782535656, 4151.709380343377, 4174.749515029101, 4071.7353372030725, 4092.3247664135383, 4093.5087789465306, 4098.774567398792, 4101.220768054075, 3750.774953502785, 3879.398693202558, 3979.422983667381, 4002.2395744808537, 4069.0, 4000.259951908877, 4006.8196931138023, 4007.899802504961, 4009.51885773709, 4010.598940105995, 3519.0469289544294, 3525.6121826599056, 3531.982340088309, 3534.4344904815107, 3542.36237477254, 4788.497207793166, 4988.90022199554, 5020.397552293748, 5038.622103342264, 5061.569766569846, 4569.405977222939, 4573.542645735433, 4591.862244132682, 4592.15045216636, 4593.219152744042, 5386.892262154735, 5401.648892821954, 5409.24270602116, 5437.374701909252, 5439.700816455093, 3786.2427514497213, 3809.676177524914, 3907.765534067965, 3913.706472014582, 3924.156306394139, 5453.363990802783, 5484.780608775644, 5523.696196709219, 5537.179346251074, 5548.611597188198, 3894.240623078529, 3895.9805200973815, 3898.6101389860787, 3900.239453306578, 3904.1215726461887, 3952.9327081687784, 3964.5440774311323, 3974.324364857981, 3974.503187101612, 3991.201759648082, 4387.714798538085, 4487.753173575485, 4514.390557274792, 4536.251518499411, 4540.250858608359, 5381.973090134525, 5384.192371144281, 5394.62237643369, 5403.189521571796, 5416.83749487516, 1367.8221831161886, 1373.2172661582802, 1375.917444953306, 1376.8141300924447, 1380.0960370957039, 888.1562515610196, 901.9413738107002, 956.7416797464784, 965.9275554333453, 975.1175186456269, 5162.690238585622, 5168.8449346519665, 5173.249878767633, 5175.663581867167, 5186.974065129726, 5416.756245968941, 5422.349318081777, 5431.044823863406, 5435.0, 5442.455754424526, 5025.422076461181, 5046.561124809601, 5075.857931965352, 5131.948680513222, 5135.871603209875, 2877.956830647542, 2892.248015515981, 2895.30512676956, 2899.362140329124, 2905.5205891028168, 5426.457354264542, 5564.8330550083565, 5579.358373787067, 5625.8593535161945, 5660.235868157746, 5598.188262701886, 5627.311806458046, 5634.7182640867795, 5649.915251271234, 5652.660840349592, 5715.428457154251, 5735.741891614887, 5749.223854779551, 5751.626144300691, 5758.539316854725, 5262.815801447084, 5489.39616642161, 5512.862178445411, 5563.471470210324, 5585.916211256916, 5444.673319600836, 5472.549774309731, 5488.615796894179, 5491.979411323836, 5500.724963751716, 5603.971980140073, 5707.429257074426, 5731.398203188772, 5732.197492351158, 5747.655140691572, 3893.124047089382, 3904.219156168721, 3905.628965248297, 3908.8241029154324, 3918.2555314490155, 5507.228987941611, 5513.696746678811, 5517.862053448696, 5528.861778455571, 5531.446855314436, 5330.360356757059, 5404.7297635118875, 5416.593755468277, 5445.618806683653, 5455.208994695826, 5336.973315133399, 5359.3032905722, 5391.676499410048, 5393.568514518751, 5425.674459532441, 5199.428062913152, 5319.25530425733, 5391.29913111293, 5399.946000539944, 5416.4041955385665, 5286.841394758163, 5422.240886276003, 5436.429174936733, 5475.260839786737, 5477.096279114061, 5338.46615338463, 5349.197620356822, 5357.142857142839, 5365.865853353541, 5384.4346343634925], "value": 4118.516272325935, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [733.8679037773201, 743.9776806695801, 778.0, 782.8982232309799, 791.9406044546661, 13896.652583685413, 14375.496857609985, 14459.92770036151, 14575.927120364397, 14613.196274204902, 13188.604341869735, 13195.802062969064, 13201.339933003335, 13252.867471325284, 13291.468341266338, 796.434531482648, 805.9798505037392, 810.5784991804259, 812.5043723328765, 814.0191069760924, 794.8608993426157, 803.2770506544127, 803.6825453945688, 804.1315379390273, 813.0081300812999, 848.0713618587637, 856.1224744636766, 856.2807241916788, 856.3577317012241, 856.7258477287271, 848.3933987199182, 849.8470275350435, 850.1668365002301, 850.421713235, 850.5024560632038, 625.9311475737711, 631.9936800631981, 632.0645444741808, 632.6741728010079, 632.89873620221, 13357.866421335759, 13386.665333366647, 13400.664983375396, 13405.195688258638, 13418.0, 10413.427261500614, 10522.105621022223, 10624.840627390595, 10628.893711062869, 10869.619563315246, 10048.145907597864, 10157.436783727415, 10158.39049657023, 10366.533505992249, 10710.143188544898, 3729.4219395993664, 3730.123420996064, 3774.1508160663907, 3788.242351529705, 3848.692104631623, 58110.70944645292, 59418.22315739083, 60467.09299360513, 60866.391336086956, 62112.0, 10019.849702254473, 10740.0, 10969.890301096886, 10976.945115274531, 11129.944350278196, 19926.90036549808, 20094.69857952132, 20123.993800310218, 20239.4940126498, 20361.694574581394, 7678.270564296383, 8083.757487275391, 8093.109757926623, 8181.918180818235, 8378.162183781573, 4549.499555048942, 4559.202139625552, 4560.749158796231, 4621.514740952151, 4652.744099074515, 3361.09250502363, 3430.0, 3479.5128681984543, 3482.0946553895665, 3489.3370259650587, 633.5850018238061, 639.8144538083997, 640.6188317950812, 640.8878446271884, 651.8272657745702, 635.5170070746174, 695.4957655699577, 713.350850725837, 734.2510639148039, 742.6509540515949, 9219.631214751469, 9289.16397524226, 9631.759206019906, 9647.614095436244, 9863.457509837028, 681.3356976947437, 701.7017767448814, 718.4144921888644, 732.1945859554447, 739.0798455922411, 4130.979345103316, 4333.371661109121, 4461.888452788641, 4558.247889098328, 4578.725276483422, 63777.36222637714, 85833.57083214544, 89748.0, 91336.71658208466, 92844.0, 66701.33298666951, 71748.0, 73246.63376683189, 74977.0, 75420.0, 67489.32510674928, 69193.3080669197, 69350.0, 69482.30517694859, 71132.2886771136, 8895.199432051146, 9068.863967040368, 9104.362694611315, 9110.180083792226, 9123.15408748489, 46572.54839225843, 47525.28712069253, 47919.76040119777, 48160.75919620379, 49370.259446109056, 61822.0, 63292.36707633049, 63314.366856330846, 65744.34255657574, 65802.68394631984, 10755.569777208824, 11030.195558831938, 11413.0, 12021.09841761854, 12090.516379344728, 12455.314957677414, 12728.6817829555, 12904.935475322563, 13055.543055992996, 13820.37808298649, 12032.578859739868, 12247.0, 12512.499500019898, 12628.152807915072, 12883.80674289905, 11287.20989530725, 11334.773304534028, 11885.465154067915, 12122.212056216318, 12132.393380331125, 11782.469788859351, 12127.45426455794, 12298.142189212018, 12305.446254918372, 12512.0, 9559.926446770984, 9698.175655069399, 9763.658271960447, 9852.162566181954, 9959.302848800515, 8541.316694664287, 8781.780455488664, 9600.231981441608, 9612.327137100336, 9645.27660425485], "value": 6896.954342338178, "unit": "score"}], "name": "dromaeo_css", "value": 6978.686040452141, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 111.0, 113.0, 111.0, 110.0, 109.0, 112.0, 110.0, 111.0, 110.0], "value": 110.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 121.0, 122.0, 168.0, 130.0, 130.0, 127.0, 121.0, 151.0, 122.0], "value": 134.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 162.0, 162.0, 162.0, 161.0, 162.0, 161.0, 162.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 102.0, 77.0, 80.0, 79.0, 77.0, 103.0, 75.0], "value": 81.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 108.0, 82.0, 82.0, 82.0, 106.0, 83.0, 82.0, 116.0], "value": 90.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 147.0, 146.0, 146.0, 146.0, 146.0, 145.0, 145.0, 146.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 85.0, 85.0, 85.0, 85.0, 85.0, 84.0, 84.0, 85.0], "value": 84.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 52.0, 51.0, 51.0, 53.0, 53.0, 53.0, 55.0, 53.0], "value": 52.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 60.0, 60.0, 70.0, 60.0, 59.0, 60.0, 64.0, 60.0], "value": 61.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 79.0, 79.0, 79.0, 78.0, 80.0, 79.0, 88.0, 80.0], "value": 80.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 139.0, 133.0, 132.0, 137.0, 135.0, 139.0, 134.0, 167.0, 135.0], "value": 138.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 165.0, 168.0, 163.0, 165.0, 164.0, 163.0, 163.0, 164.0, 164.0], "value": 164.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 65.0, 65.0, 63.0, 67.0, 63.0, 63.0, 62.0, 63.0, 63.0], "value": 64.2, "unit": "score"}], "name": "kraken", "value": 1488.3000000000002, "alertThreshold": 2.0}]} 06:14:51 INFO - Return code: 0 06:14:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:14:52 INFO - # TBPL SUCCESS # 06:14:52 INFO - Running post-action listener: _resource_record_post_action 06:14:52 INFO - [mozharness: 2016-10-30 13:14:52.048138Z] Finished run-tests step (success) 06:14:52 INFO - Running post-run listener: _resource_record_post_run 06:14:52 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 0; Write bytes: 392261632; Read time: 0; Write time: 295260 06:14:52 INFO - TinderboxPrint: CPU usage
13.0% 06:14:52 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 06:14:52 INFO - TinderboxPrint: I/O write bytes / time
392,261,632 / 295,260 06:14:52 INFO - TinderboxPrint: CPU idle
8,305.4 (87.0%) 06:14:52 INFO - TinderboxPrint: CPU user
1,197.1 (12.5%) 06:14:52 INFO - TinderboxPrint: Swap in / out
0 / 0 06:14:52 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 104521728; Read time: 0; Write time: 67236 06:14:52 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 286433280; Read time: 0; Write time: 227868 06:14:52 INFO - Running post-run listener: _upload_blobber_files 06:14:52 INFO - Blob upload gear active. 06:14:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:14:52 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 06:14:52 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'] 06:14:52 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 06:14:53 INFO - (blobuploader) - INFO - Open directory for files ... 06:14:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:14:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:14:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:14:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:14:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:14:54 INFO - (blobuploader) - INFO - Done attempting. 06:14:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:14:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:14:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:14:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:14:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:14:55 INFO - (blobuploader) - INFO - Done attempting. 06:14:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:14:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:14:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:15:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:15:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:15:03 INFO - (blobuploader) - INFO - Done attempting. 06:15:03 INFO - (blobuploader) - INFO - Iteration through files over. 06:15:03 INFO - Return code: 0 06:15:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:15:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:15:03 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4dd9f61e8e9ec9afeeb9736a5367f012c7918b1e4dbaa7be98f42a80dc639b0d00d226dc85325f838eb3cee8995185ceb0a16e66bdadbd2c535c585e7fd84f2d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3227cd16d00ae14445a9637b1007cf425abb60d63ca585f4b53dae3aa2f9b9d12a09e634f8b9fd14765d01c18b6083137ce2af00055015981459eb4180010818", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f2001b55bdcc4ceabffcd8987dec7f9ba9f5b2274e5bfee7805568bcc80e1f08c638ae553f0b13bf03d1c8313066d17122e8d475d795a2af5f7e96e5d0310937"} 06:15:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:15:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:15:03 INFO - Contents: 06:15:03 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4dd9f61e8e9ec9afeeb9736a5367f012c7918b1e4dbaa7be98f42a80dc639b0d00d226dc85325f838eb3cee8995185ceb0a16e66bdadbd2c535c585e7fd84f2d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3227cd16d00ae14445a9637b1007cf425abb60d63ca585f4b53dae3aa2f9b9d12a09e634f8b9fd14765d01c18b6083137ce2af00055015981459eb4180010818", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f2001b55bdcc4ceabffcd8987dec7f9ba9f5b2274e5bfee7805568bcc80e1f08c638ae553f0b13bf03d1c8313066d17122e8d475d795a2af5f7e96e5d0310937"} 06:15:03 INFO - Running post-run listener: copy_logs_to_upload_dir 06:15:03 INFO - Copying logs to upload dir... 06:15:03 INFO - mkdir: /builds/slave/test/build/upload/logs 06:15:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.646117 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-10-30 06:15:03.092100) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-30 06:15:03.095824) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41bf3e9aed84707956354da8000001c5-1477832058.329704-471705509 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/4dd9f61e8e9ec9afeeb9736a5367f012c7918b1e4dbaa7be98f42a80dc639b0d00d226dc85325f838eb3cee8995185ceb0a16e66bdadbd2c535c585e7fd84f2d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3227cd16d00ae14445a9637b1007cf425abb60d63ca585f4b53dae3aa2f9b9d12a09e634f8b9fd14765d01c18b6083137ce2af00055015981459eb4180010818", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f2001b55bdcc4ceabffcd8987dec7f9ba9f5b2274e5bfee7805568bcc80e1f08c638ae553f0b13bf03d1c8313066d17122e8d475d795a2af5f7e96e5d0310937"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477683089/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011231 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477683089/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/4dd9f61e8e9ec9afeeb9736a5367f012c7918b1e4dbaa7be98f42a80dc639b0d00d226dc85325f838eb3cee8995185ceb0a16e66bdadbd2c535c585e7fd84f2d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3227cd16d00ae14445a9637b1007cf425abb60d63ca585f4b53dae3aa2f9b9d12a09e634f8b9fd14765d01c18b6083137ce2af00055015981459eb4180010818", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f2001b55bdcc4ceabffcd8987dec7f9ba9f5b2274e5bfee7805568bcc80e1f08c638ae553f0b13bf03d1c8313066d17122e8d475d795a2af5f7e96e5d0310937"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-30 06:15:03.121604) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-30 06:15:03.121963) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41bf3e9aed84707956354da8000001c5-1477832058.329704-471705509 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004438 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-30 06:15:03.206685) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-30 06:15:03.207045) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-30 06:15:03.207436) ========= ========= Total master_lag: 0.18 =========