builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-010 starttime: 1476743507.66 results: success (0) buildid: 20161017153002 builduid: f9bb2eb607804b4c86c315867a6b3c0d revision: b08f6d369c80f062a34bbb22ff568c88489114c5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-17 15:31:47.663324) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-17 15:31:47.663923) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-17 15:31:47.664253) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-17 15:31:47.681495) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 15:31:47.682126) ========= 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=eca2ab57546de7b41f256b19000001ef-1476743507.323003-1525556765 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-17 15:31:48-- 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% 70.1M=0s 2016-10-17 15:31:48 (70.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.121235 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 15:31:47.818010) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 15:31:47.818334) ========= 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=eca2ab57546de7b41f256b19000001ef-1476743507.323003-1525556765 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019240 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 15:31:47.869768) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 15:31:47.870413) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev b08f6d369c80f062a34bbb22ff568c88489114c5 --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 b08f6d369c80f062a34bbb22ff568c88489114c5 --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=eca2ab57546de7b41f256b19000001ef-1476743507.323003-1525556765 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-17 15:31:48,282 truncating revision to first 12 chars 2016-10-17 15:31:48,282 Setting DEBUG logging. 2016-10-17 15:31:48,282 attempt 1/10 2016-10-17 15:31:48,282 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/b08f6d369c80?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-17 15:31:48,657 unpacking tar archive at: mozilla-inbound-b08f6d369c80/testing/mozharness/ program finished with exit code 0 elapsedTime=0.687130 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 15:31:48.571388) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-17 15:31:48.571718) ========= script_repo_revision: b08f6d369c80f062a34bbb22ff568c88489114c5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-17 15:31:48.572129) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-17 15:31:48.572418) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-17 15:31:48.581984) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-10-17 15:31:48.582399) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=eca2ab57546de7b41f256b19000001ef-1476743507.323003-1525556765 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:31:49 INFO - MultiFileLogger online at 20161017 15:31:49 in /builds/slave/test 15:31:49 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 15:31:49 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:31:49 INFO - {'append_to_log': False, 15:31:49 INFO - 'base_work_dir': '/builds/slave/test', 15:31:49 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 15:31:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:31:49 INFO - 'branch': 'Mozilla-Inbound', 15:31:49 INFO - 'buildbot_json_path': 'buildprops.json', 15:31:49 INFO - 'config_files': ('talos/linux_config.py',), 15:31:49 INFO - 'default_actions': ('clobber', 15:31:49 INFO - 'read-buildbot-config', 15:31:49 INFO - 'download-and-extract', 15:31:49 INFO - 'populate-webroot', 15:31:49 INFO - 'create-virtualenv', 15:31:49 INFO - 'install', 15:31:49 INFO - 'run-tests'), 15:31:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:31:49 INFO - 'download_minidump_stackwalk': True, 15:31:49 INFO - 'download_symbols': 'ondemand', 15:31:49 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:31:49 INFO - 'tooltool.py': '/tools/tooltool.py', 15:31:49 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:31:49 INFO - '/tools/misc-python/virtualenv.py')}, 15:31:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:31:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:31:49 INFO - 'installer_path': 'installer.exe', 15:31:49 INFO - 'log_level': 'info', 15:31:49 INFO - 'log_name': 'talos', 15:31:49 INFO - 'log_to_console': True, 15:31:49 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:31:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:31:49 INFO - 'opt_config_files': (), 15:31:49 INFO - 'pip_index': False, 15:31:49 INFO - 'sps_profile': False, 15:31:49 INFO - 'sps_profile_interval': 0, 15:31:49 INFO - 'suite': 'dromaeojs-e10s', 15:31:49 INFO - 'system_bits': '32', 15:31:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:31:49 INFO - 'title': 'talos-linux64-ix-010', 15:31:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:31:49 INFO - 'use_talos_json': True, 15:31:49 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:31:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:31:49 INFO - 'work_dir': 'build'} 15:31:49 INFO - [mozharness: 2016-10-17 22:31:49.091810Z] Running clobber step. 15:31:49 INFO - Running pre-action listener: _resource_record_pre_action 15:31:49 INFO - Running main action method: clobber 15:31:49 INFO - rmtree: /builds/slave/test/build 15:31:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:31:49 INFO - Running post-action listener: _resource_record_post_action 15:31:49 INFO - [mozharness: 2016-10-17 22:31:49.610792Z] Finished clobber step (success) 15:31:49 INFO - [mozharness: 2016-10-17 22:31:49.610892Z] Running read-buildbot-config step. 15:31:49 INFO - Running pre-action listener: _resource_record_pre_action 15:31:49 INFO - Running main action method: read_buildbot_config 15:31:49 INFO - Using buildbot properties: 15:31:49 INFO - { 15:31:49 INFO - "project": "", 15:31:49 INFO - "product": "firefox", 15:31:49 INFO - "script_repo_revision": "production", 15:31:49 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 15:31:49 INFO - "repository": "", 15:31:49 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 15:31:49 INFO - "buildid": "20161017153002", 15:31:49 INFO - "stage_platform": "linux64-pgo", 15:31:49 INFO - "basedir": "/builds/slave/test", 15:31:49 INFO - "buildnumber": 1309, 15:31:49 INFO - "platform": "ubuntu64_hw", 15:31:49 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 15:31:49 INFO - "slavebuilddir": "test", 15:31:49 INFO - "branch": "mozilla-inbound", 15:31:49 INFO - "revision": "b08f6d369c80f062a34bbb22ff568c88489114c5", 15:31:49 INFO - "slavename": "talos-linux64-ix-010", 15:31:49 INFO - "builduid": "f9bb2eb607804b4c86c315867a6b3c0d", 15:31:49 INFO - "repo_path": "integration/mozilla-inbound" 15:31:49 INFO - } 15:31:49 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1476732604/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 15:31:49 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1476732604/firefox-52.0a1.en-US.linux-x86_64.test_packages.json. 15:31:49 INFO - Running post-action listener: _resource_record_post_action 15:31:49 INFO - [mozharness: 2016-10-17 22:31:49.613229Z] Finished read-buildbot-config step (success) 15:31:49 INFO - [mozharness: 2016-10-17 22:31:49.613315Z] Running download-and-extract step. 15:31:49 INFO - Running pre-action listener: _resource_record_pre_action 15:31:49 INFO - Running main action method: download_and_extract 15:31:49 INFO - mkdir: /builds/slave/test/build/tests 15:31:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:31:49 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1476732604/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 15:31:49 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1476732604/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 15:31:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1476732604/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 15:31:49 INFO - Downloaded 1361 bytes. 15:31:49 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 15:31:49 INFO - Using the following test package requirements: 15:31:49 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 15:31:49 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:31:49 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:31:49 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:31:49 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:31:49 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:31:49 INFO - u'jsshell-linux-x86_64.zip'], 15:31:49 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:31:49 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:31:49 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 15:31:49 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:31:49 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:31:49 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:31:49 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:31:49 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:31:49 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:31:49 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:31:49 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:31:49 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:31:49 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/1476732604/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 15:31:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1476732604/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:31:49 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1476732604/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 15:31:49 INFO - Http code: 200 15:31:49 INFO - via: 1.1 e1eb7447ab46f530f6009f1d93917c54.cloudfront.net (CloudFront) 15:31:49 INFO - x-amz-cf-id: PfiExFDXBR_dQH2TAJTfbfYQ541uM-4NmY6ei67z6wurTLVatq98Hg== 15:31:49 INFO - x-amz-replication-status: COMPLETED 15:31:49 INFO - x-amz-version-id: mQJUe1oi5pZ7kwx8lmEhzb.Bu5ZhIYvW 15:31:49 INFO - Expected file size: 22089281 15:31:49 INFO - Obtained file size: 22089281 15:31:53 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 15:31:53 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/1476732604/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 15:31:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1476732604/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:31:53 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1476732604/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 15:31:53 INFO - Http code: 200 15:31:53 INFO - via: 1.1 66ed69e8b47ad05050331602c798132f.cloudfront.net (CloudFront) 15:31:53 INFO - x-amz-cf-id: fxKflZSjj26ett-IPEKd0_PowkloPXe-Zb9xZiGweZMV_B8bR86M3w== 15:31:53 INFO - x-amz-replication-status: COMPLETED 15:31:53 INFO - x-amz-version-id: mQJUe1oi5pZ7kwx8lmEhzb.Bu5ZhIYvW 15:31:54 INFO - Expected file size: 22089281 15:31:54 INFO - Obtained file size: 22089281 15:31:58 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/1476732604/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 15:31:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1476732604/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:31:58 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1476732604/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 15:31:58 INFO - Http code: 200 15:31:58 INFO - via: 1.1 441811a054e8d055b893175754efd0c3.cloudfront.net (CloudFront) 15:31:58 INFO - x-amz-cf-id: ezL253V6UlIYSJrUyWl3g3dXqblySTPovizjjxLTmhDJh_0jnSkZBQ== 15:31:58 INFO - x-amz-replication-status: COMPLETED 15:31:58 INFO - x-amz-version-id: Qfr6dXueKVRs799Ig.JTj9asBGSDHW5G 15:31:59 INFO - Expected file size: 14409028 15:31:59 INFO - Obtained file size: 14409028 15:31:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:31:59 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1476732604/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:31:59 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1476732604/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 15:31:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1476732604/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 15:32:00 INFO - Downloaded 59482468 bytes. 15:32:00 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1476732604/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:32:00 INFO - mkdir: /builds/slave/test/properties 15:32:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:32:00 INFO - Writing to file /builds/slave/test/properties/build_url 15:32:00 INFO - Contents: 15:32:00 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1476732604/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:32:00 INFO - Running post-action listener: _resource_record_post_action 15:32:00 INFO - Running post-action listener: set_extra_try_arguments 15:32:00 INFO - [mozharness: 2016-10-17 22:32:00.519324Z] Finished download-and-extract step (success) 15:32:00 INFO - [mozharness: 2016-10-17 22:32:00.519551Z] Running populate-webroot step. 15:32:00 INFO - Running pre-action listener: _resource_record_pre_action 15:32:00 INFO - Running main action method: populate_webroot 15:32:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:32:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:32:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:32:00 INFO - '--tppagecycles', 15:32:00 INFO - '7'], 15:32:00 INFO - 'tests': ['tsvgm']}}, 15:32:00 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:32:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:32:00 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:32:00 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:32:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:32:00 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:32:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:32:00 INFO - 'talos_options': ['--disable-e10s'], 15:32:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:32:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:32:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:32:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:32:00 INFO - 'talos_options': ['--disable-e10s'], 15:32:00 INFO - 'tests': ['damp', 'tps']}, 15:32:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:32:00 INFO - 'tests': ['damp', 'tps']}, 15:32:00 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:32:00 INFO - 'tests': ['dromaeo_dom']}, 15:32:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:32:00 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:32:00 INFO - 'tests': ['basic_compositor_video']}, 15:32:00 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:32:00 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:32:00 INFO - 'tests': ['a11yr', 15:32:00 INFO - 'ts_paint', 15:32:00 INFO - 'tpaint', 15:32:00 INFO - 'sessionrestore', 15:32:00 INFO - 'sessionrestore_no_auto_restore', 15:32:00 INFO - 'tabpaint']}, 15:32:00 INFO - 'other-e10s': {'tests': ['a11yr', 15:32:00 INFO - 'ts_paint', 15:32:00 INFO - 'tpaint', 15:32:00 INFO - 'sessionrestore', 15:32:00 INFO - 'sessionrestore_no_auto_restore', 15:32:00 INFO - 'tabpaint']}, 15:32:00 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:32:00 INFO - 'ts_paint', 15:32:00 INFO - 'tpaint', 15:32:00 INFO - 'sessionrestore', 15:32:00 INFO - 'sessionrestore_no_auto_restore', 15:32:00 INFO - 'tabpaint']}, 15:32:00 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:32:00 INFO - 'ts_paint', 15:32:00 INFO - 'tpaint', 15:32:00 INFO - 'sessionrestore', 15:32:00 INFO - 'sessionrestore_no_auto_restore', 15:32:00 INFO - 'tabpaint']}, 15:32:00 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:32:00 INFO - 'tests': ['a11yr', 15:32:00 INFO - 'ts_paint', 15:32:00 INFO - 'tpaint', 15:32:00 INFO - 'sessionrestore', 15:32:00 INFO - 'sessionrestore_no_auto_restore', 15:32:00 INFO - 'tabpaint']}, 15:32:00 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:32:00 INFO - 'tests': ['a11yr', 15:32:00 INFO - 'ts_paint', 15:32:00 INFO - 'tpaint', 15:32:00 INFO - 'sessionrestore', 15:32:00 INFO - 'sessionrestore_no_auto_restore', 15:32:00 INFO - 'tabpaint']}, 15:32:00 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:32:00 INFO - 'tests': ['tsvgx', 15:32:00 INFO - 'tsvgr_opacity', 15:32:00 INFO - 'tart', 15:32:00 INFO - 'tscrollx', 15:32:00 INFO - 'cart']}, 15:32:00 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:32:00 INFO - 'tsvgr_opacity', 15:32:00 INFO - 'tart', 15:32:00 INFO - 'tscrollx', 15:32:00 INFO - 'cart']}, 15:32:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:32:00 INFO - 'talos_options': ['--disable-e10s'], 15:32:00 INFO - 'tests': ['tp5o']}, 15:32:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:32:00 INFO - 'tests': ['tp5o']}, 15:32:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:32:00 INFO - 'talos_options': ['--disable-e10s', 15:32:00 INFO - '--xperf_path', 15:32:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:32:00 INFO - 'tests': ['tp5n']}, 15:32:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:32:00 INFO - 'talos_options': ['--xperf_path', 15:32:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:32:00 INFO - 'tests': ['tp5n']}}, 15:32:00 INFO - 'talos.zip': {'path': '', 15:32:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:32:00 INFO - Running post-action listener: _resource_record_post_action 15:32:00 INFO - [mozharness: 2016-10-17 22:32:00.541643Z] Finished populate-webroot step (success) 15:32:00 INFO - [mozharness: 2016-10-17 22:32:00.541732Z] Running create-virtualenv step. 15:32:00 INFO - Running pre-action listener: _resource_record_pre_action 15:32:00 INFO - Running main action method: create_virtualenv 15:32:00 INFO - Creating virtualenv /builds/slave/test/build/venv 15:32:00 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:32:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:32:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:32:00 INFO - Using real prefix '/usr' 15:32:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:32:01 INFO - Installing distribute.............................................................................................................................................................................................done. 15:32:03 INFO - Installing pip.................done. 15:32:03 INFO - Return code: 0 15:32:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:32:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:32:03 INFO - Reading from file tmpfile_stdout 15:32:03 INFO - Output received: 15:32:03 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 15:32:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:32:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:32:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:32:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:32:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:32:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1ec222f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c6f60>, '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 0x27c7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27c81d0>, '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': 'eca2ab57546de7b41f256b19000001ef-1476743507.323003-1525556765', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:32:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:32:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:32:03 INFO - Using env: {'DISPLAY': ':0', 15:32:03 INFO - 'HOME': '/home/cltbld', 15:32:03 INFO - 'LANG': 'en_US.UTF-8', 15:32:03 INFO - 'LANGUAGE': 'en_US:en', 15:32:03 INFO - 'LOGNAME': 'cltbld', 15:32:03 INFO - 'MAIL': '/var/mail/cltbld', 15:32:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:32:03 INFO - 'MOZ_NO_REMOTE': '1', 15:32:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:32:03 INFO - 'NO_EM_RESTART': '1', 15:32:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:32:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:32:03 INFO - 'PWD': '/builds/slave/test', 15:32:03 INFO - 'SHELL': '/bin/bash', 15:32:03 INFO - 'SHLVL': '1', 15:32:03 INFO - 'TERM': 'linux', 15:32:03 INFO - 'TMOUT': '86400', 15:32:03 INFO - 'USER': 'cltbld', 15:32:03 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1476743507.323003-1525556765', 15:32:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:32:03 INFO - '_': '/tools/buildbot/bin/python'} 15:32:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:32:03 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 15:32:03 INFO - Cleaning up... 15:32:03 INFO - Return code: 0 15:32:03 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:32:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:32:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:32:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:32:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:32:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1ec222f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c6f60>, '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 0x27c7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27c81d0>, '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': 'eca2ab57546de7b41f256b19000001ef-1476743507.323003-1525556765', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:32:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:32:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:32:03 INFO - Using env: {'DISPLAY': ':0', 15:32:03 INFO - 'HOME': '/home/cltbld', 15:32:03 INFO - 'LANG': 'en_US.UTF-8', 15:32:03 INFO - 'LANGUAGE': 'en_US:en', 15:32:03 INFO - 'LOGNAME': 'cltbld', 15:32:03 INFO - 'MAIL': '/var/mail/cltbld', 15:32:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:32:03 INFO - 'MOZ_NO_REMOTE': '1', 15:32:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:32:03 INFO - 'NO_EM_RESTART': '1', 15:32:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:32:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:32:03 INFO - 'PWD': '/builds/slave/test', 15:32:03 INFO - 'SHELL': '/bin/bash', 15:32:03 INFO - 'SHLVL': '1', 15:32:03 INFO - 'TERM': 'linux', 15:32:03 INFO - 'TMOUT': '86400', 15:32:03 INFO - 'USER': 'cltbld', 15:32:03 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1476743507.323003-1525556765', 15:32:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:32:03 INFO - '_': '/tools/buildbot/bin/python'} 15:32:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:32:03 INFO - Downloading/unpacking psutil>=3.1.1 15:32:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:32:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:32:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:32:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:32:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:32:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:32:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:32:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:32:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:32:05 INFO - Installing collected packages: psutil 15:32:05 INFO - Running setup.py install for psutil 15:32:05 INFO - building 'psutil._psutil_linux' extension 15:32:05 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 15:32:06 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 15:32:06 INFO - building 'psutil._psutil_posix' extension 15:32:06 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 15:32:06 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 15:32:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:32:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:32:06 INFO - Successfully installed psutil 15:32:06 INFO - Cleaning up... 15:32:06 INFO - Return code: 0 15:32:06 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:32:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:32:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:32:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:32:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:32:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1ec222f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c6f60>, '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 0x27c7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27c81d0>, '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': 'eca2ab57546de7b41f256b19000001ef-1476743507.323003-1525556765', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:32:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:32:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:32:06 INFO - Using env: {'DISPLAY': ':0', 15:32:06 INFO - 'HOME': '/home/cltbld', 15:32:06 INFO - 'LANG': 'en_US.UTF-8', 15:32:06 INFO - 'LANGUAGE': 'en_US:en', 15:32:06 INFO - 'LOGNAME': 'cltbld', 15:32:06 INFO - 'MAIL': '/var/mail/cltbld', 15:32:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:32:06 INFO - 'MOZ_NO_REMOTE': '1', 15:32:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:32:06 INFO - 'NO_EM_RESTART': '1', 15:32:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:32:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:32:06 INFO - 'PWD': '/builds/slave/test', 15:32:06 INFO - 'SHELL': '/bin/bash', 15:32:06 INFO - 'SHLVL': '1', 15:32:06 INFO - 'TERM': 'linux', 15:32:06 INFO - 'TMOUT': '86400', 15:32:06 INFO - 'USER': 'cltbld', 15:32:06 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1476743507.323003-1525556765', 15:32:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:32:06 INFO - '_': '/tools/buildbot/bin/python'} 15:32:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:32:06 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:32:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:32:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:32:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:32:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:32:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:32:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:32:08 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:32:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:32:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:32:08 INFO - Installing collected packages: mozsystemmonitor 15:32:08 INFO - Running setup.py install for mozsystemmonitor 15:32:08 INFO - Successfully installed mozsystemmonitor 15:32:08 INFO - Cleaning up... 15:32:08 INFO - Return code: 0 15:32:08 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:32:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:32:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:32:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:32:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:32:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1ec222f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c6f60>, '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 0x27c7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27c81d0>, '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': 'eca2ab57546de7b41f256b19000001ef-1476743507.323003-1525556765', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:32:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:32:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:32:08 INFO - Using env: {'DISPLAY': ':0', 15:32:08 INFO - 'HOME': '/home/cltbld', 15:32:08 INFO - 'LANG': 'en_US.UTF-8', 15:32:08 INFO - 'LANGUAGE': 'en_US:en', 15:32:08 INFO - 'LOGNAME': 'cltbld', 15:32:08 INFO - 'MAIL': '/var/mail/cltbld', 15:32:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:32:08 INFO - 'MOZ_NO_REMOTE': '1', 15:32:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:32:08 INFO - 'NO_EM_RESTART': '1', 15:32:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:32:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:32:08 INFO - 'PWD': '/builds/slave/test', 15:32:08 INFO - 'SHELL': '/bin/bash', 15:32:08 INFO - 'SHLVL': '1', 15:32:08 INFO - 'TERM': 'linux', 15:32:08 INFO - 'TMOUT': '86400', 15:32:08 INFO - 'USER': 'cltbld', 15:32:08 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1476743507.323003-1525556765', 15:32:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:32:08 INFO - '_': '/tools/buildbot/bin/python'} 15:32:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:32:08 INFO - Downloading/unpacking jsonschema==2.5.1 15:32:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:32:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:32:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:32:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:32:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:32:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:32:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:32:10 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:32:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:32:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:32:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:32:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:32:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:32:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:32:11 INFO - Downloading functools32-3.2.3-2.tar.gz 15:32:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:32:11 INFO - warning: no files found matching '*.txt' 15:32:11 INFO - no previously-included directories found matching 'build' 15:32:11 INFO - no previously-included directories found matching 'dist' 15:32:11 INFO - no previously-included directories found matching '.git*' 15:32:11 INFO - Installing collected packages: jsonschema, functools32 15:32:11 INFO - Running setup.py install for functools32 15:32:11 INFO - warning: no files found matching '*.txt' 15:32:11 INFO - no previously-included directories found matching 'build' 15:32:11 INFO - no previously-included directories found matching 'dist' 15:32:11 INFO - no previously-included directories found matching '.git*' 15:32:11 INFO - Successfully installed jsonschema functools32 15:32:11 INFO - Cleaning up... 15:32:11 INFO - Return code: 0 15:32:11 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:32:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:32:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:32:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:32:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:32:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1ec222f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c6f60>, '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 0x27c7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27c81d0>, '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': 'eca2ab57546de7b41f256b19000001ef-1476743507.323003-1525556765', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:32:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:32:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 15:32:11 INFO - Using env: {'DISPLAY': ':0', 15:32:11 INFO - 'HOME': '/home/cltbld', 15:32:11 INFO - 'LANG': 'en_US.UTF-8', 15:32:11 INFO - 'LANGUAGE': 'en_US:en', 15:32:11 INFO - 'LOGNAME': 'cltbld', 15:32:11 INFO - 'MAIL': '/var/mail/cltbld', 15:32:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:32:11 INFO - 'MOZ_NO_REMOTE': '1', 15:32:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:32:11 INFO - 'NO_EM_RESTART': '1', 15:32:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:32:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:32:11 INFO - 'PWD': '/builds/slave/test', 15:32:11 INFO - 'SHELL': '/bin/bash', 15:32:11 INFO - 'SHLVL': '1', 15:32:11 INFO - 'TERM': 'linux', 15:32:11 INFO - 'TMOUT': '86400', 15:32:11 INFO - 'USER': 'cltbld', 15:32:11 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1476743507.323003-1525556765', 15:32:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:32:11 INFO - '_': '/tools/buildbot/bin/python'} 15:32:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:32:11 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:32:11 INFO - Cleaning up... 15:32:11 INFO - Return code: 0 15:32:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:32:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:32:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:32:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:32:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:32:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1ec222f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c6f60>, '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 0x27c7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27c81d0>, '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': 'eca2ab57546de7b41f256b19000001ef-1476743507.323003-1525556765', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:32:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:32:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:32:11 INFO - Using env: {'DISPLAY': ':0', 15:32:11 INFO - 'HOME': '/home/cltbld', 15:32:11 INFO - 'LANG': 'en_US.UTF-8', 15:32:11 INFO - 'LANGUAGE': 'en_US:en', 15:32:11 INFO - 'LOGNAME': 'cltbld', 15:32:11 INFO - 'MAIL': '/var/mail/cltbld', 15:32:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:32:11 INFO - 'MOZ_NO_REMOTE': '1', 15:32:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:32:11 INFO - 'NO_EM_RESTART': '1', 15:32:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:32:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:32:11 INFO - 'PWD': '/builds/slave/test', 15:32:11 INFO - 'SHELL': '/bin/bash', 15:32:11 INFO - 'SHLVL': '1', 15:32:11 INFO - 'TERM': 'linux', 15:32:11 INFO - 'TMOUT': '86400', 15:32:11 INFO - 'USER': 'cltbld', 15:32:11 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1476743507.323003-1525556765', 15:32:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:32:11 INFO - '_': '/tools/buildbot/bin/python'} 15:32:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:32:11 INFO - Downloading/unpacking blobuploader==1.2.4 15:32:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:32:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:32:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:32:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:32:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:32:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:32:13 INFO - Downloading blobuploader-1.2.4.tar.gz 15:32:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:32:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:32:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:32:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:32:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:32:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:32:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:32:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:32:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:32:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:32:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:32:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:32:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:32:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:32:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:32:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:32:14 INFO - Downloading docopt-0.6.1.tar.gz 15:32:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:32:14 INFO - Installing collected packages: blobuploader, requests, docopt 15:32:14 INFO - Running setup.py install for blobuploader 15:32:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:32:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:32:14 INFO - Running setup.py install for requests 15:32:15 INFO - Running setup.py install for docopt 15:32:15 INFO - Successfully installed blobuploader requests docopt 15:32:15 INFO - Cleaning up... 15:32:15 INFO - Return code: 0 15:32:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:32:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:32:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:32:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:32:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:32:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1ec222f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c6f60>, '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 0x27c7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27c81d0>, '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': 'eca2ab57546de7b41f256b19000001ef-1476743507.323003-1525556765', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:32:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:32:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:32:15 INFO - Using env: {'DISPLAY': ':0', 15:32:15 INFO - 'HOME': '/home/cltbld', 15:32:15 INFO - 'LANG': 'en_US.UTF-8', 15:32:15 INFO - 'LANGUAGE': 'en_US:en', 15:32:15 INFO - 'LOGNAME': 'cltbld', 15:32:15 INFO - 'MAIL': '/var/mail/cltbld', 15:32:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:32:15 INFO - 'MOZ_NO_REMOTE': '1', 15:32:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:32:15 INFO - 'NO_EM_RESTART': '1', 15:32:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:32:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:32:15 INFO - 'PWD': '/builds/slave/test', 15:32:15 INFO - 'SHELL': '/bin/bash', 15:32:15 INFO - 'SHLVL': '1', 15:32:15 INFO - 'TERM': 'linux', 15:32:15 INFO - 'TMOUT': '86400', 15:32:15 INFO - 'USER': 'cltbld', 15:32:15 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1476743507.323003-1525556765', 15:32:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:32:15 INFO - '_': '/tools/buildbot/bin/python'} 15:32:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:32:15 INFO - Running setup.py (path:/tmp/pip-BHucjC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:32:15 INFO - Running setup.py (path:/tmp/pip-Shp95L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:32:15 INFO - Running setup.py (path:/tmp/pip-lM7URj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:32:15 INFO - Running setup.py (path:/tmp/pip-y3XS3h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:32:15 INFO - Running setup.py (path:/tmp/pip-kAeLKk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:32:15 INFO - Running setup.py (path:/tmp/pip-zljl9t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:32:15 INFO - Running setup.py (path:/tmp/pip-eYS2r_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:32:15 INFO - Running setup.py (path:/tmp/pip-sRXyVf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:32:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:32:16 INFO - Running setup.py (path:/tmp/pip-rS7yn9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:32:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:32:16 INFO - Running setup.py (path:/tmp/pip-pZM8Ie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:32:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:32:16 INFO - Running setup.py (path:/tmp/pip-6n0xgq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:32:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:32:16 INFO - Running setup.py (path:/tmp/pip-8v_M6I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:32:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:32:16 INFO - Running setup.py (path:/tmp/pip-nwlE1q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:32:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:32:16 INFO - Running setup.py (path:/tmp/pip-0RIH9D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:32:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:32:16 INFO - Running setup.py (path:/tmp/pip-IL0GSl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:32:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:32:16 INFO - Running setup.py (path:/tmp/pip-A4LGdF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:32:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:32:16 INFO - Running setup.py (path:/tmp/pip-0mlJ1W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:32:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:32:16 INFO - Running setup.py install for manifestparser 15:32:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:32:16 INFO - Running setup.py install for mozcrash 15:32:16 INFO - Running setup.py install for mozdebug 15:32:16 INFO - Running setup.py install for mozdevice 15:32:17 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:32:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:32:17 INFO - Running setup.py install for mozfile 15:32:17 INFO - Running setup.py install for mozhttpd 15:32:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:32:17 INFO - Running setup.py install for mozinfo 15:32:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:32:17 INFO - Running setup.py install for mozInstall 15:32:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:32:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:32:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:32:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:32:17 INFO - Running setup.py install for mozleak 15:32:17 INFO - Running setup.py install for mozlog 15:32:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:32:17 INFO - Running setup.py install for moznetwork 15:32:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:32:17 INFO - Running setup.py install for mozprocess 15:32:17 INFO - Running setup.py install for mozprofile 15:32:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:32:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:32:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:32:18 INFO - Running setup.py install for mozrunner 15:32:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:32:18 INFO - Running setup.py install for mozscreenshot 15:32:18 INFO - Running setup.py install for moztest 15:32:18 INFO - Running setup.py install for mozversion 15:32:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:32:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:32:18 INFO - Cleaning up... 15:32:18 INFO - Return code: 0 15:32:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:32:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:32:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:32:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:32:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:32:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1ec222f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c6f60>, '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 0x27c7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27c81d0>, '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': 'eca2ab57546de7b41f256b19000001ef-1476743507.323003-1525556765', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:32:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:32:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:32:18 INFO - Using env: {'DISPLAY': ':0', 15:32:18 INFO - 'HOME': '/home/cltbld', 15:32:18 INFO - 'LANG': 'en_US.UTF-8', 15:32:18 INFO - 'LANGUAGE': 'en_US:en', 15:32:18 INFO - 'LOGNAME': 'cltbld', 15:32:18 INFO - 'MAIL': '/var/mail/cltbld', 15:32:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:32:18 INFO - 'MOZ_NO_REMOTE': '1', 15:32:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:32:18 INFO - 'NO_EM_RESTART': '1', 15:32:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:32:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:32:18 INFO - 'PWD': '/builds/slave/test', 15:32:18 INFO - 'SHELL': '/bin/bash', 15:32:18 INFO - 'SHLVL': '1', 15:32:18 INFO - 'TERM': 'linux', 15:32:18 INFO - 'TMOUT': '86400', 15:32:18 INFO - 'USER': 'cltbld', 15:32:18 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1476743507.323003-1525556765', 15:32:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:32:18 INFO - '_': '/tools/buildbot/bin/python'} 15:32:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:32:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:32:18 INFO - Running setup.py (path:/tmp/pip-Vok3vC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:32:18 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 15:32:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:32:18 INFO - Running setup.py (path:/tmp/pip-qh2nQX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:32:18 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)) 15:32:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:32:18 INFO - Running setup.py (path:/tmp/pip-dqDieh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:32:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:32:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:32:18 INFO - Running setup.py (path:/tmp/pip-VuL0De-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:32:19 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)) 15:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:32:19 INFO - Running setup.py (path:/tmp/pip-VYIBcg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:32:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 15:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:32:19 INFO - Running setup.py (path:/tmp/pip-Sy5osT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:32:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 15:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:32:19 INFO - Running setup.py (path:/tmp/pip-mMv_LV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:32:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 15:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:32:19 INFO - Running setup.py (path:/tmp/pip-eo6Sg6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:32:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:32:19 INFO - Running setup.py (path:/tmp/pip-o7o9HG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:32:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 15:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:32:19 INFO - Running setup.py (path:/tmp/pip-hpLHQ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:32:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:32:19 INFO - Running setup.py (path:/tmp/pip-MvLKIC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:32:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 15:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:32:19 INFO - Running setup.py (path:/tmp/pip-YhJ_7Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:32:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 15:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:32:19 INFO - Running setup.py (path:/tmp/pip-mkxyOd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:32:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 15:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:32:19 INFO - Running setup.py (path:/tmp/pip-9q45q_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:32:19 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)) 15:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:32:19 INFO - Running setup.py (path:/tmp/pip-OhhWTA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:32:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 15:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:32:19 INFO - Running setup.py (path:/tmp/pip-azb3jC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:32:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 15:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:32:19 INFO - Running setup.py (path:/tmp/pip-ZS3sCA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:32:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 15:32:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:32:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:32:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:32:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:32:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:32:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:32:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:32:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:32:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:32:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:32:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:32:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:32:21 INFO - Downloading blessings-1.6.tar.gz 15:32:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:32:21 INFO - Installing collected packages: blessings 15:32:21 INFO - Running setup.py install for blessings 15:32:22 INFO - Successfully installed blessings 15:32:22 INFO - Cleaning up... 15:32:22 INFO - Return code: 0 15:32:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:32:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:32:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:32:22 INFO - Reading from file tmpfile_stdout 15:32:22 INFO - Current package versions: 15:32:22 INFO - argparse == 1.2.1 15:32:22 INFO - blessings == 1.6 15:32:22 INFO - blobuploader == 1.2.4 15:32:22 INFO - docopt == 0.6.1 15:32:22 INFO - functools32 == 3.2.3-2 15:32:22 INFO - jsonschema == 2.5.1 15:32:22 INFO - manifestparser == 1.1 15:32:22 INFO - mozInstall == 1.12 15:32:22 INFO - mozcrash == 0.17 15:32:22 INFO - mozdebug == 0.1 15:32:22 INFO - mozdevice == 0.48 15:32:22 INFO - mozfile == 1.2 15:32:22 INFO - mozhttpd == 0.7 15:32:22 INFO - mozinfo == 0.9 15:32:22 INFO - mozleak == 0.1 15:32:22 INFO - mozlog == 3.4 15:32:22 INFO - moznetwork == 0.27 15:32:22 INFO - mozprocess == 0.23 15:32:22 INFO - mozprofile == 0.28 15:32:22 INFO - mozrunner == 6.12 15:32:22 INFO - mozscreenshot == 0.1 15:32:22 INFO - mozsystemmonitor == 0.3 15:32:22 INFO - moztest == 0.7 15:32:22 INFO - mozversion == 1.4 15:32:22 INFO - psutil == 3.1.1 15:32:22 INFO - requests == 1.2.3 15:32:22 INFO - wsgiref == 0.1.2 15:32:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:32:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:32:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:32:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:32:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:32:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1ec222f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c6f60>, '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 0x27c7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27c81d0>, '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': 'eca2ab57546de7b41f256b19000001ef-1476743507.323003-1525556765', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:32:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 15:32:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:32:22 INFO - Using env: {'DISPLAY': ':0', 15:32:22 INFO - 'HOME': '/home/cltbld', 15:32:22 INFO - 'LANG': 'en_US.UTF-8', 15:32:22 INFO - 'LANGUAGE': 'en_US:en', 15:32:22 INFO - 'LOGNAME': 'cltbld', 15:32:22 INFO - 'MAIL': '/var/mail/cltbld', 15:32:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:32:22 INFO - 'MOZ_NO_REMOTE': '1', 15:32:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:32:22 INFO - 'NO_EM_RESTART': '1', 15:32:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:32:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:32:22 INFO - 'PWD': '/builds/slave/test', 15:32:22 INFO - 'SHELL': '/bin/bash', 15:32:22 INFO - 'SHLVL': '1', 15:32:22 INFO - 'TERM': 'linux', 15:32:22 INFO - 'TMOUT': '86400', 15:32:22 INFO - 'USER': 'cltbld', 15:32:22 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1476743507.323003-1525556765', 15:32:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:32:22 INFO - '_': '/tools/buildbot/bin/python'} 15:32:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:32:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:32:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 15:32:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 15:32:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:32:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 15:32:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 15:32:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 15:32:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 15:32:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 15:32:22 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:32:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:32:22 INFO - Cleaning up... 15:32:22 INFO - Return code: 0 15:32:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:32:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:32:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:32:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:32:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:32:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1ec222f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c6f60>, '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 0x27c7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27c81d0>, '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': 'eca2ab57546de7b41f256b19000001ef-1476743507.323003-1525556765', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:32:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:32:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:32:22 INFO - Using env: {'DISPLAY': ':0', 15:32:22 INFO - 'HOME': '/home/cltbld', 15:32:22 INFO - 'LANG': 'en_US.UTF-8', 15:32:22 INFO - 'LANGUAGE': 'en_US:en', 15:32:22 INFO - 'LOGNAME': 'cltbld', 15:32:22 INFO - 'MAIL': '/var/mail/cltbld', 15:32:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:32:22 INFO - 'MOZ_NO_REMOTE': '1', 15:32:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:32:22 INFO - 'NO_EM_RESTART': '1', 15:32:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:32:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:32:22 INFO - 'PWD': '/builds/slave/test', 15:32:22 INFO - 'SHELL': '/bin/bash', 15:32:22 INFO - 'SHLVL': '1', 15:32:22 INFO - 'TERM': 'linux', 15:32:22 INFO - 'TMOUT': '86400', 15:32:22 INFO - 'USER': 'cltbld', 15:32:22 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1476743507.323003-1525556765', 15:32:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:32:22 INFO - '_': '/tools/buildbot/bin/python'} 15:32:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:32:22 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:32:22 INFO - Cleaning up... 15:32:22 INFO - Return code: 0 15:32:22 INFO - Running post-action listener: _resource_record_post_action 15:32:22 INFO - Running post-action listener: _start_resource_monitoring 15:32:22 INFO - Starting resource monitoring. 15:32:22 INFO - [mozharness: 2016-10-17 22:32:22.833191Z] Finished create-virtualenv step (success) 15:32:22 INFO - [mozharness: 2016-10-17 22:32:22.833721Z] Running install step. 15:32:22 INFO - Running pre-action listener: _resource_record_pre_action 15:32:22 INFO - Running main action method: install 15:32:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:32:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:32:23 INFO - Reading from file tmpfile_stdout 15:32:23 INFO - Detecting whether we're running mozinstall >=1.0... 15:32:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:32:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:32:23 INFO - Reading from file tmpfile_stdout 15:32:23 INFO - Output received: 15:32:23 INFO - Usage: mozinstall [options] installer 15:32:23 INFO - Options: 15:32:23 INFO - -h, --help show this help message and exit 15:32:23 INFO - -d DEST, --destination=DEST 15:32:23 INFO - Directory to install application into. [default: 15:32:23 INFO - "/builds/slave/test"] 15:32:23 INFO - --app=APP Application being installed. [default: firefox] 15:32:23 INFO - mkdir: /builds/slave/test/build/application 15:32:23 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'] 15:32:23 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 15:32:40 INFO - Reading from file tmpfile_stdout 15:32:40 INFO - Output received: 15:32:40 INFO - /builds/slave/test/build/application/firefox/firefox 15:32:40 INFO - Running post-action listener: _resource_record_post_action 15:32:40 INFO - [mozharness: 2016-10-17 22:32:40.068460Z] Finished install step (success) 15:32:40 INFO - [mozharness: 2016-10-17 22:32:40.068730Z] Running run-tests step. 15:32:40 INFO - Running pre-action listener: _resource_record_pre_action 15:32:40 INFO - Running main action method: run_tests 15:32:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:32:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:32:40 INFO - Python 2.7.3 15:32:40 INFO - Return code: 0 15:32:40 INFO - grabbing minidump binary from tooltool 15:32: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')]} 15:32:40 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 0x27c6f60>, '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 0x27c7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27c81d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:32:40 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 15:32:40 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 15:32:40 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 15:32:40 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:32:40 INFO - Return code: 0 15:32:40 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:32:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:32:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:32:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:32:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:32:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1476732604/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 15:32:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1476732604/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-010 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 15:32:40 INFO - Using env: {'DISPLAY': ':0', 15:32:40 INFO - 'HOME': '/home/cltbld', 15:32:40 INFO - 'LANG': 'en_US.UTF-8', 15:32:40 INFO - 'LANGUAGE': 'en_US:en', 15:32:40 INFO - 'LOGNAME': 'cltbld', 15:32:40 INFO - 'MAIL': '/var/mail/cltbld', 15:32:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:32:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:32:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:32:40 INFO - 'MOZ_NO_REMOTE': '1', 15:32:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:32:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:32:40 INFO - 'NO_EM_RESTART': '1', 15:32:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:32:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:32:40 INFO - 'PWD': '/builds/slave/test', 15:32:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:32:40 INFO - 'SHELL': '/bin/bash', 15:32:40 INFO - 'SHLVL': '1', 15:32:40 INFO - 'TERM': 'linux', 15:32:40 INFO - 'TMOUT': '86400', 15:32:40 INFO - 'USER': 'cltbld', 15:32:40 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1476743507.323003-1525556765', 15:32:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:32:40 INFO - '_': '/tools/buildbot/bin/python'} 15:32:40 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1476732604/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 15:32:40 INFO - mozversion application_buildid: 20161017123004 15:32:40 INFO - mozversion application_changeset: b08f6d369c80f062a34bbb22ff568c88489114c5 15:32:40 INFO - mozversion application_display_name: Nightly 15:32:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:32:40 INFO - mozversion application_name: Firefox 15:32:40 INFO - mozversion application_remotingname: firefox 15:32:40 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 15:32:40 INFO - mozversion application_vendor: Mozilla 15:32:40 INFO - mozversion application_version: 52.0a1 15:32:40 INFO - mozversion platform_buildid: 20161017123004 15:32:40 INFO - mozversion platform_changeset: b08f6d369c80f062a34bbb22ff568c88489114c5 15:32:40 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 15:32:40 INFO - mozversion platform_version: 52.0a1 15:32:40 INFO - using testdate: 1476743560 15:32:40 INFO - actual date: 1476743560 15:32:40 INFO - starting webserver on 'localhost:40307' 15:32:40 INFO - SUITE-START | Running 2 tests 15:32:40 INFO - TEST-START | dromaeo_css 15:32:40 INFO - operating with platform_type : linux_ 15:32:40 INFO - Initialising browser for dromaeo_css test... 15:32:40 INFO - TEST-INFO | started process 17195 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsPJIhg/profile http://localhost:40307/getInfo.html) 15:32:45 INFO - PROCESS | 17195 | __metrics Screen width/height:1600/1200 15:32:45 INFO - PROCESS | 17195 | colorDepth:24 15:32:45 INFO - PROCESS | 17195 | Browser inner width/height: 1024/697 15:32:45 INFO - PROCESS | 17195 | __metrics 15:32:46 ERROR - PROCESS | 17195 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3087: TypeError: this.tabs is undefined 15:32:47 INFO - TEST-INFO | 17195: exit 0 15:32:47 INFO - Browser initialized. 15:32:47 INFO - Running cycle 1/1 for dromaeo_css test... 15:32:47 INFO - TEST-INFO | started process 17318 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsPJIhg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:32:59 INFO - PROCESS | 17318 | RSS: Main: 182468608 15:32:59 INFO - PROCESS | 17318 | 15:33:49 INFO - PROCESS | 17318 | 1476743629105 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 15:36:00 INFO - PROCESS | 17318 | Cycle 1(1): loaded http://localhost:40307/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40307/tests/dromaeo/cssquery-ext.html) 15:36:01 INFO - PROCESS | 17318 | RSS: Main: 193716224 15:36:01 INFO - PROCESS | 17318 | 15:39:03 INFO - PROCESS | 17318 | Cycle 1(1): loaded http://localhost:40307/tests/dromaeo/cssquery-ext.html (next: http://localhost:40307/tests/dromaeo/cssquery-jquery.html) 15:39:04 INFO - PROCESS | 17318 | RSS: Main: 194433024 15:39:04 INFO - PROCESS | 17318 | 15:42:06 INFO - PROCESS | 17318 | Cycle 1(1): loaded http://localhost:40307/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40307/tests/dromaeo/cssquery-mootools.html) 15:42:07 INFO - PROCESS | 17318 | RSS: Main: 197021696 15:42:07 INFO - PROCESS | 17318 | 15:45:08 INFO - PROCESS | 17318 | Cycle 1(1): loaded http://localhost:40307/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40307/tests/dromaeo/cssquery-prototype.html) 15:45:09 INFO - PROCESS | 17318 | RSS: Main: 193908736 15:45:09 INFO - PROCESS | 17318 | 15:48:12 INFO - PROCESS | 17318 | Cycle 1(1): loaded http://localhost:40307/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40307/tests/dromaeo/cssquery-yui.html) 15:48:12 INFO - PROCESS | 17318 | RSS: Main: 197054464 15:48:12 INFO - PROCESS | 17318 | 15:51:15 INFO - PROCESS | 17318 | Cycle 1(1): loaded http://localhost:40307/tests/dromaeo/cssquery-yui.html (next: http://localhost:40307/tests/dromaeo/cssquery-dojo.html) 15:51:15 INFO - PROCESS | 17318 | RSS: Main: 196636672 15:51:15 INFO - PROCESS | 17318 | 15:51:15 INFO - PROCESS | 17318 | __start_tp_report 15:51:15 INFO - PROCESS | 17318 | _x_x_mozilla_page_load 15:51:15 INFO - PROCESS | 17318 | _x_x_mozilla_page_load_details 15:51:15 INFO - PROCESS | 17318 | |i|pagename|runs| 15:51:15 INFO - PROCESS | 17318 | |0;dojo.html;3016.683248258933;3042.5131978883383;3046.8324242166673;3072.2012276808036;3077.999999999999;5422.078246698061;5429.077056900326;5452.809151679687;5485.61600687952;5592.245046918665;5466.863328416782;5481.5340696040885;5500.367457742361;5555.944440555603;5580.776768929238;4970.502949705019;4996.200607902736;5045.243213517983;5085.84742457725;5108.157154069574;5021.748912554376;5088.18589025756;5133.691978481284;5136.563392111675;5191.870203244911;4902.460729319772;4929.580985616227;5020.0963826511215;5084.288199652052;5096.668716533413;5025.748712564394;5047.242913562958;5065.265536497224;5082.923756143661;5126.102931986888;4985.725785081819;4992.051510213048;4995.5753760930365;5004.824831130929;5063.493650634944;5374.7043912584795;5539.307586551641;5540.529055030327;5562.86092847678;5563.248961390242;5768.653880767168;5828.388019258002;5846.824595262149;5853.5902486825935;5860.179574859523;5870.853228669317;5914.497267732248;5922.733476993546;5928.555358348141;5929.229200203989;5469.261649677283;5479.780808767645;5538.695371754511;5539.778408863641;5671.404502527258;6024.487918526975;6056.242969628796;6106.45041946227;6113.510919126459;6120.816375508742;5848.824535263949;5851.297844258716;5862.062070068769;5865.472107510344;5867.677277749679;5706.543476521868;5773.797917072882;5820.592558520948;5853.64878107315;5854.414558544111;5629.183768353648;5696.458836410535;5790.681512516768;5826;5861.824145275648;5768.077107662753;5842.415758424208;5893.44012318829;5903.970480147657;5915.112733089984;4360.803763830635;4456.7548784817145;4463.866084017484;4473.642108631302;4533.365328853963;3911.061345277113;3940.6847452203756;3941.664958478504;3964.0684439156776;4008.7394319369146;5587.720613969285;5616.213730077792;5620.690862002547;5640.8871822563315;5650.576206784508;5871.3541510433815;5895.174675545427;5898.1152827076285;5900.291964964232;5926.585139040226;5468.097763868917;5474.91787623186;5510.283663123768;5556;5559.8888022240135;5063.265826455144;5067.442581316052;5070.264811602297;5072.4673909239;5115.181570948705;6085.878282434326;6095.963686173362;6095.969520152371;6135.662538560422;6138.631682099089;5697.829065128053;5705.372409035086;5809.331926828299;5838.854028649318;5925.229720136354;5998.550108741774;5999.220101386792;6027.547933905063;6105.694715264308;6124.693765311627;5711.257536520226;5751.7411716472025;5775.191473193672;5784.392638772868;5792.913106303493;5782.335031471266;5843.474087332161;5865.149553314831;5867.061270196748;5881.411858814085;5770.826875193751;5803.071508558611;5858;5918.822435326947;5930.347661757117;5771.336296325809;5806.274215723035;5821.70891455417;5838.2702162229725;5846.590738648254;5607.5513958882375;5621.128725047624;5651.4348565143155;5671.206031155559;5754.625949313281;5824.912626310694;5825.388334225015;5832.708364581669;5870.295564532284;5891.263592050994;5715.5713321500225;5722.7710891563875;5726.79956201531;5733.340665823317;5735.426457354231 15:51:15 INFO - PROCESS | 17318 | |1;ext.html;569.9943000569995;574.7844558290643;585.2567239605701;589.8525368657836;597.2295738497338;41027.38458923115;42687.78656106715;42706;46666;46702.76648616761;43570.910727231756;43808.342874856906;44028.55971440284;44071;44122.7793861031;8656.264217541517;8804.163604457566;8807.911920880806;8811.206991370775;8824.205821476065;8598.699045533407;8620;8688.131186881325;8710;8739;8729.694460693878;8791.912080879174;8795.340349473816;8806.911930880706;8823.250023747989;8735.388522803407;8756.956215218946;8767.473951562926;8769.298456123559;8783.253423459013;8386.119457457002;8389.286910612605;8476.110008449086;8515.914840851636;8520.573971301472;40950.38574421386;41339.586604133874;41389.79305103485;41448.1710365794;41448.79275603633;3058.7552995760284;3207.8556464959133;3347.2301370684636;3382.1713680148523;3726;30825.84587077073;30931.381372372653;31224.37551248985;31400.685993140232;31754.364912701847;4075.551689314173;4142.482189726285;4202.768847713374;4207.158568286355;4274.829006839723;306922;311258;311798;312170;312181;57175;57351.42648573544;57466.7126664364;57472;57547.712261439265;60875.69562152161;60966.69516652388;61024.389756102755;61135;61262.38737612567;15369.231538423033;15731.606709832346;15750.369985200692;15817.367305307658;15836.52490425289;11820.172587918934;11881.049516038696;11957.701057473632;11975.940120299343;11998.40007999614;15306.693866122616;16933.83066169347;16945.661086778196;17061.658766824596;17082.48752537401;3058.204866734665;5504.944950550524;5718.170865224519;5822.854428639233;5980.252468441445;803.5459965119688;950.4487397309682;1077.7790552936785;1112.7162573543694;1136.9602063927723;29378.412431751247;30924.907509249344;30969.535456968162;31244.531332030037;31663;1078.078243102152;1081.1134869407167;1088.2871719024051;1121.685927940178;1134.9659510214706;15655.452059178102;16379.508614741577;16411.753823692656;16416.671666566603;16639.916800415922;495659;496670;498987;503960;504900;56027;56330.71834640801;56503.434965649816;57092.429075709544;57140.714296428254;1292.825468561751;1343.764841152814;1348.7100273441258;1351.905366624327;1363.3796622536524;29614.407711846074;30508.237294067825;30982.69017309798;31336;31519.84240078785;49897.50102498929;49902.750486247336;50436.24345634745;50489;50618.49381506285;419562;423309;424078;424560;425008;26356.73643263543;27229.72770272351;27334.453310934066;27339;27488;42368.15263694647;45602.315965259884;47232.2915156266;47236.7638161807;47316;37835.81082094682;38854;39729.80135099306;40172.799136005306;40846.387304191056;38749.22501549897;38825.41761873518;39379.6062039376;39798.801005994785;39893.800530997156;39135.41296880606;39147;39202.41196381999;39309.80345098256;39317.41023884701;31708;35272.294554109285;35435.468467973515;35653.28693426169;35951.64048359483;26367;26874;26924.596131057657;27081.1875643731;27285 15:51:15 INFO - PROCESS | 17318 | |2;jquery.html;377.85263747138623;379.30397720183464;388.6832231731138;389.03761338905684;415.5242247626468;17659.20533575989;18749.718754218662;19282.61434771304;19299.421017369503;19430.222791088374;18021.09894505276;18219.453416397497;18429.723554146665;18481.353152639662;18514.166862491187;5411.323584551921;5524.751386187631;5683.403242659523;5692.943070569303;5826.883462330751;5856.9414305857035;5891.381404952483;5904.202932604107;5905.911411328812;5910;5889.2049573307695;5900.793472228473;5983.10253461982;6243.843903902416;6292.307846136921;5929.258842644669;6332;6387;6389.329120442357;6396.2324521057535;5584.636998595079;5624.268845050158;5632;5633.8591535211535;5638.097904335327;13470.25913574753;13633.522826701017;13805.033647644668;13808.723825523433;13866.653333666638;2136.5513242219154;2216.8448208625405;2322.6980492535863;2509.874506274697;2752.2156185487243;10099.091081802673;10220.74448138795;12229.755404891941;12617.306048167347;13617.182969021791;1798.3346161920174;1857.572758265593;1895.6682580548486;1897.4212865076147;1952.4337941996803;66243.66878165626;71846.64076679635;76485;77698.22301776966;79572;10296.691099267035;10630.149588032938;10688.732781680364;10798.784024319626;11059.22585419013;15082.17048062367;15083.54749357521;15104.622384440258;15126.924365378103;15139.318730657147;7696.499727517694;7807.843843123106;7999.400044996649;8195.754127376189;8236.752897413087;7577.659005344773;7650.38796896247;7811.882821757678;7813.335866451302;7840.568768717661;4511.932321015187;4520.141173177151;4597.95402045982;4627.884302892455;4693.342931989524;1924.9903750481158;1941.9029048547516;1953.3456292142291;1958.3831093205595;1992.4421162074643;851.3359579527978;909.9590518426687;923.7182659288846;926.7868390270276;934.9859752103724;17841.821581784017;19423.708644370345;19479.12343944526;19603.411897643095;19725.309614163434;934.1825902335456;935.8409070458039;958.2956526952685;971.0726256425238;1012.5190534496055;10230.744231394274;10812.443669713886;10876.891231087588;10941;10991.120710343153;416881;422551;424673;424950;427778;84907;85374;85670;85766.14233857706;86028.56985715032;998.6854140945579;1010.7675234696061;1014.3102690170755;1015.0762805846645;1021.9131373833159;16402.343906243615;16408.832605938205;16940.40708575194;16961;17073;40877.182456350114;41068;41142.382864257655;41341.58658413377;42234.57765422307;54111;54525.45474545362;54916.72541637266;56650.43349566452;57732.71133644305;8105.230003149692;8287.751367458986;8360.414770965974;8467.830643386975;8612.65549378018;9176.770580735534;12028.699282517657;13090.541831035867;13102.344882756015;13123.212607243597;10590.947045264724;11120.662941453002;11305.604303849655;11827.704307392383;11843.526258949545;10979.231453798158;11168.050715689258;11409.600663977053;11771.411429428323;11856.585019524275;11338.886611133783;11410.54357825711;11464.197506174487;11653.184277100521;11709.941450292694;8166.387520935835;8270.172982701682;8321.708740194064;8387.580620968805;8627.35294852876;11114.777704445703;11140.16448766362;11335.319880807177;11408.714782130513;11860.466279017292 15:51:15 INFO - PROCESS | 17318 | |3;mootools.html;1475.2549962269052;1502.4215676964368;1636.190085907476;1723.9741403878936;1778.8043315235313;8588.785280367994;8831.249343805785;9196.862047069282;9290.024547422525;9326.300527460442;8851.95574022129;9049.864252036208;9052.502112383816;9087.818243635124;9111.36220464566;2149.3337065509704;2174.771648976858;2176.455886028485;2181.887237508866;2182.6180418426793;2253.526759380532;2271.1823743452346;2338.7895089441945;2339.4034521197073;2348.0490401387465;2295.678604995302;2299.9655005174936;2310.699609050821;2315.8610483371053;2345.5660702769956;2286.0969916882736;2291.8395712300144;2293.4610366563843;2303.2744685424204;2305.9769402306015;2181.5091604389045;2182.71624688791;2183.1049269799464;2186.4424571734266;2187.431267870349;9092.454452732858;9119.680811171644;9194;9210.078992100804;9225.492597907112;5131.435542090367;5314.176302673091;5316.760745766411;5335.599830012765;5364.436734142937;3352.5474061001696;3355.5134505496812;3549.6627820357025;3565.714742820568;3572.4284114541547;1044.6343779677052;1103.47584897174;1107.6787731557838;1116.8938950799661;1143.5597295041387;12527.56153534631;12606.369681515887;12649.557265495663;12707.93646031764;12710.300933448656;4271.273883439822;4413.095315460387;4479.193745125844;4529.977350113229;4535.455745310518;9762.414255144715;9818.65634702782;9839.80320393588;9851.950740246253;9868.30921835479;5228.529432351107;5233.921491177635;5237.869053273698;5243.921341179809;5248.921266181011;4148.688848336386;4267.914641707149;4859.1010663027455;4860.975695121572;4899.877503062452;3697.149655579232;3710.7364507650313;3722.9627703722617;3811.923761524754;3845.134844659985;1149.350616901448;1165.8834116588444;1178.3460179600404;1182.456070207697;1184.3782014442315;801.7835184500152;946.6024269806697;955.0592666223764;963.3689933093694;973.6592192732487;5997.910031349533;6003.159557661931;6056.909756243918;6105.084237364342;6136.570440069152;447.25755246291;450.1042924580062;453.709625839463;465.4972629560067;926.6015613286216;4038.273110840018;4110.280700877394;4119.8970025748995;4154.543000269968;4157;11203.60787372438;11528.423578821026;11548.133889958286;11556.248843825124;11585.942070289595;11381.772364552828;11385;11408.714782130513;11410.087193024538;11432.199746017699;7867.881981770278;8110.5539195343645;8155.83688326242;8230.09468958414;8262.752117436487;5728.570357223308;6031.788887388921;6069.4840938518955;6256;6372.872542549216;10016.248781341574;10361.378317300987;10387.117095046704;10610.787784244427;10624.309419887682;10061.195104391778;10311.845322320021;10339.276250662682;10557.260991730505;10603.628872989408;7461.291177338144;7733.381329493514;8226.62980165882;8532;8710;8617.612207450806;8831.381803273965;8836.116388361112;8908;8910.108989101298;7428.405727541892;7517.887231691419;7671.53970761756;7755.495892766952;7936.56348900816;7517.1731109579;7604.885926711215;7685.077790665156;7793.454458188099;7938.6030698466;6907.481938854506;7046.365827075588;7060.576365418091;7065.823354415975;7072.964635176997;5051.545360917388;5289.523942845162;5291.100512912737;5427.375851777097;5593.580481463825;5042.84871453857;5055.87360315995;5074.5940324774665;5095.515925987025;5303.708296043755 15:51:15 INFO - PROCESS | 17318 | |4;prototype.html;320.25221108711156;320.5875784719982;330.88749825059483;333.4531368555569;334.9313390754896;5288.338957630287;5512.944870551293;5514.944850551493;5539.224508568798;5563.527100196483;5260.763265653045;5363.302770639821;5367.577591938129;5374.677519348832;5400.351957765064;4212.094399704063;4215.367694845782;4235.322348424253;4240.745555266679;4246.363045543162;4152.110789590744;4204.810783514749;4236.915261694764;4241.575842415765;4259.70182087254;4170.749755014709;4173.1862286854075;4178;4178.582141785828;4182.79086045698;4140.399642051885;4174.812133453972;4178.582141785828;4186.811593478301;4193.559676233997;3703.7962912039825;3703.8333275002688;3709.536307961505;3721.8697345593046;3730.421784623388;5064.3163172971545;5286;5318.149096144598;5323.760430780624;5351.973240133813;4787.904241915177;4788.036904868987;4792.760361981887;4810.422749270075;4814.542618451276;5375.408705042442;5706.715988902505;5715.199872017921;5722.736561261845;5742.28221472316;4026.7583944963394;4045.7053742802314;4051.230266249403;4054.3715724062818;4084.244414783245;5852.444017818343;5881.206037184968;5955.196048533436;5974.3428222895445;6035.215421995156;4043.2317859606583;4186.937195942063;4189.6438802701505;4193.161367726406;4197.706160568792;4177.268977928911;4177.749335039907;4181.937270940938;4186.811593478301;4218.894527636834;4773.856784296477;4777.570018698334;4779.808807647724;4793.5685788279225;4800.207965685692;5574.104804366535;5680;5703.771849126071;5707.600467967285;5719.142128680648;1380.3029470117726;1387.7502049630962;1393.7073214625043;1402.389960367223;1402.4109873853006;888.5823662878437;894.9105089491129;907.419251678926;917.6512925088424;921.2123634292717;4835.661503694778;4847.636427267969;4869.831240502254;4880.536349046906;4937.728424936591;5080.722933707738;5119.385673719177;5158.3552055993005;5167.379914410295;5189.506996835295;4737.857864264078;4904.43598986114;4930.10191076431;4965.82619608312;4975.303457515878;2729.280553251439;2733.384988377639;2749.958750618742;2755.3938133610573;2756.9385786472353;5218.843434696965;5243.868903277448;5249.448807875195;5279.815206467755;5281.683099014072;4905.558499735041;5194.831162988297;5236.764345604457;5246.403030499927;5266.262723218752;5241.240020196974;5266.7366631668265;5270.367555893241;5279.551238144724;5286.841394758163;5090.847274581768;5130.846074617767;5141.434442211428;5173.430922598586;5178.275041494118;4703.670743047954;5013.8830626635445;5018.297438358706;5068.442471328225;5118.334616499831;5202.24567437727;5222.582193424593;5235.240890070994;5273.284258606897;5286.392064912584;3726.31063253299;3726.9813650931574;3864.942025869558;3879.4374815652136;3972.7219094663096;5806.129080637938;5829.8251052468495;5834.620749651259;5850.853728656818;5863.355030946507;5685.71571421419;5740.3685594585395;5745;5754.014864871612;5768.2501274834;5452.672839629635;5608.7195640217005;5672.631278966854;5677.78566359112;5678.643363004307;5620.775168993358;5676.148577713376;5682.289713785777;5688.431156884279;5712.885742285048;5483.588730845123;5698.430156984268;5787.594868359174;5792.739326730391;5814.859975613122;5590.456342364296;5619.241402410622;5623.915641265467;5635.211070450222;5642.294713160855 15:51:15 INFO - PROCESS | 17318 | |5;yui.html;709.7019251914196;712.2912701861649;712.8324843661742;759.3796254585238;805.2752522729543;14680.339384727686;15647.765283520755;15778.76331855023;15928.522144335659;15938.601534961617;14477.131372117681;14610.269486525658;14642.853571464282;14676.339564719587;14720.705585888303;620.5904103291829;661.0513912535503;773.4547144263295;793.1354823242665;797.2067792546425;769.6575024114271;793.9325157361632;803.0604193094094;803.7950322667712;803.8713805791075;848.1476116502906;851.6125163050797;851.8679604661256;852.8592782190931;853.0105078109364;843.3337663246028;848.393398719912;849.235687880906;849.8215374771305;850.0988951711175;619.5601123202532;619.6406084470996;620.4044117647019;621.2358798677607;623.1245100633618;14368.928155359261;14413.71172576553;14419.639509012253;14545.854541454555;14578.562643120724;14821.555353339418;14847.777283340758;15078.472253471076;15098.698026039418;15108.848911510964;11349.20555561111;11356.091512678966;11462.254953428;11560.595379161688;12234.632961011184;3730.9440358394645;3738.4953031340965;3818;3847.1920896611746;3966.107625784204;75004.62497687477;75007.62496187484;75221;75570;76456.23543764548;10238.53926573306;10393.53229104692;10509.894901051044;10603.94698026505;10651.89348106509;22690.319290421314;22691.319260421882;22744.772552274597;22859.885700571722;23050.193243236405;7872;7983.760487185394;8167.142450042778;8287.337013038943;8407.2433480987;4448.510663826976;4456.643468522575;4556.954430455653;4557.726536407826;4592.7014744041535;3193.824339661341;3320.1865542942132;3346.9497957530657;3358.7313014958745;3359.2105855124514;576.5790972589949;596.2517041113462;611.4252602553674;613.9938600614026;618.6350053468475;564.5709260961617;627.0030651264511;640.2924768131242;666.7133132752963;698.3121625199175;8075.394345424117;8177.037510997437;8409.20112589303;8511.524369989544;8653.394262401698;628.205320269859;656.9967150164218;674.1135406939858;707.8159678483528;718.5652680128447;4104.8768536943935;4109.363048727452;4299.161663475592;4368.191884501377;4387.8244870204835;92078.53960730287;108785;117258;119550.4022479882;122208;89115.55442222748;89435.55282223548;92209;92431;93058;50417.74791126021;55002.724986374815;65438;73832.26167738362;81373.20088587122;8307.750767476986;9625.055446738768;9881.555330010024;10036.698899033041;10053.597856085968;47714.5228547724;48511.27233091577;48637;49160.508394915596;49261.50738492713;62712.37287627065;65942.67028664827;70100.29899701141;71214;71325;12549.874501255235;12857.871421285667;12868.549600763929;12877.742445151232;13159.342032898125;12497.710271351323;12632.431540580512;12803.03977201695;13169.868301317247;13565.914726821633;13087.738245234852;13154.671133221364;13228.338583071001;13521.526746564217;13633.454661813417;13169.670758231121;13532.59402217935;14093;14307.64230894236;14529.200893950512;10938.45307734626;11245.437728113398;11343.943280283545;11604.419779011185;11987.64037078889;10168.440735759605;10288.897111029093;10498.370097794157;10672.199585031309;10765.515551800345;9906.405615663083;10205.183585313305;10992.395418251754;11022.559097636005;11055.170862185207 15:51:15 INFO - PROCESS | 17318 | __end_tp_report 15:51:15 INFO - PROCESS | 17318 | __start_cc_report 15:51:15 INFO - PROCESS | 17318 | _x_x_mozilla_cycle_collect,311 15:51:15 INFO - PROCESS | 17318 | __end_cc_report 15:51:15 INFO - PROCESS | 17318 | __startTimestamp1476744675862__endTimestamp 15:51:15 INFO - PROCESS | 17318 | 15:51:15 INFO - PROCESS | 17318 | ------- Summary: start ------- 15:51:15 INFO - PROCESS | 17318 | Number of tests: 6 15:51:15 INFO - PROCESS | 17318 | 15:51:15 INFO - PROCESS | 17318 | [#0] dojo.html Cycles:165 Average:5468.42 Median:5705.37 stddev:637.38 (11.2%) stddev-sans-first:609.63 15:51:15 INFO - PROCESS | 17318 | Values: 3016.7 3042.5 3046.8 3072.2 3078.0 5422.1 5429.1 5452.8 5485.6 5592.2 5466.9 5481.5 5500.4 5555.9 5580.8 4970.5 4996.2 5045.2 5085.8 5108.2 5021.7 5088.2 5133.7 5136.6 5191.9 4902.5 4929.6 5020.1 5084.3 5096.7 5025.7 5047.2 5065.3 5082.9 5126.1 4985.7 4992.1 4995.6 5004.8 5063.5 5374.7 5539.3 5540.5 5562.9 5563.2 5768.7 5828.4 5846.8 5853.6 5860.2 5870.9 5914.5 5922.7 5928.6 5929.2 5469.3 5479.8 5538.7 5539.8 5671.4 6024.5 6056.2 6106.5 6113.5 6120.8 5848.8 5851.3 5862.1 5865.5 5867.7 5706.5 5773.8 5820.6 5853.6 5854.4 5629.2 5696.5 5790.7 5826.0 5861.8 5768.1 5842.4 5893.4 5904.0 5915.1 4360.8 4456.8 4463.9 4473.6 4533.4 3911.1 3940.7 3941.7 3964.1 4008.7 5587.7 5616.2 5620.7 5640.9 5650.6 5871.4 5895.2 5898.1 5900.3 5926.6 5468.1 5474.9 5510.3 5556.0 5559.9 5063.3 5067.4 5070.3 5072.5 5115.2 6085.9 6096.0 6096.0 6135.7 6138.6 5697.8 5705.4 5809.3 5838.9 5925.2 5998.6 5999.2 6027.5 6105.7 6124.7 5711.3 5751.7 5775.2 5784.4 5792.9 5782.3 5843.5 5865.1 5867.1 5881.4 5770.8 5803.1 5858.0 5918.8 5930.3 5771.3 5806.3 5821.7 5838.3 5846.6 5607.6 5621.1 5651.4 5671.2 5754.6 5824.9 5825.4 5832.7 5870.3 5891.3 5715.6 5722.8 5726.8 5733.3 5735.4 15:51:15 INFO - PROCESS | 17318 | 15:51:15 INFO - PROCESS | 17318 | [#1] ext.html Cycles:180 Average:57091.27 Median:40988.89 stddev:110932.35 (270.6%) stddev-sans-first:111162.37 15:51:15 INFO - PROCESS | 17318 | Values: 570.0 574.8 585.3 589.9 597.2 41027.4 42687.8 42706.0 46666.0 46702.8 43570.9 43808.3 44028.6 44071.0 44122.8 8656.3 8804.2 8807.9 8811.2 8824.2 8598.7 8620.0 8688.1 8710.0 8739.0 8729.7 8791.9 8795.3 8806.9 8823.3 8735.4 8757.0 8767.5 8769.3 8783.3 8386.1 8389.3 8476.1 8515.9 8520.6 40950.4 41339.6 41389.8 41448.2 41448.8 3058.8 3207.9 3347.2 3382.2 3726.0 30825.8 30931.4 31224.4 31400.7 31754.4 4075.6 4142.5 4202.8 4207.2 4274.8 306922.0 311258.0 311798.0 312170.0 312181.0 57175.0 57351.4 57466.7 57472.0 57547.7 60875.7 60966.7 61024.4 61135.0 61262.4 15369.2 15731.6 15750.4 15817.4 15836.5 11820.2 11881.0 11957.7 11975.9 11998.4 15306.7 16933.8 16945.7 17061.7 17082.5 3058.2 5504.9 5718.2 5822.9 5980.3 803.5 950.4 1077.8 1112.7 1137.0 29378.4 30924.9 30969.5 31244.5 31663.0 1078.1 1081.1 1088.3 1121.7 1135.0 15655.5 16379.5 16411.8 16416.7 16639.9 495659.0 496670.0 498987.0 503960.0 504900.0 56027.0 56330.7 56503.4 57092.4 57140.7 1292.8 1343.8 1348.7 1351.9 1363.4 29614.4 30508.2 30982.7 31336.0 31519.8 49897.5 49902.8 50436.2 50489.0 50618.5 419562.0 423309.0 424078.0 424560.0 425008.0 26356.7 27229.7 27334.5 27339.0 27488.0 42368.2 45602.3 47232.3 47236.8 47316.0 37835.8 38854.0 39729.8 40172.8 40846.4 38749.2 38825.4 39379.6 39798.8 39893.8 39135.4 39147.0 39202.4 39309.8 39317.4 31708.0 35272.3 35435.5 35653.3 35951.6 26367.0 26874.0 26924.6 27081.2 27285.0 15:51:15 INFO - PROCESS | 17318 | 15:51:15 INFO - PROCESS | 17318 | [#2] jquery.html Cycles:180 Average:26367.58 Median:383.99 stddev:69950.71 (18216.6%) stddev-sans-first:70119.72 15:51:15 INFO - PROCESS | 17318 | Values: 377.9 379.3 388.7 389.0 415.5 17659.2 18749.7 19282.6 19299.4 19430.2 18021.1 18219.5 18429.7 18481.4 18514.2 5411.3 5524.8 5683.4 5692.9 5826.9 5856.9 5891.4 5904.2 5905.9 5910.0 5889.2 5900.8 5983.1 6243.8 6292.3 5929.3 6332.0 6387.0 6389.3 6396.2 5584.6 5624.3 5632.0 5633.9 5638.1 13470.3 13633.5 13805.0 13808.7 13866.7 2136.6 2216.8 2322.7 2509.9 2752.2 10099.1 10220.7 12229.8 12617.3 13617.2 1798.3 1857.6 1895.7 1897.4 1952.4 66243.7 71846.6 76485.0 77698.2 79572.0 10296.7 10630.1 10688.7 10798.8 11059.2 15082.2 15083.5 15104.6 15126.9 15139.3 7696.5 7807.8 7999.4 8195.8 8236.8 7577.7 7650.4 7811.9 7813.3 7840.6 4511.9 4520.1 4598.0 4627.9 4693.3 1925.0 1941.9 1953.3 1958.4 1992.4 851.3 910.0 923.7 926.8 935.0 17841.8 19423.7 19479.1 19603.4 19725.3 934.2 935.8 958.3 971.1 1012.5 10230.7 10812.4 10876.9 10941.0 10991.1 416881.0 422551.0 424673.0 424950.0 427778.0 84907.0 85374.0 85670.0 85766.1 86028.6 998.7 1010.8 1014.3 1015.1 1021.9 16402.3 16408.8 16940.4 16961.0 17073.0 40877.2 41068.0 41142.4 41341.6 42234.6 54111.0 54525.5 54916.7 56650.4 57732.7 8105.2 8287.8 8360.4 8467.8 8612.7 9176.8 12028.7 13090.5 13102.3 13123.2 10590.9 11120.7 11305.6 11827.7 11843.5 10979.2 11168.1 11409.6 11771.4 11856.6 11338.9 11410.5 11464.2 11653.2 11709.9 8166.4 8270.2 8321.7 8387.6 8627.4 11114.8 11140.2 11335.3 11408.7 11860.5 15:51:15 INFO - PROCESS | 17318 | 15:51:15 INFO - PROCESS | 17318 | [#3] mootools.html Cycles:180 Average:5862.29 Median:2662.30 stddev:3435.53 (129.0%) stddev-sans-first:3429.35 15:51:15 INFO - PROCESS | 17318 | Values: 1475.3 1502.4 1636.2 1724.0 1778.8 8588.8 8831.2 9196.9 9290.0 9326.3 8852.0 9049.9 9052.5 9087.8 9111.4 2149.3 2174.8 2176.5 2181.9 2182.6 2253.5 2271.2 2338.8 2339.4 2348.0 2295.7 2300.0 2310.7 2315.9 2345.6 2286.1 2291.8 2293.5 2303.3 2306.0 2181.5 2182.7 2183.1 2186.4 2187.4 9092.5 9119.7 9194.0 9210.1 9225.5 5131.4 5314.2 5316.8 5335.6 5364.4 3352.5 3355.5 3549.7 3565.7 3572.4 1044.6 1103.5 1107.7 1116.9 1143.6 12527.6 12606.4 12649.6 12707.9 12710.3 4271.3 4413.1 4479.2 4530.0 4535.5 9762.4 9818.7 9839.8 9852.0 9868.3 5228.5 5233.9 5237.9 5243.9 5248.9 4148.7 4267.9 4859.1 4861.0 4899.9 3697.1 3710.7 3723.0 3811.9 3845.1 1149.4 1165.9 1178.3 1182.5 1184.4 801.8 946.6 955.1 963.4 973.7 5997.9 6003.2 6056.9 6105.1 6136.6 447.3 450.1 453.7 465.5 926.6 4038.3 4110.3 4119.9 4154.5 4157.0 11203.6 11528.4 11548.1 11556.2 11585.9 11381.8 11385.0 11408.7 11410.1 11432.2 7867.9 8110.6 8155.8 8230.1 8262.8 5728.6 6031.8 6069.5 6256.0 6372.9 10016.2 10361.4 10387.1 10610.8 10624.3 10061.2 10311.8 10339.3 10557.3 10603.6 7461.3 7733.4 8226.6 8532.0 8710.0 8617.6 8831.4 8836.1 8908.0 8910.1 7428.4 7517.9 7671.5 7755.5 7936.6 7517.2 7604.9 7685.1 7793.5 7938.6 6907.5 7046.4 7060.6 7065.8 7073.0 5051.5 5289.5 5291.1 5427.4 5593.6 5042.8 5055.9 5074.6 5095.5 5303.7 15:51:15 INFO - PROCESS | 17318 | 15:51:15 INFO - PROCESS | 17318 | [#4] prototype.html Cycles:180 Average:4590.98 Median:5136.14 stddev:1339.10 (26.1%) stddev-sans-first:1303.93 15:51:15 INFO - PROCESS | 17318 | Values: 320.3 320.6 330.9 333.5 334.9 5288.3 5512.9 5514.9 5539.2 5563.5 5260.8 5363.3 5367.6 5374.7 5400.4 4212.1 4215.4 4235.3 4240.7 4246.4 4152.1 4204.8 4236.9 4241.6 4259.7 4170.7 4173.2 4178.0 4178.6 4182.8 4140.4 4174.8 4178.6 4186.8 4193.6 3703.8 3703.8 3709.5 3721.9 3730.4 5064.3 5286.0 5318.1 5323.8 5352.0 4787.9 4788.0 4792.8 4810.4 4814.5 5375.4 5706.7 5715.2 5722.7 5742.3 4026.8 4045.7 4051.2 4054.4 4084.2 5852.4 5881.2 5955.2 5974.3 6035.2 4043.2 4186.9 4189.6 4193.2 4197.7 4177.3 4177.7 4181.9 4186.8 4218.9 4773.9 4777.6 4779.8 4793.6 4800.2 5574.1 5680.0 5703.8 5707.6 5719.1 1380.3 1387.8 1393.7 1402.4 1402.4 888.6 894.9 907.4 917.7 921.2 4835.7 4847.6 4869.8 4880.5 4937.7 5080.7 5119.4 5158.4 5167.4 5189.5 4737.9 4904.4 4930.1 4965.8 4975.3 2729.3 2733.4 2750.0 2755.4 2756.9 5218.8 5243.9 5249.4 5279.8 5281.7 4905.6 5194.8 5236.8 5246.4 5266.3 5241.2 5266.7 5270.4 5279.6 5286.8 5090.8 5130.8 5141.4 5173.4 5178.3 4703.7 5013.9 5018.3 5068.4 5118.3 5202.2 5222.6 5235.2 5273.3 5286.4 3726.3 3727.0 3864.9 3879.4 3972.7 5806.1 5829.8 5834.6 5850.9 5863.4 5685.7 5740.4 5745.0 5754.0 5768.3 5452.7 5608.7 5672.6 5677.8 5678.6 5620.8 5676.1 5682.3 5688.4 5712.9 5483.6 5698.4 5787.6 5792.7 5814.9 5590.5 5619.2 5623.9 5635.2 5642.3 15:51:15 INFO - PROCESS | 17318 | 15:51:15 INFO - PROCESS | 17318 | [#5] yui.html Cycles:180 Average:19429.33 Median:4452.58 stddev:27728.44 (622.8%) stddev-sans-first:27770.60 15:51:15 INFO - PROCESS | 17318 | Values: 709.7 712.3 712.8 759.4 805.3 14680.3 15647.8 15778.8 15928.5 15938.6 14477.1 14610.3 14642.9 14676.3 14720.7 620.6 661.1 773.5 793.1 797.2 769.7 793.9 803.1 803.8 803.9 848.1 851.6 851.9 852.9 853.0 843.3 848.4 849.2 849.8 850.1 619.6 619.6 620.4 621.2 623.1 14368.9 14413.7 14419.6 14545.9 14578.6 14821.6 14847.8 15078.5 15098.7 15108.8 11349.2 11356.1 11462.3 11560.6 12234.6 3730.9 3738.5 3818.0 3847.2 3966.1 75004.6 75007.6 75221.0 75570.0 76456.2 10238.5 10393.5 10509.9 10603.9 10651.9 22690.3 22691.3 22744.8 22859.9 23050.2 7872.0 7983.8 8167.1 8287.3 8407.2 4448.5 4456.6 4557.0 4557.7 4592.7 3193.8 3320.2 3346.9 3358.7 3359.2 576.6 596.3 611.4 614.0 618.6 564.6 627.0 640.3 666.7 698.3 8075.4 8177.0 8409.2 8511.5 8653.4 628.2 657.0 674.1 707.8 718.6 4104.9 4109.4 4299.2 4368.2 4387.8 92078.5 108785.0 117258.0 119550.4 122208.0 89115.6 89435.6 92209.0 92431.0 93058.0 50417.7 55002.7 65438.0 73832.3 81373.2 8307.8 9625.1 9881.6 10036.7 10053.6 47714.5 48511.3 48637.0 49160.5 49261.5 62712.4 65942.7 70100.3 71214.0 71325.0 12549.9 12857.9 12868.5 12877.7 13159.3 12497.7 12632.4 12803.0 13169.9 13565.9 13087.7 13154.7 13228.3 13521.5 13633.5 13169.7 13532.6 14093.0 14307.6 14529.2 10938.5 11245.4 11343.9 11604.4 11987.6 10168.4 10288.9 10498.4 10672.2 10765.5 9906.4 10205.2 10992.4 11022.6 11055.2 15:51:15 INFO - PROCESS | 17318 | -------- Summary: end -------- 15:51:15 INFO - PROCESS | 17318 | 15:51:16 INFO - TEST-INFO | 17318: exit 0 15:51:16 INFO - TEST-OK | dromaeo_css | took 1116587ms 15:51:16 INFO - TEST-START | kraken 15:51:16 INFO - operating with platform_type : linux_ 15:51:16 INFO - Initialising browser for kraken test... 15:51:16 INFO - TEST-INFO | started process 17679 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQO3izA/profile http://localhost:40307/getInfo.html) 15:51:21 INFO - PROCESS | 17679 | __metrics Screen width/height:1600/1200 15:51:21 INFO - PROCESS | 17679 | colorDepth:24 15:51:21 INFO - PROCESS | 17679 | Browser inner width/height: 1024/697 15:51:21 INFO - PROCESS | 17679 | __metrics 15:51:22 ERROR - PROCESS | 17679 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3087: TypeError: this.tabs is undefined 15:51:23 INFO - TEST-INFO | 17679: exit 0 15:51:23 INFO - Browser initialized. 15:51:23 INFO - Running cycle 1/1 for kraken test... 15:51:23 INFO - TEST-INFO | started process 17802 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQO3izA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:51:35 INFO - PROCESS | 17802 | RSS: Main: 182124544 15:51:35 INFO - PROCESS | 17802 | 15:51:38 INFO - PROCESS | 17802 | Cycle 1(1): loaded http://localhost:40307/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40307/tests/kraken/driver.html?testName=audio-beat-detection) 15:51:39 INFO - PROCESS | 17802 | RSS: Main: 196218880 15:51:39 INFO - PROCESS | 17802 | 15:51:41 INFO - PROCESS | 17802 | Cycle 1(1): loaded http://localhost:40307/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40307/tests/kraken/driver.html?testName=audio-dft) 15:51:42 INFO - PROCESS | 17802 | RSS: Main: 194015232 15:51:42 INFO - PROCESS | 17802 | 15:51:45 INFO - PROCESS | 17802 | Cycle 1(1): loaded http://localhost:40307/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40307/tests/kraken/driver.html?testName=audio-fft) 15:51:46 INFO - PROCESS | 17802 | RSS: Main: 190447616 15:51:46 INFO - PROCESS | 17802 | 15:51:48 INFO - PROCESS | 17802 | Cycle 1(1): loaded http://localhost:40307/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40307/tests/kraken/driver.html?testName=audio-oscillator) 15:51:48 INFO - PROCESS | 17802 | RSS: Main: 191102976 15:51:48 INFO - PROCESS | 17802 | 15:51:50 INFO - PROCESS | 17802 | Cycle 1(1): loaded http://localhost:40307/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40307/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:51:51 INFO - PROCESS | 17802 | RSS: Main: 191123456 15:51:51 INFO - PROCESS | 17802 | 15:51:54 INFO - PROCESS | 17802 | Cycle 1(1): loaded http://localhost:40307/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40307/tests/kraken/driver.html?testName=imaging-darkroom) 15:51:55 INFO - PROCESS | 17802 | RSS: Main: 191549440 15:51:55 INFO - PROCESS | 17802 | 15:51:58 INFO - PROCESS | 17802 | Cycle 1(1): loaded http://localhost:40307/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40307/tests/kraken/driver.html?testName=imaging-desaturate) 15:51:59 INFO - PROCESS | 17802 | RSS: Main: 191983616 15:51:59 INFO - PROCESS | 17802 | 15:52:02 INFO - PROCESS | 17802 | Cycle 1(1): loaded http://localhost:40307/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40307/tests/kraken/driver.html?testName=json-parse-financial) 15:52:02 INFO - PROCESS | 17802 | RSS: Main: 192237568 15:52:02 INFO - PROCESS | 17802 | 15:52:04 INFO - PROCESS | 17802 | Cycle 1(1): loaded http://localhost:40307/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40307/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:52:04 INFO - PROCESS | 17802 | RSS: Main: 191619072 15:52:04 INFO - PROCESS | 17802 | 15:52:06 INFO - PROCESS | 17802 | Cycle 1(1): loaded http://localhost:40307/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40307/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:52:07 INFO - PROCESS | 17802 | RSS: Main: 191946752 15:52:07 INFO - PROCESS | 17802 | 15:52:09 INFO - PROCESS | 17802 | Cycle 1(1): loaded http://localhost:40307/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40307/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:52:09 INFO - PROCESS | 17802 | RSS: Main: 191967232 15:52:09 INFO - PROCESS | 17802 | 15:52:12 INFO - PROCESS | 17802 | Cycle 1(1): loaded http://localhost:40307/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40307/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:52:13 INFO - PROCESS | 17802 | RSS: Main: 192303104 15:52:13 INFO - PROCESS | 17802 | 15:52:16 INFO - PROCESS | 17802 | Cycle 1(1): loaded http://localhost:40307/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40307/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:52:16 INFO - PROCESS | 17802 | RSS: Main: 192540672 15:52:16 INFO - PROCESS | 17802 | 15:52:18 INFO - PROCESS | 17802 | Cycle 1(1): loaded http://localhost:40307/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40307/tests/kraken/driver.html?testName=ai-astar) 15:52:18 INFO - PROCESS | 17802 | RSS: Main: 194146304 15:52:18 INFO - PROCESS | 17802 | 15:52:18 INFO - PROCESS | 17802 | __start_tp_report 15:52:18 INFO - PROCESS | 17802 | _x_x_mozilla_page_load 15:52:18 INFO - PROCESS | 17802 | _x_x_mozilla_page_load_details 15:52:18 INFO - PROCESS | 17802 | |i|pagename|runs| 15:52:18 INFO - PROCESS | 17802 | |0;ai-astar;106;113;112;113;113;115;113;112;114;112 15:52:18 INFO - PROCESS | 17802 | |1;audio-beat-detection;149;124;123;156;125;129;127;124;166;125 15:52:18 INFO - PROCESS | 17802 | |2;audio-dft;162;166;163;167;167;163;163;163;162;164 15:52:18 INFO - PROCESS | 17802 | |3;audio-fft;77;78;78;110;77;76;76;76;108;74 15:52:18 INFO - PROCESS | 17802 | |4;audio-oscillator;82;83;110;83;83;86;99;84;82;110 15:52:18 INFO - PROCESS | 17802 | |5;imaging-gaussian-blur;119;119;117;119;118;118;118;119;119;118 15:52:18 INFO - PROCESS | 17802 | |6;imaging-darkroom;147;148;147;148;148;146;147;146;147;149 15:52:18 INFO - PROCESS | 17802 | |7;imaging-desaturate;85;86;86;85;85;86;86;86;87;86 15:52:18 INFO - PROCESS | 17802 | |8;json-parse-financial;54;57;54;58;54;56;59;57;55;56 15:52:18 INFO - PROCESS | 17802 | |9;json-stringify-tinderbox;63;63;61;62;62;61;61;63;61;62 15:52:18 INFO - PROCESS | 17802 | |10;stanford-crypto-aes;83;89;86;80;82;81;84;84;81;81 15:52:18 INFO - PROCESS | 17802 | |11;stanford-crypto-ccm;144;136;141;133;132;135;138;132;184;132 15:52:18 INFO - PROCESS | 17802 | |12;stanford-crypto-pbkdf2;166;173;168;170;172;165;165;166;163;166 15:52:18 INFO - PROCESS | 17802 | |13;stanford-crypto-sha256-iterative;70;70;74;66;67;66;67;67;65;69 15:52:18 INFO - PROCESS | 17802 | __end_tp_report 15:52:18 INFO - PROCESS | 17802 | __start_cc_report 15:52:18 INFO - PROCESS | 17802 | _x_x_mozilla_cycle_collect,809 15:52:18 INFO - PROCESS | 17802 | __end_cc_report 15:52:18 INFO - PROCESS | 17802 | __startTimestamp1476744738859__endTimestamp 15:52:18 INFO - PROCESS | 17802 | 15:52:18 INFO - PROCESS | 17802 | ------- Summary: start ------- 15:52:18 INFO - PROCESS | 17802 | Number of tests: 14 15:52:18 INFO - PROCESS | 17802 | 15:52:18 INFO - PROCESS | 17802 | [#0] ai-astar Cycles:10 Average:112.30 Median:113.00 stddev:2.41 (2.1%) stddev-sans-first:1.00 15:52:18 INFO - PROCESS | 17802 | Values: 106.0 113.0 112.0 113.0 113.0 115.0 113.0 112.0 114.0 112.0 15:52:18 INFO - PROCESS | 17802 | 15:52:18 INFO - PROCESS | 17802 | [#1] audio-beat-detection Cycles:10 Average:134.80 Median:128.00 stddev:15.93 (12.4%) stddev-sans-first:16.05 15:52:18 INFO - PROCESS | 17802 | Values: 149.0 124.0 123.0 156.0 125.0 129.0 127.0 124.0 166.0 125.0 15:52:18 INFO - PROCESS | 17802 | 15:52:18 INFO - PROCESS | 17802 | [#2] audio-dft Cycles:10 Average:164.00 Median:163.50 stddev:1.94 (1.2%) stddev-sans-first:1.92 15:52:18 INFO - PROCESS | 17802 | Values: 162.0 166.0 163.0 167.0 167.0 163.0 163.0 163.0 162.0 164.0 15:52:18 INFO - PROCESS | 17802 | 15:52:18 INFO - PROCESS | 17802 | [#3] audio-fft Cycles:10 Average:83.00 Median:76.50 stddev:13.76 (18.0%) stddev-sans-first:14.42 15:52:18 INFO - PROCESS | 17802 | Values: 77.0 78.0 78.0 110.0 77.0 76.0 76.0 76.0 108.0 74.0 15:52:18 INFO - PROCESS | 17802 | 15:52:18 INFO - PROCESS | 17802 | [#4] audio-oscillator Cycles:10 Average:90.20 Median:83.00 stddev:11.58 (14.0%) stddev-sans-first:11.90 15:52:18 INFO - PROCESS | 17802 | Values: 82.0 83.0 110.0 83.0 83.0 86.0 99.0 84.0 82.0 110.0 15:52:18 INFO - PROCESS | 17802 | 15:52:18 INFO - PROCESS | 17802 | [#5] imaging-gaussian-blur Cycles:10 Average:118.40 Median:119.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 15:52:18 INFO - PROCESS | 17802 | Values: 119.0 119.0 117.0 119.0 118.0 118.0 118.0 119.0 119.0 118.0 15:52:18 INFO - PROCESS | 17802 | 15:52:18 INFO - PROCESS | 17802 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.50 stddev:0.95 (0.6%) stddev-sans-first:1.00 15:52:18 INFO - PROCESS | 17802 | Values: 147.0 148.0 147.0 148.0 148.0 146.0 147.0 146.0 147.0 149.0 15:52:18 INFO - PROCESS | 17802 | 15:52:18 INFO - PROCESS | 17802 | [#7] imaging-desaturate Cycles:10 Average:85.80 Median:86.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 15:52:18 INFO - PROCESS | 17802 | Values: 85.0 86.0 86.0 85.0 85.0 86.0 86.0 86.0 87.0 86.0 15:52:18 INFO - PROCESS | 17802 | 15:52:18 INFO - PROCESS | 17802 | [#8] json-parse-financial Cycles:10 Average:56.00 Median:56.50 stddev:1.76 (3.1%) stddev-sans-first:1.72 15:52:18 INFO - PROCESS | 17802 | Values: 54.0 57.0 54.0 58.0 54.0 56.0 59.0 57.0 55.0 56.0 15:52:18 INFO - PROCESS | 17802 | 15:52:18 INFO - PROCESS | 17802 | [#9] json-stringify-tinderbox Cycles:10 Average:61.90 Median:62.00 stddev:0.88 (1.4%) stddev-sans-first:0.83 15:52:18 INFO - PROCESS | 17802 | Values: 63.0 63.0 61.0 62.0 62.0 61.0 61.0 63.0 61.0 62.0 15:52:18 INFO - PROCESS | 17802 | 15:52:18 INFO - PROCESS | 17802 | [#10] stanford-crypto-aes Cycles:10 Average:83.10 Median:83.50 stddev:2.77 (3.3%) stddev-sans-first:2.93 15:52:18 INFO - PROCESS | 17802 | Values: 83.0 89.0 86.0 80.0 82.0 81.0 84.0 84.0 81.0 81.0 15:52:18 INFO - PROCESS | 17802 | 15:52:18 INFO - PROCESS | 17802 | [#11] stanford-crypto-ccm Cycles:10 Average:140.70 Median:137.00 stddev:15.76 (11.5%) stddev-sans-first:16.67 15:52:18 INFO - PROCESS | 17802 | Values: 144.0 136.0 141.0 133.0 132.0 135.0 138.0 132.0 184.0 132.0 15:52:18 INFO - PROCESS | 17802 | 15:52:18 INFO - PROCESS | 17802 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.40 Median:167.00 stddev:3.27 (2.0%) stddev-sans-first:3.43 15:52:18 INFO - PROCESS | 17802 | Values: 166.0 173.0 168.0 170.0 172.0 165.0 165.0 166.0 163.0 166.0 15:52:18 INFO - PROCESS | 17802 | 15:52:18 INFO - PROCESS | 17802 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.10 Median:68.00 stddev:2.69 (3.9%) stddev-sans-first:2.76 15:52:18 INFO - PROCESS | 17802 | Values: 70.0 70.0 74.0 66.0 67.0 66.0 67.0 67.0 65.0 69.0 15:52:18 INFO - PROCESS | 17802 | -------- Summary: end -------- 15:52:18 INFO - PROCESS | 17802 | 15:52:20 INFO - TEST-INFO | 17802: exit 0 15:52:20 INFO - TEST-OK | kraken | took 63131ms 15:52:20 INFO - SUITE-END | took 1179s 15:52:20 INFO - Completed test suite (00:19:40) 15:52:20 INFO - javascript benchmark 15:52:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7099.037223921744, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3016.683248258933, 3042.5131978883383, 3046.8324242166673, 3072.2012276808036, 3077.999999999999, 5422.078246698061, 5429.077056900326, 5452.809151679687, 5485.61600687952, 5592.245046918665, 5466.863328416782, 5481.5340696040885, 5500.367457742361, 5555.944440555603, 5580.776768929238, 4970.502949705019, 4996.200607902736, 5045.243213517983, 5085.84742457725, 5108.157154069574, 5021.748912554376, 5088.18589025756, 5133.691978481284, 5136.563392111675, 5191.870203244911, 4902.460729319772, 4929.580985616227, 5020.0963826511215, 5084.288199652052, 5096.668716533413, 5025.748712564394, 5047.242913562958, 5065.265536497224, 5082.923756143661, 5126.102931986888, 4985.725785081819, 4992.051510213048, 4995.5753760930365, 5004.824831130929, 5063.493650634944, 5374.7043912584795, 5539.307586551641, 5540.529055030327, 5562.86092847678, 5563.248961390242, 5768.653880767168, 5828.388019258002, 5846.824595262149, 5853.5902486825935, 5860.179574859523, 5870.853228669317, 5914.497267732248, 5922.733476993546, 5928.555358348141, 5929.229200203989, 5469.261649677283, 5479.780808767645, 5538.695371754511, 5539.778408863641, 5671.404502527258, 6024.487918526975, 6056.242969628796, 6106.45041946227, 6113.510919126459, 6120.816375508742, 5848.824535263949, 5851.297844258716, 5862.062070068769, 5865.472107510344, 5867.677277749679, 5706.543476521868, 5773.797917072882, 5820.592558520948, 5853.64878107315, 5854.414558544111, 5629.183768353648, 5696.458836410535, 5790.681512516768, 5826.0, 5861.824145275648, 5768.077107662753, 5842.415758424208, 5893.44012318829, 5903.970480147657, 5915.112733089984, 4360.803763830635, 4456.7548784817145, 4463.866084017484, 4473.642108631302, 4533.365328853963, 3911.061345277113, 3940.6847452203756, 3941.664958478504, 3964.0684439156776, 4008.7394319369146, 5587.720613969285, 5616.213730077792, 5620.690862002547, 5640.8871822563315, 5650.576206784508, 5871.3541510433815, 5895.174675545427, 5898.1152827076285, 5900.291964964232, 5926.585139040226, 5468.097763868917, 5474.91787623186, 5510.283663123768, 5556.0, 5559.8888022240135, 5063.265826455144, 5067.442581316052, 5070.264811602297, 5072.4673909239, 5115.181570948705, 6085.878282434326, 6095.963686173362, 6095.969520152371, 6135.662538560422, 6138.631682099089, 5697.829065128053, 5705.372409035086, 5809.331926828299, 5838.854028649318, 5925.229720136354, 5998.550108741774, 5999.220101386792, 6027.547933905063, 6105.694715264308, 6124.693765311627, 5711.257536520226, 5751.7411716472025, 5775.191473193672, 5784.392638772868, 5792.913106303493, 5782.335031471266, 5843.474087332161, 5865.149553314831, 5867.061270196748, 5881.411858814085, 5770.826875193751, 5803.071508558611, 5858.0, 5918.822435326947, 5930.347661757117, 5771.336296325809, 5806.274215723035, 5821.70891455417, 5838.2702162229725, 5846.590738648254, 5607.5513958882375, 5621.128725047624, 5651.4348565143155, 5671.206031155559, 5754.625949313281, 5824.912626310694, 5825.388334225015, 5832.708364581669, 5870.295564532284, 5891.263592050994, 5715.5713321500225, 5722.7710891563875, 5726.79956201531, 5733.340665823317, 5735.426457354231], "value": 5423.046186864974, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [569.9943000569995, 574.7844558290643, 585.2567239605701, 589.8525368657836, 597.2295738497338, 41027.38458923115, 42687.78656106715, 42706.0, 46666.0, 46702.76648616761, 43570.910727231756, 43808.342874856906, 44028.55971440284, 44071.0, 44122.7793861031, 8656.264217541517, 8804.163604457566, 8807.911920880806, 8811.206991370775, 8824.205821476065, 8598.699045533407, 8620.0, 8688.131186881325, 8710.0, 8739.0, 8729.694460693878, 8791.912080879174, 8795.340349473816, 8806.911930880706, 8823.250023747989, 8735.388522803407, 8756.956215218946, 8767.473951562926, 8769.298456123559, 8783.253423459013, 8386.119457457002, 8389.286910612605, 8476.110008449086, 8515.914840851636, 8520.573971301472, 40950.38574421386, 41339.586604133874, 41389.79305103485, 41448.1710365794, 41448.79275603633, 3058.7552995760284, 3207.8556464959133, 3347.2301370684636, 3382.1713680148523, 3726.0, 30825.84587077073, 30931.381372372653, 31224.37551248985, 31400.685993140232, 31754.364912701847, 4075.551689314173, 4142.482189726285, 4202.768847713374, 4207.158568286355, 4274.829006839723, 306922.0, 311258.0, 311798.0, 312170.0, 312181.0, 57175.0, 57351.42648573544, 57466.7126664364, 57472.0, 57547.712261439265, 60875.69562152161, 60966.69516652388, 61024.389756102755, 61135.0, 61262.38737612567, 15369.231538423033, 15731.606709832346, 15750.369985200692, 15817.367305307658, 15836.52490425289, 11820.172587918934, 11881.049516038696, 11957.701057473632, 11975.940120299343, 11998.40007999614, 15306.693866122616, 16933.83066169347, 16945.661086778196, 17061.658766824596, 17082.48752537401, 3058.204866734665, 5504.944950550524, 5718.170865224519, 5822.854428639233, 5980.252468441445, 803.5459965119688, 950.4487397309682, 1077.7790552936785, 1112.7162573543694, 1136.9602063927723, 29378.412431751247, 30924.907509249344, 30969.535456968162, 31244.531332030037, 31663.0, 1078.078243102152, 1081.1134869407167, 1088.2871719024051, 1121.685927940178, 1134.9659510214706, 15655.452059178102, 16379.508614741577, 16411.753823692656, 16416.671666566603, 16639.916800415922, 495659.0, 496670.0, 498987.0, 503960.0, 504900.0, 56027.0, 56330.71834640801, 56503.434965649816, 57092.429075709544, 57140.714296428254, 1292.825468561751, 1343.764841152814, 1348.7100273441258, 1351.905366624327, 1363.3796622536524, 29614.407711846074, 30508.237294067825, 30982.69017309798, 31336.0, 31519.84240078785, 49897.50102498929, 49902.750486247336, 50436.24345634745, 50489.0, 50618.49381506285, 419562.0, 423309.0, 424078.0, 424560.0, 425008.0, 26356.73643263543, 27229.72770272351, 27334.453310934066, 27339.0, 27488.0, 42368.15263694647, 45602.315965259884, 47232.2915156266, 47236.7638161807, 47316.0, 37835.81082094682, 38854.0, 39729.80135099306, 40172.799136005306, 40846.387304191056, 38749.22501549897, 38825.41761873518, 39379.6062039376, 39798.801005994785, 39893.800530997156, 39135.41296880606, 39147.0, 39202.41196381999, 39309.80345098256, 39317.41023884701, 31708.0, 35272.294554109285, 35435.468467973515, 35653.28693426169, 35951.64048359483, 26367.0, 26874.0, 26924.596131057657, 27081.1875643731, 27285.0], "value": 19265.31604997188, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.85263747138623, 379.30397720183464, 388.6832231731138, 389.03761338905684, 415.5242247626468, 17659.20533575989, 18749.718754218662, 19282.61434771304, 19299.421017369503, 19430.222791088374, 18021.09894505276, 18219.453416397497, 18429.723554146665, 18481.353152639662, 18514.166862491187, 5411.323584551921, 5524.751386187631, 5683.403242659523, 5692.943070569303, 5826.883462330751, 5856.9414305857035, 5891.381404952483, 5904.202932604107, 5905.911411328812, 5910.0, 5889.2049573307695, 5900.793472228473, 5983.10253461982, 6243.843903902416, 6292.307846136921, 5929.258842644669, 6332.0, 6387.0, 6389.329120442357, 6396.2324521057535, 5584.636998595079, 5624.268845050158, 5632.0, 5633.8591535211535, 5638.097904335327, 13470.25913574753, 13633.522826701017, 13805.033647644668, 13808.723825523433, 13866.653333666638, 2136.5513242219154, 2216.8448208625405, 2322.6980492535863, 2509.874506274697, 2752.2156185487243, 10099.091081802673, 10220.74448138795, 12229.755404891941, 12617.306048167347, 13617.182969021791, 1798.3346161920174, 1857.572758265593, 1895.6682580548486, 1897.4212865076147, 1952.4337941996803, 66243.66878165626, 71846.64076679635, 76485.0, 77698.22301776966, 79572.0, 10296.691099267035, 10630.149588032938, 10688.732781680364, 10798.784024319626, 11059.22585419013, 15082.17048062367, 15083.54749357521, 15104.622384440258, 15126.924365378103, 15139.318730657147, 7696.499727517694, 7807.843843123106, 7999.400044996649, 8195.754127376189, 8236.752897413087, 7577.659005344773, 7650.38796896247, 7811.882821757678, 7813.335866451302, 7840.568768717661, 4511.932321015187, 4520.141173177151, 4597.95402045982, 4627.884302892455, 4693.342931989524, 1924.9903750481158, 1941.9029048547516, 1953.3456292142291, 1958.3831093205595, 1992.4421162074643, 851.3359579527978, 909.9590518426687, 923.7182659288846, 926.7868390270276, 934.9859752103724, 17841.821581784017, 19423.708644370345, 19479.12343944526, 19603.411897643095, 19725.309614163434, 934.1825902335456, 935.8409070458039, 958.2956526952685, 971.0726256425238, 1012.5190534496055, 10230.744231394274, 10812.443669713886, 10876.891231087588, 10941.0, 10991.120710343153, 416881.0, 422551.0, 424673.0, 424950.0, 427778.0, 84907.0, 85374.0, 85670.0, 85766.14233857706, 86028.56985715032, 998.6854140945579, 1010.7675234696061, 1014.3102690170755, 1015.0762805846645, 1021.9131373833159, 16402.343906243615, 16408.832605938205, 16940.40708575194, 16961.0, 17073.0, 40877.182456350114, 41068.0, 41142.382864257655, 41341.58658413377, 42234.57765422307, 54111.0, 54525.45474545362, 54916.72541637266, 56650.43349566452, 57732.71133644305, 8105.230003149692, 8287.751367458986, 8360.414770965974, 8467.830643386975, 8612.65549378018, 9176.770580735534, 12028.699282517657, 13090.541831035867, 13102.344882756015, 13123.212607243597, 10590.947045264724, 11120.662941453002, 11305.604303849655, 11827.704307392383, 11843.526258949545, 10979.231453798158, 11168.050715689258, 11409.600663977053, 11771.411429428323, 11856.585019524275, 11338.886611133783, 11410.54357825711, 11464.197506174487, 11653.184277100521, 11709.941450292694, 8166.387520935835, 8270.172982701682, 8321.708740194064, 8387.580620968805, 8627.35294852876, 11114.777704445703, 11140.16448766362, 11335.319880807177, 11408.714782130513, 11860.466279017292], "value": 8931.364231920854, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1475.2549962269052, 1502.4215676964368, 1636.190085907476, 1723.9741403878936, 1778.8043315235313, 8588.785280367994, 8831.249343805785, 9196.862047069282, 9290.024547422525, 9326.300527460442, 8851.95574022129, 9049.864252036208, 9052.502112383816, 9087.818243635124, 9111.36220464566, 2149.3337065509704, 2174.771648976858, 2176.455886028485, 2181.887237508866, 2182.6180418426793, 2253.526759380532, 2271.1823743452346, 2338.7895089441945, 2339.4034521197073, 2348.0490401387465, 2295.678604995302, 2299.9655005174936, 2310.699609050821, 2315.8610483371053, 2345.5660702769956, 2286.0969916882736, 2291.8395712300144, 2293.4610366563843, 2303.2744685424204, 2305.9769402306015, 2181.5091604389045, 2182.71624688791, 2183.1049269799464, 2186.4424571734266, 2187.431267870349, 9092.454452732858, 9119.680811171644, 9194.0, 9210.078992100804, 9225.492597907112, 5131.435542090367, 5314.176302673091, 5316.760745766411, 5335.599830012765, 5364.436734142937, 3352.5474061001696, 3355.5134505496812, 3549.6627820357025, 3565.714742820568, 3572.4284114541547, 1044.6343779677052, 1103.47584897174, 1107.6787731557838, 1116.8938950799661, 1143.5597295041387, 12527.56153534631, 12606.369681515887, 12649.557265495663, 12707.93646031764, 12710.300933448656, 4271.273883439822, 4413.095315460387, 4479.193745125844, 4529.977350113229, 4535.455745310518, 9762.414255144715, 9818.65634702782, 9839.80320393588, 9851.950740246253, 9868.30921835479, 5228.529432351107, 5233.921491177635, 5237.869053273698, 5243.921341179809, 5248.921266181011, 4148.688848336386, 4267.914641707149, 4859.1010663027455, 4860.975695121572, 4899.877503062452, 3697.149655579232, 3710.7364507650313, 3722.9627703722617, 3811.923761524754, 3845.134844659985, 1149.350616901448, 1165.8834116588444, 1178.3460179600404, 1182.456070207697, 1184.3782014442315, 801.7835184500152, 946.6024269806697, 955.0592666223764, 963.3689933093694, 973.6592192732487, 5997.910031349533, 6003.159557661931, 6056.909756243918, 6105.084237364342, 6136.570440069152, 447.25755246291, 450.1042924580062, 453.709625839463, 465.4972629560067, 926.6015613286216, 4038.273110840018, 4110.280700877394, 4119.8970025748995, 4154.543000269968, 4157.0, 11203.60787372438, 11528.423578821026, 11548.133889958286, 11556.248843825124, 11585.942070289595, 11381.772364552828, 11385.0, 11408.714782130513, 11410.087193024538, 11432.199746017699, 7867.881981770278, 8110.5539195343645, 8155.83688326242, 8230.09468958414, 8262.752117436487, 5728.570357223308, 6031.788887388921, 6069.4840938518955, 6256.0, 6372.872542549216, 10016.248781341574, 10361.378317300987, 10387.117095046704, 10610.787784244427, 10624.309419887682, 10061.195104391778, 10311.845322320021, 10339.276250662682, 10557.260991730505, 10603.628872989408, 7461.291177338144, 7733.381329493514, 8226.62980165882, 8532.0, 8710.0, 8617.612207450806, 8831.381803273965, 8836.116388361112, 8908.0, 8910.108989101298, 7428.405727541892, 7517.887231691419, 7671.53970761756, 7755.495892766952, 7936.56348900816, 7517.1731109579, 7604.885926711215, 7685.077790665156, 7793.454458188099, 7938.6030698466, 6907.481938854506, 7046.365827075588, 7060.576365418091, 7065.823354415975, 7072.964635176997, 5051.545360917388, 5289.523942845162, 5291.100512912737, 5427.375851777097, 5593.580481463825, 5042.84871453857, 5055.87360315995, 5074.5940324774665, 5095.515925987025, 5303.708296043755], "value": 4578.614388910971, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [320.25221108711156, 320.5875784719982, 330.88749825059483, 333.4531368555569, 334.9313390754896, 5288.338957630287, 5512.944870551293, 5514.944850551493, 5539.224508568798, 5563.527100196483, 5260.763265653045, 5363.302770639821, 5367.577591938129, 5374.677519348832, 5400.351957765064, 4212.094399704063, 4215.367694845782, 4235.322348424253, 4240.745555266679, 4246.363045543162, 4152.110789590744, 4204.810783514749, 4236.915261694764, 4241.575842415765, 4259.70182087254, 4170.749755014709, 4173.1862286854075, 4178.0, 4178.582141785828, 4182.79086045698, 4140.399642051885, 4174.812133453972, 4178.582141785828, 4186.811593478301, 4193.559676233997, 3703.7962912039825, 3703.8333275002688, 3709.536307961505, 3721.8697345593046, 3730.421784623388, 5064.3163172971545, 5286.0, 5318.149096144598, 5323.760430780624, 5351.973240133813, 4787.904241915177, 4788.036904868987, 4792.760361981887, 4810.422749270075, 4814.542618451276, 5375.408705042442, 5706.715988902505, 5715.199872017921, 5722.736561261845, 5742.28221472316, 4026.7583944963394, 4045.7053742802314, 4051.230266249403, 4054.3715724062818, 4084.244414783245, 5852.444017818343, 5881.206037184968, 5955.196048533436, 5974.3428222895445, 6035.215421995156, 4043.2317859606583, 4186.937195942063, 4189.6438802701505, 4193.161367726406, 4197.706160568792, 4177.268977928911, 4177.749335039907, 4181.937270940938, 4186.811593478301, 4218.894527636834, 4773.856784296477, 4777.570018698334, 4779.808807647724, 4793.5685788279225, 4800.207965685692, 5574.104804366535, 5680.0, 5703.771849126071, 5707.600467967285, 5719.142128680648, 1380.3029470117726, 1387.7502049630962, 1393.7073214625043, 1402.389960367223, 1402.4109873853006, 888.5823662878437, 894.9105089491129, 907.419251678926, 917.6512925088424, 921.2123634292717, 4835.661503694778, 4847.636427267969, 4869.831240502254, 4880.536349046906, 4937.728424936591, 5080.722933707738, 5119.385673719177, 5158.3552055993005, 5167.379914410295, 5189.506996835295, 4737.857864264078, 4904.43598986114, 4930.10191076431, 4965.82619608312, 4975.303457515878, 2729.280553251439, 2733.384988377639, 2749.958750618742, 2755.3938133610573, 2756.9385786472353, 5218.843434696965, 5243.868903277448, 5249.448807875195, 5279.815206467755, 5281.683099014072, 4905.558499735041, 5194.831162988297, 5236.764345604457, 5246.403030499927, 5266.262723218752, 5241.240020196974, 5266.7366631668265, 5270.367555893241, 5279.551238144724, 5286.841394758163, 5090.847274581768, 5130.846074617767, 5141.434442211428, 5173.430922598586, 5178.275041494118, 4703.670743047954, 5013.8830626635445, 5018.297438358706, 5068.442471328225, 5118.334616499831, 5202.24567437727, 5222.582193424593, 5235.240890070994, 5273.284258606897, 5286.392064912584, 3726.31063253299, 3726.9813650931574, 3864.942025869558, 3879.4374815652136, 3972.7219094663096, 5806.129080637938, 5829.8251052468495, 5834.620749651259, 5850.853728656818, 5863.355030946507, 5685.71571421419, 5740.3685594585395, 5745.0, 5754.014864871612, 5768.2501274834, 5452.672839629635, 5608.7195640217005, 5672.631278966854, 5677.78566359112, 5678.643363004307, 5620.775168993358, 5676.148577713376, 5682.289713785777, 5688.431156884279, 5712.885742285048, 5483.588730845123, 5698.430156984268, 5787.594868359174, 5792.739326730391, 5814.859975613122, 5590.456342364296, 5619.241402410622, 5623.915641265467, 5635.211070450222, 5642.294713160855], "value": 4161.372362776719, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [709.7019251914196, 712.2912701861649, 712.8324843661742, 759.3796254585238, 805.2752522729543, 14680.339384727686, 15647.765283520755, 15778.76331855023, 15928.522144335659, 15938.601534961617, 14477.131372117681, 14610.269486525658, 14642.853571464282, 14676.339564719587, 14720.705585888303, 620.5904103291829, 661.0513912535503, 773.4547144263295, 793.1354823242665, 797.2067792546425, 769.6575024114271, 793.9325157361632, 803.0604193094094, 803.7950322667712, 803.8713805791075, 848.1476116502906, 851.6125163050797, 851.8679604661256, 852.8592782190931, 853.0105078109364, 843.3337663246028, 848.393398719912, 849.235687880906, 849.8215374771305, 850.0988951711175, 619.5601123202532, 619.6406084470996, 620.4044117647019, 621.2358798677607, 623.1245100633618, 14368.928155359261, 14413.71172576553, 14419.639509012253, 14545.854541454555, 14578.562643120724, 14821.555353339418, 14847.777283340758, 15078.472253471076, 15098.698026039418, 15108.848911510964, 11349.20555561111, 11356.091512678966, 11462.254953428, 11560.595379161688, 12234.632961011184, 3730.9440358394645, 3738.4953031340965, 3818.0, 3847.1920896611746, 3966.107625784204, 75004.62497687477, 75007.62496187484, 75221.0, 75570.0, 76456.23543764548, 10238.53926573306, 10393.53229104692, 10509.894901051044, 10603.94698026505, 10651.89348106509, 22690.319290421314, 22691.319260421882, 22744.772552274597, 22859.885700571722, 23050.193243236405, 7872.0, 7983.760487185394, 8167.142450042778, 8287.337013038943, 8407.2433480987, 4448.510663826976, 4456.643468522575, 4556.954430455653, 4557.726536407826, 4592.7014744041535, 3193.824339661341, 3320.1865542942132, 3346.9497957530657, 3358.7313014958745, 3359.2105855124514, 576.5790972589949, 596.2517041113462, 611.4252602553674, 613.9938600614026, 618.6350053468475, 564.5709260961617, 627.0030651264511, 640.2924768131242, 666.7133132752963, 698.3121625199175, 8075.394345424117, 8177.037510997437, 8409.20112589303, 8511.524369989544, 8653.394262401698, 628.205320269859, 656.9967150164218, 674.1135406939858, 707.8159678483528, 718.5652680128447, 4104.8768536943935, 4109.363048727452, 4299.161663475592, 4368.191884501377, 4387.8244870204835, 92078.53960730287, 108785.0, 117258.0, 119550.4022479882, 122208.0, 89115.55442222748, 89435.55282223548, 92209.0, 92431.0, 93058.0, 50417.74791126021, 55002.724986374815, 65438.0, 73832.26167738362, 81373.20088587122, 8307.750767476986, 9625.055446738768, 9881.555330010024, 10036.698899033041, 10053.597856085968, 47714.5228547724, 48511.27233091577, 48637.0, 49160.508394915596, 49261.50738492713, 62712.37287627065, 65942.67028664827, 70100.29899701141, 71214.0, 71325.0, 12549.874501255235, 12857.871421285667, 12868.549600763929, 12877.742445151232, 13159.342032898125, 12497.710271351323, 12632.431540580512, 12803.03977201695, 13169.868301317247, 13565.914726821633, 13087.738245234852, 13154.671133221364, 13228.338583071001, 13521.526746564217, 13633.454661813417, 13169.670758231121, 13532.59402217935, 14093.0, 14307.64230894236, 14529.200893950512, 10938.45307734626, 11245.437728113398, 11343.943280283545, 11604.419779011185, 11987.64037078889, 10168.440735759605, 10288.897111029093, 10498.370097794157, 10672.199585031309, 10765.515551800345, 9906.405615663083, 10205.183585313305, 10992.395418251754, 11022.559097636005, 11055.170862185207], "value": 7198.551293179135, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1513.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 113.0, 112.0, 113.0, 113.0, 115.0, 113.0, 112.0, 114.0, 112.0], "value": 112.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 124.0, 123.0, 156.0, 125.0, 129.0, 127.0, 124.0, 166.0, 125.0], "value": 134.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 166.0, 163.0, 167.0, 167.0, 163.0, 163.0, 163.0, 162.0, 164.0], "value": 164.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 78.0, 110.0, 77.0, 76.0, 76.0, 76.0, 108.0, 74.0], "value": 83.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 110.0, 83.0, 83.0, 86.0, 99.0, 84.0, 82.0, 110.0], "value": 90.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 119.0, 117.0, 119.0, 118.0, 118.0, 118.0, 119.0, 119.0, 118.0], "value": 118.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 147.0, 148.0, 148.0, 146.0, 147.0, 146.0, 147.0, 149.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 86.0, 85.0, 85.0, 86.0, 86.0, 86.0, 87.0, 86.0], "value": 85.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 57.0, 54.0, 58.0, 54.0, 56.0, 59.0, 57.0, 55.0, 56.0], "value": 56.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 61.0, 62.0, 62.0, 61.0, 61.0, 63.0, 61.0, 62.0], "value": 61.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 89.0, 86.0, 80.0, 82.0, 81.0, 84.0, 84.0, 81.0, 81.0], "value": 83.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 136.0, 141.0, 133.0, 132.0, 135.0, 138.0, 132.0, 184.0, 132.0], "value": 140.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 173.0, 168.0, 170.0, 172.0, 165.0, 165.0, 166.0, 163.0, 166.0], "value": 167.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 74.0, 66.0, 67.0, 66.0, 67.0, 67.0, 65.0, 69.0], "value": 68.1, "unit": "score"}]}]} 15:52:20 INFO - Return code: 0 15:52:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:52:20 ERROR - # TBPL SUCCESS # 15:52:20 INFO - Running post-action listener: _resource_record_post_action 15:52:20 INFO - [mozharness: 2016-10-17 22:52:20.662519Z] Finished run-tests step (success) 15:52:20 INFO - Running post-run listener: _resource_record_post_run 15:52:20 INFO - Total resource usage - Wall time: 1197s; CPU: 14.0%; Read bytes: 4096; Write bytes: 392585216; Read time: 12; Write time: 509400 15:52:20 INFO - TinderboxPrint: CPU usage
13.5% 15:52:20 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 15:52:20 INFO - TinderboxPrint: I/O write bytes / time
392,585,216 / 509,400 15:52:20 INFO - TinderboxPrint: CPU idle
8,255.1 (86.5%) 15:52:20 INFO - TinderboxPrint: CPU user
1,223.6 (12.8%) 15:52:20 INFO - TinderboxPrint: Swap in / out
0 / 0 15:52:20 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103383040; Read time: 0; Write time: 154160 15:52:20 INFO - run-tests - Wall time: 1181s; CPU: 14.0%; Read bytes: 0; Write bytes: 288690176; Read time: 0; Write time: 355212 15:52:21 INFO - Running post-run listener: _upload_blobber_files 15:52:21 INFO - Blob upload gear active. 15:52:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:52:21 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 15:52:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:52:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:52:21 INFO - (blobuploader) - INFO - Open directory for files ... 15:52:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:52:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:52:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:52:25 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:52:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:52:25 INFO - (blobuploader) - INFO - Done attempting. 15:52:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:52:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:52:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:52:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:52:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:52:26 INFO - (blobuploader) - INFO - Done attempting. 15:52:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:52:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:52:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:52:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:52:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:52:27 INFO - (blobuploader) - INFO - Done attempting. 15:52:27 INFO - (blobuploader) - INFO - Iteration through files over. 15:52:27 INFO - Return code: 0 15:52:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:52:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:52:27 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5b64400ebce143b477aff6223cc8d6ed2f03f52c323ee4ff0249fb1a89a2ac9874f00f8a430218f1795aea49e462a29ab07abf29bb2349722fa75bdc4c26ab83", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fa605530eb6ac2389c2bab2e286c1422c96a8957410cdf497f0ebf2976946777e9bf4da30aabe94a56ecdac72b6cf090a29b4f22e038853ba60a45a88b7956f9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5e217f0a99ba839140e497466e5bf94a06cbabe472677ff9784d7ea1ff7fed7118ed9872913a5f30262513d62b67490aca2ee4559bf76cac73c76e4d023b2645"} 15:52:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:52:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:52:27 INFO - Contents: 15:52:27 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5b64400ebce143b477aff6223cc8d6ed2f03f52c323ee4ff0249fb1a89a2ac9874f00f8a430218f1795aea49e462a29ab07abf29bb2349722fa75bdc4c26ab83", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fa605530eb6ac2389c2bab2e286c1422c96a8957410cdf497f0ebf2976946777e9bf4da30aabe94a56ecdac72b6cf090a29b4f22e038853ba60a45a88b7956f9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5e217f0a99ba839140e497466e5bf94a06cbabe472677ff9784d7ea1ff7fed7118ed9872913a5f30262513d62b67490aca2ee4559bf76cac73c76e4d023b2645"} 15:52:27 INFO - Running post-run listener: copy_logs_to_upload_dir 15:52:27 INFO - Copying logs to upload dir... 15:52:27 INFO - mkdir: /builds/slave/test/build/upload/logs 15:52:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.703672 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-10-17 15:52:27.297971) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-17 15:52:27.301830) ========= 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=eca2ab57546de7b41f256b19000001ef-1476743507.323003-1525556765 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5b64400ebce143b477aff6223cc8d6ed2f03f52c323ee4ff0249fb1a89a2ac9874f00f8a430218f1795aea49e462a29ab07abf29bb2349722fa75bdc4c26ab83", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fa605530eb6ac2389c2bab2e286c1422c96a8957410cdf497f0ebf2976946777e9bf4da30aabe94a56ecdac72b6cf090a29b4f22e038853ba60a45a88b7956f9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5e217f0a99ba839140e497466e5bf94a06cbabe472677ff9784d7ea1ff7fed7118ed9872913a5f30262513d62b67490aca2ee4559bf76cac73c76e4d023b2645"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1476732604/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011287 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1476732604/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5b64400ebce143b477aff6223cc8d6ed2f03f52c323ee4ff0249fb1a89a2ac9874f00f8a430218f1795aea49e462a29ab07abf29bb2349722fa75bdc4c26ab83", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fa605530eb6ac2389c2bab2e286c1422c96a8957410cdf497f0ebf2976946777e9bf4da30aabe94a56ecdac72b6cf090a29b4f22e038853ba60a45a88b7956f9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5e217f0a99ba839140e497466e5bf94a06cbabe472677ff9784d7ea1ff7fed7118ed9872913a5f30262513d62b67490aca2ee4559bf76cac73c76e4d023b2645"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-17 15:52:27.327808) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 15:52:27.328130) ========= 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=eca2ab57546de7b41f256b19000001ef-1476743507.323003-1525556765 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004512 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 15:52:27.411178) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-17 15:52:27.411513) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-17 15:52:27.411867) ========= ========= Total master_lag: 0.17 =========