builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-033 starttime: 1481652109.42 results: success (0) buildid: 20161213091200 builduid: ace1b13492f34da99303ec294fac7598 revision: 489f981e8c2beb050d7faee956dd940431bdafe6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-13 10:01:49.415764) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-13 10:01:49.416344) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-13 10:01:49.416705) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-13 10:01:49.434148) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-13 10:01:49.434663) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1481651706.286370-1723659657 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-13 10:01:49-- 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% 223M=0s 2016-12-13 10:01:49 (223 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.115417 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-13 10:01:49.569102) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-13 10:01:49.569440) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1481651706.286370-1723659657 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021223 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-13 10:01:49.618835) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-13 10:01:49.619188) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 489f981e8c2beb050d7faee956dd940431bdafe6 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 489f981e8c2beb050d7faee956dd940431bdafe6 --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=edae0fb5fee9fb758e8af6d3000002a4-1481651706.286370-1723659657 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-13 10:01:49,978 truncating revision to first 12 chars 2016-12-13 10:01:49,978 Setting DEBUG logging. 2016-12-13 10:01:49,979 attempt 1/10 2016-12-13 10:01:49,979 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/489f981e8c2b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-13 10:01:50,769 unpacking tar archive at: mozilla-central-489f981e8c2b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.097774 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-13 10:01:50.730749) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-13 10:01:50.731074) ========= script_repo_revision: 489f981e8c2beb050d7faee956dd940431bdafe6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-13 10:01:50.731493) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-13 10:01:50.731773) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-13 10:01:50.741431) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-12-13 10:01:50.741764) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=edae0fb5fee9fb758e8af6d3000002a4-1481651706.286370-1723659657 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:01:51 INFO - MultiFileLogger online at 20161213 10:01:51 in /builds/slave/test 10:01:51 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 10:01:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:01:51 INFO - {'append_to_log': False, 10:01:51 INFO - 'base_work_dir': '/builds/slave/test', 10:01:51 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 10:01:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:01:51 INFO - 'branch': 'Firefox-Non-PGO', 10:01:51 INFO - 'buildbot_json_path': 'buildprops.json', 10:01:51 INFO - 'config_files': ('talos/linux_config.py',), 10:01:51 INFO - 'default_actions': ('clobber', 10:01:51 INFO - 'read-buildbot-config', 10:01:51 INFO - 'download-and-extract', 10:01:51 INFO - 'populate-webroot', 10:01:51 INFO - 'create-virtualenv', 10:01:51 INFO - 'install', 10:01:51 INFO - 'run-tests'), 10:01:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:01:51 INFO - 'download_minidump_stackwalk': True, 10:01:51 INFO - 'download_symbols': 'ondemand', 10:01:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:01:51 INFO - 'tooltool.py': '/tools/tooltool.py', 10:01:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:01:51 INFO - '/tools/misc-python/virtualenv.py')}, 10:01:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:01:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:01:51 INFO - 'installer_path': 'installer.exe', 10:01:51 INFO - 'log_level': 'info', 10:01:51 INFO - 'log_name': 'talos', 10:01:51 INFO - 'log_to_console': True, 10:01:51 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:01:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:01:51 INFO - 'opt_config_files': (), 10:01:51 INFO - 'pip_index': False, 10:01:51 INFO - 'sps_profile': False, 10:01:51 INFO - 'sps_profile_interval': 0, 10:01:51 INFO - 'suite': 'dromaeojs', 10:01:51 INFO - 'system_bits': '32', 10:01:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:01:51 INFO - 'title': 'talos-linux64-ix-033', 10:01:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:01:51 INFO - 'use_talos_json': True, 10:01:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:01:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:01:51 INFO - 'work_dir': 'build'} 10:01:51 INFO - [mozharness: 2016-12-13 18:01:51.205057Z] Running clobber step. 10:01:51 INFO - Running pre-action listener: _resource_record_pre_action 10:01:51 INFO - Running main action method: clobber 10:01:51 INFO - rmtree: /builds/slave/test/build 10:01:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:01:52 INFO - Running post-action listener: _resource_record_post_action 10:01:52 INFO - [mozharness: 2016-12-13 18:01:52.184123Z] Finished clobber step (success) 10:01:52 INFO - [mozharness: 2016-12-13 18:01:52.184222Z] Running read-buildbot-config step. 10:01:52 INFO - Running pre-action listener: _resource_record_pre_action 10:01:52 INFO - Running main action method: read_buildbot_config 10:01:52 INFO - Using buildbot properties: 10:01:52 INFO - { 10:01:52 INFO - "project": "", 10:01:52 INFO - "product": "firefox", 10:01:52 INFO - "script_repo_revision": "production", 10:01:52 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 10:01:52 INFO - "repository": "", 10:01:52 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 10:01:52 INFO - "buildid": "20161213091200", 10:01:52 INFO - "pgo_build": "False", 10:01:52 INFO - "basedir": "/builds/slave/test", 10:01:52 INFO - "buildnumber": 868, 10:01:52 INFO - "slavename": "talos-linux64-ix-033", 10:01:52 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:01:52 INFO - "platform": "ubuntu64_hw", 10:01:52 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 10:01:52 INFO - "branch": "mozilla-central", 10:01:52 INFO - "repo_path": "mozilla-central", 10:01:52 INFO - "revision": "489f981e8c2beb050d7faee956dd940431bdafe6", 10:01:52 INFO - "stage_platform": "linux64", 10:01:52 INFO - "builduid": "ace1b13492f34da99303ec294fac7598", 10:01:52 INFO - "slavebuilddir": "test" 10:01:52 INFO - } 10:01:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/HdFBkxqyReGQ0JCq6xL_mA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 10:01:52 INFO - Running post-action listener: _resource_record_post_action 10:01:52 INFO - [mozharness: 2016-12-13 18:01:52.186653Z] Finished read-buildbot-config step (success) 10:01:52 INFO - [mozharness: 2016-12-13 18:01:52.186741Z] Running download-and-extract step. 10:01:52 INFO - Running pre-action listener: _resource_record_pre_action 10:01:52 INFO - Running main action method: download_and_extract 10:01:52 INFO - mkdir: /builds/slave/test/build/tests 10:01:52 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')]} 10:01:52 INFO - trying https://queue.taskcluster.net/v1/task/HdFBkxqyReGQ0JCq6xL_mA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 10:01:52 INFO - Downloading https://queue.taskcluster.net/v1/task/HdFBkxqyReGQ0JCq6xL_mA/artifacts/public/build/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 10:01:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HdFBkxqyReGQ0JCq6xL_mA/artifacts/public/build/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 10:01:52 INFO - Downloaded 1361 bytes. 10:01:52 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 10:01:52 INFO - Using the following test package requirements: 10:01:52 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 10:01:52 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 10:01:52 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:01:52 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 10:01:52 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:01:52 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 10:01:52 INFO - u'jsshell-linux-x86_64.zip'], 10:01:52 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 10:01:52 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:01:52 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 10:01:52 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 10:01:52 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:01:52 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 10:01:52 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:01:52 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 10:01:52 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:01:52 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 10:01:52 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:01:52 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:01:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HdFBkxqyReGQ0JCq6xL_mA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 10:01:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HdFBkxqyReGQ0JCq6xL_mA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:01:52 INFO - Fetch https://queue.taskcluster.net/v1/task/HdFBkxqyReGQ0JCq6xL_mA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 10:01:53 INFO - Expected file size: 20211493 10:01:53 INFO - Obtained file size: 20211493 10:01:57 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 10:01:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HdFBkxqyReGQ0JCq6xL_mA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 10:01:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HdFBkxqyReGQ0JCq6xL_mA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:01:57 INFO - Fetch https://queue.taskcluster.net/v1/task/HdFBkxqyReGQ0JCq6xL_mA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 10:01:58 INFO - Expected file size: 20211493 10:01:58 INFO - Obtained file size: 20211493 10:02:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HdFBkxqyReGQ0JCq6xL_mA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 10:02:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HdFBkxqyReGQ0JCq6xL_mA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:02:03 INFO - Fetch https://queue.taskcluster.net/v1/task/HdFBkxqyReGQ0JCq6xL_mA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 10:02:03 INFO - Expected file size: 14409734 10:02:03 INFO - Obtained file size: 14409734 10:02:04 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')]} 10:02:04 INFO - trying https://queue.taskcluster.net/v1/task/HdFBkxqyReGQ0JCq6xL_mA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 10:02:04 INFO - Downloading https://queue.taskcluster.net/v1/task/HdFBkxqyReGQ0JCq6xL_mA/artifacts/public/build/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 10:02:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HdFBkxqyReGQ0JCq6xL_mA/artifacts/public/build/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 10:02:06 INFO - Downloaded 55767840 bytes. 10:02:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HdFBkxqyReGQ0JCq6xL_mA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 10:02:06 INFO - mkdir: /builds/slave/test/properties 10:02:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:02:06 INFO - Writing to file /builds/slave/test/properties/build_url 10:02:06 INFO - Contents: 10:02:06 INFO - build_url:https://queue.taskcluster.net/v1/task/HdFBkxqyReGQ0JCq6xL_mA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 10:02:07 INFO - Running post-action listener: _resource_record_post_action 10:02:07 INFO - Running post-action listener: set_extra_try_arguments 10:02:07 INFO - [mozharness: 2016-12-13 18:02:07.166140Z] Finished download-and-extract step (success) 10:02:07 INFO - [mozharness: 2016-12-13 18:02:07.166366Z] Running populate-webroot step. 10:02:07 INFO - Running pre-action listener: _resource_record_pre_action 10:02:07 INFO - Running main action method: populate_webroot 10:02:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:02:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:02:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:02:07 INFO - '--tppagecycles', 10:02:07 INFO - '7'], 10:02:07 INFO - 'tests': ['tsvgm']}}, 10:02:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:02:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:02:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:02:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:02:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:02:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:02:07 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 10:02:07 INFO - 'talos_options': ['--disable-e10s'], 10:02:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:02:07 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 10:02:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:02:07 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 10:02:07 INFO - 'talos_options': ['--disable-e10s'], 10:02:07 INFO - 'tests': ['damp', 'tps']}, 10:02:07 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 10:02:07 INFO - 'tests': ['damp', 'tps']}, 10:02:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:02:07 INFO - 'tests': ['dromaeo_dom']}, 10:02:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:02:07 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:02:07 INFO - 'tests': ['basic_compositor_video']}, 10:02:07 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:02:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:02:07 INFO - 'tests': ['a11yr', 10:02:07 INFO - 'ts_paint', 10:02:07 INFO - 'tpaint', 10:02:07 INFO - 'sessionrestore', 10:02:07 INFO - 'sessionrestore_no_auto_restore', 10:02:07 INFO - 'tabpaint']}, 10:02:07 INFO - 'other-e10s': {'tests': ['a11yr', 10:02:07 INFO - 'ts_paint', 10:02:07 INFO - 'tpaint', 10:02:07 INFO - 'sessionrestore', 10:02:07 INFO - 'sessionrestore_no_auto_restore', 10:02:07 INFO - 'tabpaint']}, 10:02:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:02:07 INFO - 'ts_paint', 10:02:07 INFO - 'tpaint', 10:02:07 INFO - 'sessionrestore', 10:02:07 INFO - 'sessionrestore_no_auto_restore', 10:02:07 INFO - 'tabpaint']}, 10:02:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:02:07 INFO - 'ts_paint', 10:02:07 INFO - 'tpaint', 10:02:07 INFO - 'sessionrestore', 10:02:07 INFO - 'sessionrestore_no_auto_restore', 10:02:07 INFO - 'tabpaint']}, 10:02:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:02:07 INFO - 'tests': ['a11yr', 10:02:07 INFO - 'ts_paint', 10:02:07 INFO - 'tpaint', 10:02:07 INFO - 'sessionrestore', 10:02:07 INFO - 'sessionrestore_no_auto_restore', 10:02:07 INFO - 'tabpaint']}, 10:02:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:02:07 INFO - 'tests': ['a11yr', 10:02:07 INFO - 'ts_paint', 10:02:07 INFO - 'tpaint', 10:02:07 INFO - 'sessionrestore', 10:02:07 INFO - 'sessionrestore_no_auto_restore', 10:02:07 INFO - 'tabpaint']}, 10:02:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:02:07 INFO - 'tests': ['tsvgx', 10:02:07 INFO - 'tsvgr_opacity', 10:02:07 INFO - 'tart', 10:02:07 INFO - 'tscrollx', 10:02:07 INFO - 'cart', 10:02:07 INFO - 'tsvg_static']}, 10:02:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:02:07 INFO - 'tsvgr_opacity', 10:02:07 INFO - 'tart', 10:02:07 INFO - 'tscrollx', 10:02:07 INFO - 'cart', 10:02:07 INFO - 'tsvg_static']}, 10:02:07 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 10:02:07 INFO - 'talos_options': ['--disable-e10s'], 10:02:07 INFO - 'tests': ['tp5o']}, 10:02:07 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 10:02:07 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 10:02:07 INFO - 'talos_options': ['--disable-e10s', 10:02:07 INFO - '--xperf_path', 10:02:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:02:07 INFO - 'tests': ['tp5n']}, 10:02:07 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 10:02:07 INFO - 'talos_options': ['--xperf_path', 10:02:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:02:07 INFO - 'tests': ['tp5n']}}, 10:02:07 INFO - 'talos.zip': {'path': '', 10:02:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:02:07 INFO - Running post-action listener: _resource_record_post_action 10:02:07 INFO - [mozharness: 2016-12-13 18:02:07.183894Z] Finished populate-webroot step (success) 10:02:07 INFO - [mozharness: 2016-12-13 18:02:07.183982Z] Running create-virtualenv step. 10:02:07 INFO - Running pre-action listener: _resource_record_pre_action 10:02:07 INFO - Running main action method: create_virtualenv 10:02:07 INFO - Creating virtualenv /builds/slave/test/build/venv 10:02:07 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 10:02:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:02:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:02:07 INFO - Using real prefix '/usr' 10:02:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:02:07 INFO - Installing distribute.............................................................................................................................................................................................done. 10:02:09 INFO - Installing pip.................done. 10:02:09 INFO - Return code: 0 10:02:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:02:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:02:09 INFO - Reading from file tmpfile_stdout 10:02:09 INFO - Output received: 10:02:09 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) 10:02:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:02: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')]} 10:02:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02: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')]} 10:02:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1cb60c6e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c39a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd7120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e67f20>, '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 0x1dd4c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd4f90>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1481651706.286370-1723659657', '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 10:02: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', 'pip>=1.5'] in /builds/slave/test/build 10:02: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 pip>=1.5 10:02:09 INFO - Using env: {'DISPLAY': ':0', 10:02:09 INFO - 'HOME': '/home/cltbld', 10:02:09 INFO - 'LANG': 'en_US.UTF-8', 10:02:09 INFO - 'LANGUAGE': 'en_US:en', 10:02:09 INFO - 'LOGNAME': 'cltbld', 10:02:09 INFO - 'MAIL': '/var/mail/cltbld', 10:02:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:09 INFO - 'MOZ_NO_REMOTE': '1', 10:02:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:02:09 INFO - 'NO_EM_RESTART': '1', 10:02:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:02:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:09 INFO - 'PWD': '/builds/slave/test', 10:02:09 INFO - 'SHELL': '/bin/bash', 10:02:09 INFO - 'SHLVL': '1', 10:02:09 INFO - 'TERM': 'linux', 10:02:09 INFO - 'TMOUT': '86400', 10:02:09 INFO - 'USER': 'cltbld', 10:02:09 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1481651706.286370-1723659657', 10:02:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:09 INFO - '_': '/tools/buildbot/bin/python'} 10:02:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:10 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 10:02:10 INFO - Cleaning up... 10:02:10 INFO - Return code: 0 10:02:10 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:02:10 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')]} 10:02:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:10 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')]} 10:02:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:10 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 0x7f1cb60c6e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c39a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd7120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e67f20>, '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 0x1dd4c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd4f90>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1481651706.286370-1723659657', '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 10:02:10 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 10:02:10 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 10:02:10 INFO - Using env: {'DISPLAY': ':0', 10:02:10 INFO - 'HOME': '/home/cltbld', 10:02:10 INFO - 'LANG': 'en_US.UTF-8', 10:02:10 INFO - 'LANGUAGE': 'en_US:en', 10:02:10 INFO - 'LOGNAME': 'cltbld', 10:02:10 INFO - 'MAIL': '/var/mail/cltbld', 10:02:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:10 INFO - 'MOZ_NO_REMOTE': '1', 10:02:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:02:10 INFO - 'NO_EM_RESTART': '1', 10:02:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:02:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:10 INFO - 'PWD': '/builds/slave/test', 10:02:10 INFO - 'SHELL': '/bin/bash', 10:02:10 INFO - 'SHLVL': '1', 10:02:10 INFO - 'TERM': 'linux', 10:02:10 INFO - 'TMOUT': '86400', 10:02:10 INFO - 'USER': 'cltbld', 10:02:10 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1481651706.286370-1723659657', 10:02:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:10 INFO - '_': '/tools/buildbot/bin/python'} 10:02:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:10 INFO - Downloading/unpacking psutil>=3.1.1 10:02:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:02:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:02:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:02:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:02:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:02:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:02:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:02:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:02:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:02:12 INFO - Installing collected packages: psutil 10:02:12 INFO - Running setup.py install for psutil 10:02:12 INFO - building 'psutil._psutil_linux' extension 10:02:12 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 10:02:12 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 10:02:12 INFO - building 'psutil._psutil_posix' extension 10:02:12 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 10:02:12 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 10:02:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:02:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:02:12 INFO - Successfully installed psutil 10:02:12 INFO - Cleaning up... 10:02:13 INFO - Return code: 0 10:02:13 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:02:13 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')]} 10:02:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:13 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')]} 10:02:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:13 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 0x7f1cb60c6e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c39a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd7120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e67f20>, '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 0x1dd4c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd4f90>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1481651706.286370-1723659657', '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 10:02:13 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 10:02:13 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 10:02:13 INFO - Using env: {'DISPLAY': ':0', 10:02:13 INFO - 'HOME': '/home/cltbld', 10:02:13 INFO - 'LANG': 'en_US.UTF-8', 10:02:13 INFO - 'LANGUAGE': 'en_US:en', 10:02:13 INFO - 'LOGNAME': 'cltbld', 10:02:13 INFO - 'MAIL': '/var/mail/cltbld', 10:02:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:13 INFO - 'MOZ_NO_REMOTE': '1', 10:02:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:02:13 INFO - 'NO_EM_RESTART': '1', 10:02:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:02:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:13 INFO - 'PWD': '/builds/slave/test', 10:02:13 INFO - 'SHELL': '/bin/bash', 10:02:13 INFO - 'SHLVL': '1', 10:02:13 INFO - 'TERM': 'linux', 10:02:13 INFO - 'TMOUT': '86400', 10:02:13 INFO - 'USER': 'cltbld', 10:02:13 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1481651706.286370-1723659657', 10:02:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:13 INFO - '_': '/tools/buildbot/bin/python'} 10:02:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:13 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:02:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:02:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:02:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:02:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:02:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:02:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:02:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:02:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:02:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:02:15 INFO - Installing collected packages: mozsystemmonitor 10:02:15 INFO - Running setup.py install for mozsystemmonitor 10:02:15 INFO - Successfully installed mozsystemmonitor 10:02:15 INFO - Cleaning up... 10:02:15 INFO - Return code: 0 10:02:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:02:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:02:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:02:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f1cb60c6e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c39a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd7120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e67f20>, '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 0x1dd4c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd4f90>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1481651706.286370-1723659657', '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 10:02:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:02:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:02:15 INFO - Using env: {'DISPLAY': ':0', 10:02:15 INFO - 'HOME': '/home/cltbld', 10:02:15 INFO - 'LANG': 'en_US.UTF-8', 10:02:15 INFO - 'LANGUAGE': 'en_US:en', 10:02:15 INFO - 'LOGNAME': 'cltbld', 10:02:15 INFO - 'MAIL': '/var/mail/cltbld', 10:02:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:15 INFO - 'MOZ_NO_REMOTE': '1', 10:02:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:02:15 INFO - 'NO_EM_RESTART': '1', 10:02:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:02:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:15 INFO - 'PWD': '/builds/slave/test', 10:02:15 INFO - 'SHELL': '/bin/bash', 10:02:15 INFO - 'SHLVL': '1', 10:02:15 INFO - 'TERM': 'linux', 10:02:15 INFO - 'TMOUT': '86400', 10:02:15 INFO - 'USER': 'cltbld', 10:02:15 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1481651706.286370-1723659657', 10:02:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:15 INFO - '_': '/tools/buildbot/bin/python'} 10:02:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:15 INFO - Downloading/unpacking jsonschema==2.5.1 10:02:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:02:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:02:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:02:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:02:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:02:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:02:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:02:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:02:17 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 10:02:17 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 10:02:17 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 10:02:17 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 10:02:17 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 10:02:17 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 10:02:17 INFO - Downloading functools32-3.2.3-2.tar.gz 10:02:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:02:17 INFO - warning: no files found matching '*.txt' 10:02:17 INFO - no previously-included directories found matching 'build' 10:02:17 INFO - no previously-included directories found matching 'dist' 10:02:17 INFO - no previously-included directories found matching '.git*' 10:02:17 INFO - Installing collected packages: jsonschema, functools32 10:02:18 INFO - Running setup.py install for functools32 10:02:18 INFO - warning: no files found matching '*.txt' 10:02:18 INFO - no previously-included directories found matching 'build' 10:02:18 INFO - no previously-included directories found matching 'dist' 10:02:18 INFO - no previously-included directories found matching '.git*' 10:02:18 INFO - Successfully installed jsonschema functools32 10:02:18 INFO - Cleaning up... 10:02:18 INFO - Return code: 0 10:02:18 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:02:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:02:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:02:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f1cb60c6e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c39a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd7120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e67f20>, '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 0x1dd4c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd4f90>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1481651706.286370-1723659657', '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 10:02:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 10:02:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 10:02:18 INFO - Using env: {'DISPLAY': ':0', 10:02:18 INFO - 'HOME': '/home/cltbld', 10:02:18 INFO - 'LANG': 'en_US.UTF-8', 10:02:18 INFO - 'LANGUAGE': 'en_US:en', 10:02:18 INFO - 'LOGNAME': 'cltbld', 10:02:18 INFO - 'MAIL': '/var/mail/cltbld', 10:02:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:18 INFO - 'MOZ_NO_REMOTE': '1', 10:02:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:02:18 INFO - 'NO_EM_RESTART': '1', 10:02:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:02:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:18 INFO - 'PWD': '/builds/slave/test', 10:02:18 INFO - 'SHELL': '/bin/bash', 10:02:18 INFO - 'SHLVL': '1', 10:02:18 INFO - 'TERM': 'linux', 10:02:18 INFO - 'TMOUT': '86400', 10:02:18 INFO - 'USER': 'cltbld', 10:02:18 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1481651706.286370-1723659657', 10:02:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:18 INFO - '_': '/tools/buildbot/bin/python'} 10:02:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:18 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:02:18 INFO - Cleaning up... 10:02:18 INFO - Return code: 0 10:02:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:02:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:02:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:02:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f1cb60c6e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c39a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd7120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e67f20>, '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 0x1dd4c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd4f90>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1481651706.286370-1723659657', '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 10:02:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:02:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:02:18 INFO - Using env: {'DISPLAY': ':0', 10:02:18 INFO - 'HOME': '/home/cltbld', 10:02:18 INFO - 'LANG': 'en_US.UTF-8', 10:02:18 INFO - 'LANGUAGE': 'en_US:en', 10:02:18 INFO - 'LOGNAME': 'cltbld', 10:02:18 INFO - 'MAIL': '/var/mail/cltbld', 10:02:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:18 INFO - 'MOZ_NO_REMOTE': '1', 10:02:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:02:18 INFO - 'NO_EM_RESTART': '1', 10:02:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:02:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:18 INFO - 'PWD': '/builds/slave/test', 10:02:18 INFO - 'SHELL': '/bin/bash', 10:02:18 INFO - 'SHLVL': '1', 10:02:18 INFO - 'TERM': 'linux', 10:02:18 INFO - 'TMOUT': '86400', 10:02:18 INFO - 'USER': 'cltbld', 10:02:18 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1481651706.286370-1723659657', 10:02:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:18 INFO - '_': '/tools/buildbot/bin/python'} 10:02:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:18 INFO - Downloading/unpacking blobuploader==1.2.4 10:02:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:02:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:02:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:02:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:02:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:02:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:02:20 INFO - Downloading blobuploader-1.2.4.tar.gz 10:02:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:02:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:02:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:02:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:02:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:02:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:02:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:02:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:02:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:02:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:02:21 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 10:02:21 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 10:02:21 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 10:02:21 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 10:02:21 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 10:02:21 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 10:02:21 INFO - Downloading docopt-0.6.1.tar.gz 10:02:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:02:21 INFO - Installing collected packages: blobuploader, requests, docopt 10:02:21 INFO - Running setup.py install for blobuploader 10:02:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:02:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:02:21 INFO - Running setup.py install for requests 10:02:21 INFO - Running setup.py install for docopt 10:02:21 INFO - Successfully installed blobuploader requests docopt 10:02:21 INFO - Cleaning up... 10:02:21 INFO - Return code: 0 10:02:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:02:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:02:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:02:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:22 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 0x7f1cb60c6e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c39a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd7120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e67f20>, '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 0x1dd4c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd4f90>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1481651706.286370-1723659657', '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 10:02:22 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 10:02:22 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 10:02:22 INFO - Using env: {'DISPLAY': ':0', 10:02:22 INFO - 'HOME': '/home/cltbld', 10:02:22 INFO - 'LANG': 'en_US.UTF-8', 10:02:22 INFO - 'LANGUAGE': 'en_US:en', 10:02:22 INFO - 'LOGNAME': 'cltbld', 10:02:22 INFO - 'MAIL': '/var/mail/cltbld', 10:02:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:22 INFO - 'MOZ_NO_REMOTE': '1', 10:02:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:02:22 INFO - 'NO_EM_RESTART': '1', 10:02:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:02:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:22 INFO - 'PWD': '/builds/slave/test', 10:02:22 INFO - 'SHELL': '/bin/bash', 10:02:22 INFO - 'SHLVL': '1', 10:02:22 INFO - 'TERM': 'linux', 10:02:22 INFO - 'TMOUT': '86400', 10:02:22 INFO - 'USER': 'cltbld', 10:02:22 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1481651706.286370-1723659657', 10:02:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:22 INFO - '_': '/tools/buildbot/bin/python'} 10:02:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:02:22 INFO - Running setup.py (path:/tmp/pip-oFP7qQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:02:22 INFO - Running setup.py (path:/tmp/pip-PUkwMK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:02:22 INFO - Running setup.py (path:/tmp/pip-rzC9v4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:02:22 INFO - Running setup.py (path:/tmp/pip-qEPtzN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:02:22 INFO - Running setup.py (path:/tmp/pip-6tetvU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:02:22 INFO - Running setup.py (path:/tmp/pip-F289qO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:02:22 INFO - Running setup.py (path:/tmp/pip-rRfCO6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:02:22 INFO - Running setup.py (path:/tmp/pip-xHbNro-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:02:22 INFO - Running setup.py (path:/tmp/pip-MwI_36-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:02:22 INFO - Running setup.py (path:/tmp/pip-XkHTZG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:02:22 INFO - Running setup.py (path:/tmp/pip-VqqVmz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:02:23 INFO - Running setup.py (path:/tmp/pip-KgdPDx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:02:23 INFO - Running setup.py (path:/tmp/pip-ZpcATB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:02:23 INFO - Running setup.py (path:/tmp/pip-ZU7T3u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:02:23 INFO - Running setup.py (path:/tmp/pip-h3c5bQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:02:23 INFO - Running setup.py (path:/tmp/pip-NW1GyM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:02:23 INFO - Running setup.py (path:/tmp/pip-Yxlcwp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:02:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:02:23 INFO - Running setup.py install for manifestparser 10:02:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:02:23 INFO - Running setup.py install for mozcrash 10:02:23 INFO - Running setup.py install for mozdebug 10:02:23 INFO - Running setup.py install for mozdevice 10:02:23 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:02:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:02:23 INFO - Running setup.py install for mozfile 10:02:23 INFO - Running setup.py install for mozhttpd 10:02:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:02:24 INFO - Running setup.py install for mozinfo 10:02:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:02:24 INFO - Running setup.py install for mozInstall 10:02:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:02:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:02:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:02:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:02:24 INFO - Running setup.py install for mozleak 10:02:24 INFO - Running setup.py install for mozlog 10:02:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:02:24 INFO - Running setup.py install for moznetwork 10:02:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:02:24 INFO - Running setup.py install for mozprocess 10:02:24 INFO - Running setup.py install for mozprofile 10:02:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:02:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:02:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:02:24 INFO - Running setup.py install for mozrunner 10:02:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:02:24 INFO - Running setup.py install for mozscreenshot 10:02:25 INFO - Running setup.py install for moztest 10:02:25 INFO - Running setup.py install for mozversion 10:02:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:02:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:02:25 INFO - Cleaning up... 10:02:25 INFO - Return code: 0 10:02:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:02:25 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')]} 10:02:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:25 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')]} 10:02:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:25 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 0x7f1cb60c6e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c39a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd7120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e67f20>, '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 0x1dd4c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd4f90>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1481651706.286370-1723659657', '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 10:02:25 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 10:02:25 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 10:02:25 INFO - Using env: {'DISPLAY': ':0', 10:02:25 INFO - 'HOME': '/home/cltbld', 10:02:25 INFO - 'LANG': 'en_US.UTF-8', 10:02:25 INFO - 'LANGUAGE': 'en_US:en', 10:02:25 INFO - 'LOGNAME': 'cltbld', 10:02:25 INFO - 'MAIL': '/var/mail/cltbld', 10:02:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:25 INFO - 'MOZ_NO_REMOTE': '1', 10:02:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:02:25 INFO - 'NO_EM_RESTART': '1', 10:02:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:02:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:25 INFO - 'PWD': '/builds/slave/test', 10:02:25 INFO - 'SHELL': '/bin/bash', 10:02:25 INFO - 'SHLVL': '1', 10:02:25 INFO - 'TERM': 'linux', 10:02:25 INFO - 'TMOUT': '86400', 10:02:25 INFO - 'USER': 'cltbld', 10:02:25 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1481651706.286370-1723659657', 10:02:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:25 INFO - '_': '/tools/buildbot/bin/python'} 10:02:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:02:25 INFO - Running setup.py (path:/tmp/pip-cfsXRH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:02:25 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)) 10:02:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:02:25 INFO - Running setup.py (path:/tmp/pip-8XJhlH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:02:25 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)) 10:02:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:02:25 INFO - Running setup.py (path:/tmp/pip-Z49kFC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:02:25 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)) 10:02:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:02:25 INFO - Running setup.py (path:/tmp/pip-1zzpcm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:02:25 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)) 10:02:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:02:25 INFO - Running setup.py (path:/tmp/pip-Amn40M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:02:25 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)) 10:02:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:02:25 INFO - Running setup.py (path:/tmp/pip-d5bI9b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:02:25 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)) 10:02:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:02:25 INFO - Running setup.py (path:/tmp/pip-sJuWYe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:02:26 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)) 10:02:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:02:26 INFO - Running setup.py (path:/tmp/pip-QC8FwU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:02:26 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)) 10:02:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:02:26 INFO - Running setup.py (path:/tmp/pip-BXLGAj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:02:26 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)) 10:02:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:02:26 INFO - Running setup.py (path:/tmp/pip-bSW3H4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:02:26 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)) 10:02:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:02:26 INFO - Running setup.py (path:/tmp/pip-ovW8EY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:02:26 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)) 10:02:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:02:26 INFO - Running setup.py (path:/tmp/pip-fFRs4F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:02:26 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)) 10:02:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:02:26 INFO - Running setup.py (path:/tmp/pip-TIn5Xg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:02:26 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)) 10:02:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:02:26 INFO - Running setup.py (path:/tmp/pip-bpEZqe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:02:26 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)) 10:02:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:02:26 INFO - Running setup.py (path:/tmp/pip-Snm_Pd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:02:26 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)) 10:02:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:02:26 INFO - Running setup.py (path:/tmp/pip-Cl7nwG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:02:26 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)) 10:02:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:02:26 INFO - Running setup.py (path:/tmp/pip-Gj5cvw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:02:26 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)) 10:02:26 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)) 10:02:26 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)) 10:02:26 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)) 10:02:26 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)) 10:02:26 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)) 10:02:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:02:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:02:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:02:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:02:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:02:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:02:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:02:28 INFO - Downloading blessings-1.6.tar.gz 10:02:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:02:28 INFO - Installing collected packages: blessings 10:02:28 INFO - Running setup.py install for blessings 10:02:28 INFO - Successfully installed blessings 10:02:28 INFO - Cleaning up... 10:02:28 INFO - Return code: 0 10:02:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:02:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:02:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:02:29 INFO - Reading from file tmpfile_stdout 10:02:29 INFO - Current package versions: 10:02:29 INFO - argparse == 1.2.1 10:02:29 INFO - blessings == 1.6 10:02:29 INFO - blobuploader == 1.2.4 10:02:29 INFO - docopt == 0.6.1 10:02:29 INFO - functools32 == 3.2.3-2 10:02:29 INFO - jsonschema == 2.5.1 10:02:29 INFO - manifestparser == 1.1 10:02:29 INFO - mozInstall == 1.12 10:02:29 INFO - mozcrash == 1.0 10:02:29 INFO - mozdebug == 0.1 10:02:29 INFO - mozdevice == 0.49 10:02:29 INFO - mozfile == 1.2 10:02:29 INFO - mozhttpd == 0.7 10:02:29 INFO - mozinfo == 0.9 10:02:29 INFO - mozleak == 0.1 10:02:29 INFO - mozlog == 3.4 10:02:29 INFO - moznetwork == 0.27 10:02:29 INFO - mozprocess == 0.23 10:02:29 INFO - mozprofile == 0.28 10:02:29 INFO - mozrunner == 6.13 10:02:29 INFO - mozscreenshot == 0.1 10:02:29 INFO - mozsystemmonitor == 0.3 10:02:29 INFO - moztest == 0.7 10:02:29 INFO - mozversion == 1.4 10:02:29 INFO - psutil == 3.1.1 10:02:29 INFO - requests == 1.2.3 10:02:29 INFO - wsgiref == 0.1.2 10:02:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:02:29 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')]} 10:02:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:29 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')]} 10:02:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:29 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 0x7f1cb60c6e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c39a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd7120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e67f20>, '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 0x1dd4c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd4f90>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1481651706.286370-1723659657', '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 10:02:29 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 10:02:29 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 10:02:29 INFO - Using env: {'DISPLAY': ':0', 10:02:29 INFO - 'HOME': '/home/cltbld', 10:02:29 INFO - 'LANG': 'en_US.UTF-8', 10:02:29 INFO - 'LANGUAGE': 'en_US:en', 10:02:29 INFO - 'LOGNAME': 'cltbld', 10:02:29 INFO - 'MAIL': '/var/mail/cltbld', 10:02:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:29 INFO - 'MOZ_NO_REMOTE': '1', 10:02:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:02:29 INFO - 'NO_EM_RESTART': '1', 10:02:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:02:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:29 INFO - 'PWD': '/builds/slave/test', 10:02:29 INFO - 'SHELL': '/bin/bash', 10:02:29 INFO - 'SHLVL': '1', 10:02:29 INFO - 'TERM': 'linux', 10:02:29 INFO - 'TMOUT': '86400', 10:02:29 INFO - 'USER': 'cltbld', 10:02:29 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1481651706.286370-1723659657', 10:02:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:29 INFO - '_': '/tools/buildbot/bin/python'} 10:02:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:29 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)) 10:02:29 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)) 10:02:29 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)) 10:02:29 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)) 10:02:29 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)) 10:02:29 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)) 10:02:29 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)) 10:02:29 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)) 10:02:29 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)) 10:02:29 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)) 10:02:29 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)) 10:02:29 INFO - Cleaning up... 10:02:29 INFO - Return code: 0 10:02:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:02:29 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')]} 10:02:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:29 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')]} 10:02:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:29 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 0x7f1cb60c6e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c39a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd7120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e67f20>, '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 0x1dd4c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd4f90>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1481651706.286370-1723659657', '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 10:02:29 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 10:02:29 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 10:02:29 INFO - Using env: {'DISPLAY': ':0', 10:02:29 INFO - 'HOME': '/home/cltbld', 10:02:29 INFO - 'LANG': 'en_US.UTF-8', 10:02:29 INFO - 'LANGUAGE': 'en_US:en', 10:02:29 INFO - 'LOGNAME': 'cltbld', 10:02:29 INFO - 'MAIL': '/var/mail/cltbld', 10:02:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:29 INFO - 'MOZ_NO_REMOTE': '1', 10:02:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:02:29 INFO - 'NO_EM_RESTART': '1', 10:02:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:02:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:29 INFO - 'PWD': '/builds/slave/test', 10:02:29 INFO - 'SHELL': '/bin/bash', 10:02:29 INFO - 'SHLVL': '1', 10:02:29 INFO - 'TERM': 'linux', 10:02:29 INFO - 'TMOUT': '86400', 10:02:29 INFO - 'USER': 'cltbld', 10:02:29 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1481651706.286370-1723659657', 10:02:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:29 INFO - '_': '/tools/buildbot/bin/python'} 10:02:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:29 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:02:29 INFO - Cleaning up... 10:02:29 INFO - Return code: 0 10:02:29 INFO - Running post-action listener: _resource_record_post_action 10:02:29 INFO - Running post-action listener: _start_resource_monitoring 10:02:29 INFO - Starting resource monitoring. 10:02:29 INFO - [mozharness: 2016-12-13 18:02:29.701906Z] Finished create-virtualenv step (success) 10:02:29 INFO - [mozharness: 2016-12-13 18:02:29.702428Z] Running install step. 10:02:29 INFO - Running pre-action listener: _resource_record_pre_action 10:02:29 INFO - Running main action method: install 10:02:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:02:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:02:29 INFO - Reading from file tmpfile_stdout 10:02:29 INFO - Detecting whether we're running mozinstall >=1.0... 10:02:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:02:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:02:29 INFO - Reading from file tmpfile_stdout 10:02:29 INFO - Output received: 10:02:29 INFO - Usage: mozinstall [options] installer 10:02:29 INFO - Options: 10:02:29 INFO - -h, --help show this help message and exit 10:02:29 INFO - -d DEST, --destination=DEST 10:02:29 INFO - Directory to install application into. [default: 10:02:29 INFO - "/builds/slave/test"] 10:02:29 INFO - --app=APP Application being installed. [default: firefox] 10:02:29 INFO - mkdir: /builds/slave/test/build/application 10:02:29 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'] 10:02:29 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 10:02:46 INFO - Reading from file tmpfile_stdout 10:02:46 INFO - Output received: 10:02:46 INFO - /builds/slave/test/build/application/firefox/firefox 10:02:46 INFO - Running post-action listener: _resource_record_post_action 10:02:46 INFO - [mozharness: 2016-12-13 18:02:46.855162Z] Finished install step (success) 10:02:46 INFO - [mozharness: 2016-12-13 18:02:46.855404Z] Running run-tests step. 10:02:46 INFO - Running pre-action listener: _resource_record_pre_action 10:02:46 INFO - Running main action method: run_tests 10:02:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:02:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:02:46 INFO - Python 2.7.3 10:02:46 INFO - Return code: 0 10:02:46 INFO - grabbing minidump binary from tooltool 10:02: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')]} 10:02:46 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 0x1e67f20>, '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 0x1dd4c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd4f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:02:46 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 10:02:46 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 10:02:46 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 10:02:46 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:02:46 INFO - Return code: 0 10:02:46 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:02:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:02:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:02:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:02:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:02:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HdFBkxqyReGQ0JCq6xL_mA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--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 10:02:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HdFBkxqyReGQ0JCq6xL_mA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-033 --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 10:02:46 INFO - Using env: {'DISPLAY': ':0', 10:02:46 INFO - 'HOME': '/home/cltbld', 10:02:46 INFO - 'LANG': 'en_US.UTF-8', 10:02:46 INFO - 'LANGUAGE': 'en_US:en', 10:02:46 INFO - 'LOGNAME': 'cltbld', 10:02:46 INFO - 'MAIL': '/var/mail/cltbld', 10:02:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:02:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:02:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:46 INFO - 'MOZ_NO_REMOTE': '1', 10:02:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:02:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:02:46 INFO - 'NO_EM_RESTART': '1', 10:02:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:02:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:46 INFO - 'PWD': '/builds/slave/test', 10:02:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:02:46 INFO - 'SHELL': '/bin/bash', 10:02:46 INFO - 'SHLVL': '1', 10:02:46 INFO - 'TERM': 'linux', 10:02:46 INFO - 'TMOUT': '86400', 10:02:46 INFO - 'USER': 'cltbld', 10:02:46 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1481651706.286370-1723659657', 10:02:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:46 INFO - '_': '/tools/buildbot/bin/python'} 10:02:46 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HdFBkxqyReGQ0JCq6xL_mA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--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 10:02:47 INFO - mozversion application_buildid: 20161213091200 10:02:47 INFO - mozversion application_changeset: 489f981e8c2beb050d7faee956dd940431bdafe6 10:02:47 INFO - mozversion application_display_name: Nightly 10:02:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:02:47 INFO - mozversion application_name: Firefox 10:02:47 INFO - mozversion application_remotingname: firefox 10:02:47 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:02:47 INFO - mozversion application_vendor: Mozilla 10:02:47 INFO - mozversion application_version: 53.0a1 10:02:47 INFO - mozversion platform_buildid: 20161213091200 10:02:47 INFO - mozversion platform_changeset: 489f981e8c2beb050d7faee956dd940431bdafe6 10:02:47 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:02:47 INFO - mozversion platform_version: 53.0a1 10:02:47 INFO - using testdate: 1481652167 10:02:47 INFO - actual date: 1481652167 10:02:47 INFO - starting webserver on 'localhost:51230' 10:02:47 INFO - SUITE-START | Running 2 tests 10:02:47 INFO - TEST-START | dromaeo_css 10:02:47 INFO - operating with platform_type : linux_ 10:02:47 INFO - Initialising browser for dromaeo_css test... 10:02:47 INFO - TEST-INFO | started process 31854 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxdF4l3/profile http://localhost:51230/getInfo.html) 10:02:52 INFO - PROCESS | 31854 | __metrics Screen width/height:1600/1200 10:02:52 INFO - PROCESS | 31854 | colorDepth:24 10:02:52 INFO - PROCESS | 31854 | Browser inner width/height: 1024/697 10:02:52 INFO - PROCESS | 31854 | __metrics 10:02:52 INFO - PROCESS | 31854 | 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" 10:02:52 INFO - PROCESS | 31854 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:02:53 INFO - PROCESS | 31854 | console.error: PushService: 10:02:53 INFO - PROCESS | 31854 | stateChangeProcessEnqueue: Error transitioning state 10:02:53 INFO - PROCESS | 31854 | UnknownError 10:02:54 INFO - TEST-INFO | 31854: exit 0 10:02:54 INFO - Browser initialized. 10:02:54 INFO - Running cycle 1/1 for dromaeo_css test... 10:02:54 INFO - TEST-INFO | started process 31940 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxdF4l3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:03:06 INFO - PROCESS | 31940 | RSS: Main: 173608960 10:03:06 INFO - PROCESS | 31940 | 10:03:57 INFO - PROCESS | 31940 | 1481652237694 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] 10:06:12 INFO - PROCESS | 31940 | Cycle 1(1): loaded http://localhost:51230/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51230/tests/dromaeo/cssquery-ext.html) 10:06:13 INFO - PROCESS | 31940 | RSS: Main: 326021120 10:06:13 INFO - PROCESS | 31940 | 10:09:16 INFO - PROCESS | 31940 | Cycle 1(1): loaded http://localhost:51230/tests/dromaeo/cssquery-ext.html (next: http://localhost:51230/tests/dromaeo/cssquery-jquery.html) 10:09:17 INFO - PROCESS | 31940 | RSS: Main: 272297984 10:09:17 INFO - PROCESS | 31940 | 10:12:19 INFO - PROCESS | 31940 | Cycle 1(1): loaded http://localhost:51230/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51230/tests/dromaeo/cssquery-mootools.html) 10:12:20 INFO - PROCESS | 31940 | RSS: Main: 218357760 10:12:20 INFO - PROCESS | 31940 | 10:15:22 INFO - PROCESS | 31940 | Cycle 1(1): loaded http://localhost:51230/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51230/tests/dromaeo/cssquery-prototype.html) 10:15:23 INFO - PROCESS | 31940 | RSS: Main: 219820032 10:15:23 INFO - PROCESS | 31940 | 10:18:26 INFO - PROCESS | 31940 | Cycle 1(1): loaded http://localhost:51230/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51230/tests/dromaeo/cssquery-yui.html) 10:18:27 INFO - PROCESS | 31940 | RSS: Main: 220741632 10:18:27 INFO - PROCESS | 31940 | 10:21:30 INFO - PROCESS | 31940 | Cycle 1(1): loaded http://localhost:51230/tests/dromaeo/cssquery-yui.html (next: http://localhost:51230/tests/dromaeo/cssquery-dojo.html) 10:21:30 INFO - PROCESS | 31940 | RSS: Main: 318582784 10:21:30 INFO - PROCESS | 31940 | 10:21:30 INFO - PROCESS | 31940 | __start_tp_report 10:21:30 INFO - PROCESS | 31940 | _x_x_mozilla_page_load 10:21:30 INFO - PROCESS | 31940 | _x_x_mozilla_page_load_details 10:21:30 INFO - PROCESS | 31940 | |i|pagename|runs| 10:21:30 INFO - PROCESS | 31940 | |0;dojo.html;2609.8956041758324;2639.3533584271854;2659.70743218246;2672.2384120525644;2682.222155574882;4742.69172503787;4775.14047471455;4803.663743537953;4827.227643577028;4878.634102442317;4798;4804.37543119394;4830.951690483094;4851.126797176506;4903.583195428393;4403.515613282536;4425.645948324142;4448.0436706108185;4448.733076015449;4453.51011388747;4463.285874260119;4485.573870482299;4509.819607215723;4511.030128522367;4547.18150732868;4469.463664360265;4505.121501307246;4511.842085527007;4516.525764794715;4539.319102134673;4360.847370342054;4393.626541743955;4401.5598440156045;4409.867703968886;4426.468823741139;4404.977975110136;4406.471223453206;4445.022095139064;4461.5315391883705;4483.955160448387;4783.4499032611;4804.399450068741;4835.830745923911;4854.514548545118;4906;5019.372578427697;5065.898682026339;5066.82266120684;5178.844634660966;5181.1969144782615;5156.046131465653;5180.844574662766;5194.68831870089;5215.035218484592;5265;4862.610991120667;4865.489123642037;4869.123557759637;4874.975625121922;4912.484189160086;5056.620753443506;5314.813981510706;5315.574754019669;5317.760700768475;5319.734013299397;4878.756062196876;4924.581410580141;4974.801007959641;4999.725015124203;5008.749562521859;5093.8726531837;5095.261187127846;5095.821646242438;5095.847124586194;5133.076046311699;5015.724135172528;5021.297018417425;5076.568491678175;5108.3103780989095;5119.795208191705;4993.950060499348;5030.069437154065;5039.168537191323;5050.77271522775;5056.9633225188745;4409.867703968886;4424.225760491901;4432.224360736858;4444;4455.68810183284;3846.3268927937497;3847.7691338519217;3851.2105018471148;3874.496315479026;3888.6305800948867;4326.221280169537;4347.760873152007;4417.690761646718;4425.579569940851;4467.754273514988;5154.587632989352;5159;5164.845054648366;5200.375954885438;5267.631265811433;4437.911241775147;4438.378626992224;4443.844465443694;4446.110777844444;4481.731096134243;4633.0733853229485;4711.929321060187;4722.362481065013;4722.5513576210205;4765.69023013503;4765.237561990065;4778.713277203379;4828.275758636232;4832.855014349575;4836.395450568679;5168.638195326291;5198.272241886215;5253.894922101613;5254.395744489432;5302.39022512416;4847.466778654416;4851.830185943475;4871.537203965618;4898.53463920927;4902.019596080727;5166.509181627739;5171.9482805171465;5173;5174.97412512935;5224.451432599674;4971.875703107451;5005.174146265826;5204.453532379046;5248.527632513092;5261.710605916558;5005.674631148963;5012.523810238022;5018.749062546931;5063.924041139312;5119.769610367468;5008.6744361616375;5061.670991385548;5064.18972964324;5075;5118.360204974379;4814.398200224972;4956.157453232887;4987.251912213052;5000.224965130411;5000.899982000266;4957.727324997016;5021.84934451967;5027.245913112916;5032.3961124665275;5033.043721692867;4936.03747269279;4983.950160498349;4986.12742770021;5005.174146265826;5020 10:21:30 INFO - PROCESS | 31940 | |1;ext.html;514.8841510660101;544.8093167391413;545.9727013649317;549.390176903637;562.1258942344652;28697.282567935785;29428;41713.16573668529;43573;43791.34312985308;39578.40632390516;40199.799001004954;40208.59791402085;40213.19573608526;40214.59785402145;7480.13978392485;7675.9232407676045;7680.731174408897;7706.113796913371;7706.6917323307;7338.082739657543;7548.20743821899;7555.16893141754;9563.569639366211;9827.115559599635;9945.90054099457;10015.098641122298;10015.248856335767;10022.649207277747;10024.348417352885;9875.40747555149;9938.254630902638;9939.55272012754;9948.950255248714;9957.004299570057;9711.125998660083;9821.607135714563;9823.90176098237;9824.459654718987;9834.262430317684;37255.254894902224;37732.24535509302;37734.24531509355;37735.62264377349;37748.24503509914;2878.33798226407;2939.7501212396974;2999.205210619166;3092.8298943558098;3248.772585918987;27743;28316.433671326457;28348.57477137824;28787.99242026519;29268.41463170725;3474.2356681530023;3489.6510348965153;3518.2611651553207;3547.255076433952;3566.1084728817796;244063;244733.77633111898;245339;245847;245873;53080.73459632677;53631.731841340545;53634.73182634062;53647.46352536503;53716;55929.720351397984;56029;56049.71975140098;56062;56134.15798763022;13291.66770830737;13637.249951252776;13667.583104223944;13668.453261869612;13671.726565468634;8498.320134389234;9781.657641982496;10045.447500387403;10047.296689231829;10051.296409251283;14491;16674.83325166757;17126.40057597978;17168.22742976569;17819.19813608391;5430.13117901134;5631.099024156116;5686.60193786431;5703.372629010805;5726.341470730919;793.964271607779;848.9872651910226;880.5773228850188;904.3759805734022;972.7811242470387;26061.478770424485;27044.45911081807;27129.864350678516;27428.86285568599;27576;906.954652267384;947.5120313038791;976.7509285132246;1006.3961623026125;1025.564135242519;14384.640383990483;14596.34316455762;14609.707805843824;14613.693153423288;14797.63005924839;352877;353597;354454;354704;355043;42995.140097198506;44118.33822492665;47974.28038579424;49325;49362.75318623384;1148.4717030166216;1149.5918948773233;1155.0759392485977;1158.8145896656495;1172.267332916927;26549.33626659349;27724.722752772213;27905;28517.714822851507;28709.56935645925;38098.80950595229;38488;38492.807535963264;38572;38584.22831543297;297307;299424;300312;301269;301321;35177;35302;35446.29107417889;35559.28881422305;35576.64423355837;36701.44947825838;37131.25737485181;41118.38322425106;41275.38086928758;41418;34820.65179348174;34957.47563786495;35127.47308790319;35450.29099417946;35635.82182089073;33991.32017359688;34235.31529369448;34391;34417.48373774345;34528;33877.322453550296;33991.66008339885;34608.134796630286;34650.48024279587;34963.300733984666;30180.396392072475;32262.838685806422;32528.331692003554;32573.674263258014;32735;23861.522769544164;24317.878410607835;24380.524597657433;24445.144419945216;24896.87551562303 10:21:30 INFO - PROCESS | 31940 | |2;jquery.html;345.0786400311169;361.64197444529924;369.68207341686156;372.92727918055976;384.79413513770123;12359.134860559765;12426.130170888042;13245.403956821954;13387.39756710948;16726.16369181542;16224.594385140377;16493.092879891603;16628.085455299955;16745.07902065386;16797.748033779473;4791.640626952975;4800.711957282557;4943.184374578191;4967.180415231483;4969.503049695038;3618.203995121069;3817.6945844332527;4746.501617330166;4815.855524334275;4817.22924332107;3786.532140339024;3807.638274363931;3824.273388056274;3837.57786643469;3972.423998520213;5743.368229494773;5806.65160090396;5808.186853840466;5810.477057064884;5810.506106980912;4950.257461380786;5116.769745361467;5121.359830021247;5130.025295193938;5151.819686310999;19381.224751009944;19534.80465195344;19631.214751409927;19665.80334196654;19732.60534789296;1965.5872266823985;1977.5847072114873;2006.398080575836;2067.2041264113273;2351.670766092748;12278.386080696018;12493.875061249362;12883.871161288362;13286.734265314639;13303.068785185042;1685.4859267923277;1698.269744010075;1702.4807433732706;1719.6302794899157;1752.1326943163087;63681.552312698346;63950.360496394904;65441.672791635734;66342.33657663362;66979.95300704884;9353.766155846159;9511.191548718298;9612.855807162898;9863.457509836884;9957.954414786487;13179.341032948314;13389.531366402129;13405.66485837862;13409.463621455228;13432.261225632685;6754.898676519856;6887.311268873173;6912.516123871382;6955.582665040114;7278.526895751759;6703.899441508382;6740.39336459721;6761.830954226184;6951.374376306157;6951.7219311228;5232.476752324813;5611.186377975171;5680.573956953245;5980.611260268156;6255.654129701362;1672.757450169743;1748.2307784574746;1766.9381571645188;1814.8638852086146;1824.3888297420247;787.8109253779166;846.8899043124354;890.844102282098;917.9862302065475;945.664289177346;16374;16872.915635421745;17123.91438042827;17519.47441576755;18085.819141808675;847.8007668197969;852.1435956863313;866.7226487524058;877.2499512916493;901.833160865242;9427.764305892408;10030.949845250727;10061.19510439163;10107.494625268708;10123.836843210016;263394;267895;268341;347168;347311;54049;66171.66914165398;76965;77953;79177.60411197908;825.1913125137279;842.0821304777821;860.7116615933608;862.0904945282662;898.5013317608659;14891.62770930692;15009.799216062907;15583.06501609907;15764.132972686612;15793.21033948321;35538.64461355354;35713;35869.64130358663;36170.81914590515;36794.816025919696;50133;50659;50718.74640626773;52527;53554.46445535651;7261.854762904818;7303.634818259172;7590.886136708064;7623.65693543803;7646.808829779077;8741.606627701896;8841.955790221007;10834.566617335218;11289.943550282196;11317.547298107984;9969.750756231153;10049.648262310784;10085.798284034425;10378.636747713794;10658.893411066101;9753.9024609753;10080.69757907264;10090;10130.594776208869;10189.082982531607;8123.918760812317;8539.231469167804;10200.795984080129;10340.741481463023;10720.195985300978;6719.529632925648;6908.171019477695;6946.826329341807;7588.886166707614;7797.727079552188;9618.759531011781;10080;10288.382697038202;10450.68647940563;10540.367577945348 10:21:30 INFO - PROCESS | 31940 | |3;mootools.html;1331.3542931678135;1346.8114463975041;1412.8516505766895;1638.827923068077;1645.5803770038638;6765.154355705537;7098;7105.4315654747625;7123.67943442545;7130.679119439625;6282.591631543958;6494.383033611811;6979.197392299887;7256.346928776409;7300.415966722663;2098.8320934325257;2160.308701215604;2164.166795783619;2164.5779073080676;2168.2086038595958;2121.1939463004037;2165.404513758721;2185.7486389065302;2185.901634426447;2194.659827726705;2123.3629911026705;2125.532382875773;2131.3712454825863;2149.140343862452;2152.354293711888;2069.668852983523;2091.6862470629526;2091.989540052305;2095.2771293903656;2096.056774451488;2043.0806137238153;2088.8433367497346;2093.2568938027084;2094.057674046685;2095.235239137719;7158.176809666903;7184.173820010661;7290.125184977836;7312.341889229941;7317.451191160631;4389.122175564868;4523.819047238107;4529.04889973106;4530.161920044802;4532.025614492867;2716.578930265792;2903.3177203357195;2908.287469569948;2962.1409791160536;2962.7926045176846;842.9653248306049;935.200403654872;965.8406362950104;971.4122955611824;981.6711401680445;9322.720318390458;9573.808523829553;9590.808183836354;9595.136437720568;9601.231901447867;3846.211526637033;4006.078601921516;4060.939085913714;4106.3635136553285;4127.5666055064385;8328.625211865481;8335.791605209919;8349.165083491602;8351.832963340821;8352.206540378655;4541.159885421208;4555.977220113945;4558.6581006423985;4559.270516717309;4563.589276965089;3576.6065732769375;3690.372636651776;4005.2590270799415;4091.2226676931286;4171.749695018309;3437.914052148666;3453.671901169385;3571.607123216444;3574.5531808523933;3574.6246644102516;1132.416805345248;1170.0288760328906;1172.724409763722;1180.3685028509706;1187.3528926734778;747.917729049804;821.2813787935556;826.3182874128868;832.2010869565164;832.7376876283951;5041.8487445376695;5070.41690205631;5092.439831618519;5112.821051263188;5218.582513398919;401.78303715993036;413.7765606572417;416.44404719698935;421.02742664444617;422.74635218868434;3438.1920248741526;3457.2221250219004;3496.3881320769274;3588.982055089708;3833.0800607853917;8345.123762005023;8403.537805420638;8471.322294216448;8532.189442003;8536.359773017048;8413.70552030676;8422.199891010345;8423.873641895376;8426.4944103354;8427.115152908857;6656.900146497806;6855.4172895304455;6867.07294515244;6873.518853680194;6882.03651488792;5216.217567364925;5233.869153271199;5298.390685071112;5330.493603107699;5551.722413879209;7956.562389068657;7993.560354180576;8015.078265999251;8018.278354948083;8077;7935.801604959922;8089.47418417801;8183.222593853575;8220.58897055133;8280.71017514384;5554.833354999357;5714.314282285986;6009.338972713085;6243.188385509855;6321.577645029832;6743.865122697421;6927.896081558882;6935.479839011993;6942.097527321416;7060.576365417885;6252.843678908063;6256.567859621223;6404.487640988803;6511.21865376139;6542.182227221598;6232.096346029891;6251.124842522141;6353.047042943411;6382.234131904202;6595.8021259362295;6007.459328660441;6162.921488739363;6165.075238714228;6200.162977998093;6206.596571222856;4359.782010899379;4609.285560738091;4617.8383756568355;4628.375169352229;4666.9533304667875;4486.50648428666;4528.071745292142;4566.543345665407;4635.072985402865;4642.675012749075 10:21:30 INFO - PROCESS | 31940 | |4;prototype.html;351.2272999401316;352.08809184212885;357.94809752585866;365.0690738616527;366.42288395776643;4865.002674451734;4904.043711476259;4924.187509061001;4928.211486162215;4945.826896058638;4875.148038397541;4879.707217566948;4880.46314905361;4913.680610760298;4926.605871530278;3553.573571171463;3749.999999999993;3822.719389004687;3850.8074596270217;3956.347202711549;3916.295066887959;3918.9020274493223;3937.6849852011915;3943.349347357697;3954.130091379892;3862.633049860259;3893.279743247508;3897.2205558888195;3903.7657740535515;3913.3542965410816;3703.6296370363016;3808.5620153682403;3838.7888666123354;3876.6898648108086;3900.8049597520153;3497.5278337424375;3517.82410879455;3527.153483164048;3536.169000284931;3536.91157721059;4746.169420351459;4749.311349854252;4752.192127338326;4755.524447555252;4786.305985632099;4319.50325712544;4494.325876103713;4505.986153115556;4515.819367225307;4520.355591978697;5077.720725360104;5081.18701007837;5113.1052065888325;5122.28288039671;5132.794688212504;3822.0444888777806;3830.9042273943096;3834;3867.6712479439;3881.8059097045316;5114.667546609458;5200.193969934666;5284.313039304866;5401.648892821954;5404.054290499147;3974.2448934702315;3974.5492895093084;3975.34406822871;3998.3202855514633;4003.4795476587856;4022.6781857451333;4035.1929614077303;4047.251258517184;4051.108756073659;4057.3711074783455;4065.9593404066172;4448.666350023761;4459.175052615276;4491.685582009293;4494.280915053576;5055.949440505621;5082.288479612857;5083.923741143886;5098.490150984871;5106.310648062538;1261.520622163572;1265.4811527273773;1265.5064524835323;1265.9873401266054;1272.351100938528;823.6664151018847;858.403409630301;866.1728049712509;872.1801506583791;873.9344549158711;4383.627391671744;4386.758728269912;4388.429504164438;4397.2304846651705;4398.912021759547;5039.344885164978;5090.211017292326;5106.753028667375;5138.58891288696;5156.819511317086;4334.940903071016;4360.215161271001;4384.868453946387;4396.922154491868;4431.534688857688;2606.687197536308;2722.278596172016;2736.3022429280804;2743.396452780385;2759.5788169092934;4797.193641719563;4816.301636262792;4818.494058123917;4830.661853670209;4836.694092594979;5161.4322424533275;5293.279684102682;5302.628815982921;5315.176147697113;5319.4414586467865;4920.975395123073;4927.433345165208;4945.703257804471;4950.950490495049;4951.282064100757;5312.867178320573;5322.840314790563;5334.573234141337;5337.25278461008;5354.518093371616;5005.648474911826;5222.9216561750845;5241.68549887008;5244.580433565382;5294.629375943647;4771.212749896228;4772.141014617263;4866;4910.459849416633;4958.380202474691;3665.981670091739;3688.3360995021153;3688.502052223023;3699.815009249473;3699.852005919733;5271.868203294948;5278.4721527846905;5289.550388217045;5297.973510132425;5306.204069389622;4969.527894849984;5069.631199576168;5069.8732531687;5101.69389836611;5144.074066668036;5099.23511473282;5110.718910459812;5113.463086375877;5121.206213036985;5127.87180320495;5044.218146187347;5083.313752643346;5089.51649593288;5090;5091.261767043832;5041.621878359065;5161.587073034223;5177.534021938043;5196.116660167856;5198.818041368534;5038.798448062036;5040.798368065236;5058.848234552969;5064.5441910228255;5066.898662026812 10:21:30 INFO - PROCESS | 31940 | |5;yui.html;629.7229219143577;649.2566011916355;661.3386613386614;704.3203308807;735.2243383230691;12216.755664886698;13220.40508177132;13237.13958592692;13256.270905100215;13260.93369533151;13291;13432.126911750729;13435.395407206675;13438;13441.193528388303;766;783.3380793229741;786.1745167574053;796.8485987662326;796.928276455119;779.9025121859768;782.5578548120322;782.7808213700173;782.9491083079581;783.1424590073889;822.0915887943826;823.9629216685233;824.1922915542772;825.0470706334194;825.3438516379492;818.8853560501534;819.0376307838326;820.6307161777224;820.741466438076;820.827626198499;601.3955974245898;601.4646964201863;601.6480358989952;601.6841158391835;601.8074216250801;13233.206007639476;13326.866731332757;13350.399232034582;13357.465701371933;13681.452741890413;12479.812802807965;12922.483100675961;13093.345332733421;13248.47006119754;13315.267660278681;10345.222276964076;10392.532336044897;10470.895291047069;10726.892731072667;10801.729956751065;3173.539836723662;3194.7923384979904;3199.2641692410875;3199.3601279744144;3298.224917144469;63965.3603463964;66057;66200.33799662038;66410;66593.99999999952;9308.162265396148;9432.905670943202;9433.669821556212;9632.662856799978;9684.32209745311;18776.436706898814;18789.530261743294;18814.52963675919;18828.341008064654;18855.905720471583;5463.3717122530625;5511.559075273968;5545.639533430314;5576.693281869536;5927.673977931169;3628.5101511296166;3669.2111196092433;3713.405855063177;3802.1825307559006;3810.047488127968;2836.5319722246013;2908.2147820088458;2909.2726818295428;2926.414717056597;3128.8748450061744;527.9155335146359;530.6815910453697;531.8112070215095;535.3254898827428;543.0225593930909;467.21274652211133;556.5964675610231;562.2522045679236;573.7102763104689;578.8292453726077;7317.1219453664835;7344.118705755237;7467.626618669045;7550.886736698954;7672.846543069108;529.1797713543991;546.4644648244663;566.1677334318545;567.7218163100134;585.5754577930966;3310.586176727909;3532.6643968822923;3636.7999760012926;3637.0153176787867;3657;72522;73058;73409;74455.25544744592;74661;63860;63998.68000659967;64763;65002.34997649963;65402.67298663476;53047;55631.443685562626;55679;55866.441335586125;56255.71872140695;8090.7168249111;8505.277051450696;8657.17756813127;8736.170063843925;8757.649694012169;34057.65942340545;34280.48579271263;34310.48534271938;34750.304993900485;35347.293054139285;45131.54868451274;45363;45998;46198.53801461942;46496;10351.534180961724;10679.199060070681;10873.238873279111;10950.945245273722;11119.555217791198;10575.788484230427;10848.349099054081;10993.835092473779;11311.434428278717;11395.772084558428;11430.599929002445;11610.767784644091;11980.028303202893;12028.15802893789;12059.51761929513;10909.127269818237;11059.834102488308;11203.103751700008;11598.594049208237;11636.592719254786;11260.83108753353;11466.484008219484;11672.299662020307;11835.46740396667;12280.508779648713;9373;9430.387024843363;9560.569774360032;9595;10215.795684086424;8999.37004409685;9733.415995040037;9746.707598772047;10021.498925053864;10140.188784897338 10:21:30 INFO - PROCESS | 31940 | __end_tp_report 10:21:30 INFO - PROCESS | 31940 | __start_cc_report 10:21:30 INFO - PROCESS | 31940 | _x_x_mozilla_cycle_collect,1546 10:21:30 INFO - PROCESS | 31940 | __end_cc_report 10:21:30 INFO - PROCESS | 31940 | __startTimestamp1481653290458__endTimestamp 10:21:30 INFO - PROCESS | 31940 | 10:21:30 INFO - PROCESS | 31940 | ------- Summary: start ------- 10:21:30 INFO - PROCESS | 31940 | Number of tests: 6 10:21:30 INFO - PROCESS | 31940 | 10:21:30 INFO - PROCESS | 31940 | [#0] dojo.html Cycles:165 Average:4768.82 Median:4898.53 stddev:497.34 (10.2%) stddev-sans-first:469.15 10:21:30 INFO - PROCESS | 31940 | Values: 2609.9 2639.4 2659.7 2672.2 2682.2 4742.7 4775.1 4803.7 4827.2 4878.6 4798.0 4804.4 4831.0 4851.1 4903.6 4403.5 4425.6 4448.0 4448.7 4453.5 4463.3 4485.6 4509.8 4511.0 4547.2 4469.5 4505.1 4511.8 4516.5 4539.3 4360.8 4393.6 4401.6 4409.9 4426.5 4405.0 4406.5 4445.0 4461.5 4484.0 4783.4 4804.4 4835.8 4854.5 4906.0 5019.4 5065.9 5066.8 5178.8 5181.2 5156.0 5180.8 5194.7 5215.0 5265.0 4862.6 4865.5 4869.1 4875.0 4912.5 5056.6 5314.8 5315.6 5317.8 5319.7 4878.8 4924.6 4974.8 4999.7 5008.7 5093.9 5095.3 5095.8 5095.8 5133.1 5015.7 5021.3 5076.6 5108.3 5119.8 4994.0 5030.1 5039.2 5050.8 5057.0 4409.9 4424.2 4432.2 4444.0 4455.7 3846.3 3847.8 3851.2 3874.5 3888.6 4326.2 4347.8 4417.7 4425.6 4467.8 5154.6 5159.0 5164.8 5200.4 5267.6 4437.9 4438.4 4443.8 4446.1 4481.7 4633.1 4711.9 4722.4 4722.6 4765.7 4765.2 4778.7 4828.3 4832.9 4836.4 5168.6 5198.3 5253.9 5254.4 5302.4 4847.5 4851.8 4871.5 4898.5 4902.0 5166.5 5171.9 5173.0 5175.0 5224.5 4971.9 5005.2 5204.5 5248.5 5261.7 5005.7 5012.5 5018.7 5063.9 5119.8 5008.7 5061.7 5064.2 5075.0 5118.4 4814.4 4956.2 4987.3 5000.2 5000.9 4957.7 5021.8 5027.2 5032.4 5033.0 4936.0 4984.0 4986.1 5005.2 5020.0 10:21:30 INFO - PROCESS | 31940 | 10:21:30 INFO - PROCESS | 31940 | [#1] ext.html Cycles:180 Average:45664.88 Median:354025.50 stddev:79485.17 (22.5%) stddev-sans-first:79635.86 10:21:30 INFO - PROCESS | 31940 | Values: 514.9 544.8 546.0 549.4 562.1 28697.3 29428.0 41713.2 43573.0 43791.3 39578.4 40199.8 40208.6 40213.2 40214.6 7480.1 7675.9 7680.7 7706.1 7706.7 7338.1 7548.2 7555.2 9563.6 9827.1 9945.9 10015.1 10015.2 10022.6 10024.3 9875.4 9938.3 9939.6 9949.0 9957.0 9711.1 9821.6 9823.9 9824.5 9834.3 37255.3 37732.2 37734.2 37735.6 37748.2 2878.3 2939.8 2999.2 3092.8 3248.8 27743.0 28316.4 28348.6 28788.0 29268.4 3474.2 3489.7 3518.3 3547.3 3566.1 244063.0 244733.8 245339.0 245847.0 245873.0 53080.7 53631.7 53634.7 53647.5 53716.0 55929.7 56029.0 56049.7 56062.0 56134.2 13291.7 13637.2 13667.6 13668.5 13671.7 8498.3 9781.7 10045.4 10047.3 10051.3 14491.0 16674.8 17126.4 17168.2 17819.2 5430.1 5631.1 5686.6 5703.4 5726.3 794.0 849.0 880.6 904.4 972.8 26061.5 27044.5 27129.9 27428.9 27576.0 907.0 947.5 976.8 1006.4 1025.6 14384.6 14596.3 14609.7 14613.7 14797.6 352877.0 353597.0 354454.0 354704.0 355043.0 42995.1 44118.3 47974.3 49325.0 49362.8 1148.5 1149.6 1155.1 1158.8 1172.3 26549.3 27724.7 27905.0 28517.7 28709.6 38098.8 38488.0 38492.8 38572.0 38584.2 297307.0 299424.0 300312.0 301269.0 301321.0 35177.0 35302.0 35446.3 35559.3 35576.6 36701.4 37131.3 41118.4 41275.4 41418.0 34820.7 34957.5 35127.5 35450.3 35635.8 33991.3 34235.3 34391.0 34417.5 34528.0 33877.3 33991.7 34608.1 34650.5 34963.3 30180.4 32262.8 32528.3 32573.7 32735.0 23861.5 24317.9 24380.5 24445.1 24896.9 10:21:30 INFO - PROCESS | 31940 | 10:21:30 INFO - PROCESS | 31940 | [#2] jquery.html Cycles:180 Average:21325.27 Median:3830.93 stddev:50309.23 (1313.2%) stddev-sans-first:50425.70 10:21:30 INFO - PROCESS | 31940 | Values: 345.1 361.6 369.7 372.9 384.8 12359.1 12426.1 13245.4 13387.4 16726.2 16224.6 16493.1 16628.1 16745.1 16797.7 4791.6 4800.7 4943.2 4967.2 4969.5 3618.2 3817.7 4746.5 4815.9 4817.2 3786.5 3807.6 3824.3 3837.6 3972.4 5743.4 5806.7 5808.2 5810.5 5810.5 4950.3 5116.8 5121.4 5130.0 5151.8 19381.2 19534.8 19631.2 19665.8 19732.6 1965.6 1977.6 2006.4 2067.2 2351.7 12278.4 12493.9 12883.9 13286.7 13303.1 1685.5 1698.3 1702.5 1719.6 1752.1 63681.6 63950.4 65441.7 66342.3 66980.0 9353.8 9511.2 9612.9 9863.5 9958.0 13179.3 13389.5 13405.7 13409.5 13432.3 6754.9 6887.3 6912.5 6955.6 7278.5 6703.9 6740.4 6761.8 6951.4 6951.7 5232.5 5611.2 5680.6 5980.6 6255.7 1672.8 1748.2 1766.9 1814.9 1824.4 787.8 846.9 890.8 918.0 945.7 16374.0 16872.9 17123.9 17519.5 18085.8 847.8 852.1 866.7 877.2 901.8 9427.8 10030.9 10061.2 10107.5 10123.8 263394.0 267895.0 268341.0 347168.0 347311.0 54049.0 66171.7 76965.0 77953.0 79177.6 825.2 842.1 860.7 862.1 898.5 14891.6 15009.8 15583.1 15764.1 15793.2 35538.6 35713.0 35869.6 36170.8 36794.8 50133.0 50659.0 50718.7 52527.0 53554.5 7261.9 7303.6 7590.9 7623.7 7646.8 8741.6 8842.0 10834.6 11289.9 11317.5 9969.8 10049.6 10085.8 10378.6 10658.9 9753.9 10080.7 10090.0 10130.6 10189.1 8123.9 8539.2 10200.8 10340.7 10720.2 6719.5 6908.2 6946.8 7588.9 7797.7 9618.8 10080.0 10288.4 10450.7 10540.4 10:21:30 INFO - PROCESS | 31940 | 10:21:30 INFO - PROCESS | 31940 | [#3] mootools.html Cycles:180 Average:4796.88 Median:5226.23 stddev:2559.07 (49.0%) stddev-sans-first:2552.99 10:21:30 INFO - PROCESS | 31940 | Values: 1331.4 1346.8 1412.9 1638.8 1645.6 6765.2 7098.0 7105.4 7123.7 7130.7 6282.6 6494.4 6979.2 7256.3 7300.4 2098.8 2160.3 2164.2 2164.6 2168.2 2121.2 2165.4 2185.7 2185.9 2194.7 2123.4 2125.5 2131.4 2149.1 2152.4 2069.7 2091.7 2092.0 2095.3 2096.1 2043.1 2088.8 2093.3 2094.1 2095.2 7158.2 7184.2 7290.1 7312.3 7317.5 4389.1 4523.8 4529.0 4530.2 4532.0 2716.6 2903.3 2908.3 2962.1 2962.8 843.0 935.2 965.8 971.4 981.7 9322.7 9573.8 9590.8 9595.1 9601.2 3846.2 4006.1 4060.9 4106.4 4127.6 8328.6 8335.8 8349.2 8351.8 8352.2 4541.2 4556.0 4558.7 4559.3 4563.6 3576.6 3690.4 4005.3 4091.2 4171.7 3437.9 3453.7 3571.6 3574.6 3574.6 1132.4 1170.0 1172.7 1180.4 1187.4 747.9 821.3 826.3 832.2 832.7 5041.8 5070.4 5092.4 5112.8 5218.6 401.8 413.8 416.4 421.0 422.7 3438.2 3457.2 3496.4 3589.0 3833.1 8345.1 8403.5 8471.3 8532.2 8536.4 8413.7 8422.2 8423.9 8426.5 8427.1 6656.9 6855.4 6867.1 6873.5 6882.0 5216.2 5233.9 5298.4 5330.5 5551.7 7956.6 7993.6 8015.1 8018.3 8077.0 7935.8 8089.5 8183.2 8220.6 8280.7 5554.8 5714.3 6009.3 6243.2 6321.6 6743.9 6927.9 6935.5 6942.1 7060.6 6252.8 6256.6 6404.5 6511.2 6542.2 6232.1 6251.1 6353.0 6382.2 6595.8 6007.5 6162.9 6165.1 6200.2 6206.6 4359.8 4609.3 4617.8 4628.4 4667.0 4486.5 4528.1 4566.5 4635.1 4642.7 10:21:30 INFO - PROCESS | 31940 | 10:21:30 INFO - PROCESS | 31940 | [#4] prototype.html Cycles:180 Average:4269.32 Median:4833.68 stddev:1218.36 (25.2%) stddev-sans-first:1185.76 10:21:30 INFO - PROCESS | 31940 | Values: 351.2 352.1 357.9 365.1 366.4 4865.0 4904.0 4924.2 4928.2 4945.8 4875.1 4879.7 4880.5 4913.7 4926.6 3553.6 3750.0 3822.7 3850.8 3956.3 3916.3 3918.9 3937.7 3943.3 3954.1 3862.6 3893.3 3897.2 3903.8 3913.4 3703.6 3808.6 3838.8 3876.7 3900.8 3497.5 3517.8 3527.2 3536.2 3536.9 4746.2 4749.3 4752.2 4755.5 4786.3 4319.5 4494.3 4506.0 4515.8 4520.4 5077.7 5081.2 5113.1 5122.3 5132.8 3822.0 3830.9 3834.0 3867.7 3881.8 5114.7 5200.2 5284.3 5401.6 5404.1 3974.2 3974.5 3975.3 3998.3 4003.5 4022.7 4035.2 4047.3 4051.1 4057.4 4066.0 4448.7 4459.2 4491.7 4494.3 5055.9 5082.3 5083.9 5098.5 5106.3 1261.5 1265.5 1265.5 1266.0 1272.4 823.7 858.4 866.2 872.2 873.9 4383.6 4386.8 4388.4 4397.2 4398.9 5039.3 5090.2 5106.8 5138.6 5156.8 4334.9 4360.2 4384.9 4396.9 4431.5 2606.7 2722.3 2736.3 2743.4 2759.6 4797.2 4816.3 4818.5 4830.7 4836.7 5161.4 5293.3 5302.6 5315.2 5319.4 4921.0 4927.4 4945.7 4951.0 4951.3 5312.9 5322.8 5334.6 5337.3 5354.5 5005.6 5222.9 5241.7 5244.6 5294.6 4771.2 4772.1 4866.0 4910.5 4958.4 3666.0 3688.3 3688.5 3699.8 3699.9 5271.9 5278.5 5289.6 5298.0 5306.2 4969.5 5069.6 5069.9 5101.7 5144.1 5099.2 5110.7 5113.5 5121.2 5127.9 5044.2 5083.3 5089.5 5090.0 5091.3 5041.6 5161.6 5177.5 5196.1 5198.8 5038.8 5040.8 5058.8 5064.5 5066.9 10:21:30 INFO - PROCESS | 31940 | 10:21:30 INFO - PROCESS | 31940 | [#5] yui.html Cycles:180 Average:15239.99 Median:529.93 stddev:19929.26 (3760.7%) stddev-sans-first:19954.97 10:21:30 INFO - PROCESS | 31940 | Values: 629.7 649.3 661.3 704.3 735.2 12216.8 13220.4 13237.1 13256.3 13260.9 13291.0 13432.1 13435.4 13438.0 13441.2 766.0 783.3 786.2 796.8 796.9 779.9 782.6 782.8 782.9 783.1 822.1 824.0 824.2 825.0 825.3 818.9 819.0 820.6 820.7 820.8 601.4 601.5 601.6 601.7 601.8 13233.2 13326.9 13350.4 13357.5 13681.5 12479.8 12922.5 13093.3 13248.5 13315.3 10345.2 10392.5 10470.9 10726.9 10801.7 3173.5 3194.8 3199.3 3199.4 3298.2 63965.4 66057.0 66200.3 66410.0 66594.0 9308.2 9432.9 9433.7 9632.7 9684.3 18776.4 18789.5 18814.5 18828.3 18855.9 5463.4 5511.6 5545.6 5576.7 5927.7 3628.5 3669.2 3713.4 3802.2 3810.0 2836.5 2908.2 2909.3 2926.4 3128.9 527.9 530.7 531.8 535.3 543.0 467.2 556.6 562.3 573.7 578.8 7317.1 7344.1 7467.6 7550.9 7672.8 529.2 546.5 566.2 567.7 585.6 3310.6 3532.7 3636.8 3637.0 3657.0 72522.0 73058.0 73409.0 74455.3 74661.0 63860.0 63998.7 64763.0 65002.3 65402.7 53047.0 55631.4 55679.0 55866.4 56255.7 8090.7 8505.3 8657.2 8736.2 8757.6 34057.7 34280.5 34310.5 34750.3 35347.3 45131.5 45363.0 45998.0 46198.5 46496.0 10351.5 10679.2 10873.2 10950.9 11119.6 10575.8 10848.3 10993.8 11311.4 11395.8 11430.6 11610.8 11980.0 12028.2 12059.5 10909.1 11059.8 11203.1 11598.6 11636.6 11260.8 11466.5 11672.3 11835.5 12280.5 9373.0 9430.4 9560.6 9595.0 10215.8 8999.4 9733.4 9746.7 10021.5 10140.2 10:21:30 INFO - PROCESS | 31940 | -------- Summary: end -------- 10:21:30 INFO - PROCESS | 31940 | 10:21:31 INFO - TEST-INFO | 31940: exit 0 10:21:31 INFO - TEST-OK | dromaeo_css | took 1124406ms 10:21:31 INFO - TEST-START | kraken 10:21:31 INFO - operating with platform_type : linux_ 10:21:31 INFO - Initialising browser for kraken test... 10:21:31 INFO - TEST-INFO | started process 32249 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6utm0D/profile http://localhost:51230/getInfo.html) 10:21:36 INFO - PROCESS | 32249 | __metrics Screen width/height:1600/1200 10:21:36 INFO - PROCESS | 32249 | colorDepth:24 10:21:36 INFO - PROCESS | 32249 | Browser inner width/height: 1024/697 10:21:36 INFO - PROCESS | 32249 | __metrics 10:21:37 INFO - PROCESS | 32249 | 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" 10:21:37 INFO - PROCESS | 32249 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:21:38 INFO - PROCESS | 32249 | console.error: PushService: 10:21:38 INFO - PROCESS | 32249 | stateChangeProcessEnqueue: Error transitioning state 10:21:38 INFO - PROCESS | 32249 | UnknownError 10:21:38 INFO - TEST-INFO | 32249: exit 0 10:21:38 INFO - Browser initialized. 10:21:38 INFO - Running cycle 1/1 for kraken test... 10:21:38 INFO - TEST-INFO | started process 32331 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6utm0D/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:21:51 INFO - PROCESS | 32331 | RSS: Main: 173678592 10:21:51 INFO - PROCESS | 32331 | 10:21:53 INFO - PROCESS | 32331 | Cycle 1(1): loaded http://localhost:51230/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51230/tests/kraken/driver.html?testName=audio-beat-detection) 10:21:54 INFO - PROCESS | 32331 | RSS: Main: 236171264 10:21:54 INFO - PROCESS | 32331 | 10:21:57 INFO - PROCESS | 32331 | Cycle 1(1): loaded http://localhost:51230/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51230/tests/kraken/driver.html?testName=audio-dft) 10:21:58 INFO - PROCESS | 32331 | RSS: Main: 218669056 10:21:58 INFO - PROCESS | 32331 | 10:22:01 INFO - PROCESS | 32331 | Cycle 1(1): loaded http://localhost:51230/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51230/tests/kraken/driver.html?testName=audio-fft) 10:22:02 INFO - PROCESS | 32331 | RSS: Main: 300859392 10:22:02 INFO - PROCESS | 32331 | 10:22:04 INFO - PROCESS | 32331 | Cycle 1(1): loaded http://localhost:51230/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51230/tests/kraken/driver.html?testName=audio-oscillator) 10:22:04 INFO - PROCESS | 32331 | RSS: Main: 210214912 10:22:04 INFO - PROCESS | 32331 | 10:22:07 INFO - PROCESS | 32331 | Cycle 1(1): loaded http://localhost:51230/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51230/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:22:07 INFO - PROCESS | 32331 | RSS: Main: 214413312 10:22:07 INFO - PROCESS | 32331 | 10:22:11 INFO - PROCESS | 32331 | Cycle 1(1): loaded http://localhost:51230/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51230/tests/kraken/driver.html?testName=imaging-darkroom) 10:22:11 INFO - PROCESS | 32331 | RSS: Main: 254521344 10:22:11 INFO - PROCESS | 32331 | 10:22:15 INFO - PROCESS | 32331 | Cycle 1(1): loaded http://localhost:51230/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51230/tests/kraken/driver.html?testName=imaging-desaturate) 10:22:15 INFO - PROCESS | 32331 | RSS: Main: 254201856 10:22:15 INFO - PROCESS | 32331 | 10:22:18 INFO - PROCESS | 32331 | Cycle 1(1): loaded http://localhost:51230/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51230/tests/kraken/driver.html?testName=json-parse-financial) 10:22:19 INFO - PROCESS | 32331 | RSS: Main: 253177856 10:22:19 INFO - PROCESS | 32331 | 10:22:20 INFO - PROCESS | 32331 | Cycle 1(1): loaded http://localhost:51230/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51230/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:22:21 INFO - PROCESS | 32331 | RSS: Main: 215371776 10:22:21 INFO - PROCESS | 32331 | 10:22:23 INFO - PROCESS | 32331 | Cycle 1(1): loaded http://localhost:51230/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51230/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:22:24 INFO - PROCESS | 32331 | RSS: Main: 223227904 10:22:24 INFO - PROCESS | 32331 | 10:22:26 INFO - PROCESS | 32331 | Cycle 1(1): loaded http://localhost:51230/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51230/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:22:26 INFO - PROCESS | 32331 | RSS: Main: 230739968 10:22:26 INFO - PROCESS | 32331 | 10:22:29 INFO - PROCESS | 32331 | Cycle 1(1): loaded http://localhost:51230/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51230/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:22:30 INFO - PROCESS | 32331 | RSS: Main: 240218112 10:22:30 INFO - PROCESS | 32331 | 10:22:33 INFO - PROCESS | 32331 | Cycle 1(1): loaded http://localhost:51230/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51230/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:22:34 INFO - PROCESS | 32331 | RSS: Main: 236691456 10:22:34 INFO - PROCESS | 32331 | 10:22:35 INFO - PROCESS | 32331 | Cycle 1(1): loaded http://localhost:51230/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51230/tests/kraken/driver.html?testName=ai-astar) 10:22:36 INFO - PROCESS | 32331 | RSS: Main: 288854016 10:22:36 INFO - PROCESS | 32331 | 10:22:36 INFO - PROCESS | 32331 | __start_tp_report 10:22:36 INFO - PROCESS | 32331 | _x_x_mozilla_page_load 10:22:36 INFO - PROCESS | 32331 | _x_x_mozilla_page_load_details 10:22:36 INFO - PROCESS | 32331 | |i|pagename|runs| 10:22:36 INFO - PROCESS | 32331 | |0;ai-astar;114;118;117;115;115;116;115;116;114;115 10:22:36 INFO - PROCESS | 32331 | |1;audio-beat-detection;157;128;129;173;128;130;133;130;158;130 10:22:36 INFO - PROCESS | 32331 | |2;audio-dft;162;162;162;164;163;163;163;162;163;162 10:22:36 INFO - PROCESS | 32331 | |3;audio-fft;77;76;78;103;77;77;82;77;93;76 10:22:36 INFO - PROCESS | 32331 | |4;audio-oscillator;85;90;106;83;84;85;97;83;83;120 10:22:36 INFO - PROCESS | 32331 | |5;imaging-gaussian-blur;128;127;127;128;127;127;127;127;127;127 10:22:36 INFO - PROCESS | 32331 | |6;imaging-darkroom;148;147;147;148;147;148;147;148;148;146 10:22:36 INFO - PROCESS | 32331 | |7;imaging-desaturate;95;95;95;96;95;96;95;95;95;95 10:22:36 INFO - PROCESS | 32331 | |8;json-parse-financial;63;63;63;63;64;72;64;63;64;66 10:22:36 INFO - PROCESS | 32331 | |9;json-stringify-tinderbox;66;67;66;67;67;67;67;66;66;66 10:22:36 INFO - PROCESS | 32331 | |10;stanford-crypto-aes;86;85;86;85;85;84;84;85;85;84 10:22:36 INFO - PROCESS | 32331 | |11;stanford-crypto-ccm;144;140;143;139;139;139;154;140;192;141 10:22:36 INFO - PROCESS | 32331 | |12;stanford-crypto-pbkdf2;181;181;179;180;184;181;180;178;179;180 10:22:36 INFO - PROCESS | 32331 | |13;stanford-crypto-sha256-iterative;69;69;70;68;68;69;67;69;67;67 10:22:36 INFO - PROCESS | 32331 | __end_tp_report 10:22:36 INFO - PROCESS | 32331 | __start_cc_report 10:22:36 INFO - PROCESS | 32331 | _x_x_mozilla_cycle_collect,2010 10:22:36 INFO - PROCESS | 32331 | __end_cc_report 10:22:36 INFO - PROCESS | 32331 | __startTimestamp1481653356243__endTimestamp 10:22:36 INFO - PROCESS | 32331 | 10:22:36 INFO - PROCESS | 32331 | ------- Summary: start ------- 10:22:36 INFO - PROCESS | 32331 | Number of tests: 14 10:22:36 INFO - PROCESS | 32331 | 10:22:36 INFO - PROCESS | 32331 | [#0] ai-astar Cycles:10 Average:115.50 Median:115.50 stddev:1.27 (1.1%) stddev-sans-first:1.22 10:22:36 INFO - PROCESS | 32331 | Values: 114.0 118.0 117.0 115.0 115.0 116.0 115.0 116.0 114.0 115.0 10:22:36 INFO - PROCESS | 32331 | 10:22:36 INFO - PROCESS | 32331 | [#1] audio-beat-detection Cycles:10 Average:139.60 Median:131.50 stddev:16.53 (12.6%) stddev-sans-first:16.29 10:22:36 INFO - PROCESS | 32331 | Values: 157.0 128.0 129.0 173.0 128.0 130.0 133.0 130.0 158.0 130.0 10:22:36 INFO - PROCESS | 32331 | 10:22:36 INFO - PROCESS | 32331 | [#2] audio-dft Cycles:10 Average:162.60 Median:163.00 stddev:0.70 (0.4%) stddev-sans-first:0.71 10:22:36 INFO - PROCESS | 32331 | Values: 162.0 162.0 162.0 164.0 163.0 163.0 163.0 162.0 163.0 162.0 10:22:36 INFO - PROCESS | 32331 | 10:22:36 INFO - PROCESS | 32331 | [#3] audio-fft Cycles:10 Average:81.60 Median:77.00 stddev:9.12 (11.8%) stddev-sans-first:9.52 10:22:36 INFO - PROCESS | 32331 | Values: 77.0 76.0 78.0 103.0 77.0 77.0 82.0 77.0 93.0 76.0 10:22:36 INFO - PROCESS | 32331 | 10:22:36 INFO - PROCESS | 32331 | [#4] audio-oscillator Cycles:10 Average:91.60 Median:84.50 stddev:12.53 (14.8%) stddev-sans-first:13.06 10:22:36 INFO - PROCESS | 32331 | Values: 85.0 90.0 106.0 83.0 84.0 85.0 97.0 83.0 83.0 120.0 10:22:36 INFO - PROCESS | 32331 | 10:22:36 INFO - PROCESS | 32331 | [#5] imaging-gaussian-blur Cycles:10 Average:127.20 Median:127.00 stddev:0.42 (0.3%) stddev-sans-first:0.33 10:22:36 INFO - PROCESS | 32331 | Values: 128.0 127.0 127.0 128.0 127.0 127.0 127.0 127.0 127.0 127.0 10:22:36 INFO - PROCESS | 32331 | 10:22:36 INFO - PROCESS | 32331 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:148.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 10:22:36 INFO - PROCESS | 32331 | Values: 148.0 147.0 147.0 148.0 147.0 148.0 147.0 148.0 148.0 146.0 10:22:36 INFO - PROCESS | 32331 | 10:22:36 INFO - PROCESS | 32331 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 10:22:36 INFO - PROCESS | 32331 | Values: 95.0 95.0 95.0 96.0 95.0 96.0 95.0 95.0 95.0 95.0 10:22:36 INFO - PROCESS | 32331 | 10:22:36 INFO - PROCESS | 32331 | [#8] json-parse-financial Cycles:10 Average:64.50 Median:64.00 stddev:2.80 (4.4%) stddev-sans-first:2.92 10:22:36 INFO - PROCESS | 32331 | Values: 63.0 63.0 63.0 63.0 64.0 72.0 64.0 63.0 64.0 66.0 10:22:36 INFO - PROCESS | 32331 | 10:22:36 INFO - PROCESS | 32331 | [#9] json-stringify-tinderbox Cycles:10 Average:66.50 Median:67.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 10:22:36 INFO - PROCESS | 32331 | Values: 66.0 67.0 66.0 67.0 67.0 67.0 67.0 66.0 66.0 66.0 10:22:36 INFO - PROCESS | 32331 | 10:22:36 INFO - PROCESS | 32331 | [#10] stanford-crypto-aes Cycles:10 Average:84.90 Median:85.00 stddev:0.74 (0.9%) stddev-sans-first:0.67 10:22:36 INFO - PROCESS | 32331 | Values: 86.0 85.0 86.0 85.0 85.0 84.0 84.0 85.0 85.0 84.0 10:22:36 INFO - PROCESS | 32331 | 10:22:36 INFO - PROCESS | 32331 | [#11] stanford-crypto-ccm Cycles:10 Average:147.10 Median:142.00 stddev:16.41 (11.6%) stddev-sans-first:17.37 10:22:36 INFO - PROCESS | 32331 | Values: 144.0 140.0 143.0 139.0 139.0 139.0 154.0 140.0 192.0 141.0 10:22:36 INFO - PROCESS | 32331 | 10:22:36 INFO - PROCESS | 32331 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.30 Median:180.50 stddev:1.64 (0.9%) stddev-sans-first:1.72 10:22:36 INFO - PROCESS | 32331 | Values: 181.0 181.0 179.0 180.0 184.0 181.0 180.0 178.0 179.0 180.0 10:22:36 INFO - PROCESS | 32331 | 10:22:36 INFO - PROCESS | 32331 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:69.00 stddev:1.06 (1.5%) stddev-sans-first:1.09 10:22:36 INFO - PROCESS | 32331 | Values: 69.0 69.0 70.0 68.0 68.0 69.0 67.0 69.0 67.0 67.0 10:22:36 INFO - PROCESS | 32331 | -------- Summary: end -------- 10:22:36 INFO - PROCESS | 32331 | 10:22:37 INFO - TEST-INFO | 32331: exit 0 10:22:37 INFO - TEST-OK | kraken | took 66114ms 10:22:37 INFO - SUITE-END | took 1190s 10:22:37 INFO - Completed test suite (00:19:50) 10:22:37 INFO - javascript benchmark 10:22:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2609.8956041758324, 2639.3533584271854, 2659.70743218246, 2672.2384120525644, 2682.222155574882, 4742.69172503787, 4775.14047471455, 4803.663743537953, 4827.227643577028, 4878.634102442317, 4798.0, 4804.37543119394, 4830.951690483094, 4851.126797176506, 4903.583195428393, 4403.515613282536, 4425.645948324142, 4448.0436706108185, 4448.733076015449, 4453.51011388747, 4463.285874260119, 4485.573870482299, 4509.819607215723, 4511.030128522367, 4547.18150732868, 4469.463664360265, 4505.121501307246, 4511.842085527007, 4516.525764794715, 4539.319102134673, 4360.847370342054, 4393.626541743955, 4401.5598440156045, 4409.867703968886, 4426.468823741139, 4404.977975110136, 4406.471223453206, 4445.022095139064, 4461.5315391883705, 4483.955160448387, 4783.4499032611, 4804.399450068741, 4835.830745923911, 4854.514548545118, 4906.0, 5019.372578427697, 5065.898682026339, 5066.82266120684, 5178.844634660966, 5181.1969144782615, 5156.046131465653, 5180.844574662766, 5194.68831870089, 5215.035218484592, 5265.0, 4862.610991120667, 4865.489123642037, 4869.123557759637, 4874.975625121922, 4912.484189160086, 5056.620753443506, 5314.813981510706, 5315.574754019669, 5317.760700768475, 5319.734013299397, 4878.756062196876, 4924.581410580141, 4974.801007959641, 4999.725015124203, 5008.749562521859, 5093.8726531837, 5095.261187127846, 5095.821646242438, 5095.847124586194, 5133.076046311699, 5015.724135172528, 5021.297018417425, 5076.568491678175, 5108.3103780989095, 5119.795208191705, 4993.950060499348, 5030.069437154065, 5039.168537191323, 5050.77271522775, 5056.9633225188745, 4409.867703968886, 4424.225760491901, 4432.224360736858, 4444.0, 4455.68810183284, 3846.3268927937497, 3847.7691338519217, 3851.2105018471148, 3874.496315479026, 3888.6305800948867, 4326.221280169537, 4347.760873152007, 4417.690761646718, 4425.579569940851, 4467.754273514988, 5154.587632989352, 5159.0, 5164.845054648366, 5200.375954885438, 5267.631265811433, 4437.911241775147, 4438.378626992224, 4443.844465443694, 4446.110777844444, 4481.731096134243, 4633.0733853229485, 4711.929321060187, 4722.362481065013, 4722.5513576210205, 4765.69023013503, 4765.237561990065, 4778.713277203379, 4828.275758636232, 4832.855014349575, 4836.395450568679, 5168.638195326291, 5198.272241886215, 5253.894922101613, 5254.395744489432, 5302.39022512416, 4847.466778654416, 4851.830185943475, 4871.537203965618, 4898.53463920927, 4902.019596080727, 5166.509181627739, 5171.9482805171465, 5173.0, 5174.97412512935, 5224.451432599674, 4971.875703107451, 5005.174146265826, 5204.453532379046, 5248.527632513092, 5261.710605916558, 5005.674631148963, 5012.523810238022, 5018.749062546931, 5063.924041139312, 5119.769610367468, 5008.6744361616375, 5061.670991385548, 5064.18972964324, 5075.0, 5118.360204974379, 4814.398200224972, 4956.157453232887, 4987.251912213052, 5000.224965130411, 5000.899982000266, 4957.727324997016, 5021.84934451967, 5027.245913112916, 5032.3961124665275, 5033.043721692867, 4936.03747269279, 4983.950160498349, 4986.12742770021, 5005.174146265826, 5020.0], "value": 4736.747001232101, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [514.8841510660101, 544.8093167391413, 545.9727013649317, 549.390176903637, 562.1258942344652, 28697.282567935785, 29428.0, 41713.16573668529, 43573.0, 43791.34312985308, 39578.40632390516, 40199.799001004954, 40208.59791402085, 40213.19573608526, 40214.59785402145, 7480.13978392485, 7675.9232407676045, 7680.731174408897, 7706.113796913371, 7706.6917323307, 7338.082739657543, 7548.20743821899, 7555.16893141754, 9563.569639366211, 9827.115559599635, 9945.90054099457, 10015.098641122298, 10015.248856335767, 10022.649207277747, 10024.348417352885, 9875.40747555149, 9938.254630902638, 9939.55272012754, 9948.950255248714, 9957.004299570057, 9711.125998660083, 9821.607135714563, 9823.90176098237, 9824.459654718987, 9834.262430317684, 37255.254894902224, 37732.24535509302, 37734.24531509355, 37735.62264377349, 37748.24503509914, 2878.33798226407, 2939.7501212396974, 2999.205210619166, 3092.8298943558098, 3248.772585918987, 27743.0, 28316.433671326457, 28348.57477137824, 28787.99242026519, 29268.41463170725, 3474.2356681530023, 3489.6510348965153, 3518.2611651553207, 3547.255076433952, 3566.1084728817796, 244063.0, 244733.77633111898, 245339.0, 245847.0, 245873.0, 53080.73459632677, 53631.731841340545, 53634.73182634062, 53647.46352536503, 53716.0, 55929.720351397984, 56029.0, 56049.71975140098, 56062.0, 56134.15798763022, 13291.66770830737, 13637.249951252776, 13667.583104223944, 13668.453261869612, 13671.726565468634, 8498.320134389234, 9781.657641982496, 10045.447500387403, 10047.296689231829, 10051.296409251283, 14491.0, 16674.83325166757, 17126.40057597978, 17168.22742976569, 17819.19813608391, 5430.13117901134, 5631.099024156116, 5686.60193786431, 5703.372629010805, 5726.341470730919, 793.964271607779, 848.9872651910226, 880.5773228850188, 904.3759805734022, 972.7811242470387, 26061.478770424485, 27044.45911081807, 27129.864350678516, 27428.86285568599, 27576.0, 906.954652267384, 947.5120313038791, 976.7509285132246, 1006.3961623026125, 1025.564135242519, 14384.640383990483, 14596.34316455762, 14609.707805843824, 14613.693153423288, 14797.63005924839, 352877.0, 353597.0, 354454.0, 354704.0, 355043.0, 42995.140097198506, 44118.33822492665, 47974.28038579424, 49325.0, 49362.75318623384, 1148.4717030166216, 1149.5918948773233, 1155.0759392485977, 1158.8145896656495, 1172.267332916927, 26549.33626659349, 27724.722752772213, 27905.0, 28517.714822851507, 28709.56935645925, 38098.80950595229, 38488.0, 38492.807535963264, 38572.0, 38584.22831543297, 297307.0, 299424.0, 300312.0, 301269.0, 301321.0, 35177.0, 35302.0, 35446.29107417889, 35559.28881422305, 35576.64423355837, 36701.44947825838, 37131.25737485181, 41118.38322425106, 41275.38086928758, 41418.0, 34820.65179348174, 34957.47563786495, 35127.47308790319, 35450.29099417946, 35635.82182089073, 33991.32017359688, 34235.31529369448, 34391.0, 34417.48373774345, 34528.0, 33877.322453550296, 33991.66008339885, 34608.134796630286, 34650.48024279587, 34963.300733984666, 30180.396392072475, 32262.838685806422, 32528.331692003554, 32573.674263258014, 32735.0, 23861.522769544164, 24317.878410607835, 24380.524597657433, 24445.144419945216, 24896.87551562303], "value": 17446.57252686682, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.0786400311169, 361.64197444529924, 369.68207341686156, 372.92727918055976, 384.79413513770123, 12359.134860559765, 12426.130170888042, 13245.403956821954, 13387.39756710948, 16726.16369181542, 16224.594385140377, 16493.092879891603, 16628.085455299955, 16745.07902065386, 16797.748033779473, 4791.640626952975, 4800.711957282557, 4943.184374578191, 4967.180415231483, 4969.503049695038, 3618.203995121069, 3817.6945844332527, 4746.501617330166, 4815.855524334275, 4817.22924332107, 3786.532140339024, 3807.638274363931, 3824.273388056274, 3837.57786643469, 3972.423998520213, 5743.368229494773, 5806.65160090396, 5808.186853840466, 5810.477057064884, 5810.506106980912, 4950.257461380786, 5116.769745361467, 5121.359830021247, 5130.025295193938, 5151.819686310999, 19381.224751009944, 19534.80465195344, 19631.214751409927, 19665.80334196654, 19732.60534789296, 1965.5872266823985, 1977.5847072114873, 2006.398080575836, 2067.2041264113273, 2351.670766092748, 12278.386080696018, 12493.875061249362, 12883.871161288362, 13286.734265314639, 13303.068785185042, 1685.4859267923277, 1698.269744010075, 1702.4807433732706, 1719.6302794899157, 1752.1326943163087, 63681.552312698346, 63950.360496394904, 65441.672791635734, 66342.33657663362, 66979.95300704884, 9353.766155846159, 9511.191548718298, 9612.855807162898, 9863.457509836884, 9957.954414786487, 13179.341032948314, 13389.531366402129, 13405.66485837862, 13409.463621455228, 13432.261225632685, 6754.898676519856, 6887.311268873173, 6912.516123871382, 6955.582665040114, 7278.526895751759, 6703.899441508382, 6740.39336459721, 6761.830954226184, 6951.374376306157, 6951.7219311228, 5232.476752324813, 5611.186377975171, 5680.573956953245, 5980.611260268156, 6255.654129701362, 1672.757450169743, 1748.2307784574746, 1766.9381571645188, 1814.8638852086146, 1824.3888297420247, 787.8109253779166, 846.8899043124354, 890.844102282098, 917.9862302065475, 945.664289177346, 16374.0, 16872.915635421745, 17123.91438042827, 17519.47441576755, 18085.819141808675, 847.8007668197969, 852.1435956863313, 866.7226487524058, 877.2499512916493, 901.833160865242, 9427.764305892408, 10030.949845250727, 10061.19510439163, 10107.494625268708, 10123.836843210016, 263394.0, 267895.0, 268341.0, 347168.0, 347311.0, 54049.0, 66171.66914165398, 76965.0, 77953.0, 79177.60411197908, 825.1913125137279, 842.0821304777821, 860.7116615933608, 862.0904945282662, 898.5013317608659, 14891.62770930692, 15009.799216062907, 15583.06501609907, 15764.132972686612, 15793.21033948321, 35538.64461355354, 35713.0, 35869.64130358663, 36170.81914590515, 36794.816025919696, 50133.0, 50659.0, 50718.74640626773, 52527.0, 53554.46445535651, 7261.854762904818, 7303.634818259172, 7590.886136708064, 7623.65693543803, 7646.808829779077, 8741.606627701896, 8841.955790221007, 10834.566617335218, 11289.943550282196, 11317.547298107984, 9969.750756231153, 10049.648262310784, 10085.798284034425, 10378.636747713794, 10658.893411066101, 9753.9024609753, 10080.69757907264, 10090.0, 10130.594776208869, 10189.082982531607, 8123.918760812317, 8539.231469167804, 10200.795984080129, 10340.741481463023, 10720.195985300978, 6719.529632925648, 6908.171019477695, 6946.826329341807, 7588.886166707614, 7797.727079552188, 9618.759531011781, 10080.0, 10288.382697038202, 10450.68647940563, 10540.367577945348], "value": 7962.9058456222465, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1331.3542931678135, 1346.8114463975041, 1412.8516505766895, 1638.827923068077, 1645.5803770038638, 6765.154355705537, 7098.0, 7105.4315654747625, 7123.67943442545, 7130.679119439625, 6282.591631543958, 6494.383033611811, 6979.197392299887, 7256.346928776409, 7300.415966722663, 2098.8320934325257, 2160.308701215604, 2164.166795783619, 2164.5779073080676, 2168.2086038595958, 2121.1939463004037, 2165.404513758721, 2185.7486389065302, 2185.901634426447, 2194.659827726705, 2123.3629911026705, 2125.532382875773, 2131.3712454825863, 2149.140343862452, 2152.354293711888, 2069.668852983523, 2091.6862470629526, 2091.989540052305, 2095.2771293903656, 2096.056774451488, 2043.0806137238153, 2088.8433367497346, 2093.2568938027084, 2094.057674046685, 2095.235239137719, 7158.176809666903, 7184.173820010661, 7290.125184977836, 7312.341889229941, 7317.451191160631, 4389.122175564868, 4523.819047238107, 4529.04889973106, 4530.161920044802, 4532.025614492867, 2716.578930265792, 2903.3177203357195, 2908.287469569948, 2962.1409791160536, 2962.7926045176846, 842.9653248306049, 935.200403654872, 965.8406362950104, 971.4122955611824, 981.6711401680445, 9322.720318390458, 9573.808523829553, 9590.808183836354, 9595.136437720568, 9601.231901447867, 3846.211526637033, 4006.078601921516, 4060.939085913714, 4106.3635136553285, 4127.5666055064385, 8328.625211865481, 8335.791605209919, 8349.165083491602, 8351.832963340821, 8352.206540378655, 4541.159885421208, 4555.977220113945, 4558.6581006423985, 4559.270516717309, 4563.589276965089, 3576.6065732769375, 3690.372636651776, 4005.2590270799415, 4091.2226676931286, 4171.749695018309, 3437.914052148666, 3453.671901169385, 3571.607123216444, 3574.5531808523933, 3574.6246644102516, 1132.416805345248, 1170.0288760328906, 1172.724409763722, 1180.3685028509706, 1187.3528926734778, 747.917729049804, 821.2813787935556, 826.3182874128868, 832.2010869565164, 832.7376876283951, 5041.8487445376695, 5070.41690205631, 5092.439831618519, 5112.821051263188, 5218.582513398919, 401.78303715993036, 413.7765606572417, 416.44404719698935, 421.02742664444617, 422.74635218868434, 3438.1920248741526, 3457.2221250219004, 3496.3881320769274, 3588.982055089708, 3833.0800607853917, 8345.123762005023, 8403.537805420638, 8471.322294216448, 8532.189442003, 8536.359773017048, 8413.70552030676, 8422.199891010345, 8423.873641895376, 8426.4944103354, 8427.115152908857, 6656.900146497806, 6855.4172895304455, 6867.07294515244, 6873.518853680194, 6882.03651488792, 5216.217567364925, 5233.869153271199, 5298.390685071112, 5330.493603107699, 5551.722413879209, 7956.562389068657, 7993.560354180576, 8015.078265999251, 8018.278354948083, 8077.0, 7935.801604959922, 8089.47418417801, 8183.222593853575, 8220.58897055133, 8280.71017514384, 5554.833354999357, 5714.314282285986, 6009.338972713085, 6243.188385509855, 6321.577645029832, 6743.865122697421, 6927.896081558882, 6935.479839011993, 6942.097527321416, 7060.576365417885, 6252.843678908063, 6256.567859621223, 6404.487640988803, 6511.21865376139, 6542.182227221598, 6232.096346029891, 6251.124842522141, 6353.047042943411, 6382.234131904202, 6595.8021259362295, 6007.459328660441, 6162.921488739363, 6165.075238714228, 6200.162977998093, 6206.596571222856, 4359.782010899379, 4609.285560738091, 4617.8383756568355, 4628.375169352229, 4666.9533304667875, 4486.50648428666, 4528.071745292142, 4566.543345665407, 4635.072985402865, 4642.675012749075], "value": 3870.955158380212, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.2272999401316, 352.08809184212885, 357.94809752585866, 365.0690738616527, 366.42288395776643, 4865.002674451734, 4904.043711476259, 4924.187509061001, 4928.211486162215, 4945.826896058638, 4875.148038397541, 4879.707217566948, 4880.46314905361, 4913.680610760298, 4926.605871530278, 3553.573571171463, 3749.999999999993, 3822.719389004687, 3850.8074596270217, 3956.347202711549, 3916.295066887959, 3918.9020274493223, 3937.6849852011915, 3943.349347357697, 3954.130091379892, 3862.633049860259, 3893.279743247508, 3897.2205558888195, 3903.7657740535515, 3913.3542965410816, 3703.6296370363016, 3808.5620153682403, 3838.7888666123354, 3876.6898648108086, 3900.8049597520153, 3497.5278337424375, 3517.82410879455, 3527.153483164048, 3536.169000284931, 3536.91157721059, 4746.169420351459, 4749.311349854252, 4752.192127338326, 4755.524447555252, 4786.305985632099, 4319.50325712544, 4494.325876103713, 4505.986153115556, 4515.819367225307, 4520.355591978697, 5077.720725360104, 5081.18701007837, 5113.1052065888325, 5122.28288039671, 5132.794688212504, 3822.0444888777806, 3830.9042273943096, 3834.0, 3867.6712479439, 3881.8059097045316, 5114.667546609458, 5200.193969934666, 5284.313039304866, 5401.648892821954, 5404.054290499147, 3974.2448934702315, 3974.5492895093084, 3975.34406822871, 3998.3202855514633, 4003.4795476587856, 4022.6781857451333, 4035.1929614077303, 4047.251258517184, 4051.108756073659, 4057.3711074783455, 4065.9593404066172, 4448.666350023761, 4459.175052615276, 4491.685582009293, 4494.280915053576, 5055.949440505621, 5082.288479612857, 5083.923741143886, 5098.490150984871, 5106.310648062538, 1261.520622163572, 1265.4811527273773, 1265.5064524835323, 1265.9873401266054, 1272.351100938528, 823.6664151018847, 858.403409630301, 866.1728049712509, 872.1801506583791, 873.9344549158711, 4383.627391671744, 4386.758728269912, 4388.429504164438, 4397.2304846651705, 4398.912021759547, 5039.344885164978, 5090.211017292326, 5106.753028667375, 5138.58891288696, 5156.819511317086, 4334.940903071016, 4360.215161271001, 4384.868453946387, 4396.922154491868, 4431.534688857688, 2606.687197536308, 2722.278596172016, 2736.3022429280804, 2743.396452780385, 2759.5788169092934, 4797.193641719563, 4816.301636262792, 4818.494058123917, 4830.661853670209, 4836.694092594979, 5161.4322424533275, 5293.279684102682, 5302.628815982921, 5315.176147697113, 5319.4414586467865, 4920.975395123073, 4927.433345165208, 4945.703257804471, 4950.950490495049, 4951.282064100757, 5312.867178320573, 5322.840314790563, 5334.573234141337, 5337.25278461008, 5354.518093371616, 5005.648474911826, 5222.9216561750845, 5241.68549887008, 5244.580433565382, 5294.629375943647, 4771.212749896228, 4772.141014617263, 4866.0, 4910.459849416633, 4958.380202474691, 3665.981670091739, 3688.3360995021153, 3688.502052223023, 3699.815009249473, 3699.852005919733, 5271.868203294948, 5278.4721527846905, 5289.550388217045, 5297.973510132425, 5306.204069389622, 4969.527894849984, 5069.631199576168, 5069.8732531687, 5101.69389836611, 5144.074066668036, 5099.23511473282, 5110.718910459812, 5113.463086375877, 5121.206213036985, 5127.87180320495, 5044.218146187347, 5083.313752643346, 5089.51649593288, 5090.0, 5091.261767043832, 5041.621878359065, 5161.587073034223, 5177.534021938043, 5196.116660167856, 5198.818041368534, 5038.798448062036, 5040.798368065236, 5058.848234552969, 5064.5441910228255, 5066.898662026812], "value": 3892.08403179327, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [629.7229219143577, 649.2566011916355, 661.3386613386614, 704.3203308807, 735.2243383230691, 12216.755664886698, 13220.40508177132, 13237.13958592692, 13256.270905100215, 13260.93369533151, 13291.0, 13432.126911750729, 13435.395407206675, 13438.0, 13441.193528388303, 766.0, 783.3380793229741, 786.1745167574053, 796.8485987662326, 796.928276455119, 779.9025121859768, 782.5578548120322, 782.7808213700173, 782.9491083079581, 783.1424590073889, 822.0915887943826, 823.9629216685233, 824.1922915542772, 825.0470706334194, 825.3438516379492, 818.8853560501534, 819.0376307838326, 820.6307161777224, 820.741466438076, 820.827626198499, 601.3955974245898, 601.4646964201863, 601.6480358989952, 601.6841158391835, 601.8074216250801, 13233.206007639476, 13326.866731332757, 13350.399232034582, 13357.465701371933, 13681.452741890413, 12479.812802807965, 12922.483100675961, 13093.345332733421, 13248.47006119754, 13315.267660278681, 10345.222276964076, 10392.532336044897, 10470.895291047069, 10726.892731072667, 10801.729956751065, 3173.539836723662, 3194.7923384979904, 3199.2641692410875, 3199.3601279744144, 3298.224917144469, 63965.3603463964, 66057.0, 66200.33799662038, 66410.0, 66593.99999999952, 9308.162265396148, 9432.905670943202, 9433.669821556212, 9632.662856799978, 9684.32209745311, 18776.436706898814, 18789.530261743294, 18814.52963675919, 18828.341008064654, 18855.905720471583, 5463.3717122530625, 5511.559075273968, 5545.639533430314, 5576.693281869536, 5927.673977931169, 3628.5101511296166, 3669.2111196092433, 3713.405855063177, 3802.1825307559006, 3810.047488127968, 2836.5319722246013, 2908.2147820088458, 2909.2726818295428, 2926.414717056597, 3128.8748450061744, 527.9155335146359, 530.6815910453697, 531.8112070215095, 535.3254898827428, 543.0225593930909, 467.21274652211133, 556.5964675610231, 562.2522045679236, 573.7102763104689, 578.8292453726077, 7317.1219453664835, 7344.118705755237, 7467.626618669045, 7550.886736698954, 7672.846543069108, 529.1797713543991, 546.4644648244663, 566.1677334318545, 567.7218163100134, 585.5754577930966, 3310.586176727909, 3532.6643968822923, 3636.7999760012926, 3637.0153176787867, 3657.0, 72522.0, 73058.0, 73409.0, 74455.25544744592, 74661.0, 63860.0, 63998.68000659967, 64763.0, 65002.34997649963, 65402.67298663476, 53047.0, 55631.443685562626, 55679.0, 55866.441335586125, 56255.71872140695, 8090.7168249111, 8505.277051450696, 8657.17756813127, 8736.170063843925, 8757.649694012169, 34057.65942340545, 34280.48579271263, 34310.48534271938, 34750.304993900485, 35347.293054139285, 45131.54868451274, 45363.0, 45998.0, 46198.53801461942, 46496.0, 10351.534180961724, 10679.199060070681, 10873.238873279111, 10950.945245273722, 11119.555217791198, 10575.788484230427, 10848.349099054081, 10993.835092473779, 11311.434428278717, 11395.772084558428, 11430.599929002445, 11610.767784644091, 11980.028303202893, 12028.15802893789, 12059.51761929513, 10909.127269818237, 11059.834102488308, 11203.103751700008, 11598.594049208237, 11636.592719254786, 11260.83108753353, 11466.484008219484, 11672.299662020307, 11835.46740396667, 12280.508779648713, 9373.0, 9430.387024843363, 9560.569774360032, 9595.0, 10215.795684086424, 8999.37004409685, 9733.415995040037, 9746.707598772047, 10021.498925053864, 10140.188784897338], "value": 6203.519691503027, "unit": "score"}], "name": "dromaeo_css", "value": 6282.875083307285, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 118.0, 117.0, 115.0, 115.0, 116.0, 115.0, 116.0, 114.0, 115.0], "value": 115.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 128.0, 129.0, 173.0, 128.0, 130.0, 133.0, 130.0, 158.0, 130.0], "value": 139.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 164.0, 163.0, 163.0, 163.0, 162.0, 163.0, 162.0], "value": 162.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 78.0, 103.0, 77.0, 77.0, 82.0, 77.0, 93.0, 76.0], "value": 81.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 90.0, 106.0, 83.0, 84.0, 85.0, 97.0, 83.0, 83.0, 120.0], "value": 91.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 127.0, 127.0, 128.0, 127.0, 127.0, 127.0, 127.0, 127.0, 127.0], "value": 127.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 147.0, 148.0, 147.0, 148.0, 147.0, 148.0, 148.0, 146.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 63.0, 64.0, 72.0, 64.0, 63.0, 64.0, 66.0], "value": 64.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 66.0, 67.0, 67.0, 67.0, 67.0, 66.0, 66.0, 66.0], "value": 66.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 86.0, 85.0, 85.0, 84.0, 84.0, 85.0, 85.0, 84.0], "value": 84.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 140.0, 143.0, 139.0, 139.0, 139.0, 154.0, 140.0, 192.0, 141.0], "value": 147.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 181.0, 179.0, 180.0, 184.0, 181.0, 180.0, 178.0, 179.0, 180.0], "value": 180.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 70.0, 68.0, 68.0, 69.0, 67.0, 69.0, 67.0, 67.0], "value": 68.3, "unit": "score"}], "name": "kraken", "value": 1572.3, "alertThreshold": 2.0}]} 10:22:37 INFO - Return code: 0 10:22:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:22:38 INFO - # TBPL SUCCESS # 10:22:38 INFO - Running post-action listener: _resource_record_post_action 10:22:38 INFO - [mozharness: 2016-12-13 18:22:38.063406Z] Finished run-tests step (success) 10:22:38 INFO - Running post-run listener: _resource_record_post_run 10:22:38 INFO - Total resource usage - Wall time: 1208s; CPU: 13.0%; Read bytes: 4096; Write bytes: 405495808; Read time: 12; Write time: 349972 10:22:38 INFO - TinderboxPrint: CPU usage
13.2% 10:22:38 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 10:22:38 INFO - TinderboxPrint: I/O write bytes / time
405,495,808 / 349,972 10:22:38 INFO - TinderboxPrint: CPU idle
8,368.8 (86.8%) 10:22:38 INFO - TinderboxPrint: CPU user
1,215.7 (12.6%) 10:22:38 INFO - TinderboxPrint: Swap in / out
0 / 0 10:22:38 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 100003840; Read time: 0; Write time: 99608 10:22:38 INFO - run-tests - Wall time: 1191s; CPU: 13.0%; Read bytes: 0; Write bytes: 288804864; Read time: 0; Write time: 244484 10:22:38 INFO - Running post-run listener: _upload_blobber_files 10:22:38 INFO - Blob upload gear active. 10:22:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:22:38 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 10:22:38 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:22:38 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:22:39 INFO - (blobuploader) - INFO - Open directory for files ... 10:22:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:22:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:22:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:22:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:22:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:22:42 INFO - (blobuploader) - INFO - Done attempting. 10:22:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:22:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:22:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:22:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:22:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:22:43 INFO - (blobuploader) - INFO - Done attempting. 10:22:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:22:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:22:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:22:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:22:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:22:43 INFO - (blobuploader) - INFO - Done attempting. 10:22:43 INFO - (blobuploader) - INFO - Iteration through files over. 10:22:43 INFO - Return code: 0 10:22:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:22:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:22:43 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0db9a36748706d529b056290980cddd63c8e1e4ce4bba09ae5ed7af7b9e8990995c42bc54d9fe8ff3531be9bc6255495631fc7bda77c46c8244eb243da04161f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1e3c041e29916721e7c50905ee92aa327b649a4c8e662900eb80a2823ffac5cbc0b205158d6cf8f22dab05736542fa9dad60824dc0cfe24134c1145ecd6d86c4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/36e3ba1e51a23d0209c66218fc9ad38ef1c4747838c5875112bd382cd07bc5c953eaaa369c98b6a9935b4b307b4351ebc4dc0d9624c62699c763ba03fd00e3a8"} 10:22:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:22:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:22:43 INFO - Contents: 10:22:43 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0db9a36748706d529b056290980cddd63c8e1e4ce4bba09ae5ed7af7b9e8990995c42bc54d9fe8ff3531be9bc6255495631fc7bda77c46c8244eb243da04161f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1e3c041e29916721e7c50905ee92aa327b649a4c8e662900eb80a2823ffac5cbc0b205158d6cf8f22dab05736542fa9dad60824dc0cfe24134c1145ecd6d86c4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/36e3ba1e51a23d0209c66218fc9ad38ef1c4747838c5875112bd382cd07bc5c953eaaa369c98b6a9935b4b307b4351ebc4dc0d9624c62699c763ba03fd00e3a8"} 10:22:43 INFO - Running post-run listener: copy_logs_to_upload_dir 10:22:43 INFO - Copying logs to upload dir... 10:22:43 INFO - mkdir: /builds/slave/test/build/upload/logs 10:22:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.939018 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-12-13 10:22:43.710125) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-13 10:22:43.713427) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1481651706.286370-1723659657 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0db9a36748706d529b056290980cddd63c8e1e4ce4bba09ae5ed7af7b9e8990995c42bc54d9fe8ff3531be9bc6255495631fc7bda77c46c8244eb243da04161f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1e3c041e29916721e7c50905ee92aa327b649a4c8e662900eb80a2823ffac5cbc0b205158d6cf8f22dab05736542fa9dad60824dc0cfe24134c1145ecd6d86c4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/36e3ba1e51a23d0209c66218fc9ad38ef1c4747838c5875112bd382cd07bc5c953eaaa369c98b6a9935b4b307b4351ebc4dc0d9624c62699c763ba03fd00e3a8"} build_url:https://queue.taskcluster.net/v1/task/HdFBkxqyReGQ0JCq6xL_mA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011968 build_url: 'https://queue.taskcluster.net/v1/task/HdFBkxqyReGQ0JCq6xL_mA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0db9a36748706d529b056290980cddd63c8e1e4ce4bba09ae5ed7af7b9e8990995c42bc54d9fe8ff3531be9bc6255495631fc7bda77c46c8244eb243da04161f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1e3c041e29916721e7c50905ee92aa327b649a4c8e662900eb80a2823ffac5cbc0b205158d6cf8f22dab05736542fa9dad60824dc0cfe24134c1145ecd6d86c4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/36e3ba1e51a23d0209c66218fc9ad38ef1c4747838c5875112bd382cd07bc5c953eaaa369c98b6a9935b4b307b4351ebc4dc0d9624c62699c763ba03fd00e3a8"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-13 10:22:43.740952) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-13 10:22:43.741386) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1481651706.286370-1723659657 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004515 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-13 10:22:43.823895) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-13 10:22:43.824374) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-13 10:22:43.824895) ========= ========= Total master_lag: 0.18 =========