builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-064 starttime: 1481776833.84 results: success (0) buildid: 20161214202419 builduid: 20915e6f75814699be695482b37c7cc9 revision: 3d48c2a8393ab0858920bf9493d3254e6ff120af ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-14 20:40:33.843838) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-14 20:40:33.844315) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-14 20:40:33.844597) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-14 20:40:33.860519) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-14 20:40:33.861052) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1481776834.777213-229459152 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-14 20:40:35-- 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% 226M=0s 2016-12-14 20:40:35 (226 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.141201 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-14 20:40:34.017657) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-14 20:40:34.018201) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1481776834.777213-229459152 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019295 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-14 20:40:34.069893) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-14 20:40:34.070469) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 3d48c2a8393ab0858920bf9493d3254e6ff120af --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 3d48c2a8393ab0858920bf9493d3254e6ff120af --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=a12cd81e0ef515edd9e0d800000001bb-1481776834.777213-229459152 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-14 20:40:35,725 truncating revision to first 12 chars 2016-12-14 20:40:35,725 Setting DEBUG logging. 2016-12-14 20:40:35,725 attempt 1/10 2016-12-14 20:40:35,725 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/3d48c2a8393a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-14 20:40:36,077 unpacking tar archive at: mozilla-inbound-3d48c2a8393a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.647517 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-14 20:40:34.734011) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-14 20:40:34.734547) ========= script_repo_revision: 3d48c2a8393ab0858920bf9493d3254e6ff120af ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-14 20:40:34.735223) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-14 20:40:34.735663) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-14 20:40:34.747223) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-12-14 20:40:34.747632) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a12cd81e0ef515edd9e0d800000001bb-1481776834.777213-229459152 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:40:36 INFO - MultiFileLogger online at 20161214 20:40:36 in /builds/slave/test 20:40:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 20:40:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:40:36 INFO - {'append_to_log': False, 20:40:36 INFO - 'base_work_dir': '/builds/slave/test', 20:40:36 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 20:40:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:40:36 INFO - 'branch': 'Mozilla-Inbound', 20:40:36 INFO - 'buildbot_json_path': 'buildprops.json', 20:40:36 INFO - 'config_files': ('talos/linux_config.py',), 20:40:36 INFO - 'default_actions': ('clobber', 20:40:36 INFO - 'read-buildbot-config', 20:40:36 INFO - 'download-and-extract', 20:40:36 INFO - 'populate-webroot', 20:40:36 INFO - 'create-virtualenv', 20:40:36 INFO - 'install', 20:40:36 INFO - 'run-tests'), 20:40:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:40:36 INFO - 'download_minidump_stackwalk': True, 20:40:36 INFO - 'download_symbols': 'ondemand', 20:40:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:40:36 INFO - 'tooltool.py': '/tools/tooltool.py', 20:40:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:40:36 INFO - '/tools/misc-python/virtualenv.py')}, 20:40:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:40:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:40:36 INFO - 'installer_path': 'installer.exe', 20:40:36 INFO - 'log_level': 'info', 20:40:36 INFO - 'log_name': 'talos', 20:40:36 INFO - 'log_to_console': True, 20:40:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:40:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:40:36 INFO - 'opt_config_files': (), 20:40:36 INFO - 'pip_index': False, 20:40:36 INFO - 'sps_profile': False, 20:40:36 INFO - 'sps_profile_interval': 0, 20:40:36 INFO - 'suite': 'dromaeojs', 20:40:36 INFO - 'system_bits': '32', 20:40:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:40:36 INFO - 'title': 'talos-linux64-ix-064', 20:40:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:40:36 INFO - 'use_talos_json': True, 20:40:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:40:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:40:36 INFO - 'work_dir': 'build'} 20:40:36 INFO - [mozharness: 2016-12-15 04:40:36.497844Z] Running clobber step. 20:40:36 INFO - Running pre-action listener: _resource_record_pre_action 20:40:36 INFO - Running main action method: clobber 20:40:36 INFO - rmtree: /builds/slave/test/build 20:40:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:40:36 INFO - Running post-action listener: _resource_record_post_action 20:40:36 INFO - [mozharness: 2016-12-15 04:40:36.970818Z] Finished clobber step (success) 20:40:36 INFO - [mozharness: 2016-12-15 04:40:36.970918Z] Running read-buildbot-config step. 20:40:36 INFO - Running pre-action listener: _resource_record_pre_action 20:40:36 INFO - Running main action method: read_buildbot_config 20:40:36 INFO - Using buildbot properties: 20:40:36 INFO - { 20:40:36 INFO - "project": "", 20:40:36 INFO - "product": "firefox", 20:40:36 INFO - "script_repo_revision": "production", 20:40:36 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 20:40:36 INFO - "repository": "", 20:40:36 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 20:40:36 INFO - "buildid": "20161214202419", 20:40:36 INFO - "stage_platform": "linux64-pgo", 20:40:36 INFO - "basedir": "/builds/slave/test", 20:40:36 INFO - "buildnumber": 2285, 20:40:36 INFO - "platform": "ubuntu64_hw", 20:40:36 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 20:40:36 INFO - "slavebuilddir": "test", 20:40:36 INFO - "branch": "mozilla-inbound", 20:40:36 INFO - "revision": "3d48c2a8393ab0858920bf9493d3254e6ff120af", 20:40:36 INFO - "slavename": "talos-linux64-ix-064", 20:40:36 INFO - "builduid": "20915e6f75814699be695482b37c7cc9", 20:40:36 INFO - "repo_path": "integration/mozilla-inbound" 20:40:36 INFO - } 20:40:36 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481769487/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 20:40:36 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481769487/firefox-53.0a1.en-US.linux-x86_64.test_packages.json. 20:40:36 INFO - Running post-action listener: _resource_record_post_action 20:40:36 INFO - [mozharness: 2016-12-15 04:40:36.973299Z] Finished read-buildbot-config step (success) 20:40:36 INFO - [mozharness: 2016-12-15 04:40:36.973392Z] Running download-and-extract step. 20:40:36 INFO - Running pre-action listener: _resource_record_pre_action 20:40:36 INFO - Running main action method: download_and_extract 20:40:36 INFO - mkdir: /builds/slave/test/build/tests 20:40:36 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')]} 20:40:36 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481769487/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 20:40:36 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481769487/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 20:40:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481769487/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 20:40:37 INFO - Downloaded 1361 bytes. 20:40:37 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 20:40:37 INFO - Using the following test package requirements: 20:40:37 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 20:40:37 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 20:40:37 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:40:37 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 20:40:37 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:40:37 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 20:40:37 INFO - u'jsshell-linux-x86_64.zip'], 20:40:37 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 20:40:37 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:40:37 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 20:40:37 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 20:40:37 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:40:37 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 20:40:37 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:40:37 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 20:40:37 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:40:37 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 20:40:37 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:40:37 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:40:37 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/1481769487/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 20:40:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481769487/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:40:37 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481769487/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 20:40:37 INFO - Expected file size: 21775368 20:40:37 INFO - Obtained file size: 21775368 20:40:41 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 20:40:41 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/1481769487/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 20:40:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481769487/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:40:41 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481769487/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 20:40:41 INFO - Expected file size: 21775368 20:40:41 INFO - Obtained file size: 21775368 20:40:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481769487/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 20:40:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481769487/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 20:40:46 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481769487/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 20:40:46 INFO - Expected file size: 14409734 20:40:46 INFO - Obtained file size: 14409734 20:40:46 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')]} 20:40:46 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481769487/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 20:40:46 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481769487/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 20:40:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481769487/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 20:40:47 INFO - Downloaded 59751850 bytes. 20:40:47 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481769487/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 20:40:47 INFO - mkdir: /builds/slave/test/properties 20:40:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:40:47 INFO - Writing to file /builds/slave/test/properties/build_url 20:40:47 INFO - Contents: 20:40:47 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481769487/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 20:40:47 INFO - Running post-action listener: _resource_record_post_action 20:40:47 INFO - Running post-action listener: set_extra_try_arguments 20:40:47 INFO - [mozharness: 2016-12-15 04:40:47.639883Z] Finished download-and-extract step (success) 20:40:47 INFO - [mozharness: 2016-12-15 04:40:47.640112Z] Running populate-webroot step. 20:40:47 INFO - Running pre-action listener: _resource_record_pre_action 20:40:47 INFO - Running main action method: populate_webroot 20:40:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:40:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:40:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:40:47 INFO - '--tppagecycles', 20:40:47 INFO - '7'], 20:40:47 INFO - 'tests': ['tsvgm']}}, 20:40:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:40:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:40:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:40:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:40:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:40:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:40:47 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 20:40:47 INFO - 'talos_options': ['--disable-e10s'], 20:40:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:40:47 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 20:40:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:40:47 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 20:40:47 INFO - 'talos_options': ['--disable-e10s'], 20:40:47 INFO - 'tests': ['damp', 'tps']}, 20:40:47 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 20:40:47 INFO - 'tests': ['damp', 'tps']}, 20:40:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:40:47 INFO - 'tests': ['dromaeo_dom']}, 20:40:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:40:47 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:40:47 INFO - 'tests': ['basic_compositor_video']}, 20:40:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:40:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:40:47 INFO - 'tests': ['a11yr', 20:40:47 INFO - 'ts_paint', 20:40:47 INFO - 'tpaint', 20:40:47 INFO - 'sessionrestore', 20:40:47 INFO - 'sessionrestore_no_auto_restore', 20:40:47 INFO - 'tabpaint']}, 20:40:47 INFO - 'other-e10s': {'tests': ['a11yr', 20:40:47 INFO - 'ts_paint', 20:40:47 INFO - 'tpaint', 20:40:47 INFO - 'sessionrestore', 20:40:47 INFO - 'sessionrestore_no_auto_restore', 20:40:47 INFO - 'tabpaint']}, 20:40:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:40:47 INFO - 'ts_paint', 20:40:47 INFO - 'tpaint', 20:40:47 INFO - 'sessionrestore', 20:40:47 INFO - 'sessionrestore_no_auto_restore', 20:40:47 INFO - 'tabpaint']}, 20:40:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:40:47 INFO - 'ts_paint', 20:40:47 INFO - 'tpaint', 20:40:47 INFO - 'sessionrestore', 20:40:47 INFO - 'sessionrestore_no_auto_restore', 20:40:47 INFO - 'tabpaint']}, 20:40:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:40:47 INFO - 'tests': ['a11yr', 20:40:47 INFO - 'ts_paint', 20:40:47 INFO - 'tpaint', 20:40:47 INFO - 'sessionrestore', 20:40:47 INFO - 'sessionrestore_no_auto_restore', 20:40:47 INFO - 'tabpaint']}, 20:40:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:40:47 INFO - 'tests': ['a11yr', 20:40:47 INFO - 'ts_paint', 20:40:47 INFO - 'tpaint', 20:40:47 INFO - 'sessionrestore', 20:40:47 INFO - 'sessionrestore_no_auto_restore', 20:40:47 INFO - 'tabpaint']}, 20:40:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:40:47 INFO - 'tests': ['tsvgx', 20:40:47 INFO - 'tsvgr_opacity', 20:40:47 INFO - 'tart', 20:40:47 INFO - 'tscrollx', 20:40:47 INFO - 'cart', 20:40:47 INFO - 'tsvg_static']}, 20:40:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:40:47 INFO - 'tsvgr_opacity', 20:40:47 INFO - 'tart', 20:40:47 INFO - 'tscrollx', 20:40:47 INFO - 'cart', 20:40:47 INFO - 'tsvg_static']}, 20:40:47 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 20:40:47 INFO - 'talos_options': ['--disable-e10s'], 20:40:47 INFO - 'tests': ['tp5o']}, 20:40:47 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 20:40:47 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 20:40:47 INFO - 'talos_options': ['--disable-e10s', 20:40:47 INFO - '--xperf_path', 20:40:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:40:47 INFO - 'tests': ['tp5n']}, 20:40:47 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 20:40:47 INFO - 'talos_options': ['--xperf_path', 20:40:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:40:47 INFO - 'tests': ['tp5n']}}, 20:40:47 INFO - 'talos.zip': {'path': '', 20:40:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:40:47 INFO - Running post-action listener: _resource_record_post_action 20:40:47 INFO - [mozharness: 2016-12-15 04:40:47.661404Z] Finished populate-webroot step (success) 20:40:47 INFO - [mozharness: 2016-12-15 04:40:47.661492Z] Running create-virtualenv step. 20:40:47 INFO - Running pre-action listener: _resource_record_pre_action 20:40:47 INFO - Running main action method: create_virtualenv 20:40:47 INFO - Creating virtualenv /builds/slave/test/build/venv 20:40:47 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 20:40:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:40:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:40:47 INFO - Using real prefix '/usr' 20:40:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:40:48 INFO - Installing distribute.............................................................................................................................................................................................done. 20:40:50 INFO - Installing pip.................done. 20:40:50 INFO - Return code: 0 20:40:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 20:40:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 20:40:50 INFO - Reading from file tmpfile_stdout 20:40:50 INFO - Output received: 20:40:50 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) 20:40:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:40:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:40:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:40:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:40:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:40:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:40:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:40:50 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 0x7ff352c62e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2005a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21a3120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2233f20>, '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 0x21a0c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a0f90>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1481776834.777213-229459152', '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 20:40:50 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 20:40:50 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 20:40:50 INFO - Using env: {'DISPLAY': ':0', 20:40:50 INFO - 'HOME': '/home/cltbld', 20:40:50 INFO - 'LANG': 'en_US.UTF-8', 20:40:50 INFO - 'LANGUAGE': 'en_US:en', 20:40:50 INFO - 'LOGNAME': 'cltbld', 20:40:50 INFO - 'MAIL': '/var/mail/cltbld', 20:40:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:40:50 INFO - 'MOZ_NO_REMOTE': '1', 20:40:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:40:50 INFO - 'NO_EM_RESTART': '1', 20:40:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:40:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:40:50 INFO - 'PWD': '/builds/slave/test', 20:40:50 INFO - 'SHELL': '/bin/bash', 20:40:50 INFO - 'SHLVL': '1', 20:40:50 INFO - 'TERM': 'linux', 20:40:50 INFO - 'TMOUT': '86400', 20:40:50 INFO - 'USER': 'cltbld', 20:40:50 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1481776834.777213-229459152', 20:40:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:40:50 INFO - '_': '/tools/buildbot/bin/python'} 20:40:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:40:50 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 20:40:50 INFO - Cleaning up... 20:40:50 INFO - Return code: 0 20:40:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:40:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:40:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:40:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:40:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:40:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:40:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:40:50 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 0x7ff352c62e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2005a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21a3120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2233f20>, '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 0x21a0c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a0f90>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1481776834.777213-229459152', '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 20:40:50 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 20:40:50 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 20:40:50 INFO - Using env: {'DISPLAY': ':0', 20:40:50 INFO - 'HOME': '/home/cltbld', 20:40:50 INFO - 'LANG': 'en_US.UTF-8', 20:40:50 INFO - 'LANGUAGE': 'en_US:en', 20:40:50 INFO - 'LOGNAME': 'cltbld', 20:40:50 INFO - 'MAIL': '/var/mail/cltbld', 20:40:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:40:50 INFO - 'MOZ_NO_REMOTE': '1', 20:40:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:40:50 INFO - 'NO_EM_RESTART': '1', 20:40:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:40:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:40:50 INFO - 'PWD': '/builds/slave/test', 20:40:50 INFO - 'SHELL': '/bin/bash', 20:40:50 INFO - 'SHLVL': '1', 20:40:50 INFO - 'TERM': 'linux', 20:40:50 INFO - 'TMOUT': '86400', 20:40:50 INFO - 'USER': 'cltbld', 20:40:50 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1481776834.777213-229459152', 20:40:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:40:50 INFO - '_': '/tools/buildbot/bin/python'} 20:40:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:40:50 INFO - Downloading/unpacking psutil>=3.1.1 20:40:50 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 20:40:50 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 20:40:50 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 20:40:50 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 20:40:50 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 20:40:50 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 20:40:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:40:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:40:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:40:53 INFO - Installing collected packages: psutil 20:40:53 INFO - Running setup.py install for psutil 20:40:53 INFO - building 'psutil._psutil_linux' extension 20:40:53 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 20:40:53 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 20:40:53 INFO - building 'psutil._psutil_posix' extension 20:40:53 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 20:40:53 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 20:40:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:40:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:40:53 INFO - Successfully installed psutil 20:40:53 INFO - Cleaning up... 20:40:53 INFO - Return code: 0 20:40:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:40:53 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')]} 20:40:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:40:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:40:53 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')]} 20:40:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:40:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:40:53 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 0x7ff352c62e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2005a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21a3120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2233f20>, '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 0x21a0c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a0f90>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1481776834.777213-229459152', '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 20:40:53 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 20:40:53 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 20:40:53 INFO - Using env: {'DISPLAY': ':0', 20:40:53 INFO - 'HOME': '/home/cltbld', 20:40:53 INFO - 'LANG': 'en_US.UTF-8', 20:40:53 INFO - 'LANGUAGE': 'en_US:en', 20:40:53 INFO - 'LOGNAME': 'cltbld', 20:40:53 INFO - 'MAIL': '/var/mail/cltbld', 20:40:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:40:53 INFO - 'MOZ_NO_REMOTE': '1', 20:40:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:40:53 INFO - 'NO_EM_RESTART': '1', 20:40:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:40:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:40:53 INFO - 'PWD': '/builds/slave/test', 20:40:53 INFO - 'SHELL': '/bin/bash', 20:40:53 INFO - 'SHLVL': '1', 20:40:53 INFO - 'TERM': 'linux', 20:40:53 INFO - 'TMOUT': '86400', 20:40:53 INFO - 'USER': 'cltbld', 20:40:53 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1481776834.777213-229459152', 20:40:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:40:53 INFO - '_': '/tools/buildbot/bin/python'} 20:40:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:40:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:40:53 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 20:40:53 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 20:40:53 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 20:40:53 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 20:40:53 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 20:40:53 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 20:40:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:40:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:40:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:40:55 INFO - Installing collected packages: mozsystemmonitor 20:40:55 INFO - Running setup.py install for mozsystemmonitor 20:40:55 INFO - Successfully installed mozsystemmonitor 20:40:55 INFO - Cleaning up... 20:40:55 INFO - Return code: 0 20:40:55 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:40:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:40:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:40:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:40:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:40:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:40:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:40:56 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 0x7ff352c62e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2005a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21a3120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2233f20>, '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 0x21a0c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a0f90>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1481776834.777213-229459152', '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 20:40:56 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 20:40:56 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 20:40:56 INFO - Using env: {'DISPLAY': ':0', 20:40:56 INFO - 'HOME': '/home/cltbld', 20:40:56 INFO - 'LANG': 'en_US.UTF-8', 20:40:56 INFO - 'LANGUAGE': 'en_US:en', 20:40:56 INFO - 'LOGNAME': 'cltbld', 20:40:56 INFO - 'MAIL': '/var/mail/cltbld', 20:40:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:40:56 INFO - 'MOZ_NO_REMOTE': '1', 20:40:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:40:56 INFO - 'NO_EM_RESTART': '1', 20:40:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:40:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:40:56 INFO - 'PWD': '/builds/slave/test', 20:40:56 INFO - 'SHELL': '/bin/bash', 20:40:56 INFO - 'SHLVL': '1', 20:40:56 INFO - 'TERM': 'linux', 20:40:56 INFO - 'TMOUT': '86400', 20:40:56 INFO - 'USER': 'cltbld', 20:40:56 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1481776834.777213-229459152', 20:40:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:40:56 INFO - '_': '/tools/buildbot/bin/python'} 20:40:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:40:56 INFO - Downloading/unpacking jsonschema==2.5.1 20:40:56 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 20:40:56 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 20:40:56 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 20:40:56 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 20:40:56 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 20:40:56 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 20:40:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:40:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:40:58 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 20:40:58 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 20:40:58 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 20:40:58 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 20:40:58 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 20:40:58 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 20:40:58 INFO - Downloading functools32-3.2.3-2.tar.gz 20:40:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:40:58 INFO - warning: no files found matching '*.txt' 20:40:58 INFO - no previously-included directories found matching 'build' 20:40:58 INFO - no previously-included directories found matching 'dist' 20:40:58 INFO - no previously-included directories found matching '.git*' 20:40:58 INFO - Installing collected packages: jsonschema, functools32 20:40:58 INFO - Running setup.py install for functools32 20:40:58 INFO - warning: no files found matching '*.txt' 20:40:58 INFO - no previously-included directories found matching 'build' 20:40:58 INFO - no previously-included directories found matching 'dist' 20:40:58 INFO - no previously-included directories found matching '.git*' 20:40:58 INFO - Successfully installed jsonschema functools32 20:40:58 INFO - Cleaning up... 20:40:58 INFO - Return code: 0 20:40:58 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:40:58 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')]} 20:40:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:40:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:40:58 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')]} 20:40:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:40:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:40:58 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 0x7ff352c62e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2005a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21a3120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2233f20>, '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 0x21a0c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a0f90>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1481776834.777213-229459152', '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 20:40:58 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 20:40:58 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 20:40:58 INFO - Using env: {'DISPLAY': ':0', 20:40:58 INFO - 'HOME': '/home/cltbld', 20:40:58 INFO - 'LANG': 'en_US.UTF-8', 20:40:58 INFO - 'LANGUAGE': 'en_US:en', 20:40:58 INFO - 'LOGNAME': 'cltbld', 20:40:58 INFO - 'MAIL': '/var/mail/cltbld', 20:40:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:40:58 INFO - 'MOZ_NO_REMOTE': '1', 20:40:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:40:58 INFO - 'NO_EM_RESTART': '1', 20:40:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:40:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:40:58 INFO - 'PWD': '/builds/slave/test', 20:40:58 INFO - 'SHELL': '/bin/bash', 20:40:58 INFO - 'SHLVL': '1', 20:40:58 INFO - 'TERM': 'linux', 20:40:58 INFO - 'TMOUT': '86400', 20:40:58 INFO - 'USER': 'cltbld', 20:40:58 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1481776834.777213-229459152', 20:40:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:40:58 INFO - '_': '/tools/buildbot/bin/python'} 20:40:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:40:58 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:40:58 INFO - Cleaning up... 20:40:58 INFO - Return code: 0 20:40:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:40:58 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')]} 20:40:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:40:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:40:58 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')]} 20:40:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:40:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:40:58 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 0x7ff352c62e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2005a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21a3120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2233f20>, '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 0x21a0c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a0f90>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1481776834.777213-229459152', '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 20:40:58 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 20:40:58 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 20:40:58 INFO - Using env: {'DISPLAY': ':0', 20:40:58 INFO - 'HOME': '/home/cltbld', 20:40:58 INFO - 'LANG': 'en_US.UTF-8', 20:40:58 INFO - 'LANGUAGE': 'en_US:en', 20:40:58 INFO - 'LOGNAME': 'cltbld', 20:40:58 INFO - 'MAIL': '/var/mail/cltbld', 20:40:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:40:58 INFO - 'MOZ_NO_REMOTE': '1', 20:40:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:40:58 INFO - 'NO_EM_RESTART': '1', 20:40:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:40:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:40:58 INFO - 'PWD': '/builds/slave/test', 20:40:58 INFO - 'SHELL': '/bin/bash', 20:40:58 INFO - 'SHLVL': '1', 20:40:58 INFO - 'TERM': 'linux', 20:40:58 INFO - 'TMOUT': '86400', 20:40:58 INFO - 'USER': 'cltbld', 20:40:58 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1481776834.777213-229459152', 20:40:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:40:58 INFO - '_': '/tools/buildbot/bin/python'} 20:40:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:40:59 INFO - Downloading/unpacking blobuploader==1.2.4 20:40:59 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 20:40:59 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 20:40:59 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 20:40:59 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 20:40:59 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 20:40:59 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 20:41:01 INFO - Downloading blobuploader-1.2.4.tar.gz 20:41:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:41:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:41:01 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 20:41:01 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 20:41:01 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 20:41:01 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 20:41:01 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 20:41:01 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 20:41:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:41:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:41:01 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 20:41:01 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 20:41:01 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 20:41:01 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 20:41:01 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 20:41:01 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 20:41:01 INFO - Downloading docopt-0.6.1.tar.gz 20:41:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:41:01 INFO - Installing collected packages: blobuploader, requests, docopt 20:41:01 INFO - Running setup.py install for blobuploader 20:41:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:41:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:41:01 INFO - Running setup.py install for requests 20:41:02 INFO - Running setup.py install for docopt 20:41:02 INFO - Successfully installed blobuploader requests docopt 20:41:02 INFO - Cleaning up... 20:41:02 INFO - Return code: 0 20:41:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:41:02 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')]} 20:41:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:41:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:41:02 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')]} 20:41:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:41:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:41:02 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 0x7ff352c62e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2005a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21a3120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2233f20>, '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 0x21a0c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a0f90>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1481776834.777213-229459152', '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 20:41:02 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 20:41:02 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 20:41:02 INFO - Using env: {'DISPLAY': ':0', 20:41:02 INFO - 'HOME': '/home/cltbld', 20:41:02 INFO - 'LANG': 'en_US.UTF-8', 20:41:02 INFO - 'LANGUAGE': 'en_US:en', 20:41:02 INFO - 'LOGNAME': 'cltbld', 20:41:02 INFO - 'MAIL': '/var/mail/cltbld', 20:41:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:41:02 INFO - 'MOZ_NO_REMOTE': '1', 20:41:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:41:02 INFO - 'NO_EM_RESTART': '1', 20:41:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:41:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:41:02 INFO - 'PWD': '/builds/slave/test', 20:41:02 INFO - 'SHELL': '/bin/bash', 20:41:02 INFO - 'SHLVL': '1', 20:41:02 INFO - 'TERM': 'linux', 20:41:02 INFO - 'TMOUT': '86400', 20:41:02 INFO - 'USER': 'cltbld', 20:41:02 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1481776834.777213-229459152', 20:41:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:41:02 INFO - '_': '/tools/buildbot/bin/python'} 20:41:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:41:02 INFO - Running setup.py (path:/tmp/pip-E61Fil-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:41:02 INFO - Running setup.py (path:/tmp/pip-66XWAK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:41:02 INFO - Running setup.py (path:/tmp/pip-D_2Ri_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:41:02 INFO - Running setup.py (path:/tmp/pip-D9xvEi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:41:02 INFO - Running setup.py (path:/tmp/pip-iwfKbP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:41:03 INFO - Running setup.py (path:/tmp/pip-vgb_tS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:41:03 INFO - Running setup.py (path:/tmp/pip-kg8Xkn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:41:03 INFO - Running setup.py (path:/tmp/pip-IPfzQy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:41:03 INFO - Running setup.py (path:/tmp/pip-cq7Kdm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:41:03 INFO - Running setup.py (path:/tmp/pip-UQAI5N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:41:03 INFO - Running setup.py (path:/tmp/pip-awFjQZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:41:03 INFO - Running setup.py (path:/tmp/pip-CZO0IV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:41:03 INFO - Running setup.py (path:/tmp/pip-_Hoia3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:41:03 INFO - Running setup.py (path:/tmp/pip-uLzeCj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:41:03 INFO - Running setup.py (path:/tmp/pip-1AhXBI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:41:03 INFO - Running setup.py (path:/tmp/pip-6hVQEk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:41:03 INFO - Running setup.py (path:/tmp/pip-Ket9vE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:41:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:41:03 INFO - Running setup.py install for manifestparser 20:41:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:41:04 INFO - Running setup.py install for mozcrash 20:41:04 INFO - Running setup.py install for mozdebug 20:41:04 INFO - Running setup.py install for mozdevice 20:41:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:41:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:41:04 INFO - Running setup.py install for mozfile 20:41:04 INFO - Running setup.py install for mozhttpd 20:41:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:41:04 INFO - Running setup.py install for mozinfo 20:41:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:41:04 INFO - Running setup.py install for mozInstall 20:41:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:41:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:41:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:41:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:41:04 INFO - Running setup.py install for mozleak 20:41:04 INFO - Running setup.py install for mozlog 20:41:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:41:04 INFO - Running setup.py install for moznetwork 20:41:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:41:05 INFO - Running setup.py install for mozprocess 20:41:05 INFO - Running setup.py install for mozprofile 20:41:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:41:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:41:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:41:05 INFO - Running setup.py install for mozrunner 20:41:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:41:05 INFO - Running setup.py install for mozscreenshot 20:41:05 INFO - Running setup.py install for moztest 20:41:05 INFO - Running setup.py install for mozversion 20:41:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:41:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:41:05 INFO - Cleaning up... 20:41:05 INFO - Return code: 0 20:41:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:41:05 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')]} 20:41:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:41:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:41:05 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')]} 20:41:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:41:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:41:05 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 0x7ff352c62e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2005a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21a3120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2233f20>, '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 0x21a0c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a0f90>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1481776834.777213-229459152', '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 20:41:05 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 20:41:05 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 20:41:05 INFO - Using env: {'DISPLAY': ':0', 20:41:05 INFO - 'HOME': '/home/cltbld', 20:41:05 INFO - 'LANG': 'en_US.UTF-8', 20:41:05 INFO - 'LANGUAGE': 'en_US:en', 20:41:05 INFO - 'LOGNAME': 'cltbld', 20:41:05 INFO - 'MAIL': '/var/mail/cltbld', 20:41:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:41:05 INFO - 'MOZ_NO_REMOTE': '1', 20:41:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:41:05 INFO - 'NO_EM_RESTART': '1', 20:41:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:41:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:41:05 INFO - 'PWD': '/builds/slave/test', 20:41:05 INFO - 'SHELL': '/bin/bash', 20:41:05 INFO - 'SHLVL': '1', 20:41:05 INFO - 'TERM': 'linux', 20:41:05 INFO - 'TMOUT': '86400', 20:41:05 INFO - 'USER': 'cltbld', 20:41:05 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1481776834.777213-229459152', 20:41:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:41:05 INFO - '_': '/tools/buildbot/bin/python'} 20:41:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:41:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:41:05 INFO - Running setup.py (path:/tmp/pip-ZoXQ0w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:41:06 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)) 20:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:41:06 INFO - Running setup.py (path:/tmp/pip-GB4F1o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:41:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:41:06 INFO - Running setup.py (path:/tmp/pip-vtdALY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:41:06 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)) 20:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:41:06 INFO - Running setup.py (path:/tmp/pip-FkpKow-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:41:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:41:06 INFO - Running setup.py (path:/tmp/pip-getMGi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:41:06 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)) 20:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:41:06 INFO - Running setup.py (path:/tmp/pip-Yr8GQ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:41:06 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)) 20:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:41:06 INFO - Running setup.py (path:/tmp/pip-eN2mwM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:41:06 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)) 20:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:41:06 INFO - Running setup.py (path:/tmp/pip-18IEm9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:41:06 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)) 20:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:41:06 INFO - Running setup.py (path:/tmp/pip-X15c_V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:41:06 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)) 20:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:41:06 INFO - Running setup.py (path:/tmp/pip-l1T0mV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:41:06 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)) 20:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:41:06 INFO - Running setup.py (path:/tmp/pip-Lu7P2_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:41:06 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)) 20:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:41:06 INFO - Running setup.py (path:/tmp/pip-PbEUU3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:41:06 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)) 20:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:41:06 INFO - Running setup.py (path:/tmp/pip-CvlcBM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:41:06 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)) 20:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:41:06 INFO - Running setup.py (path:/tmp/pip-j9zWFl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:41:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 20:41:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:41:07 INFO - Running setup.py (path:/tmp/pip-zqzoK1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:41:07 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)) 20:41:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:41:07 INFO - Running setup.py (path:/tmp/pip-ndvhah-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:41:07 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)) 20:41:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:41:07 INFO - Running setup.py (path:/tmp/pip-jIXqdZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:41:07 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)) 20:41:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:41:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:41:07 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)) 20:41:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:41:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:41:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:41:07 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 20:41:07 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 20:41:07 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 20:41:07 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 20:41:07 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 20:41:07 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 20:41:09 INFO - Downloading blessings-1.6.tar.gz 20:41:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:41:09 INFO - Installing collected packages: blessings 20:41:09 INFO - Running setup.py install for blessings 20:41:09 INFO - Successfully installed blessings 20:41:09 INFO - Cleaning up... 20:41:09 INFO - Return code: 0 20:41:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:41:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:41:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:41:09 INFO - Reading from file tmpfile_stdout 20:41:09 INFO - Current package versions: 20:41:09 INFO - argparse == 1.2.1 20:41:09 INFO - blessings == 1.6 20:41:09 INFO - blobuploader == 1.2.4 20:41:09 INFO - docopt == 0.6.1 20:41:09 INFO - functools32 == 3.2.3-2 20:41:09 INFO - jsonschema == 2.5.1 20:41:09 INFO - manifestparser == 1.1 20:41:09 INFO - mozInstall == 1.12 20:41:09 INFO - mozcrash == 1.0 20:41:09 INFO - mozdebug == 0.1 20:41:09 INFO - mozdevice == 0.49 20:41:09 INFO - mozfile == 1.2 20:41:09 INFO - mozhttpd == 0.7 20:41:09 INFO - mozinfo == 0.9 20:41:09 INFO - mozleak == 0.1 20:41:09 INFO - mozlog == 3.4 20:41:09 INFO - moznetwork == 0.27 20:41:09 INFO - mozprocess == 0.23 20:41:09 INFO - mozprofile == 0.28 20:41:09 INFO - mozrunner == 6.13 20:41:09 INFO - mozscreenshot == 0.1 20:41:09 INFO - mozsystemmonitor == 0.3 20:41:09 INFO - moztest == 0.7 20:41:09 INFO - mozversion == 1.4 20:41:09 INFO - psutil == 3.1.1 20:41:09 INFO - requests == 1.2.3 20:41:09 INFO - wsgiref == 0.1.2 20:41:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:41:09 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')]} 20:41:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:41:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:41:09 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')]} 20:41:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:41:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:41:09 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 0x7ff352c62e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2005a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21a3120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2233f20>, '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 0x21a0c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a0f90>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1481776834.777213-229459152', '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 20:41:09 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 20:41:09 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 20:41:09 INFO - Using env: {'DISPLAY': ':0', 20:41:09 INFO - 'HOME': '/home/cltbld', 20:41:09 INFO - 'LANG': 'en_US.UTF-8', 20:41:09 INFO - 'LANGUAGE': 'en_US:en', 20:41:09 INFO - 'LOGNAME': 'cltbld', 20:41:09 INFO - 'MAIL': '/var/mail/cltbld', 20:41:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:41:09 INFO - 'MOZ_NO_REMOTE': '1', 20:41:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:41:09 INFO - 'NO_EM_RESTART': '1', 20:41:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:41:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:41:09 INFO - 'PWD': '/builds/slave/test', 20:41:09 INFO - 'SHELL': '/bin/bash', 20:41:09 INFO - 'SHLVL': '1', 20:41:09 INFO - 'TERM': 'linux', 20:41:09 INFO - 'TMOUT': '86400', 20:41:09 INFO - 'USER': 'cltbld', 20:41:09 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1481776834.777213-229459152', 20:41:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:41:09 INFO - '_': '/tools/buildbot/bin/python'} 20:41:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:41:09 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)) 20:41:09 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)) 20:41:09 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)) 20:41:09 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)) 20:41:09 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)) 20:41:09 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)) 20:41:09 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)) 20:41:09 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)) 20:41:09 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)) 20:41:09 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)) 20:41:09 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)) 20:41:09 INFO - Cleaning up... 20:41:09 INFO - Return code: 0 20:41:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:41:09 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')]} 20:41:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:41:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:41:09 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')]} 20:41:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:41:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:41:09 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 0x7ff352c62e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2005a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21a3120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2233f20>, '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 0x21a0c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a0f90>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1481776834.777213-229459152', '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 20:41:09 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 20:41:09 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 20:41:09 INFO - Using env: {'DISPLAY': ':0', 20:41:09 INFO - 'HOME': '/home/cltbld', 20:41:09 INFO - 'LANG': 'en_US.UTF-8', 20:41:09 INFO - 'LANGUAGE': 'en_US:en', 20:41:09 INFO - 'LOGNAME': 'cltbld', 20:41:09 INFO - 'MAIL': '/var/mail/cltbld', 20:41:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:41:09 INFO - 'MOZ_NO_REMOTE': '1', 20:41:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:41:09 INFO - 'NO_EM_RESTART': '1', 20:41:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:41:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:41:09 INFO - 'PWD': '/builds/slave/test', 20:41:09 INFO - 'SHELL': '/bin/bash', 20:41:09 INFO - 'SHLVL': '1', 20:41:09 INFO - 'TERM': 'linux', 20:41:09 INFO - 'TMOUT': '86400', 20:41:09 INFO - 'USER': 'cltbld', 20:41:09 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1481776834.777213-229459152', 20:41:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:41:09 INFO - '_': '/tools/buildbot/bin/python'} 20:41:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:41:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:41:10 INFO - Cleaning up... 20:41:10 INFO - Return code: 0 20:41:10 INFO - Running post-action listener: _resource_record_post_action 20:41:10 INFO - Running post-action listener: _start_resource_monitoring 20:41:10 INFO - Starting resource monitoring. 20:41:10 INFO - [mozharness: 2016-12-15 04:41:10.122649Z] Finished create-virtualenv step (success) 20:41:10 INFO - [mozharness: 2016-12-15 04:41:10.123173Z] Running install step. 20:41:10 INFO - Running pre-action listener: _resource_record_pre_action 20:41:10 INFO - Running main action method: install 20:41:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:41:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:41:10 INFO - Reading from file tmpfile_stdout 20:41:10 INFO - Detecting whether we're running mozinstall >=1.0... 20:41:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:41:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:41:10 INFO - Reading from file tmpfile_stdout 20:41:10 INFO - Output received: 20:41:10 INFO - Usage: mozinstall [options] installer 20:41:10 INFO - Options: 20:41:10 INFO - -h, --help show this help message and exit 20:41:10 INFO - -d DEST, --destination=DEST 20:41:10 INFO - Directory to install application into. [default: 20:41:10 INFO - "/builds/slave/test"] 20:41:10 INFO - --app=APP Application being installed. [default: firefox] 20:41:10 INFO - mkdir: /builds/slave/test/build/application 20:41:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 20:41:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 20:41:27 INFO - Reading from file tmpfile_stdout 20:41:27 INFO - Output received: 20:41:27 INFO - /builds/slave/test/build/application/firefox/firefox 20:41:27 INFO - Running post-action listener: _resource_record_post_action 20:41:27 INFO - [mozharness: 2016-12-15 04:41:27.393082Z] Finished install step (success) 20:41:27 INFO - [mozharness: 2016-12-15 04:41:27.393428Z] Running run-tests step. 20:41:27 INFO - Running pre-action listener: _resource_record_pre_action 20:41:27 INFO - Running main action method: run_tests 20:41:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:41:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:41:27 INFO - Python 2.7.3 20:41:27 INFO - Return code: 0 20:41:27 INFO - grabbing minidump binary from tooltool 20:41:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:41:27 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 0x2233f20>, '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 0x21a0c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a0f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:41:27 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 20:41:27 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 20:41:27 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 20:41:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:41:27 INFO - Return code: 0 20:41:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:41:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:41:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:41:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:41:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:41:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481769487/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 20:41:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481769487/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-064 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 20:41:27 INFO - Using env: {'DISPLAY': ':0', 20:41:27 INFO - 'HOME': '/home/cltbld', 20:41:27 INFO - 'LANG': 'en_US.UTF-8', 20:41:27 INFO - 'LANGUAGE': 'en_US:en', 20:41:27 INFO - 'LOGNAME': 'cltbld', 20:41:27 INFO - 'MAIL': '/var/mail/cltbld', 20:41:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:41:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:41:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:41:27 INFO - 'MOZ_NO_REMOTE': '1', 20:41:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:41:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:41:27 INFO - 'NO_EM_RESTART': '1', 20:41:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:41:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:41:27 INFO - 'PWD': '/builds/slave/test', 20:41:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:41:27 INFO - 'SHELL': '/bin/bash', 20:41:27 INFO - 'SHLVL': '1', 20:41:27 INFO - 'TERM': 'linux', 20:41:27 INFO - 'TMOUT': '86400', 20:41:27 INFO - 'USER': 'cltbld', 20:41:27 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1481776834.777213-229459152', 20:41:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:41:27 INFO - '_': '/tools/buildbot/bin/python'} 20:41:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481769487/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 20:41:27 INFO - mozversion application_buildid: 20161214183807 20:41:27 INFO - mozversion application_changeset: 3d48c2a8393ab0858920bf9493d3254e6ff120af 20:41:27 INFO - mozversion application_display_name: Nightly 20:41:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:41:27 INFO - mozversion application_name: Firefox 20:41:27 INFO - mozversion application_remotingname: firefox 20:41:27 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 20:41:27 INFO - mozversion application_vendor: Mozilla 20:41:27 INFO - mozversion application_version: 53.0a1 20:41:27 INFO - mozversion platform_buildid: 20161214183807 20:41:27 INFO - mozversion platform_changeset: 3d48c2a8393ab0858920bf9493d3254e6ff120af 20:41:27 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 20:41:27 INFO - mozversion platform_version: 53.0a1 20:41:27 INFO - using testdate: 1481776887 20:41:27 INFO - actual date: 1481776887 20:41:27 INFO - starting webserver on 'localhost:55668' 20:41:27 INFO - SUITE-START | Running 2 tests 20:41:27 INFO - TEST-START | dromaeo_css 20:41:27 INFO - operating with platform_type : linux_ 20:41:27 INFO - Initialising browser for dromaeo_css test... 20:41:27 INFO - TEST-INFO | started process 24217 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwHDUPZ/profile http://localhost:55668/getInfo.html) 20:41:32 INFO - PROCESS | 24217 | __metrics Screen width/height:1600/1200 20:41:32 INFO - PROCESS | 24217 | colorDepth:24 20:41:32 INFO - PROCESS | 24217 | Browser inner width/height: 1024/697 20:41:32 INFO - PROCESS | 24217 | __metrics 20:41:32 INFO - PROCESS | 24217 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 20:41:32 INFO - PROCESS | 24217 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:41:33 INFO - PROCESS | 24217 | console.error: PushService: 20:41:33 INFO - PROCESS | 24217 | stateChangeProcessEnqueue: Error transitioning state 20:41:33 INFO - PROCESS | 24217 | UnknownError 20:41:34 INFO - TEST-INFO | 24217: exit 0 20:41:34 INFO - Browser initialized. 20:41:34 INFO - Running cycle 1/1 for dromaeo_css test... 20:41:34 INFO - TEST-INFO | started process 24301 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwHDUPZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:41:46 INFO - PROCESS | 24301 | RSS: Main: 172601344 20:41:46 INFO - PROCESS | 24301 | 20:42:37 INFO - PROCESS | 24301 | 1481776957483 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] 20:44:48 INFO - PROCESS | 24301 | Cycle 1(1): loaded http://localhost:55668/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55668/tests/dromaeo/cssquery-ext.html) 20:44:49 INFO - PROCESS | 24301 | RSS: Main: 291074048 20:44:49 INFO - PROCESS | 24301 | 20:47:52 INFO - PROCESS | 24301 | Cycle 1(1): loaded http://localhost:55668/tests/dromaeo/cssquery-ext.html (next: http://localhost:55668/tests/dromaeo/cssquery-jquery.html) 20:47:52 INFO - PROCESS | 24301 | RSS: Main: 283451392 20:47:52 INFO - PROCESS | 24301 | 20:50:55 INFO - PROCESS | 24301 | Cycle 1(1): loaded http://localhost:55668/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55668/tests/dromaeo/cssquery-mootools.html) 20:50:55 INFO - PROCESS | 24301 | RSS: Main: 222916608 20:50:55 INFO - PROCESS | 24301 | 20:53:57 INFO - PROCESS | 24301 | Cycle 1(1): loaded http://localhost:55668/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55668/tests/dromaeo/cssquery-prototype.html) 20:53:58 INFO - PROCESS | 24301 | RSS: Main: 222785536 20:53:58 INFO - PROCESS | 24301 | 20:57:01 INFO - PROCESS | 24301 | Cycle 1(1): loaded http://localhost:55668/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55668/tests/dromaeo/cssquery-yui.html) 20:57:01 INFO - PROCESS | 24301 | RSS: Main: 229011456 20:57:01 INFO - PROCESS | 24301 | 21:00:04 INFO - PROCESS | 24301 | Cycle 1(1): loaded http://localhost:55668/tests/dromaeo/cssquery-yui.html (next: http://localhost:55668/tests/dromaeo/cssquery-dojo.html) 21:00:04 INFO - PROCESS | 24301 | RSS: Main: 321880064 21:00:04 INFO - PROCESS | 24301 | 21:00:04 INFO - PROCESS | 24301 | __start_tp_report 21:00:04 INFO - PROCESS | 24301 | _x_x_mozilla_page_load 21:00:04 INFO - PROCESS | 24301 | _x_x_mozilla_page_load_details 21:00:04 INFO - PROCESS | 24301 | |i|pagename|runs| 21:00:04 INFO - PROCESS | 24301 | |0;dojo.html;3048.847557622119;3072.800267982582;3084.9383012339754;3103.317270200555;3106.9378612427754;5208.218767184924;5231.398389185245;5276.472352764727;5350.384705758839;5357.491038351355;5240.895182096356;5291.2327712481665;5304.071787437193;5304.469553044693;5404.32445944257;4814.446338671045;4854.87862803431;4874.731889746063;4880.072786170634;4887.706737595738;4834.9033019339595;4950.480199579047;4952.900941981158;4989.57588604969;5023.397192336906;4952.0838644850455;4988.925166122511;4996.5503104720565;5005.824796132118;5046.243063540462;4755.405574303212;4777.259524773665;4789.521047895182;4825.1555977703765;4888.755562221874;4815.422149342066;4824.155772739757;4834.178189707758;4889.119958407486;4894.828680996148;5261.842144735664;5280.867978300535;5297.231901374279;5323.813666521653;5363.517283444469;5465.07093794056;5515.696636684981;5672.829815105553;5680.715964201773;5695.658260504383;5642.153676948449;5728.79949201776;5744.281964754406;5752.884942301131;5782.97108514459;5352.625316227865;5354.143337066051;5355.785768569292;5359.196120581866;5361.81233656824;5579.191017302468;5823.82528524145;5827.562932780059;5834.824955251349;5835.56233282497;5442.482964118402;5450.4549545045975;5479.123340265538;5527.972360138254;5533.253010843565;5600.159976003551;5624.718764061862;5631.436856314418;5651.773929042874;5690.260266165455;5623.212750214973;5626.212330273765;5626.803061892814;5628.409017053233;5631.1271752878365;5444.5916556258435;5451.918221226685;5488.615796894179;5564.137558678412;5678.602497825195;4331.263685173465;4335.046289816235;4337.457817772778;4341.08837144197;4343.587359200871;3858.8456461741216;3915.1190982028816;3916.4321173429694;3918.7256892017285;3924.1955399143108;5339.893202136013;5383.596230282745;5401.7029063401105;5430.945690543123;5443.646162999393;5620.072688006515;5655.208270842086;5665.575081868877;5669.1496275558175;5694.743736531866;5264.15773476242;5394.056040192951;5397.460253974571;5403.621746477787;5435.701036443033;4768.570828625371;4825.420949486084;4826.107170173529;4827.275908613666;4831;5773.047447171254;5816.069428891357;5829.854253643608;5837.357890632027;5837.708114594338;5631.493165615114;5635.549156067586;5637.633553819152;5642.717864106696;5646.265985421869;5834.883302334015;5844.415558444121;5849.0933905243055;5851.882962340815;5860.326062502867;5520.723963801875;5532.640378375393;5534.252875861707;5535.723213839373;5535.723213839373;5494.945050549603;5564.749586268546;5619.719014049199;5620.747066382104;5623;5498.862528436821;5510.504054635102;5536.335639723259;5550.888982220252;5553.916691249554;5530.917036244379;5541.6120871540215;5542.7782888684005;5543.750531226186;5546.833594992157;5388.218708287355;5390.299261096033;5420.05149098914;5428.782848686008;5511.311086114236;5529.806456773994;5538.584606154635;5541.085720856014;5574.609777315549;5600.0759874620235;5415.83752487426;5420.186971954081;5423.322084739408;5424.321959755031;5425.159100339453 21:00:04 INFO - PROCESS | 24301 | |1;ext.html;538.9703566303853;572.2217783814012;576.7087620751521;583.9445252700992;591.2550186764676;30430.99999999997;39658;40671;40777.38833917493;43477.130457390835;42306.788466057704;42644.14711705764;42798.572014279845;42827.35758963618;42840;8581.914180858204;8769.079246679103;8769.868451973194;8770.780730481725;8779.956100219522;7801.492902961318;8004.799880002988;10053.798924021552;10280.383177009366;10302.690919272434;10372.118369938564;10433.373997560133;10439.21705872059;10443.216758743087;10454.163666906667;10366.067053965142;10427.06156445916;10433.686989390331;10454.163666906628;10460.895391046144;9957.253206009505;9997.750056248578;10006;10006.349587276804;10012.697079671716;40445;40603.7969810152;40663.39004914929;40740.79629601833;40814.79592602018;3210.11721776511;3246.5292532582644;3357.8824741133944;3462.87879924204;3608.296382205445;30290.84854575713;30809.383812323853;30821.075367739002;31051.844740776378;32284;4005.239004589119;4094.1402305515876;4109.958900410988;4197.496300443936;4312.849050283225;328031;329755;330369;331033;333058;54902;55231;55315.72342138264;55317.723411382685;55445.72277138589;57155.71422142863;57448;57657.42342576604;57700;57718;15512.301946412439;16027.599310017109;16050.598735031717;16078.356865725475;16078.517644470685;10382.740431489123;12400.875991240153;12487.31319777421;12502.437390317458;12510.311932843599;12068.396580170956;15427.460038898585;15754.448594299145;15805.051696898223;16300.266488008068;5922.378150294243;6021.548383871227;6048.879022419527;6080.111946825311;6120.632762034292;826.6114925984778;896.5472436419566;948.3314263444255;964.2044073664501;964.3972517176765;30148.24629384283;31207.843960780505;31370.37259254802;31682.524762128585;32101.197470063435;987.7678745494803;996.21299173652;1020.6223697231923;1038.3458421194598;1065.504540388723;15828.841711582967;16568.254428550503;16603.796179869507;16625.91687041581;16775.2451139699;435199;437372;437867;438078;438368;45387;53674;55417.16874246889;55457.44542554523;61127;1290.9483620655255;1291.3994992328423;1320.0429688475779;1324.423875614111;1330.8003799429969;30078.881677483776;31920.201994950312;32282.35435291328;32895;33093.50359744654;49903.25145122754;50507.74746126246;50541.49458505368;50557;50653.74673126611;415400;416699;416799;416835;417062;38854.4171837417;39555.2088958225;39801.80099099486;39964.60035399609;40000;43998.560014399445;44724.77637611791;44754.3286850704;45568.772156139006;45765.77117114393;37656.43515347327;38565.22869542649;38848.22303553857;39528.40707389334;40045.79977100096;37745.15142215063;38046.239075218895;39051.80474097725;39276;39480.40779388369;34545.82727086449;35835.46246806248;35915.46126808048;37500.624993750804;38419.42370864384;29522.55716164302;31078.68921310758;32332.35335293328;32341.514877277332;32439;24782;24838.50322993566;25066.498670026864;25314.493710126062;25349.873250633627 21:00:04 INFO - PROCESS | 24301 | |2;jquery.html;369.4587429415905;379.48579674540997;387.1637263510817;395.9326914424548;420.45341056626376;13363.331833408327;14478;16070;18873.62252754944;18944.71582926257;17612.622295990037;18086.638267234648;18190.27238910442;18191;18423.539411514717;4938.950610493894;5161.9741901290445;5163.302954101186;5165.121929272014;5170.3795544534705;4402.141582391435;5018.5232402921665;5520.696361700105;5554.0835762099205;5570.637908535932;5444.972775136119;5482.753276102585;5520.06158952979;5524.530414914737;5526;4822.541858523435;4894.36373271476;4921.704697718148;4926.802927882881;5527.613067085305;4788.664793464459;4789.544993225638;4791.401074865642;4791.760411979422;4792.688475249098;13195.802062969064;13240.20558766477;13466.797998030037;13544.187348759007;13622.93188534061;2186.9273670492985;2595.0268649256527;2652.1910817200746;2807.83153010818;2870.641169853768;9855.753606159831;9876.45679487628;10252.128569071638;10429.843552346721;10694.091002264817;1865.1513561329562;1873.531617095726;1933.806619338069;1936.5545924437458;1955.0811118774154;71732.6413367935;76046.23953760447;76184.99999999945;76686.61656691736;77449;10455.320404173704;10759.78480430387;10775;11039.951204635547;11193.466646008379;15091.396344146331;15205.467808626645;15211.239438028055;15233.542993710207;15252.313645885963;7305.817354566178;7618.923810761932;7653.392787514685;7725.034370703662;7805.853390317595;7300.306470885257;7316.670749816271;7352.19125896151;7538.09542854861;7561.281678240558;4586.656000799887;4672.462666793294;4712.670113092051;4721.126591580569;4722.362481065013;1895.478743345591;1902.2486117983597;1916.492129585661;1934.429343343717;1987.4236471423126;704.2675617357891;814.4543156085437;850.306999795165;896.6054935828215;902.7382059202757;17325.133743312785;18410.35563755262;18556.721649175273;18851.52871178204;18989.24043038263;875.6628697951207;941.9764505887408;959.5825815770162;974.0892265731563;1020.4438580973388;8295.419320647617;10008;10291.485425728684;10376.896231037745;10405.167586593054;378834;400735;406617;414080;414151;83161;84283.57858210792;84753;85500;87578;913.1781396742984;917.738444543302;939.5537119868145;939.7509659940122;946.0823001688351;15848.623280660933;15915.681686366439;16143.596410089842;16778.993260404415;16988.915055424644;37611.62388376191;38021.23957520889;38375.42436863505;38599.42100868433;39547;51607.48392516177;52204;52548.474515254355;52958;53761;7873.803154921173;8126.83746325082;8191.262786349257;8207.95896020516;8453.196946290092;10698.572057117939;12216.938915305367;12245.265284082983;12293.262404255773;12723.172993755376;10738.838917416402;10918.290311129751;10960.397178154959;11101.500432480396;11191.944040279746;5059.06407314648;7584.54492730438;10260.127889129508;10539.314944528582;10807.243492955418;10827.837582436112;11114.166437517057;11116.166287528305;11153.163512736739;11189.328640281608;8230.506169629842;8240.670373185005;8289.668413263644;8399.118092600433;8555.657773689232;9294.860577091484;10775.191860610643;10826.621068262573;10852.782944341227;11236.157288203254 21:00:04 INFO - PROCESS | 24301 | |3;mootools.html;1391.7842734376172;1395.4487977248987;1541.6762479879226;1683.3350826423555;1745.458907738601;7186.820329491766;7400.592967386805;7698.268664476873;8124.431289809716;8151.87772183417;7711;7895.368370530358;7922.366210703144;8139.6744130234865;8144.7556573302745;2164.3398763377204;2192.506685995654;2194.484296190394;2194.8902554872193;2195.4730864592543;1879.3046572768026;1930.9903450482798;2169.370882444089;2201.7688142745023;2235.888205589722;1907.4468404162776;1922.1734654098732;1930.6524825531399;2107.4415279950827;2151.290074275493;2080.209520382245;2084.718562993999;2087.9164833406644;2093.1208892265286;2110.757262914754;2116.0266277512364;2117.650587653051;2139.2726472999097;2156.5147841735643;2164.8809315487642;8057.234562716532;8104.756857294291;8136.267735903797;8144.592770361458;8150.5517196554165;4860.052289803454;5022.045811295879;5025.472325405816;5033.370828646419;5034.244863270502;3078.1535077853546;3299.4226010448315;3315.5026745988052;3356.2951780126205;3391.7795343302605;1008.3748076192734;1043.8173319669027;1044.6448207609449;1046.7278507588082;1120.0535547462382;11052.336859788438;11106.500207490682;11107.278026928223;11108.500117494732;11114.833277500844;4228.809703563347;4502.392177056121;4548.634709950807;4608.861734147981;4644.698094623838;9457.43255404678;9479.90520094804;9493.810123797486;9495.335326527076;9498;5151.5621172200035;5161.200013997836;5161.870953226125;5163.173892177234;5164.9741751291;4571.885702857388;4586.541345865387;4660.34557732007;4729.834455794031;4734.313524538922;3700.4264339027495;3769.4722738816586;3824.6040195328505;3843.7309388342546;3874.2638898609175;1221.151299846598;1222.5537678747194;1235.937094099074;1236.8206610041493;1243.12980913361;789.3448437796615;855.5508358112041;882.2412725056446;893.3835653399134;949.0177666115537;5093.083245015859;5188.066148093304;5304.9734751326;5322.148456246982;5451;433.22452809471326;436.5787015530029;440.04290667797414;958.9856152157723;968.162539403411;3790.5261842269715;3911.706622003361;3946.980265098656;3948.822302996372;4041.818118184689;9592.856107158399;9935.254855885838;9943.850842237372;9947.651832185984;9951.303408761461;9628.422294662343;9689.27330450219;9858.40849549015;9860.140559237883;9862.605495780088;7510.361619262315;7520.887186692204;7648.31165195124;7670.693172273158;7676.462647614725;5449.291592093003;5452;5459.918101228564;5490.862728431821;5590.552755779447;9065.63737450521;9075.682351117679;9125.634974600942;9162.404443711137;9202.493862837608;8479.915200847912;8720.607572659119;8726.520041397784;8942.239909607757;9185;7155.212926578176;7305.159906610807;7330.120385553768;7334.156571994075;7345.926540734525;7539.170691224071;7582.128055273714;7591.658375373232;7597.582132982518;7604.163542010485;6757.7634782784335;6801.9319806801295;6898.068760717239;7019.6841142147705;7038.507304488637;6739.55086233049;6760.256371799196;6794.93205067943;6820.863582728219;6931.722731090902;6221.10507652951;6403.9359606405205;6461.418472337512;6485.513586480938;6578.605283682994;4482.484514280899;4630.606398456034;4662.580367766917;4670.78981445829;4800.879978000578;4442.4669039715445;4491.595756381941;4508.233600287894;4521.457425109008;4531.886702832456 21:00:04 INFO - PROCESS | 24301 | |4;prototype.html;376.3169846728188;379.0769476325147;383.5512450432992;383.77549133756753;389.41198789827354;5184.662996905203;5199.714015729133;5210.2445145453885;5223.686578805269;5270.233127608008;5000.724960127201;5166.225066240066;5236.7119808410525;5237.921431178526;5244.39689435715;4158.6465150462245;4168.541460439349;4190.832366705328;4199.404226393966;4220.26145424551;4138.958610413887;4140.420341152241;4154.916901661965;4156.729812562189;4214.115035842461;4141.62725354718;4168.228502886276;4171.812268447912;4194.748315101088;4199.874003779892;3891.571927088032;4072.9796351018354;4083.1425400665894;4092;4093.5497095319492;3612.8916132516065;3613.9819300903328;3615.9389148185546;3618.7285953553323;3622.855085796565;5138.922916156261;5160.354955630546;5160.432352441228;5161.270974223639;5167;4579.473360563545;4609.354690343354;4635.351050852883;4663.440387153563;4704.788284527204;5374.758135883855;5381.300430943952;5386.569074474032;5425.321834770653;5430.484104010113;3896.688264938798;3912.7065470089856;3914.706397020206;3924.4309575111733;3939.8424063037446;5420.205855900846;5610.69141197234;5621.606487545873;5658.74535645897;5675.9432405675825;4241.554636763157;4269.850555230552;4276.882942943263;4282.957170428318;4286.2284788738325;4317.956820431818;4326.935095973563;4339.284018136972;4344.588753241918;4347.739135651871;4713.9617623269905;4772.856814295576;4795.136875362468;4818.951810481921;4827.324174615556;5481.287432633732;5511.448855114537;5542.667439953535;5600.771417579701;5602.467765562265;1468.3465857693438;1480.592836969842;1481.740520557539;1490.0314795382872;1493.828209755892;1000.7298029532132;1039.3555995282973;1062.9264442912713;1069.3476979042778;1072.790805792863;5144.9742751286;5179.067767801756;5196.4803519648485;5202.2456743771945;5299.470052994747;5440.265564148868;5443.298556981291;5450.781968721207;5453.209284653703;5460.614419060208;4890.1931181355385;5147.433782283946;5172.431032586413;5183.429822719498;5193.195054766517;2889.552119421493;2890.9710902891125;2900.839664134321;2907.636545431821;2937.206954122375;5678.829635110953;5680.097167448951;5687.810193075696;5692.544596432275;5704.515116215085;5258.842234732964;5474.111431556107;5475;5481.561475082063;5528.848556322858;5680.40355762639;5720.399358067426;5846.083124306725;5867.119932010232;5874.471297583067;5664.37691853904;5687.630304030225;5688.54491640676;5706.771729130788;5710.886377156581;5454.754536045967;5580.441955804387;5585.497305242548;5604.439556044363;5640.802571909963;5837.737301821513;5854.970725146517;5860.912086318794;5865.384134665969;5877.294724633071;4229.534751177306;4231.703780735319;4232.619064284229;4237.368613083923;4255;5443.7822487100075;5635.718214089361;5643.35101463337;5650.886982260249;5653.908054020039;5501.367342755634;5506.752196151103;5518.475744804237;5526.734039043973;5549.139883318092;5378.784848606012;5533.695646739468;5538.169274608841;5540.307461567304;5545.445455454423;5412.242286080031;5449.2371068049715;5454.863628409322;5459.918101228405;5461.535769459481;5543.6396634218645;5548.750306236309;5609.971950140223;5643.633163844337;5661.377248502744;5300.639232920434;5463.672179669233;5491.560675146058;5508.972455137859;5509.283793106871 21:00:04 INFO - PROCESS | 24301 | |5;yui.html;659.7921654678777;762.3367670126987;770.1797585571366;783.4437549339968;786.7561056072622;15056.322465489053;15929.44246951357;15992.440264590741;16094.1952902355;16095.59761005974;14070.296485175752;14935.402583896659;14994.775078373834;15122.621934451645;15139.772903406458;790.0282652337628;806.2824086562964;806.6612022950375;808.1958451340925;809.352517985612;678.6606696651675;699.6396855619361;803.6704950970103;806.818465845183;808.0949336742856;731.6817184524722;733.8348871503896;809.6113865344638;840.9285210757093;841.1378337204384;843.42225575481;844.7550210438965;844.7676888855552;845.1168528887297;845.1970627903517;616.824205101544;617.8702472480785;620.3889169168366;621.0063897763587;621.0497938154631;11811.46848391816;12246.142770006103;13826.308684565833;14236.928815355857;14680.385157632652;14594.34325455357;14819.18494482803;14828;15027.924860375737;15110.773338399933;11276.465707002728;11495.367754773484;11520.251183673117;11609.76780464386;11671.12466565011;3716.2753263113705;3727.962720372816;3763.284975854579;3774.452704357853;3781.810909454544;70818.52130688184;74637.62681186559;76793;76800.84798727967;76965.23034769637;11473.713157171138;11484.310941343547;11594.594189203337;11604.419779011016;11921.105917056255;21382.251621193183;21382.893085534473;21384.893075534525;21578.784212157992;21656.891715541322;7618.657160427794;7641.465097443237;7676.731314403969;7902.328302094386;8021.117677055519;4343.305071188658;4391.14372697321;4400.823967041282;4478.104379124188;4524.321351797257;3440.4839274108585;3519.6480351964597;3528.047427194643;3561.216532362876;3564.0555252857494;552.3068548971015;580.1008436922752;598.1685457214476;598.299989012856;600.9969950150308;614.5974386776668;630.8990561510228;704.429412176139;724.5290561135304;738.7857521318865;8422.326213902874;9085.454872707658;9638.9036109638;10364.429956352473;10689;632.5508888689083;684.5721424109931;760.7451503746307;765.7128576783706;772.97681069568;4539.7049191802425;4745.6440766942615;4772.809087636525;4851.708897466164;4857.732824694605;69146.65426672835;69936.30063699298;71272.2872771276;72030.63984680043;72492;63654.36345636577;63885.680571597775;64351.67824160849;64673.67663161654;65090.674546626964;57127.714361428756;57525;58284.41715582875;58527.70736146377;60603.09095363573;9184.678536251198;9230.169284764403;9345.411280082539;9353.906460935303;9368.15686588183;39728.80135599303;40239.597604023584;40516.39225411562;40782.388264176654;41378.1724365517;50304.49695502998;50838.74580627073;54068.45931540634;54236.45763542472;54274.45725542694;10963.232573719763;11097.389643569359;11531.942340288246;11799.233049851731;12584.937075314565;13340.733185336045;13446.126001809851;13476.797848032484;13966.860331396556;14214.360353784312;12403.317817520123;12421.689457763629;13009.739805204032;13091.018173636825;13438.731225375634;12536.561220357244;13017.284049377375;13040.869591304345;13330.866691332962;13420.865791341961;12106.939465302617;12241.632751017483;12484.563040293546;12601.87398126007;12627.30549819732;9999.450030248407;10193.382633753323;10339.076154806491;10587.947060264649;10608.340122657672;9516.666916657883;9733.393989991571;10367.222458315808;10718;10719.142468602337 21:00:04 INFO - PROCESS | 24301 | __end_tp_report 21:00:04 INFO - PROCESS | 24301 | __start_cc_report 21:00:04 INFO - PROCESS | 24301 | _x_x_mozilla_cycle_collect,1109 21:00:04 INFO - PROCESS | 24301 | __end_cc_report 21:00:04 INFO - PROCESS | 24301 | __startTimestamp1481778004779__endTimestamp 21:00:04 INFO - PROCESS | 24301 | 21:00:04 INFO - PROCESS | 24301 | ------- Summary: start ------- 21:00:04 INFO - PROCESS | 24301 | Number of tests: 6 21:00:04 INFO - PROCESS | 24301 | 21:00:04 INFO - PROCESS | 24301 | [#0] dojo.html Cycles:165 Average:5260.72 Median:5435.70 stddev:575.68 (10.6%) stddev-sans-first:550.68 21:00:04 INFO - PROCESS | 24301 | Values: 3048.8 3072.8 3084.9 3103.3 3106.9 5208.2 5231.4 5276.5 5350.4 5357.5 5240.9 5291.2 5304.1 5304.5 5404.3 4814.4 4854.9 4874.7 4880.1 4887.7 4834.9 4950.5 4952.9 4989.6 5023.4 4952.1 4988.9 4996.6 5005.8 5046.2 4755.4 4777.3 4789.5 4825.2 4888.8 4815.4 4824.2 4834.2 4889.1 4894.8 5261.8 5280.9 5297.2 5323.8 5363.5 5465.1 5515.7 5672.8 5680.7 5695.7 5642.2 5728.8 5744.3 5752.9 5783.0 5352.6 5354.1 5355.8 5359.2 5361.8 5579.2 5823.8 5827.6 5834.8 5835.6 5442.5 5450.5 5479.1 5528.0 5533.3 5600.2 5624.7 5631.4 5651.8 5690.3 5623.2 5626.2 5626.8 5628.4 5631.1 5444.6 5451.9 5488.6 5564.1 5678.6 4331.3 4335.0 4337.5 4341.1 4343.6 3858.8 3915.1 3916.4 3918.7 3924.2 5339.9 5383.6 5401.7 5430.9 5443.6 5620.1 5655.2 5665.6 5669.1 5694.7 5264.2 5394.1 5397.5 5403.6 5435.7 4768.6 4825.4 4826.1 4827.3 4831.0 5773.0 5816.1 5829.9 5837.4 5837.7 5631.5 5635.5 5637.6 5642.7 5646.3 5834.9 5844.4 5849.1 5851.9 5860.3 5520.7 5532.6 5534.3 5535.7 5535.7 5494.9 5564.7 5619.7 5620.7 5623.0 5498.9 5510.5 5536.3 5550.9 5553.9 5530.9 5541.6 5542.8 5543.8 5546.8 5388.2 5390.3 5420.1 5428.8 5511.3 5529.8 5538.6 5541.1 5574.6 5600.1 5415.8 5420.2 5423.3 5424.3 5425.2 21:00:04 INFO - PROCESS | 24301 | 21:00:04 INFO - PROCESS | 24301 | [#1] ext.html Cycles:180 Average:55546.60 Median:38953.11 stddev:104883.70 (269.3%) stddev-sans-first:105096.61 21:00:04 INFO - PROCESS | 24301 | Values: 539.0 572.2 576.7 583.9 591.3 30431.0 39658.0 40671.0 40777.4 43477.1 42306.8 42644.1 42798.6 42827.4 42840.0 8581.9 8769.1 8769.9 8770.8 8780.0 7801.5 8004.8 10053.8 10280.4 10302.7 10372.1 10433.4 10439.2 10443.2 10454.2 10366.1 10427.1 10433.7 10454.2 10460.9 9957.3 9997.8 10006.0 10006.3 10012.7 40445.0 40603.8 40663.4 40740.8 40814.8 3210.1 3246.5 3357.9 3462.9 3608.3 30290.8 30809.4 30821.1 31051.8 32284.0 4005.2 4094.1 4110.0 4197.5 4312.8 328031.0 329755.0 330369.0 331033.0 333058.0 54902.0 55231.0 55315.7 55317.7 55445.7 57155.7 57448.0 57657.4 57700.0 57718.0 15512.3 16027.6 16050.6 16078.4 16078.5 10382.7 12400.9 12487.3 12502.4 12510.3 12068.4 15427.5 15754.4 15805.1 16300.3 5922.4 6021.5 6048.9 6080.1 6120.6 826.6 896.5 948.3 964.2 964.4 30148.2 31207.8 31370.4 31682.5 32101.2 987.8 996.2 1020.6 1038.3 1065.5 15828.8 16568.3 16603.8 16625.9 16775.2 435199.0 437372.0 437867.0 438078.0 438368.0 45387.0 53674.0 55417.2 55457.4 61127.0 1290.9 1291.4 1320.0 1324.4 1330.8 30078.9 31920.2 32282.4 32895.0 33093.5 49903.3 50507.7 50541.5 50557.0 50653.7 415400.0 416699.0 416799.0 416835.0 417062.0 38854.4 39555.2 39801.8 39964.6 40000.0 43998.6 44724.8 44754.3 45568.8 45765.8 37656.4 38565.2 38848.2 39528.4 40045.8 37745.2 38046.2 39051.8 39276.0 39480.4 34545.8 35835.5 35915.5 37500.6 38419.4 29522.6 31078.7 32332.4 32341.5 32439.0 24782.0 24838.5 25066.5 25314.5 25349.9 21:00:04 INFO - PROCESS | 24301 | 21:00:04 INFO - PROCESS | 24301 | [#2] jquery.html Cycles:180 Average:25232.22 Median:403676.00 stddev:66792.79 (16.5%) stddev-sans-first:66954.08 21:00:04 INFO - PROCESS | 24301 | Values: 369.5 379.5 387.2 395.9 420.5 13363.3 14478.0 16070.0 18873.6 18944.7 17612.6 18086.6 18190.3 18191.0 18423.5 4939.0 5162.0 5163.3 5165.1 5170.4 4402.1 5018.5 5520.7 5554.1 5570.6 5445.0 5482.8 5520.1 5524.5 5526.0 4822.5 4894.4 4921.7 4926.8 5527.6 4788.7 4789.5 4791.4 4791.8 4792.7 13195.8 13240.2 13466.8 13544.2 13622.9 2186.9 2595.0 2652.2 2807.8 2870.6 9855.8 9876.5 10252.1 10429.8 10694.1 1865.2 1873.5 1933.8 1936.6 1955.1 71732.6 76046.2 76185.0 76686.6 77449.0 10455.3 10759.8 10775.0 11040.0 11193.5 15091.4 15205.5 15211.2 15233.5 15252.3 7305.8 7618.9 7653.4 7725.0 7805.9 7300.3 7316.7 7352.2 7538.1 7561.3 4586.7 4672.5 4712.7 4721.1 4722.4 1895.5 1902.2 1916.5 1934.4 1987.4 704.3 814.5 850.3 896.6 902.7 17325.1 18410.4 18556.7 18851.5 18989.2 875.7 942.0 959.6 974.1 1020.4 8295.4 10008.0 10291.5 10376.9 10405.2 378834.0 400735.0 406617.0 414080.0 414151.0 83161.0 84283.6 84753.0 85500.0 87578.0 913.2 917.7 939.6 939.8 946.1 15848.6 15915.7 16143.6 16779.0 16988.9 37611.6 38021.2 38375.4 38599.4 39547.0 51607.5 52204.0 52548.5 52958.0 53761.0 7873.8 8126.8 8191.3 8208.0 8453.2 10698.6 12216.9 12245.3 12293.3 12723.2 10738.8 10918.3 10960.4 11101.5 11191.9 5059.1 7584.5 10260.1 10539.3 10807.2 10827.8 11114.2 11116.2 11153.2 11189.3 8230.5 8240.7 8289.7 8399.1 8555.7 9294.9 10775.2 10826.6 10852.8 11236.2 21:00:04 INFO - PROCESS | 24301 | 21:00:04 INFO - PROCESS | 24301 | [#3] mootools.html Cycles:180 Average:5297.30 Median:5161.54 stddev:2954.84 (57.2%) stddev-sans-first:2948.55 21:00:04 INFO - PROCESS | 24301 | Values: 1391.8 1395.4 1541.7 1683.3 1745.5 7186.8 7400.6 7698.3 8124.4 8151.9 7711.0 7895.4 7922.4 8139.7 8144.8 2164.3 2192.5 2194.5 2194.9 2195.5 1879.3 1931.0 2169.4 2201.8 2235.9 1907.4 1922.2 1930.7 2107.4 2151.3 2080.2 2084.7 2087.9 2093.1 2110.8 2116.0 2117.7 2139.3 2156.5 2164.9 8057.2 8104.8 8136.3 8144.6 8150.6 4860.1 5022.0 5025.5 5033.4 5034.2 3078.2 3299.4 3315.5 3356.3 3391.8 1008.4 1043.8 1044.6 1046.7 1120.1 11052.3 11106.5 11107.3 11108.5 11114.8 4228.8 4502.4 4548.6 4608.9 4644.7 9457.4 9479.9 9493.8 9495.3 9498.0 5151.6 5161.2 5161.9 5163.2 5165.0 4571.9 4586.5 4660.3 4729.8 4734.3 3700.4 3769.5 3824.6 3843.7 3874.3 1221.2 1222.6 1235.9 1236.8 1243.1 789.3 855.6 882.2 893.4 949.0 5093.1 5188.1 5305.0 5322.1 5451.0 433.2 436.6 440.0 959.0 968.2 3790.5 3911.7 3947.0 3948.8 4041.8 9592.9 9935.3 9943.9 9947.7 9951.3 9628.4 9689.3 9858.4 9860.1 9862.6 7510.4 7520.9 7648.3 7670.7 7676.5 5449.3 5452.0 5459.9 5490.9 5590.6 9065.6 9075.7 9125.6 9162.4 9202.5 8479.9 8720.6 8726.5 8942.2 9185.0 7155.2 7305.2 7330.1 7334.2 7345.9 7539.2 7582.1 7591.7 7597.6 7604.2 6757.8 6801.9 6898.1 7019.7 7038.5 6739.6 6760.3 6794.9 6820.9 6931.7 6221.1 6403.9 6461.4 6485.5 6578.6 4482.5 4630.6 4662.6 4670.8 4800.9 4442.5 4491.6 4508.2 4521.5 4531.9 21:00:04 INFO - PROCESS | 24301 | 21:00:04 INFO - PROCESS | 24301 | [#4] prototype.html Cycles:180 Average:4645.92 Median:5198.10 stddev:1323.71 (25.5%) stddev-sans-first:1288.05 21:00:04 INFO - PROCESS | 24301 | Values: 376.3 379.1 383.6 383.8 389.4 5184.7 5199.7 5210.2 5223.7 5270.2 5000.7 5166.2 5236.7 5237.9 5244.4 4158.6 4168.5 4190.8 4199.4 4220.3 4139.0 4140.4 4154.9 4156.7 4214.1 4141.6 4168.2 4171.8 4194.7 4199.9 3891.6 4073.0 4083.1 4092.0 4093.5 3612.9 3614.0 3615.9 3618.7 3622.9 5138.9 5160.4 5160.4 5161.3 5167.0 4579.5 4609.4 4635.4 4663.4 4704.8 5374.8 5381.3 5386.6 5425.3 5430.5 3896.7 3912.7 3914.7 3924.4 3939.8 5420.2 5610.7 5621.6 5658.7 5675.9 4241.6 4269.9 4276.9 4283.0 4286.2 4318.0 4326.9 4339.3 4344.6 4347.7 4714.0 4772.9 4795.1 4819.0 4827.3 5481.3 5511.4 5542.7 5600.8 5602.5 1468.3 1480.6 1481.7 1490.0 1493.8 1000.7 1039.4 1062.9 1069.3 1072.8 5145.0 5179.1 5196.5 5202.2 5299.5 5440.3 5443.3 5450.8 5453.2 5460.6 4890.2 5147.4 5172.4 5183.4 5193.2 2889.6 2891.0 2900.8 2907.6 2937.2 5678.8 5680.1 5687.8 5692.5 5704.5 5258.8 5474.1 5475.0 5481.6 5528.8 5680.4 5720.4 5846.1 5867.1 5874.5 5664.4 5687.6 5688.5 5706.8 5710.9 5454.8 5580.4 5585.5 5604.4 5640.8 5837.7 5855.0 5860.9 5865.4 5877.3 4229.5 4231.7 4232.6 4237.4 4255.0 5443.8 5635.7 5643.4 5650.9 5653.9 5501.4 5506.8 5518.5 5526.7 5549.1 5378.8 5533.7 5538.2 5540.3 5545.4 5412.2 5449.2 5454.9 5459.9 5461.5 5543.6 5548.8 5610.0 5643.6 5661.4 5300.6 5463.7 5491.6 5509.0 5509.3 21:00:04 INFO - PROCESS | 24301 | 21:00:04 INFO - PROCESS | 24301 | [#5] yui.html Cycles:180 Average:16656.97 Median:4759.23 stddev:20896.54 (439.1%) stddev-sans-first:20920.63 21:00:04 INFO - PROCESS | 24301 | Values: 659.8 762.3 770.2 783.4 786.8 15056.3 15929.4 15992.4 16094.2 16095.6 14070.3 14935.4 14994.8 15122.6 15139.8 790.0 806.3 806.7 808.2 809.4 678.7 699.6 803.7 806.8 808.1 731.7 733.8 809.6 840.9 841.1 843.4 844.8 844.8 845.1 845.2 616.8 617.9 620.4 621.0 621.0 11811.5 12246.1 13826.3 14236.9 14680.4 14594.3 14819.2 14828.0 15027.9 15110.8 11276.5 11495.4 11520.3 11609.8 11671.1 3716.3 3728.0 3763.3 3774.5 3781.8 70818.5 74637.6 76793.0 76800.8 76965.2 11473.7 11484.3 11594.6 11604.4 11921.1 21382.3 21382.9 21384.9 21578.8 21656.9 7618.7 7641.5 7676.7 7902.3 8021.1 4343.3 4391.1 4400.8 4478.1 4524.3 3440.5 3519.6 3528.0 3561.2 3564.1 552.3 580.1 598.2 598.3 601.0 614.6 630.9 704.4 724.5 738.8 8422.3 9085.5 9638.9 10364.4 10689.0 632.6 684.6 760.7 765.7 773.0 4539.7 4745.6 4772.8 4851.7 4857.7 69146.7 69936.3 71272.3 72030.6 72492.0 63654.4 63885.7 64351.7 64673.7 65090.7 57127.7 57525.0 58284.4 58527.7 60603.1 9184.7 9230.2 9345.4 9353.9 9368.2 39728.8 40239.6 40516.4 40782.4 41378.2 50304.5 50838.7 54068.5 54236.5 54274.5 10963.2 11097.4 11531.9 11799.2 12584.9 13340.7 13446.1 13476.8 13966.9 14214.4 12403.3 12421.7 13009.7 13091.0 13438.7 12536.6 13017.3 13040.9 13330.9 13420.9 12106.9 12241.6 12484.6 12601.9 12627.3 9999.5 10193.4 10339.1 10587.9 10608.3 9516.7 9733.4 10367.2 10718.0 10719.1 21:00:04 INFO - PROCESS | 24301 | -------- Summary: end -------- 21:00:04 INFO - PROCESS | 24301 | 21:00:05 INFO - TEST-INFO | 24301: exit 0 21:00:05 INFO - TEST-OK | dromaeo_css | took 1118097ms 21:00:05 INFO - TEST-START | kraken 21:00:05 INFO - operating with platform_type : linux_ 21:00:05 INFO - Initialising browser for kraken test... 21:00:05 INFO - TEST-INFO | started process 24604 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaTJROa/profile http://localhost:55668/getInfo.html) 21:00:10 INFO - PROCESS | 24604 | __metrics Screen width/height:1600/1200 21:00:10 INFO - PROCESS | 24604 | colorDepth:24 21:00:10 INFO - PROCESS | 24604 | Browser inner width/height: 1024/697 21:00:10 INFO - PROCESS | 24604 | __metrics 21:00:10 INFO - PROCESS | 24604 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:00:10 INFO - PROCESS | 24604 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:00:11 INFO - PROCESS | 24604 | console.error: PushService: 21:00:11 INFO - PROCESS | 24604 | stateChangeProcessEnqueue: Error transitioning state 21:00:11 INFO - PROCESS | 24604 | UnknownError 21:00:12 INFO - TEST-INFO | 24604: exit 0 21:00:12 INFO - Browser initialized. 21:00:12 INFO - Running cycle 1/1 for kraken test... 21:00:12 INFO - TEST-INFO | started process 24687 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaTJROa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:00:24 INFO - PROCESS | 24687 | RSS: Main: 172015616 21:00:24 INFO - PROCESS | 24687 | 21:00:27 INFO - PROCESS | 24687 | Cycle 1(1): loaded http://localhost:55668/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55668/tests/kraken/driver.html?testName=audio-beat-detection) 21:00:28 INFO - PROCESS | 24687 | RSS: Main: 230858752 21:00:28 INFO - PROCESS | 24687 | 21:00:30 INFO - PROCESS | 24687 | Cycle 1(1): loaded http://localhost:55668/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55668/tests/kraken/driver.html?testName=audio-dft) 21:00:31 INFO - PROCESS | 24687 | RSS: Main: 217239552 21:00:31 INFO - PROCESS | 24687 | 21:00:34 INFO - PROCESS | 24687 | Cycle 1(1): loaded http://localhost:55668/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55668/tests/kraken/driver.html?testName=audio-fft) 21:00:34 INFO - PROCESS | 24687 | RSS: Main: 298983424 21:00:34 INFO - PROCESS | 24687 | 21:00:36 INFO - PROCESS | 24687 | Cycle 1(1): loaded http://localhost:55668/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55668/tests/kraken/driver.html?testName=audio-oscillator) 21:00:37 INFO - PROCESS | 24687 | RSS: Main: 209141760 21:00:37 INFO - PROCESS | 24687 | 21:00:39 INFO - PROCESS | 24687 | Cycle 1(1): loaded http://localhost:55668/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55668/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:00:40 INFO - PROCESS | 24687 | RSS: Main: 214130688 21:00:40 INFO - PROCESS | 24687 | 21:00:43 INFO - PROCESS | 24687 | Cycle 1(1): loaded http://localhost:55668/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55668/tests/kraken/driver.html?testName=imaging-darkroom) 21:00:44 INFO - PROCESS | 24687 | RSS: Main: 253337600 21:00:44 INFO - PROCESS | 24687 | 21:00:47 INFO - PROCESS | 24687 | Cycle 1(1): loaded http://localhost:55668/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55668/tests/kraken/driver.html?testName=imaging-desaturate) 21:00:47 INFO - PROCESS | 24687 | RSS: Main: 253493248 21:00:47 INFO - PROCESS | 24687 | 21:00:50 INFO - PROCESS | 24687 | Cycle 1(1): loaded http://localhost:55668/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55668/tests/kraken/driver.html?testName=json-parse-financial) 21:00:51 INFO - PROCESS | 24687 | RSS: Main: 252108800 21:00:51 INFO - PROCESS | 24687 | 21:00:52 INFO - PROCESS | 24687 | Cycle 1(1): loaded http://localhost:55668/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55668/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:00:53 INFO - PROCESS | 24687 | RSS: Main: 214114304 21:00:53 INFO - PROCESS | 24687 | 21:00:55 INFO - PROCESS | 24687 | Cycle 1(1): loaded http://localhost:55668/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55668/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:00:55 INFO - PROCESS | 24687 | RSS: Main: 221954048 21:00:55 INFO - PROCESS | 24687 | 21:00:57 INFO - PROCESS | 24687 | Cycle 1(1): loaded http://localhost:55668/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55668/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:00:58 INFO - PROCESS | 24687 | RSS: Main: 229879808 21:00:58 INFO - PROCESS | 24687 | 21:01:01 INFO - PROCESS | 24687 | Cycle 1(1): loaded http://localhost:55668/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55668/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:01:02 INFO - PROCESS | 24687 | RSS: Main: 239321088 21:01:02 INFO - PROCESS | 24687 | 21:01:04 INFO - PROCESS | 24687 | Cycle 1(1): loaded http://localhost:55668/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55668/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:01:05 INFO - PROCESS | 24687 | RSS: Main: 235794432 21:01:05 INFO - PROCESS | 24687 | 21:01:07 INFO - PROCESS | 24687 | Cycle 1(1): loaded http://localhost:55668/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55668/tests/kraken/driver.html?testName=ai-astar) 21:01:07 INFO - PROCESS | 24687 | RSS: Main: 287256576 21:01:07 INFO - PROCESS | 24687 | 21:01:07 INFO - PROCESS | 24687 | __start_tp_report 21:01:07 INFO - PROCESS | 24687 | _x_x_mozilla_page_load 21:01:07 INFO - PROCESS | 24687 | _x_x_mozilla_page_load_details 21:01:07 INFO - PROCESS | 24687 | |i|pagename|runs| 21:01:07 INFO - PROCESS | 24687 | |0;ai-astar;111;116;113;111;113;112;112;113;112;111 21:01:07 INFO - PROCESS | 24687 | |1;audio-beat-detection;149;130;129;169;133;128;123;127;142;126 21:01:07 INFO - PROCESS | 24687 | |2;audio-dft;163;161;162;161;161;162;163;161;162;162 21:01:07 INFO - PROCESS | 24687 | |3;audio-fft;76;78;77;108;76;76;75;77;89;75 21:01:07 INFO - PROCESS | 24687 | |4;audio-oscillator;85;84;100;84;90;83;102;83;83;110 21:01:07 INFO - PROCESS | 24687 | |5;imaging-gaussian-blur;127;127;127;127;127;127;127;126;126;127 21:01:07 INFO - PROCESS | 24687 | |6;imaging-darkroom;147;147;147;147;147;148;148;147;147;147 21:01:07 INFO - PROCESS | 24687 | |7;imaging-desaturate;95;95;95;96;95;95;96;96;96;95 21:01:07 INFO - PROCESS | 24687 | |8;json-parse-financial;53;52;51;61;53;53;52;53;51;53 21:01:07 INFO - PROCESS | 24687 | |9;json-stringify-tinderbox;65;64;64;65;64;70;64;65;64;65 21:01:07 INFO - PROCESS | 24687 | |10;stanford-crypto-aes;84;87;81;81;80;81;80;81;86;85 21:01:07 INFO - PROCESS | 24687 | |11;stanford-crypto-ccm;139;135;133;130;142;138;132;132;186;155 21:01:07 INFO - PROCESS | 24687 | |12;stanford-crypto-pbkdf2;171;168;167;167;171;167;166;165;166;166 21:01:07 INFO - PROCESS | 24687 | |13;stanford-crypto-sha256-iterative;65;66;64;64;64;64;64;63;63;63 21:01:07 INFO - PROCESS | 24687 | __end_tp_report 21:01:07 INFO - PROCESS | 24687 | __start_cc_report 21:01:07 INFO - PROCESS | 24687 | _x_x_mozilla_cycle_collect,1721 21:01:07 INFO - PROCESS | 24687 | __end_cc_report 21:01:07 INFO - PROCESS | 24687 | __startTimestamp1481778067357__endTimestamp 21:01:07 INFO - PROCESS | 24687 | 21:01:07 INFO - PROCESS | 24687 | ------- Summary: start ------- 21:01:07 INFO - PROCESS | 24687 | Number of tests: 14 21:01:07 INFO - PROCESS | 24687 | 21:01:07 INFO - PROCESS | 24687 | [#0] ai-astar Cycles:10 Average:112.40 Median:112.50 stddev:1.51 (1.3%) stddev-sans-first:1.51 21:01:07 INFO - PROCESS | 24687 | Values: 111.0 116.0 113.0 111.0 113.0 112.0 112.0 113.0 112.0 111.0 21:01:07 INFO - PROCESS | 24687 | 21:01:07 INFO - PROCESS | 24687 | [#1] audio-beat-detection Cycles:10 Average:135.60 Median:131.50 stddev:14.14 (10.8%) stddev-sans-first:14.15 21:01:07 INFO - PROCESS | 24687 | Values: 149.0 130.0 129.0 169.0 133.0 128.0 123.0 127.0 142.0 126.0 21:01:07 INFO - PROCESS | 24687 | 21:01:07 INFO - PROCESS | 24687 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:0.79 (0.5%) stddev-sans-first:0.71 21:01:07 INFO - PROCESS | 24687 | Values: 163.0 161.0 162.0 161.0 161.0 162.0 163.0 161.0 162.0 162.0 21:01:07 INFO - PROCESS | 24687 | 21:01:07 INFO - PROCESS | 24687 | [#3] audio-fft Cycles:10 Average:80.70 Median:76.50 stddev:10.44 (13.6%) stddev-sans-first:10.93 21:01:07 INFO - PROCESS | 24687 | Values: 76.0 78.0 77.0 108.0 76.0 76.0 75.0 77.0 89.0 75.0 21:01:07 INFO - PROCESS | 24687 | 21:01:07 INFO - PROCESS | 24687 | [#4] audio-oscillator Cycles:10 Average:90.40 Median:83.50 stddev:9.92 (11.9%) stddev-sans-first:10.33 21:01:07 INFO - PROCESS | 24687 | Values: 85.0 84.0 100.0 84.0 90.0 83.0 102.0 83.0 83.0 110.0 21:01:07 INFO - PROCESS | 24687 | 21:01:07 INFO - PROCESS | 24687 | [#5] imaging-gaussian-blur Cycles:10 Average:126.80 Median:127.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 21:01:07 INFO - PROCESS | 24687 | Values: 127.0 127.0 127.0 127.0 127.0 127.0 127.0 126.0 126.0 127.0 21:01:07 INFO - PROCESS | 24687 | 21:01:07 INFO - PROCESS | 24687 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 21:01:07 INFO - PROCESS | 24687 | Values: 147.0 147.0 147.0 147.0 147.0 148.0 148.0 147.0 147.0 147.0 21:01:07 INFO - PROCESS | 24687 | 21:01:07 INFO - PROCESS | 24687 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 21:01:07 INFO - PROCESS | 24687 | Values: 95.0 95.0 95.0 96.0 95.0 95.0 96.0 96.0 96.0 95.0 21:01:07 INFO - PROCESS | 24687 | 21:01:07 INFO - PROCESS | 24687 | [#8] json-parse-financial Cycles:10 Average:53.20 Median:53.00 stddev:2.86 (5.4%) stddev-sans-first:3.03 21:01:07 INFO - PROCESS | 24687 | Values: 53.0 52.0 51.0 61.0 53.0 53.0 52.0 53.0 51.0 53.0 21:01:07 INFO - PROCESS | 24687 | 21:01:07 INFO - PROCESS | 24687 | [#9] json-stringify-tinderbox Cycles:10 Average:65.00 Median:65.00 stddev:1.83 (2.8%) stddev-sans-first:1.94 21:01:07 INFO - PROCESS | 24687 | Values: 65.0 64.0 64.0 65.0 64.0 70.0 64.0 65.0 64.0 65.0 21:01:07 INFO - PROCESS | 24687 | 21:01:07 INFO - PROCESS | 24687 | [#10] stanford-crypto-aes Cycles:10 Average:82.60 Median:82.50 stddev:2.63 (3.2%) stddev-sans-first:2.74 21:01:07 INFO - PROCESS | 24687 | Values: 84.0 87.0 81.0 81.0 80.0 81.0 80.0 81.0 86.0 85.0 21:01:07 INFO - PROCESS | 24687 | 21:01:07 INFO - PROCESS | 24687 | [#11] stanford-crypto-ccm Cycles:10 Average:142.20 Median:138.50 stddev:17.01 (12.3%) stddev-sans-first:18.00 21:01:07 INFO - PROCESS | 24687 | Values: 139.0 135.0 133.0 130.0 142.0 138.0 132.0 132.0 186.0 155.0 21:01:07 INFO - PROCESS | 24687 | 21:01:07 INFO - PROCESS | 24687 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.40 Median:167.00 stddev:2.07 (1.2%) stddev-sans-first:1.73 21:01:07 INFO - PROCESS | 24687 | Values: 171.0 168.0 167.0 167.0 171.0 167.0 166.0 165.0 166.0 166.0 21:01:07 INFO - PROCESS | 24687 | 21:01:07 INFO - PROCESS | 24687 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.00 Median:64.00 stddev:0.94 (1.5%) stddev-sans-first:0.93 21:01:07 INFO - PROCESS | 24687 | Values: 65.0 66.0 64.0 64.0 64.0 64.0 64.0 63.0 63.0 63.0 21:01:07 INFO - PROCESS | 24687 | -------- Summary: end -------- 21:01:07 INFO - PROCESS | 24687 | 21:01:08 INFO - TEST-INFO | 24687: exit 0 21:01:08 INFO - TEST-OK | kraken | took 62888ms 21:01:08 INFO - SUITE-END | took 1180s 21:01:09 INFO - Completed test suite (00:19:41) 21:01:09 INFO - javascript benchmark 21:01:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3048.847557622119, 3072.800267982582, 3084.9383012339754, 3103.317270200555, 3106.9378612427754, 5208.218767184924, 5231.398389185245, 5276.472352764727, 5350.384705758839, 5357.491038351355, 5240.895182096356, 5291.2327712481665, 5304.071787437193, 5304.469553044693, 5404.32445944257, 4814.446338671045, 4854.87862803431, 4874.731889746063, 4880.072786170634, 4887.706737595738, 4834.9033019339595, 4950.480199579047, 4952.900941981158, 4989.57588604969, 5023.397192336906, 4952.0838644850455, 4988.925166122511, 4996.5503104720565, 5005.824796132118, 5046.243063540462, 4755.405574303212, 4777.259524773665, 4789.521047895182, 4825.1555977703765, 4888.755562221874, 4815.422149342066, 4824.155772739757, 4834.178189707758, 4889.119958407486, 4894.828680996148, 5261.842144735664, 5280.867978300535, 5297.231901374279, 5323.813666521653, 5363.517283444469, 5465.07093794056, 5515.696636684981, 5672.829815105553, 5680.715964201773, 5695.658260504383, 5642.153676948449, 5728.79949201776, 5744.281964754406, 5752.884942301131, 5782.97108514459, 5352.625316227865, 5354.143337066051, 5355.785768569292, 5359.196120581866, 5361.81233656824, 5579.191017302468, 5823.82528524145, 5827.562932780059, 5834.824955251349, 5835.56233282497, 5442.482964118402, 5450.4549545045975, 5479.123340265538, 5527.972360138254, 5533.253010843565, 5600.159976003551, 5624.718764061862, 5631.436856314418, 5651.773929042874, 5690.260266165455, 5623.212750214973, 5626.212330273765, 5626.803061892814, 5628.409017053233, 5631.1271752878365, 5444.5916556258435, 5451.918221226685, 5488.615796894179, 5564.137558678412, 5678.602497825195, 4331.263685173465, 4335.046289816235, 4337.457817772778, 4341.08837144197, 4343.587359200871, 3858.8456461741216, 3915.1190982028816, 3916.4321173429694, 3918.7256892017285, 3924.1955399143108, 5339.893202136013, 5383.596230282745, 5401.7029063401105, 5430.945690543123, 5443.646162999393, 5620.072688006515, 5655.208270842086, 5665.575081868877, 5669.1496275558175, 5694.743736531866, 5264.15773476242, 5394.056040192951, 5397.460253974571, 5403.621746477787, 5435.701036443033, 4768.570828625371, 4825.420949486084, 4826.107170173529, 4827.275908613666, 4831.0, 5773.047447171254, 5816.069428891357, 5829.854253643608, 5837.357890632027, 5837.708114594338, 5631.493165615114, 5635.549156067586, 5637.633553819152, 5642.717864106696, 5646.265985421869, 5834.883302334015, 5844.415558444121, 5849.0933905243055, 5851.882962340815, 5860.326062502867, 5520.723963801875, 5532.640378375393, 5534.252875861707, 5535.723213839373, 5535.723213839373, 5494.945050549603, 5564.749586268546, 5619.719014049199, 5620.747066382104, 5623.0, 5498.862528436821, 5510.504054635102, 5536.335639723259, 5550.888982220252, 5553.916691249554, 5530.917036244379, 5541.6120871540215, 5542.7782888684005, 5543.750531226186, 5546.833594992157, 5388.218708287355, 5390.299261096033, 5420.05149098914, 5428.782848686008, 5511.311086114236, 5529.806456773994, 5538.584606154635, 5541.085720856014, 5574.609777315549, 5600.0759874620235, 5415.83752487426, 5420.186971954081, 5423.322084739408, 5424.321959755031, 5425.159100339453], "value": 5222.963950663381, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [538.9703566303853, 572.2217783814012, 576.7087620751521, 583.9445252700992, 591.2550186764676, 30430.99999999997, 39658.0, 40671.0, 40777.38833917493, 43477.130457390835, 42306.788466057704, 42644.14711705764, 42798.572014279845, 42827.35758963618, 42840.0, 8581.914180858204, 8769.079246679103, 8769.868451973194, 8770.780730481725, 8779.956100219522, 7801.492902961318, 8004.799880002988, 10053.798924021552, 10280.383177009366, 10302.690919272434, 10372.118369938564, 10433.373997560133, 10439.21705872059, 10443.216758743087, 10454.163666906667, 10366.067053965142, 10427.06156445916, 10433.686989390331, 10454.163666906628, 10460.895391046144, 9957.253206009505, 9997.750056248578, 10006.0, 10006.349587276804, 10012.697079671716, 40445.0, 40603.7969810152, 40663.39004914929, 40740.79629601833, 40814.79592602018, 3210.11721776511, 3246.5292532582644, 3357.8824741133944, 3462.87879924204, 3608.296382205445, 30290.84854575713, 30809.383812323853, 30821.075367739002, 31051.844740776378, 32284.0, 4005.239004589119, 4094.1402305515876, 4109.958900410988, 4197.496300443936, 4312.849050283225, 328031.0, 329755.0, 330369.0, 331033.0, 333058.0, 54902.0, 55231.0, 55315.72342138264, 55317.723411382685, 55445.72277138589, 57155.71422142863, 57448.0, 57657.42342576604, 57700.0, 57718.0, 15512.301946412439, 16027.599310017109, 16050.598735031717, 16078.356865725475, 16078.517644470685, 10382.740431489123, 12400.875991240153, 12487.31319777421, 12502.437390317458, 12510.311932843599, 12068.396580170956, 15427.460038898585, 15754.448594299145, 15805.051696898223, 16300.266488008068, 5922.378150294243, 6021.548383871227, 6048.879022419527, 6080.111946825311, 6120.632762034292, 826.6114925984778, 896.5472436419566, 948.3314263444255, 964.2044073664501, 964.3972517176765, 30148.24629384283, 31207.843960780505, 31370.37259254802, 31682.524762128585, 32101.197470063435, 987.7678745494803, 996.21299173652, 1020.6223697231923, 1038.3458421194598, 1065.504540388723, 15828.841711582967, 16568.254428550503, 16603.796179869507, 16625.91687041581, 16775.2451139699, 435199.0, 437372.0, 437867.0, 438078.0, 438368.0, 45387.0, 53674.0, 55417.16874246889, 55457.44542554523, 61127.0, 1290.9483620655255, 1291.3994992328423, 1320.0429688475779, 1324.423875614111, 1330.8003799429969, 30078.881677483776, 31920.201994950312, 32282.35435291328, 32895.0, 33093.50359744654, 49903.25145122754, 50507.74746126246, 50541.49458505368, 50557.0, 50653.74673126611, 415400.0, 416699.0, 416799.0, 416835.0, 417062.0, 38854.4171837417, 39555.2088958225, 39801.80099099486, 39964.60035399609, 40000.0, 43998.560014399445, 44724.77637611791, 44754.3286850704, 45568.772156139006, 45765.77117114393, 37656.43515347327, 38565.22869542649, 38848.22303553857, 39528.40707389334, 40045.79977100096, 37745.15142215063, 38046.239075218895, 39051.80474097725, 39276.0, 39480.40779388369, 34545.82727086449, 35835.46246806248, 35915.46126808048, 37500.624993750804, 38419.42370864384, 29522.55716164302, 31078.68921310758, 32332.35335293328, 32341.514877277332, 32439.0, 24782.0, 24838.50322993566, 25066.498670026864, 25314.493710126062, 25349.873250633627], "value": 19366.302955950134, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [369.4587429415905, 379.48579674540997, 387.1637263510817, 395.9326914424548, 420.45341056626376, 13363.331833408327, 14478.0, 16070.0, 18873.62252754944, 18944.71582926257, 17612.622295990037, 18086.638267234648, 18190.27238910442, 18191.0, 18423.539411514717, 4938.950610493894, 5161.9741901290445, 5163.302954101186, 5165.121929272014, 5170.3795544534705, 4402.141582391435, 5018.5232402921665, 5520.696361700105, 5554.0835762099205, 5570.637908535932, 5444.972775136119, 5482.753276102585, 5520.06158952979, 5524.530414914737, 5526.0, 4822.541858523435, 4894.36373271476, 4921.704697718148, 4926.802927882881, 5527.613067085305, 4788.664793464459, 4789.544993225638, 4791.401074865642, 4791.760411979422, 4792.688475249098, 13195.802062969064, 13240.20558766477, 13466.797998030037, 13544.187348759007, 13622.93188534061, 2186.9273670492985, 2595.0268649256527, 2652.1910817200746, 2807.83153010818, 2870.641169853768, 9855.753606159831, 9876.45679487628, 10252.128569071638, 10429.843552346721, 10694.091002264817, 1865.1513561329562, 1873.531617095726, 1933.806619338069, 1936.5545924437458, 1955.0811118774154, 71732.6413367935, 76046.23953760447, 76184.99999999945, 76686.61656691736, 77449.0, 10455.320404173704, 10759.78480430387, 10775.0, 11039.951204635547, 11193.466646008379, 15091.396344146331, 15205.467808626645, 15211.239438028055, 15233.542993710207, 15252.313645885963, 7305.817354566178, 7618.923810761932, 7653.392787514685, 7725.034370703662, 7805.853390317595, 7300.306470885257, 7316.670749816271, 7352.19125896151, 7538.09542854861, 7561.281678240558, 4586.656000799887, 4672.462666793294, 4712.670113092051, 4721.126591580569, 4722.362481065013, 1895.478743345591, 1902.2486117983597, 1916.492129585661, 1934.429343343717, 1987.4236471423126, 704.2675617357891, 814.4543156085437, 850.306999795165, 896.6054935828215, 902.7382059202757, 17325.133743312785, 18410.35563755262, 18556.721649175273, 18851.52871178204, 18989.24043038263, 875.6628697951207, 941.9764505887408, 959.5825815770162, 974.0892265731563, 1020.4438580973388, 8295.419320647617, 10008.0, 10291.485425728684, 10376.896231037745, 10405.167586593054, 378834.0, 400735.0, 406617.0, 414080.0, 414151.0, 83161.0, 84283.57858210792, 84753.0, 85500.0, 87578.0, 913.1781396742984, 917.738444543302, 939.5537119868145, 939.7509659940122, 946.0823001688351, 15848.623280660933, 15915.681686366439, 16143.596410089842, 16778.993260404415, 16988.915055424644, 37611.62388376191, 38021.23957520889, 38375.42436863505, 38599.42100868433, 39547.0, 51607.48392516177, 52204.0, 52548.474515254355, 52958.0, 53761.0, 7873.803154921173, 8126.83746325082, 8191.262786349257, 8207.95896020516, 8453.196946290092, 10698.572057117939, 12216.938915305367, 12245.265284082983, 12293.262404255773, 12723.172993755376, 10738.838917416402, 10918.290311129751, 10960.397178154959, 11101.500432480396, 11191.944040279746, 5059.06407314648, 7584.54492730438, 10260.127889129508, 10539.314944528582, 10807.243492955418, 10827.837582436112, 11114.166437517057, 11116.166287528305, 11153.163512736739, 11189.328640281608, 8230.506169629842, 8240.670373185005, 8289.668413263644, 8399.118092600433, 8555.657773689232, 9294.860577091484, 10775.191860610643, 10826.621068262573, 10852.782944341227, 11236.157288203254], "value": 8472.649652173226, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1391.7842734376172, 1395.4487977248987, 1541.6762479879226, 1683.3350826423555, 1745.458907738601, 7186.820329491766, 7400.592967386805, 7698.268664476873, 8124.431289809716, 8151.87772183417, 7711.0, 7895.368370530358, 7922.366210703144, 8139.6744130234865, 8144.7556573302745, 2164.3398763377204, 2192.506685995654, 2194.484296190394, 2194.8902554872193, 2195.4730864592543, 1879.3046572768026, 1930.9903450482798, 2169.370882444089, 2201.7688142745023, 2235.888205589722, 1907.4468404162776, 1922.1734654098732, 1930.6524825531399, 2107.4415279950827, 2151.290074275493, 2080.209520382245, 2084.718562993999, 2087.9164833406644, 2093.1208892265286, 2110.757262914754, 2116.0266277512364, 2117.650587653051, 2139.2726472999097, 2156.5147841735643, 2164.8809315487642, 8057.234562716532, 8104.756857294291, 8136.267735903797, 8144.592770361458, 8150.5517196554165, 4860.052289803454, 5022.045811295879, 5025.472325405816, 5033.370828646419, 5034.244863270502, 3078.1535077853546, 3299.4226010448315, 3315.5026745988052, 3356.2951780126205, 3391.7795343302605, 1008.3748076192734, 1043.8173319669027, 1044.6448207609449, 1046.7278507588082, 1120.0535547462382, 11052.336859788438, 11106.500207490682, 11107.278026928223, 11108.500117494732, 11114.833277500844, 4228.809703563347, 4502.392177056121, 4548.634709950807, 4608.861734147981, 4644.698094623838, 9457.43255404678, 9479.90520094804, 9493.810123797486, 9495.335326527076, 9498.0, 5151.5621172200035, 5161.200013997836, 5161.870953226125, 5163.173892177234, 5164.9741751291, 4571.885702857388, 4586.541345865387, 4660.34557732007, 4729.834455794031, 4734.313524538922, 3700.4264339027495, 3769.4722738816586, 3824.6040195328505, 3843.7309388342546, 3874.2638898609175, 1221.151299846598, 1222.5537678747194, 1235.937094099074, 1236.8206610041493, 1243.12980913361, 789.3448437796615, 855.5508358112041, 882.2412725056446, 893.3835653399134, 949.0177666115537, 5093.083245015859, 5188.066148093304, 5304.9734751326, 5322.148456246982, 5451.0, 433.22452809471326, 436.5787015530029, 440.04290667797414, 958.9856152157723, 968.162539403411, 3790.5261842269715, 3911.706622003361, 3946.980265098656, 3948.822302996372, 4041.818118184689, 9592.856107158399, 9935.254855885838, 9943.850842237372, 9947.651832185984, 9951.303408761461, 9628.422294662343, 9689.27330450219, 9858.40849549015, 9860.140559237883, 9862.605495780088, 7510.361619262315, 7520.887186692204, 7648.31165195124, 7670.693172273158, 7676.462647614725, 5449.291592093003, 5452.0, 5459.918101228564, 5490.862728431821, 5590.552755779447, 9065.63737450521, 9075.682351117679, 9125.634974600942, 9162.404443711137, 9202.493862837608, 8479.915200847912, 8720.607572659119, 8726.520041397784, 8942.239909607757, 9185.0, 7155.212926578176, 7305.159906610807, 7330.120385553768, 7334.156571994075, 7345.926540734525, 7539.170691224071, 7582.128055273714, 7591.658375373232, 7597.582132982518, 7604.163542010485, 6757.7634782784335, 6801.9319806801295, 6898.068760717239, 7019.6841142147705, 7038.507304488637, 6739.55086233049, 6760.256371799196, 6794.93205067943, 6820.863582728219, 6931.722731090902, 6221.10507652951, 6403.9359606405205, 6461.418472337512, 6485.513586480938, 6578.605283682994, 4482.484514280899, 4630.606398456034, 4662.580367766917, 4670.78981445829, 4800.879978000578, 4442.4669039715445, 4491.595756381941, 4508.233600287894, 4521.457425109008, 4531.886702832456], "value": 4241.273097374133, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.3169846728188, 379.0769476325147, 383.5512450432992, 383.77549133756753, 389.41198789827354, 5184.662996905203, 5199.714015729133, 5210.2445145453885, 5223.686578805269, 5270.233127608008, 5000.724960127201, 5166.225066240066, 5236.7119808410525, 5237.921431178526, 5244.39689435715, 4158.6465150462245, 4168.541460439349, 4190.832366705328, 4199.404226393966, 4220.26145424551, 4138.958610413887, 4140.420341152241, 4154.916901661965, 4156.729812562189, 4214.115035842461, 4141.62725354718, 4168.228502886276, 4171.812268447912, 4194.748315101088, 4199.874003779892, 3891.571927088032, 4072.9796351018354, 4083.1425400665894, 4092.0, 4093.5497095319492, 3612.8916132516065, 3613.9819300903328, 3615.9389148185546, 3618.7285953553323, 3622.855085796565, 5138.922916156261, 5160.354955630546, 5160.432352441228, 5161.270974223639, 5167.0, 4579.473360563545, 4609.354690343354, 4635.351050852883, 4663.440387153563, 4704.788284527204, 5374.758135883855, 5381.300430943952, 5386.569074474032, 5425.321834770653, 5430.484104010113, 3896.688264938798, 3912.7065470089856, 3914.706397020206, 3924.4309575111733, 3939.8424063037446, 5420.205855900846, 5610.69141197234, 5621.606487545873, 5658.74535645897, 5675.9432405675825, 4241.554636763157, 4269.850555230552, 4276.882942943263, 4282.957170428318, 4286.2284788738325, 4317.956820431818, 4326.935095973563, 4339.284018136972, 4344.588753241918, 4347.739135651871, 4713.9617623269905, 4772.856814295576, 4795.136875362468, 4818.951810481921, 4827.324174615556, 5481.287432633732, 5511.448855114537, 5542.667439953535, 5600.771417579701, 5602.467765562265, 1468.3465857693438, 1480.592836969842, 1481.740520557539, 1490.0314795382872, 1493.828209755892, 1000.7298029532132, 1039.3555995282973, 1062.9264442912713, 1069.3476979042778, 1072.790805792863, 5144.9742751286, 5179.067767801756, 5196.4803519648485, 5202.2456743771945, 5299.470052994747, 5440.265564148868, 5443.298556981291, 5450.781968721207, 5453.209284653703, 5460.614419060208, 4890.1931181355385, 5147.433782283946, 5172.431032586413, 5183.429822719498, 5193.195054766517, 2889.552119421493, 2890.9710902891125, 2900.839664134321, 2907.636545431821, 2937.206954122375, 5678.829635110953, 5680.097167448951, 5687.810193075696, 5692.544596432275, 5704.515116215085, 5258.842234732964, 5474.111431556107, 5475.0, 5481.561475082063, 5528.848556322858, 5680.40355762639, 5720.399358067426, 5846.083124306725, 5867.119932010232, 5874.471297583067, 5664.37691853904, 5687.630304030225, 5688.54491640676, 5706.771729130788, 5710.886377156581, 5454.754536045967, 5580.441955804387, 5585.497305242548, 5604.439556044363, 5640.802571909963, 5837.737301821513, 5854.970725146517, 5860.912086318794, 5865.384134665969, 5877.294724633071, 4229.534751177306, 4231.703780735319, 4232.619064284229, 4237.368613083923, 4255.0, 5443.7822487100075, 5635.718214089361, 5643.35101463337, 5650.886982260249, 5653.908054020039, 5501.367342755634, 5506.752196151103, 5518.475744804237, 5526.734039043973, 5549.139883318092, 5378.784848606012, 5533.695646739468, 5538.169274608841, 5540.307461567304, 5545.445455454423, 5412.242286080031, 5449.2371068049715, 5454.863628409322, 5459.918101228405, 5461.535769459481, 5543.6396634218645, 5548.750306236309, 5609.971950140223, 5643.633163844337, 5661.377248502744, 5300.639232920434, 5463.672179669233, 5491.560675146058, 5508.972455137859, 5509.283793106871], "value": 4245.786278313807, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [659.7921654678777, 762.3367670126987, 770.1797585571366, 783.4437549339968, 786.7561056072622, 15056.322465489053, 15929.44246951357, 15992.440264590741, 16094.1952902355, 16095.59761005974, 14070.296485175752, 14935.402583896659, 14994.775078373834, 15122.621934451645, 15139.772903406458, 790.0282652337628, 806.2824086562964, 806.6612022950375, 808.1958451340925, 809.352517985612, 678.6606696651675, 699.6396855619361, 803.6704950970103, 806.818465845183, 808.0949336742856, 731.6817184524722, 733.8348871503896, 809.6113865344638, 840.9285210757093, 841.1378337204384, 843.42225575481, 844.7550210438965, 844.7676888855552, 845.1168528887297, 845.1970627903517, 616.824205101544, 617.8702472480785, 620.3889169168366, 621.0063897763587, 621.0497938154631, 11811.46848391816, 12246.142770006103, 13826.308684565833, 14236.928815355857, 14680.385157632652, 14594.34325455357, 14819.18494482803, 14828.0, 15027.924860375737, 15110.773338399933, 11276.465707002728, 11495.367754773484, 11520.251183673117, 11609.76780464386, 11671.12466565011, 3716.2753263113705, 3727.962720372816, 3763.284975854579, 3774.452704357853, 3781.810909454544, 70818.52130688184, 74637.62681186559, 76793.0, 76800.84798727967, 76965.23034769637, 11473.713157171138, 11484.310941343547, 11594.594189203337, 11604.419779011016, 11921.105917056255, 21382.251621193183, 21382.893085534473, 21384.893075534525, 21578.784212157992, 21656.891715541322, 7618.657160427794, 7641.465097443237, 7676.731314403969, 7902.328302094386, 8021.117677055519, 4343.305071188658, 4391.14372697321, 4400.823967041282, 4478.104379124188, 4524.321351797257, 3440.4839274108585, 3519.6480351964597, 3528.047427194643, 3561.216532362876, 3564.0555252857494, 552.3068548971015, 580.1008436922752, 598.1685457214476, 598.299989012856, 600.9969950150308, 614.5974386776668, 630.8990561510228, 704.429412176139, 724.5290561135304, 738.7857521318865, 8422.326213902874, 9085.454872707658, 9638.9036109638, 10364.429956352473, 10689.0, 632.5508888689083, 684.5721424109931, 760.7451503746307, 765.7128576783706, 772.97681069568, 4539.7049191802425, 4745.6440766942615, 4772.809087636525, 4851.708897466164, 4857.732824694605, 69146.65426672835, 69936.30063699298, 71272.2872771276, 72030.63984680043, 72492.0, 63654.36345636577, 63885.680571597775, 64351.67824160849, 64673.67663161654, 65090.674546626964, 57127.714361428756, 57525.0, 58284.41715582875, 58527.70736146377, 60603.09095363573, 9184.678536251198, 9230.169284764403, 9345.411280082539, 9353.906460935303, 9368.15686588183, 39728.80135599303, 40239.597604023584, 40516.39225411562, 40782.388264176654, 41378.1724365517, 50304.49695502998, 50838.74580627073, 54068.45931540634, 54236.45763542472, 54274.45725542694, 10963.232573719763, 11097.389643569359, 11531.942340288246, 11799.233049851731, 12584.937075314565, 13340.733185336045, 13446.126001809851, 13476.797848032484, 13966.860331396556, 14214.360353784312, 12403.317817520123, 12421.689457763629, 13009.739805204032, 13091.018173636825, 13438.731225375634, 12536.561220357244, 13017.284049377375, 13040.869591304345, 13330.866691332962, 13420.865791341961, 12106.939465302617, 12241.632751017483, 12484.563040293546, 12601.87398126007, 12627.30549819732, 9999.450030248407, 10193.382633753323, 10339.076154806491, 10587.947060264649, 10608.340122657672, 9516.666916657883, 9733.393989991571, 10367.222458315808, 10718.0, 10719.142468602337], "value": 6961.279942225316, "unit": "score"}], "name": "dromaeo_css", "value": 6894.912176824776, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 116.0, 113.0, 111.0, 113.0, 112.0, 112.0, 113.0, 112.0, 111.0], "value": 112.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 130.0, 129.0, 169.0, 133.0, 128.0, 123.0, 127.0, 142.0, 126.0], "value": 135.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 162.0, 161.0, 161.0, 162.0, 163.0, 161.0, 162.0, 162.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 78.0, 77.0, 108.0, 76.0, 76.0, 75.0, 77.0, 89.0, 75.0], "value": 80.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 100.0, 84.0, 90.0, 83.0, 102.0, 83.0, 83.0, 110.0], "value": 90.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 127.0, 127.0, 127.0, 127.0, 127.0, 127.0, 126.0, 126.0, 127.0], "value": 126.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 147.0, 147.0, 148.0, 148.0, 147.0, 147.0, 147.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 51.0, 61.0, 53.0, 53.0, 52.0, 53.0, 51.0, 53.0], "value": 53.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 64.0, 65.0, 64.0, 70.0, 64.0, 65.0, 64.0, 65.0], "value": 65.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 87.0, 81.0, 81.0, 80.0, 81.0, 80.0, 81.0, 86.0, 85.0], "value": 82.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 135.0, 133.0, 130.0, 142.0, 138.0, 132.0, 132.0, 186.0, 155.0], "value": 142.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 168.0, 167.0, 167.0, 171.0, 167.0, 166.0, 165.0, 166.0, 166.0], "value": 167.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 64.0, 64.0, 64.0, 64.0, 64.0, 63.0, 63.0, 63.0], "value": 64.0, "unit": "score"}], "name": "kraken", "value": 1524.7, "alertThreshold": 2.0}]} 21:01:09 INFO - Return code: 0 21:01:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:01:09 INFO - # TBPL SUCCESS # 21:01:09 INFO - Running post-action listener: _resource_record_post_action 21:01:09 INFO - [mozharness: 2016-12-15 05:01:09.150781Z] Finished run-tests step (success) 21:01:09 INFO - Running post-run listener: _resource_record_post_run 21:01:09 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 397631488; Read time: 16; Write time: 402496 21:01:09 INFO - TinderboxPrint: CPU usage
13.2% 21:01:09 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 21:01:09 INFO - TinderboxPrint: I/O write bytes / time
397,631,488 / 402,496 21:01:09 INFO - TinderboxPrint: CPU idle
8,296.1 (86.8%) 21:01:09 INFO - TinderboxPrint: CPU user
1,209.8 (12.7%) 21:01:09 INFO - TinderboxPrint: Swap in / out
0 / 0 21:01:09 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 105824256; Read time: 0; Write time: 144792 21:01:09 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 0; Write bytes: 288231424; Read time: 0; Write time: 257292 21:01:09 INFO - Running post-run listener: _upload_blobber_files 21:01:09 INFO - Blob upload gear active. 21:01:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:01:09 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 21:01:09 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'] 21:01:09 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 21:01:10 INFO - (blobuploader) - INFO - Open directory for files ... 21:01:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:01:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:01:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:01:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:01:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:01:11 INFO - (blobuploader) - INFO - Done attempting. 21:01:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:01:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:01:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:01:15 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:01:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:01:15 INFO - (blobuploader) - INFO - Done attempting. 21:01:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:01:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:01:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:01:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:01:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:01:15 INFO - (blobuploader) - INFO - Done attempting. 21:01:15 INFO - (blobuploader) - INFO - Iteration through files over. 21:01:15 INFO - Return code: 0 21:01:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:01:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:01:15 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f9b84443377db0bd19b8588fbc32954a486ee1c811a5fbde53682402c8984760fe4e5449217af90494c28b030c15a7813fc73ab79dc6443399e9c688f90f9a2f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f288387dc81831acb2f61f6e5e26d75f1c5ef8c3cfe25f8eb662100303a35aa9140814f79f82cf73c135321f2e545870544b75f22c8346a344c22d89da8fad78", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2187dce0ad1d91a33a38d0409f9395b3dec9fafd011758fd6899b3f1ab4145599d625aa8d554e79bc961e19485c237d9c18a35ff29aa5372d6f5db91da10dcdf"} 21:01:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:01:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:01:15 INFO - Contents: 21:01:15 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f9b84443377db0bd19b8588fbc32954a486ee1c811a5fbde53682402c8984760fe4e5449217af90494c28b030c15a7813fc73ab79dc6443399e9c688f90f9a2f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f288387dc81831acb2f61f6e5e26d75f1c5ef8c3cfe25f8eb662100303a35aa9140814f79f82cf73c135321f2e545870544b75f22c8346a344c22d89da8fad78", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2187dce0ad1d91a33a38d0409f9395b3dec9fafd011758fd6899b3f1ab4145599d625aa8d554e79bc961e19485c237d9c18a35ff29aa5372d6f5db91da10dcdf"} 21:01:15 INFO - Running post-run listener: copy_logs_to_upload_dir 21:01:15 INFO - Copying logs to upload dir... 21:01:15 INFO - mkdir: /builds/slave/test/build/upload/logs 21:01:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.552324 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-12-14 21:01:14.294337) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-14 21:01:14.297545) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1481776834.777213-229459152 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f9b84443377db0bd19b8588fbc32954a486ee1c811a5fbde53682402c8984760fe4e5449217af90494c28b030c15a7813fc73ab79dc6443399e9c688f90f9a2f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f288387dc81831acb2f61f6e5e26d75f1c5ef8c3cfe25f8eb662100303a35aa9140814f79f82cf73c135321f2e545870544b75f22c8346a344c22d89da8fad78", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2187dce0ad1d91a33a38d0409f9395b3dec9fafd011758fd6899b3f1ab4145599d625aa8d554e79bc961e19485c237d9c18a35ff29aa5372d6f5db91da10dcdf"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481769487/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011699 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481769487/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f9b84443377db0bd19b8588fbc32954a486ee1c811a5fbde53682402c8984760fe4e5449217af90494c28b030c15a7813fc73ab79dc6443399e9c688f90f9a2f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f288387dc81831acb2f61f6e5e26d75f1c5ef8c3cfe25f8eb662100303a35aa9140814f79f82cf73c135321f2e545870544b75f22c8346a344c22d89da8fad78", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2187dce0ad1d91a33a38d0409f9395b3dec9fafd011758fd6899b3f1ab4145599d625aa8d554e79bc961e19485c237d9c18a35ff29aa5372d6f5db91da10dcdf"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-14 21:01:14.323498) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-14 21:01:14.323853) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1481776834.777213-229459152 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004484 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-14 21:01:14.409259) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-14 21:01:14.409668) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-14 21:01:14.409992) ========= ========= Total master_lag: 0.15 =========