builder: autoland_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-007 starttime: 1474528727.45 results: success (0) buildid: 20160921213059 builduid: ff2637382ba5403fac491222df8797c7 revision: 4aa20c3e211f6fec5d82bb74b087e13ad7ac04cc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-22 00:18:47.455434) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-22 00:18:47.456453) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-22 00:18:47.457077) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-22 00:18:47.473027) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 00:18:47.473725) ========= 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=923d835db2ba3686ebe126b700000192-1474528727.23348-1798013729 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-22 00:18:47-- 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: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.2M=0s 2016-09-22 00:18:47 (46.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.090033 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 00:18:47.579911) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 00:18:47.580270) ========= 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=923d835db2ba3686ebe126b700000192-1474528727.23348-1798013729 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016405 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 00:18:47.632786) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 00:18:47.633411) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 4aa20c3e211f6fec5d82bb74b087e13ad7ac04cc --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 4aa20c3e211f6fec5d82bb74b087e13ad7ac04cc --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=923d835db2ba3686ebe126b700000192-1474528727.23348-1798013729 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-22 00:18:48,053 truncating revision to first 12 chars 2016-09-22 00:18:48,053 Setting DEBUG logging. 2016-09-22 00:18:48,053 attempt 1/10 2016-09-22 00:18:48,053 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/4aa20c3e211f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-22 00:18:48,360 unpacking tar archive at: autoland-4aa20c3e211f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.622328 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 00:18:48.269991) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-22 00:18:48.270378) ========= script_repo_revision: 4aa20c3e211f6fec5d82bb74b087e13ad7ac04cc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-22 00:18:48.270851) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-22 00:18:48.271168) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-22 00:18:48.280667) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-09-22 00:18:48.280993) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 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', 'Autoland', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] 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=923d835db2ba3686ebe126b700000192-1474528727.23348-1798013729 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:18:48 INFO - MultiFileLogger online at 20160922 00:18:48 in /builds/slave/test 00:18:48 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 00:18:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:18:48 INFO - {'append_to_log': False, 00:18:48 INFO - 'base_work_dir': '/builds/slave/test', 00:18:48 INFO - 'blob_upload_branch': 'Autoland', 00:18:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:18:48 INFO - 'branch': 'Autoland', 00:18:48 INFO - 'buildbot_json_path': 'buildprops.json', 00:18:48 INFO - 'config_files': ('talos/linux_config.py',), 00:18:48 INFO - 'default_actions': ('clobber', 00:18:48 INFO - 'read-buildbot-config', 00:18:48 INFO - 'download-and-extract', 00:18:48 INFO - 'populate-webroot', 00:18:48 INFO - 'create-virtualenv', 00:18:48 INFO - 'install', 00:18:48 INFO - 'run-tests'), 00:18:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:18:48 INFO - 'download_minidump_stackwalk': True, 00:18:48 INFO - 'download_symbols': 'ondemand', 00:18:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:18:48 INFO - 'tooltool.py': '/tools/tooltool.py', 00:18:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:18:48 INFO - '/tools/misc-python/virtualenv.py')}, 00:18:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:18:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:18:48 INFO - 'installer_path': 'installer.exe', 00:18:48 INFO - 'log_level': 'info', 00:18:48 INFO - 'log_name': 'talos', 00:18:48 INFO - 'log_to_console': True, 00:18:48 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:18:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:18:48 INFO - 'opt_config_files': (), 00:18:48 INFO - 'pip_index': False, 00:18:48 INFO - 'sps_profile': False, 00:18:48 INFO - 'sps_profile_interval': 0, 00:18:48 INFO - 'suite': 'dromaeojs-e10s', 00:18:48 INFO - 'system_bits': '32', 00:18:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:18:48 INFO - 'title': 'talos-linux64-ix-007', 00:18:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:18:48 INFO - 'use_talos_json': True, 00:18:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:18:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:18:48 INFO - 'work_dir': 'build'} 00:18:48 INFO - [mozharness: 2016-09-22 07:18:48.799946Z] Running clobber step. 00:18:48 INFO - Running pre-action listener: _resource_record_pre_action 00:18:48 INFO - Running main action method: clobber 00:18:48 INFO - rmtree: /builds/slave/test/build 00:18:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:18:49 INFO - Running post-action listener: _resource_record_post_action 00:18:49 INFO - [mozharness: 2016-09-22 07:18:49.285311Z] Finished clobber step (success) 00:18:49 INFO - [mozharness: 2016-09-22 07:18:49.285412Z] Running read-buildbot-config step. 00:18:49 INFO - Running pre-action listener: _resource_record_pre_action 00:18:49 INFO - Running main action method: read_buildbot_config 00:18:49 INFO - Using buildbot properties: 00:18:49 INFO - { 00:18:49 INFO - "project": "", 00:18:49 INFO - "product": "firefox", 00:18:49 INFO - "script_repo_revision": "production", 00:18:49 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs-e10s", 00:18:49 INFO - "repository": "", 00:18:49 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland pgo talos dromaeojs-e10s", 00:18:49 INFO - "buildid": "20160921213059", 00:18:49 INFO - "pgo_build": "True", 00:18:49 INFO - "basedir": "/builds/slave/test", 00:18:49 INFO - "buildnumber": 263, 00:18:49 INFO - "slavename": "talos-linux64-ix-007", 00:18:49 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 00:18:49 INFO - "platform": "ubuntu64_hw", 00:18:49 INFO - "scheduler": "tests-autoland-linux64-pgo-talos", 00:18:49 INFO - "branch": "autoland", 00:18:49 INFO - "repo_path": "integration/autoland", 00:18:49 INFO - "revision": "4aa20c3e211f6fec5d82bb74b087e13ad7ac04cc", 00:18:49 INFO - "stage_platform": "linux64-pgo", 00:18:49 INFO - "builduid": "ff2637382ba5403fac491222df8797c7", 00:18:49 INFO - "slavebuilddir": "test" 00:18:49 INFO - } 00:18:49 INFO - Found installer url https://queue.taskcluster.net/v1/task/YR5hGCoQR2OgnI19DYIPVw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 00:18:49 INFO - Running post-action listener: _resource_record_post_action 00:18:49 INFO - [mozharness: 2016-09-22 07:18:49.287887Z] Finished read-buildbot-config step (success) 00:18:49 INFO - [mozharness: 2016-09-22 07:18:49.287978Z] Running download-and-extract step. 00:18:49 INFO - Running pre-action listener: _resource_record_pre_action 00:18:49 INFO - Running main action method: download_and_extract 00:18:49 INFO - mkdir: /builds/slave/test/build/tests 00:18:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:18:49 INFO - trying https://queue.taskcluster.net/v1/task/YR5hGCoQR2OgnI19DYIPVw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 00:18:49 INFO - Downloading https://queue.taskcluster.net/v1/task/YR5hGCoQR2OgnI19DYIPVw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 00:18:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YR5hGCoQR2OgnI19DYIPVw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 00:18:49 INFO - Downloaded 1361 bytes. 00:18:49 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 00:18:49 INFO - Using the following test package requirements: 00:18:49 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 00:18:49 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:18:49 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 00:18:49 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:18:49 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 00:18:49 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:18:49 INFO - u'jsshell-linux-x86_64.zip'], 00:18:49 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:18:49 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 00:18:49 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 00:18:49 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:18:49 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 00:18:49 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:18:49 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 00:18:49 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:18:49 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 00:18:49 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:18:49 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 00:18:49 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 00:18:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YR5hGCoQR2OgnI19DYIPVw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 00:18:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YR5hGCoQR2OgnI19DYIPVw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 00:18:49 INFO - Fetch https://queue.taskcluster.net/v1/task/YR5hGCoQR2OgnI19DYIPVw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 00:18:50 INFO - Expected file size: 21944097 00:18:54 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 00:18:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YR5hGCoQR2OgnI19DYIPVw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 00:18:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YR5hGCoQR2OgnI19DYIPVw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 00:18:54 INFO - Fetch https://queue.taskcluster.net/v1/task/YR5hGCoQR2OgnI19DYIPVw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 00:18:55 INFO - Expected file size: 21944097 00:18:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YR5hGCoQR2OgnI19DYIPVw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 00:18:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YR5hGCoQR2OgnI19DYIPVw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 00:18:59 INFO - Fetch https://queue.taskcluster.net/v1/task/YR5hGCoQR2OgnI19DYIPVw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 00:19:00 INFO - Expected file size: 14414059 00:19:00 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')]} 00:19:00 INFO - trying https://queue.taskcluster.net/v1/task/YR5hGCoQR2OgnI19DYIPVw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 00:19:00 INFO - Downloading https://queue.taskcluster.net/v1/task/YR5hGCoQR2OgnI19DYIPVw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 00:19:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YR5hGCoQR2OgnI19DYIPVw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 00:19:02 INFO - Downloaded 59569812 bytes. 00:19:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YR5hGCoQR2OgnI19DYIPVw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 00:19:02 INFO - mkdir: /builds/slave/test/properties 00:19:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:19:02 INFO - Writing to file /builds/slave/test/properties/build_url 00:19:02 INFO - Contents: 00:19:02 INFO - build_url:https://queue.taskcluster.net/v1/task/YR5hGCoQR2OgnI19DYIPVw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 00:19:02 INFO - Running post-action listener: _resource_record_post_action 00:19:02 INFO - Running post-action listener: set_extra_try_arguments 00:19:02 INFO - [mozharness: 2016-09-22 07:19:02.786138Z] Finished download-and-extract step (success) 00:19:02 INFO - [mozharness: 2016-09-22 07:19:02.786368Z] Running populate-webroot step. 00:19:02 INFO - Running pre-action listener: _resource_record_pre_action 00:19:02 INFO - Running main action method: populate_webroot 00:19:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:19:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:19:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:19:02 INFO - '--tppagecycles', 00:19:02 INFO - '7'], 00:19:02 INFO - 'tests': ['tsvgm']}}, 00:19:02 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 00:19:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:19:02 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:19:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 00:19:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 00:19:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:19:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:19:02 INFO - 'talos_options': ['--disable-e10s'], 00:19:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:19:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:19:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:19:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:19:02 INFO - 'talos_options': ['--disable-e10s'], 00:19:02 INFO - 'tests': ['damp', 'tps']}, 00:19:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:19:02 INFO - 'tests': ['damp', 'tps']}, 00:19:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 00:19:02 INFO - 'tests': ['dromaeo_dom']}, 00:19:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:19:02 INFO - 'g4': {'talos_options': ['--disable-e10s'], 00:19:02 INFO - 'tests': ['basic_compositor_video']}, 00:19:02 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 00:19:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 00:19:02 INFO - 'tests': ['a11yr', 00:19:02 INFO - 'ts_paint', 00:19:02 INFO - 'tpaint', 00:19:02 INFO - 'sessionrestore', 00:19:02 INFO - 'sessionrestore_no_auto_restore', 00:19:02 INFO - 'tabpaint']}, 00:19:02 INFO - 'other-e10s': {'tests': ['a11yr', 00:19:02 INFO - 'ts_paint', 00:19:02 INFO - 'tpaint', 00:19:02 INFO - 'sessionrestore', 00:19:02 INFO - 'sessionrestore_no_auto_restore', 00:19:02 INFO - 'tabpaint']}, 00:19:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 00:19:02 INFO - 'ts_paint', 00:19:02 INFO - 'tpaint', 00:19:02 INFO - 'sessionrestore', 00:19:02 INFO - 'sessionrestore_no_auto_restore', 00:19:02 INFO - 'tabpaint']}, 00:19:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 00:19:02 INFO - 'ts_paint', 00:19:02 INFO - 'tpaint', 00:19:02 INFO - 'sessionrestore', 00:19:02 INFO - 'sessionrestore_no_auto_restore', 00:19:02 INFO - 'tabpaint']}, 00:19:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 00:19:02 INFO - 'tests': ['a11yr', 00:19:02 INFO - 'ts_paint', 00:19:02 INFO - 'tpaint', 00:19:02 INFO - 'sessionrestore', 00:19:02 INFO - 'sessionrestore_no_auto_restore', 00:19:02 INFO - 'tabpaint']}, 00:19:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 00:19:02 INFO - 'tests': ['a11yr', 00:19:02 INFO - 'ts_paint', 00:19:02 INFO - 'tpaint', 00:19:02 INFO - 'sessionrestore', 00:19:02 INFO - 'sessionrestore_no_auto_restore', 00:19:02 INFO - 'tabpaint']}, 00:19:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 00:19:02 INFO - 'tests': ['tsvgx', 00:19:02 INFO - 'tsvgr_opacity', 00:19:02 INFO - 'tart', 00:19:02 INFO - 'tscrollx', 00:19:02 INFO - 'cart']}, 00:19:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:19:02 INFO - 'tsvgr_opacity', 00:19:02 INFO - 'tart', 00:19:02 INFO - 'tscrollx', 00:19:02 INFO - 'cart']}, 00:19:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:19:02 INFO - 'talos_options': ['--disable-e10s'], 00:19:02 INFO - 'tests': ['tp5o']}, 00:19:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:19:02 INFO - 'tests': ['tp5o']}, 00:19:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:19:02 INFO - 'talos_options': ['--disable-e10s', 00:19:02 INFO - '--xperf_path', 00:19:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:19:02 INFO - 'tests': ['tp5n']}, 00:19:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:19:02 INFO - 'talos_options': ['--xperf_path', 00:19:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:19:02 INFO - 'tests': ['tp5n']}}, 00:19:02 INFO - 'talos.zip': {'path': '', 00:19:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:19:02 INFO - Running post-action listener: _resource_record_post_action 00:19:02 INFO - [mozharness: 2016-09-22 07:19:02.802518Z] Finished populate-webroot step (success) 00:19:02 INFO - [mozharness: 2016-09-22 07:19:02.802633Z] Running create-virtualenv step. 00:19:02 INFO - Running pre-action listener: _resource_record_pre_action 00:19:02 INFO - Running main action method: create_virtualenv 00:19:02 INFO - Creating virtualenv /builds/slave/test/build/venv 00:19:02 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 00:19:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:19:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:19:02 INFO - Using real prefix '/usr' 00:19:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:19:03 INFO - Installing distribute.............................................................................................................................................................................................done. 00:19:05 INFO - Installing pip.................done. 00:19:05 INFO - Return code: 0 00:19:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:19:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:19:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:19:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:19:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:19:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:19:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:19:05 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 0x7f51d84a8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2687790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2684930>, '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 0x2685830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2685cc0>, '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': '923d835db2ba3686ebe126b700000192-1474528727.23348-1798013729', '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 00:19:05 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 00:19:05 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 00:19:05 INFO - Using env: {'DISPLAY': ':0', 00:19:05 INFO - 'HOME': '/home/cltbld', 00:19:05 INFO - 'LANG': 'en_US.UTF-8', 00:19:05 INFO - 'LANGUAGE': 'en_US:en', 00:19:05 INFO - 'LOGNAME': 'cltbld', 00:19:05 INFO - 'MAIL': '/var/mail/cltbld', 00:19:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:19:05 INFO - 'MOZ_NO_REMOTE': '1', 00:19:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:19:05 INFO - 'NO_EM_RESTART': '1', 00:19:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:19:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:19:05 INFO - 'PWD': '/builds/slave/test', 00:19:05 INFO - 'SHELL': '/bin/bash', 00:19:05 INFO - 'SHLVL': '1', 00:19:05 INFO - 'TERM': 'linux', 00:19:05 INFO - 'TMOUT': '86400', 00:19:05 INFO - 'USER': 'cltbld', 00:19:05 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1474528727.23348-1798013729', 00:19:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:19:05 INFO - '_': '/tools/buildbot/bin/python'} 00:19:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:19:05 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 00:19:05 INFO - Cleaning up... 00:19:05 INFO - Return code: 0 00:19:05 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 00:19:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:19:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:19:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:19:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:19:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:19:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:19:05 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 0x7f51d84a8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2687790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2684930>, '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 0x2685830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2685cc0>, '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': '923d835db2ba3686ebe126b700000192-1474528727.23348-1798013729', '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 00:19:05 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 00:19:05 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 00:19:05 INFO - Using env: {'DISPLAY': ':0', 00:19:05 INFO - 'HOME': '/home/cltbld', 00:19:05 INFO - 'LANG': 'en_US.UTF-8', 00:19:05 INFO - 'LANGUAGE': 'en_US:en', 00:19:05 INFO - 'LOGNAME': 'cltbld', 00:19:05 INFO - 'MAIL': '/var/mail/cltbld', 00:19:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:19:05 INFO - 'MOZ_NO_REMOTE': '1', 00:19:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:19:05 INFO - 'NO_EM_RESTART': '1', 00:19:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:19:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:19:05 INFO - 'PWD': '/builds/slave/test', 00:19:05 INFO - 'SHELL': '/bin/bash', 00:19:05 INFO - 'SHLVL': '1', 00:19:05 INFO - 'TERM': 'linux', 00:19:05 INFO - 'TMOUT': '86400', 00:19:05 INFO - 'USER': 'cltbld', 00:19:05 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1474528727.23348-1798013729', 00:19:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:19:05 INFO - '_': '/tools/buildbot/bin/python'} 00:19:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:19:05 INFO - Downloading/unpacking psutil>=3.1.1 00:19:05 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 00:19:05 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 00:19:05 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 00:19:05 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 00:19:05 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 00:19:05 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 00:19:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:19:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:19:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:19:07 INFO - Installing collected packages: psutil 00:19:07 INFO - Running setup.py install for psutil 00:19:07 INFO - building 'psutil._psutil_linux' extension 00:19:07 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 00:19:08 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 00:19:08 INFO - building 'psutil._psutil_posix' extension 00:19:08 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 00:19:08 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 00:19:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:19:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:19:08 INFO - Successfully installed psutil 00:19:08 INFO - Cleaning up... 00:19:08 INFO - Return code: 0 00:19:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 00:19: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')]} 00:19:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:19:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:19: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')]} 00:19:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:19:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:19: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f51d84a8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2687790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2684930>, '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 0x2685830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2685cc0>, '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': '923d835db2ba3686ebe126b700000192-1474528727.23348-1798013729', '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 00:19: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 00:19: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 mozsystemmonitor==0.3 00:19:08 INFO - Using env: {'DISPLAY': ':0', 00:19:08 INFO - 'HOME': '/home/cltbld', 00:19:08 INFO - 'LANG': 'en_US.UTF-8', 00:19:08 INFO - 'LANGUAGE': 'en_US:en', 00:19:08 INFO - 'LOGNAME': 'cltbld', 00:19:08 INFO - 'MAIL': '/var/mail/cltbld', 00:19:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:19:08 INFO - 'MOZ_NO_REMOTE': '1', 00:19:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:19:08 INFO - 'NO_EM_RESTART': '1', 00:19:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:19:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:19:08 INFO - 'PWD': '/builds/slave/test', 00:19:08 INFO - 'SHELL': '/bin/bash', 00:19:08 INFO - 'SHLVL': '1', 00:19:08 INFO - 'TERM': 'linux', 00:19:08 INFO - 'TMOUT': '86400', 00:19:08 INFO - 'USER': 'cltbld', 00:19:08 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1474528727.23348-1798013729', 00:19:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:19:08 INFO - '_': '/tools/buildbot/bin/python'} 00:19:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:19:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 00:19: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 00:19: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 00:19: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 00:19: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 00:19: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 00:19: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 00:19:10 INFO - Downloading mozsystemmonitor-0.3.tar.gz 00:19:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:19:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 00:19:10 INFO - Installing collected packages: mozsystemmonitor 00:19:10 INFO - Running setup.py install for mozsystemmonitor 00:19:10 INFO - Successfully installed mozsystemmonitor 00:19:10 INFO - Cleaning up... 00:19:10 INFO - Return code: 0 00:19:10 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 00:19:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:19:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:19:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:19:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:19:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:19:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:19:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f51d84a8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2687790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2684930>, '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 0x2685830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2685cc0>, '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': '923d835db2ba3686ebe126b700000192-1474528727.23348-1798013729', '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 00:19:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 00:19:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 00:19:10 INFO - Using env: {'DISPLAY': ':0', 00:19:10 INFO - 'HOME': '/home/cltbld', 00:19:10 INFO - 'LANG': 'en_US.UTF-8', 00:19:10 INFO - 'LANGUAGE': 'en_US:en', 00:19:10 INFO - 'LOGNAME': 'cltbld', 00:19:10 INFO - 'MAIL': '/var/mail/cltbld', 00:19:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:19:10 INFO - 'MOZ_NO_REMOTE': '1', 00:19:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:19:10 INFO - 'NO_EM_RESTART': '1', 00:19:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:19:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:19:10 INFO - 'PWD': '/builds/slave/test', 00:19:10 INFO - 'SHELL': '/bin/bash', 00:19:10 INFO - 'SHLVL': '1', 00:19:10 INFO - 'TERM': 'linux', 00:19:10 INFO - 'TMOUT': '86400', 00:19:10 INFO - 'USER': 'cltbld', 00:19:10 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1474528727.23348-1798013729', 00:19:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:19:10 INFO - '_': '/tools/buildbot/bin/python'} 00:19:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:19:10 INFO - Downloading/unpacking jsonschema==2.5.1 00:19:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:19:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:19:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:19:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:19:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:19:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:19:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:19:12 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 00:19:12 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 00:19:12 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 00:19:12 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 00:19:12 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 00:19:12 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 00:19:12 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 00:19:13 INFO - Downloading functools32-3.2.3-2.tar.gz 00:19:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:19:13 INFO - warning: no files found matching '*.txt' 00:19:13 INFO - no previously-included directories found matching 'build' 00:19:13 INFO - no previously-included directories found matching 'dist' 00:19:13 INFO - no previously-included directories found matching '.git*' 00:19:13 INFO - Installing collected packages: jsonschema, functools32 00:19:13 INFO - Running setup.py install for functools32 00:19:13 INFO - warning: no files found matching '*.txt' 00:19:13 INFO - no previously-included directories found matching 'build' 00:19:13 INFO - no previously-included directories found matching 'dist' 00:19:13 INFO - no previously-included directories found matching '.git*' 00:19:13 INFO - Successfully installed jsonschema functools32 00:19:13 INFO - Cleaning up... 00:19:13 INFO - Return code: 0 00:19:13 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 00:19:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:19:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:19:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:19:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:19:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:19:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:19:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f51d84a8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2687790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2684930>, '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 0x2685830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2685cc0>, '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': '923d835db2ba3686ebe126b700000192-1474528727.23348-1798013729', '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 00:19:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 00:19:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 00:19:13 INFO - Using env: {'DISPLAY': ':0', 00:19:13 INFO - 'HOME': '/home/cltbld', 00:19:13 INFO - 'LANG': 'en_US.UTF-8', 00:19:13 INFO - 'LANGUAGE': 'en_US:en', 00:19:13 INFO - 'LOGNAME': 'cltbld', 00:19:13 INFO - 'MAIL': '/var/mail/cltbld', 00:19:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:19:13 INFO - 'MOZ_NO_REMOTE': '1', 00:19:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:19:13 INFO - 'NO_EM_RESTART': '1', 00:19:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:19:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:19:13 INFO - 'PWD': '/builds/slave/test', 00:19:13 INFO - 'SHELL': '/bin/bash', 00:19:13 INFO - 'SHLVL': '1', 00:19:13 INFO - 'TERM': 'linux', 00:19:13 INFO - 'TMOUT': '86400', 00:19:13 INFO - 'USER': 'cltbld', 00:19:13 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1474528727.23348-1798013729', 00:19:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:19:13 INFO - '_': '/tools/buildbot/bin/python'} 00:19:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:19:13 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 00:19:13 INFO - Cleaning up... 00:19:13 INFO - Return code: 0 00:19:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:19:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:19:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:19:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:19:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:19:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:19:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:19:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f51d84a8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2687790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2684930>, '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 0x2685830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2685cc0>, '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': '923d835db2ba3686ebe126b700000192-1474528727.23348-1798013729', '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 00:19:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 00:19:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 00:19:13 INFO - Using env: {'DISPLAY': ':0', 00:19:13 INFO - 'HOME': '/home/cltbld', 00:19:13 INFO - 'LANG': 'en_US.UTF-8', 00:19:13 INFO - 'LANGUAGE': 'en_US:en', 00:19:13 INFO - 'LOGNAME': 'cltbld', 00:19:13 INFO - 'MAIL': '/var/mail/cltbld', 00:19:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:19:13 INFO - 'MOZ_NO_REMOTE': '1', 00:19:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:19:13 INFO - 'NO_EM_RESTART': '1', 00:19:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:19:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:19:13 INFO - 'PWD': '/builds/slave/test', 00:19:13 INFO - 'SHELL': '/bin/bash', 00:19:13 INFO - 'SHLVL': '1', 00:19:13 INFO - 'TERM': 'linux', 00:19:13 INFO - 'TMOUT': '86400', 00:19:13 INFO - 'USER': 'cltbld', 00:19:13 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1474528727.23348-1798013729', 00:19:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:19:13 INFO - '_': '/tools/buildbot/bin/python'} 00:19:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:19:13 INFO - Downloading/unpacking blobuploader==1.2.4 00:19:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:19:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:19:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:19:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:19:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:19:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:19:15 INFO - Downloading blobuploader-1.2.4.tar.gz 00:19:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:19:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:19:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:19:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:19:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:19:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:19:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:19:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:19:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:19:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:19:16 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 00:19:16 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 00:19:16 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 00:19:16 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 00:19:16 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 00:19:16 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 00:19:16 INFO - Downloading docopt-0.6.1.tar.gz 00:19:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:19:16 INFO - Installing collected packages: blobuploader, requests, docopt 00:19:16 INFO - Running setup.py install for blobuploader 00:19:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:19:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:19:16 INFO - Running setup.py install for requests 00:19:16 INFO - Running setup.py install for docopt 00:19:16 INFO - Successfully installed blobuploader requests docopt 00:19:16 INFO - Cleaning up... 00:19:16 INFO - Return code: 0 00:19:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:19: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')]} 00:19:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:19:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:19: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')]} 00:19:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:19:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:19:16 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 0x7f51d84a8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2687790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2684930>, '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 0x2685830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2685cc0>, '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': '923d835db2ba3686ebe126b700000192-1474528727.23348-1798013729', '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 00:19:16 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 00:19:16 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 00:19:16 INFO - Using env: {'DISPLAY': ':0', 00:19:16 INFO - 'HOME': '/home/cltbld', 00:19:16 INFO - 'LANG': 'en_US.UTF-8', 00:19:16 INFO - 'LANGUAGE': 'en_US:en', 00:19:16 INFO - 'LOGNAME': 'cltbld', 00:19:16 INFO - 'MAIL': '/var/mail/cltbld', 00:19:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:19:16 INFO - 'MOZ_NO_REMOTE': '1', 00:19:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:19:16 INFO - 'NO_EM_RESTART': '1', 00:19:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:19:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:19:16 INFO - 'PWD': '/builds/slave/test', 00:19:16 INFO - 'SHELL': '/bin/bash', 00:19:16 INFO - 'SHLVL': '1', 00:19:16 INFO - 'TERM': 'linux', 00:19:16 INFO - 'TMOUT': '86400', 00:19:16 INFO - 'USER': 'cltbld', 00:19:16 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1474528727.23348-1798013729', 00:19:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:19:16 INFO - '_': '/tools/buildbot/bin/python'} 00:19:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:19:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:19:17 INFO - Running setup.py (path:/tmp/pip-jBTrFS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:19:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:19:17 INFO - Running setup.py (path:/tmp/pip-zQnNXs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:19:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:19:17 INFO - Running setup.py (path:/tmp/pip-eGgfoy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:19:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:19:17 INFO - Running setup.py (path:/tmp/pip-LCROgn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:19:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:19:17 INFO - Running setup.py (path:/tmp/pip-OYy5kv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:19:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:19:17 INFO - Running setup.py (path:/tmp/pip-srL2Uv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:19:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:19:17 INFO - Running setup.py (path:/tmp/pip-hE412S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:19:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:19:17 INFO - Running setup.py (path:/tmp/pip-VI2WIL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:19:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:19:17 INFO - Running setup.py (path:/tmp/pip-rTS9PL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:19:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:19:17 INFO - Running setup.py (path:/tmp/pip-_PsSfr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:19:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:19:17 INFO - Running setup.py (path:/tmp/pip-S9vTQ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:19:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:19:17 INFO - Running setup.py (path:/tmp/pip-vx4YZS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:19:18 INFO - Running setup.py (path:/tmp/pip-VE9XR5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:19:18 INFO - Running setup.py (path:/tmp/pip-u_gUhx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:19:18 INFO - Running setup.py (path:/tmp/pip-HMpbdM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:19:18 INFO - Running setup.py (path:/tmp/pip-9WV6sP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:19:18 INFO - Running setup.py (path:/tmp/pip-BRBkS6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:19:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:19:18 INFO - Running setup.py install for manifestparser 00:19:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:19:18 INFO - Running setup.py install for mozcrash 00:19:18 INFO - Running setup.py install for mozdebug 00:19:18 INFO - Running setup.py install for mozdevice 00:19:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:19:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:19:18 INFO - Running setup.py install for mozfile 00:19:18 INFO - Running setup.py install for mozhttpd 00:19:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:19:18 INFO - Running setup.py install for mozinfo 00:19:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:19:19 INFO - Running setup.py install for mozInstall 00:19:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:19:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:19:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:19:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:19:19 INFO - Running setup.py install for mozleak 00:19:19 INFO - Running setup.py install for mozlog 00:19:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:19:19 INFO - Running setup.py install for moznetwork 00:19:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:19:19 INFO - Running setup.py install for mozprocess 00:19:19 INFO - Running setup.py install for mozprofile 00:19:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:19:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:19:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:19:19 INFO - Running setup.py install for mozrunner 00:19:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:19:19 INFO - Running setup.py install for mozscreenshot 00:19:19 INFO - Running setup.py install for moztest 00:19:20 INFO - Running setup.py install for mozversion 00:19:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:19:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:19:20 INFO - Cleaning up... 00:19:20 INFO - Return code: 0 00:19:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:19: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')]} 00:19:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:19:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:19: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')]} 00:19:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:19:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:19:20 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 0x7f51d84a8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2687790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2684930>, '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 0x2685830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2685cc0>, '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': '923d835db2ba3686ebe126b700000192-1474528727.23348-1798013729', '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 00:19:20 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 00:19:20 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 00:19:20 INFO - Using env: {'DISPLAY': ':0', 00:19:20 INFO - 'HOME': '/home/cltbld', 00:19:20 INFO - 'LANG': 'en_US.UTF-8', 00:19:20 INFO - 'LANGUAGE': 'en_US:en', 00:19:20 INFO - 'LOGNAME': 'cltbld', 00:19:20 INFO - 'MAIL': '/var/mail/cltbld', 00:19:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:19:20 INFO - 'MOZ_NO_REMOTE': '1', 00:19:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:19:20 INFO - 'NO_EM_RESTART': '1', 00:19:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:19:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:19:20 INFO - 'PWD': '/builds/slave/test', 00:19:20 INFO - 'SHELL': '/bin/bash', 00:19:20 INFO - 'SHLVL': '1', 00:19:20 INFO - 'TERM': 'linux', 00:19:20 INFO - 'TMOUT': '86400', 00:19:20 INFO - 'USER': 'cltbld', 00:19:20 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1474528727.23348-1798013729', 00:19:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:19:20 INFO - '_': '/tools/buildbot/bin/python'} 00:19:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:19:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:19:20 INFO - Running setup.py (path:/tmp/pip-2k4xGp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:19:20 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)) 00:19:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:19:20 INFO - Running setup.py (path:/tmp/pip-gWwmIJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:19:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 00:19:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:19:20 INFO - Running setup.py (path:/tmp/pip-6efFHJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:19:20 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)) 00:19:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:19:20 INFO - Running setup.py (path:/tmp/pip-YiTCwU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:19:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 00:19:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:19:20 INFO - Running setup.py (path:/tmp/pip-ucULd_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:19:20 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)) 00:19:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:19:20 INFO - Running setup.py (path:/tmp/pip-fwXixg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:19:20 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)) 00:19:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:19:20 INFO - Running setup.py (path:/tmp/pip-HLbDCR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:19:20 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)) 00:19:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:19:20 INFO - Running setup.py (path:/tmp/pip-HKYRVH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:19:20 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)) 00:19:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:19:20 INFO - Running setup.py (path:/tmp/pip-ag6B6T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:19:21 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)) 00:19:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:19:21 INFO - Running setup.py (path:/tmp/pip-8wgwqG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:19:21 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)) 00:19:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:19:21 INFO - Running setup.py (path:/tmp/pip-SbOiKW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:19:21 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)) 00:19:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:19:21 INFO - Running setup.py (path:/tmp/pip-GHJlnB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:19:21 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)) 00:19:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:19:21 INFO - Running setup.py (path:/tmp/pip-L3WQ5f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:19:21 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)) 00:19:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:19:21 INFO - Running setup.py (path:/tmp/pip-UhfMJI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:19:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 00:19:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:19:21 INFO - Running setup.py (path:/tmp/pip-_kb78w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:19:21 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)) 00:19:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:19:21 INFO - Running setup.py (path:/tmp/pip-oCBblG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:19:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 00:19:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:19:21 INFO - Running setup.py (path:/tmp/pip-iIIju0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:19:21 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)) 00:19:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 00:19:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 00:19:21 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)) 00:19:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 00:19:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 00:19:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:19:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:19:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:19:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:19:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:19:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:19:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:19:23 INFO - Downloading blessings-1.6.tar.gz 00:19:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:19:23 INFO - Installing collected packages: blessings 00:19:23 INFO - Running setup.py install for blessings 00:19:23 INFO - Successfully installed blessings 00:19:23 INFO - Cleaning up... 00:19:23 INFO - Return code: 0 00:19:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:19:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:19:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:19:23 INFO - Reading from file tmpfile_stdout 00:19:23 INFO - Current package versions: 00:19:23 INFO - argparse == 1.2.1 00:19:23 INFO - blessings == 1.6 00:19:23 INFO - blobuploader == 1.2.4 00:19:23 INFO - docopt == 0.6.1 00:19:23 INFO - functools32 == 3.2.3-2 00:19:23 INFO - jsonschema == 2.5.1 00:19:23 INFO - manifestparser == 1.1 00:19:23 INFO - mozInstall == 1.12 00:19:23 INFO - mozcrash == 0.17 00:19:23 INFO - mozdebug == 0.1 00:19:23 INFO - mozdevice == 0.48 00:19:23 INFO - mozfile == 1.2 00:19:23 INFO - mozhttpd == 0.7 00:19:23 INFO - mozinfo == 0.9 00:19:23 INFO - mozleak == 0.1 00:19:23 INFO - mozlog == 3.4 00:19:23 INFO - moznetwork == 0.27 00:19:23 INFO - mozprocess == 0.23 00:19:23 INFO - mozprofile == 0.28 00:19:23 INFO - mozrunner == 6.12 00:19:23 INFO - mozscreenshot == 0.1 00:19:23 INFO - mozsystemmonitor == 0.3 00:19:23 INFO - moztest == 0.7 00:19:23 INFO - mozversion == 1.4 00:19:23 INFO - psutil == 3.1.1 00:19:23 INFO - requests == 1.2.3 00:19:23 INFO - wsgiref == 0.1.2 00:19:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:19:23 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')]} 00:19:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:19:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:19:23 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')]} 00:19:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:19:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:19:23 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 0x7f51d84a8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2687790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2684930>, '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 0x2685830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2685cc0>, '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': '923d835db2ba3686ebe126b700000192-1474528727.23348-1798013729', '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 00:19:23 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 00:19:23 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 00:19:24 INFO - Using env: {'DISPLAY': ':0', 00:19:24 INFO - 'HOME': '/home/cltbld', 00:19:24 INFO - 'LANG': 'en_US.UTF-8', 00:19:24 INFO - 'LANGUAGE': 'en_US:en', 00:19:24 INFO - 'LOGNAME': 'cltbld', 00:19:24 INFO - 'MAIL': '/var/mail/cltbld', 00:19:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:19:24 INFO - 'MOZ_NO_REMOTE': '1', 00:19:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:19:24 INFO - 'NO_EM_RESTART': '1', 00:19:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:19:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:19:24 INFO - 'PWD': '/builds/slave/test', 00:19:24 INFO - 'SHELL': '/bin/bash', 00:19:24 INFO - 'SHLVL': '1', 00:19:24 INFO - 'TERM': 'linux', 00:19:24 INFO - 'TMOUT': '86400', 00:19:24 INFO - 'USER': 'cltbld', 00:19:24 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1474528727.23348-1798013729', 00:19:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:19:24 INFO - '_': '/tools/buildbot/bin/python'} 00:19:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:19:24 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)) 00:19:24 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)) 00:19:24 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)) 00:19:24 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)) 00:19:24 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)) 00:19:24 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)) 00:19:24 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)) 00:19:24 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)) 00:19:24 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)) 00:19:24 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)) 00:19:24 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)) 00:19:24 INFO - Cleaning up... 00:19:24 INFO - Return code: 0 00:19:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:19:24 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')]} 00:19:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:19:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:19:24 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')]} 00:19:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:19:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:19:24 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 0x7f51d84a8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2687790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2684930>, '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 0x2685830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2685cc0>, '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': '923d835db2ba3686ebe126b700000192-1474528727.23348-1798013729', '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 00:19:24 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 00:19:24 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 00:19:24 INFO - Using env: {'DISPLAY': ':0', 00:19:24 INFO - 'HOME': '/home/cltbld', 00:19:24 INFO - 'LANG': 'en_US.UTF-8', 00:19:24 INFO - 'LANGUAGE': 'en_US:en', 00:19:24 INFO - 'LOGNAME': 'cltbld', 00:19:24 INFO - 'MAIL': '/var/mail/cltbld', 00:19:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:19:24 INFO - 'MOZ_NO_REMOTE': '1', 00:19:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:19:24 INFO - 'NO_EM_RESTART': '1', 00:19:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:19:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:19:24 INFO - 'PWD': '/builds/slave/test', 00:19:24 INFO - 'SHELL': '/bin/bash', 00:19:24 INFO - 'SHLVL': '1', 00:19:24 INFO - 'TERM': 'linux', 00:19:24 INFO - 'TMOUT': '86400', 00:19:24 INFO - 'USER': 'cltbld', 00:19:24 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1474528727.23348-1798013729', 00:19:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:19:24 INFO - '_': '/tools/buildbot/bin/python'} 00:19:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:19:24 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 00:19:24 INFO - Cleaning up... 00:19:24 INFO - Return code: 0 00:19:24 INFO - Running post-action listener: _resource_record_post_action 00:19:24 INFO - Running post-action listener: _start_resource_monitoring 00:19:24 INFO - Starting resource monitoring. 00:19:24 INFO - [mozharness: 2016-09-22 07:19:24.478851Z] Finished create-virtualenv step (success) 00:19:24 INFO - [mozharness: 2016-09-22 07:19:24.479319Z] Running install step. 00:19:24 INFO - Running pre-action listener: _resource_record_pre_action 00:19:24 INFO - Running main action method: install 00:19:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:19:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:19:24 INFO - Reading from file tmpfile_stdout 00:19:24 INFO - Detecting whether we're running mozinstall >=1.0... 00:19:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:19:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:19:24 INFO - Reading from file tmpfile_stdout 00:19:24 INFO - Output received: 00:19:24 INFO - Usage: mozinstall [options] installer 00:19:24 INFO - Options: 00:19:24 INFO - -h, --help show this help message and exit 00:19:24 INFO - -d DEST, --destination=DEST 00:19:24 INFO - Directory to install application into. [default: 00:19:24 INFO - "/builds/slave/test"] 00:19:24 INFO - --app=APP Application being installed. [default: firefox] 00:19:24 INFO - mkdir: /builds/slave/test/build/application 00:19:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 00:19:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 00:19:41 INFO - Reading from file tmpfile_stdout 00:19:41 INFO - Output received: 00:19:41 INFO - /builds/slave/test/build/application/firefox/firefox 00:19:41 INFO - Running post-action listener: _resource_record_post_action 00:19:41 INFO - [mozharness: 2016-09-22 07:19:41.940046Z] Finished install step (success) 00:19:41 INFO - [mozharness: 2016-09-22 07:19:41.940292Z] Running run-tests step. 00:19:41 INFO - Running pre-action listener: _resource_record_pre_action 00:19:41 INFO - Running main action method: run_tests 00:19:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:19:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:19:41 INFO - Python 2.7.3 00:19:41 INFO - Return code: 0 00:19:41 INFO - grabbing minidump binary from tooltool 00:19: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')]} 00:19:41 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 0x2684930>, '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 0x2685830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2685cc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:19:41 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 00:19:41 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 00:19:41 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 00:19:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:19:42 INFO - Return code: 0 00:19:42 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 00:19:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:19:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:19:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 00:19:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:19:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YR5hGCoQR2OgnI19DYIPVw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--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 00:19:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YR5hGCoQR2OgnI19DYIPVw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-007 --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 00:19:42 INFO - Using env: {'DISPLAY': ':0', 00:19:42 INFO - 'HOME': '/home/cltbld', 00:19:42 INFO - 'LANG': 'en_US.UTF-8', 00:19:42 INFO - 'LANGUAGE': 'en_US:en', 00:19:42 INFO - 'LOGNAME': 'cltbld', 00:19:42 INFO - 'MAIL': '/var/mail/cltbld', 00:19:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:19:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 00:19:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:19:42 INFO - 'MOZ_NO_REMOTE': '1', 00:19:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:19:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:19:42 INFO - 'NO_EM_RESTART': '1', 00:19:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:19:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:19:42 INFO - 'PWD': '/builds/slave/test', 00:19:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:19:42 INFO - 'SHELL': '/bin/bash', 00:19:42 INFO - 'SHLVL': '1', 00:19:42 INFO - 'TERM': 'linux', 00:19:42 INFO - 'TMOUT': '86400', 00:19:42 INFO - 'USER': 'cltbld', 00:19:42 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1474528727.23348-1798013729', 00:19:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:19:42 INFO - '_': '/tools/buildbot/bin/python'} 00:19:42 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YR5hGCoQR2OgnI19DYIPVw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--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 00:19:42 INFO - mozversion application_buildid: 20160921213059 00:19:42 INFO - mozversion application_changeset: 4aa20c3e211f6fec5d82bb74b087e13ad7ac04cc 00:19:42 INFO - mozversion application_display_name: Nightly 00:19:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:19:42 INFO - mozversion application_name: Firefox 00:19:42 INFO - mozversion application_remotingname: firefox 00:19:42 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 00:19:42 INFO - mozversion application_vendor: Mozilla 00:19:42 INFO - mozversion application_version: 52.0a1 00:19:42 INFO - mozversion platform_buildid: 20160921213059 00:19:42 INFO - mozversion platform_changeset: 4aa20c3e211f6fec5d82bb74b087e13ad7ac04cc 00:19:42 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 00:19:42 INFO - mozversion platform_version: 52.0a1 00:19:42 INFO - using testdate: 1474528782 00:19:42 INFO - actual date: 1474528782 00:19:42 INFO - starting webserver on 'localhost:49838' 00:19:42 INFO - SUITE-START | Running 2 tests 00:19:42 INFO - TEST-START | dromaeo_css 00:19:42 INFO - operating with platform_type : linux_ 00:19:42 INFO - Initialising browser for dromaeo_css test... 00:19:42 INFO - TEST-INFO | started process 6600 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKqNoLd/profile http://localhost:49838/getInfo.html) 00:19:46 INFO - PROCESS | 6600 | __metrics Screen width/height:1600/1200 00:19:46 INFO - PROCESS | 6600 | colorDepth:24 00:19:46 INFO - PROCESS | 6600 | Browser inner width/height: 1024/697 00:19:46 INFO - PROCESS | 6600 | __metrics 00:19:46 ERROR - PROCESS | 6600 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3067: TypeError: this.tabs is undefined 00:19:47 INFO - TEST-INFO | 6600: exit 0 00:19:47 INFO - Browser initialized. 00:19:47 INFO - Running cycle 1/1 for dromaeo_css test... 00:19:47 INFO - TEST-INFO | started process 6719 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKqNoLd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:19:59 INFO - PROCESS | 6719 | RSS: Main: 184623104 00:19:59 INFO - PROCESS | 6719 | 00:20:49 INFO - PROCESS | 6719 | 1474528849527 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] 00:22:59 INFO - PROCESS | 6719 | Cycle 1(1): loaded http://localhost:49838/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49838/tests/dromaeo/cssquery-ext.html) 00:23:00 INFO - PROCESS | 6719 | RSS: Main: 192290816 00:23:00 INFO - PROCESS | 6719 | 00:26:02 INFO - PROCESS | 6719 | Cycle 1(1): loaded http://localhost:49838/tests/dromaeo/cssquery-ext.html (next: http://localhost:49838/tests/dromaeo/cssquery-jquery.html) 00:26:03 INFO - PROCESS | 6719 | RSS: Main: 195944448 00:26:03 INFO - PROCESS | 6719 | 00:29:05 INFO - PROCESS | 6719 | Cycle 1(1): loaded http://localhost:49838/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49838/tests/dromaeo/cssquery-mootools.html) 00:29:05 INFO - PROCESS | 6719 | RSS: Main: 194576384 00:29:05 INFO - PROCESS | 6719 | 00:32:07 INFO - PROCESS | 6719 | Cycle 1(1): loaded http://localhost:49838/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49838/tests/dromaeo/cssquery-prototype.html) 00:32:08 INFO - PROCESS | 6719 | RSS: Main: 197726208 00:32:08 INFO - PROCESS | 6719 | 00:35:10 INFO - PROCESS | 6719 | Cycle 1(1): loaded http://localhost:49838/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49838/tests/dromaeo/cssquery-yui.html) 00:35:11 INFO - PROCESS | 6719 | RSS: Main: 196620288 00:35:11 INFO - PROCESS | 6719 | 00:38:14 INFO - PROCESS | 6719 | Cycle 1(1): loaded http://localhost:49838/tests/dromaeo/cssquery-yui.html (next: http://localhost:49838/tests/dromaeo/cssquery-dojo.html) 00:38:14 INFO - PROCESS | 6719 | RSS: Main: 198983680 00:38:14 INFO - PROCESS | 6719 | 00:38:14 INFO - PROCESS | 6719 | __start_tp_report 00:38:14 INFO - PROCESS | 6719 | _x_x_mozilla_page_load 00:38:14 INFO - PROCESS | 6719 | _x_x_mozilla_page_load_details 00:38:14 INFO - PROCESS | 6719 | |i|pagename|runs| 00:38:14 INFO - PROCESS | 6719 | |0;dojo.html;3026.25856665117;3030.5454181872715;3031.2118849099256;3046.329807442362;3050.389922015597;5286.286351342567;5353.437889021655;5405.135178371452;5406.83779486616;5500.834974950748;5287.814926477574;5399.83800485986;5410.377806552247;5439.809606663767;5508.586855985807;4867.610591152717;4941.135301322272;4962.900741985158;4993.201087825949;5053.317802096725;5024.673396229252;5026.924596131061;5079.288899554065;5106.336176297076;5121;4716.198246298138;4772.2125849234835;4870.147724148295;4882.902341953177;4987.900241995158;4903.2645103234445;4916.090523253174;4939.407271127452;4950.801967921278;4973.254011898208;4857.587105096071;4893.314935908976;4906.607471402315;4913.754312284372;4932.975335123338;5239.738013099368;5278.313819203479;5365.222042803772;5412.648177868426;5443.5100840924115;5808.506276966463;5854.882902341929;5855.531557475391;5904.468597826216;5913.024350982083;5878.118282257653;5884.823455296348;5894.8821023579285;5895.705214739289;5901.793437229677;5228.058949389147;5258.605604579672;5463.098588732854;5470.452954704538;5479.917801232985;5773.191753154478;5778.5377169826315;5812.418758124154;5842.357340692521;5903.439173278532;5539.584531160179;5571.526420254243;5584.91622625661;5585.944140558624;5587.972060139673;5541.944580554224;5585.748641311069;5609.579281553818;5673.149027645886;5673.971630141823;5745.195672605839;5785.595008349375;5786.681732504669;5807;5879.853003674857;5794.565407594448;5806.796762113306;5824.417558244142;5826.621269617546;5831.3877042910735;4277.807498662505;4443.466783985942;4453.710508816916;4457.576530229688;4512.2554778461845;3847.115163512408;3927.489426374553;3957.0700885291935;3979.303621866162;4041.8989525261513;5528.668279903219;5562.638428502134;5575.944240557543;5593.636413633101;5605.943940560543;5832.154337621021;5879.764809407661;5901.3213480450295;5904.4685978261305;5968.8806223876145;5385.703786291713;5390.568754499631;5449.04641687703;5480.451954804487;5509.338879334426;5029.119904016856;5034.0686972910125;5038.470960549163;5041.773120209599;5090.872728181825;5998.88002239944;6045.486133678686;6050.183225264621;6053.152558641794;6064.090386442069;5507.284053073236;5559.777608895599;5715.914261286167;5742.253507044057;5878.94121058801;6013.128096426081;6017.638941663514;6019.879602408015;6047.78832740852;6067.544934130046;5585.497305242548;5676.148577713376;5677.971610141923;5681.460261275172;5688.601797874109;5687.151675705495;5692.373838877637;5717.256756621613;5745.770169193353;5805.245318108618;5574.247476590771;5663.631863928831;5664.26364572603;5731.541476681772;5735.168400581976;5575.330960284792;5616.915746263728;5624.184493248375;5633.3521645009705;5634.070378387684;5439.918401223906;5512.586556008396;5540.473655002768;5569.66582005081;5581.748821303132;5614.943850561605;5654.293213348332;5659.094544872801;5680.346760122638;5697.230873832145;5443.755031023535;5542.11326187808;5542.445755424425;5554.861128471821;5564.8330550083565 00:38:14 INFO - PROCESS | 6719 | |1;ext.html;534.4601952028453;569.8034178208517;573.2576313673793;587.5475883569653;588.5350573047293;32636.510452343235;42506.574934250646;43979.78010109945;44009.11981760363;44136.77931610338;44536.10927781442;44575;44758.77620611892;44898.55101448984;45239.77380113095;8988.910110898889;9106.908930910706;9115.908840911605;9120.635174593008;9125.087491250888;8947.910520894773;8983.820323593556;9014.729558113268;9018.233450156744;9046.050164732707;8858.114188581154;8864.069272726367;8870.37907346486;8888.600012999399;8889.533227017535;8994.550272486415;9026.50354230517;9031.412958157698;9066.410683305565;9088.318376121784;8926;9002.459852408876;9025.277977761829;9032.367734258605;9047.411918225294;43331.35002974958;43432;43600.56399436029;43746.12507749827;43797.78101109474;3451.447768357076;3549.112721819545;3588.318219538279;3939.546952100488;4058.9594104059174;32135.357292854012;32253;32443.351132977208;32446.513302300486;32789.508157377655;3996.580359062286;4088.3049881520215;4171.124063946575;4279.614834664864;4304.289792184286;324201;324290;324572;324958.9999999976;324966;32290.515642265385;33688.1577960548;57970.4202957965;58364.41635583675;58467.41532584705;37415.62584374176;37701.24597508089;37857.43213851794;37922.81038594845;37933.43099853504;15224.162671053198;15322.846771532142;15325.080495170325;15380.769288460682;15500.379984800482;11787.646370608896;11829.053675705924;11839.052875769918;11849.348285844362;11889.940550297193;8580.528070956032;8588.098249683819;8682.78293042679;8746.912530874737;8754.21212090915;3392.592888853304;3394.6096198936943;3404.982975085158;3436.6278462372943;3493.161641206143;985.1084768284713;990.7225976726528;994.1500017485091;1007.5818535307765;1081.259337353915;32056.83971580174;32876.17809554732;33604.1598960028;33669.831650842076;35641.10897227538;1113.2485572238706;1125.431657013203;1148.9827652585218;1156.3986726901965;1173.5833779008328;16878;17046.260855660854;17155.142242887807;17169.31322747101;17198.31206751741;525505;528496;530417;530895;531304;58691.70654146702;59392.40607593955;59533;59579.702101489216;59663.40336596579;1327.3628658244097;1387.1746310944973;1388.6667199871958;1393.9303034848217;1397.9720405592034;30507.847460762554;31307.686923130477;31603.36793264076;31899.202519937186;32690.182745430604;51213.74393128011;52138.47861521488;52151;52425.213621796465;52450.21324680209;472323;475266;476066;476340;477638;28814;28925.513359232304;29182.854085729436;29192.854035730536;29209.70790292155;47024.529754703384;47864.282035768796;48274.75862620665;48442;48788.26817597668;40164.59835401609;41054.178916420904;41153.38269926013;41318.79340603398;43159.78420107879;41424.58575414207;41733;41880.3717944225;42247.57752422559;42570.787146064074;41589;43403.13193736171;44191.779041104586;44638.330425043;44918.550814492744;33515.329693406486;36492.27015459729;37202.8139859299;37340.446749101866;37573.87278381653;28016.15951521376;28237.90774479623;28404.289892752848;28749.71250287554;28764.56853147246 00:38:14 INFO - PROCESS | 6719 | |2;jquery.html;401.5081525131714;404.2662567440098;405.7747949887812;407.77572335215643;425.9701820872538;15972.361105555792;16237.83762162378;17809;19450.221991120357;19463.805361946357;18164.63670726588;19014.90492547535;19121.043947802587;19390.515237119078;19611.607767844635;5138.177891537355;5350.839474815762;5635.408282130379;5862.443067908542;5875.76496940124;5817.505512031483;5867.383924687911;5869.2369991901205;5921.230240068785;5938.287405511344;5774.480296773289;5938.524918006549;5949.375315591866;5957.970210148943;5962.195103661015;5933.345983681046;5942.465178133967;5942.851428714295;5976.850578735544;6023.427774361428;5562.249096372019;5789.392113828029;5798.188253644493;5804.477597016246;5808.128780682931;13151.145175563557;14701;22257.109715611357;22763.861806909754;22942.885285573466;2271.1369679521677;2274.7042884425086;2377.2511658827416;2423.333583264599;2763.392053748172;9823.90176098237;10245.104655638655;10373.84439233412;11967.341796201206;14640.267986600735;1901.610169915164;1958.0992743338081;1981.296639692917;1986.5629561496448;1997.9001049947444;85781.14218857794;85924.57037714896;87325;88850.3362247834;90363;10952.288101273392;11088.833667494993;11212.551497940154;11259.887401125883;11338.092952563775;15701.842981570266;15762.448314308944;15777.0533767972;15808.60478488024;15867.365305387886;7760.30157285847;7888.487248328955;8110.31062359706;8134.267915887599;8223.876641850376;7501.174870764212;7549.358304544176;7717.151113377524;7762.650680719381;7780.14418413974;4542.704724192917;4573.588377046081;4610.017692392304;4787.40157480315;4820.783064762094;1855.7680289963755;1943.6015616798522;1954.7556555430572;1995.7704863940542;2002.5193953451358;902.2826852652157;949.9335046546813;964.3153361113688;1016.1718199667248;1065.3607835298758;19565.21739130447;19621.705674414894;19721.309754158534;19884.90057549703;19929.302474413325;995.5072239241478;1020.5968642386216;1022.5551884930079;1039.620538503456;1065.5950738719237;10467.738306542398;11051.834222486508;11070.501827417624;11091.168162387854;11092.722681933015;446101;453581;454951;456208;457906;82544.58727706443;83799.16200838036;87837;89584;93435.53282233546;990.5443495991924;1038.200585549123;1050.9894901051046;1057.2387880725864;1065.8188108021654;16948.661026779148;17140.828591713922;17441.215145318238;17622.64754704873;17926.103694814945;40811.59188408078;41530.584694153884;42474.36288455614;42740;42824;55352.44647553473;57279.71360143173;57438;57734.422655774586;58171;7556.546607203585;7687.502186505239;7840.059192896889;7887.487313324616;8029.678812847655;11366;13472.461101555828;13587.184768913898;13759.10565813219;13977.371018303997;11560.190786644855;11742.236754610924;11764.235324703866;12020.398980051137;12040;11498.25261358009;11635.709107272385;11654.883451165719;11846.703832404259;12387;11922.761544768882;11961.282323060645;12180;12190.329531875832;12649.620511384674;7738.961305193438;7928.365730741642;8034.919650803417;8202.425830192067;8390;10308.484575771032;11614.70963225926;11829.940850295694;12423.378831058591;12450.626481205578 00:38:14 INFO - PROCESS | 6719 | |3;mootools.html;1467.963300917477;1503.8571335723104;1649.851513363797;1800.6488734696738;1816.6820806358892;7884.093329267136;8140.063892652347;8560.357973152008;9098.63605455781;9197.310201734872;8512.616932238048;8787.560621968907;8809.075047120055;9023.18791308782;9052.502112383816;2422.152246713645;2444.511097780442;2450.534398464295;2450.791682706972;2453.717822450414;2363.917262895799;2368.8578685278853;2379.583572874749;2390.7728765767224;2403.843750156243;2388.9283321500384;2427.0655797517907;2435;2458.5820410530255;2462.273629279358;2373.7270213925362;2387.140629373424;2390.0081466191596;2415.6376543518436;2441.0235905637887;2307.1694190091553;2329.8369114162015;2331.6968794056834;2338.754430784777;2348.072511358004;9081.954590227007;9131.26949844011;9148.130927561871;9153.221976132038;9158.633654653806;5172.27588137661;5189.455107213726;5214.8174813881715;5238.528532432099;5261.263423120728;3072.2165847708916;3267.836608169606;3276.918077048069;3277.5083737439336;3358.630550639428;1021.0861279155189;1021.2442792333619;1023.518946095334;1065.6110519660267;1100.114407901639;12410.131290809646;12431.564895228623;12518.186317889307;12540.24758514492;12543.24740515572;4419.226635338803;4599.195140850338;4700.08348372071;4707.7881495332795;4715.83494577695;10432.5826966922;10553.947230263799;10619.469026548642;10633.361998280128;10637.9468102659;5289.735513224324;5303.337082864642;5309.840704778863;5310.734463276821;5335.119705248668;4674.883127921829;4786.976065119652;4831.855044348676;4835.95164048355;4884.609231261491;3964.2467931093;4072.3687828386646;4146.315857883415;4146.357314616239;4211.220924129046;1317.3610798762784;1327.741090487365;1331.7203387288585;1331.993340033313;1334.2461509247244;899.9145081217274;945.6406565505064;956.8947415784259;971.3249291742171;985.1478471122427;5949.702514874239;5970.910436343458;6000.159977603139;6016.849578760566;6060.2424696912885;453.8479609330845;459.34543275832476;462.4889497105717;463.88402899275184;466.7199680191858;3897.2984862724984;4002.079521709965;4028.8388464461677;4081.163361510883;4104.91790164195;10693.304935179189;11059.115270778319;11080.168987325982;11087.113030957504;11097.001269885588;10988.285761425483;10990.890091099147;11003.724906877233;11010;11049.834252486218;8161.306288965505;8191.754247372588;8209.8358032839;8212.671493140328;8287.668493260322;5966.910496342645;6089.69551522431;6130.831466701124;6153.3538978408415;6158.107074474266;9810.950945245228;9936.503174841373;9948.900510994798;10010.549525271526;10129.544170512492;10141.442220677933;10230.567720518984;10244.129249013917;10269.948650257;10382.11752001058;7660.157382687788;7861.646225919962;7919.406044546567;7922.405819563441;7991.400644951768;8701.782455438664;8712.78218044554;8729.869051964099;8739.43193692408;8779.956100219459;7570.659320330488;7703.345215656732;7717.614119294125;7962.402819788424;8013.6794528218215;7068.646567671699;7231.4214862811905;7284.089488813898;7305.159906610807;7522;6895.827604309932;7005.509614327152;7008.159020917523;7013.263607321362;7026.262242464468;4951.3810773653295;5100.974495127501;5188.584913206859;5248.317718696698;5290.127129023668;5047.066292735855;5178.559822414986;5217.713025783618;5223.45153758865;5375.274337964324 00:38:14 INFO - PROCESS | 6719 | |4;prototype.html;324.4792108665592;324.59425717852685;329.8202479648591;333.35495815596806;335.59728326008764;5516.586256030799;5540.418256083109;5570.164475328703;5573.331200255965;5648.774049038038;5417.133258678612;5428.267183930168;5453.182022696597;5462;5506.64206826557;4060.654844338235;4070.9185816283657;4158.293090174678;4268.743875367472;4284.464441944757;4266.679999000072;4271;4288.9785551072355;4318.244307246235;4329.307310830268;4231.344141658048;4237.194932962727;4249.405083288327;4252.468441444819;4280.6361459275995;3989.4015897615445;4194.580541945811;4238.321868501025;4253.787310634456;4289.313709806432;3702.0929872181487;3710.9257814843554;3719.5350581177354;3719.851205951759;3722.7394082414244;5305.867353316198;5349.598780091509;5383.300170977748;5399.9730001350135;5427.402985671573;4579.702319349231;4805.183118869765;4822.517748225185;4852;4856;5637.393342897296;5643.717814109319;5664.660120392789;5706.914396284059;5750.971245143789;4023.6378725914515;4030.234255491447;4057.742099949025;4061.3704875744306;4081.8979525511804;5926.525877929798;5927;5931.73307201177;6035.909461358083;6063.393660633946;4139.406328563525;4142.06803469217;4145.2124096421585;4184.539700632928;4192.161567686475;4227.704060715781;4248.426462427595;4249.7237679551345;4263.253930562139;4263.957360426356;4749.962680997136;4813.3983252093485;4834.486067245083;4876.244182151772;4880.902381952341;5677.971610141923;5713.428657134254;5721.39925307845;5726.341470730836;5745.368009518949;1431.1270125223605;1453.7019910918236;1455.8762505187178;1456.4247122386598;1457.9125252484885;879.6261588824724;886.2112719679491;928.4846909965034;950.9239260859115;951.1629765806047;5475.479829416199;5504.339479262434;5505.559555235572;5527.723613819373;5551.9722401387735;5822;5828.0966450200285;5833.183354330397;5835.570285280133;5858.882822343615;5383.950129724744;5397.758515541447;5416.9729151353995;5460.535854452416;5524.972375138099;3060.7398371138256;3076.2616971927023;3077.8461076946064;3112.750979921601;3127.702868227515;5794.942050579524;5923.940760592425;6091.878162436727;6121.908171377433;6130.938690613126;5989.31122920861;6075.301340345917;6104.572679912363;6124.7538804433725;6128.295246046761;6225.844353891189;6225.937740622627;6233.506597361001;6262.68686565679;6317.557770955989;5669.971650141723;5923.216088438427;5930.584859059824;5984.551158663031;5988.161657368059;5902.1736956826935;5915.201447804491;5923.200367950271;5946.464818166212;5950.940490595039;5886.705664716661;6129.417705317987;6203.720832562636;6216.53375996793;6248.250209974832;4162.916741665089;4186.204621121977;4188.5811418857875;4190.476190476191;4209.515905670887;5956.493698035715;5961.552883533665;5995;6009.489193418608;6025.758969641165;5652.959513928988;5796.101604251347;5804.564657650778;5853.122031695109;5884.58807883444;5813.476787089182;5834.599696072827;5843.532517398513;5845.620034697731;5852.18069470266;5418.266154830574;5805.564582656402;5807.564432667482;5829.417058294137;5864.472197502245;5802.100674395476;5835.649861008353;5845.386234445492;5858.384869588632;5882.647041177372;5665.093585026376;5667.801626943037;5701.344345400332;5712.971435142964;5730.71346432685 00:38:14 INFO - PROCESS | 6719 | |5;yui.html;740.563067790004;757.3675980556235;764.575660508418;778.8247644280037;823.5717426937989;15219.162946037977;16666.166691665414;16826.579335516617;16839.158042097908;16919.830801691995;15262.313195906183;15364.231788410563;15517.379304827793;15563.922180389081;15617.609559761011;643.4209211709452;663.0452148905584;767.03736810303;770.3067239484453;789.4276649429147;788.6529926832204;790.8892755014302;792.302773559267;797.4696826610326;797.6131576185545;826.8139668574582;827.4993628854546;828.8135169586855;836.9539675317885;838.0655569040506;814.6985615322369;818.0755746007034;821.7082935557851;822.0382152881114;828.5484410996022;613.3284053960906;613.5888954400518;617.2438762515882;618.7153909201772;619.7118339971935;15253.694926101527;15454.227288635635;15512;15514.146721930289;15598.532044038697;15001.099934003885;15046.924765376103;15258.694826103527;15456.381744730197;15687.529374118794;10947.124230061656;11063.502142403611;11070.225084244106;11269.718257043558;11782.528698852035;3836.6547010769164;3846.632206838582;3946.546147193052;3960.920781584352;4073.5315438724333;79035;79042.20957790464;79459.6027019867;80273;80571.19428805754;10753.279475283916;11153.330800152016;11260.493277802518;11334.433278336215;11655.825162622568;19464.416067517996;20490.077946492147;22835.657465138036;22856.885715571316;22947.19684811057;8072.192780721881;8311.088449656612;8449.873251901226;8495.447795893248;8548.48709077445;4744.501827308152;4768.117898188846;4817.542333478314;4824.059308434892;4844.636652251095;3545.308664810337;3618.81905904709;3760.417135344026;3774.735768496179;3790.0714324990554;644.754993102618;645.319188256394;653.9280679125293;657.0669649098196;666.7099811581977;635.6980434293766;655.7409823119937;704.232386698501;706.2937062937064;711.8683043636944;9375.682815883038;9592.529288358815;9753.512324383752;9796.608135674636;9961.153301969414;646.5829539946708;684.9896402805822;691.312144416309;698.441247002396;736.0725485887713;4882.340883980688;4907.950920490749;4910.729909854921;5007.749612519432;5087.771050302746;90334.09665903388;120107;123997;128546.35726821492;129813;106275;111455.44272278587;112409;114316.42841785737;114441;90023.09976900279;90377;91251.54374228086;92718;95288;8942.37403381757;8962.417442866194;9255.583498742439;9513.809723805347;9524.285678573997;54642;55053;55600;56117.71941140268;56523.71738141283;74451;75604.62197688976;83423.58288208763;84368.57815711127;86697;11111.666650000512;11203.751175975905;12617.684557886127;12826.358682066046;12917.09580329368;14083.507077252247;14361.425542978583;14380;14545.272736362927;15471.071735695894;13986.510472133426;14057;14329.78505322442;14385.28073596337;14711.632209194855;13482.955874958398;13984.930075349557;14019.088759230617;14584.052036617586;14754.704905902037;13227.470901163846;14373.496927607484;14683;14737.410503579737;14777.25317175915;11597.620129983787;11780.70548236301;11811.763764724828;11919.642410727693;11965.880341196476;9936.672709662827;10357.896421035693;10789.40658263803;11263.549458021587;12407.813882791585 00:38:14 INFO - PROCESS | 6719 | __end_tp_report 00:38:14 INFO - PROCESS | 6719 | __start_cc_report 00:38:14 INFO - PROCESS | 6719 | _x_x_mozilla_cycle_collect,299 00:38:14 INFO - PROCESS | 6719 | __end_cc_report 00:38:14 INFO - PROCESS | 6719 | __startTimestamp1474529894417__endTimestamp 00:38:14 INFO - PROCESS | 6719 | 00:38:14 INFO - PROCESS | 6719 | ------- Summary: start ------- 00:38:14 INFO - PROCESS | 6719 | Number of tests: 6 00:38:14 INFO - PROCESS | 6719 | 00:38:14 INFO - PROCESS | 6719 | [#0] dojo.html Cycles:165 Average:5368.79 Median:5562.64 stddev:617.70 (11.1%) stddev-sans-first:591.63 00:38:14 INFO - PROCESS | 6719 | Values: 3026.3 3030.5 3031.2 3046.3 3050.4 5286.3 5353.4 5405.1 5406.8 5500.8 5287.8 5399.8 5410.4 5439.8 5508.6 4867.6 4941.1 4962.9 4993.2 5053.3 5024.7 5026.9 5079.3 5106.3 5121.0 4716.2 4772.2 4870.1 4882.9 4987.9 4903.3 4916.1 4939.4 4950.8 4973.3 4857.6 4893.3 4906.6 4913.8 4933.0 5239.7 5278.3 5365.2 5412.6 5443.5 5808.5 5854.9 5855.5 5904.5 5913.0 5878.1 5884.8 5894.9 5895.7 5901.8 5228.1 5258.6 5463.1 5470.5 5479.9 5773.2 5778.5 5812.4 5842.4 5903.4 5539.6 5571.5 5584.9 5585.9 5588.0 5541.9 5585.7 5609.6 5673.1 5674.0 5745.2 5785.6 5786.7 5807.0 5879.9 5794.6 5806.8 5824.4 5826.6 5831.4 4277.8 4443.5 4453.7 4457.6 4512.3 3847.1 3927.5 3957.1 3979.3 4041.9 5528.7 5562.6 5575.9 5593.6 5605.9 5832.2 5879.8 5901.3 5904.5 5968.9 5385.7 5390.6 5449.0 5480.5 5509.3 5029.1 5034.1 5038.5 5041.8 5090.9 5998.9 6045.5 6050.2 6053.2 6064.1 5507.3 5559.8 5715.9 5742.3 5878.9 6013.1 6017.6 6019.9 6047.8 6067.5 5585.5 5676.1 5678.0 5681.5 5688.6 5687.2 5692.4 5717.3 5745.8 5805.2 5574.2 5663.6 5664.3 5731.5 5735.2 5575.3 5616.9 5624.2 5633.4 5634.1 5439.9 5512.6 5540.5 5569.7 5581.7 5614.9 5654.3 5659.1 5680.3 5697.2 5443.8 5542.1 5542.4 5554.9 5564.8 00:38:14 INFO - PROCESS | 6719 | 00:38:14 INFO - PROCESS | 6719 | [#1] ext.html Cycles:180 Average:59353.13 Median:42063.97 stddev:120020.79 (285.3%) stddev-sans-first:120276.24 00:38:14 INFO - PROCESS | 6719 | Values: 534.5 569.8 573.3 587.5 588.5 32636.5 42506.6 43979.8 44009.1 44136.8 44536.1 44575.0 44758.8 44898.6 45239.8 8988.9 9106.9 9115.9 9120.6 9125.1 8947.9 8983.8 9014.7 9018.2 9046.1 8858.1 8864.1 8870.4 8888.6 8889.5 8994.6 9026.5 9031.4 9066.4 9088.3 8926.0 9002.5 9025.3 9032.4 9047.4 43331.4 43432.0 43600.6 43746.1 43797.8 3451.4 3549.1 3588.3 3939.5 4059.0 32135.4 32253.0 32443.4 32446.5 32789.5 3996.6 4088.3 4171.1 4279.6 4304.3 324201.0 324290.0 324572.0 324959.0 324966.0 32290.5 33688.2 57970.4 58364.4 58467.4 37415.6 37701.2 37857.4 37922.8 37933.4 15224.2 15322.8 15325.1 15380.8 15500.4 11787.6 11829.1 11839.1 11849.3 11889.9 8580.5 8588.1 8682.8 8746.9 8754.2 3392.6 3394.6 3405.0 3436.6 3493.2 985.1 990.7 994.2 1007.6 1081.3 32056.8 32876.2 33604.2 33669.8 35641.1 1113.2 1125.4 1149.0 1156.4 1173.6 16878.0 17046.3 17155.1 17169.3 17198.3 525505.0 528496.0 530417.0 530895.0 531304.0 58691.7 59392.4 59533.0 59579.7 59663.4 1327.4 1387.2 1388.7 1393.9 1398.0 30507.8 31307.7 31603.4 31899.2 32690.2 51213.7 52138.5 52151.0 52425.2 52450.2 472323.0 475266.0 476066.0 476340.0 477638.0 28814.0 28925.5 29182.9 29192.9 29209.7 47024.5 47864.3 48274.8 48442.0 48788.3 40164.6 41054.2 41153.4 41318.8 43159.8 41424.6 41733.0 41880.4 42247.6 42570.8 41589.0 43403.1 44191.8 44638.3 44918.6 33515.3 36492.3 37202.8 37340.4 37573.9 28016.2 28237.9 28404.3 28749.7 28764.6 00:38:14 INFO - PROCESS | 6719 | 00:38:14 INFO - PROCESS | 6719 | [#2] jquery.html Cycles:180 Average:27957.30 Median:12660.07 stddev:75068.80 (593.0%) stddev-sans-first:75250.88 00:38:14 INFO - PROCESS | 6719 | Values: 401.5 404.3 405.8 407.8 426.0 15972.4 16237.8 17809.0 19450.2 19463.8 18164.6 19014.9 19121.0 19390.5 19611.6 5138.2 5350.8 5635.4 5862.4 5875.8 5817.5 5867.4 5869.2 5921.2 5938.3 5774.5 5938.5 5949.4 5958.0 5962.2 5933.3 5942.5 5942.9 5976.9 6023.4 5562.2 5789.4 5798.2 5804.5 5808.1 13151.1 14701.0 22257.1 22763.9 22942.9 2271.1 2274.7 2377.3 2423.3 2763.4 9823.9 10245.1 10373.8 11967.3 14640.3 1901.6 1958.1 1981.3 1986.6 1997.9 85781.1 85924.6 87325.0 88850.3 90363.0 10952.3 11088.8 11212.6 11259.9 11338.1 15701.8 15762.4 15777.1 15808.6 15867.4 7760.3 7888.5 8110.3 8134.3 8223.9 7501.2 7549.4 7717.2 7762.7 7780.1 4542.7 4573.6 4610.0 4787.4 4820.8 1855.8 1943.6 1954.8 1995.8 2002.5 902.3 949.9 964.3 1016.2 1065.4 19565.2 19621.7 19721.3 19884.9 19929.3 995.5 1020.6 1022.6 1039.6 1065.6 10467.7 11051.8 11070.5 11091.2 11092.7 446101.0 453581.0 454951.0 456208.0 457906.0 82544.6 83799.2 87837.0 89584.0 93435.5 990.5 1038.2 1051.0 1057.2 1065.8 16948.7 17140.8 17441.2 17622.6 17926.1 40811.6 41530.6 42474.4 42740.0 42824.0 55352.4 57279.7 57438.0 57734.4 58171.0 7556.5 7687.5 7840.1 7887.5 8029.7 11366.0 13472.5 13587.2 13759.1 13977.4 11560.2 11742.2 11764.2 12020.4 12040.0 11498.3 11635.7 11654.9 11846.7 12387.0 11922.8 11961.3 12180.0 12190.3 12649.6 7739.0 7928.4 8034.9 8202.4 8390.0 10308.5 11614.7 11829.9 12423.4 12450.6 00:38:14 INFO - PROCESS | 6719 | 00:38:14 INFO - PROCESS | 6719 | [#3] mootools.html Cycles:180 Average:5832.13 Median:4703.94 stddev:3341.96 (71.0%) stddev-sans-first:3335.24 00:38:14 INFO - PROCESS | 6719 | Values: 1468.0 1503.9 1649.9 1800.6 1816.7 7884.1 8140.1 8560.4 9098.6 9197.3 8512.6 8787.6 8809.1 9023.2 9052.5 2422.2 2444.5 2450.5 2450.8 2453.7 2363.9 2368.9 2379.6 2390.8 2403.8 2388.9 2427.1 2435.0 2458.6 2462.3 2373.7 2387.1 2390.0 2415.6 2441.0 2307.2 2329.8 2331.7 2338.8 2348.1 9082.0 9131.3 9148.1 9153.2 9158.6 5172.3 5189.5 5214.8 5238.5 5261.3 3072.2 3267.8 3276.9 3277.5 3358.6 1021.1 1021.2 1023.5 1065.6 1100.1 12410.1 12431.6 12518.2 12540.2 12543.2 4419.2 4599.2 4700.1 4707.8 4715.8 10432.6 10553.9 10619.5 10633.4 10637.9 5289.7 5303.3 5309.8 5310.7 5335.1 4674.9 4787.0 4831.9 4836.0 4884.6 3964.2 4072.4 4146.3 4146.4 4211.2 1317.4 1327.7 1331.7 1332.0 1334.2 899.9 945.6 956.9 971.3 985.1 5949.7 5970.9 6000.2 6016.8 6060.2 453.8 459.3 462.5 463.9 466.7 3897.3 4002.1 4028.8 4081.2 4104.9 10693.3 11059.1 11080.2 11087.1 11097.0 10988.3 10990.9 11003.7 11010.0 11049.8 8161.3 8191.8 8209.8 8212.7 8287.7 5966.9 6089.7 6130.8 6153.4 6158.1 9811.0 9936.5 9948.9 10010.5 10129.5 10141.4 10230.6 10244.1 10269.9 10382.1 7660.2 7861.6 7919.4 7922.4 7991.4 8701.8 8712.8 8729.9 8739.4 8780.0 7570.7 7703.3 7717.6 7962.4 8013.7 7068.6 7231.4 7284.1 7305.2 7522.0 6895.8 7005.5 7008.2 7013.3 7026.3 4951.4 5101.0 5188.6 5248.3 5290.1 5047.1 5178.6 5217.7 5223.5 5375.3 00:38:14 INFO - PROCESS | 6719 | 00:38:14 INFO - PROCESS | 6719 | [#4] prototype.html Cycles:180 Average:4846.07 Median:5534.07 stddev:1452.27 (26.2%) stddev-sans-first:1416.13 00:38:14 INFO - PROCESS | 6719 | Values: 324.5 324.6 329.8 333.4 335.6 5516.6 5540.4 5570.2 5573.3 5648.8 5417.1 5428.3 5453.2 5462.0 5506.6 4060.7 4070.9 4158.3 4268.7 4284.5 4266.7 4271.0 4289.0 4318.2 4329.3 4231.3 4237.2 4249.4 4252.5 4280.6 3989.4 4194.6 4238.3 4253.8 4289.3 3702.1 3710.9 3719.5 3719.9 3722.7 5305.9 5349.6 5383.3 5400.0 5427.4 4579.7 4805.2 4822.5 4852.0 4856.0 5637.4 5643.7 5664.7 5706.9 5751.0 4023.6 4030.2 4057.7 4061.4 4081.9 5926.5 5927.0 5931.7 6035.9 6063.4 4139.4 4142.1 4145.2 4184.5 4192.2 4227.7 4248.4 4249.7 4263.3 4264.0 4750.0 4813.4 4834.5 4876.2 4880.9 5678.0 5713.4 5721.4 5726.3 5745.4 1431.1 1453.7 1455.9 1456.4 1457.9 879.6 886.2 928.5 950.9 951.2 5475.5 5504.3 5505.6 5527.7 5552.0 5822.0 5828.1 5833.2 5835.6 5858.9 5384.0 5397.8 5417.0 5460.5 5525.0 3060.7 3076.3 3077.8 3112.8 3127.7 5794.9 5923.9 6091.9 6121.9 6130.9 5989.3 6075.3 6104.6 6124.8 6128.3 6225.8 6225.9 6233.5 6262.7 6317.6 5670.0 5923.2 5930.6 5984.6 5988.2 5902.2 5915.2 5923.2 5946.5 5950.9 5886.7 6129.4 6203.7 6216.5 6248.3 4162.9 4186.2 4188.6 4190.5 4209.5 5956.5 5961.6 5995.0 6009.5 6025.8 5653.0 5796.1 5804.6 5853.1 5884.6 5813.5 5834.6 5843.5 5845.6 5852.2 5418.3 5805.6 5807.6 5829.4 5864.5 5802.1 5835.6 5845.4 5858.4 5882.6 5665.1 5667.8 5701.3 5713.0 5730.7 00:38:14 INFO - PROCESS | 6719 | 00:38:14 INFO - PROCESS | 6719 | [#5] yui.html Cycles:180 Average:21914.31 Median:4820.80 stddev:32244.61 (668.9%) stddev-sans-first:32295.87 00:38:14 INFO - PROCESS | 6719 | Values: 740.6 757.4 764.6 778.8 823.6 15219.2 16666.2 16826.6 16839.2 16919.8 15262.3 15364.2 15517.4 15563.9 15617.6 643.4 663.0 767.0 770.3 789.4 788.7 790.9 792.3 797.5 797.6 826.8 827.5 828.8 837.0 838.1 814.7 818.1 821.7 822.0 828.5 613.3 613.6 617.2 618.7 619.7 15253.7 15454.2 15512.0 15514.1 15598.5 15001.1 15046.9 15258.7 15456.4 15687.5 10947.1 11063.5 11070.2 11269.7 11782.5 3836.7 3846.6 3946.5 3960.9 4073.5 79035.0 79042.2 79459.6 80273.0 80571.2 10753.3 11153.3 11260.5 11334.4 11655.8 19464.4 20490.1 22835.7 22856.9 22947.2 8072.2 8311.1 8449.9 8495.4 8548.5 4744.5 4768.1 4817.5 4824.1 4844.6 3545.3 3618.8 3760.4 3774.7 3790.1 644.8 645.3 653.9 657.1 666.7 635.7 655.7 704.2 706.3 711.9 9375.7 9592.5 9753.5 9796.6 9961.2 646.6 685.0 691.3 698.4 736.1 4882.3 4908.0 4910.7 5007.7 5087.8 90334.1 120107.0 123997.0 128546.4 129813.0 106275.0 111455.4 112409.0 114316.4 114441.0 90023.1 90377.0 91251.5 92718.0 95288.0 8942.4 8962.4 9255.6 9513.8 9524.3 54642.0 55053.0 55600.0 56117.7 56523.7 74451.0 75604.6 83423.6 84368.6 86697.0 11111.7 11203.8 12617.7 12826.4 12917.1 14083.5 14361.4 14380.0 14545.3 15471.1 13986.5 14057.0 14329.8 14385.3 14711.6 13483.0 13984.9 14019.1 14584.1 14754.7 13227.5 14373.5 14683.0 14737.4 14777.3 11597.6 11780.7 11811.8 11919.6 11965.9 9936.7 10357.9 10789.4 11263.5 12407.8 00:38:14 INFO - PROCESS | 6719 | -------- Summary: end -------- 00:38:14 INFO - PROCESS | 6719 | 00:38:15 INFO - TEST-INFO | 6719: exit 0 00:38:15 INFO - TEST-OK | dromaeo_css | took 1113256ms 00:38:15 INFO - TEST-START | kraken 00:38:15 INFO - operating with platform_type : linux_ 00:38:15 INFO - Initialising browser for kraken test... 00:38:15 INFO - TEST-INFO | started process 7069 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpShJPXy/profile http://localhost:49838/getInfo.html) 00:38:19 INFO - PROCESS | 7069 | __metrics Screen width/height:1600/1200 00:38:19 INFO - PROCESS | 7069 | colorDepth:24 00:38:19 INFO - PROCESS | 7069 | Browser inner width/height: 1024/697 00:38:19 INFO - PROCESS | 7069 | __metrics 00:38:20 ERROR - PROCESS | 7069 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3067: TypeError: this.tabs is undefined 00:38:21 INFO - TEST-INFO | 7069: exit 0 00:38:21 INFO - Browser initialized. 00:38:21 INFO - Running cycle 1/1 for kraken test... 00:38:21 INFO - TEST-INFO | started process 7195 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpShJPXy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:38:33 INFO - PROCESS | 7195 | RSS: Main: 185262080 00:38:33 INFO - PROCESS | 7195 | 00:38:35 INFO - PROCESS | 7195 | Cycle 1(1): loaded http://localhost:49838/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49838/tests/kraken/driver.html?testName=audio-beat-detection) 00:38:36 INFO - PROCESS | 7195 | RSS: Main: 199057408 00:38:36 INFO - PROCESS | 7195 | 00:38:39 INFO - PROCESS | 7195 | Cycle 1(1): loaded http://localhost:49838/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49838/tests/kraken/driver.html?testName=audio-dft) 00:38:40 INFO - PROCESS | 7195 | RSS: Main: 196530176 00:38:40 INFO - PROCESS | 7195 | 00:38:42 INFO - PROCESS | 7195 | Cycle 1(1): loaded http://localhost:49838/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49838/tests/kraken/driver.html?testName=audio-fft) 00:38:43 INFO - PROCESS | 7195 | RSS: Main: 192176128 00:38:43 INFO - PROCESS | 7195 | 00:38:45 INFO - PROCESS | 7195 | Cycle 1(1): loaded http://localhost:49838/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49838/tests/kraken/driver.html?testName=audio-oscillator) 00:38:46 INFO - PROCESS | 7195 | RSS: Main: 192868352 00:38:46 INFO - PROCESS | 7195 | 00:38:48 INFO - PROCESS | 7195 | Cycle 1(1): loaded http://localhost:49838/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49838/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:38:49 INFO - PROCESS | 7195 | RSS: Main: 193310720 00:38:49 INFO - PROCESS | 7195 | 00:38:52 INFO - PROCESS | 7195 | Cycle 1(1): loaded http://localhost:49838/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49838/tests/kraken/driver.html?testName=imaging-darkroom) 00:38:52 INFO - PROCESS | 7195 | RSS: Main: 193417216 00:38:52 INFO - PROCESS | 7195 | 00:38:56 INFO - PROCESS | 7195 | Cycle 1(1): loaded http://localhost:49838/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49838/tests/kraken/driver.html?testName=imaging-desaturate) 00:38:56 INFO - PROCESS | 7195 | RSS: Main: 191995904 00:38:56 INFO - PROCESS | 7195 | 00:38:59 INFO - PROCESS | 7195 | Cycle 1(1): loaded http://localhost:49838/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49838/tests/kraken/driver.html?testName=json-parse-financial) 00:39:00 INFO - PROCESS | 7195 | RSS: Main: 193036288 00:39:00 INFO - PROCESS | 7195 | 00:39:01 INFO - PROCESS | 7195 | Cycle 1(1): loaded http://localhost:49838/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49838/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:39:02 INFO - PROCESS | 7195 | RSS: Main: 193077248 00:39:02 INFO - PROCESS | 7195 | 00:39:04 INFO - PROCESS | 7195 | Cycle 1(1): loaded http://localhost:49838/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49838/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:39:05 INFO - PROCESS | 7195 | RSS: Main: 192978944 00:39:05 INFO - PROCESS | 7195 | 00:39:07 INFO - PROCESS | 7195 | Cycle 1(1): loaded http://localhost:49838/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49838/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:39:07 INFO - PROCESS | 7195 | RSS: Main: 193294336 00:39:07 INFO - PROCESS | 7195 | 00:39:10 INFO - PROCESS | 7195 | Cycle 1(1): loaded http://localhost:49838/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49838/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:39:11 INFO - PROCESS | 7195 | RSS: Main: 193462272 00:39:11 INFO - PROCESS | 7195 | 00:39:13 INFO - PROCESS | 7195 | Cycle 1(1): loaded http://localhost:49838/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49838/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:39:14 INFO - PROCESS | 7195 | RSS: Main: 193585152 00:39:14 INFO - PROCESS | 7195 | 00:39:16 INFO - PROCESS | 7195 | Cycle 1(1): loaded http://localhost:49838/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49838/tests/kraken/driver.html?testName=ai-astar) 00:39:16 INFO - PROCESS | 7195 | RSS: Main: 195026944 00:39:16 INFO - PROCESS | 7195 | 00:39:16 INFO - PROCESS | 7195 | __start_tp_report 00:39:16 INFO - PROCESS | 7195 | _x_x_mozilla_page_load 00:39:16 INFO - PROCESS | 7195 | _x_x_mozilla_page_load_details 00:39:16 INFO - PROCESS | 7195 | |i|pagename|runs| 00:39:16 INFO - PROCESS | 7195 | |0;ai-astar;107;113;112;112;111;111;111;111;111;111 00:39:16 INFO - PROCESS | 7195 | |1;audio-beat-detection;157;119;120;171;121;121;124;121;148;126 00:39:16 INFO - PROCESS | 7195 | |2;audio-dft;163;163;163;164;166;165;162;166;162;162 00:39:16 INFO - PROCESS | 7195 | |3;audio-fft;81;77;77;117;76;77;77;77;99;77 00:39:16 INFO - PROCESS | 7195 | |4;audio-oscillator;82;82;122;83;83;84;102;84;84;108 00:39:16 INFO - PROCESS | 7195 | |5;imaging-gaussian-blur;117;118;118;117;117;117;119;118;118;118 00:39:16 INFO - PROCESS | 7195 | |6;imaging-darkroom;148;147;148;147;146;147;146;148;148;148 00:39:16 INFO - PROCESS | 7195 | |7;imaging-desaturate;96;109;96;96;97;95;95;96;96;95 00:39:16 INFO - PROCESS | 7195 | |8;json-parse-financial;51;52;53;51;54;54;54;54;53;54 00:39:16 INFO - PROCESS | 7195 | |9;json-stringify-tinderbox;62;61;64;62;61;62;62;61;61;65 00:39:16 INFO - PROCESS | 7195 | |10;stanford-crypto-aes;80;88;80;80;80;80;88;81;83;81 00:39:16 INFO - PROCESS | 7195 | |11;stanford-crypto-ccm;134;140;128;125;129;126;134;126;172;127 00:39:16 INFO - PROCESS | 7195 | |12;stanford-crypto-pbkdf2;166;163;160;166;165;168;162;167;161;164 00:39:16 INFO - PROCESS | 7195 | |13;stanford-crypto-sha256-iterative;66;66;66;66;64;66;70;66;63;65 00:39:16 INFO - PROCESS | 7195 | __end_tp_report 00:39:16 INFO - PROCESS | 7195 | __start_cc_report 00:39:16 INFO - PROCESS | 7195 | _x_x_mozilla_cycle_collect,789 00:39:16 INFO - PROCESS | 7195 | __end_cc_report 00:39:16 INFO - PROCESS | 7195 | __startTimestamp1474529956493__endTimestamp 00:39:16 INFO - PROCESS | 7195 | 00:39:16 INFO - PROCESS | 7195 | ------- Summary: start ------- 00:39:16 INFO - PROCESS | 7195 | Number of tests: 14 00:39:16 INFO - PROCESS | 7195 | 00:39:16 INFO - PROCESS | 7195 | [#0] ai-astar Cycles:10 Average:111.00 Median:111.00 stddev:1.56 (1.4%) stddev-sans-first:0.73 00:39:16 INFO - PROCESS | 7195 | Values: 107.0 113.0 112.0 112.0 111.0 111.0 111.0 111.0 111.0 111.0 00:39:16 INFO - PROCESS | 7195 | 00:39:16 INFO - PROCESS | 7195 | [#1] audio-beat-detection Cycles:10 Average:132.80 Median:125.00 stddev:18.77 (15.0%) stddev-sans-first:17.75 00:39:16 INFO - PROCESS | 7195 | Values: 157.0 119.0 120.0 171.0 121.0 121.0 124.0 121.0 148.0 126.0 00:39:16 INFO - PROCESS | 7195 | 00:39:16 INFO - PROCESS | 7195 | [#2] audio-dft Cycles:10 Average:163.60 Median:163.50 stddev:1.58 (1.0%) stddev-sans-first:1.66 00:39:16 INFO - PROCESS | 7195 | Values: 163.0 163.0 163.0 164.0 166.0 165.0 162.0 166.0 162.0 162.0 00:39:16 INFO - PROCESS | 7195 | 00:39:16 INFO - PROCESS | 7195 | [#3] audio-fft Cycles:10 Average:83.50 Median:77.00 stddev:13.66 (17.7%) stddev-sans-first:14.45 00:39:16 INFO - PROCESS | 7195 | Values: 81.0 77.0 77.0 117.0 76.0 77.0 77.0 77.0 99.0 77.0 00:39:16 INFO - PROCESS | 7195 | 00:39:16 INFO - PROCESS | 7195 | [#4] audio-oscillator Cycles:10 Average:91.40 Median:83.00 stddev:14.17 (17.1%) stddev-sans-first:14.61 00:39:16 INFO - PROCESS | 7195 | Values: 82.0 82.0 122.0 83.0 83.0 84.0 102.0 84.0 84.0 108.0 00:39:16 INFO - PROCESS | 7195 | 00:39:16 INFO - PROCESS | 7195 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.67 (0.6%) stddev-sans-first:0.67 00:39:16 INFO - PROCESS | 7195 | Values: 117.0 118.0 118.0 117.0 117.0 117.0 119.0 118.0 118.0 118.0 00:39:16 INFO - PROCESS | 7195 | 00:39:16 INFO - PROCESS | 7195 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:148.00 stddev:0.82 (0.6%) stddev-sans-first:0.83 00:39:16 INFO - PROCESS | 7195 | Values: 148.0 147.0 148.0 147.0 146.0 147.0 146.0 148.0 148.0 148.0 00:39:16 INFO - PROCESS | 7195 | 00:39:16 INFO - PROCESS | 7195 | [#7] imaging-desaturate Cycles:10 Average:97.10 Median:96.00 stddev:4.23 (4.4%) stddev-sans-first:4.47 00:39:16 INFO - PROCESS | 7195 | Values: 96.0 109.0 96.0 96.0 97.0 95.0 95.0 96.0 96.0 95.0 00:39:16 INFO - PROCESS | 7195 | 00:39:16 INFO - PROCESS | 7195 | [#8] json-parse-financial Cycles:10 Average:53.00 Median:54.00 stddev:1.25 (2.3%) stddev-sans-first:1.09 00:39:16 INFO - PROCESS | 7195 | Values: 51.0 52.0 53.0 51.0 54.0 54.0 54.0 54.0 53.0 54.0 00:39:16 INFO - PROCESS | 7195 | 00:39:16 INFO - PROCESS | 7195 | [#9] json-stringify-tinderbox Cycles:10 Average:62.10 Median:62.00 stddev:1.37 (2.2%) stddev-sans-first:1.45 00:39:16 INFO - PROCESS | 7195 | Values: 62.0 61.0 64.0 62.0 61.0 62.0 62.0 61.0 61.0 65.0 00:39:16 INFO - PROCESS | 7195 | 00:39:16 INFO - PROCESS | 7195 | [#10] stanford-crypto-aes Cycles:10 Average:82.10 Median:81.00 stddev:3.25 (4.0%) stddev-sans-first:3.35 00:39:16 INFO - PROCESS | 7195 | Values: 80.0 88.0 80.0 80.0 80.0 80.0 88.0 81.0 83.0 81.0 00:39:16 INFO - PROCESS | 7195 | 00:39:16 INFO - PROCESS | 7195 | [#11] stanford-crypto-ccm Cycles:10 Average:134.10 Median:131.50 stddev:14.14 (10.8%) stddev-sans-first:15.00 00:39:16 INFO - PROCESS | 7195 | Values: 134.0 140.0 128.0 125.0 129.0 126.0 134.0 126.0 172.0 127.0 00:39:16 INFO - PROCESS | 7195 | 00:39:16 INFO - PROCESS | 7195 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.20 Median:165.50 stddev:2.66 (1.6%) stddev-sans-first:2.74 00:39:16 INFO - PROCESS | 7195 | Values: 166.0 163.0 160.0 166.0 165.0 168.0 162.0 167.0 161.0 164.0 00:39:16 INFO - PROCESS | 7195 | 00:39:16 INFO - PROCESS | 7195 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.80 Median:66.00 stddev:1.81 (2.7%) stddev-sans-first:1.92 00:39:16 INFO - PROCESS | 7195 | Values: 66.0 66.0 66.0 66.0 64.0 66.0 70.0 66.0 63.0 65.0 00:39:16 INFO - PROCESS | 7195 | -------- Summary: end -------- 00:39:16 INFO - PROCESS | 7195 | 00:39:16 INFO - PROCESS | 7195 | 00:39:16 INFO - PROCESS | 7195 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 00:39:16 INFO - PROCESS | 7195 | 00:39:16 INFO - PROCESS | 7195 | 00:39:16 INFO - PROCESS | 7195 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 00:39:16 INFO - PROCESS | 7195 | 00:39:16 INFO - PROCESS | 7195 | 00:39:16 INFO - PROCESS | 7195 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 00:39:16 INFO - PROCESS | 7195 | 00:39:16 INFO - PROCESS | 7195 | 00:39:16 INFO - PROCESS | 7195 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x2000C,name=PAPZ::Msg_Destroy) Channel error: cannot send/recv 00:39:16 INFO - PROCESS | 7195 | 00:39:16 INFO - PROCESS | 7195 | 00:39:16 INFO - PROCESS | 7195 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 00:39:16 INFO - PROCESS | 7195 | 00:39:17 INFO - TEST-INFO | 7195: exit 0 00:39:17 INFO - TEST-OK | kraken | took 62170ms 00:39:17 INFO - SUITE-END | took 1175s 00:39:17 INFO - Completed test suite (00:19:35) 00:39:17 INFO - javascript benchmark 00:39:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7236.652793602079, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3026.25856665117, 3030.5454181872715, 3031.2118849099256, 3046.329807442362, 3050.389922015597, 5286.286351342567, 5353.437889021655, 5405.135178371452, 5406.83779486616, 5500.834974950748, 5287.814926477574, 5399.83800485986, 5410.377806552247, 5439.809606663767, 5508.586855985807, 4867.610591152717, 4941.135301322272, 4962.900741985158, 4993.201087825949, 5053.317802096725, 5024.673396229252, 5026.924596131061, 5079.288899554065, 5106.336176297076, 5121.0, 4716.198246298138, 4772.2125849234835, 4870.147724148295, 4882.902341953177, 4987.900241995158, 4903.2645103234445, 4916.090523253174, 4939.407271127452, 4950.801967921278, 4973.254011898208, 4857.587105096071, 4893.314935908976, 4906.607471402315, 4913.754312284372, 4932.975335123338, 5239.738013099368, 5278.313819203479, 5365.222042803772, 5412.648177868426, 5443.5100840924115, 5808.506276966463, 5854.882902341929, 5855.531557475391, 5904.468597826216, 5913.024350982083, 5878.118282257653, 5884.823455296348, 5894.8821023579285, 5895.705214739289, 5901.793437229677, 5228.058949389147, 5258.605604579672, 5463.098588732854, 5470.452954704538, 5479.917801232985, 5773.191753154478, 5778.5377169826315, 5812.418758124154, 5842.357340692521, 5903.439173278532, 5539.584531160179, 5571.526420254243, 5584.91622625661, 5585.944140558624, 5587.972060139673, 5541.944580554224, 5585.748641311069, 5609.579281553818, 5673.149027645886, 5673.971630141823, 5745.195672605839, 5785.595008349375, 5786.681732504669, 5807.0, 5879.853003674857, 5794.565407594448, 5806.796762113306, 5824.417558244142, 5826.621269617546, 5831.3877042910735, 4277.807498662505, 4443.466783985942, 4453.710508816916, 4457.576530229688, 4512.2554778461845, 3847.115163512408, 3927.489426374553, 3957.0700885291935, 3979.303621866162, 4041.8989525261513, 5528.668279903219, 5562.638428502134, 5575.944240557543, 5593.636413633101, 5605.943940560543, 5832.154337621021, 5879.764809407661, 5901.3213480450295, 5904.4685978261305, 5968.8806223876145, 5385.703786291713, 5390.568754499631, 5449.04641687703, 5480.451954804487, 5509.338879334426, 5029.119904016856, 5034.0686972910125, 5038.470960549163, 5041.773120209599, 5090.872728181825, 5998.88002239944, 6045.486133678686, 6050.183225264621, 6053.152558641794, 6064.090386442069, 5507.284053073236, 5559.777608895599, 5715.914261286167, 5742.253507044057, 5878.94121058801, 6013.128096426081, 6017.638941663514, 6019.879602408015, 6047.78832740852, 6067.544934130046, 5585.497305242548, 5676.148577713376, 5677.971610141923, 5681.460261275172, 5688.601797874109, 5687.151675705495, 5692.373838877637, 5717.256756621613, 5745.770169193353, 5805.245318108618, 5574.247476590771, 5663.631863928831, 5664.26364572603, 5731.541476681772, 5735.168400581976, 5575.330960284792, 5616.915746263728, 5624.184493248375, 5633.3521645009705, 5634.070378387684, 5439.918401223906, 5512.586556008396, 5540.473655002768, 5569.66582005081, 5581.748821303132, 5614.943850561605, 5654.293213348332, 5659.094544872801, 5680.346760122638, 5697.230873832145, 5443.755031023535, 5542.11326187808, 5542.445755424425, 5554.861128471821, 5564.8330550083565], "value": 5325.985245402177, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [534.4601952028453, 569.8034178208517, 573.2576313673793, 587.5475883569653, 588.5350573047293, 32636.510452343235, 42506.574934250646, 43979.78010109945, 44009.11981760363, 44136.77931610338, 44536.10927781442, 44575.0, 44758.77620611892, 44898.55101448984, 45239.77380113095, 8988.910110898889, 9106.908930910706, 9115.908840911605, 9120.635174593008, 9125.087491250888, 8947.910520894773, 8983.820323593556, 9014.729558113268, 9018.233450156744, 9046.050164732707, 8858.114188581154, 8864.069272726367, 8870.37907346486, 8888.600012999399, 8889.533227017535, 8994.550272486415, 9026.50354230517, 9031.412958157698, 9066.410683305565, 9088.318376121784, 8926.0, 9002.459852408876, 9025.277977761829, 9032.367734258605, 9047.411918225294, 43331.35002974958, 43432.0, 43600.56399436029, 43746.12507749827, 43797.78101109474, 3451.447768357076, 3549.112721819545, 3588.318219538279, 3939.546952100488, 4058.9594104059174, 32135.357292854012, 32253.0, 32443.351132977208, 32446.513302300486, 32789.508157377655, 3996.580359062286, 4088.3049881520215, 4171.124063946575, 4279.614834664864, 4304.289792184286, 324201.0, 324290.0, 324572.0, 324958.9999999976, 324966.0, 32290.515642265385, 33688.1577960548, 57970.4202957965, 58364.41635583675, 58467.41532584705, 37415.62584374176, 37701.24597508089, 37857.43213851794, 37922.81038594845, 37933.43099853504, 15224.162671053198, 15322.846771532142, 15325.080495170325, 15380.769288460682, 15500.379984800482, 11787.646370608896, 11829.053675705924, 11839.052875769918, 11849.348285844362, 11889.940550297193, 8580.528070956032, 8588.098249683819, 8682.78293042679, 8746.912530874737, 8754.21212090915, 3392.592888853304, 3394.6096198936943, 3404.982975085158, 3436.6278462372943, 3493.161641206143, 985.1084768284713, 990.7225976726528, 994.1500017485091, 1007.5818535307765, 1081.259337353915, 32056.83971580174, 32876.17809554732, 33604.1598960028, 33669.831650842076, 35641.10897227538, 1113.2485572238706, 1125.431657013203, 1148.9827652585218, 1156.3986726901965, 1173.5833779008328, 16878.0, 17046.260855660854, 17155.142242887807, 17169.31322747101, 17198.31206751741, 525505.0, 528496.0, 530417.0, 530895.0, 531304.0, 58691.70654146702, 59392.40607593955, 59533.0, 59579.702101489216, 59663.40336596579, 1327.3628658244097, 1387.1746310944973, 1388.6667199871958, 1393.9303034848217, 1397.9720405592034, 30507.847460762554, 31307.686923130477, 31603.36793264076, 31899.202519937186, 32690.182745430604, 51213.74393128011, 52138.47861521488, 52151.0, 52425.213621796465, 52450.21324680209, 472323.0, 475266.0, 476066.0, 476340.0, 477638.0, 28814.0, 28925.513359232304, 29182.854085729436, 29192.854035730536, 29209.70790292155, 47024.529754703384, 47864.282035768796, 48274.75862620665, 48442.0, 48788.26817597668, 40164.59835401609, 41054.178916420904, 41153.38269926013, 41318.79340603398, 43159.78420107879, 41424.58575414207, 41733.0, 41880.3717944225, 42247.57752422559, 42570.787146064074, 41589.0, 43403.13193736171, 44191.779041104586, 44638.330425043, 44918.550814492744, 33515.329693406486, 36492.27015459729, 37202.8139859299, 37340.446749101866, 37573.87278381653, 28016.15951521376, 28237.90774479623, 28404.289892752848, 28749.71250287554, 28764.56853147246], "value": 19001.190466010437, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [401.5081525131714, 404.2662567440098, 405.7747949887812, 407.77572335215643, 425.9701820872538, 15972.361105555792, 16237.83762162378, 17809.0, 19450.221991120357, 19463.805361946357, 18164.63670726588, 19014.90492547535, 19121.043947802587, 19390.515237119078, 19611.607767844635, 5138.177891537355, 5350.839474815762, 5635.408282130379, 5862.443067908542, 5875.76496940124, 5817.505512031483, 5867.383924687911, 5869.2369991901205, 5921.230240068785, 5938.287405511344, 5774.480296773289, 5938.524918006549, 5949.375315591866, 5957.970210148943, 5962.195103661015, 5933.345983681046, 5942.465178133967, 5942.851428714295, 5976.850578735544, 6023.427774361428, 5562.249096372019, 5789.392113828029, 5798.188253644493, 5804.477597016246, 5808.128780682931, 13151.145175563557, 14701.0, 22257.109715611357, 22763.861806909754, 22942.885285573466, 2271.1369679521677, 2274.7042884425086, 2377.2511658827416, 2423.333583264599, 2763.392053748172, 9823.90176098237, 10245.104655638655, 10373.84439233412, 11967.341796201206, 14640.267986600735, 1901.610169915164, 1958.0992743338081, 1981.296639692917, 1986.5629561496448, 1997.9001049947444, 85781.14218857794, 85924.57037714896, 87325.0, 88850.3362247834, 90363.0, 10952.288101273392, 11088.833667494993, 11212.551497940154, 11259.887401125883, 11338.092952563775, 15701.842981570266, 15762.448314308944, 15777.0533767972, 15808.60478488024, 15867.365305387886, 7760.30157285847, 7888.487248328955, 8110.31062359706, 8134.267915887599, 8223.876641850376, 7501.174870764212, 7549.358304544176, 7717.151113377524, 7762.650680719381, 7780.14418413974, 4542.704724192917, 4573.588377046081, 4610.017692392304, 4787.40157480315, 4820.783064762094, 1855.7680289963755, 1943.6015616798522, 1954.7556555430572, 1995.7704863940542, 2002.5193953451358, 902.2826852652157, 949.9335046546813, 964.3153361113688, 1016.1718199667248, 1065.3607835298758, 19565.21739130447, 19621.705674414894, 19721.309754158534, 19884.90057549703, 19929.302474413325, 995.5072239241478, 1020.5968642386216, 1022.5551884930079, 1039.620538503456, 1065.5950738719237, 10467.738306542398, 11051.834222486508, 11070.501827417624, 11091.168162387854, 11092.722681933015, 446101.0, 453581.0, 454951.0, 456208.0, 457906.0, 82544.58727706443, 83799.16200838036, 87837.0, 89584.0, 93435.53282233546, 990.5443495991924, 1038.200585549123, 1050.9894901051046, 1057.2387880725864, 1065.8188108021654, 16948.661026779148, 17140.828591713922, 17441.215145318238, 17622.64754704873, 17926.103694814945, 40811.59188408078, 41530.584694153884, 42474.36288455614, 42740.0, 42824.0, 55352.44647553473, 57279.71360143173, 57438.0, 57734.422655774586, 58171.0, 7556.546607203585, 7687.502186505239, 7840.059192896889, 7887.487313324616, 8029.678812847655, 11366.0, 13472.461101555828, 13587.184768913898, 13759.10565813219, 13977.371018303997, 11560.190786644855, 11742.236754610924, 11764.235324703866, 12020.398980051137, 12040.0, 11498.25261358009, 11635.709107272385, 11654.883451165719, 11846.703832404259, 12387.0, 11922.761544768882, 11961.282323060645, 12180.0, 12190.329531875832, 12649.620511384674, 7738.961305193438, 7928.365730741642, 8034.919650803417, 8202.425830192067, 8390.0, 10308.484575771032, 11614.70963225926, 11829.940850295694, 12423.378831058591, 12450.626481205578], "value": 9212.722724730556, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1467.963300917477, 1503.8571335723104, 1649.851513363797, 1800.6488734696738, 1816.6820806358892, 7884.093329267136, 8140.063892652347, 8560.357973152008, 9098.63605455781, 9197.310201734872, 8512.616932238048, 8787.560621968907, 8809.075047120055, 9023.18791308782, 9052.502112383816, 2422.152246713645, 2444.511097780442, 2450.534398464295, 2450.791682706972, 2453.717822450414, 2363.917262895799, 2368.8578685278853, 2379.583572874749, 2390.7728765767224, 2403.843750156243, 2388.9283321500384, 2427.0655797517907, 2435.0, 2458.5820410530255, 2462.273629279358, 2373.7270213925362, 2387.140629373424, 2390.0081466191596, 2415.6376543518436, 2441.0235905637887, 2307.1694190091553, 2329.8369114162015, 2331.6968794056834, 2338.754430784777, 2348.072511358004, 9081.954590227007, 9131.26949844011, 9148.130927561871, 9153.221976132038, 9158.633654653806, 5172.27588137661, 5189.455107213726, 5214.8174813881715, 5238.528532432099, 5261.263423120728, 3072.2165847708916, 3267.836608169606, 3276.918077048069, 3277.5083737439336, 3358.630550639428, 1021.0861279155189, 1021.2442792333619, 1023.518946095334, 1065.6110519660267, 1100.114407901639, 12410.131290809646, 12431.564895228623, 12518.186317889307, 12540.24758514492, 12543.24740515572, 4419.226635338803, 4599.195140850338, 4700.08348372071, 4707.7881495332795, 4715.83494577695, 10432.5826966922, 10553.947230263799, 10619.469026548642, 10633.361998280128, 10637.9468102659, 5289.735513224324, 5303.337082864642, 5309.840704778863, 5310.734463276821, 5335.119705248668, 4674.883127921829, 4786.976065119652, 4831.855044348676, 4835.95164048355, 4884.609231261491, 3964.2467931093, 4072.3687828386646, 4146.315857883415, 4146.357314616239, 4211.220924129046, 1317.3610798762784, 1327.741090487365, 1331.7203387288585, 1331.993340033313, 1334.2461509247244, 899.9145081217274, 945.6406565505064, 956.8947415784259, 971.3249291742171, 985.1478471122427, 5949.702514874239, 5970.910436343458, 6000.159977603139, 6016.849578760566, 6060.2424696912885, 453.8479609330845, 459.34543275832476, 462.4889497105717, 463.88402899275184, 466.7199680191858, 3897.2984862724984, 4002.079521709965, 4028.8388464461677, 4081.163361510883, 4104.91790164195, 10693.304935179189, 11059.115270778319, 11080.168987325982, 11087.113030957504, 11097.001269885588, 10988.285761425483, 10990.890091099147, 11003.724906877233, 11010.0, 11049.834252486218, 8161.306288965505, 8191.754247372588, 8209.8358032839, 8212.671493140328, 8287.668493260322, 5966.910496342645, 6089.69551522431, 6130.831466701124, 6153.3538978408415, 6158.107074474266, 9810.950945245228, 9936.503174841373, 9948.900510994798, 10010.549525271526, 10129.544170512492, 10141.442220677933, 10230.567720518984, 10244.129249013917, 10269.948650257, 10382.11752001058, 7660.157382687788, 7861.646225919962, 7919.406044546567, 7922.405819563441, 7991.400644951768, 8701.782455438664, 8712.78218044554, 8729.869051964099, 8739.43193692408, 8779.956100219459, 7570.659320330488, 7703.345215656732, 7717.614119294125, 7962.402819788424, 8013.6794528218215, 7068.646567671699, 7231.4214862811905, 7284.089488813898, 7305.159906610807, 7522.0, 6895.827604309932, 7005.509614327152, 7008.159020917523, 7013.263607321362, 7026.262242464468, 4951.3810773653295, 5100.974495127501, 5188.584913206859, 5248.317718696698, 5290.127129023668, 5047.066292735855, 5178.559822414986, 5217.713025783618, 5223.45153758865, 5375.274337964324], "value": 4588.25589335009, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [324.4792108665592, 324.59425717852685, 329.8202479648591, 333.35495815596806, 335.59728326008764, 5516.586256030799, 5540.418256083109, 5570.164475328703, 5573.331200255965, 5648.774049038038, 5417.133258678612, 5428.267183930168, 5453.182022696597, 5462.0, 5506.64206826557, 4060.654844338235, 4070.9185816283657, 4158.293090174678, 4268.743875367472, 4284.464441944757, 4266.679999000072, 4271.0, 4288.9785551072355, 4318.244307246235, 4329.307310830268, 4231.344141658048, 4237.194932962727, 4249.405083288327, 4252.468441444819, 4280.6361459275995, 3989.4015897615445, 4194.580541945811, 4238.321868501025, 4253.787310634456, 4289.313709806432, 3702.0929872181487, 3710.9257814843554, 3719.5350581177354, 3719.851205951759, 3722.7394082414244, 5305.867353316198, 5349.598780091509, 5383.300170977748, 5399.9730001350135, 5427.402985671573, 4579.702319349231, 4805.183118869765, 4822.517748225185, 4852.0, 4856.0, 5637.393342897296, 5643.717814109319, 5664.660120392789, 5706.914396284059, 5750.971245143789, 4023.6378725914515, 4030.234255491447, 4057.742099949025, 4061.3704875744306, 4081.8979525511804, 5926.525877929798, 5927.0, 5931.73307201177, 6035.909461358083, 6063.393660633946, 4139.406328563525, 4142.06803469217, 4145.2124096421585, 4184.539700632928, 4192.161567686475, 4227.704060715781, 4248.426462427595, 4249.7237679551345, 4263.253930562139, 4263.957360426356, 4749.962680997136, 4813.3983252093485, 4834.486067245083, 4876.244182151772, 4880.902381952341, 5677.971610141923, 5713.428657134254, 5721.39925307845, 5726.341470730836, 5745.368009518949, 1431.1270125223605, 1453.7019910918236, 1455.8762505187178, 1456.4247122386598, 1457.9125252484885, 879.6261588824724, 886.2112719679491, 928.4846909965034, 950.9239260859115, 951.1629765806047, 5475.479829416199, 5504.339479262434, 5505.559555235572, 5527.723613819373, 5551.9722401387735, 5822.0, 5828.0966450200285, 5833.183354330397, 5835.570285280133, 5858.882822343615, 5383.950129724744, 5397.758515541447, 5416.9729151353995, 5460.535854452416, 5524.972375138099, 3060.7398371138256, 3076.2616971927023, 3077.8461076946064, 3112.750979921601, 3127.702868227515, 5794.942050579524, 5923.940760592425, 6091.878162436727, 6121.908171377433, 6130.938690613126, 5989.31122920861, 6075.301340345917, 6104.572679912363, 6124.7538804433725, 6128.295246046761, 6225.844353891189, 6225.937740622627, 6233.506597361001, 6262.68686565679, 6317.557770955989, 5669.971650141723, 5923.216088438427, 5930.584859059824, 5984.551158663031, 5988.161657368059, 5902.1736956826935, 5915.201447804491, 5923.200367950271, 5946.464818166212, 5950.940490595039, 5886.705664716661, 6129.417705317987, 6203.720832562636, 6216.53375996793, 6248.250209974832, 4162.916741665089, 4186.204621121977, 4188.5811418857875, 4190.476190476191, 4209.515905670887, 5956.493698035715, 5961.552883533665, 5995.0, 6009.489193418608, 6025.758969641165, 5652.959513928988, 5796.101604251347, 5804.564657650778, 5853.122031695109, 5884.58807883444, 5813.476787089182, 5834.599696072827, 5843.532517398513, 5845.620034697731, 5852.18069470266, 5418.266154830574, 5805.564582656402, 5807.564432667482, 5829.417058294137, 5864.472197502245, 5802.100674395476, 5835.649861008353, 5845.386234445492, 5858.384869588632, 5882.647041177372, 5665.093585026376, 5667.801626943037, 5701.344345400332, 5712.971435142964, 5730.71346432685], "value": 4374.2245193453555, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [740.563067790004, 757.3675980556235, 764.575660508418, 778.8247644280037, 823.5717426937989, 15219.162946037977, 16666.166691665414, 16826.579335516617, 16839.158042097908, 16919.830801691995, 15262.313195906183, 15364.231788410563, 15517.379304827793, 15563.922180389081, 15617.609559761011, 643.4209211709452, 663.0452148905584, 767.03736810303, 770.3067239484453, 789.4276649429147, 788.6529926832204, 790.8892755014302, 792.302773559267, 797.4696826610326, 797.6131576185545, 826.8139668574582, 827.4993628854546, 828.8135169586855, 836.9539675317885, 838.0655569040506, 814.6985615322369, 818.0755746007034, 821.7082935557851, 822.0382152881114, 828.5484410996022, 613.3284053960906, 613.5888954400518, 617.2438762515882, 618.7153909201772, 619.7118339971935, 15253.694926101527, 15454.227288635635, 15512.0, 15514.146721930289, 15598.532044038697, 15001.099934003885, 15046.924765376103, 15258.694826103527, 15456.381744730197, 15687.529374118794, 10947.124230061656, 11063.502142403611, 11070.225084244106, 11269.718257043558, 11782.528698852035, 3836.6547010769164, 3846.632206838582, 3946.546147193052, 3960.920781584352, 4073.5315438724333, 79035.0, 79042.20957790464, 79459.6027019867, 80273.0, 80571.19428805754, 10753.279475283916, 11153.330800152016, 11260.493277802518, 11334.433278336215, 11655.825162622568, 19464.416067517996, 20490.077946492147, 22835.657465138036, 22856.885715571316, 22947.19684811057, 8072.192780721881, 8311.088449656612, 8449.873251901226, 8495.447795893248, 8548.48709077445, 4744.501827308152, 4768.117898188846, 4817.542333478314, 4824.059308434892, 4844.636652251095, 3545.308664810337, 3618.81905904709, 3760.417135344026, 3774.735768496179, 3790.0714324990554, 644.754993102618, 645.319188256394, 653.9280679125293, 657.0669649098196, 666.7099811581977, 635.6980434293766, 655.7409823119937, 704.232386698501, 706.2937062937064, 711.8683043636944, 9375.682815883038, 9592.529288358815, 9753.512324383752, 9796.608135674636, 9961.153301969414, 646.5829539946708, 684.9896402805822, 691.312144416309, 698.441247002396, 736.0725485887713, 4882.340883980688, 4907.950920490749, 4910.729909854921, 5007.749612519432, 5087.771050302746, 90334.09665903388, 120107.0, 123997.0, 128546.35726821492, 129813.0, 106275.0, 111455.44272278587, 112409.0, 114316.42841785737, 114441.0, 90023.09976900279, 90377.0, 91251.54374228086, 92718.0, 95288.0, 8942.37403381757, 8962.417442866194, 9255.583498742439, 9513.809723805347, 9524.285678573997, 54642.0, 55053.0, 55600.0, 56117.71941140268, 56523.71738141283, 74451.0, 75604.62197688976, 83423.58288208763, 84368.57815711127, 86697.0, 11111.666650000512, 11203.751175975905, 12617.684557886127, 12826.358682066046, 12917.09580329368, 14083.507077252247, 14361.425542978583, 14380.0, 14545.272736362927, 15471.071735695894, 13986.510472133426, 14057.0, 14329.78505322442, 14385.28073596337, 14711.632209194855, 13482.955874958398, 13984.930075349557, 14019.088759230617, 14584.052036617586, 14754.704905902037, 13227.470901163846, 14373.496927607484, 14683.0, 14737.410503579737, 14777.25317175915, 11597.620129983787, 11780.70548236301, 11811.763764724828, 11919.642410727693, 11965.880341196476, 9936.672709662827, 10357.896421035693, 10789.40658263803, 11263.549458021587, 12407.813882791585], "value": 7674.798286520896, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1505.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 113.0, 112.0, 112.0, 111.0, 111.0, 111.0, 111.0, 111.0, 111.0], "value": 111.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 119.0, 120.0, 171.0, 121.0, 121.0, 124.0, 121.0, 148.0, 126.0], "value": 132.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 163.0, 164.0, 166.0, 165.0, 162.0, 166.0, 162.0, 162.0], "value": 163.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 77.0, 77.0, 117.0, 76.0, 77.0, 77.0, 77.0, 99.0, 77.0], "value": 83.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 122.0, 83.0, 83.0, 84.0, 102.0, 84.0, 84.0, 108.0], "value": 91.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 117.0, 117.0, 117.0, 119.0, 118.0, 118.0, 118.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 148.0, 147.0, 146.0, 147.0, 146.0, 148.0, 148.0, 148.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 109.0, 96.0, 96.0, 97.0, 95.0, 95.0, 96.0, 96.0, 95.0], "value": 97.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 52.0, 53.0, 51.0, 54.0, 54.0, 54.0, 54.0, 53.0, 54.0], "value": 53.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 64.0, 62.0, 61.0, 62.0, 62.0, 61.0, 61.0, 65.0], "value": 62.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 88.0, 80.0, 80.0, 80.0, 80.0, 88.0, 81.0, 83.0, 81.0], "value": 82.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 140.0, 128.0, 125.0, 129.0, 126.0, 134.0, 126.0, 172.0, 127.0], "value": 134.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 163.0, 160.0, 166.0, 165.0, 168.0, 162.0, 167.0, 161.0, 164.0], "value": 164.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 66.0, 64.0, 66.0, 70.0, 66.0, 63.0, 65.0], "value": 65.8, "unit": "score"}]}]} 00:39:17 INFO - Return code: 0 00:39:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 00:39:17 ERROR - # TBPL SUCCESS # 00:39:17 INFO - Running post-action listener: _resource_record_post_action 00:39:17 INFO - [mozharness: 2016-09-22 07:39:17.785729Z] Finished run-tests step (success) 00:39:17 INFO - Running post-run listener: _resource_record_post_run 00:39:17 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 8192; Write bytes: 393990144; Read time: 192; Write time: 319204 00:39:17 INFO - TinderboxPrint: CPU usage
13.4% 00:39:17 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 192 00:39:17 INFO - TinderboxPrint: I/O write bytes / time
393,990,144 / 319,204 00:39:17 INFO - TinderboxPrint: CPU idle
8,241.3 (86.6%) 00:39:17 INFO - TinderboxPrint: CPU user
1,212.6 (12.7%) 00:39:17 INFO - TinderboxPrint: Swap in / out
0 / 0 00:39:17 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 106688512; Read time: 0; Write time: 107428 00:39:17 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 287301632; Read time: 188; Write time: 211776 00:39:18 INFO - Running post-run listener: _upload_blobber_files 00:39:18 INFO - Blob upload gear active. 00:39:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:39:18 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 00:39:18 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', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 00:39:18 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 Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 00:39:18 INFO - (blobuploader) - INFO - Open directory for files ... 00:39:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 00:39:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:39:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:39:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 00:39:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:39:19 INFO - (blobuploader) - INFO - Done attempting. 00:39:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 00:39:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:39:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:39:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 00:39:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:39:23 INFO - (blobuploader) - INFO - Done attempting. 00:39:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 00:39:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:39:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:39:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 00:39:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:39:24 INFO - (blobuploader) - INFO - Done attempting. 00:39:24 INFO - (blobuploader) - INFO - Iteration through files over. 00:39:24 INFO - Return code: 0 00:39:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:39:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:39:24 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/3279cc9a0a538675b3b50516af1ca4a5deb0e6efd11d255ece432057044defa145060f943926a589771507f6426d801e7938c0e9ee069a90ad01d1f5a99e8597", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/c8740a8a9c8b3a95cd10826301cb4d17ddd8b5092019830c3cacdeaa37014b3b5d7e124879fe22f4411badb6374df4b2766b8e339fc7f7e9aa182ae36a5a61a6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/34143fce1203c715ef9b6d9657b04b459794869ca6521ca1a168acd959348e74e3bce28fcda313c2155ff93427ea30315b876b76be4a664e146bfe49ce3404f9"} 00:39:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:39:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:39:24 INFO - Contents: 00:39:24 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/3279cc9a0a538675b3b50516af1ca4a5deb0e6efd11d255ece432057044defa145060f943926a589771507f6426d801e7938c0e9ee069a90ad01d1f5a99e8597", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/c8740a8a9c8b3a95cd10826301cb4d17ddd8b5092019830c3cacdeaa37014b3b5d7e124879fe22f4411badb6374df4b2766b8e339fc7f7e9aa182ae36a5a61a6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/34143fce1203c715ef9b6d9657b04b459794869ca6521ca1a168acd959348e74e3bce28fcda313c2155ff93427ea30315b876b76be4a664e146bfe49ce3404f9"} 00:39:24 INFO - Running post-run listener: copy_logs_to_upload_dir 00:39:24 INFO - Copying logs to upload dir... 00:39:24 INFO - mkdir: /builds/slave/test/build/upload/logs 00:39:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.056573 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-09-22 00:39:24.356680) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-22 00:39:24.362134) ========= 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=923d835db2ba3686ebe126b700000192-1474528727.23348-1798013729 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/Autoland/sha512/3279cc9a0a538675b3b50516af1ca4a5deb0e6efd11d255ece432057044defa145060f943926a589771507f6426d801e7938c0e9ee069a90ad01d1f5a99e8597", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/c8740a8a9c8b3a95cd10826301cb4d17ddd8b5092019830c3cacdeaa37014b3b5d7e124879fe22f4411badb6374df4b2766b8e339fc7f7e9aa182ae36a5a61a6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/34143fce1203c715ef9b6d9657b04b459794869ca6521ca1a168acd959348e74e3bce28fcda313c2155ff93427ea30315b876b76be4a664e146bfe49ce3404f9"} build_url:https://queue.taskcluster.net/v1/task/YR5hGCoQR2OgnI19DYIPVw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011363 build_url: 'https://queue.taskcluster.net/v1/task/YR5hGCoQR2OgnI19DYIPVw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/3279cc9a0a538675b3b50516af1ca4a5deb0e6efd11d255ece432057044defa145060f943926a589771507f6426d801e7938c0e9ee069a90ad01d1f5a99e8597", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/c8740a8a9c8b3a95cd10826301cb4d17ddd8b5092019830c3cacdeaa37014b3b5d7e124879fe22f4411badb6374df4b2766b8e339fc7f7e9aa182ae36a5a61a6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/34143fce1203c715ef9b6d9657b04b459794869ca6521ca1a168acd959348e74e3bce28fcda313c2155ff93427ea30315b876b76be4a664e146bfe49ce3404f9"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-22 00:39:24.392660) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 00:39:24.393395) ========= 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=923d835db2ba3686ebe126b700000192-1474528727.23348-1798013729 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004456 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 00:39:24.476346) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-22 00:39:24.477054) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-22 00:39:24.477702) ========= ========= Total master_lag: 0.18 =========