builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-045 starttime: 1483611639.66 results: success (0) buildid: 20170105015754 builduid: 0a483729ca0c4ca781d874647df5d9c5 revision: c069e5e1e63f5d4ae8d7857f7b0d5798b81a657c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-05 02:20:39.657837) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-05 02:20:39.658308) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-05 02:20:39.658630) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-05 02:20:39.673852) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 02:20:39.674241) ========= 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=4300f881736b422476174874000001bc-1483611639.445210-549087217 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-05 02:20:40-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 70.4M=0s 2017-01-05 02:20:40 (70.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.116030 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 02:20:39.804202) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 02:20:39.804551) ========= 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=4300f881736b422476174874000001bc-1483611639.445210-549087217 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019142 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 02:20:39.854509) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 02:20:39.854866) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev c069e5e1e63f5d4ae8d7857f7b0d5798b81a657c --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev c069e5e1e63f5d4ae8d7857f7b0d5798b81a657c --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=4300f881736b422476174874000001bc-1483611639.445210-549087217 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-05 02:20:40,338 truncating revision to first 12 chars 2017-01-05 02:20:40,338 Setting DEBUG logging. 2017-01-05 02:20:40,338 attempt 1/10 2017-01-05 02:20:40,339 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/c069e5e1e63f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-05 02:20:40,658 unpacking tar archive at: mozilla-inbound-c069e5e1e63f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.618132 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 02:20:40.485669) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-05 02:20:40.486001) ========= script_repo_revision: c069e5e1e63f5d4ae8d7857f7b0d5798b81a657c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-05 02:20:40.486446) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-05 02:20:40.486736) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-05 02:20:40.494778) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2017-01-05 02:20:40.495347) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=4300f881736b422476174874000001bc-1483611639.445210-549087217 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:20:41 INFO - MultiFileLogger online at 20170105 02:20:41 in /builds/slave/test 02:20:41 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 02:20:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:20:41 INFO - {'append_to_log': False, 02:20:41 INFO - 'base_work_dir': '/builds/slave/test', 02:20:41 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 02:20:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:20:41 INFO - 'branch': 'Mozilla-Inbound', 02:20:41 INFO - 'buildbot_json_path': 'buildprops.json', 02:20:41 INFO - 'config_files': ('talos/linux_config.py',), 02:20:41 INFO - 'default_actions': ('clobber', 02:20:41 INFO - 'read-buildbot-config', 02:20:41 INFO - 'download-and-extract', 02:20:41 INFO - 'populate-webroot', 02:20:41 INFO - 'create-virtualenv', 02:20:41 INFO - 'install', 02:20:41 INFO - 'run-tests'), 02:20:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:20:41 INFO - 'download_minidump_stackwalk': True, 02:20:41 INFO - 'download_symbols': 'ondemand', 02:20:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:20:41 INFO - 'tooltool.py': '/tools/tooltool.py', 02:20:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:20:41 INFO - '/tools/misc-python/virtualenv.py')}, 02:20:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:20:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:20:41 INFO - 'installer_path': 'installer.exe', 02:20:41 INFO - 'log_level': 'info', 02:20:41 INFO - 'log_name': 'talos', 02:20:41 INFO - 'log_to_console': True, 02:20:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:20:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:20:41 INFO - 'opt_config_files': (), 02:20:41 INFO - 'pip_index': False, 02:20:41 INFO - 'sps_profile': False, 02:20:41 INFO - 'sps_profile_interval': 0, 02:20:41 INFO - 'suite': 'dromaeojs-e10s', 02:20:41 INFO - 'system_bits': '32', 02:20:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:20:41 INFO - 'title': 'talos-linux64-ix-045', 02:20:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:20:41 INFO - 'use_talos_json': True, 02:20:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:20:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:20:41 INFO - 'work_dir': 'build'} 02:20:41 INFO - [mozharness: 2017-01-05 10:20:41.070576Z] Running clobber step. 02:20:41 INFO - Running pre-action listener: _resource_record_pre_action 02:20:41 INFO - Running main action method: clobber 02:20:41 INFO - rmtree: /builds/slave/test/build 02:20:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:20:41 INFO - Running post-action listener: _resource_record_post_action 02:20:41 INFO - [mozharness: 2017-01-05 10:20:41.530919Z] Finished clobber step (success) 02:20:41 INFO - [mozharness: 2017-01-05 10:20:41.531019Z] Running read-buildbot-config step. 02:20:41 INFO - Running pre-action listener: _resource_record_pre_action 02:20:41 INFO - Running main action method: read_buildbot_config 02:20:41 INFO - Using buildbot properties: 02:20:41 INFO - { 02:20:41 INFO - "project": "", 02:20:41 INFO - "product": "firefox", 02:20:41 INFO - "script_repo_revision": "production", 02:20:41 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 02:20:41 INFO - "repository": "", 02:20:41 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 02:20:41 INFO - "buildid": "20170105015754", 02:20:41 INFO - "stage_platform": "linux64-pgo", 02:20:41 INFO - "basedir": "/builds/slave/test", 02:20:41 INFO - "buildnumber": 2413, 02:20:41 INFO - "platform": "ubuntu64_hw", 02:20:41 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 02:20:41 INFO - "slavebuilddir": "test", 02:20:41 INFO - "branch": "mozilla-inbound", 02:20:41 INFO - "revision": "c069e5e1e63f5d4ae8d7857f7b0d5798b81a657c", 02:20:41 INFO - "slavename": "talos-linux64-ix-045", 02:20:41 INFO - "builduid": "0a483729ca0c4ca781d874647df5d9c5", 02:20:41 INFO - "repo_path": "integration/mozilla-inbound" 02:20:41 INFO - } 02:20:41 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483602863/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 02:20:41 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483602863/firefox-53.0a1.en-US.linux-x86_64.test_packages.json. 02:20:41 INFO - Running post-action listener: _resource_record_post_action 02:20:41 INFO - [mozharness: 2017-01-05 10:20:41.533381Z] Finished read-buildbot-config step (success) 02:20:41 INFO - [mozharness: 2017-01-05 10:20:41.533468Z] Running download-and-extract step. 02:20:41 INFO - Running pre-action listener: _resource_record_pre_action 02:20:41 INFO - Running main action method: download_and_extract 02:20:41 INFO - mkdir: /builds/slave/test/build/tests 02:20:41 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')]} 02:20:41 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483602863/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 02:20:41 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483602863/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 02:20:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483602863/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 02:20:41 INFO - Downloaded 1361 bytes. 02:20:41 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 02:20:41 INFO - Using the following test package requirements: 02:20:41 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 02:20:41 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 02:20:41 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:20:41 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 02:20:41 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:20:41 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 02:20:41 INFO - u'jsshell-linux-x86_64.zip'], 02:20:41 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 02:20:41 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:20:41 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 02:20:41 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 02:20:41 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:20:41 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 02:20:41 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:20:41 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 02:20:41 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:20:41 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 02:20:41 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:20:41 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:20:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483602863/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 02:20:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483602863/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:20:41 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483602863/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 02:20:41 INFO - Expected file size: 21834066 02:20:41 INFO - Obtained file size: 21834066 02:20:45 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 02:20:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483602863/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 02:20:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483602863/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:20:45 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483602863/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 02:20:46 INFO - Expected file size: 21834066 02:20:46 INFO - Obtained file size: 21834066 02:20:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483602863/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 02:20:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483602863/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:20:50 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483602863/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 02:20:51 INFO - Expected file size: 14403730 02:20:51 INFO - Obtained file size: 14403730 02:20:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:20:51 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483602863/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 02:20:51 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483602863/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 02:20:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483602863/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 02:20:51 INFO - Downloaded 61446038 bytes. 02:20:51 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483602863/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 02:20:51 INFO - mkdir: /builds/slave/test/properties 02:20:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:20:51 INFO - Writing to file /builds/slave/test/properties/build_url 02:20:51 INFO - Contents: 02:20:51 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483602863/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 02:20:52 INFO - Running post-action listener: _resource_record_post_action 02:20:52 INFO - Running post-action listener: set_extra_try_arguments 02:20:52 INFO - [mozharness: 2017-01-05 10:20:52.323488Z] Finished download-and-extract step (success) 02:20:52 INFO - [mozharness: 2017-01-05 10:20:52.323717Z] Running populate-webroot step. 02:20:52 INFO - Running pre-action listener: _resource_record_pre_action 02:20:52 INFO - Running main action method: populate_webroot 02:20:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:20:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:20:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:20:52 INFO - '--tppagecycles', 02:20:52 INFO - '7'], 02:20:52 INFO - 'tests': ['tsvgm']}}, 02:20:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:20:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:20:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:20:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:20:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:20:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:20:52 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 02:20:52 INFO - 'talos_options': ['--disable-e10s'], 02:20:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:20:52 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:20:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:20:52 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 02:20:52 INFO - 'talos_options': ['--disable-e10s'], 02:20:52 INFO - 'tests': ['damp', 'tps']}, 02:20:52 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:20:52 INFO - 'tests': ['damp', 'tps']}, 02:20:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:20:52 INFO - 'tests': ['dromaeo_dom']}, 02:20:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:20:52 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:20:52 INFO - 'tests': ['basic_compositor_video']}, 02:20:52 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:20:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:20:52 INFO - 'tests': ['a11yr', 02:20:52 INFO - 'ts_paint', 02:20:52 INFO - 'tpaint', 02:20:52 INFO - 'sessionrestore', 02:20:52 INFO - 'sessionrestore_no_auto_restore', 02:20:52 INFO - 'tabpaint']}, 02:20:52 INFO - 'other-e10s': {'tests': ['a11yr', 02:20:52 INFO - 'ts_paint', 02:20:52 INFO - 'tpaint', 02:20:52 INFO - 'sessionrestore', 02:20:52 INFO - 'sessionrestore_no_auto_restore', 02:20:52 INFO - 'tabpaint']}, 02:20:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:20:52 INFO - 'ts_paint', 02:20:52 INFO - 'tpaint', 02:20:52 INFO - 'sessionrestore', 02:20:52 INFO - 'sessionrestore_no_auto_restore', 02:20:52 INFO - 'tabpaint']}, 02:20:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:20:52 INFO - 'ts_paint', 02:20:52 INFO - 'tpaint', 02:20:52 INFO - 'sessionrestore', 02:20:52 INFO - 'sessionrestore_no_auto_restore', 02:20:52 INFO - 'tabpaint']}, 02:20:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:20:52 INFO - 'tests': ['a11yr', 02:20:52 INFO - 'ts_paint', 02:20:52 INFO - 'tpaint', 02:20:52 INFO - 'sessionrestore', 02:20:52 INFO - 'sessionrestore_no_auto_restore', 02:20:52 INFO - 'tabpaint']}, 02:20:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:20:52 INFO - 'tests': ['a11yr', 02:20:52 INFO - 'ts_paint', 02:20:52 INFO - 'tpaint', 02:20:52 INFO - 'sessionrestore', 02:20:52 INFO - 'sessionrestore_no_auto_restore', 02:20:52 INFO - 'tabpaint']}, 02:20:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:20:52 INFO - 'tests': ['tsvgx', 02:20:52 INFO - 'tsvgr_opacity', 02:20:52 INFO - 'tart', 02:20:52 INFO - 'tscrollx', 02:20:52 INFO - 'cart', 02:20:52 INFO - 'tsvg_static']}, 02:20:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:20:52 INFO - 'tsvgr_opacity', 02:20:52 INFO - 'tart', 02:20:52 INFO - 'tscrollx', 02:20:52 INFO - 'cart', 02:20:52 INFO - 'tsvg_static']}, 02:20:52 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 02:20:52 INFO - 'talos_options': ['--disable-e10s'], 02:20:52 INFO - 'tests': ['tp5o']}, 02:20:52 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:20:52 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 02:20:52 INFO - 'talos_options': ['--disable-e10s', 02:20:52 INFO - '--xperf_path', 02:20:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:20:52 INFO - 'tests': ['tp5n']}, 02:20:52 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:20:52 INFO - 'talos_options': ['--xperf_path', 02:20:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:20:52 INFO - 'tests': ['tp5n']}}, 02:20:52 INFO - 'talos.zip': {'path': '', 02:20:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:20:52 INFO - Running post-action listener: _resource_record_post_action 02:20:52 INFO - [mozharness: 2017-01-05 10:20:52.343379Z] Finished populate-webroot step (success) 02:20:52 INFO - [mozharness: 2017-01-05 10:20:52.343467Z] Running create-virtualenv step. 02:20:52 INFO - Running pre-action listener: _resource_record_pre_action 02:20:52 INFO - Running main action method: create_virtualenv 02:20:52 INFO - Creating virtualenv /builds/slave/test/build/venv 02:20:52 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 02:20:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:20:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:20:52 INFO - Using real prefix '/usr' 02:20:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:20:53 INFO - Installing distribute.............................................................................................................................................................................................done. 02:20:55 INFO - Installing pip.................done. 02:20:55 INFO - Return code: 0 02:20:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:20:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:20:55 INFO - Reading from file tmpfile_stdout 02:20:55 INFO - Output received: 02:20:55 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) 02:20:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:20:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:20:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:20:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:55 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 0x279f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b11480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0e820>, '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 0x2b0f520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b0f9b0>, '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': '4300f881736b422476174874000001bc-1483611639.445210-549087217', '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 02:20:55 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 02:20:55 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 02:20:55 INFO - Using env: {'DISPLAY': ':0', 02:20:55 INFO - 'HOME': '/home/cltbld', 02:20:55 INFO - 'LANG': 'en_US.UTF-8', 02:20:55 INFO - 'LANGUAGE': 'en_US:en', 02:20:55 INFO - 'LOGNAME': 'cltbld', 02:20:55 INFO - 'MAIL': '/var/mail/cltbld', 02:20:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:55 INFO - 'MOZ_NO_REMOTE': '1', 02:20:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:20:55 INFO - 'NO_EM_RESTART': '1', 02:20:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:20:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:55 INFO - 'PWD': '/builds/slave/test', 02:20:55 INFO - 'SHELL': '/bin/bash', 02:20:55 INFO - 'SHLVL': '1', 02:20:55 INFO - 'TERM': 'linux', 02:20:55 INFO - 'TMOUT': '86400', 02:20:55 INFO - 'USER': 'cltbld', 02:20:55 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1483611639.445210-549087217', 02:20:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:55 INFO - '_': '/tools/buildbot/bin/python'} 02:20:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:55 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 02:20:55 INFO - Cleaning up... 02:20:55 INFO - Return code: 0 02:20:55 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:20:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:20:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:20:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:55 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 0x279f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b11480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0e820>, '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 0x2b0f520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b0f9b0>, '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': '4300f881736b422476174874000001bc-1483611639.445210-549087217', '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 02:20:55 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 02:20:55 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 02:20:55 INFO - Using env: {'DISPLAY': ':0', 02:20:55 INFO - 'HOME': '/home/cltbld', 02:20:55 INFO - 'LANG': 'en_US.UTF-8', 02:20:55 INFO - 'LANGUAGE': 'en_US:en', 02:20:55 INFO - 'LOGNAME': 'cltbld', 02:20:55 INFO - 'MAIL': '/var/mail/cltbld', 02:20:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:55 INFO - 'MOZ_NO_REMOTE': '1', 02:20:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:20:55 INFO - 'NO_EM_RESTART': '1', 02:20:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:20:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:55 INFO - 'PWD': '/builds/slave/test', 02:20:55 INFO - 'SHELL': '/bin/bash', 02:20:55 INFO - 'SHLVL': '1', 02:20:55 INFO - 'TERM': 'linux', 02:20:55 INFO - 'TMOUT': '86400', 02:20:55 INFO - 'USER': 'cltbld', 02:20:55 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1483611639.445210-549087217', 02:20:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:55 INFO - '_': '/tools/buildbot/bin/python'} 02:20:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:55 INFO - Downloading/unpacking psutil>=3.1.1 02:20:55 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 02:20:55 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 02:20:55 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 02:20:55 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 02:20:55 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 02:20:55 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 02:20:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:20:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:20:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:20:57 INFO - Installing collected packages: psutil 02:20:57 INFO - Running setup.py install for psutil 02:20:58 INFO - building 'psutil._psutil_linux' extension 02:20:58 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 02:20:58 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 02:20:58 INFO - building 'psutil._psutil_posix' extension 02:20:58 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 02:20:58 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 02:20:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:20:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:20:58 INFO - Successfully installed psutil 02:20:58 INFO - Cleaning up... 02:20:58 INFO - Return code: 0 02:20:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:20:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:20:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:20:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x279f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b11480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0e820>, '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 0x2b0f520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b0f9b0>, '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': '4300f881736b422476174874000001bc-1483611639.445210-549087217', '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 02:21:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:21:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:21:03 INFO - Using env: {'DISPLAY': ':0', 02:21:03 INFO - 'HOME': '/home/cltbld', 02:21:03 INFO - 'LANG': 'en_US.UTF-8', 02:21:03 INFO - 'LANGUAGE': 'en_US:en', 02:21:03 INFO - 'LOGNAME': 'cltbld', 02:21:03 INFO - 'MAIL': '/var/mail/cltbld', 02:21:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:21:03 INFO - 'MOZ_NO_REMOTE': '1', 02:21:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:21:03 INFO - 'NO_EM_RESTART': '1', 02:21:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:21:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:21:03 INFO - 'PWD': '/builds/slave/test', 02:21:03 INFO - 'SHELL': '/bin/bash', 02:21:03 INFO - 'SHLVL': '1', 02:21:03 INFO - 'TERM': 'linux', 02:21:03 INFO - 'TMOUT': '86400', 02:21:03 INFO - 'USER': 'cltbld', 02:21:03 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1483611639.445210-549087217', 02:21:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:21:03 INFO - '_': '/tools/buildbot/bin/python'} 02:21:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:21:03 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:21:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:21:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:21:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:21:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:21:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:21:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:21:05 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:21:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:21:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:21:05 INFO - Installing collected packages: mozsystemmonitor 02:21:05 INFO - Running setup.py install for mozsystemmonitor 02:21:06 INFO - Successfully installed mozsystemmonitor 02:21:06 INFO - Cleaning up... 02:21:06 INFO - Return code: 0 02:21:06 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:21:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:21:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:21:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x279f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b11480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0e820>, '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 0x2b0f520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b0f9b0>, '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': '4300f881736b422476174874000001bc-1483611639.445210-549087217', '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 02:21:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:21:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:21:06 INFO - Using env: {'DISPLAY': ':0', 02:21:06 INFO - 'HOME': '/home/cltbld', 02:21:06 INFO - 'LANG': 'en_US.UTF-8', 02:21:06 INFO - 'LANGUAGE': 'en_US:en', 02:21:06 INFO - 'LOGNAME': 'cltbld', 02:21:06 INFO - 'MAIL': '/var/mail/cltbld', 02:21:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:21:06 INFO - 'MOZ_NO_REMOTE': '1', 02:21:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:21:06 INFO - 'NO_EM_RESTART': '1', 02:21:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:21:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:21:06 INFO - 'PWD': '/builds/slave/test', 02:21:06 INFO - 'SHELL': '/bin/bash', 02:21:06 INFO - 'SHLVL': '1', 02:21:06 INFO - 'TERM': 'linux', 02:21:06 INFO - 'TMOUT': '86400', 02:21:06 INFO - 'USER': 'cltbld', 02:21:06 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1483611639.445210-549087217', 02:21:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:21:06 INFO - '_': '/tools/buildbot/bin/python'} 02:21:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:21:06 INFO - Downloading/unpacking jsonschema==2.5.1 02:21:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:21:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:21:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:21:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:21:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:21:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:21:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:21:08 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:21:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:21:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:21:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:21:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:21:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:21:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:21:08 INFO - Downloading functools32-3.2.3-2.tar.gz 02:21:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:21:08 INFO - warning: no files found matching '*.txt' 02:21:08 INFO - no previously-included directories found matching 'build' 02:21:08 INFO - no previously-included directories found matching 'dist' 02:21:08 INFO - no previously-included directories found matching '.git*' 02:21:08 INFO - Installing collected packages: jsonschema, functools32 02:21:08 INFO - Running setup.py install for functools32 02:21:08 INFO - warning: no files found matching '*.txt' 02:21:08 INFO - no previously-included directories found matching 'build' 02:21:08 INFO - no previously-included directories found matching 'dist' 02:21:08 INFO - no previously-included directories found matching '.git*' 02:21:08 INFO - Successfully installed jsonschema functools32 02:21:08 INFO - Cleaning up... 02:21:08 INFO - Return code: 0 02:21:08 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:21:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:21:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:21:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x279f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b11480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0e820>, '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 0x2b0f520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b0f9b0>, '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': '4300f881736b422476174874000001bc-1483611639.445210-549087217', '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 02:21:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 02:21:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 02:21:08 INFO - Using env: {'DISPLAY': ':0', 02:21:08 INFO - 'HOME': '/home/cltbld', 02:21:08 INFO - 'LANG': 'en_US.UTF-8', 02:21:08 INFO - 'LANGUAGE': 'en_US:en', 02:21:08 INFO - 'LOGNAME': 'cltbld', 02:21:08 INFO - 'MAIL': '/var/mail/cltbld', 02:21:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:21:08 INFO - 'MOZ_NO_REMOTE': '1', 02:21:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:21:08 INFO - 'NO_EM_RESTART': '1', 02:21:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:21:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:21:08 INFO - 'PWD': '/builds/slave/test', 02:21:08 INFO - 'SHELL': '/bin/bash', 02:21:08 INFO - 'SHLVL': '1', 02:21:08 INFO - 'TERM': 'linux', 02:21:08 INFO - 'TMOUT': '86400', 02:21:08 INFO - 'USER': 'cltbld', 02:21:08 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1483611639.445210-549087217', 02:21:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:21:08 INFO - '_': '/tools/buildbot/bin/python'} 02:21:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:21:09 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:21:09 INFO - Cleaning up... 02:21:09 INFO - Return code: 0 02:21:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:21: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')]} 02:21:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:21:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21: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')]} 02:21:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:21:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21: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', '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 0x279f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b11480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0e820>, '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 0x2b0f520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b0f9b0>, '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': '4300f881736b422476174874000001bc-1483611639.445210-549087217', '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 02:21: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:21: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 blobuploader==1.2.4 02:21:09 INFO - Using env: {'DISPLAY': ':0', 02:21:09 INFO - 'HOME': '/home/cltbld', 02:21:09 INFO - 'LANG': 'en_US.UTF-8', 02:21:09 INFO - 'LANGUAGE': 'en_US:en', 02:21:09 INFO - 'LOGNAME': 'cltbld', 02:21:09 INFO - 'MAIL': '/var/mail/cltbld', 02:21:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:21:09 INFO - 'MOZ_NO_REMOTE': '1', 02:21:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:21:09 INFO - 'NO_EM_RESTART': '1', 02:21:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:21:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:21:09 INFO - 'PWD': '/builds/slave/test', 02:21:09 INFO - 'SHELL': '/bin/bash', 02:21:09 INFO - 'SHLVL': '1', 02:21:09 INFO - 'TERM': 'linux', 02:21:09 INFO - 'TMOUT': '86400', 02:21:09 INFO - 'USER': 'cltbld', 02:21:09 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1483611639.445210-549087217', 02:21:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:21:09 INFO - '_': '/tools/buildbot/bin/python'} 02:21:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:21:09 INFO - Downloading/unpacking blobuploader==1.2.4 02:21:09 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 02:21:09 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 02:21:09 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 02:21:09 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 02:21:09 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 02:21:09 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 02:21:11 INFO - Downloading blobuploader-1.2.4.tar.gz 02:21:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:21:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:21:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:21:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:21:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:21:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:21:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:21:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:21:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:21:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:21:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:21:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:21:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:21:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:21:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:21:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:21:12 INFO - Downloading docopt-0.6.1.tar.gz 02:21:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:21:12 INFO - Installing collected packages: blobuploader, requests, docopt 02:21:12 INFO - Running setup.py install for blobuploader 02:21:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:21:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:21:12 INFO - Running setup.py install for requests 02:21:12 INFO - Running setup.py install for docopt 02:21:12 INFO - Successfully installed blobuploader requests docopt 02:21:12 INFO - Cleaning up... 02:21:12 INFO - Return code: 0 02:21:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:21:12 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')]} 02:21:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:21:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:12 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')]} 02:21:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:21:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:12 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 0x279f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b11480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0e820>, '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 0x2b0f520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b0f9b0>, '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': '4300f881736b422476174874000001bc-1483611639.445210-549087217', '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 02:21:12 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 02:21:12 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 02:21:12 INFO - Using env: {'DISPLAY': ':0', 02:21:12 INFO - 'HOME': '/home/cltbld', 02:21:12 INFO - 'LANG': 'en_US.UTF-8', 02:21:12 INFO - 'LANGUAGE': 'en_US:en', 02:21:12 INFO - 'LOGNAME': 'cltbld', 02:21:12 INFO - 'MAIL': '/var/mail/cltbld', 02:21:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:21:12 INFO - 'MOZ_NO_REMOTE': '1', 02:21:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:21:12 INFO - 'NO_EM_RESTART': '1', 02:21:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:21:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:21:12 INFO - 'PWD': '/builds/slave/test', 02:21:12 INFO - 'SHELL': '/bin/bash', 02:21:12 INFO - 'SHLVL': '1', 02:21:12 INFO - 'TERM': 'linux', 02:21:12 INFO - 'TMOUT': '86400', 02:21:12 INFO - 'USER': 'cltbld', 02:21:12 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1483611639.445210-549087217', 02:21:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:21:12 INFO - '_': '/tools/buildbot/bin/python'} 02:21:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:21:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:21:13 INFO - Running setup.py (path:/tmp/pip-OSc_Ru-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:21:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:21:13 INFO - Running setup.py (path:/tmp/pip-BXN5qS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:21:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:21:13 INFO - Running setup.py (path:/tmp/pip-Pe8y_t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:21:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:21:13 INFO - Running setup.py (path:/tmp/pip-zZRG2R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:21:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:21:13 INFO - Running setup.py (path:/tmp/pip-yqd9Gd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:21:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:21:13 INFO - Running setup.py (path:/tmp/pip-q17SJS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:21:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:21:13 INFO - Running setup.py (path:/tmp/pip-pg25gK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:21:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:21:13 INFO - Running setup.py (path:/tmp/pip-hsTTlY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:21:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:21:13 INFO - Running setup.py (path:/tmp/pip-XXLBL8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:21:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:21:13 INFO - Running setup.py (path:/tmp/pip-KMcCa7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:21:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:21:13 INFO - Running setup.py (path:/tmp/pip-PV7GnJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:21:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:21:13 INFO - Running setup.py (path:/tmp/pip-Q3hmuw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:21:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:21:13 INFO - Running setup.py (path:/tmp/pip-N5_nmW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:21:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:21:14 INFO - Running setup.py (path:/tmp/pip-1rMCL0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:21:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:21:14 INFO - Running setup.py (path:/tmp/pip-5BICjn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:21:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:21:14 INFO - Running setup.py (path:/tmp/pip-N8inJm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:21:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:21:14 INFO - Running setup.py (path:/tmp/pip-r0nC7U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:21:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:21:14 INFO - Running setup.py install for manifestparser 02:21:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:21:14 INFO - Running setup.py install for mozcrash 02:21:14 INFO - Running setup.py install for mozdebug 02:21:14 INFO - Running setup.py install for mozdevice 02:21:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:21:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:21:14 INFO - Running setup.py install for mozfile 02:21:14 INFO - Running setup.py install for mozhttpd 02:21:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:21:14 INFO - Running setup.py install for mozinfo 02:21:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:21:14 INFO - Running setup.py install for mozInstall 02:21:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:21:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:21:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:21:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:21:15 INFO - Running setup.py install for mozleak 02:21:15 INFO - Running setup.py install for mozlog 02:21:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:21:15 INFO - Running setup.py install for moznetwork 02:21:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:21:15 INFO - Running setup.py install for mozprocess 02:21:15 INFO - Running setup.py install for mozprofile 02:21:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:21:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:21:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:21:15 INFO - Running setup.py install for mozrunner 02:21:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:21:15 INFO - Running setup.py install for mozscreenshot 02:21:15 INFO - Running setup.py install for moztest 02:21:15 INFO - Running setup.py install for mozversion 02:21:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:21:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:21:16 INFO - Cleaning up... 02:21:16 INFO - Return code: 0 02:21:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:21:16 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')]} 02:21:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:21:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:16 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')]} 02:21:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:21:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:16 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 0x279f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b11480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0e820>, '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 0x2b0f520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b0f9b0>, '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': '4300f881736b422476174874000001bc-1483611639.445210-549087217', '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 02:21:16 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 02:21:16 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 02:21:16 INFO - Using env: {'DISPLAY': ':0', 02:21:16 INFO - 'HOME': '/home/cltbld', 02:21:16 INFO - 'LANG': 'en_US.UTF-8', 02:21:16 INFO - 'LANGUAGE': 'en_US:en', 02:21:16 INFO - 'LOGNAME': 'cltbld', 02:21:16 INFO - 'MAIL': '/var/mail/cltbld', 02:21:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:21:16 INFO - 'MOZ_NO_REMOTE': '1', 02:21:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:21:16 INFO - 'NO_EM_RESTART': '1', 02:21:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:21:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:21:16 INFO - 'PWD': '/builds/slave/test', 02:21:16 INFO - 'SHELL': '/bin/bash', 02:21:16 INFO - 'SHLVL': '1', 02:21:16 INFO - 'TERM': 'linux', 02:21:16 INFO - 'TMOUT': '86400', 02:21:16 INFO - 'USER': 'cltbld', 02:21:16 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1483611639.445210-549087217', 02:21:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:21:16 INFO - '_': '/tools/buildbot/bin/python'} 02:21:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:21:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:21:16 INFO - Running setup.py (path:/tmp/pip-wwlLVX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:21:16 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)) 02:21:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:21:16 INFO - Running setup.py (path:/tmp/pip-Kf1GfF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:21:16 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)) 02:21:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:21:16 INFO - Running setup.py (path:/tmp/pip-H7u71p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:21:16 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)) 02:21:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:21:16 INFO - Running setup.py (path:/tmp/pip-5kLMoj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:21:16 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)) 02:21:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:21:16 INFO - Running setup.py (path:/tmp/pip-nhtFQ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:21:16 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)) 02:21:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:21:16 INFO - Running setup.py (path:/tmp/pip-ql8zHO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:21:16 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)) 02:21:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:21:16 INFO - Running setup.py (path:/tmp/pip-zcKbwF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:21:16 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)) 02:21:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:21:16 INFO - Running setup.py (path:/tmp/pip-JMOr7d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:21:16 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)) 02:21:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:21:16 INFO - Running setup.py (path:/tmp/pip-Bchvtb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:21:16 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)) 02:21:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:21:16 INFO - Running setup.py (path:/tmp/pip-NCu6O0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:21:17 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)) 02:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:21:17 INFO - Running setup.py (path:/tmp/pip-2ZvlD1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:21:17 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)) 02:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:21:17 INFO - Running setup.py (path:/tmp/pip-dYzvON-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:21:17 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)) 02:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:21:17 INFO - Running setup.py (path:/tmp/pip-Z62ySo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:21:17 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)) 02:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:21:17 INFO - Running setup.py (path:/tmp/pip-VQVpdf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:21:17 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)) 02:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:21:17 INFO - Running setup.py (path:/tmp/pip-VmiFYy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:21:17 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)) 02:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:21:17 INFO - Running setup.py (path:/tmp/pip-hcC63P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:21:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 02:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:21:17 INFO - Running setup.py (path:/tmp/pip-Zz3XPx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:21:17 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)) 02:21:17 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)) 02:21:17 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)) 02:21:17 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)) 02:21:17 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)) 02:21:17 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)) 02:21:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:21: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 02:21: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 02:21: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 02:21: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 02:21: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 02:21: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 02:21:19 INFO - Downloading blessings-1.6.tar.gz 02:21:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:21:19 INFO - Installing collected packages: blessings 02:21:19 INFO - Running setup.py install for blessings 02:21:19 INFO - Successfully installed blessings 02:21:19 INFO - Cleaning up... 02:21:19 INFO - Return code: 0 02:21:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:21:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:21:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:21:20 INFO - Reading from file tmpfile_stdout 02:21:20 INFO - Current package versions: 02:21:20 INFO - argparse == 1.2.1 02:21:20 INFO - blessings == 1.6 02:21:20 INFO - blobuploader == 1.2.4 02:21:20 INFO - docopt == 0.6.1 02:21:20 INFO - functools32 == 3.2.3-2 02:21:20 INFO - jsonschema == 2.5.1 02:21:20 INFO - manifestparser == 1.1 02:21:20 INFO - mozInstall == 1.12 02:21:20 INFO - mozcrash == 1.0 02:21:20 INFO - mozdebug == 0.1 02:21:20 INFO - mozdevice == 0.49 02:21:20 INFO - mozfile == 1.2 02:21:20 INFO - mozhttpd == 0.7 02:21:20 INFO - mozinfo == 0.9 02:21:20 INFO - mozleak == 0.1 02:21:20 INFO - mozlog == 3.4 02:21:20 INFO - moznetwork == 0.27 02:21:20 INFO - mozprocess == 0.23 02:21:20 INFO - mozprofile == 0.28 02:21:20 INFO - mozrunner == 6.13 02:21:20 INFO - mozscreenshot == 0.1 02:21:20 INFO - mozsystemmonitor == 0.3 02:21:20 INFO - moztest == 0.8 02:21:20 INFO - mozversion == 1.4 02:21:20 INFO - psutil == 3.1.1 02:21:20 INFO - requests == 1.2.3 02:21:20 INFO - wsgiref == 0.1.2 02:21:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:21:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:21:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:21:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:20 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 0x279f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b11480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0e820>, '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 0x2b0f520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b0f9b0>, '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': '4300f881736b422476174874000001bc-1483611639.445210-549087217', '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 02:21:20 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 02:21:20 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 02:21:20 INFO - Using env: {'DISPLAY': ':0', 02:21:20 INFO - 'HOME': '/home/cltbld', 02:21:20 INFO - 'LANG': 'en_US.UTF-8', 02:21:20 INFO - 'LANGUAGE': 'en_US:en', 02:21:20 INFO - 'LOGNAME': 'cltbld', 02:21:20 INFO - 'MAIL': '/var/mail/cltbld', 02:21:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:21:20 INFO - 'MOZ_NO_REMOTE': '1', 02:21:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:21:20 INFO - 'NO_EM_RESTART': '1', 02:21:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:21:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:21:20 INFO - 'PWD': '/builds/slave/test', 02:21:20 INFO - 'SHELL': '/bin/bash', 02:21:20 INFO - 'SHLVL': '1', 02:21:20 INFO - 'TERM': 'linux', 02:21:20 INFO - 'TMOUT': '86400', 02:21:20 INFO - 'USER': 'cltbld', 02:21:20 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1483611639.445210-549087217', 02:21:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:21:20 INFO - '_': '/tools/buildbot/bin/python'} 02:21:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:21:20 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)) 02:21:20 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)) 02:21:20 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)) 02:21:20 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)) 02:21:20 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)) 02:21:20 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)) 02:21:20 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)) 02:21:20 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)) 02:21:20 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)) 02:21:20 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)) 02:21:20 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)) 02:21:20 INFO - Cleaning up... 02:21:20 INFO - Return code: 0 02:21:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:21:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:21:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:21:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x279f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b11480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0e820>, '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 0x2b0f520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b0f9b0>, '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': '4300f881736b422476174874000001bc-1483611639.445210-549087217', '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 02:21:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:21:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:21:20 INFO - Using env: {'DISPLAY': ':0', 02:21:20 INFO - 'HOME': '/home/cltbld', 02:21:20 INFO - 'LANG': 'en_US.UTF-8', 02:21:20 INFO - 'LANGUAGE': 'en_US:en', 02:21:20 INFO - 'LOGNAME': 'cltbld', 02:21:20 INFO - 'MAIL': '/var/mail/cltbld', 02:21:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:21:20 INFO - 'MOZ_NO_REMOTE': '1', 02:21:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:21:20 INFO - 'NO_EM_RESTART': '1', 02:21:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:21:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:21:20 INFO - 'PWD': '/builds/slave/test', 02:21:20 INFO - 'SHELL': '/bin/bash', 02:21:20 INFO - 'SHLVL': '1', 02:21:20 INFO - 'TERM': 'linux', 02:21:20 INFO - 'TMOUT': '86400', 02:21:20 INFO - 'USER': 'cltbld', 02:21:20 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1483611639.445210-549087217', 02:21:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:21:20 INFO - '_': '/tools/buildbot/bin/python'} 02:21:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:21:20 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:21:20 INFO - Cleaning up... 02:21:20 INFO - Return code: 0 02:21:20 INFO - Running post-action listener: _resource_record_post_action 02:21:20 INFO - Running post-action listener: _start_resource_monitoring 02:21:20 INFO - Starting resource monitoring. 02:21:20 INFO - [mozharness: 2017-01-05 10:21:20.525919Z] Finished create-virtualenv step (success) 02:21:20 INFO - [mozharness: 2017-01-05 10:21:20.526506Z] Running install step. 02:21:20 INFO - Running pre-action listener: _resource_record_pre_action 02:21:20 INFO - Running main action method: install 02:21:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:21:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:21:20 INFO - Reading from file tmpfile_stdout 02:21:20 INFO - Detecting whether we're running mozinstall >=1.0... 02:21:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:21:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:21:20 INFO - Reading from file tmpfile_stdout 02:21:20 INFO - Output received: 02:21:20 INFO - Usage: mozinstall [options] installer 02:21:20 INFO - Options: 02:21:20 INFO - -h, --help show this help message and exit 02:21:20 INFO - -d DEST, --destination=DEST 02:21:20 INFO - Directory to install application into. [default: 02:21:20 INFO - "/builds/slave/test"] 02:21:20 INFO - --app=APP Application being installed. [default: firefox] 02:21:20 INFO - mkdir: /builds/slave/test/build/application 02:21:20 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'] 02:21:20 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 02:21:38 INFO - Reading from file tmpfile_stdout 02:21:38 INFO - Output received: 02:21:38 INFO - /builds/slave/test/build/application/firefox/firefox 02:21:38 INFO - Running post-action listener: _resource_record_post_action 02:21:38 INFO - [mozharness: 2017-01-05 10:21:38.167612Z] Finished install step (success) 02:21:38 INFO - [mozharness: 2017-01-05 10:21:38.167884Z] Running run-tests step. 02:21:38 INFO - Running pre-action listener: _resource_record_pre_action 02:21:38 INFO - Running main action method: run_tests 02:21:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:21:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:21:38 INFO - Python 2.7.3 02:21:38 INFO - Return code: 0 02:21:38 INFO - grabbing minidump binary from tooltool 02:21:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:38 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 0x2b0e820>, '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 0x2b0f520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b0f9b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:21:38 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 02:21:38 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 02:21:38 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 02:21:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:21:38 INFO - Return code: 0 02:21:38 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:21:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:21:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:21:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:21:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:21:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483602863/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 02:21:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483602863/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-045 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 02:21:38 INFO - Using env: {'DISPLAY': ':0', 02:21:38 INFO - 'HOME': '/home/cltbld', 02:21:38 INFO - 'LANG': 'en_US.UTF-8', 02:21:38 INFO - 'LANGUAGE': 'en_US:en', 02:21:38 INFO - 'LOGNAME': 'cltbld', 02:21:38 INFO - 'MAIL': '/var/mail/cltbld', 02:21:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:21:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:21:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:21:38 INFO - 'MOZ_NO_REMOTE': '1', 02:21:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:21:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:21:38 INFO - 'NO_EM_RESTART': '1', 02:21:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:21:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:21:38 INFO - 'PWD': '/builds/slave/test', 02:21:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:21:38 INFO - 'SHELL': '/bin/bash', 02:21:38 INFO - 'SHLVL': '1', 02:21:38 INFO - 'TERM': 'linux', 02:21:38 INFO - 'TMOUT': '86400', 02:21:38 INFO - 'USER': 'cltbld', 02:21:38 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1483611639.445210-549087217', 02:21:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:21:38 INFO - '_': '/tools/buildbot/bin/python'} 02:21:38 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483602863/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 02:21:38 INFO - mozversion application_buildid: 20170104235423 02:21:38 INFO - mozversion application_changeset: c069e5e1e63f5d4ae8d7857f7b0d5798b81a657c 02:21:38 INFO - mozversion application_display_name: Nightly 02:21:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:21:38 INFO - mozversion application_name: Firefox 02:21:38 INFO - mozversion application_remotingname: firefox 02:21:38 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 02:21:38 INFO - mozversion application_vendor: Mozilla 02:21:38 INFO - mozversion application_version: 53.0a1 02:21:38 INFO - mozversion platform_buildid: 20170104235423 02:21:38 INFO - mozversion platform_changeset: c069e5e1e63f5d4ae8d7857f7b0d5798b81a657c 02:21:38 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 02:21:38 INFO - mozversion platform_version: 53.0a1 02:21:38 INFO - using testdate: 1483611698 02:21:38 INFO - actual date: 1483611698 02:21:38 INFO - starting webserver on 'localhost:57631' 02:21:38 INFO - SUITE-START | Running 2 tests 02:21:38 INFO - TEST-START | dromaeo_css 02:21:38 INFO - operating with platform_type : linux_ 02:21:38 INFO - Initialising browser for dromaeo_css test... 02:21:38 INFO - TEST-INFO | started process 6525 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppmBdCX/profile http://localhost:57631/getInfo.html) 02:21:38 INFO - PROCESS | 6525 | 1483611698916 addons.xpi WARN Exception running bootstrap method install on shield-recipe-client@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getBoolPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js :: this.install :: line 38" data: no] Stack trace: this.install()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:38 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4907 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2060 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3762 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2795 < callProvider()@resource://gre/modules/AddonManager.jsm:263 < _startProvider()@resource://gre/modules/AddonManager.jsm:758 < startup()@resource://gre/modules/AddonManager.jsm:940 < startup()@resource://gre/modules/AddonManager.jsm:2913 < observe()@resource://gre/components/addonManager.js:65 02:21:42 INFO - PROCESS | 6525 | __metrics Screen width/height:1600/1200 02:21:42 INFO - PROCESS | 6525 | colorDepth:24 02:21:42 INFO - PROCESS | 6525 | Browser inner width/height: 1024/697 02:21:42 INFO - PROCESS | 6525 | __metrics 02:21:43 ERROR - PROCESS | 6525 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3252: TypeError: this.tabs is undefined 02:21:44 INFO - TEST-INFO | 6525: exit 0 02:21:44 INFO - Browser initialized. 02:21:44 INFO - Running cycle 1/1 for dromaeo_css test... 02:21:44 INFO - TEST-INFO | started process 6647 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppmBdCX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:21:56 INFO - PROCESS | 6647 | RSS: Main: 154378240 02:21:56 INFO - PROCESS | 6647 | 02:22:45 INFO - PROCESS | 6647 | 1483611765666 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] 02:24:56 INFO - PROCESS | 6647 | Cycle 1(1): loaded http://localhost:57631/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57631/tests/dromaeo/cssquery-ext.html) 02:24:57 INFO - PROCESS | 6647 | RSS: Main: 163610624 02:24:57 INFO - PROCESS | 6647 | 02:26:44 INFO - PROCESS | 6647 | ************************* 02:26:44 INFO - PROCESS | 6647 | A coding exception was thrown and uncaught in a Task. 02:26:44 INFO - PROCESS | 6647 | 02:26:44 INFO - PROCESS | 6647 | Full message: ReferenceError: fetch is not defined 02:26:44 INFO - PROCESS | 6647 | Full stack: apiCall@resource://shield-recipe-client/lib/NormandyApi.jsm:37:5 02:26:44 INFO - PROCESS | 6647 | get@resource://shield-recipe-client/lib/NormandyApi.jsm:44:12 02:26:44 INFO - PROCESS | 6647 | this.NormandyApi.fetchRecipes<@resource://shield-recipe-client/lib/NormandyApi.jsm:52:34 02:26:44 INFO - PROCESS | 6647 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 02:26:44 INFO - PROCESS | 6647 | TaskImpl@resource://gre/modules/Task.jsm:277:3 02:26:44 INFO - PROCESS | 6647 | asyncFunction@resource://gre/modules/Task.jsm:252:14 02:26:44 INFO - PROCESS | 6647 | this.RecipeRunner.start<@resource://shield-recipe-client/lib/RecipeRunner.jsm:64:23 02:26:44 INFO - PROCESS | 6647 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 02:26:44 INFO - PROCESS | 6647 | TaskImpl@resource://gre/modules/Task.jsm:277:3 02:26:44 INFO - PROCESS | 6647 | asyncFunction@resource://gre/modules/Task.jsm:252:14 02:26:44 INFO - PROCESS | 6647 | setTimeout_timer@resource://gre/modules/Timer.jsm:30:5 02:26:44 INFO - PROCESS | 6647 | 02:26:44 INFO - PROCESS | 6647 | ************************* 02:27:59 INFO - PROCESS | 6647 | Cycle 1(1): loaded http://localhost:57631/tests/dromaeo/cssquery-ext.html (next: http://localhost:57631/tests/dromaeo/cssquery-jquery.html) 02:28:00 INFO - PROCESS | 6647 | RSS: Main: 160215040 02:28:00 INFO - PROCESS | 6647 | 02:31:02 INFO - PROCESS | 6647 | Cycle 1(1): loaded http://localhost:57631/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57631/tests/dromaeo/cssquery-mootools.html) 02:31:03 INFO - PROCESS | 6647 | RSS: Main: 166010880 02:31:03 INFO - PROCESS | 6647 | 02:34:04 INFO - PROCESS | 6647 | Cycle 1(1): loaded http://localhost:57631/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57631/tests/dromaeo/cssquery-prototype.html) 02:34:05 INFO - PROCESS | 6647 | RSS: Main: 160698368 02:34:05 INFO - PROCESS | 6647 | 02:37:08 INFO - PROCESS | 6647 | Cycle 1(1): loaded http://localhost:57631/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57631/tests/dromaeo/cssquery-yui.html) 02:37:08 INFO - PROCESS | 6647 | RSS: Main: 164507648 02:37:08 INFO - PROCESS | 6647 | 02:40:11 INFO - PROCESS | 6647 | Cycle 1(1): loaded http://localhost:57631/tests/dromaeo/cssquery-yui.html (next: http://localhost:57631/tests/dromaeo/cssquery-dojo.html) 02:40:11 INFO - PROCESS | 6647 | RSS: Main: 164065280 02:40:11 INFO - PROCESS | 6647 | 02:40:11 INFO - PROCESS | 6647 | __start_tp_report 02:40:11 INFO - PROCESS | 6647 | _x_x_mozilla_page_load 02:40:11 INFO - PROCESS | 6647 | _x_x_mozilla_page_load_details 02:40:11 INFO - PROCESS | 6647 | |i|pagename|runs| 02:40:11 INFO - PROCESS | 6647 | |0;dojo.html;3168.461361568533;3197.840107994601;3201.855916483758;3213.855376508058;3220.5491231227647;5268.236105764662;5326.893462130755;5358;5386.73066346683;5392.325959255093;5331.280277162582;5339;5422.728863556826;5430.8913821723545;5509.917351239725;4856.10162120008;4861.513848615128;4907.312976183337;4971.651984361096;5007.324011258488;4799.472058073609;4942.728149951751;5023.799048038074;5035.622328325372;5035.84892453227;4839.685420447659;4870;4944.802207911679;5002.224655178453;5026.170681837492;4883.682560633548;4892.486288939681;4919.532644398776;4949.307097006422;4979.7261150636705;4875.68308059975;4909.214525675875;4912.238603016538;4926.4088309403105;4974.925376119361;5245.632805703603;5373.946260537384;5415.48552887479;5417.106177480711;5423.430539793344;5677.971610141964;5712.80005199816;5719.227904232958;5765.1640512125505;5842.824715258549;5780.7687692492245;5793.275840519935;5794.594378393472;5800.477956983849;5814.912776308359;5405.648632838853;5418.29562156921;5418.729063546807;5422.43064478228;5424.159255315432;5813.476787089182;5855.443732845373;5933.762649493972;5966.880662386815;5978.1929439525975;5737.225474560964;5771.797987070432;5786.826395208151;5787.768489260382;5846.590738648339;5843.912341314884;5871.853203669857;5873.177755114288;5899.321578018497;5906;5633.943660563424;5673.262475878192;5771.538276937835;5776.826695199151;5786.566007549451;5827.504662103684;5835.912461313083;5852.473277405054;5854.648721076749;5881.852953676193;4369.300911854088;4379.540148284448;4388.2759344707765;4395.3187255974735;4411.647068234533;3795;3800;3888.7666739995125;3905.726599138033;3959.247742928834;5615.298087739033;5618.494335509824;5627.803026894039;5671.489565939085;5683.2895888014;5838.795642152504;5863.560232982543;5913.49735272498;5918.378570250062;5932.673702946293;5385.138377859524;5411.269478620415;5489.176623506506;5613.214150019001;5621.943780562142;4798.47216806151;4829.444613869379;4848.296996935424;4870.805167793319;4886.951130488721;6118.969405152946;6127.540434467343;6131.233595800525;6143.754249830046;6147.96926015376;5598.748056337393;5623.550115990629;5863.413658634103;5866.911996319973;5875.14810352488;5893.057110862242;5921.822345329647;5932.762689492544;5944.64332140073;5948.315943666534;5533.446655334435;5571.637843540157;5579.525740311957;5595.412481689364;5607.663540187602;5659.745311460912;5670.914936276042;5826.650400975955;5859.00396932514;5879.794207202727;5729.656220626775;5752.252207213036;5756.366799651951;5771.134329850556;5806.5064469518875;5718.399568045295;5755.906377788207;5778.508826749605;5778.682172480554;5784;5528.44715528444;5559.305086864142;5648.378678345297;5656.8020119295625;5705.942940570541;5764.567657425626;5770.653760774367;5785.4214578541805;5792.304923409218;5803.100519419497;5629.352624448241;5629.971850140723;5643.463870932255;5653.2085508028085;5657.4059723728415 02:40:11 INFO - PROCESS | 6647 | |1;ext.html;551.7048379117172;566.2271000084883;574.2850151561307;585.9560532960027;586.8826234753047;43941;44850.32724509131;44979.550204497944;49298.50701492984;49508;46928.530714692846;47568;47626;47645;47681.28478072832;9097.226735727454;9280.814383712323;9284.210842078432;9286.628534858632;10267.743306417324;10187.98120187979;10561.735956601107;10568.260221784478;10571.947140264288;10574.735631609194;10591.046805787477;10610.840837387444;10653.467326633676;10657.893421065768;10664.573417063308;10539.789204215911;10568.260221784478;10630.521626526825;10642.09542188915;10646.361218326925;10370.85920548739;10457.058864702138;10459.424731639756;10511.63209287679;10514;38996;39108.80445597754;39370.60629393698;39388.80305598483;39477.80261098705;4131.669466442678;4158.521769996429;4206.348016057516;4226.344916537942;4258;30198;30351.24121896948;30790.692093079007;31087.84456077705;31515.527267091013;4224.471941007374;4451.5103338632725;4480.439945006874;4484.41702578666;4493.213687604689;326139;326221;326593;326737;327244;53874.19188712173;53978.46021539735;54437;54683.45316546863;54751.72624136854;56626.43373566212;56644.71677641585;57209.42790572041;57258.42741572531;57362;16293.429729959631;16665.833341666672;16692.664586833023;16722.498325050266;16737.16314184286;12127.818082728767;12318.322492262832;12351.073669474825;12604.369781511072;13052.804207936888;17904.641907161782;18101.637967240582;18128.184231709605;18204.271829126686;18241.63516729658;6885.345892140239;7206.423486121098;7246.927530724625;7289.2346303638415;7290.161631412456;941.0119374656583;955.6177528988321;956.636478138303;989.8020395920845;998.8851282102506;31348.37303253922;31647.84176079105;32363.352732945208;32703.50944735831;33037.50443743346;1097.8737445193744;1103.7682086761708;1122.2817396866012;1149.436775979764;1240.2620440837686;17003.659926801396;17065.829341706423;17184.054876981638;17469.388571400195;17643.73534396985;527923;531876;532445.4043676497;533050;533965;63293;63762.36237637657;64101.35898640954;64121.35878641154;64436.677816610616;1424.4658253155067;1463.4877792772656;1468.3906178935836;1476.343027352839;1480.6520467690084;29173.7082629171;30666.233344166576;31889.840550797097;32654.34691306208;32769.34461310808;53499.465005351005;55060.174097389376;55074.724626376614;55100;55375;398505;398694;398715;399651;400024;28897;29225.415491690474;29471.85264073666;29474;29498.705012949595;48890.199764042816;49035.754821225666;49119.50880491149;49134.508654914425;50448;41284.38073428961;41768.164636707705;42347.57652423436;42984;43266;36991.44512832256;38756.6124338753;38871.61128388793;41781.79109104435;42764;38274.2345153101;38690.80654596709;38822.223555529294;39568.80215598903;39674.60325396824;32393.83803081064;33925.83037084799;34838.12904677302;35278.29443411169;35513.28973420569;26644.46711065729;27231.183064508095;27386.31534211581;27584.310392240353;27613.171604851887 02:40:11 INFO - PROCESS | 6647 | |2;jquery.html;415.97712125833067;421.51736261980017;425.3874420833998;429.22524842659004;443.58967954641946;18442.354517591888;18974.061342024183;20104.798952010475;20205.39383818486;20300.18799248028;20348.59302813943;20499.180032798708;20744.273950411738;21022.789772102275;21424.785752142474;5887.293524777033;6144.662043587601;6154.906986853737;6170.598911070789;6180.227471566054;5917.349091599942;5942.762289508414;5984.790532331369;6047.425494578008;6087.391260873921;5957.374475680056;5971.283445986488;5977.8206653800235;5978.730957106941;5995.160677505153;5835.270591176103;5985.191999080133;6001.159837622737;6010.248718910137;6020.698965051752;5373.543248823816;5395.406505284415;5416.620836541444;5424.810131645373;5429.212764149216;23545;24694.5061098777;24766.380840478952;25024.37439064038;25238.621420678704;2794.455081259155;2828.1656911211244;2830.616054760423;2849.088291746642;2855.0578309157927;14590;15258.847411525854;15462.768058479132;15499.922500387425;15852.207389630588;1717.4847545736354;1813.537547925284;1842.9907850460795;1856.7029275315886;1857.3127942661301;94145.99999999932;94726;96349;97571.51214243955;97884;12292.385380730928;12370.319632420304;12539.498420063277;12539.874601254052;12583.748325033632;16847.24187411545;16854.41009564659;16878.493645190418;16884.57788555296;16961.660766784596;8368.139802879434;8601.354898382646;8612.138786121463;8615.526146062026;8852.955735221412;8162.918370816215;8221.671133154727;8302.377321700897;8427.367947403847;8468.153184681483;5129.256257842592;5189.844304670866;5204.583633309327;5232.063310355141;5303.496167864047;2096.863703859244;2124.734408198975;2141.9250326238816;2181.879996600202;2192.3861318830754;880.4321212817824;902.8781114549583;904.3533873280636;907.8048219632678;916.6837441082815;20104.195832166843;20942.67870086275;20963.685544716842;20990.475238118863;21072.473188170417;890.3589415620743;912.8219997100634;926.3885835348772;937.8827646544182;939.4973689076311;11006.669799906016;11287.774244515227;11387.886121138683;11529.596464123715;11546.307221566733;548746;563235;565328;574922;587346;99809.50095249622;99908.50045749724;103003;103098.5239649508;105674.47162764137;1014.3204053284318;1024.073213741565;1038.9064984151462;1043.7651528406047;1113.8774734779329;18588.25646974106;18652.440426786674;18805.529861753566;18817.24731010799;19052;44959;44961.77519112384;45011.32483012692;45856.31215531837;45923;65766.34233657602;66232.6688366555;66344.68276586055;67308.66345668436;67932;9066.368053750388;9229.86155207659;9315;9359.15767580921;9595.13643772064;8987.46075235488;10217.795644086927;13085.41115649779;14144.302683678025;14280.214588197749;11799;12042.21725587834;12096.637100886988;12165.81751273714;12288.569900053455;11174.27367221128;11310.773784524428;11564.190506664452;11750.764984700087;11812;11837.822432663344;11891.394661720557;11913.225640333698;12464.252144871336;12555.435005424595;7760.534367937942;8034.196580341919;8158.959205203936;9093.727188184364;9249;9088.818223635622;11406.48670809799;11825.113116516124;12080.93959530232;12643.241405515699 02:40:11 INFO - PROCESS | 6647 | |3;mootools.html;1431.949881754139;1444.0830072903702;1444.7616143336347;1446.291317254545;1458.474949018354;7432.9256707432905;7544.773656790291;8105;8646.697365592205;8659.610317535718;7534.773956781305;7806.492577982442;7814.452988290822;7978.561179135145;7989.760307190793;2301.7813307735737;2334.043042352636;2340.052278827069;2340.3914982104607;2342.910546595833;2228.4428892776805;2234.5419189066283;2269.1604106480627;2281.3726225288096;2296;2338.4504641409253;2361.574916515035;2365.1840115160244;2368.159303447277;2382.5830479666074;2285.268714011517;2315.3169814904645;2323.117215458132;2328.231683544443;2332.486852892361;2301.390131615123;2335.4161459635093;2356.15178535727;2358.5400846834873;2366.0890557135453;8700.434471759316;8736.737897863075;8753.124687531259;8819.867701984474;8840.8673869892;5266.657667251617;5397.595180361489;5433.049216387117;5434.885848401068;5436.184572314145;3267;3365.7812242204177;3431.365197438482;3445.3453843769603;3489.6335884732243;1353.262471952788;1399.0766094377764;1400.0969374753226;1449.7535418978798;1470.0958910270215;11679.766404671944;11696.18126731129;11726.296422214695;11733.823992640117;11743.295402275891;4469.41897553316;4541.250693635513;4562.6996306052615;4576.473705523841;4630.884227894329;8734.257588105082;9116.49859257734;9230.307726920508;9276.11876871696;9281.95359023214;5200.803815122543;5338.252644629677;5357.544608708304;5359.678419294777;5365.946340536622;4871.098846713369;4895.241237608177;4991.700497970133;5027.874303142451;5042.3444952156715;3703.148275896559;3715.498407714924;3721.3673675475234;3777;3812.5806161322234;1149.3563604381407;1159.1769843411105;1172.6540670502222;1180.734334774686;1211.9878801211876;925.9166674999148;940.5673390240567;952.1050212799946;956.7464621875208;963.2534785541261;5336.4129945705945;5485.61600687948;5513;5598.048331783525;5603.187537806995;986.0829428631441;1029.351508549624;1030.8762948446235;1047.3454091193005;1070.4540684251087;3508.5965114011706;3539.8053107078845;3753.230587729509;3796.772193668389;3849.9037524062123;10066.44634545107;10253.282270241161;10281.12610428122;10330.121939635064;10349.43078130695;10214.233932455096;10280.280380373451;10326.380417174994;10342.482875856178;10385;7582.886256706154;7994.760157195294;8006.1993800619475;8138.267555920114;8174.264316211569;5477.643953143033;5661.858453538694;5746.281714785652;5813.709314534171;5873.472897046884;9173.724788256362;9346.345755797029;9407.247420206504;9460.621575136918;9561.091696288842;9529.190018848476;9553.379030363005;9591.328606997444;9604.327697061419;9606.327557070937;7246.275372462923;7252.601106939169;7395.482316237812;7557.35762460175;7621.504602200839;8377;8408.831823363376;8416.789580260542;8448.873266900879;8466.830663386821;7488.213737557478;7577.204393538819;7604.923950760422;7724.111727151225;7759.030121234846;7394.852102957803;7475.88786168197;7554;7594.8101297468;7598.544087354777;6513.283538810632;6652.634105124264;6656.633885136171;6657.833554161185;6658.933410666025;4794.712317260975;4795.568398844121;4880;4892.951070489249;5095.719735414587;4976.900461990667;5010.423801262901;5097.108006098992;5101.107306221471;5177.223416487557 02:40:11 INFO - PROCESS | 6647 | |4;prototype.html;395.6770802574852;409.54335915454277;412.2003313571671;421.877655479911;423.7563401044399;5175.482451754822;5287.47125287471;5396;5477.917831232529;5498.9725051374735;5245.7377131143485;5380.569554435646;5399.5680345572355;5406.486383793534;5409.7016715988175;4387.999999999992;4388.410837605812;4389.912201755963;4404.889877753049;4430.734155950653;4047.655949244303;4231.513375961757;4367.213901497729;4409.140217657558;4432.578905004019;4260.084081922386;4263.509696384925;4264.765437900915;4264.91019400493;4267.8079486423185;4255.723377980421;4261.829526818923;4267.295896177127;4272.935905961429;4290.528041915387;3813.2754776592637;3820.083180036771;3831;3834.9424758628643;3838.3111430970284;5089.796408143707;5209.843704688866;5282.2076688496645;5284.4187139414635;5290.867728306785;4835.492273311287;4908.656394052417;4911.4106307243;4915.975420122876;4928.654994150411;5340;5624.437556244384;5632.295963004624;5638.4361563843695;5676.3188417389765;4071.7964101795087;4091.468109145792;4103.2409004333995;4110.260153172428;4123.525794533637;5897.790952854697;5941.7920372787175;5942.405759424067;5979.940200597982;6023.909641355383;3988.6011398860464;4250.829966801355;4251.171021650748;4274.7435153890865;4286.914261714748;4259.829606815754;4286.849960251377;4288.228118938621;4290.37789520524;4290.8843700637435;4858.246971719389;4860.1008813369635;4861.9303753174245;4872.19608764557;4879.634027447955;5401.7029063401105;5587.8603034923635;5701;5710.486056254874;5733.369329373765;1429.6711756295902;1432.9068610540282;1434.3473719457622;1439.7768345906193;1451.426686458864;941.3175447800427;998.3660375661507;1003.6386900715737;1012.7366884610054;1015.1523477895892;5185.585153187736;5235.717249273952;5314.661548918463;5320.2817619620855;5370.355557333145;5641.802536911188;5647.407022262685;5649.293838270216;5655.575831812631;5755.963926493271;5020.49795020495;5247.449017853147;5256.6320357574605;5269.367675878842;5392.757325920343;2959.4820906341306;2976;2996.2060054085687;3000.6497076315745;3004;5895.848015474321;5918.402031451484;5928.806341653616;5947.524198064145;5983.516840511139;5587.74855131512;5905.940940590539;5925.111233315038;5935.495482883917;5964.522838172936;6087.939120608826;6106.908396374058;6137.987232106741;6155.938440615537;6261.5616906816085;5593.356763972195;5775.884482310415;5791.884162316815;5816.982028144973;5864.530837532901;5751.194832723339;5752.395998420273;5787.55311172207;5810.448007439287;5836.708164591839;5882.7058647066615;6104.877902441837;6179.3820617937845;6180.662442281297;6207.96896015517;4176.728512646669;4389.429374181336;4473.865784026484;4493.236149854598;4517.322401639649;5775.422457754191;5840.831833633205;5849.502792262705;5864.208331875142;5906.645601263938;5483.75323110469;5758.021136406905;5768.451997060272;5773.826785196451;5787.39232380594;5622.184783206494;5674.559939226172;5683.346415162144;5692.7722891083895;5711.943290491273;5499.615026948075;5586.86032849182;5619.747111379916;5719.485246327684;5721.141828725558;5457.781688732406;5611.158326250932;5623.915641265467;5650.547956163415;5677.233573467694;5508.586855985897;5513.476219759277;5539.944600554104;5548.528375088002;5579.246801681721 02:40:11 INFO - PROCESS | 6647 | |5;yui.html;752.428154602502;777.700585274669;805.7381351060903;841.4404421059994;860.2601762484264;15289.847101528996;16590.502284931456;16862.915685421587;17293.39473118441;17471.82528174718;15486.380544778223;15700.528984130495;15704.842951570481;15714.292856821441;15898.205089745496;734.5078797205884;751.1587022534769;766.31797700047;767.2365995834152;769.1385648074137;777.9183185765498;781.1290411191509;782.8747400415934;783.0368646564729;784.7371130671232;808.9352851771844;811.9512829230265;814.3281792521194;821.1870248454047;821.3593397150232;808.59974312715;808.6361137488154;813.3168138763438;815.229608020418;815.9428839981204;595.6634501506635;599.6671847124844;599.8260504453704;600;600.2886579403378;15352.385904563804;15522.767158492632;16673.583160420963;16812.74780878288;16921.238544265416;14873.70252594953;15239.695206095816;15261.160636165007;15628;15743.370265189378;12642.49430022798;12810.29543375114;12833.614991550268;12841.165324253894;12955;3771.698264138862;3858.903527411809;3905.1213476967737;3909.3745000799736;3947.8026098695236;76790.61604691997;78091;78258.21741782567;79814;80520;11642.70893227676;11645.941770291094;11748.647540573797;11828.34944078084;11931.284122952651;22381.664275035888;22772.31683049511;22836.31491055271;22838.200662977048;22924.19765308206;8344.332453403713;8344.874826877602;8420.78948026292;8513.787155321166;8524.360672949553;4442.666799990014;4531.614812740954;4534.274516077412;4570.085982803453;4646.233371493733;3781.8865434037025;3799.7340186186702;3818.4463252828186;3873.2447172801035;3887.688984881203;627.4227710506345;628.5882746800853;634.5875181132209;642.5534253693638;702.5187746393736;754.9091562691857;766.4136935244543;767.85794627994;781.7263957614789;806.2018601584389;9900.306978511579;9963.452010139366;10505.9474702626;10722.624708135178;11156.832647510293;766.0440078390448;771.4388231072785;776.1927595300937;778.2101167315179;802.2418814220506;4862.878428039327;5139.100657384943;5144.254083157996;5154.819581314636;5169.81905633301;65497;66521.33478665249;67109.99335009979;69789.65105174441;77629.6118519415;66474.33525664681;66760;67590;68451;70236;48985.26522102171;58044;59166.40833591695;60309.39690603125;61720.999999999105;10116.949415253172;10326.076170440585;10529.684109476728;10770.138388929023;10897.237193396386;41908.79045604752;42600.360994585724;43033.784831075645;43447.34828977631;45574.08851823011;51700.75478461855;52188.739056305996;52379.73810131077;54559.72720136374;56200.43799561952;12691.746165076831;12894.806577901527;12989.4154763034;13491.460341586228;13758.587242382744;14440.422383104979;14515;14980.325885335404;15242.237888105328;15780.289886954884;14078.507252246121;14575.781363279348;14610.858665386993;15456.227188640747;15603.765943511084;13933;14193.36873719582;14624.70750584961;14782.704345913236;14913.3289001993;13275;14243.928780356446;14740;14805.629859253175;14813.629659258604;11269.267497612629;11305.71735706614;12137;12223.572174973833;12653.873461265637;10569.524371403151;11257.041268826759;11387.316760994367;11709.297442153498;12107.152499324962 02:40:11 INFO - PROCESS | 6647 | __end_tp_report 02:40:11 INFO - PROCESS | 6647 | __start_cc_report 02:40:11 INFO - PROCESS | 6647 | _x_x_mozilla_cycle_collect,320 02:40:11 INFO - PROCESS | 6647 | __end_cc_report 02:40:11 INFO - PROCESS | 6647 | __startTimestamp1483612811835__endTimestamp 02:40:11 INFO - PROCESS | 6647 | 02:40:11 INFO - PROCESS | 6647 | ------- Summary: start ------- 02:40:11 INFO - PROCESS | 6647 | Number of tests: 6 02:40:11 INFO - PROCESS | 6647 | 02:40:11 INFO - PROCESS | 6647 | [#0] dojo.html Cycles:165 Average:5394.31 Median:5629.35 stddev:626.49 (11.1%) stddev-sans-first:603.59 02:40:11 INFO - PROCESS | 6647 | Values: 3168.5 3197.8 3201.9 3213.9 3220.5 5268.2 5326.9 5358.0 5386.7 5392.3 5331.3 5339.0 5422.7 5430.9 5509.9 4856.1 4861.5 4907.3 4971.7 5007.3 4799.5 4942.7 5023.8 5035.6 5035.8 4839.7 4870.0 4944.8 5002.2 5026.2 4883.7 4892.5 4919.5 4949.3 4979.7 4875.7 4909.2 4912.2 4926.4 4974.9 5245.6 5373.9 5415.5 5417.1 5423.4 5678.0 5712.8 5719.2 5765.2 5842.8 5780.8 5793.3 5794.6 5800.5 5814.9 5405.6 5418.3 5418.7 5422.4 5424.2 5813.5 5855.4 5933.8 5966.9 5978.2 5737.2 5771.8 5786.8 5787.8 5846.6 5843.9 5871.9 5873.2 5899.3 5906.0 5633.9 5673.3 5771.5 5776.8 5786.6 5827.5 5835.9 5852.5 5854.6 5881.9 4369.3 4379.5 4388.3 4395.3 4411.6 3795.0 3800.0 3888.8 3905.7 3959.2 5615.3 5618.5 5627.8 5671.5 5683.3 5838.8 5863.6 5913.5 5918.4 5932.7 5385.1 5411.3 5489.2 5613.2 5621.9 4798.5 4829.4 4848.3 4870.8 4887.0 6119.0 6127.5 6131.2 6143.8 6148.0 5598.7 5623.6 5863.4 5866.9 5875.1 5893.1 5921.8 5932.8 5944.6 5948.3 5533.4 5571.6 5579.5 5595.4 5607.7 5659.7 5670.9 5826.7 5859.0 5879.8 5729.7 5752.3 5756.4 5771.1 5806.5 5718.4 5755.9 5778.5 5778.7 5784.0 5528.4 5559.3 5648.4 5656.8 5705.9 5764.6 5770.7 5785.4 5792.3 5803.1 5629.4 5630.0 5643.5 5653.2 5657.4 02:40:11 INFO - PROCESS | 6647 | 02:40:11 INFO - PROCESS | 6647 | [#1] ext.html Cycles:180 Average:58694.04 Median:38846.92 stddev:113213.91 (291.4%) stddev-sans-first:113447.34 02:40:11 INFO - PROCESS | 6647 | Values: 551.7 566.2 574.3 586.0 586.9 43941.0 44850.3 44979.6 49298.5 49508.0 46928.5 47568.0 47626.0 47645.0 47681.3 9097.2 9280.8 9284.2 9286.6 10267.7 10188.0 10561.7 10568.3 10571.9 10574.7 10591.0 10610.8 10653.5 10657.9 10664.6 10539.8 10568.3 10630.5 10642.1 10646.4 10370.9 10457.1 10459.4 10511.6 10514.0 38996.0 39108.8 39370.6 39388.8 39477.8 4131.7 4158.5 4206.3 4226.3 4258.0 30198.0 30351.2 30790.7 31087.8 31515.5 4224.5 4451.5 4480.4 4484.4 4493.2 326139.0 326221.0 326593.0 326737.0 327244.0 53874.2 53978.5 54437.0 54683.5 54751.7 56626.4 56644.7 57209.4 57258.4 57362.0 16293.4 16665.8 16692.7 16722.5 16737.2 12127.8 12318.3 12351.1 12604.4 13052.8 17904.6 18101.6 18128.2 18204.3 18241.6 6885.3 7206.4 7246.9 7289.2 7290.2 941.0 955.6 956.6 989.8 998.9 31348.4 31647.8 32363.4 32703.5 33037.5 1097.9 1103.8 1122.3 1149.4 1240.3 17003.7 17065.8 17184.1 17469.4 17643.7 527923.0 531876.0 532445.4 533050.0 533965.0 63293.0 63762.4 64101.4 64121.4 64436.7 1424.5 1463.5 1468.4 1476.3 1480.7 29173.7 30666.2 31889.8 32654.3 32769.3 53499.5 55060.2 55074.7 55100.0 55375.0 398505.0 398694.0 398715.0 399651.0 400024.0 28897.0 29225.4 29471.9 29474.0 29498.7 48890.2 49035.8 49119.5 49134.5 50448.0 41284.4 41768.2 42347.6 42984.0 43266.0 36991.4 38756.6 38871.6 41781.8 42764.0 38274.2 38690.8 38822.2 39568.8 39674.6 32393.8 33925.8 34838.1 35278.3 35513.3 26644.5 27231.2 27386.3 27584.3 27613.2 02:40:11 INFO - PROCESS | 6647 | 02:40:11 INFO - PROCESS | 6647 | [#2] jquery.html Cycles:180 Average:32718.25 Median:1635.52 stddev:93746.64 (5731.9%) stddev-sans-first:93978.25 02:40:11 INFO - PROCESS | 6647 | Values: 416.0 421.5 425.4 429.2 443.6 18442.4 18974.1 20104.8 20205.4 20300.2 20348.6 20499.2 20744.3 21022.8 21424.8 5887.3 6144.7 6154.9 6170.6 6180.2 5917.3 5942.8 5984.8 6047.4 6087.4 5957.4 5971.3 5977.8 5978.7 5995.2 5835.3 5985.2 6001.2 6010.2 6020.7 5373.5 5395.4 5416.6 5424.8 5429.2 23545.0 24694.5 24766.4 25024.4 25238.6 2794.5 2828.2 2830.6 2849.1 2855.1 14590.0 15258.8 15462.8 15499.9 15852.2 1717.5 1813.5 1843.0 1856.7 1857.3 94146.0 94726.0 96349.0 97571.5 97884.0 12292.4 12370.3 12539.5 12539.9 12583.7 16847.2 16854.4 16878.5 16884.6 16961.7 8368.1 8601.4 8612.1 8615.5 8853.0 8162.9 8221.7 8302.4 8427.4 8468.2 5129.3 5189.8 5204.6 5232.1 5303.5 2096.9 2124.7 2141.9 2181.9 2192.4 880.4 902.9 904.4 907.8 916.7 20104.2 20942.7 20963.7 20990.5 21072.5 890.4 912.8 926.4 937.9 939.5 11006.7 11287.8 11387.9 11529.6 11546.3 548746.0 563235.0 565328.0 574922.0 587346.0 99809.5 99908.5 103003.0 103098.5 105674.5 1014.3 1024.1 1038.9 1043.8 1113.9 18588.3 18652.4 18805.5 18817.2 19052.0 44959.0 44961.8 45011.3 45856.3 45923.0 65766.3 66232.7 66344.7 67308.7 67932.0 9066.4 9229.9 9315.0 9359.2 9595.1 8987.5 10217.8 13085.4 14144.3 14280.2 11799.0 12042.2 12096.6 12165.8 12288.6 11174.3 11310.8 11564.2 11750.8 11812.0 11837.8 11891.4 11913.2 12464.3 12555.4 7760.5 8034.2 8159.0 9093.7 9249.0 9088.8 11406.5 11825.1 12080.9 12643.2 02:40:11 INFO - PROCESS | 6647 | 02:40:11 INFO - PROCESS | 6647 | [#3] mootools.html Cycles:180 Average:5570.62 Median:5096.41 stddev:3064.73 (60.1%) stddev-sans-first:3057.54 02:40:11 INFO - PROCESS | 6647 | Values: 1431.9 1444.1 1444.8 1446.3 1458.5 7432.9 7544.8 8105.0 8646.7 8659.6 7534.8 7806.5 7814.5 7978.6 7989.8 2301.8 2334.0 2340.1 2340.4 2342.9 2228.4 2234.5 2269.2 2281.4 2296.0 2338.5 2361.6 2365.2 2368.2 2382.6 2285.3 2315.3 2323.1 2328.2 2332.5 2301.4 2335.4 2356.2 2358.5 2366.1 8700.4 8736.7 8753.1 8819.9 8840.9 5266.7 5397.6 5433.0 5434.9 5436.2 3267.0 3365.8 3431.4 3445.3 3489.6 1353.3 1399.1 1400.1 1449.8 1470.1 11679.8 11696.2 11726.3 11733.8 11743.3 4469.4 4541.3 4562.7 4576.5 4630.9 8734.3 9116.5 9230.3 9276.1 9282.0 5200.8 5338.3 5357.5 5359.7 5365.9 4871.1 4895.2 4991.7 5027.9 5042.3 3703.1 3715.5 3721.4 3777.0 3812.6 1149.4 1159.2 1172.7 1180.7 1212.0 925.9 940.6 952.1 956.7 963.3 5336.4 5485.6 5513.0 5598.0 5603.2 986.1 1029.4 1030.9 1047.3 1070.5 3508.6 3539.8 3753.2 3796.8 3849.9 10066.4 10253.3 10281.1 10330.1 10349.4 10214.2 10280.3 10326.4 10342.5 10385.0 7582.9 7994.8 8006.2 8138.3 8174.3 5477.6 5661.9 5746.3 5813.7 5873.5 9173.7 9346.3 9407.2 9460.6 9561.1 9529.2 9553.4 9591.3 9604.3 9606.3 7246.3 7252.6 7395.5 7557.4 7621.5 8377.0 8408.8 8416.8 8448.9 8466.8 7488.2 7577.2 7604.9 7724.1 7759.0 7394.9 7475.9 7554.0 7594.8 7598.5 6513.3 6652.6 6656.6 6657.8 6658.9 4794.7 4795.6 4880.0 4893.0 5095.7 4976.9 5010.4 5097.1 5101.1 5177.2 02:40:11 INFO - PROCESS | 6647 | 02:40:11 INFO - PROCESS | 6647 | [#4] prototype.html Cycles:180 Average:4794.82 Median:5375.46 stddev:1386.61 (25.8%) stddev-sans-first:1350.61 02:40:11 INFO - PROCESS | 6647 | Values: 395.7 409.5 412.2 421.9 423.8 5175.5 5287.5 5396.0 5477.9 5499.0 5245.7 5380.6 5399.6 5406.5 5409.7 4388.0 4388.4 4389.9 4404.9 4430.7 4047.7 4231.5 4367.2 4409.1 4432.6 4260.1 4263.5 4264.8 4264.9 4267.8 4255.7 4261.8 4267.3 4272.9 4290.5 3813.3 3820.1 3831.0 3834.9 3838.3 5089.8 5209.8 5282.2 5284.4 5290.9 4835.5 4908.7 4911.4 4916.0 4928.7 5340.0 5624.4 5632.3 5638.4 5676.3 4071.8 4091.5 4103.2 4110.3 4123.5 5897.8 5941.8 5942.4 5979.9 6023.9 3988.6 4250.8 4251.2 4274.7 4286.9 4259.8 4286.8 4288.2 4290.4 4290.9 4858.2 4860.1 4861.9 4872.2 4879.6 5401.7 5587.9 5701.0 5710.5 5733.4 1429.7 1432.9 1434.3 1439.8 1451.4 941.3 998.4 1003.6 1012.7 1015.2 5185.6 5235.7 5314.7 5320.3 5370.4 5641.8 5647.4 5649.3 5655.6 5756.0 5020.5 5247.4 5256.6 5269.4 5392.8 2959.5 2976.0 2996.2 3000.6 3004.0 5895.8 5918.4 5928.8 5947.5 5983.5 5587.7 5905.9 5925.1 5935.5 5964.5 6087.9 6106.9 6138.0 6155.9 6261.6 5593.4 5775.9 5791.9 5817.0 5864.5 5751.2 5752.4 5787.6 5810.4 5836.7 5882.7 6104.9 6179.4 6180.7 6208.0 4176.7 4389.4 4473.9 4493.2 4517.3 5775.4 5840.8 5849.5 5864.2 5906.6 5483.8 5758.0 5768.5 5773.8 5787.4 5622.2 5674.6 5683.3 5692.8 5711.9 5499.6 5586.9 5619.7 5719.5 5721.1 5457.8 5611.2 5623.9 5650.5 5677.2 5508.6 5513.5 5539.9 5548.5 5579.2 02:40:11 INFO - PROCESS | 6647 | 02:40:11 INFO - PROCESS | 6647 | [#5] yui.html Cycles:180 Average:17509.70 Median:43240.57 stddev:21271.13 (49.2%) stddev-sans-first:21293.58 02:40:11 INFO - PROCESS | 6647 | Values: 752.4 777.7 805.7 841.4 860.3 15289.8 16590.5 16862.9 17293.4 17471.8 15486.4 15700.5 15704.8 15714.3 15898.2 734.5 751.2 766.3 767.2 769.1 777.9 781.1 782.9 783.0 784.7 808.9 812.0 814.3 821.2 821.4 808.6 808.6 813.3 815.2 815.9 595.7 599.7 599.8 600.0 600.3 15352.4 15522.8 16673.6 16812.7 16921.2 14873.7 15239.7 15261.2 15628.0 15743.4 12642.5 12810.3 12833.6 12841.2 12955.0 3771.7 3858.9 3905.1 3909.4 3947.8 76790.6 78091.0 78258.2 79814.0 80520.0 11642.7 11645.9 11748.6 11828.3 11931.3 22381.7 22772.3 22836.3 22838.2 22924.2 8344.3 8344.9 8420.8 8513.8 8524.4 4442.7 4531.6 4534.3 4570.1 4646.2 3781.9 3799.7 3818.4 3873.2 3887.7 627.4 628.6 634.6 642.6 702.5 754.9 766.4 767.9 781.7 806.2 9900.3 9963.5 10505.9 10722.6 11156.8 766.0 771.4 776.2 778.2 802.2 4862.9 5139.1 5144.3 5154.8 5169.8 65497.0 66521.3 67110.0 69789.7 77629.6 66474.3 66760.0 67590.0 68451.0 70236.0 48985.3 58044.0 59166.4 60309.4 61721.0 10116.9 10326.1 10529.7 10770.1 10897.2 41908.8 42600.4 43033.8 43447.3 45574.1 51700.8 52188.7 52379.7 54559.7 56200.4 12691.7 12894.8 12989.4 13491.5 13758.6 14440.4 14515.0 14980.3 15242.2 15780.3 14078.5 14575.8 14610.9 15456.2 15603.8 13933.0 14193.4 14624.7 14782.7 14913.3 13275.0 14243.9 14740.0 14805.6 14813.6 11269.3 11305.7 12137.0 12223.6 12653.9 10569.5 11257.0 11387.3 11709.3 12107.2 02:40:11 INFO - PROCESS | 6647 | -------- Summary: end -------- 02:40:11 INFO - PROCESS | 6647 | 02:40:12 INFO - TEST-INFO | 6647: exit 0 02:40:12 INFO - TEST-OK | dromaeo_css | took 1114125ms 02:40:12 INFO - TEST-START | kraken 02:40:12 INFO - operating with platform_type : linux_ 02:40:12 INFO - Initialising browser for kraken test... 02:40:12 INFO - TEST-INFO | started process 6998 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQH0YgL/profile http://localhost:57631/getInfo.html) 02:40:13 INFO - PROCESS | 6998 | 1483612813010 addons.xpi WARN Exception running bootstrap method install on shield-recipe-client@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getBoolPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js :: this.install :: line 38" data: no] Stack trace: this.install()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:38 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4907 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2060 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3762 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2795 < callProvider()@resource://gre/modules/AddonManager.jsm:263 < _startProvider()@resource://gre/modules/AddonManager.jsm:758 < startup()@resource://gre/modules/AddonManager.jsm:940 < startup()@resource://gre/modules/AddonManager.jsm:2913 < observe()@resource://gre/components/addonManager.js:65 02:40:16 INFO - PROCESS | 6998 | __metrics Screen width/height:1600/1200 02:40:16 INFO - PROCESS | 6998 | colorDepth:24 02:40:16 INFO - PROCESS | 6998 | Browser inner width/height: 1024/697 02:40:16 INFO - PROCESS | 6998 | __metrics 02:40:17 ERROR - PROCESS | 6998 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3252: TypeError: this.tabs is undefined 02:40:18 INFO - TEST-INFO | 6998: exit 0 02:40:18 INFO - Browser initialized. 02:40:18 INFO - Running cycle 1/1 for kraken test... 02:40:18 INFO - TEST-INFO | started process 7123 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQH0YgL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:40:30 INFO - PROCESS | 7123 | RSS: Main: 154292224 02:40:30 INFO - PROCESS | 7123 | 02:40:32 INFO - PROCESS | 7123 | Cycle 1(1): loaded http://localhost:57631/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57631/tests/kraken/driver.html?testName=audio-beat-detection) 02:40:33 INFO - PROCESS | 7123 | RSS: Main: 160972800 02:40:33 INFO - PROCESS | 7123 | 02:40:36 INFO - PROCESS | 7123 | Cycle 1(1): loaded http://localhost:57631/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57631/tests/kraken/driver.html?testName=audio-dft) 02:40:36 INFO - PROCESS | 7123 | RSS: Main: 159535104 02:40:36 INFO - PROCESS | 7123 | 02:40:39 INFO - PROCESS | 7123 | Cycle 1(1): loaded http://localhost:57631/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57631/tests/kraken/driver.html?testName=audio-fft) 02:40:40 INFO - PROCESS | 7123 | RSS: Main: 155987968 02:40:40 INFO - PROCESS | 7123 | 02:40:42 INFO - PROCESS | 7123 | Cycle 1(1): loaded http://localhost:57631/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57631/tests/kraken/driver.html?testName=audio-oscillator) 02:40:43 INFO - PROCESS | 7123 | RSS: Main: 156622848 02:40:43 INFO - PROCESS | 7123 | 02:40:45 INFO - PROCESS | 7123 | Cycle 1(1): loaded http://localhost:57631/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57631/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:40:45 INFO - PROCESS | 7123 | RSS: Main: 156925952 02:40:45 INFO - PROCESS | 7123 | 02:40:48 INFO - PROCESS | 7123 | Cycle 1(1): loaded http://localhost:57631/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57631/tests/kraken/driver.html?testName=imaging-darkroom) 02:40:49 INFO - PROCESS | 7123 | RSS: Main: 161792000 02:40:49 INFO - PROCESS | 7123 | 02:40:53 INFO - PROCESS | 7123 | Cycle 1(1): loaded http://localhost:57631/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57631/tests/kraken/driver.html?testName=imaging-desaturate) 02:40:53 INFO - PROCESS | 7123 | RSS: Main: 159973376 02:40:53 INFO - PROCESS | 7123 | 02:40:56 INFO - PROCESS | 7123 | Cycle 1(1): loaded http://localhost:57631/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57631/tests/kraken/driver.html?testName=json-parse-financial) 02:40:57 INFO - PROCESS | 7123 | RSS: Main: 160423936 02:40:57 INFO - PROCESS | 7123 | 02:40:58 INFO - PROCESS | 7123 | Cycle 1(1): loaded http://localhost:57631/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57631/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:40:59 INFO - PROCESS | 7123 | RSS: Main: 160342016 02:40:59 INFO - PROCESS | 7123 | 02:41:01 INFO - PROCESS | 7123 | Cycle 1(1): loaded http://localhost:57631/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57631/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:41:01 INFO - PROCESS | 7123 | RSS: Main: 160350208 02:41:01 INFO - PROCESS | 7123 | 02:41:03 INFO - PROCESS | 7123 | Cycle 1(1): loaded http://localhost:57631/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57631/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:41:04 INFO - PROCESS | 7123 | RSS: Main: 160227328 02:41:04 INFO - PROCESS | 7123 | 02:41:07 INFO - PROCESS | 7123 | Cycle 1(1): loaded http://localhost:57631/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57631/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:41:07 INFO - PROCESS | 7123 | RSS: Main: 160321536 02:41:07 INFO - PROCESS | 7123 | 02:41:10 INFO - PROCESS | 7123 | Cycle 1(1): loaded http://localhost:57631/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57631/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:41:11 INFO - PROCESS | 7123 | RSS: Main: 160608256 02:41:11 INFO - PROCESS | 7123 | 02:41:13 INFO - PROCESS | 7123 | Cycle 1(1): loaded http://localhost:57631/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57631/tests/kraken/driver.html?testName=ai-astar) 02:41:13 INFO - PROCESS | 7123 | RSS: Main: 162213888 02:41:13 INFO - PROCESS | 7123 | 02:41:13 INFO - PROCESS | 7123 | __start_tp_report 02:41:13 INFO - PROCESS | 7123 | _x_x_mozilla_page_load 02:41:13 INFO - PROCESS | 7123 | _x_x_mozilla_page_load_details 02:41:13 INFO - PROCESS | 7123 | |i|pagename|runs| 02:41:13 INFO - PROCESS | 7123 | |0;ai-astar;106;113;112;112;113;112;112;112;114;115 02:41:13 INFO - PROCESS | 7123 | |1;audio-beat-detection;148;121;120;170;123;122;123;122;143;123 02:41:13 INFO - PROCESS | 7123 | |2;audio-dft;163;161;162;163;165;174;164;162;162;165 02:41:13 INFO - PROCESS | 7123 | |3;audio-fft;77;76;75;108;77;77;76;76;97;78 02:41:13 INFO - PROCESS | 7123 | |4;audio-oscillator;83;83;108;84;83;83;103;85;83;112 02:41:13 INFO - PROCESS | 7123 | |5;imaging-gaussian-blur;119;117;118;117;118;117;118;117;121;118 02:41:13 INFO - PROCESS | 7123 | |6;imaging-darkroom;147;148;150;148;148;148;147;147;148;147 02:41:13 INFO - PROCESS | 7123 | |7;imaging-desaturate;96;97;96;96;97;97;96;97;96;97 02:41:13 INFO - PROCESS | 7123 | |8;json-parse-financial;58;57;57;59;58;58;58;58;57;58 02:41:13 INFO - PROCESS | 7123 | |9;json-stringify-tinderbox;66;67;66;66;67;66;71;66;66;66 02:41:13 INFO - PROCESS | 7123 | |10;stanford-crypto-aes;82;83;83;85;87;80;83;86;91;84 02:41:13 INFO - PROCESS | 7123 | |11;stanford-crypto-ccm;126;137;129;134;135;134;136;128;181;146 02:41:13 INFO - PROCESS | 7123 | |12;stanford-crypto-pbkdf2;168;172;170;165;169;166;170;167;170;167 02:41:13 INFO - PROCESS | 7123 | |13;stanford-crypto-sha256-iterative;66;63;65;62;63;63;64;62;63;67 02:41:13 INFO - PROCESS | 7123 | __end_tp_report 02:41:13 INFO - PROCESS | 7123 | __start_cc_report 02:41:13 INFO - PROCESS | 7123 | _x_x_mozilla_cycle_collect,733 02:41:13 INFO - PROCESS | 7123 | __end_cc_report 02:41:13 INFO - PROCESS | 7123 | __startTimestamp1483612873376__endTimestamp 02:41:13 INFO - PROCESS | 7123 | 02:41:13 INFO - PROCESS | 7123 | ------- Summary: start ------- 02:41:13 INFO - PROCESS | 7123 | Number of tests: 14 02:41:13 INFO - PROCESS | 7123 | 02:41:13 INFO - PROCESS | 7123 | [#0] ai-astar Cycles:10 Average:112.10 Median:112.50 stddev:2.38 (2.1%) stddev-sans-first:1.09 02:41:13 INFO - PROCESS | 7123 | Values: 106.0 113.0 112.0 112.0 113.0 112.0 112.0 112.0 114.0 115.0 02:41:13 INFO - PROCESS | 7123 | 02:41:13 INFO - PROCESS | 7123 | [#1] audio-beat-detection Cycles:10 Average:131.50 Median:123.00 stddev:16.75 (13.6%) stddev-sans-first:16.67 02:41:13 INFO - PROCESS | 7123 | Values: 148.0 121.0 120.0 170.0 123.0 122.0 123.0 122.0 143.0 123.0 02:41:13 INFO - PROCESS | 7123 | 02:41:13 INFO - PROCESS | 7123 | [#2] audio-dft Cycles:10 Average:164.10 Median:163.50 stddev:3.73 (2.3%) stddev-sans-first:3.93 02:41:13 INFO - PROCESS | 7123 | Values: 163.0 161.0 162.0 163.0 165.0 174.0 164.0 162.0 162.0 165.0 02:41:13 INFO - PROCESS | 7123 | 02:41:13 INFO - PROCESS | 7123 | [#3] audio-fft Cycles:10 Average:81.70 Median:77.00 stddev:11.29 (14.7%) stddev-sans-first:11.85 02:41:13 INFO - PROCESS | 7123 | Values: 77.0 76.0 75.0 108.0 77.0 77.0 76.0 76.0 97.0 78.0 02:41:13 INFO - PROCESS | 7123 | 02:41:13 INFO - PROCESS | 7123 | [#4] audio-oscillator Cycles:10 Average:90.70 Median:83.00 stddev:11.92 (14.4%) stddev-sans-first:12.31 02:41:13 INFO - PROCESS | 7123 | Values: 83.0 83.0 108.0 84.0 83.0 83.0 103.0 85.0 83.0 112.0 02:41:13 INFO - PROCESS | 7123 | 02:41:13 INFO - PROCESS | 7123 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:1.25 (1.1%) stddev-sans-first:1.27 02:41:13 INFO - PROCESS | 7123 | Values: 119.0 117.0 118.0 117.0 118.0 117.0 118.0 117.0 121.0 118.0 02:41:13 INFO - PROCESS | 7123 | 02:41:13 INFO - PROCESS | 7123 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:148.00 stddev:0.92 (0.6%) stddev-sans-first:0.93 02:41:13 INFO - PROCESS | 7123 | Values: 147.0 148.0 150.0 148.0 148.0 148.0 147.0 147.0 148.0 147.0 02:41:13 INFO - PROCESS | 7123 | 02:41:13 INFO - PROCESS | 7123 | [#7] imaging-desaturate Cycles:10 Average:96.50 Median:97.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 02:41:13 INFO - PROCESS | 7123 | Values: 96.0 97.0 96.0 96.0 97.0 97.0 96.0 97.0 96.0 97.0 02:41:13 INFO - PROCESS | 7123 | 02:41:13 INFO - PROCESS | 7123 | [#8] json-parse-financial Cycles:10 Average:57.80 Median:58.00 stddev:0.63 (1.1%) stddev-sans-first:0.67 02:41:13 INFO - PROCESS | 7123 | Values: 58.0 57.0 57.0 59.0 58.0 58.0 58.0 58.0 57.0 58.0 02:41:13 INFO - PROCESS | 7123 | 02:41:13 INFO - PROCESS | 7123 | [#9] json-stringify-tinderbox Cycles:10 Average:66.70 Median:66.00 stddev:1.57 (2.4%) stddev-sans-first:1.64 02:41:13 INFO - PROCESS | 7123 | Values: 66.0 67.0 66.0 66.0 67.0 66.0 71.0 66.0 66.0 66.0 02:41:13 INFO - PROCESS | 7123 | 02:41:13 INFO - PROCESS | 7123 | [#10] stanford-crypto-aes Cycles:10 Average:84.40 Median:84.50 stddev:3.06 (3.6%) stddev-sans-first:3.12 02:41:13 INFO - PROCESS | 7123 | Values: 82.0 83.0 83.0 85.0 87.0 80.0 83.0 86.0 91.0 84.0 02:41:13 INFO - PROCESS | 7123 | 02:41:13 INFO - PROCESS | 7123 | [#11] stanford-crypto-ccm Cycles:10 Average:138.60 Median:135.50 stddev:15.92 (11.7%) stddev-sans-first:16.22 02:41:13 INFO - PROCESS | 7123 | Values: 126.0 137.0 129.0 134.0 135.0 134.0 136.0 128.0 181.0 146.0 02:41:13 INFO - PROCESS | 7123 | 02:41:13 INFO - PROCESS | 7123 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.40 Median:169.50 stddev:2.17 (1.3%) stddev-sans-first:2.30 02:41:13 INFO - PROCESS | 7123 | Values: 168.0 172.0 170.0 165.0 169.0 166.0 170.0 167.0 170.0 167.0 02:41:13 INFO - PROCESS | 7123 | 02:41:13 INFO - PROCESS | 7123 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.80 Median:63.50 stddev:1.69 (2.7%) stddev-sans-first:1.59 02:41:13 INFO - PROCESS | 7123 | Values: 66.0 63.0 65.0 62.0 63.0 63.0 64.0 62.0 63.0 67.0 02:41:13 INFO - PROCESS | 7123 | -------- Summary: end -------- 02:41:13 INFO - PROCESS | 7123 | 02:41:14 INFO - TEST-INFO | 7123: exit 0 02:41:14 INFO - TEST-OK | kraken | took 61819ms 02:41:14 INFO - SUITE-END | took 1175s 02:41:14 INFO - Completed test suite (00:19:36) 02:41:14 INFO - javascript benchmark 02:41:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7353.810613206302, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3168.461361568533, 3197.840107994601, 3201.855916483758, 3213.855376508058, 3220.5491231227647, 5268.236105764662, 5326.893462130755, 5358.0, 5386.73066346683, 5392.325959255093, 5331.280277162582, 5339.0, 5422.728863556826, 5430.8913821723545, 5509.917351239725, 4856.10162120008, 4861.513848615128, 4907.312976183337, 4971.651984361096, 5007.324011258488, 4799.472058073609, 4942.728149951751, 5023.799048038074, 5035.622328325372, 5035.84892453227, 4839.685420447659, 4870.0, 4944.802207911679, 5002.224655178453, 5026.170681837492, 4883.682560633548, 4892.486288939681, 4919.532644398776, 4949.307097006422, 4979.7261150636705, 4875.68308059975, 4909.214525675875, 4912.238603016538, 4926.4088309403105, 4974.925376119361, 5245.632805703603, 5373.946260537384, 5415.48552887479, 5417.106177480711, 5423.430539793344, 5677.971610141964, 5712.80005199816, 5719.227904232958, 5765.1640512125505, 5842.824715258549, 5780.7687692492245, 5793.275840519935, 5794.594378393472, 5800.477956983849, 5814.912776308359, 5405.648632838853, 5418.29562156921, 5418.729063546807, 5422.43064478228, 5424.159255315432, 5813.476787089182, 5855.443732845373, 5933.762649493972, 5966.880662386815, 5978.1929439525975, 5737.225474560964, 5771.797987070432, 5786.826395208151, 5787.768489260382, 5846.590738648339, 5843.912341314884, 5871.853203669857, 5873.177755114288, 5899.321578018497, 5906.0, 5633.943660563424, 5673.262475878192, 5771.538276937835, 5776.826695199151, 5786.566007549451, 5827.504662103684, 5835.912461313083, 5852.473277405054, 5854.648721076749, 5881.852953676193, 4369.300911854088, 4379.540148284448, 4388.2759344707765, 4395.3187255974735, 4411.647068234533, 3795.0, 3800.0, 3888.7666739995125, 3905.726599138033, 3959.247742928834, 5615.298087739033, 5618.494335509824, 5627.803026894039, 5671.489565939085, 5683.2895888014, 5838.795642152504, 5863.560232982543, 5913.49735272498, 5918.378570250062, 5932.673702946293, 5385.138377859524, 5411.269478620415, 5489.176623506506, 5613.214150019001, 5621.943780562142, 4798.47216806151, 4829.444613869379, 4848.296996935424, 4870.805167793319, 4886.951130488721, 6118.969405152946, 6127.540434467343, 6131.233595800525, 6143.754249830046, 6147.96926015376, 5598.748056337393, 5623.550115990629, 5863.413658634103, 5866.911996319973, 5875.14810352488, 5893.057110862242, 5921.822345329647, 5932.762689492544, 5944.64332140073, 5948.315943666534, 5533.446655334435, 5571.637843540157, 5579.525740311957, 5595.412481689364, 5607.663540187602, 5659.745311460912, 5670.914936276042, 5826.650400975955, 5859.00396932514, 5879.794207202727, 5729.656220626775, 5752.252207213036, 5756.366799651951, 5771.134329850556, 5806.5064469518875, 5718.399568045295, 5755.906377788207, 5778.508826749605, 5778.682172480554, 5784.0, 5528.44715528444, 5559.305086864142, 5648.378678345297, 5656.8020119295625, 5705.942940570541, 5764.567657425626, 5770.653760774367, 5785.4214578541805, 5792.304923409218, 5803.100519419497, 5629.352624448241, 5629.971850140723, 5643.463870932255, 5653.2085508028085, 5657.4059723728415], "value": 5351.538863836336, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [551.7048379117172, 566.2271000084883, 574.2850151561307, 585.9560532960027, 586.8826234753047, 43941.0, 44850.32724509131, 44979.550204497944, 49298.50701492984, 49508.0, 46928.530714692846, 47568.0, 47626.0, 47645.0, 47681.28478072832, 9097.226735727454, 9280.814383712323, 9284.210842078432, 9286.628534858632, 10267.743306417324, 10187.98120187979, 10561.735956601107, 10568.260221784478, 10571.947140264288, 10574.735631609194, 10591.046805787477, 10610.840837387444, 10653.467326633676, 10657.893421065768, 10664.573417063308, 10539.789204215911, 10568.260221784478, 10630.521626526825, 10642.09542188915, 10646.361218326925, 10370.85920548739, 10457.058864702138, 10459.424731639756, 10511.63209287679, 10514.0, 38996.0, 39108.80445597754, 39370.60629393698, 39388.80305598483, 39477.80261098705, 4131.669466442678, 4158.521769996429, 4206.348016057516, 4226.344916537942, 4258.0, 30198.0, 30351.24121896948, 30790.692093079007, 31087.84456077705, 31515.527267091013, 4224.471941007374, 4451.5103338632725, 4480.439945006874, 4484.41702578666, 4493.213687604689, 326139.0, 326221.0, 326593.0, 326737.0, 327244.0, 53874.19188712173, 53978.46021539735, 54437.0, 54683.45316546863, 54751.72624136854, 56626.43373566212, 56644.71677641585, 57209.42790572041, 57258.42741572531, 57362.0, 16293.429729959631, 16665.833341666672, 16692.664586833023, 16722.498325050266, 16737.16314184286, 12127.818082728767, 12318.322492262832, 12351.073669474825, 12604.369781511072, 13052.804207936888, 17904.641907161782, 18101.637967240582, 18128.184231709605, 18204.271829126686, 18241.63516729658, 6885.345892140239, 7206.423486121098, 7246.927530724625, 7289.2346303638415, 7290.161631412456, 941.0119374656583, 955.6177528988321, 956.636478138303, 989.8020395920845, 998.8851282102506, 31348.37303253922, 31647.84176079105, 32363.352732945208, 32703.50944735831, 33037.50443743346, 1097.8737445193744, 1103.7682086761708, 1122.2817396866012, 1149.436775979764, 1240.2620440837686, 17003.659926801396, 17065.829341706423, 17184.054876981638, 17469.388571400195, 17643.73534396985, 527923.0, 531876.0, 532445.4043676497, 533050.0, 533965.0, 63293.0, 63762.36237637657, 64101.35898640954, 64121.35878641154, 64436.677816610616, 1424.4658253155067, 1463.4877792772656, 1468.3906178935836, 1476.343027352839, 1480.6520467690084, 29173.7082629171, 30666.233344166576, 31889.840550797097, 32654.34691306208, 32769.34461310808, 53499.465005351005, 55060.174097389376, 55074.724626376614, 55100.0, 55375.0, 398505.0, 398694.0, 398715.0, 399651.0, 400024.0, 28897.0, 29225.415491690474, 29471.85264073666, 29474.0, 29498.705012949595, 48890.199764042816, 49035.754821225666, 49119.50880491149, 49134.508654914425, 50448.0, 41284.38073428961, 41768.164636707705, 42347.57652423436, 42984.0, 43266.0, 36991.44512832256, 38756.6124338753, 38871.61128388793, 41781.79109104435, 42764.0, 38274.2345153101, 38690.80654596709, 38822.223555529294, 39568.80215598903, 39674.60325396824, 32393.83803081064, 33925.83037084799, 34838.12904677302, 35278.29443411169, 35513.28973420569, 26644.46711065729, 27231.183064508095, 27386.31534211581, 27584.310392240353, 27613.171604851887], "value": 20515.190879761132, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [415.97712125833067, 421.51736261980017, 425.3874420833998, 429.22524842659004, 443.58967954641946, 18442.354517591888, 18974.061342024183, 20104.798952010475, 20205.39383818486, 20300.18799248028, 20348.59302813943, 20499.180032798708, 20744.273950411738, 21022.789772102275, 21424.785752142474, 5887.293524777033, 6144.662043587601, 6154.906986853737, 6170.598911070789, 6180.227471566054, 5917.349091599942, 5942.762289508414, 5984.790532331369, 6047.425494578008, 6087.391260873921, 5957.374475680056, 5971.283445986488, 5977.8206653800235, 5978.730957106941, 5995.160677505153, 5835.270591176103, 5985.191999080133, 6001.159837622737, 6010.248718910137, 6020.698965051752, 5373.543248823816, 5395.406505284415, 5416.620836541444, 5424.810131645373, 5429.212764149216, 23545.0, 24694.5061098777, 24766.380840478952, 25024.37439064038, 25238.621420678704, 2794.455081259155, 2828.1656911211244, 2830.616054760423, 2849.088291746642, 2855.0578309157927, 14590.0, 15258.847411525854, 15462.768058479132, 15499.922500387425, 15852.207389630588, 1717.4847545736354, 1813.537547925284, 1842.9907850460795, 1856.7029275315886, 1857.3127942661301, 94145.99999999932, 94726.0, 96349.0, 97571.51214243955, 97884.0, 12292.385380730928, 12370.319632420304, 12539.498420063277, 12539.874601254052, 12583.748325033632, 16847.24187411545, 16854.41009564659, 16878.493645190418, 16884.57788555296, 16961.660766784596, 8368.139802879434, 8601.354898382646, 8612.138786121463, 8615.526146062026, 8852.955735221412, 8162.918370816215, 8221.671133154727, 8302.377321700897, 8427.367947403847, 8468.153184681483, 5129.256257842592, 5189.844304670866, 5204.583633309327, 5232.063310355141, 5303.496167864047, 2096.863703859244, 2124.734408198975, 2141.9250326238816, 2181.879996600202, 2192.3861318830754, 880.4321212817824, 902.8781114549583, 904.3533873280636, 907.8048219632678, 916.6837441082815, 20104.195832166843, 20942.67870086275, 20963.685544716842, 20990.475238118863, 21072.473188170417, 890.3589415620743, 912.8219997100634, 926.3885835348772, 937.8827646544182, 939.4973689076311, 11006.669799906016, 11287.774244515227, 11387.886121138683, 11529.596464123715, 11546.307221566733, 548746.0, 563235.0, 565328.0, 574922.0, 587346.0, 99809.50095249622, 99908.50045749724, 103003.0, 103098.5239649508, 105674.47162764137, 1014.3204053284318, 1024.073213741565, 1038.9064984151462, 1043.7651528406047, 1113.8774734779329, 18588.25646974106, 18652.440426786674, 18805.529861753566, 18817.24731010799, 19052.0, 44959.0, 44961.77519112384, 45011.32483012692, 45856.31215531837, 45923.0, 65766.34233657602, 66232.6688366555, 66344.68276586055, 67308.66345668436, 67932.0, 9066.368053750388, 9229.86155207659, 9315.0, 9359.15767580921, 9595.13643772064, 8987.46075235488, 10217.795644086927, 13085.41115649779, 14144.302683678025, 14280.214588197749, 11799.0, 12042.21725587834, 12096.637100886988, 12165.81751273714, 12288.569900053455, 11174.27367221128, 11310.773784524428, 11564.190506664452, 11750.764984700087, 11812.0, 11837.822432663344, 11891.394661720557, 11913.225640333698, 12464.252144871336, 12555.435005424595, 7760.534367937942, 8034.196580341919, 8158.959205203936, 9093.727188184364, 9249.0, 9088.818223635622, 11406.48670809799, 11825.113116516124, 12080.93959530232, 12643.241405515699], "value": 9803.177638594929, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1431.949881754139, 1444.0830072903702, 1444.7616143336347, 1446.291317254545, 1458.474949018354, 7432.9256707432905, 7544.773656790291, 8105.0, 8646.697365592205, 8659.610317535718, 7534.773956781305, 7806.492577982442, 7814.452988290822, 7978.561179135145, 7989.760307190793, 2301.7813307735737, 2334.043042352636, 2340.052278827069, 2340.3914982104607, 2342.910546595833, 2228.4428892776805, 2234.5419189066283, 2269.1604106480627, 2281.3726225288096, 2296.0, 2338.4504641409253, 2361.574916515035, 2365.1840115160244, 2368.159303447277, 2382.5830479666074, 2285.268714011517, 2315.3169814904645, 2323.117215458132, 2328.231683544443, 2332.486852892361, 2301.390131615123, 2335.4161459635093, 2356.15178535727, 2358.5400846834873, 2366.0890557135453, 8700.434471759316, 8736.737897863075, 8753.124687531259, 8819.867701984474, 8840.8673869892, 5266.657667251617, 5397.595180361489, 5433.049216387117, 5434.885848401068, 5436.184572314145, 3267.0, 3365.7812242204177, 3431.365197438482, 3445.3453843769603, 3489.6335884732243, 1353.262471952788, 1399.0766094377764, 1400.0969374753226, 1449.7535418978798, 1470.0958910270215, 11679.766404671944, 11696.18126731129, 11726.296422214695, 11733.823992640117, 11743.295402275891, 4469.41897553316, 4541.250693635513, 4562.6996306052615, 4576.473705523841, 4630.884227894329, 8734.257588105082, 9116.49859257734, 9230.307726920508, 9276.11876871696, 9281.95359023214, 5200.803815122543, 5338.252644629677, 5357.544608708304, 5359.678419294777, 5365.946340536622, 4871.098846713369, 4895.241237608177, 4991.700497970133, 5027.874303142451, 5042.3444952156715, 3703.148275896559, 3715.498407714924, 3721.3673675475234, 3777.0, 3812.5806161322234, 1149.3563604381407, 1159.1769843411105, 1172.6540670502222, 1180.734334774686, 1211.9878801211876, 925.9166674999148, 940.5673390240567, 952.1050212799946, 956.7464621875208, 963.2534785541261, 5336.4129945705945, 5485.61600687948, 5513.0, 5598.048331783525, 5603.187537806995, 986.0829428631441, 1029.351508549624, 1030.8762948446235, 1047.3454091193005, 1070.4540684251087, 3508.5965114011706, 3539.8053107078845, 3753.230587729509, 3796.772193668389, 3849.9037524062123, 10066.44634545107, 10253.282270241161, 10281.12610428122, 10330.121939635064, 10349.43078130695, 10214.233932455096, 10280.280380373451, 10326.380417174994, 10342.482875856178, 10385.0, 7582.886256706154, 7994.760157195294, 8006.1993800619475, 8138.267555920114, 8174.264316211569, 5477.643953143033, 5661.858453538694, 5746.281714785652, 5813.709314534171, 5873.472897046884, 9173.724788256362, 9346.345755797029, 9407.247420206504, 9460.621575136918, 9561.091696288842, 9529.190018848476, 9553.379030363005, 9591.328606997444, 9604.327697061419, 9606.327557070937, 7246.275372462923, 7252.601106939169, 7395.482316237812, 7557.35762460175, 7621.504602200839, 8377.0, 8408.831823363376, 8416.789580260542, 8448.873266900879, 8466.830663386821, 7488.213737557478, 7577.204393538819, 7604.923950760422, 7724.111727151225, 7759.030121234846, 7394.852102957803, 7475.88786168197, 7554.0, 7594.8101297468, 7598.544087354777, 6513.283538810632, 6652.634105124264, 6656.633885136171, 6657.833554161185, 6658.933410666025, 4794.712317260975, 4795.568398844121, 4880.0, 4892.951070489249, 5095.719735414587, 4976.900461990667, 5010.423801262901, 5097.108006098992, 5101.107306221471, 5177.223416487557], "value": 4526.956714379198, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [395.6770802574852, 409.54335915454277, 412.2003313571671, 421.877655479911, 423.7563401044399, 5175.482451754822, 5287.47125287471, 5396.0, 5477.917831232529, 5498.9725051374735, 5245.7377131143485, 5380.569554435646, 5399.5680345572355, 5406.486383793534, 5409.7016715988175, 4387.999999999992, 4388.410837605812, 4389.912201755963, 4404.889877753049, 4430.734155950653, 4047.655949244303, 4231.513375961757, 4367.213901497729, 4409.140217657558, 4432.578905004019, 4260.084081922386, 4263.509696384925, 4264.765437900915, 4264.91019400493, 4267.8079486423185, 4255.723377980421, 4261.829526818923, 4267.295896177127, 4272.935905961429, 4290.528041915387, 3813.2754776592637, 3820.083180036771, 3831.0, 3834.9424758628643, 3838.3111430970284, 5089.796408143707, 5209.843704688866, 5282.2076688496645, 5284.4187139414635, 5290.867728306785, 4835.492273311287, 4908.656394052417, 4911.4106307243, 4915.975420122876, 4928.654994150411, 5340.0, 5624.437556244384, 5632.295963004624, 5638.4361563843695, 5676.3188417389765, 4071.7964101795087, 4091.468109145792, 4103.2409004333995, 4110.260153172428, 4123.525794533637, 5897.790952854697, 5941.7920372787175, 5942.405759424067, 5979.940200597982, 6023.909641355383, 3988.6011398860464, 4250.829966801355, 4251.171021650748, 4274.7435153890865, 4286.914261714748, 4259.829606815754, 4286.849960251377, 4288.228118938621, 4290.37789520524, 4290.8843700637435, 4858.246971719389, 4860.1008813369635, 4861.9303753174245, 4872.19608764557, 4879.634027447955, 5401.7029063401105, 5587.8603034923635, 5701.0, 5710.486056254874, 5733.369329373765, 1429.6711756295902, 1432.9068610540282, 1434.3473719457622, 1439.7768345906193, 1451.426686458864, 941.3175447800427, 998.3660375661507, 1003.6386900715737, 1012.7366884610054, 1015.1523477895892, 5185.585153187736, 5235.717249273952, 5314.661548918463, 5320.2817619620855, 5370.355557333145, 5641.802536911188, 5647.407022262685, 5649.293838270216, 5655.575831812631, 5755.963926493271, 5020.49795020495, 5247.449017853147, 5256.6320357574605, 5269.367675878842, 5392.757325920343, 2959.4820906341306, 2976.0, 2996.2060054085687, 3000.6497076315745, 3004.0, 5895.848015474321, 5918.402031451484, 5928.806341653616, 5947.524198064145, 5983.516840511139, 5587.74855131512, 5905.940940590539, 5925.111233315038, 5935.495482883917, 5964.522838172936, 6087.939120608826, 6106.908396374058, 6137.987232106741, 6155.938440615537, 6261.5616906816085, 5593.356763972195, 5775.884482310415, 5791.884162316815, 5816.982028144973, 5864.530837532901, 5751.194832723339, 5752.395998420273, 5787.55311172207, 5810.448007439287, 5836.708164591839, 5882.7058647066615, 6104.877902441837, 6179.3820617937845, 6180.662442281297, 6207.96896015517, 4176.728512646669, 4389.429374181336, 4473.865784026484, 4493.236149854598, 4517.322401639649, 5775.422457754191, 5840.831833633205, 5849.502792262705, 5864.208331875142, 5906.645601263938, 5483.75323110469, 5758.021136406905, 5768.451997060272, 5773.826785196451, 5787.39232380594, 5622.184783206494, 5674.559939226172, 5683.346415162144, 5692.7722891083895, 5711.943290491273, 5499.615026948075, 5586.86032849182, 5619.747111379916, 5719.485246327684, 5721.141828725558, 5457.781688732406, 5611.158326250932, 5623.915641265467, 5650.547956163415, 5677.233573467694, 5508.586855985897, 5513.476219759277, 5539.944600554104, 5548.528375088002, 5579.246801681721], "value": 4371.9346105186905, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [752.428154602502, 777.700585274669, 805.7381351060903, 841.4404421059994, 860.2601762484264, 15289.847101528996, 16590.502284931456, 16862.915685421587, 17293.39473118441, 17471.82528174718, 15486.380544778223, 15700.528984130495, 15704.842951570481, 15714.292856821441, 15898.205089745496, 734.5078797205884, 751.1587022534769, 766.31797700047, 767.2365995834152, 769.1385648074137, 777.9183185765498, 781.1290411191509, 782.8747400415934, 783.0368646564729, 784.7371130671232, 808.9352851771844, 811.9512829230265, 814.3281792521194, 821.1870248454047, 821.3593397150232, 808.59974312715, 808.6361137488154, 813.3168138763438, 815.229608020418, 815.9428839981204, 595.6634501506635, 599.6671847124844, 599.8260504453704, 600.0, 600.2886579403378, 15352.385904563804, 15522.767158492632, 16673.583160420963, 16812.74780878288, 16921.238544265416, 14873.70252594953, 15239.695206095816, 15261.160636165007, 15628.0, 15743.370265189378, 12642.49430022798, 12810.29543375114, 12833.614991550268, 12841.165324253894, 12955.0, 3771.698264138862, 3858.903527411809, 3905.1213476967737, 3909.3745000799736, 3947.8026098695236, 76790.61604691997, 78091.0, 78258.21741782567, 79814.0, 80520.0, 11642.70893227676, 11645.941770291094, 11748.647540573797, 11828.34944078084, 11931.284122952651, 22381.664275035888, 22772.31683049511, 22836.31491055271, 22838.200662977048, 22924.19765308206, 8344.332453403713, 8344.874826877602, 8420.78948026292, 8513.787155321166, 8524.360672949553, 4442.666799990014, 4531.614812740954, 4534.274516077412, 4570.085982803453, 4646.233371493733, 3781.8865434037025, 3799.7340186186702, 3818.4463252828186, 3873.2447172801035, 3887.688984881203, 627.4227710506345, 628.5882746800853, 634.5875181132209, 642.5534253693638, 702.5187746393736, 754.9091562691857, 766.4136935244543, 767.85794627994, 781.7263957614789, 806.2018601584389, 9900.306978511579, 9963.452010139366, 10505.9474702626, 10722.624708135178, 11156.832647510293, 766.0440078390448, 771.4388231072785, 776.1927595300937, 778.2101167315179, 802.2418814220506, 4862.878428039327, 5139.100657384943, 5144.254083157996, 5154.819581314636, 5169.81905633301, 65497.0, 66521.33478665249, 67109.99335009979, 69789.65105174441, 77629.6118519415, 66474.33525664681, 66760.0, 67590.0, 68451.0, 70236.0, 48985.26522102171, 58044.0, 59166.40833591695, 60309.39690603125, 61720.999999999105, 10116.949415253172, 10326.076170440585, 10529.684109476728, 10770.138388929023, 10897.237193396386, 41908.79045604752, 42600.360994585724, 43033.784831075645, 43447.34828977631, 45574.08851823011, 51700.75478461855, 52188.739056305996, 52379.73810131077, 54559.72720136374, 56200.43799561952, 12691.746165076831, 12894.806577901527, 12989.4154763034, 13491.460341586228, 13758.587242382744, 14440.422383104979, 14515.0, 14980.325885335404, 15242.237888105328, 15780.289886954884, 14078.507252246121, 14575.781363279348, 14610.858665386993, 15456.227188640747, 15603.765943511084, 13933.0, 14193.36873719582, 14624.70750584961, 14782.704345913236, 14913.3289001993, 13275.0, 14243.928780356446, 14740.0, 14805.629859253175, 14813.629659258604, 11269.267497612629, 11305.71735706614, 12137.0, 12223.572174973833, 12653.873461265637, 10569.524371403151, 11257.041268826759, 11387.316760994367, 11709.297442153498, 12107.152499324962], "value": 7423.82091411045, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1522.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 113.0, 112.0, 112.0, 113.0, 112.0, 112.0, 112.0, 114.0, 115.0], "value": 112.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 121.0, 120.0, 170.0, 123.0, 122.0, 123.0, 122.0, 143.0, 123.0], "value": 131.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 162.0, 163.0, 165.0, 174.0, 164.0, 162.0, 162.0, 165.0], "value": 164.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 75.0, 108.0, 77.0, 77.0, 76.0, 76.0, 97.0, 78.0], "value": 81.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 108.0, 84.0, 83.0, 83.0, 103.0, 85.0, 83.0, 112.0], "value": 90.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 117.0, 118.0, 117.0, 118.0, 117.0, 118.0, 117.0, 121.0, 118.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 150.0, 148.0, 148.0, 148.0, 147.0, 147.0, 148.0, 147.0], "value": 147.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 96.0, 96.0, 97.0, 97.0, 96.0, 97.0, 96.0, 97.0], "value": 96.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 57.0, 57.0, 59.0, 58.0, 58.0, 58.0, 58.0, 57.0, 58.0], "value": 57.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 66.0, 66.0, 67.0, 66.0, 71.0, 66.0, 66.0, 66.0], "value": 66.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 83.0, 85.0, 87.0, 80.0, 83.0, 86.0, 91.0, 84.0], "value": 84.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 137.0, 129.0, 134.0, 135.0, 134.0, 136.0, 128.0, 181.0, 146.0], "value": 138.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 172.0, 170.0, 165.0, 169.0, 166.0, 170.0, 167.0, 170.0, 167.0], "value": 168.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 63.0, 65.0, 62.0, 63.0, 63.0, 64.0, 62.0, 63.0, 67.0], "value": 63.8, "unit": "score"}]}]} 02:41:14 INFO - Return code: 0 02:41:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:41:14 ERROR - # TBPL SUCCESS # 02:41:14 INFO - Running post-action listener: _resource_record_post_action 02:41:14 INFO - [mozharness: 2017-01-05 10:41:14.662568Z] Finished run-tests step (success) 02:41:14 INFO - Running post-run listener: _resource_record_post_run 02:41:14 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 400461824; Read time: 12; Write time: 317676 02:41:14 INFO - TinderboxPrint: CPU usage
13.4% 02:41:14 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 02:41:14 INFO - TinderboxPrint: I/O write bytes / time
400,461,824 / 317,676 02:41:14 INFO - TinderboxPrint: CPU idle
8,248.7 (86.6%) 02:41:14 INFO - TinderboxPrint: CPU user
1,216.7 (12.8%) 02:41:14 INFO - TinderboxPrint: Swap in / out
0 / 0 02:41:14 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 105529344; Read time: 0; Write time: 93288 02:41:14 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 294854656; Read time: 0; Write time: 224388 02:41:15 INFO - Running post-run listener: _upload_blobber_files 02:41:15 INFO - Blob upload gear active. 02:41:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:41:15 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 02:41:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:41:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:41:15 INFO - (blobuploader) - INFO - Open directory for files ... 02:41:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:41:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:41:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:41:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:41:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:41:16 INFO - (blobuploader) - INFO - Done attempting. 02:41:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:41:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:41:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:41:20 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:41:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:41:20 INFO - (blobuploader) - INFO - Done attempting. 02:41:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:41:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:41:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:41:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:41:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:41:21 INFO - (blobuploader) - INFO - Done attempting. 02:41:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 02:41:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:41:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:41:24 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 02:41:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:41:24 INFO - (blobuploader) - INFO - Done attempting. 02:41:24 INFO - (blobuploader) - INFO - Iteration through files over. 02:41:24 INFO - Return code: 0 02:41:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:41:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:41:24 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0449bc416a699a78c699c3c8b0235076e64485a8139f15f8cedebb4ef5cd19b657f699420d9aec2d00150b15f7a87c755f67c787086654d664a4974882e624a1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8e136da7370c2258c872a78b1d01817cdcffb4b9b3bd2d0bd8e4bcfe583fdff39227a1e878dfd807a993476b8f23ed04d07ade5603da1157de4d6831f43016f1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/93181157c7444f94d800ef25320287e6f6c46adf68ea7a9b0778d8456de4fa179d7c6441f2be874ff62f2d6e22af85e978c13aa41f6ac548ccdd098bd2da127d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/64fe7048d8d547cddaf90a6927a24be240fa533f1d71d912be61cc3d860895ce886c95e5ac31a9c3e0b1ad32f63d6849374d58e97c1c27cad93f8a40bd658b35"} 02:41:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:41:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:41:24 INFO - Contents: 02:41:24 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0449bc416a699a78c699c3c8b0235076e64485a8139f15f8cedebb4ef5cd19b657f699420d9aec2d00150b15f7a87c755f67c787086654d664a4974882e624a1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8e136da7370c2258c872a78b1d01817cdcffb4b9b3bd2d0bd8e4bcfe583fdff39227a1e878dfd807a993476b8f23ed04d07ade5603da1157de4d6831f43016f1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/93181157c7444f94d800ef25320287e6f6c46adf68ea7a9b0778d8456de4fa179d7c6441f2be874ff62f2d6e22af85e978c13aa41f6ac548ccdd098bd2da127d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/64fe7048d8d547cddaf90a6927a24be240fa533f1d71d912be61cc3d860895ce886c95e5ac31a9c3e0b1ad32f63d6849374d58e97c1c27cad93f8a40bd658b35"} 02:41:24 INFO - Running post-run listener: copy_logs_to_upload_dir 02:41:24 INFO - Copying logs to upload dir... 02:41:24 INFO - mkdir: /builds/slave/test/build/upload/logs 02:41:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.239950 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2017-01-05 02:41:23.753395) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-05 02:41:23.758942) ========= 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=4300f881736b422476174874000001bc-1483611639.445210-549087217 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0449bc416a699a78c699c3c8b0235076e64485a8139f15f8cedebb4ef5cd19b657f699420d9aec2d00150b15f7a87c755f67c787086654d664a4974882e624a1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8e136da7370c2258c872a78b1d01817cdcffb4b9b3bd2d0bd8e4bcfe583fdff39227a1e878dfd807a993476b8f23ed04d07ade5603da1157de4d6831f43016f1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/93181157c7444f94d800ef25320287e6f6c46adf68ea7a9b0778d8456de4fa179d7c6441f2be874ff62f2d6e22af85e978c13aa41f6ac548ccdd098bd2da127d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/64fe7048d8d547cddaf90a6927a24be240fa533f1d71d912be61cc3d860895ce886c95e5ac31a9c3e0b1ad32f63d6849374d58e97c1c27cad93f8a40bd658b35"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483602863/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011502 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483602863/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0449bc416a699a78c699c3c8b0235076e64485a8139f15f8cedebb4ef5cd19b657f699420d9aec2d00150b15f7a87c755f67c787086654d664a4974882e624a1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8e136da7370c2258c872a78b1d01817cdcffb4b9b3bd2d0bd8e4bcfe583fdff39227a1e878dfd807a993476b8f23ed04d07ade5603da1157de4d6831f43016f1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/93181157c7444f94d800ef25320287e6f6c46adf68ea7a9b0778d8456de4fa179d7c6441f2be874ff62f2d6e22af85e978c13aa41f6ac548ccdd098bd2da127d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/64fe7048d8d547cddaf90a6927a24be240fa533f1d71d912be61cc3d860895ce886c95e5ac31a9c3e0b1ad32f63d6849374d58e97c1c27cad93f8a40bd658b35"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-05 02:41:23.784686) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 02:41:23.785041) ========= 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=4300f881736b422476174874000001bc-1483611639.445210-549087217 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004511 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 02:41:23.871502) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-05 02:41:23.872170) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-05 02:41:23.872860) ========= ========= Total master_lag: 0.17 =========