builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-012 starttime: 1469023778.61 results: success (0) buildid: 20160720043044 builduid: d47e0a09cbe344e09f6986b39c6d9b17 revision: ed8e23b5e0c7b739e61173bb180cf3410a306679 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-20 07:09:38.614460) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-20 07:09:38.614924) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-20 07:09:38.615211) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-20 07:09:38.630841) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 07:09:38.631156) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1469023634.341069-206537822 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-20 07:09:38-- 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% 113M=0s 2016-07-20 07:09:38 (113 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.098558 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 07:09:38.743515) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 07:09:38.743831) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1469023634.341069-206537822 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014927 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 07:09:38.794393) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 07:09:38.794742) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ed8e23b5e0c7b739e61173bb180cf3410a306679 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev ed8e23b5e0c7b739e61173bb180cf3410a306679 --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=2c5dd2b0a310ecf02fd87158000001b4-1469023634.341069-206537822 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-20 07:09:38,903 truncating revision to first 12 chars 2016-07-20 07:09:38,903 Setting DEBUG logging. 2016-07-20 07:09:38,903 attempt 1/10 2016-07-20 07:09:38,903 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ed8e23b5e0c7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-20 07:09:39,198 unpacking tar archive at: mozilla-central-ed8e23b5e0c7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.593806 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 07:09:39.402639) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-20 07:09:39.402963) ========= script_repo_revision: ed8e23b5e0c7b739e61173bb180cf3410a306679 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-20 07:09:39.403377) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-20 07:09:39.403655) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-20 07:09:39.414775) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-07-20 07:09:39.415040) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=2c5dd2b0a310ecf02fd87158000001b4-1469023634.341069-206537822 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:09:39 INFO - MultiFileLogger online at 20160720 07:09:39 in /builds/slave/test 07:09:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 07:09:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:09:39 INFO - {'append_to_log': False, 07:09:39 INFO - 'base_work_dir': '/builds/slave/test', 07:09:39 INFO - 'blob_upload_branch': 'Firefox', 07:09:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:09:39 INFO - 'branch': 'Firefox', 07:09:39 INFO - 'buildbot_json_path': 'buildprops.json', 07:09:39 INFO - 'config_files': ('talos/linux_config.py',), 07:09:39 INFO - 'default_actions': ('clobber', 07:09:39 INFO - 'read-buildbot-config', 07:09:39 INFO - 'download-and-extract', 07:09:39 INFO - 'populate-webroot', 07:09:39 INFO - 'create-virtualenv', 07:09:39 INFO - 'install', 07:09:39 INFO - 'run-tests'), 07:09:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:09:39 INFO - 'download_minidump_stackwalk': True, 07:09:39 INFO - 'download_symbols': 'ondemand', 07:09:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:09:39 INFO - 'tooltool.py': '/tools/tooltool.py', 07:09:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:09:39 INFO - '/tools/misc-python/virtualenv.py')}, 07:09:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:09:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:09:39 INFO - 'installer_path': 'installer.exe', 07:09:39 INFO - 'log_level': 'info', 07:09:39 INFO - 'log_name': 'talos', 07:09:39 INFO - 'log_to_console': True, 07:09:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:09:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:09:39 INFO - 'opt_config_files': (), 07:09:39 INFO - 'pip_index': False, 07:09:39 INFO - 'sps_profile': False, 07:09:39 INFO - 'sps_profile_interval': 0, 07:09:39 INFO - 'suite': 'dromaeojs-e10s', 07:09:39 INFO - 'system_bits': '32', 07:09:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:09:39 INFO - 'title': 'talos-linux64-ix-012', 07:09:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:09:39 INFO - 'use_talos_json': True, 07:09:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:09:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:09:39 INFO - 'work_dir': 'build'} 07:09:39 INFO - [mozharness: 2016-07-20 14:09:39.614154Z] Running clobber step. 07:09:39 INFO - Running pre-action listener: _resource_record_pre_action 07:09:39 INFO - Running main action method: clobber 07:09:39 INFO - rmtree: /builds/slave/test/build 07:09:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:09:40 INFO - Running post-action listener: _resource_record_post_action 07:09:40 INFO - [mozharness: 2016-07-20 14:09:40.081119Z] Finished clobber step (success) 07:09:40 INFO - [mozharness: 2016-07-20 14:09:40.081220Z] Running read-buildbot-config step. 07:09:40 INFO - Running pre-action listener: _resource_record_pre_action 07:09:40 INFO - Running main action method: read_buildbot_config 07:09:40 INFO - Using buildbot properties: 07:09:40 INFO - { 07:09:40 INFO - "project": "", 07:09:40 INFO - "product": "firefox", 07:09:40 INFO - "script_repo_revision": "production", 07:09:40 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 07:09:40 INFO - "repository": "", 07:09:40 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 07:09:40 INFO - "buildid": "20160720043044", 07:09:40 INFO - "pgo_build": "True", 07:09:40 INFO - "basedir": "/builds/slave/test", 07:09:40 INFO - "buildnumber": 12, 07:09:40 INFO - "slavename": "talos-linux64-ix-012", 07:09:40 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:09:40 INFO - "platform": "ubuntu64_hw", 07:09:40 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 07:09:40 INFO - "branch": "mozilla-central", 07:09:40 INFO - "repo_path": "mozilla-central", 07:09:40 INFO - "revision": "ed8e23b5e0c7b739e61173bb180cf3410a306679", 07:09:40 INFO - "stage_platform": "linux64-pgo", 07:09:40 INFO - "builduid": "d47e0a09cbe344e09f6986b39c6d9b17", 07:09:40 INFO - "slavebuilddir": "test" 07:09:40 INFO - } 07:09:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/JoYT_1EmSrK2PVMprcN4OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 07:09:40 INFO - Running post-action listener: _resource_record_post_action 07:09:40 INFO - [mozharness: 2016-07-20 14:09:40.083675Z] Finished read-buildbot-config step (success) 07:09:40 INFO - [mozharness: 2016-07-20 14:09:40.083763Z] Running download-and-extract step. 07:09:40 INFO - Running pre-action listener: _resource_record_pre_action 07:09:40 INFO - Running main action method: download_and_extract 07:09:40 INFO - mkdir: /builds/slave/test/build/tests 07:09:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:40 INFO - https://queue.taskcluster.net/v1/task/JoYT_1EmSrK2PVMprcN4OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:09:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JoYT_1EmSrK2PVMprcN4OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:09:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JoYT_1EmSrK2PVMprcN4OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:09:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JoYT_1EmSrK2PVMprcN4OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:09:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JoYT_1EmSrK2PVMprcN4OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 07:09:40 INFO - Downloaded 1361 bytes. 07:09:40 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:09:40 INFO - Using the following test package requirements: 07:09:40 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:09:40 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:09:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:09:40 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:09:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:09:40 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:09:40 INFO - u'jsshell-linux-x86_64.zip'], 07:09:40 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:09:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:09:40 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:09:40 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:09:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:09:40 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:09:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:09:40 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:09:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:09:40 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:09:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:09:40 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:09:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:40 INFO - https://queue.taskcluster.net/v1/task/JoYT_1EmSrK2PVMprcN4OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:09:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JoYT_1EmSrK2PVMprcN4OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:09:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JoYT_1EmSrK2PVMprcN4OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:09:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JoYT_1EmSrK2PVMprcN4OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:09:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JoYT_1EmSrK2PVMprcN4OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:09:41 INFO - Downloaded 24343549 bytes. 07:09:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:09:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:09:43 INFO - Return code: 0 07:09:43 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:09:43 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:43 INFO - https://queue.taskcluster.net/v1/task/JoYT_1EmSrK2PVMprcN4OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:09:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JoYT_1EmSrK2PVMprcN4OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:09:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JoYT_1EmSrK2PVMprcN4OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:09:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JoYT_1EmSrK2PVMprcN4OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:09:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JoYT_1EmSrK2PVMprcN4OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:09:45 INFO - Downloaded 24343549 bytes. 07:09:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:09:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:09:46 INFO - Return code: 0 07:09:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:46 INFO - https://queue.taskcluster.net/v1/task/JoYT_1EmSrK2PVMprcN4OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:09:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JoYT_1EmSrK2PVMprcN4OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:09:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JoYT_1EmSrK2PVMprcN4OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:09:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JoYT_1EmSrK2PVMprcN4OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:09:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JoYT_1EmSrK2PVMprcN4OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:09:47 INFO - Downloaded 14403317 bytes. 07:09:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:09:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 07:09:48 INFO - Return code: 0 07:09:48 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:48 INFO - https://queue.taskcluster.net/v1/task/JoYT_1EmSrK2PVMprcN4OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:09:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JoYT_1EmSrK2PVMprcN4OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:09:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JoYT_1EmSrK2PVMprcN4OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:09:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JoYT_1EmSrK2PVMprcN4OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:09:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JoYT_1EmSrK2PVMprcN4OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:09:49 INFO - Downloaded 60899593 bytes. 07:09:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JoYT_1EmSrK2PVMprcN4OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:09:49 INFO - mkdir: /builds/slave/test/properties 07:09:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:09:49 INFO - Writing to file /builds/slave/test/properties/build_url 07:09:49 INFO - Contents: 07:09:49 INFO - build_url:https://queue.taskcluster.net/v1/task/JoYT_1EmSrK2PVMprcN4OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:09:50 INFO - Running post-action listener: _resource_record_post_action 07:09:50 INFO - Running post-action listener: set_extra_try_arguments 07:09:50 INFO - [mozharness: 2016-07-20 14:09:50.227430Z] Finished download-and-extract step (success) 07:09:50 INFO - [mozharness: 2016-07-20 14:09:50.227755Z] Running populate-webroot step. 07:09:50 INFO - Running pre-action listener: _resource_record_pre_action 07:09:50 INFO - Running main action method: populate_webroot 07:09:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:09:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:09:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:09:50 INFO - '--tppagecycles', 07:09:50 INFO - '7'], 07:09:50 INFO - 'tests': ['tsvgm']}}, 07:09:50 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:09:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:09:50 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:09:50 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:09:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:09:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:09:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:09:50 INFO - 'talos_options': ['--disable-e10s'], 07:09:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:09:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:09:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:09:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:09:50 INFO - 'talos_options': ['--disable-e10s'], 07:09:50 INFO - 'tests': ['damp', 'tps']}, 07:09:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:09:50 INFO - 'tests': ['damp', 'tps']}, 07:09:50 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:09:50 INFO - 'tests': ['dromaeo_dom']}, 07:09:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:09:50 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:09:50 INFO - 'tests': ['basic_compositor_video']}, 07:09:50 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:09:50 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:09:50 INFO - 'tests': ['a11yr', 07:09:50 INFO - 'ts_paint', 07:09:50 INFO - 'tpaint', 07:09:50 INFO - 'sessionrestore', 07:09:50 INFO - 'sessionrestore_no_auto_restore', 07:09:50 INFO - 'tabpaint']}, 07:09:50 INFO - 'other-e10s': {'tests': ['a11yr', 07:09:50 INFO - 'ts_paint', 07:09:50 INFO - 'tpaint', 07:09:50 INFO - 'sessionrestore', 07:09:50 INFO - 'sessionrestore_no_auto_restore', 07:09:50 INFO - 'tabpaint']}, 07:09:50 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:09:50 INFO - 'ts_paint', 07:09:50 INFO - 'tpaint', 07:09:50 INFO - 'sessionrestore', 07:09:50 INFO - 'sessionrestore_no_auto_restore', 07:09:50 INFO - 'tabpaint']}, 07:09:50 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:09:50 INFO - 'ts_paint', 07:09:50 INFO - 'tpaint', 07:09:50 INFO - 'sessionrestore', 07:09:50 INFO - 'sessionrestore_no_auto_restore', 07:09:50 INFO - 'tabpaint']}, 07:09:50 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:09:50 INFO - 'tests': ['a11yr', 07:09:50 INFO - 'ts_paint', 07:09:50 INFO - 'tpaint', 07:09:50 INFO - 'sessionrestore', 07:09:50 INFO - 'sessionrestore_no_auto_restore', 07:09:50 INFO - 'tabpaint']}, 07:09:50 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:09:50 INFO - 'tests': ['a11yr', 07:09:50 INFO - 'ts_paint', 07:09:50 INFO - 'tpaint', 07:09:50 INFO - 'sessionrestore', 07:09:50 INFO - 'sessionrestore_no_auto_restore', 07:09:50 INFO - 'tabpaint']}, 07:09:50 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:09:50 INFO - 'tests': ['tsvgx', 07:09:50 INFO - 'tsvgr_opacity', 07:09:50 INFO - 'tart', 07:09:50 INFO - 'tscrollx', 07:09:50 INFO - 'cart']}, 07:09:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:09:50 INFO - 'tsvgr_opacity', 07:09:50 INFO - 'tart', 07:09:50 INFO - 'tscrollx', 07:09:50 INFO - 'cart']}, 07:09:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:09:50 INFO - 'talos_options': ['--disable-e10s'], 07:09:50 INFO - 'tests': ['tp5o']}, 07:09:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:09:50 INFO - 'tests': ['tp5o']}, 07:09:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:09:50 INFO - 'talos_options': ['--disable-e10s', 07:09:50 INFO - '--xperf_path', 07:09:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:09:50 INFO - 'tests': ['tp5n']}, 07:09:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:09:50 INFO - 'talos_options': ['--xperf_path', 07:09:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:09:50 INFO - 'tests': ['tp5n']}}, 07:09:50 INFO - 'talos.zip': {'path': '', 07:09:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:09:50 INFO - Running post-action listener: _resource_record_post_action 07:09:50 INFO - [mozharness: 2016-07-20 14:09:50.245772Z] Finished populate-webroot step (success) 07:09:50 INFO - [mozharness: 2016-07-20 14:09:50.245862Z] Running create-virtualenv step. 07:09:50 INFO - Running pre-action listener: _resource_record_pre_action 07:09:50 INFO - Running main action method: create_virtualenv 07:09:50 INFO - Creating virtualenv /builds/slave/test/build/venv 07:09:50 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 07:09:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:09:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:09:50 INFO - Using real prefix '/usr' 07:09:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:09:50 INFO - Installing distribute.............................................................................................................................................................................................done. 07:09:52 INFO - Installing pip.................done. 07:09:52 INFO - Return code: 0 07:09:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:09:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:52 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 0x1b18030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd9180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd73b0>, '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 0x1dd82b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd8740>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1469023634.341069-206537822', '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 07:09:52 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 07:09:52 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 07:09:52 INFO - Using env: {'DISPLAY': ':0', 07:09:52 INFO - 'HOME': '/home/cltbld', 07:09:52 INFO - 'LANG': 'en_US.UTF-8', 07:09:52 INFO - 'LANGUAGE': 'en_US:en', 07:09:52 INFO - 'LOGNAME': 'cltbld', 07:09:52 INFO - 'MAIL': '/var/mail/cltbld', 07:09:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:52 INFO - 'MOZ_NO_REMOTE': '1', 07:09:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:52 INFO - 'NO_EM_RESTART': '1', 07:09:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:52 INFO - 'PWD': '/builds/slave/test', 07:09:52 INFO - 'SHELL': '/bin/bash', 07:09:52 INFO - 'SHLVL': '1', 07:09:52 INFO - 'TERM': 'linux', 07:09:52 INFO - 'TMOUT': '86400', 07:09:52 INFO - 'USER': 'cltbld', 07:09:52 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1469023634.341069-206537822', 07:09:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:52 INFO - '_': '/tools/buildbot/bin/python'} 07:09:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:53 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 07:09:53 INFO - Cleaning up... 07:09:53 INFO - Return code: 0 07:09:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:09:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1b18030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd9180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd73b0>, '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 0x1dd82b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd8740>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1469023634.341069-206537822', '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 07:09:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:09:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:09:53 INFO - Using env: {'DISPLAY': ':0', 07:09:53 INFO - 'HOME': '/home/cltbld', 07:09:53 INFO - 'LANG': 'en_US.UTF-8', 07:09:53 INFO - 'LANGUAGE': 'en_US:en', 07:09:53 INFO - 'LOGNAME': 'cltbld', 07:09:53 INFO - 'MAIL': '/var/mail/cltbld', 07:09:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:53 INFO - 'MOZ_NO_REMOTE': '1', 07:09:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:53 INFO - 'NO_EM_RESTART': '1', 07:09:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:53 INFO - 'PWD': '/builds/slave/test', 07:09:53 INFO - 'SHELL': '/bin/bash', 07:09:53 INFO - 'SHLVL': '1', 07:09:53 INFO - 'TERM': 'linux', 07:09:53 INFO - 'TMOUT': '86400', 07:09:53 INFO - 'USER': 'cltbld', 07:09:53 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1469023634.341069-206537822', 07:09:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:53 INFO - '_': '/tools/buildbot/bin/python'} 07:09:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:53 INFO - Downloading/unpacking psutil>=3.1.1 07:09:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:09:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:09:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:09:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:09:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:09:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:09:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:09:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:09:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:09:55 INFO - Installing collected packages: psutil 07:09:55 INFO - Running setup.py install for psutil 07:09:55 INFO - building 'psutil._psutil_linux' extension 07:09:55 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 07:09:55 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 07:09:55 INFO - building 'psutil._psutil_posix' extension 07:09:55 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 07:09:55 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 07:09:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:09:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:09:55 INFO - Successfully installed psutil 07:09:55 INFO - Cleaning up... 07:09:55 INFO - Return code: 0 07:09:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:09:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b18030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd9180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd73b0>, '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 0x1dd82b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd8740>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1469023634.341069-206537822', '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 07:09:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:09:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:09:55 INFO - Using env: {'DISPLAY': ':0', 07:09:55 INFO - 'HOME': '/home/cltbld', 07:09:55 INFO - 'LANG': 'en_US.UTF-8', 07:09:55 INFO - 'LANGUAGE': 'en_US:en', 07:09:55 INFO - 'LOGNAME': 'cltbld', 07:09:55 INFO - 'MAIL': '/var/mail/cltbld', 07:09:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:55 INFO - 'MOZ_NO_REMOTE': '1', 07:09:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:55 INFO - 'NO_EM_RESTART': '1', 07:09:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:55 INFO - 'PWD': '/builds/slave/test', 07:09:55 INFO - 'SHELL': '/bin/bash', 07:09:55 INFO - 'SHLVL': '1', 07:09:55 INFO - 'TERM': 'linux', 07:09:55 INFO - 'TMOUT': '86400', 07:09:55 INFO - 'USER': 'cltbld', 07:09:55 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1469023634.341069-206537822', 07:09:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:55 INFO - '_': '/tools/buildbot/bin/python'} 07:09:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:09:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:09:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:09:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:09:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:09:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:09:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:09:57 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:09:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:09:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:09:58 INFO - Installing collected packages: mozsystemmonitor 07:09:58 INFO - Running setup.py install for mozsystemmonitor 07:09:58 INFO - Successfully installed mozsystemmonitor 07:09:58 INFO - Cleaning up... 07:09:58 INFO - Return code: 0 07:09:58 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:09:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1b18030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd9180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd73b0>, '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 0x1dd82b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd8740>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1469023634.341069-206537822', '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 07:09:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:09:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:09:58 INFO - Using env: {'DISPLAY': ':0', 07:09:58 INFO - 'HOME': '/home/cltbld', 07:09:58 INFO - 'LANG': 'en_US.UTF-8', 07:09:58 INFO - 'LANGUAGE': 'en_US:en', 07:09:58 INFO - 'LOGNAME': 'cltbld', 07:09:58 INFO - 'MAIL': '/var/mail/cltbld', 07:09:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:58 INFO - 'MOZ_NO_REMOTE': '1', 07:09:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:58 INFO - 'NO_EM_RESTART': '1', 07:09:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:58 INFO - 'PWD': '/builds/slave/test', 07:09:58 INFO - 'SHELL': '/bin/bash', 07:09:58 INFO - 'SHLVL': '1', 07:09:58 INFO - 'TERM': 'linux', 07:09:58 INFO - 'TMOUT': '86400', 07:09:58 INFO - 'USER': 'cltbld', 07:09:58 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1469023634.341069-206537822', 07:09:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:58 INFO - '_': '/tools/buildbot/bin/python'} 07:09:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:58 INFO - Downloading/unpacking jsonschema==2.5.1 07:09:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:09:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:09:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:09:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:09:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:09:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:10:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:10:00 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:10:00 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 07:10:00 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 07:10:00 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 07:10:00 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 07:10:00 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 07:10:00 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 07:10:00 INFO - Downloading functools32-3.2.3-2.tar.gz 07:10:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:10:00 INFO - warning: no files found matching '*.txt' 07:10:00 INFO - no previously-included directories found matching 'build' 07:10:00 INFO - no previously-included directories found matching 'dist' 07:10:00 INFO - no previously-included directories found matching '.git*' 07:10:00 INFO - Installing collected packages: jsonschema, functools32 07:10:00 INFO - Running setup.py install for functools32 07:10:00 INFO - warning: no files found matching '*.txt' 07:10:00 INFO - no previously-included directories found matching 'build' 07:10:00 INFO - no previously-included directories found matching 'dist' 07:10:00 INFO - no previously-included directories found matching '.git*' 07:10:00 INFO - Successfully installed jsonschema functools32 07:10:00 INFO - Cleaning up... 07:10:00 INFO - Return code: 0 07:10:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:10: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:10:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:10:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:10:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:10:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:00 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 0x1b18030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd9180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd73b0>, '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 0x1dd82b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd8740>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1469023634.341069-206537822', '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 07:10:00 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 07:10:00 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 07:10:00 INFO - Using env: {'DISPLAY': ':0', 07:10:00 INFO - 'HOME': '/home/cltbld', 07:10:00 INFO - 'LANG': 'en_US.UTF-8', 07:10:00 INFO - 'LANGUAGE': 'en_US:en', 07:10:00 INFO - 'LOGNAME': 'cltbld', 07:10:00 INFO - 'MAIL': '/var/mail/cltbld', 07:10:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:10:00 INFO - 'MOZ_NO_REMOTE': '1', 07:10:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:10:00 INFO - 'NO_EM_RESTART': '1', 07:10:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:10:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:10:00 INFO - 'PWD': '/builds/slave/test', 07:10:00 INFO - 'SHELL': '/bin/bash', 07:10:00 INFO - 'SHLVL': '1', 07:10:00 INFO - 'TERM': 'linux', 07:10:00 INFO - 'TMOUT': '86400', 07:10:00 INFO - 'USER': 'cltbld', 07:10:00 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1469023634.341069-206537822', 07:10:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:10:00 INFO - '_': '/tools/buildbot/bin/python'} 07:10:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:10:00 INFO - Downloading/unpacking blobuploader==1.2.4 07:10:00 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 07:10:00 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 07:10:00 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 07:10:00 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 07:10:00 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 07:10:00 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 07:10:02 INFO - Downloading blobuploader-1.2.4.tar.gz 07:10:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:10:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:10:02 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 07:10:02 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 07:10:02 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 07:10:02 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 07:10:02 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 07:10:02 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 07:10:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:10:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:10:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:10:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:10:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:10:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:10:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:10:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:10:03 INFO - Downloading docopt-0.6.1.tar.gz 07:10:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:10:03 INFO - Installing collected packages: blobuploader, requests, docopt 07:10:03 INFO - Running setup.py install for blobuploader 07:10:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:10:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:10:03 INFO - Running setup.py install for requests 07:10:04 INFO - Running setup.py install for docopt 07:10:04 INFO - Successfully installed blobuploader requests docopt 07:10:04 INFO - Cleaning up... 07:10:04 INFO - Return code: 0 07:10:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:10:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:10:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:10:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:10:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:10:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:04 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 0x1b18030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd9180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd73b0>, '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 0x1dd82b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd8740>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1469023634.341069-206537822', '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 07:10:04 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 07:10:04 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 07:10:04 INFO - Using env: {'DISPLAY': ':0', 07:10:04 INFO - 'HOME': '/home/cltbld', 07:10:04 INFO - 'LANG': 'en_US.UTF-8', 07:10:04 INFO - 'LANGUAGE': 'en_US:en', 07:10:04 INFO - 'LOGNAME': 'cltbld', 07:10:04 INFO - 'MAIL': '/var/mail/cltbld', 07:10:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:10:04 INFO - 'MOZ_NO_REMOTE': '1', 07:10:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:10:04 INFO - 'NO_EM_RESTART': '1', 07:10:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:10:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:10:04 INFO - 'PWD': '/builds/slave/test', 07:10:04 INFO - 'SHELL': '/bin/bash', 07:10:04 INFO - 'SHLVL': '1', 07:10:04 INFO - 'TERM': 'linux', 07:10:04 INFO - 'TMOUT': '86400', 07:10:04 INFO - 'USER': 'cltbld', 07:10:04 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1469023634.341069-206537822', 07:10:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:10:04 INFO - '_': '/tools/buildbot/bin/python'} 07:10:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:10:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:10:04 INFO - Running setup.py (path:/tmp/pip-a6Dp7n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:10:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:10:04 INFO - Running setup.py (path:/tmp/pip-NfYNf8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:10:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:10:04 INFO - Running setup.py (path:/tmp/pip-tMKF97-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:10:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:10:04 INFO - Running setup.py (path:/tmp/pip-pJLmAc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:10:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:10:04 INFO - Running setup.py (path:/tmp/pip-fpjO9b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:10:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:10:04 INFO - Running setup.py (path:/tmp/pip-Vbvj1L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:10:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:10:04 INFO - Running setup.py (path:/tmp/pip-7twebJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:10:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:10:05 INFO - Running setup.py (path:/tmp/pip-z0lJrH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:10:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:10:05 INFO - Running setup.py (path:/tmp/pip-KxYq20-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:10:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:10:05 INFO - Running setup.py (path:/tmp/pip-3ndWB9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:10:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:10:05 INFO - Running setup.py (path:/tmp/pip-JmzDzZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:10:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:10:05 INFO - Running setup.py (path:/tmp/pip-nNQxLn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:10:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:10:05 INFO - Running setup.py (path:/tmp/pip-jTZR2R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:10:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:10:05 INFO - Running setup.py (path:/tmp/pip-xFDmDb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:10:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:10:05 INFO - Running setup.py (path:/tmp/pip-gdLlJf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:10:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:10:05 INFO - Running setup.py (path:/tmp/pip-oOwPut-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:10:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:10:05 INFO - Running setup.py (path:/tmp/pip-bY21hs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:10:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:10:05 INFO - Running setup.py install for manifestparser 07:10:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:10:05 INFO - Running setup.py install for mozcrash 07:10:05 INFO - Running setup.py install for mozdebug 07:10:06 INFO - Running setup.py install for mozdevice 07:10:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:10:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:10:06 INFO - Running setup.py install for mozfile 07:10:06 INFO - Running setup.py install for mozhttpd 07:10:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:10:06 INFO - Running setup.py install for mozinfo 07:10:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:10:06 INFO - Running setup.py install for mozInstall 07:10:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:10:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:10:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:10:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:10:06 INFO - Running setup.py install for mozleak 07:10:06 INFO - Running setup.py install for mozlog 07:10:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:10:06 INFO - Running setup.py install for moznetwork 07:10:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:10:06 INFO - Running setup.py install for mozprocess 07:10:06 INFO - Running setup.py install for mozprofile 07:10:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:10:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:10:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:10:07 INFO - Running setup.py install for mozrunner 07:10:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:10:07 INFO - Running setup.py install for mozscreenshot 07:10:07 INFO - Running setup.py install for moztest 07:10:07 INFO - Running setup.py install for mozversion 07:10:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:10:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:10:07 INFO - Cleaning up... 07:10:07 INFO - Return code: 0 07:10:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:10:07 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:10:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:10:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:07 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:10:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:10:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:07 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 0x1b18030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd9180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd73b0>, '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 0x1dd82b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd8740>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1469023634.341069-206537822', '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 07:10:07 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 07:10:07 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 07:10:07 INFO - Using env: {'DISPLAY': ':0', 07:10:07 INFO - 'HOME': '/home/cltbld', 07:10:07 INFO - 'LANG': 'en_US.UTF-8', 07:10:07 INFO - 'LANGUAGE': 'en_US:en', 07:10:07 INFO - 'LOGNAME': 'cltbld', 07:10:07 INFO - 'MAIL': '/var/mail/cltbld', 07:10:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:10:07 INFO - 'MOZ_NO_REMOTE': '1', 07:10:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:10:07 INFO - 'NO_EM_RESTART': '1', 07:10:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:10:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:10:07 INFO - 'PWD': '/builds/slave/test', 07:10:07 INFO - 'SHELL': '/bin/bash', 07:10:07 INFO - 'SHLVL': '1', 07:10:07 INFO - 'TERM': 'linux', 07:10:07 INFO - 'TMOUT': '86400', 07:10:07 INFO - 'USER': 'cltbld', 07:10:07 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1469023634.341069-206537822', 07:10:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:10:07 INFO - '_': '/tools/buildbot/bin/python'} 07:10:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:10:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:10:07 INFO - Running setup.py (path:/tmp/pip-rzjypm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:10:07 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)) 07:10:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:10:07 INFO - Running setup.py (path:/tmp/pip-TW2P3P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:10:07 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)) 07:10:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:10:07 INFO - Running setup.py (path:/tmp/pip-MdTUO0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:10:07 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)) 07:10:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:10:07 INFO - Running setup.py (path:/tmp/pip-jCCMgs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:10:08 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)) 07:10:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:10:08 INFO - Running setup.py (path:/tmp/pip-ZqMQV7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:10:08 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)) 07:10:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:10:08 INFO - Running setup.py (path:/tmp/pip-w1JqFU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:10:08 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)) 07:10:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:10:08 INFO - Running setup.py (path:/tmp/pip-D7Cn6d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:10:08 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)) 07:10:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:10:08 INFO - Running setup.py (path:/tmp/pip-TbmSDs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:10:08 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)) 07:10:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:10:08 INFO - Running setup.py (path:/tmp/pip-7llUXp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:10:08 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)) 07:10:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:10:08 INFO - Running setup.py (path:/tmp/pip-AhXKLD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:10:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 07:10:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:10:08 INFO - Running setup.py (path:/tmp/pip-z5bxbT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:10:08 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)) 07:10:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:10:08 INFO - Running setup.py (path:/tmp/pip-YLLiE8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:10:08 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)) 07:10:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:10:08 INFO - Running setup.py (path:/tmp/pip-ghy3Ah-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:10:08 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)) 07:10:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:10:08 INFO - Running setup.py (path:/tmp/pip-SZxRBU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:10:08 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)) 07:10:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:10:08 INFO - Running setup.py (path:/tmp/pip-Aa0zBB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:10:08 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)) 07:10:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:10:08 INFO - Running setup.py (path:/tmp/pip-mC92yD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:10:08 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)) 07:10:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:10:08 INFO - Running setup.py (path:/tmp/pip-Pg5kNE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:10:08 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)) 07:10:08 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)) 07:10:08 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)) 07:10:08 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)) 07:10:08 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)) 07:10:08 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)) 07:10:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:10: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 07:10: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 07:10: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 07:10: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 07:10: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 07:10: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 07:10:10 INFO - Downloading blessings-1.6.tar.gz 07:10:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:10:10 INFO - Installing collected packages: blessings 07:10:10 INFO - Running setup.py install for blessings 07:10:11 INFO - Successfully installed blessings 07:10:11 INFO - Cleaning up... 07:10:11 INFO - Return code: 0 07:10:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:10:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:10:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:10:11 INFO - Reading from file tmpfile_stdout 07:10:11 INFO - Current package versions: 07:10:11 INFO - argparse == 1.2.1 07:10:11 INFO - blessings == 1.6 07:10:11 INFO - blobuploader == 1.2.4 07:10:11 INFO - docopt == 0.6.1 07:10:11 INFO - functools32 == 3.2.3-2 07:10:11 INFO - jsonschema == 2.5.1 07:10:11 INFO - manifestparser == 1.1 07:10:11 INFO - mozInstall == 1.12 07:10:11 INFO - mozcrash == 0.17 07:10:11 INFO - mozdebug == 0.1 07:10:11 INFO - mozdevice == 0.48 07:10:11 INFO - mozfile == 1.2 07:10:11 INFO - mozhttpd == 0.7 07:10:11 INFO - mozinfo == 0.9 07:10:11 INFO - mozleak == 0.1 07:10:11 INFO - mozlog == 3.3 07:10:11 INFO - moznetwork == 0.27 07:10:11 INFO - mozprocess == 0.23 07:10:11 INFO - mozprofile == 0.28 07:10:11 INFO - mozrunner == 6.12 07:10:11 INFO - mozscreenshot == 0.1 07:10:11 INFO - mozsystemmonitor == 0.3 07:10:11 INFO - moztest == 0.7 07:10:11 INFO - mozversion == 1.4 07:10:11 INFO - psutil == 3.1.1 07:10:11 INFO - requests == 1.2.3 07:10:11 INFO - wsgiref == 0.1.2 07:10:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:10:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:10:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:10:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:10:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:10:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:11 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 0x1b18030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd9180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd73b0>, '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 0x1dd82b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd8740>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1469023634.341069-206537822', '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 07:10:11 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 07:10:11 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 07:10:11 INFO - Using env: {'DISPLAY': ':0', 07:10:11 INFO - 'HOME': '/home/cltbld', 07:10:11 INFO - 'LANG': 'en_US.UTF-8', 07:10:11 INFO - 'LANGUAGE': 'en_US:en', 07:10:11 INFO - 'LOGNAME': 'cltbld', 07:10:11 INFO - 'MAIL': '/var/mail/cltbld', 07:10:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:10:11 INFO - 'MOZ_NO_REMOTE': '1', 07:10:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:10:11 INFO - 'NO_EM_RESTART': '1', 07:10:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:10:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:10:11 INFO - 'PWD': '/builds/slave/test', 07:10:11 INFO - 'SHELL': '/bin/bash', 07:10:11 INFO - 'SHLVL': '1', 07:10:11 INFO - 'TERM': 'linux', 07:10:11 INFO - 'TMOUT': '86400', 07:10:11 INFO - 'USER': 'cltbld', 07:10:11 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1469023634.341069-206537822', 07:10:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:10:11 INFO - '_': '/tools/buildbot/bin/python'} 07:10:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:10:11 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)) 07:10:11 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)) 07:10:11 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)) 07:10:11 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)) 07:10:11 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)) 07:10:11 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)) 07:10:11 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)) 07:10:11 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)) 07:10:11 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)) 07:10:11 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)) 07:10:11 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)) 07:10:11 INFO - Cleaning up... 07:10:11 INFO - Return code: 0 07:10:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:10:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:10:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:10:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:10:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:10:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b18030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd9180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd73b0>, '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 0x1dd82b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd8740>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1469023634.341069-206537822', '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 07:10:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:10:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:10:11 INFO - Using env: {'DISPLAY': ':0', 07:10:11 INFO - 'HOME': '/home/cltbld', 07:10:11 INFO - 'LANG': 'en_US.UTF-8', 07:10:11 INFO - 'LANGUAGE': 'en_US:en', 07:10:11 INFO - 'LOGNAME': 'cltbld', 07:10:11 INFO - 'MAIL': '/var/mail/cltbld', 07:10:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:10:11 INFO - 'MOZ_NO_REMOTE': '1', 07:10:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:10:11 INFO - 'NO_EM_RESTART': '1', 07:10:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:10:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:10:11 INFO - 'PWD': '/builds/slave/test', 07:10:11 INFO - 'SHELL': '/bin/bash', 07:10:11 INFO - 'SHLVL': '1', 07:10:11 INFO - 'TERM': 'linux', 07:10:11 INFO - 'TMOUT': '86400', 07:10:11 INFO - 'USER': 'cltbld', 07:10:11 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1469023634.341069-206537822', 07:10:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:10:11 INFO - '_': '/tools/buildbot/bin/python'} 07:10:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:10:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:10:11 INFO - Cleaning up... 07:10:11 INFO - Return code: 0 07:10:11 INFO - Running post-action listener: _resource_record_post_action 07:10:11 INFO - Running post-action listener: _start_resource_monitoring 07:10:11 INFO - Starting resource monitoring. 07:10:11 INFO - [mozharness: 2016-07-20 14:10:11.812634Z] Finished create-virtualenv step (success) 07:10:11 INFO - [mozharness: 2016-07-20 14:10:11.813112Z] Running install step. 07:10:11 INFO - Running pre-action listener: _resource_record_pre_action 07:10:11 INFO - Running main action method: install 07:10:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:10:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:10:12 INFO - Reading from file tmpfile_stdout 07:10:12 INFO - Detecting whether we're running mozinstall >=1.0... 07:10:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:10:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:10:12 INFO - Reading from file tmpfile_stdout 07:10:12 INFO - Output received: 07:10:12 INFO - Usage: mozinstall [options] installer 07:10:12 INFO - Options: 07:10:12 INFO - -h, --help show this help message and exit 07:10:12 INFO - -d DEST, --destination=DEST 07:10:12 INFO - Directory to install application into. [default: 07:10:12 INFO - "/builds/slave/test"] 07:10:12 INFO - --app=APP Application being installed. [default: firefox] 07:10:12 INFO - mkdir: /builds/slave/test/build/application 07:10:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:10:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:10:29 INFO - Reading from file tmpfile_stdout 07:10:29 INFO - Output received: 07:10:29 INFO - /builds/slave/test/build/application/firefox/firefox 07:10:29 INFO - Running post-action listener: _resource_record_post_action 07:10:29 INFO - [mozharness: 2016-07-20 14:10:29.595642Z] Finished install step (success) 07:10:29 INFO - [mozharness: 2016-07-20 14:10:29.595918Z] Running run-tests step. 07:10:29 INFO - Running pre-action listener: _resource_record_pre_action 07:10:29 INFO - Running main action method: run_tests 07:10:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:10:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:10:29 INFO - Python 2.7.3 07:10:29 INFO - Return code: 0 07:10:29 INFO - grabbing minidump binary from tooltool 07:10:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:10:29 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 0x1dd73b0>, '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 0x1dd82b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd8740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:10:29 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 07:10:29 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 07:10:29 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 07:10:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:10:29 INFO - Return code: 0 07:10:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:10:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:10:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:10:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:10:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:10:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JoYT_1EmSrK2PVMprcN4OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--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 07:10:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JoYT_1EmSrK2PVMprcN4OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-012 --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 07:10:29 INFO - Using env: {'DISPLAY': ':0', 07:10:29 INFO - 'HOME': '/home/cltbld', 07:10:29 INFO - 'LANG': 'en_US.UTF-8', 07:10:29 INFO - 'LANGUAGE': 'en_US:en', 07:10:29 INFO - 'LOGNAME': 'cltbld', 07:10:29 INFO - 'MAIL': '/var/mail/cltbld', 07:10:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:10:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:10:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:10:29 INFO - 'MOZ_NO_REMOTE': '1', 07:10:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:10:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:10:29 INFO - 'NO_EM_RESTART': '1', 07:10:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:10:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:10:29 INFO - 'PWD': '/builds/slave/test', 07:10:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:10:29 INFO - 'SHELL': '/bin/bash', 07:10:29 INFO - 'SHLVL': '1', 07:10:29 INFO - 'TERM': 'linux', 07:10:29 INFO - 'TMOUT': '86400', 07:10:29 INFO - 'USER': 'cltbld', 07:10:29 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1469023634.341069-206537822', 07:10:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:10:29 INFO - '_': '/tools/buildbot/bin/python'} 07:10:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JoYT_1EmSrK2PVMprcN4OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--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 07:10:29 INFO - mozversion application_buildid: 20160720043044 07:10:29 INFO - mozversion application_changeset: ed8e23b5e0c7b739e61173bb180cf3410a306679 07:10:29 INFO - mozversion application_display_name: Nightly 07:10:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:10:29 INFO - mozversion application_name: Firefox 07:10:29 INFO - mozversion application_remotingname: firefox 07:10:29 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:10:29 INFO - mozversion application_vendor: Mozilla 07:10:29 INFO - mozversion application_version: 50.0a1 07:10:29 INFO - mozversion platform_buildid: 20160720043044 07:10:29 INFO - mozversion platform_changeset: ed8e23b5e0c7b739e61173bb180cf3410a306679 07:10:29 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:10:29 INFO - mozversion platform_version: 50.0a1 07:10:29 INFO - using testdate: 1469023829 07:10:29 INFO - actual date: 1469023829 07:10:29 INFO - starting webserver on 'localhost:34491' 07:10:29 INFO - SUITE-START | Running 2 tests 07:10:29 INFO - TEST-START | dromaeo_css 07:10:29 INFO - operating with platform_type : linux_ 07:10:29 INFO - Initialising browser for dromaeo_css test... 07:10:29 INFO - TEST-INFO | started process 28898 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzth6SX/profile http://localhost:34491/getInfo.html) 07:10:33 INFO - PROCESS | 28898 | __metrics Screen width/height:1600/1200 07:10:33 INFO - PROCESS | 28898 | colorDepth:24 07:10:33 INFO - PROCESS | 28898 | Browser inner width/height: 1024/697 07:10:33 INFO - PROCESS | 28898 | __metrics 07:10:34 ERROR - PROCESS | 28898 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 07:10:35 INFO - TEST-INFO | 28898: exit 0 07:10:35 INFO - Browser initialized. 07:10:35 INFO - Running cycle 1/1 for dromaeo_css test... 07:10:35 INFO - TEST-INFO | started process 29017 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzth6SX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:10:46 INFO - PROCESS | 29017 | RSS: Main: 167055360 07:10:46 INFO - PROCESS | 29017 | 07:11:36 INFO - PROCESS | 29017 | 1469023896553 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] 07:13:45 INFO - PROCESS | 29017 | Cycle 1(1): loaded http://localhost:34491/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34491/tests/dromaeo/cssquery-ext.html) 07:13:46 INFO - PROCESS | 29017 | RSS: Main: 172199936 07:13:46 INFO - PROCESS | 29017 | 07:16:48 INFO - PROCESS | 29017 | Cycle 1(1): loaded http://localhost:34491/tests/dromaeo/cssquery-ext.html (next: http://localhost:34491/tests/dromaeo/cssquery-jquery.html) 07:16:49 INFO - PROCESS | 29017 | RSS: Main: 169656320 07:16:49 INFO - PROCESS | 29017 | 07:19:50 INFO - PROCESS | 29017 | Cycle 1(1): loaded http://localhost:34491/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34491/tests/dromaeo/cssquery-mootools.html) 07:19:51 INFO - PROCESS | 29017 | RSS: Main: 172810240 07:19:51 INFO - PROCESS | 29017 | 07:22:53 INFO - PROCESS | 29017 | Cycle 1(1): loaded http://localhost:34491/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34491/tests/dromaeo/cssquery-prototype.html) 07:22:54 INFO - PROCESS | 29017 | RSS: Main: 167395328 07:22:54 INFO - PROCESS | 29017 | 07:25:56 INFO - PROCESS | 29017 | Cycle 1(1): loaded http://localhost:34491/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34491/tests/dromaeo/cssquery-yui.html) 07:25:57 INFO - PROCESS | 29017 | RSS: Main: 169811968 07:25:57 INFO - PROCESS | 29017 | 07:28:59 INFO - PROCESS | 29017 | Cycle 1(1): loaded http://localhost:34491/tests/dromaeo/cssquery-yui.html (next: http://localhost:34491/tests/dromaeo/cssquery-dojo.html) 07:29:00 INFO - PROCESS | 29017 | RSS: Main: 170430464 07:29:00 INFO - PROCESS | 29017 | 07:29:00 INFO - PROCESS | 29017 | __start_tp_report 07:29:00 INFO - PROCESS | 29017 | _x_x_mozilla_page_load 07:29:00 INFO - PROCESS | 29017 | _x_x_mozilla_page_load_details 07:29:00 INFO - PROCESS | 29017 | |i|pagename|runs| 07:29:00 INFO - PROCESS | 29017 | |0;dojo.html;3077.692230776922;3090;3101.3952279305518;3106.083705306934;3111.9533207001914;5445.972770136149;5490.313710786157;5522.889542209154;5541.750621222044;5582.078956972095;5313;5388.865278368043;5441.755121019553;5490.588205884555;5513.393526712059;4894.5105489451125;4923.138450771118;4939.901201975958;5033.094043072246;5034.3455350804525;4932.260160975847;5013.298138260647;5040.924386134211;5051.7726702298305;5063;4880.731559764212;4889.633277504201;4930.580900623451;4974.452810190876;4984.053029924321;4945.332380128672;4953.975230123826;4959.8264060758065;4970.453250142481;4991.3511243538105;4880.731559764212;4909.582685471739;4932.03825254072;4942.5304596063315;4971.801127954877;5367.516923476866;5373.328333958255;5452.291202143736;5452.809151679712;5477.75350109242;5852.619579727347;5868.354481007086;5878.5297176225795;5891.440313170242;5929.73316200772;5908.113782932552;5929.525637948954;5932.644041357489;5936.821895343147;5949.315828679671;5328.866778330534;5452.454754524555;5490.258815059956;5497.038018346813;5521.978433989725;6089.756409743561;6093.177421048191;6100;6104.084387341934;6132.2947860996555;5849.53203743708;5849.853753656107;5859.1797148399255;5860.179574859523;5868.23712917318;5712.542996560265;5758.251427314506;5797.623154494944;5819.039858423397;5914.319853216849;5595.524380427709;5685.687287199244;5701.344345400249;5737.799177028867;5870.324912635102;5703.429657034347;5750.453706897838;5765.250517432791;5771.94228057714;5787.826365209051;4470.351798989193;4482.238019536687;4485.798139083749;4524.2082635538645;4524.524924882906;3947.348687466593;3959.9604003960167;3997.060690737674;4000.5599384067727;4019.8191081401405;5502.147167189092;5608.1587761835235;5641.689707066151;5664;5665.631733937281;5837.737301821428;5879.059350503899;5880.529557635465;5906.350301466835;5950.077737950624;5613;5629.549636029108;5634.267545219095;5642.548596112301;5644.6330988485615;4936.136176169228;5004.724740139327;5029.06962211992;5043.36957880265;5052;6055.1522786809;6089;6096.908546371808;6106.45041946227;6140.048292514667;5850.5027072699295;5899.911501327398;5904.3210030847;5908.852278693067;5926.407359264212;5869.94130058711;5985.880282394415;6032.577719559588;6059.454649081604;6093.969530152321;5802.564807639359;5813.505852002627;5815.767369305349;5816.883662326814;5851.093080572518;5907.704614769158;5907.734151963086;5908.793192238251;5917.289925209003;5930.733117009831;5599.160125981135;5682.545396368363;5718.428157184248;5743.4256574342235;5760.740766665594;5730.570207234391;5732.914006289826;5761.596688231783;5774.538036957118;5800;5709.65742055478;5711.685857277724;5715.8571035724435;5716.399778023248;5724.542036636975;5539.861503462284;5730.054541000688;5773.826785196451;5822.650640961556;5828.388019257917;5698;5703.144528320619;5703.315602127771;5706.771729130788;5718.742656580381 07:29:00 INFO - PROCESS | 29017 | |1;ext.html;559.7088722756218;591.6450129922047;593.9724277000786;610.4140025575448;633.9334369891164;39337.409938850906;43259.35110973334;43483.78258108709;43504.347434788506;43507.34738978918;43296;43777.343339849926;43887;43921.78039109808;43962.12075758483;8831.205191532777;8957.328200384965;8969.596368163415;8997.775055623597;9018.286525560155;8896.15486528782;9047.773805654846;9078.048219632778;9079.273658107368;9086.636534538611;8829.293656507463;8849.646014159425;8866.822663546725;8873.3344999125;8887.422317549339;9036.954815225914;9077.001529831714;9085.454872707625;9085.81828363429;9094.49980251086;8857.379983401164;8953.552322383855;9003.369764116514;9013.684521041732;9015.323850711224;41559.168816623496;41658.1668366631;41885.790571047255;41911.37132943008;41981;3532.5760908691122;3582.3193593217206;3611.5124458198334;3674.816259187057;3756.3426400379826;33070.669293307;33506.83246583776;33912.83043584766;33995.49006764901;34155.31689366224;4431.49037860647;4488.842890498817;4495.9325610115875;4628.398308219944;4656.511066338054;260988;262067;262436;262475;263475;61367;61776.69111654413;62287.37712622906;62312.37687623066;62323;64171;64623.35376646267;64659.67670161713;64852.67573662196;64888;15900;16032.919835400748;17203.397881074103;17762.822371776376;17792.555186120193;12564.371781410893;12663.240205587694;12703.364831758376;12721.236725796482;12727.427265773062;20096.39710808678;20224.191032358834;20268.391948241577;20320.390388288375;20383.388498345073;7069.293070692889;7236.240194779578;7245.637718114179;7312.341889229995;7423.183449820515;1016.5527168046036;1036.4972988100765;1045.4929359260752;1060.5015642647943;1077.4935780183457;33654;33768.49347259793;33779.662203378146;33974.320513590086;34038;1123.9943800280946;1133.9546418143182;1149.7585507043614;1169.128998895828;1181.704573856536;17489.300427982736;17724.645507089786;17780.644387112185;17832;17914.193861276275;581138;583022;584439;586713;587297;60315;60546;60594.394056059755;60649.09026364608;60933.390666092775;1346.696993176547;1367.6170672211797;1385.2865774126333;1393.3312010235145;1401.0472878442756;31178.22054448657;31903.361932760752;32686.673133268363;33002.504962425104;33512.49731253985;52092;52094.21858672199;52346.476535234164;52639.21041184462;52848.73575632097;422568;423408;423590;423764;424343;28548.42903141884;28700.282492937844;28848.567271491363;28989;29042.854785725936;49220.753896230286;49677.25484117669;50701;51295.48704513056;51446.22830657618;40133.79933100316;42711;42884.35673464963;43298.567014330714;43758.56241437545;41590.792046039576;42459.363109554;42917.356239657056;43020.35469468023;43350.34974475322;36020.63979360278;41044.38433423441;42072.8963551815;42209.788951055045;43383.566164339216;35213.82393088018;37251;37933.90863400258;38476;38648;27967.72032279651;29466.85266573739;29980.85009574938;30085.849570752882;30135.397292054473 07:29:00 INFO - PROCESS | 29017 | |2;jquery.html;381.856803698613;384.77490667959245;395.91883663848915;405.9289624315745;419.74605363754927;13941.442342306296;18694.065296735178;19595.21619135233;20301.39095827126;20411.75470698222;19682.11430485628;19781.208751649952;20127.49681257969;20382.490437739063;20477.283295084675;5768.711564421783;5774.971125144379;5884.6763428011445;5889.941100589003;5916.792912248072;5795.362510123883;5833.766649334021;5854.824355269348;5865.296164460249;5868.9413105869035;5701.77192912283;5714;5745.253117094772;5797.594168408213;5856.150858125569;5770.855728606776;5834.941650583482;5845.970770146122;5850.619709718876;5858.88282234355;5034.471380505068;5182.948170518322;5195.116830138885;5208.0365132450615;5212.983468223698;23844.40388990272;23845.284641460785;24257.636135457982;24328;24344.756552434425;2358.8230882683865;2465.7041155061506;2482.515909397668;2492.6385674077155;3074.3697542003833;15185.240737963057;15187.62030949224;15316.617084572976;15326.846731532654;15730.606734831606;1881.4261650196684;1942.6406114868653;1954.2183126749271;1978.7724411692695;1985.9702104468445;75932;76403.61798190973;76605.23394766037;77413.61293193554;80070;10798.190135739851;10824.567017319376;10909.83635245472;11124.833127503094;11358.829617555743;15283.159426231441;15296;15373.461928832661;15380.38478460849;15450.381984720485;8402.915970840335;8508.319334453228;8633;8679.349048821363;8785.472871627722;8378.12029736881;8403.789905252295;8435.409521333571;8678.39251252419;8686.695965641173;6726.623136626833;6739.696713647898;6751;6768.255491895888;6984.707829051642;1946.279876445724;1991.432441754122;1993.3720877923408;1996.6605677034938;1997.131247907165;931.6273490603677;997.3068717241448;1014.8934361892043;1035.29082578434;1089.8583184186164;20747;21162.788372116083;21168.682469762967;21309;21505.569888602142;1016.9644062457778;1026.0970346095537;1064.2390690656218;1100.944952752359;1157.1957489544686;9695.321327507148;11826.5216847894;12018.939905300418;12094.334811585271;12152;477949;480829;483178;485020;501894;81980.59009704913;83151;83869;83968;84649.57675211584;1042.5621239079605;1068.3216157739892;1077.606673564159;1088.5156105532963;1102.0302134122082;15377.69244615079;18169.545761356072;18475.353362632242;18541.721874171628;18749.531261718566;38105.80947095247;39103.608963909996;39138;39465.40801888031;41760.37359439672;49797.253041205135;50628.74685626548;51392.22911656403;51987.74006129945;53425;7588.658510366937;8610.225079742853;8766.123387661182;8943.865842012505;8994.685186018458;11128.833067503832;12996.610101696964;13043.152195107288;13078.80381794293;13210.867891320964;10556.049955504042;10745.24783265164;10795;11215.943920280346;11283.548658053585;11225.60710375133;11285.548578056785;11538.94230528842;11655.592054278399;11863.169578129447;11088.501017454395;11188.552457901593;11327.263727857662;11407.771844562896;11563.710907227387;7445.9255407445235;7781.610919454118;7793.4154938378715;8204.917950820654;8292.543910085004;10602.628907988183;10635.14918806478;10908.836367454653;11050.834237486284;11276.379799111128 07:29:00 INFO - PROCESS | 29017 | |3;mootools.html;1465.4211586423362;1500.7748837674349;1604.4785444730464;1796.1737600703684;1804.3865085870802;7450.329470347668;8463.703770368038;8660.220580147785;9075;9110.99999999999;8613.569321533929;8871.955640221806;8880.95559522203;8891.733248002554;8893.021767605574;2328.75548067453;2343.742188359279;2355;2367.9052837886466;2370.7866292033714;2305.2738387408;2307.538492301538;2376;2380.571497130516;2382.0709923129994;2348.941276468085;2362.137819695816;2367.4199821043867;2370.6088495398326;2385.666006759055;2293.438107663633;2311.641695537194;2327.9418014549688;2332.5334933013464;2344.179537161997;2254.402583315423;2266.7506574276817;2269.954600907989;2274.0676322707777;2282.8744419056943;8889.599968001456;8918.73243802687;8969.372143949926;8983.955080224623;8996.100389961017;5100.15847385181;5179.8446046618665;5183.222516622499;5207.765650545734;5212.8957420851375;3274.721648659867;3304.306095719902;3402.3535528249554;3436.1409647588102;3568.9107772305642;1102.1568500097433;1146.1003112556602;1171.537242789102;1186.2230239193343;1200.4177973682756;11894;12031.578894738643;12052.156349055569;12130.696732581757;12180.756384872342;4421.579949904753;4586.472555656075;4697.037107392976;4700.529947005341;4755.334253204554;10321.380717156995;10329.276950613385;10329.483525823678;10331.74170645725;10332.690019299433;5283.1546952487415;5309.867253318698;5313.654612450178;5320.201969704498;5322.680639161663;4304.935425968613;4837.806487740521;4904.730239836843;4959.256111583291;4970.751462426936;3779.905502362463;3928.3910993796007;4017.31705610047;4023.0948036692093;4115.300398932189;1253.924764514132;1293.7735896218123;1296.293520031585;1297.098516531002;1304.706441050756;972.8297547929226;991.8264303746815;1016.9237307201842;1028.2493779540828;1040.427764729396;6002.4897883679505;6023.45788879003;6034.185384972972;6115.357887421846;6175.660338681326;451.4086546623933;457.7093545598569;461.4969683045429;462.95601917817754;478.09401184754694;4103.753774773523;4298.570142985676;4305.354196870495;4333.393324934512;4349.499807522112;10713.303635263683;10905.672829815117;10956.233063685624;11005.889941100646;11020.889791102147;10950.671479855617;10956.013958743752;10958.616448424425;10962.068224201032;10963.83554246687;7834.4907581007055;8265.297449716722;8289.253967143106;8354.665813367397;8374.162583741578;5964.194833697569;6057.818265452043;6151.84620384494;6220.160278362363;6289.371062893674;9909.207263419054;10109.443980580845;10170.949145254226;10345.172386209235;10376.429296388771;9928.900710992797;10383.792324153626;10438.37369757817;10483.528241229316;10507.73730656709;7373.9262607375385;8027.478213916077;8140.592970351578;8249.79375515617;8404.705835295736;8539.957300213458;8548.102449242988;8599.26906212979;8620.61207245663;8651.740447786577;7545.7358992435;7609.733659321897;7663.425243106901;7671.194524574839;7790.805229869298;7479.887801683088;7515.398768098648;7544.0569928758905;7641.3886889047635;7755;6775.356341147583;6859.485538584527;6871.587704737732;6876.656167191521;6881.243063263138;4914.7542622867995;5243;5315.946840531546;5395.838124856261;5448.727563621882;5279.1817268323475;5287.9735601321745;5314.654547454403;5346.812861549983;5407.297051383295 07:29:00 INFO - PROCESS | 29017 | |4;prototype.html;314.25364758698095;323.977321587489;327.3681794137315;331.17041810265283;333.5946824608101;5510.91733623995;5599.328080630325;5642.858928526789;5699.5440364770775;5711.714414279285;5513.476219759126;5566;5566.888662226763;5571.164325351199;5602.719864006804;4349.217140914634;4361.694681372305;4386.912261754763;4388.379586840869;4396.89007774805;4258.808353624095;4336.869893903188;4347.78261086946;4383.145286669101;4388.6050255477;4290.141971605692;4308.913821723564;4311.611954924057;4313.568643135693;4316.56834316569;4300.78496075195;4301.3117901135665;4303.763293018883;4304.289792184286;4377.715448495869;3667.633236676311;3807.428885667144;3814.4278358246206;3831.080540670247;3842.7502212356108;5450.4549545045575;5467.535259502907;5467.617266791326;5470.972645136789;5496.966122534688;4982.327385802942;5000.349954505928;5002.648755085104;5028.34631497903;5031.245313203012;5580.358258800249;5788.363280039192;5891.553441236882;5892.145638882338;5902.793402230901;4139.151473947833;4144.896377590554;4153.1486045360625;4187.790610469495;4188.518320393133;5840.182374467578;5950.464458198783;6116.4800991915745;6177.567570270083;6183.196184495987;4184.811683474251;4191.601797829201;4206.390073439334;4242.363645453207;4251.489821221473;4257.723247988871;4295.162443323522;4310.181065597527;4314.935275970863;4316.935245971313;4837.588804951619;4913.7973865951635;4923.950760492421;4948.233023881304;4948.752562371867;5778.855528611734;5855.765769369263;5867.882642347215;5875.265591801025;5916.792912248051;1462.2834810942775;1474.240766005508;1480.193294654416;1485.9405623774928;1488.6650503636595;907.0965515541371;940.9623615055322;953.5280036382036;956.5360800011989;960.5629438605417;5025.542592648091;5049.747512624354;5085.644004919694;5088.262201980692;5119.769610367543;5311.911058233053;5337.759800808973;5344.759485823147;5375.973120134452;5377.865553361119;5057.31726216956;5087.084324821493;5212.774997875496;5310.761015754223;5688.146777983253;3191.872325107016;3210.486322188439;3218.4206842768526;3223.3069889973767;3224.161717953349;6032.879342413127;6208.534359923024;6225.408586184305;6232.906506402408;6259.2488901332135;6034.63792172471;6104.321311639334;6112.449879510777;6116.8776624468155;6124.724387402578;6159.260888693296;6159.96920015406;6200.782972596027;6206.224221972254;6214.421015278699;5736.903006014001;5961.791337303173;5962.910556341745;5994.160817485643;6017.638941663514;5865.3254875689845;5875.383084776208;5921.282827979838;5937.881242375215;5961.7778355437895;5907.261592300963;5981.252343457068;6124.510039196764;6168.814935551941;6181.9690901547;4200.243956087934;4204.264253755519;4231.534531201503;4239.194553034913;4248.171606536695;5765.509931655856;5955.225820643289;5976.400265884355;5988;5996.2504686914135;5787.594868359343;5818.185454036523;5830.154627579062;5838.474537291664;5844.620099693507;5811.418858114154;5813.534917206698;5826.213461182686;5828.105865593614;5832.650040997553;5468.890622187613;5712.42875712442;5729.455701708331;5753.223314852441;5804.593678442638;5869.236999190078;5909.483857105016;5909.793157239476;5912.285437223157;5942.61373010753;5590.273264475592;5737.512311453574;5773.711314434346;5781.682007489629;5793.217915581343 07:29:00 INFO - PROCESS | 29017 | |5;yui.html;794.972175973841;807.7657479330994;816.2735165702524;845.4420082745389;872.276010910944;15711;16692.74960875588;16721.749173762404;16766.83233167668;16842.91578542107;15189.4683686071;15304.158271295075;15333.616659583517;15370.385184592631;15429.228538573083;797.0156856282487;838.4508147163588;843.9367047471465;844.6705784743955;845.5898889038812;841.7727213652311;843.3169133002287;843.6920524008754;844.3625063077368;844.4173520271024;884.8186121845006;885.1148851148852;885.9424137431079;887.2946007923684;887.4231749362901;877.2236570634971;878.8637761147032;886.5079880666227;886.8758373827669;888.8533391990314;644.5842431631618;644.9451796597294;645.0324513230155;645.1033064040987;645.686841881687;15967.680646387123;15993.20033998307;16021.679566408606;16062.5984350391;16109.355625774955;14523;14767.335469903881;14822.110673359524;14837.332320045623;14920.179390133539;12831.74336513274;12870.420831062625;12911.35443227835;12974;13061.86938130616;3894.6300101490315;4007.73949693269;4014.1168942832824;4068.349064149722;4091.488563929509;83557.58221208856;83791.5810420944;84317.57841210878;84320.57839710824;84584.57707711484;11754.412279385997;11859.347735874437;11930.701732456584;12213.69465763363;12337.629871103882;22164.778352216596;22220.77779222187;22226.777732222472;22286.888565557394;22325.88837055837;8822.294216462667;8898.86651700225;9029.142231487998;9063.093690630883;9178.541072946326;4874.19575770001;4889.559939605452;4904.8773780655765;5036.64743467961;5089.796408143707;3541.94687079694;3651.379265524867;3660.066682995819;3660.084978755311;3664.285464334429;588.2529187931303;604.8034388823562;606.824021033904;614.8155553333982;630.3318482408662;655.9821095788296;666.6333516565869;729.21973488368;757.5984728094119;767.1101522234293;9498.810023799486;9564.426134431957;9657.275704322205;9830.950845245728;9905.75235619101;625.6996641612052;700.8633316503233;726.5059759363578;753.7512620835112;772.7411317208686;4371.584699453547;4375.496817865923;4676.18166820805;4735.786889589976;4746.311784791186;66077.6696116526;68842;68953;78053;123633;57510;85069;103720;104052;105209.47395262975;67934.66032669904;74052;93205.53397232971;93798;94502;9329.953350233205;9652.887958260884;9655.324127311022;9669.758256043655;9772.560234789593;51649;51961.96076078533;52419.73790131025;53250;53353.46646533485;68993.65503172453;71296.64351678209;78262.2173778255;78873.60563197377;80978.59510702408;13384.799228011392;13614.18314901109;13682.384292707051;13908.374123164684;14036.719265614427;15297.46458873934;15690.9215453922;15763.605909852346;15897.205139743199;16509.422170223985;14453.855461445672;14460.349284282021;14741.336639851017;14983.101013939198;15259;14039.438422463396;14433.35049922735;14520;14521.92739036298;14741.1892345922;13536.187828729913;14064.296785160497;14125.576232713034;14555.854441455873;15072.849271507583;10751.946240268748;10766;11162.330260184415;11320.773584528428;11325.924037216451;10801.621943231949;11835.230710003822;12004.2197257178;12073.058814141155;12644.620661380173 07:29:00 INFO - PROCESS | 29017 | __end_tp_report 07:29:00 INFO - PROCESS | 29017 | __start_cc_report 07:29:00 INFO - PROCESS | 29017 | _x_x_mozilla_cycle_collect,370 07:29:00 INFO - PROCESS | 29017 | __end_cc_report 07:29:00 INFO - PROCESS | 29017 | __startTimestamp1469024940112__endTimestamp 07:29:00 INFO - PROCESS | 29017 | 07:29:00 INFO - PROCESS | 29017 | ------- Summary: start ------- 07:29:00 INFO - PROCESS | 29017 | Number of tests: 6 07:29:00 INFO - PROCESS | 29017 | 07:29:00 INFO - PROCESS | 29017 | [#0] dojo.html Cycles:165 Average:5447.91 Median:5703.14 stddev:636.08 (11.2%) stddev-sans-first:610.25 07:29:00 INFO - PROCESS | 29017 | Values: 3077.7 3090.0 3101.4 3106.1 3112.0 5446.0 5490.3 5522.9 5541.8 5582.1 5313.0 5388.9 5441.8 5490.6 5513.4 4894.5 4923.1 4939.9 5033.1 5034.3 4932.3 5013.3 5040.9 5051.8 5063.0 4880.7 4889.6 4930.6 4974.5 4984.1 4945.3 4954.0 4959.8 4970.5 4991.4 4880.7 4909.6 4932.0 4942.5 4971.8 5367.5 5373.3 5452.3 5452.8 5477.8 5852.6 5868.4 5878.5 5891.4 5929.7 5908.1 5929.5 5932.6 5936.8 5949.3 5328.9 5452.5 5490.3 5497.0 5522.0 6089.8 6093.2 6100.0 6104.1 6132.3 5849.5 5849.9 5859.2 5860.2 5868.2 5712.5 5758.3 5797.6 5819.0 5914.3 5595.5 5685.7 5701.3 5737.8 5870.3 5703.4 5750.5 5765.3 5771.9 5787.8 4470.4 4482.2 4485.8 4524.2 4524.5 3947.3 3960.0 3997.1 4000.6 4019.8 5502.1 5608.2 5641.7 5664.0 5665.6 5837.7 5879.1 5880.5 5906.4 5950.1 5613.0 5629.5 5634.3 5642.5 5644.6 4936.1 5004.7 5029.1 5043.4 5052.0 6055.2 6089.0 6096.9 6106.5 6140.0 5850.5 5899.9 5904.3 5908.9 5926.4 5869.9 5985.9 6032.6 6059.5 6094.0 5802.6 5813.5 5815.8 5816.9 5851.1 5907.7 5907.7 5908.8 5917.3 5930.7 5599.2 5682.5 5718.4 5743.4 5760.7 5730.6 5732.9 5761.6 5774.5 5800.0 5709.7 5711.7 5715.9 5716.4 5724.5 5539.9 5730.1 5773.8 5822.7 5828.4 5698.0 5703.1 5703.3 5706.8 5718.7 07:29:00 INFO - PROCESS | 29017 | 07:29:00 INFO - PROCESS | 29017 | [#1] ext.html Cycles:180 Average:59523.44 Median:424053.50 stddev:117967.71 (27.8%) stddev-sans-first:118215.57 07:29:00 INFO - PROCESS | 29017 | Values: 559.7 591.6 594.0 610.4 633.9 39337.4 43259.4 43483.8 43504.3 43507.3 43296.0 43777.3 43887.0 43921.8 43962.1 8831.2 8957.3 8969.6 8997.8 9018.3 8896.2 9047.8 9078.0 9079.3 9086.6 8829.3 8849.6 8866.8 8873.3 8887.4 9037.0 9077.0 9085.5 9085.8 9094.5 8857.4 8953.6 9003.4 9013.7 9015.3 41559.2 41658.2 41885.8 41911.4 41981.0 3532.6 3582.3 3611.5 3674.8 3756.3 33070.7 33506.8 33912.8 33995.5 34155.3 4431.5 4488.8 4495.9 4628.4 4656.5 260988.0 262067.0 262436.0 262475.0 263475.0 61367.0 61776.7 62287.4 62312.4 62323.0 64171.0 64623.4 64659.7 64852.7 64888.0 15900.0 16032.9 17203.4 17762.8 17792.6 12564.4 12663.2 12703.4 12721.2 12727.4 20096.4 20224.2 20268.4 20320.4 20383.4 7069.3 7236.2 7245.6 7312.3 7423.2 1016.6 1036.5 1045.5 1060.5 1077.5 33654.0 33768.5 33779.7 33974.3 34038.0 1124.0 1134.0 1149.8 1169.1 1181.7 17489.3 17724.6 17780.6 17832.0 17914.2 581138.0 583022.0 584439.0 586713.0 587297.0 60315.0 60546.0 60594.4 60649.1 60933.4 1346.7 1367.6 1385.3 1393.3 1401.0 31178.2 31903.4 32686.7 33002.5 33512.5 52092.0 52094.2 52346.5 52639.2 52848.7 422568.0 423408.0 423590.0 423764.0 424343.0 28548.4 28700.3 28848.6 28989.0 29042.9 49220.8 49677.3 50701.0 51295.5 51446.2 40133.8 42711.0 42884.4 43298.6 43758.6 41590.8 42459.4 42917.4 43020.4 43350.3 36020.6 41044.4 42072.9 42209.8 43383.6 35213.8 37251.0 37933.9 38476.0 38648.0 27967.7 29466.9 29980.9 30085.8 30135.4 07:29:00 INFO - PROCESS | 29017 | 07:29:00 INFO - PROCESS | 29017 | [#2] jquery.html Cycles:180 Average:28580.75 Median:24292.82 stddev:79770.35 (328.4%) stddev-sans-first:79966.03 07:29:00 INFO - PROCESS | 29017 | Values: 381.9 384.8 395.9 405.9 419.7 13941.4 18694.1 19595.2 20301.4 20411.8 19682.1 19781.2 20127.5 20382.5 20477.3 5768.7 5775.0 5884.7 5889.9 5916.8 5795.4 5833.8 5854.8 5865.3 5868.9 5701.8 5714.0 5745.3 5797.6 5856.2 5770.9 5834.9 5846.0 5850.6 5858.9 5034.5 5182.9 5195.1 5208.0 5213.0 23844.4 23845.3 24257.6 24328.0 24344.8 2358.8 2465.7 2482.5 2492.6 3074.4 15185.2 15187.6 15316.6 15326.8 15730.6 1881.4 1942.6 1954.2 1978.8 1986.0 75932.0 76403.6 76605.2 77413.6 80070.0 10798.2 10824.6 10909.8 11124.8 11358.8 15283.2 15296.0 15373.5 15380.4 15450.4 8402.9 8508.3 8633.0 8679.3 8785.5 8378.1 8403.8 8435.4 8678.4 8686.7 6726.6 6739.7 6751.0 6768.3 6984.7 1946.3 1991.4 1993.4 1996.7 1997.1 931.6 997.3 1014.9 1035.3 1089.9 20747.0 21162.8 21168.7 21309.0 21505.6 1017.0 1026.1 1064.2 1100.9 1157.2 9695.3 11826.5 12018.9 12094.3 12152.0 477949.0 480829.0 483178.0 485020.0 501894.0 81980.6 83151.0 83869.0 83968.0 84649.6 1042.6 1068.3 1077.6 1088.5 1102.0 15377.7 18169.5 18475.4 18541.7 18749.5 38105.8 39103.6 39138.0 39465.4 41760.4 49797.3 50628.7 51392.2 51987.7 53425.0 7588.7 8610.2 8766.1 8943.9 8994.7 11128.8 12996.6 13043.2 13078.8 13210.9 10556.0 10745.2 10795.0 11215.9 11283.5 11225.6 11285.5 11538.9 11655.6 11863.2 11088.5 11188.6 11327.3 11407.8 11563.7 7445.9 7781.6 7793.4 8204.9 8292.5 10602.6 10635.1 10908.8 11050.8 11276.4 07:29:00 INFO - PROCESS | 29017 | 07:29:00 INFO - PROCESS | 29017 | [#3] mootools.html Cycles:180 Average:5823.90 Median:2523.98 stddev:3310.07 (131.1%) stddev-sans-first:3303.15 07:29:00 INFO - PROCESS | 29017 | Values: 1465.4 1500.8 1604.5 1796.2 1804.4 7450.3 8463.7 8660.2 9075.0 9111.0 8613.6 8872.0 8881.0 8891.7 8893.0 2328.8 2343.7 2355.0 2367.9 2370.8 2305.3 2307.5 2376.0 2380.6 2382.1 2348.9 2362.1 2367.4 2370.6 2385.7 2293.4 2311.6 2327.9 2332.5 2344.2 2254.4 2266.8 2270.0 2274.1 2282.9 8889.6 8918.7 8969.4 8984.0 8996.1 5100.2 5179.8 5183.2 5207.8 5212.9 3274.7 3304.3 3402.4 3436.1 3568.9 1102.2 1146.1 1171.5 1186.2 1200.4 11894.0 12031.6 12052.2 12130.7 12180.8 4421.6 4586.5 4697.0 4700.5 4755.3 10321.4 10329.3 10329.5 10331.7 10332.7 5283.2 5309.9 5313.7 5320.2 5322.7 4304.9 4837.8 4904.7 4959.3 4970.8 3779.9 3928.4 4017.3 4023.1 4115.3 1253.9 1293.8 1296.3 1297.1 1304.7 972.8 991.8 1016.9 1028.2 1040.4 6002.5 6023.5 6034.2 6115.4 6175.7 451.4 457.7 461.5 463.0 478.1 4103.8 4298.6 4305.4 4333.4 4349.5 10713.3 10905.7 10956.2 11005.9 11020.9 10950.7 10956.0 10958.6 10962.1 10963.8 7834.5 8265.3 8289.3 8354.7 8374.2 5964.2 6057.8 6151.8 6220.2 6289.4 9909.2 10109.4 10170.9 10345.2 10376.4 9928.9 10383.8 10438.4 10483.5 10507.7 7373.9 8027.5 8140.6 8249.8 8404.7 8540.0 8548.1 8599.3 8620.6 8651.7 7545.7 7609.7 7663.4 7671.2 7790.8 7479.9 7515.4 7544.1 7641.4 7755.0 6775.4 6859.5 6871.6 6876.7 6881.2 4914.8 5243.0 5315.9 5395.8 5448.7 5279.2 5288.0 5314.7 5346.8 5407.3 07:29:00 INFO - PROCESS | 29017 | 07:29:00 INFO - PROCESS | 29017 | [#4] prototype.html Cycles:180 Average:4870.26 Median:5512.20 stddev:1434.94 (26.0%) stddev-sans-first:1397.63 07:29:00 INFO - PROCESS | 29017 | Values: 314.3 324.0 327.4 331.2 333.6 5510.9 5599.3 5642.9 5699.5 5711.7 5513.5 5566.0 5566.9 5571.2 5602.7 4349.2 4361.7 4386.9 4388.4 4396.9 4258.8 4336.9 4347.8 4383.1 4388.6 4290.1 4308.9 4311.6 4313.6 4316.6 4300.8 4301.3 4303.8 4304.3 4377.7 3667.6 3807.4 3814.4 3831.1 3842.8 5450.5 5467.5 5467.6 5471.0 5497.0 4982.3 5000.3 5002.6 5028.3 5031.2 5580.4 5788.4 5891.6 5892.1 5902.8 4139.2 4144.9 4153.1 4187.8 4188.5 5840.2 5950.5 6116.5 6177.6 6183.2 4184.8 4191.6 4206.4 4242.4 4251.5 4257.7 4295.2 4310.2 4314.9 4316.9 4837.6 4913.8 4924.0 4948.2 4948.8 5778.9 5855.8 5867.9 5875.3 5916.8 1462.3 1474.2 1480.2 1485.9 1488.7 907.1 941.0 953.5 956.5 960.6 5025.5 5049.7 5085.6 5088.3 5119.8 5311.9 5337.8 5344.8 5376.0 5377.9 5057.3 5087.1 5212.8 5310.8 5688.1 3191.9 3210.5 3218.4 3223.3 3224.2 6032.9 6208.5 6225.4 6232.9 6259.2 6034.6 6104.3 6112.4 6116.9 6124.7 6159.3 6160.0 6200.8 6206.2 6214.4 5736.9 5961.8 5962.9 5994.2 6017.6 5865.3 5875.4 5921.3 5937.9 5961.8 5907.3 5981.3 6124.5 6168.8 6182.0 4200.2 4204.3 4231.5 4239.2 4248.2 5765.5 5955.2 5976.4 5988.0 5996.3 5787.6 5818.2 5830.2 5838.5 5844.6 5811.4 5813.5 5826.2 5828.1 5832.7 5468.9 5712.4 5729.5 5753.2 5804.6 5869.2 5909.5 5909.8 5912.3 5942.6 5590.3 5737.5 5773.7 5781.7 5793.2 07:29:00 INFO - PROCESS | 29017 | 07:29:00 INFO - PROCESS | 29017 | [#5] yui.html Cycles:180 Average:20210.23 Median:4897.22 stddev:27636.35 (564.3%) stddev-sans-first:27675.42 07:29:00 INFO - PROCESS | 29017 | Values: 795.0 807.8 816.3 845.4 872.3 15711.0 16692.7 16721.7 16766.8 16842.9 15189.5 15304.2 15333.6 15370.4 15429.2 797.0 838.5 843.9 844.7 845.6 841.8 843.3 843.7 844.4 844.4 884.8 885.1 885.9 887.3 887.4 877.2 878.9 886.5 886.9 888.9 644.6 644.9 645.0 645.1 645.7 15967.7 15993.2 16021.7 16062.6 16109.4 14523.0 14767.3 14822.1 14837.3 14920.2 12831.7 12870.4 12911.4 12974.0 13061.9 3894.6 4007.7 4014.1 4068.3 4091.5 83557.6 83791.6 84317.6 84320.6 84584.6 11754.4 11859.3 11930.7 12213.7 12337.6 22164.8 22220.8 22226.8 22286.9 22325.9 8822.3 8898.9 9029.1 9063.1 9178.5 4874.2 4889.6 4904.9 5036.6 5089.8 3541.9 3651.4 3660.1 3660.1 3664.3 588.3 604.8 606.8 614.8 630.3 656.0 666.6 729.2 757.6 767.1 9498.8 9564.4 9657.3 9831.0 9905.8 625.7 700.9 726.5 753.8 772.7 4371.6 4375.5 4676.2 4735.8 4746.3 66077.7 68842.0 68953.0 78053.0 123633.0 57510.0 85069.0 103720.0 104052.0 105209.5 67934.7 74052.0 93205.5 93798.0 94502.0 9330.0 9652.9 9655.3 9669.8 9772.6 51649.0 51962.0 52419.7 53250.0 53353.5 68993.7 71296.6 78262.2 78873.6 80978.6 13384.8 13614.2 13682.4 13908.4 14036.7 15297.5 15690.9 15763.6 15897.2 16509.4 14453.9 14460.3 14741.3 14983.1 15259.0 14039.4 14433.4 14520.0 14521.9 14741.2 13536.2 14064.3 14125.6 14555.9 15072.8 10751.9 10766.0 11162.3 11320.8 11325.9 10801.6 11835.2 12004.2 12073.1 12644.6 07:29:00 INFO - PROCESS | 29017 | -------- Summary: end -------- 07:29:00 INFO - PROCESS | 29017 | 07:29:00 INFO - TEST-INFO | 29017: exit 0 07:29:00 INFO - TEST-OK | dromaeo_css | took 1110942ms 07:29:00 INFO - TEST-START | kraken 07:29:00 INFO - operating with platform_type : linux_ 07:29:00 INFO - Initialising browser for kraken test... 07:29:00 INFO - TEST-INFO | started process 29262 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3nQelT/profile http://localhost:34491/getInfo.html) 07:29:04 INFO - PROCESS | 29262 | __metrics Screen width/height:1600/1200 07:29:04 INFO - PROCESS | 29262 | colorDepth:24 07:29:04 INFO - PROCESS | 29262 | Browser inner width/height: 1024/697 07:29:04 INFO - PROCESS | 29262 | __metrics 07:29:05 ERROR - PROCESS | 29262 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 07:29:05 INFO - TEST-INFO | 29262: exit 0 07:29:05 INFO - Browser initialized. 07:29:05 INFO - Running cycle 1/1 for kraken test... 07:29:05 INFO - TEST-INFO | started process 29380 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3nQelT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:29:17 INFO - PROCESS | 29380 | RSS: Main: 167436288 07:29:17 INFO - PROCESS | 29380 | 07:29:20 INFO - PROCESS | 29380 | Cycle 1(1): loaded http://localhost:34491/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34491/tests/kraken/driver.html?testName=audio-beat-detection) 07:29:21 INFO - PROCESS | 29380 | RSS: Main: 173617152 07:29:21 INFO - PROCESS | 29380 | 07:29:23 INFO - PROCESS | 29380 | Cycle 1(1): loaded http://localhost:34491/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34491/tests/kraken/driver.html?testName=audio-dft) 07:29:24 INFO - PROCESS | 29380 | RSS: Main: 171872256 07:29:24 INFO - PROCESS | 29380 | 07:29:27 INFO - PROCESS | 29380 | Cycle 1(1): loaded http://localhost:34491/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34491/tests/kraken/driver.html?testName=audio-fft) 07:29:27 INFO - PROCESS | 29380 | RSS: Main: 168357888 07:29:27 INFO - PROCESS | 29380 | 07:29:29 INFO - PROCESS | 29380 | Cycle 1(1): loaded http://localhost:34491/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34491/tests/kraken/driver.html?testName=audio-oscillator) 07:29:30 INFO - PROCESS | 29380 | RSS: Main: 168914944 07:29:30 INFO - PROCESS | 29380 | 07:29:32 INFO - PROCESS | 29380 | Cycle 1(1): loaded http://localhost:34491/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34491/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:29:33 INFO - PROCESS | 29380 | RSS: Main: 168984576 07:29:33 INFO - PROCESS | 29380 | 07:29:36 INFO - PROCESS | 29380 | Cycle 1(1): loaded http://localhost:34491/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34491/tests/kraken/driver.html?testName=imaging-darkroom) 07:29:37 INFO - PROCESS | 29380 | RSS: Main: 168886272 07:29:37 INFO - PROCESS | 29380 | 07:29:40 INFO - PROCESS | 29380 | Cycle 1(1): loaded http://localhost:34491/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34491/tests/kraken/driver.html?testName=imaging-desaturate) 07:29:41 INFO - PROCESS | 29380 | RSS: Main: 166838272 07:29:41 INFO - PROCESS | 29380 | 07:29:43 INFO - PROCESS | 29380 | Cycle 1(1): loaded http://localhost:34491/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34491/tests/kraken/driver.html?testName=json-parse-financial) 07:29:44 INFO - PROCESS | 29380 | RSS: Main: 168419328 07:29:44 INFO - PROCESS | 29380 | 07:29:46 INFO - PROCESS | 29380 | Cycle 1(1): loaded http://localhost:34491/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34491/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:29:46 INFO - PROCESS | 29380 | RSS: Main: 168497152 07:29:46 INFO - PROCESS | 29380 | 07:29:48 INFO - PROCESS | 29380 | Cycle 1(1): loaded http://localhost:34491/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34491/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:29:49 INFO - PROCESS | 29380 | RSS: Main: 168730624 07:29:49 INFO - PROCESS | 29380 | 07:29:51 INFO - PROCESS | 29380 | Cycle 1(1): loaded http://localhost:34491/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34491/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:29:52 INFO - PROCESS | 29380 | RSS: Main: 169246720 07:29:52 INFO - PROCESS | 29380 | 07:29:54 INFO - PROCESS | 29380 | Cycle 1(1): loaded http://localhost:34491/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34491/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:29:55 INFO - PROCESS | 29380 | RSS: Main: 169365504 07:29:55 INFO - PROCESS | 29380 | 07:29:58 INFO - PROCESS | 29380 | Cycle 1(1): loaded http://localhost:34491/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34491/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:29:58 INFO - PROCESS | 29380 | RSS: Main: 169119744 07:29:58 INFO - PROCESS | 29380 | 07:30:00 INFO - PROCESS | 29380 | Cycle 1(1): loaded http://localhost:34491/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34491/tests/kraken/driver.html?testName=ai-astar) 07:30:00 INFO - PROCESS | 29380 | RSS: Main: 169906176 07:30:00 INFO - PROCESS | 29380 | 07:30:00 INFO - PROCESS | 29380 | __start_tp_report 07:30:00 INFO - PROCESS | 29380 | _x_x_mozilla_page_load 07:30:00 INFO - PROCESS | 29380 | _x_x_mozilla_page_load_details 07:30:00 INFO - PROCESS | 29380 | |i|pagename|runs| 07:30:00 INFO - PROCESS | 29380 | |0;ai-astar;103;112;107;113;112;113;114;112;112;112 07:30:00 INFO - PROCESS | 29380 | |1;audio-beat-detection;150;117;150;176;124;146;148;120;175;118 07:30:00 INFO - PROCESS | 29380 | |2;audio-dft;163;161;160;161;164;164;167;165;163;165 07:30:00 INFO - PROCESS | 29380 | |3;audio-fft;75;76;78;167;76;75;75;77;172;76 07:30:00 INFO - PROCESS | 29380 | |4;audio-oscillator;83;83;152;85;83;84;141;84;84;133 07:30:00 INFO - PROCESS | 29380 | |5;imaging-gaussian-blur;117;118;117;118;117;117;117;120;118;118 07:30:00 INFO - PROCESS | 29380 | |6;imaging-darkroom;148;149;146;151;147;148;147;148;146;148 07:30:00 INFO - PROCESS | 29380 | |7;imaging-desaturate;96;94;96;95;97;96;96;96;96;96 07:30:00 INFO - PROCESS | 29380 | |8;json-parse-financial;52;53;54;52;52;52;56;52;52;54 07:30:00 INFO - PROCESS | 29380 | |9;json-stringify-tinderbox;63;64;63;63;64;63;63;62;66;64 07:30:00 INFO - PROCESS | 29380 | |10;stanford-crypto-aes;76;77;76;76;77;77;84;79;84;77 07:30:00 INFO - PROCESS | 29380 | |11;stanford-crypto-ccm;124;145;122;124;144;126;138;131;169;124 07:30:00 INFO - PROCESS | 29380 | |12;stanford-crypto-pbkdf2;164;165;169;171;165;157;160;158;161;159 07:30:00 INFO - PROCESS | 29380 | |13;stanford-crypto-sha256-iterative;63;68;65;64;65;65;64;63;65;64 07:30:00 INFO - PROCESS | 29380 | __end_tp_report 07:30:00 INFO - PROCESS | 29380 | __start_cc_report 07:30:00 INFO - PROCESS | 29380 | _x_x_mozilla_cycle_collect,935 07:30:00 INFO - PROCESS | 29380 | __end_cc_report 07:30:00 INFO - PROCESS | 29380 | __startTimestamp1469025000590__endTimestamp 07:30:00 INFO - PROCESS | 29380 | 07:30:00 INFO - PROCESS | 29380 | ------- Summary: start ------- 07:30:00 INFO - PROCESS | 29380 | Number of tests: 14 07:30:00 INFO - PROCESS | 29380 | 07:30:00 INFO - PROCESS | 29380 | [#0] ai-astar Cycles:10 Average:111.00 Median:112.00 stddev:3.37 (3.0%) stddev-sans-first:1.96 07:30:00 INFO - PROCESS | 29380 | Values: 103.0 112.0 107.0 113.0 112.0 113.0 114.0 112.0 112.0 112.0 07:30:00 INFO - PROCESS | 29380 | 07:30:00 INFO - PROCESS | 29380 | [#1] audio-beat-detection Cycles:10 Average:142.40 Median:149.00 stddev:22.19 (14.9%) stddev-sans-first:23.37 07:30:00 INFO - PROCESS | 29380 | Values: 150.0 117.0 150.0 176.0 124.0 146.0 148.0 120.0 175.0 118.0 07:30:00 INFO - PROCESS | 29380 | 07:30:00 INFO - PROCESS | 29380 | [#2] audio-dft Cycles:10 Average:163.30 Median:164.00 stddev:2.16 (1.3%) stddev-sans-first:2.29 07:30:00 INFO - PROCESS | 29380 | Values: 163.0 161.0 160.0 161.0 164.0 164.0 167.0 165.0 163.0 165.0 07:30:00 INFO - PROCESS | 29380 | 07:30:00 INFO - PROCESS | 29380 | [#3] audio-fft Cycles:10 Average:94.70 Median:76.00 stddev:39.45 (51.9%) stddev-sans-first:41.20 07:30:00 INFO - PROCESS | 29380 | Values: 75.0 76.0 78.0 167.0 76.0 75.0 75.0 77.0 172.0 76.0 07:30:00 INFO - PROCESS | 29380 | 07:30:00 INFO - PROCESS | 29380 | [#4] audio-oscillator Cycles:10 Average:101.20 Median:83.50 stddev:28.52 (34.2%) stddev-sans-first:29.48 07:30:00 INFO - PROCESS | 29380 | Values: 83.0 83.0 152.0 85.0 83.0 84.0 141.0 84.0 84.0 133.0 07:30:00 INFO - PROCESS | 29380 | 07:30:00 INFO - PROCESS | 29380 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.95 (0.8%) stddev-sans-first:0.97 07:30:00 INFO - PROCESS | 29380 | Values: 117.0 118.0 117.0 118.0 117.0 117.0 117.0 120.0 118.0 118.0 07:30:00 INFO - PROCESS | 29380 | 07:30:00 INFO - PROCESS | 29380 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:148.00 stddev:1.48 (1.0%) stddev-sans-first:1.56 07:30:00 INFO - PROCESS | 29380 | Values: 148.0 149.0 146.0 151.0 147.0 148.0 147.0 148.0 146.0 148.0 07:30:00 INFO - PROCESS | 29380 | 07:30:00 INFO - PROCESS | 29380 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.79 (0.8%) stddev-sans-first:0.83 07:30:00 INFO - PROCESS | 29380 | Values: 96.0 94.0 96.0 95.0 97.0 96.0 96.0 96.0 96.0 96.0 07:30:00 INFO - PROCESS | 29380 | 07:30:00 INFO - PROCESS | 29380 | [#8] json-parse-financial Cycles:10 Average:52.90 Median:52.50 stddev:1.37 (2.6%) stddev-sans-first:1.41 07:30:00 INFO - PROCESS | 29380 | Values: 52.0 53.0 54.0 52.0 52.0 52.0 56.0 52.0 52.0 54.0 07:30:00 INFO - PROCESS | 29380 | 07:30:00 INFO - PROCESS | 29380 | [#9] json-stringify-tinderbox Cycles:10 Average:63.50 Median:63.50 stddev:1.08 (1.7%) stddev-sans-first:1.13 07:30:00 INFO - PROCESS | 29380 | Values: 63.0 64.0 63.0 63.0 64.0 63.0 63.0 62.0 66.0 64.0 07:30:00 INFO - PROCESS | 29380 | 07:30:00 INFO - PROCESS | 29380 | [#10] stanford-crypto-aes Cycles:10 Average:78.30 Median:77.00 stddev:3.13 (4.1%) stddev-sans-first:3.21 07:30:00 INFO - PROCESS | 29380 | Values: 76.0 77.0 76.0 76.0 77.0 77.0 84.0 79.0 84.0 77.0 07:30:00 INFO - PROCESS | 29380 | 07:30:00 INFO - PROCESS | 29380 | [#11] stanford-crypto-ccm Cycles:10 Average:134.70 Median:134.50 stddev:14.81 (11.0%) stddev-sans-first:15.19 07:30:00 INFO - PROCESS | 29380 | Values: 124.0 145.0 122.0 124.0 144.0 126.0 138.0 131.0 169.0 124.0 07:30:00 INFO - PROCESS | 29380 | 07:30:00 INFO - PROCESS | 29380 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.90 Median:164.50 stddev:4.70 (2.9%) stddev-sans-first:4.97 07:30:00 INFO - PROCESS | 29380 | Values: 164.0 165.0 169.0 171.0 165.0 157.0 160.0 158.0 161.0 159.0 07:30:00 INFO - PROCESS | 29380 | 07:30:00 INFO - PROCESS | 29380 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.60 Median:65.00 stddev:1.43 (2.2%) stddev-sans-first:1.39 07:30:00 INFO - PROCESS | 29380 | Values: 63.0 68.0 65.0 64.0 65.0 65.0 64.0 63.0 65.0 64.0 07:30:00 INFO - PROCESS | 29380 | -------- Summary: end -------- 07:30:00 INFO - PROCESS | 29380 | 07:30:01 INFO - TEST-INFO | 29380: exit 0 07:30:01 INFO - TEST-OK | kraken | took 60702ms 07:30:01 INFO - SUITE-END | took 1171s 07:30:01 INFO - Completed test suite (00:19:31) 07:30:01 INFO - javascript benchmark 07:30:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7392.12010121126, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3077.692230776922, 3090.0, 3101.3952279305518, 3106.083705306934, 3111.9533207001914, 5445.972770136149, 5490.313710786157, 5522.889542209154, 5541.750621222044, 5582.078956972095, 5313.0, 5388.865278368043, 5441.755121019553, 5490.588205884555, 5513.393526712059, 4894.5105489451125, 4923.138450771118, 4939.901201975958, 5033.094043072246, 5034.3455350804525, 4932.260160975847, 5013.298138260647, 5040.924386134211, 5051.7726702298305, 5063.0, 4880.731559764212, 4889.633277504201, 4930.580900623451, 4974.452810190876, 4984.053029924321, 4945.332380128672, 4953.975230123826, 4959.8264060758065, 4970.453250142481, 4991.3511243538105, 4880.731559764212, 4909.582685471739, 4932.03825254072, 4942.5304596063315, 4971.801127954877, 5367.516923476866, 5373.328333958255, 5452.291202143736, 5452.809151679712, 5477.75350109242, 5852.619579727347, 5868.354481007086, 5878.5297176225795, 5891.440313170242, 5929.73316200772, 5908.113782932552, 5929.525637948954, 5932.644041357489, 5936.821895343147, 5949.315828679671, 5328.866778330534, 5452.454754524555, 5490.258815059956, 5497.038018346813, 5521.978433989725, 6089.756409743561, 6093.177421048191, 6100.0, 6104.084387341934, 6132.2947860996555, 5849.53203743708, 5849.853753656107, 5859.1797148399255, 5860.179574859523, 5868.23712917318, 5712.542996560265, 5758.251427314506, 5797.623154494944, 5819.039858423397, 5914.319853216849, 5595.524380427709, 5685.687287199244, 5701.344345400249, 5737.799177028867, 5870.324912635102, 5703.429657034347, 5750.453706897838, 5765.250517432791, 5771.94228057714, 5787.826365209051, 4470.351798989193, 4482.238019536687, 4485.798139083749, 4524.2082635538645, 4524.524924882906, 3947.348687466593, 3959.9604003960167, 3997.060690737674, 4000.5599384067727, 4019.8191081401405, 5502.147167189092, 5608.1587761835235, 5641.689707066151, 5664.0, 5665.631733937281, 5837.737301821428, 5879.059350503899, 5880.529557635465, 5906.350301466835, 5950.077737950624, 5613.0, 5629.549636029108, 5634.267545219095, 5642.548596112301, 5644.6330988485615, 4936.136176169228, 5004.724740139327, 5029.06962211992, 5043.36957880265, 5052.0, 6055.1522786809, 6089.0, 6096.908546371808, 6106.45041946227, 6140.048292514667, 5850.5027072699295, 5899.911501327398, 5904.3210030847, 5908.852278693067, 5926.407359264212, 5869.94130058711, 5985.880282394415, 6032.577719559588, 6059.454649081604, 6093.969530152321, 5802.564807639359, 5813.505852002627, 5815.767369305349, 5816.883662326814, 5851.093080572518, 5907.704614769158, 5907.734151963086, 5908.793192238251, 5917.289925209003, 5930.733117009831, 5599.160125981135, 5682.545396368363, 5718.428157184248, 5743.4256574342235, 5760.740766665594, 5730.570207234391, 5732.914006289826, 5761.596688231783, 5774.538036957118, 5800.0, 5709.65742055478, 5711.685857277724, 5715.8571035724435, 5716.399778023248, 5724.542036636975, 5539.861503462284, 5730.054541000688, 5773.826785196451, 5822.650640961556, 5828.388019257917, 5698.0, 5703.144528320619, 5703.315602127771, 5706.771729130788, 5718.742656580381], "value": 5403.328800462574, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [559.7088722756218, 591.6450129922047, 593.9724277000786, 610.4140025575448, 633.9334369891164, 39337.409938850906, 43259.35110973334, 43483.78258108709, 43504.347434788506, 43507.34738978918, 43296.0, 43777.343339849926, 43887.0, 43921.78039109808, 43962.12075758483, 8831.205191532777, 8957.328200384965, 8969.596368163415, 8997.775055623597, 9018.286525560155, 8896.15486528782, 9047.773805654846, 9078.048219632778, 9079.273658107368, 9086.636534538611, 8829.293656507463, 8849.646014159425, 8866.822663546725, 8873.3344999125, 8887.422317549339, 9036.954815225914, 9077.001529831714, 9085.454872707625, 9085.81828363429, 9094.49980251086, 8857.379983401164, 8953.552322383855, 9003.369764116514, 9013.684521041732, 9015.323850711224, 41559.168816623496, 41658.1668366631, 41885.790571047255, 41911.37132943008, 41981.0, 3532.5760908691122, 3582.3193593217206, 3611.5124458198334, 3674.816259187057, 3756.3426400379826, 33070.669293307, 33506.83246583776, 33912.83043584766, 33995.49006764901, 34155.31689366224, 4431.49037860647, 4488.842890498817, 4495.9325610115875, 4628.398308219944, 4656.511066338054, 260988.0, 262067.0, 262436.0, 262475.0, 263475.0, 61367.0, 61776.69111654413, 62287.37712622906, 62312.37687623066, 62323.0, 64171.0, 64623.35376646267, 64659.67670161713, 64852.67573662196, 64888.0, 15900.0, 16032.919835400748, 17203.397881074103, 17762.822371776376, 17792.555186120193, 12564.371781410893, 12663.240205587694, 12703.364831758376, 12721.236725796482, 12727.427265773062, 20096.39710808678, 20224.191032358834, 20268.391948241577, 20320.390388288375, 20383.388498345073, 7069.293070692889, 7236.240194779578, 7245.637718114179, 7312.341889229995, 7423.183449820515, 1016.5527168046036, 1036.4972988100765, 1045.4929359260752, 1060.5015642647943, 1077.4935780183457, 33654.0, 33768.49347259793, 33779.662203378146, 33974.320513590086, 34038.0, 1123.9943800280946, 1133.9546418143182, 1149.7585507043614, 1169.128998895828, 1181.704573856536, 17489.300427982736, 17724.645507089786, 17780.644387112185, 17832.0, 17914.193861276275, 581138.0, 583022.0, 584439.0, 586713.0, 587297.0, 60315.0, 60546.0, 60594.394056059755, 60649.09026364608, 60933.390666092775, 1346.696993176547, 1367.6170672211797, 1385.2865774126333, 1393.3312010235145, 1401.0472878442756, 31178.22054448657, 31903.361932760752, 32686.673133268363, 33002.504962425104, 33512.49731253985, 52092.0, 52094.21858672199, 52346.476535234164, 52639.21041184462, 52848.73575632097, 422568.0, 423408.0, 423590.0, 423764.0, 424343.0, 28548.42903141884, 28700.282492937844, 28848.567271491363, 28989.0, 29042.854785725936, 49220.753896230286, 49677.25484117669, 50701.0, 51295.48704513056, 51446.22830657618, 40133.79933100316, 42711.0, 42884.35673464963, 43298.567014330714, 43758.56241437545, 41590.792046039576, 42459.363109554, 42917.356239657056, 43020.35469468023, 43350.34974475322, 36020.63979360278, 41044.38433423441, 42072.8963551815, 42209.788951055045, 43383.566164339216, 35213.82393088018, 37251.0, 37933.90863400258, 38476.0, 38648.0, 27967.72032279651, 29466.85266573739, 29980.85009574938, 30085.849570752882, 30135.397292054473], "value": 20453.52564675609, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [381.856803698613, 384.77490667959245, 395.91883663848915, 405.9289624315745, 419.74605363754927, 13941.442342306296, 18694.065296735178, 19595.21619135233, 20301.39095827126, 20411.75470698222, 19682.11430485628, 19781.208751649952, 20127.49681257969, 20382.490437739063, 20477.283295084675, 5768.711564421783, 5774.971125144379, 5884.6763428011445, 5889.941100589003, 5916.792912248072, 5795.362510123883, 5833.766649334021, 5854.824355269348, 5865.296164460249, 5868.9413105869035, 5701.77192912283, 5714.0, 5745.253117094772, 5797.594168408213, 5856.150858125569, 5770.855728606776, 5834.941650583482, 5845.970770146122, 5850.619709718876, 5858.88282234355, 5034.471380505068, 5182.948170518322, 5195.116830138885, 5208.0365132450615, 5212.983468223698, 23844.40388990272, 23845.284641460785, 24257.636135457982, 24328.0, 24344.756552434425, 2358.8230882683865, 2465.7041155061506, 2482.515909397668, 2492.6385674077155, 3074.3697542003833, 15185.240737963057, 15187.62030949224, 15316.617084572976, 15326.846731532654, 15730.606734831606, 1881.4261650196684, 1942.6406114868653, 1954.2183126749271, 1978.7724411692695, 1985.9702104468445, 75932.0, 76403.61798190973, 76605.23394766037, 77413.61293193554, 80070.0, 10798.190135739851, 10824.567017319376, 10909.83635245472, 11124.833127503094, 11358.829617555743, 15283.159426231441, 15296.0, 15373.461928832661, 15380.38478460849, 15450.381984720485, 8402.915970840335, 8508.319334453228, 8633.0, 8679.349048821363, 8785.472871627722, 8378.12029736881, 8403.789905252295, 8435.409521333571, 8678.39251252419, 8686.695965641173, 6726.623136626833, 6739.696713647898, 6751.0, 6768.255491895888, 6984.707829051642, 1946.279876445724, 1991.432441754122, 1993.3720877923408, 1996.6605677034938, 1997.131247907165, 931.6273490603677, 997.3068717241448, 1014.8934361892043, 1035.29082578434, 1089.8583184186164, 20747.0, 21162.788372116083, 21168.682469762967, 21309.0, 21505.569888602142, 1016.9644062457778, 1026.0970346095537, 1064.2390690656218, 1100.944952752359, 1157.1957489544686, 9695.321327507148, 11826.5216847894, 12018.939905300418, 12094.334811585271, 12152.0, 477949.0, 480829.0, 483178.0, 485020.0, 501894.0, 81980.59009704913, 83151.0, 83869.0, 83968.0, 84649.57675211584, 1042.5621239079605, 1068.3216157739892, 1077.606673564159, 1088.5156105532963, 1102.0302134122082, 15377.69244615079, 18169.545761356072, 18475.353362632242, 18541.721874171628, 18749.531261718566, 38105.80947095247, 39103.608963909996, 39138.0, 39465.40801888031, 41760.37359439672, 49797.253041205135, 50628.74685626548, 51392.22911656403, 51987.74006129945, 53425.0, 7588.658510366937, 8610.225079742853, 8766.123387661182, 8943.865842012505, 8994.685186018458, 11128.833067503832, 12996.610101696964, 13043.152195107288, 13078.80381794293, 13210.867891320964, 10556.049955504042, 10745.24783265164, 10795.0, 11215.943920280346, 11283.548658053585, 11225.60710375133, 11285.548578056785, 11538.94230528842, 11655.592054278399, 11863.169578129447, 11088.501017454395, 11188.552457901593, 11327.263727857662, 11407.771844562896, 11563.710907227387, 7445.9255407445235, 7781.610919454118, 7793.4154938378715, 8204.917950820654, 8292.543910085004, 10602.628907988183, 10635.14918806478, 10908.836367454653, 11050.834237486284, 11276.379799111128], "value": 9427.112607320872, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1465.4211586423362, 1500.7748837674349, 1604.4785444730464, 1796.1737600703684, 1804.3865085870802, 7450.329470347668, 8463.703770368038, 8660.220580147785, 9075.0, 9110.99999999999, 8613.569321533929, 8871.955640221806, 8880.95559522203, 8891.733248002554, 8893.021767605574, 2328.75548067453, 2343.742188359279, 2355.0, 2367.9052837886466, 2370.7866292033714, 2305.2738387408, 2307.538492301538, 2376.0, 2380.571497130516, 2382.0709923129994, 2348.941276468085, 2362.137819695816, 2367.4199821043867, 2370.6088495398326, 2385.666006759055, 2293.438107663633, 2311.641695537194, 2327.9418014549688, 2332.5334933013464, 2344.179537161997, 2254.402583315423, 2266.7506574276817, 2269.954600907989, 2274.0676322707777, 2282.8744419056943, 8889.599968001456, 8918.73243802687, 8969.372143949926, 8983.955080224623, 8996.100389961017, 5100.15847385181, 5179.8446046618665, 5183.222516622499, 5207.765650545734, 5212.8957420851375, 3274.721648659867, 3304.306095719902, 3402.3535528249554, 3436.1409647588102, 3568.9107772305642, 1102.1568500097433, 1146.1003112556602, 1171.537242789102, 1186.2230239193343, 1200.4177973682756, 11894.0, 12031.578894738643, 12052.156349055569, 12130.696732581757, 12180.756384872342, 4421.579949904753, 4586.472555656075, 4697.037107392976, 4700.529947005341, 4755.334253204554, 10321.380717156995, 10329.276950613385, 10329.483525823678, 10331.74170645725, 10332.690019299433, 5283.1546952487415, 5309.867253318698, 5313.654612450178, 5320.201969704498, 5322.680639161663, 4304.935425968613, 4837.806487740521, 4904.730239836843, 4959.256111583291, 4970.751462426936, 3779.905502362463, 3928.3910993796007, 4017.31705610047, 4023.0948036692093, 4115.300398932189, 1253.924764514132, 1293.7735896218123, 1296.293520031585, 1297.098516531002, 1304.706441050756, 972.8297547929226, 991.8264303746815, 1016.9237307201842, 1028.2493779540828, 1040.427764729396, 6002.4897883679505, 6023.45788879003, 6034.185384972972, 6115.357887421846, 6175.660338681326, 451.4086546623933, 457.7093545598569, 461.4969683045429, 462.95601917817754, 478.09401184754694, 4103.753774773523, 4298.570142985676, 4305.354196870495, 4333.393324934512, 4349.499807522112, 10713.303635263683, 10905.672829815117, 10956.233063685624, 11005.889941100646, 11020.889791102147, 10950.671479855617, 10956.013958743752, 10958.616448424425, 10962.068224201032, 10963.83554246687, 7834.4907581007055, 8265.297449716722, 8289.253967143106, 8354.665813367397, 8374.162583741578, 5964.194833697569, 6057.818265452043, 6151.84620384494, 6220.160278362363, 6289.371062893674, 9909.207263419054, 10109.443980580845, 10170.949145254226, 10345.172386209235, 10376.429296388771, 9928.900710992797, 10383.792324153626, 10438.37369757817, 10483.528241229316, 10507.73730656709, 7373.9262607375385, 8027.478213916077, 8140.592970351578, 8249.79375515617, 8404.705835295736, 8539.957300213458, 8548.102449242988, 8599.26906212979, 8620.61207245663, 8651.740447786577, 7545.7358992435, 7609.733659321897, 7663.425243106901, 7671.194524574839, 7790.805229869298, 7479.887801683088, 7515.398768098648, 7544.0569928758905, 7641.3886889047635, 7755.0, 6775.356341147583, 6859.485538584527, 6871.587704737732, 6876.656167191521, 6881.243063263138, 4914.7542622867995, 5243.0, 5315.946840531546, 5395.838124856261, 5448.727563621882, 5279.1817268323475, 5287.9735601321745, 5314.654547454403, 5346.812861549983, 5407.297051383295], "value": 4595.713374362665, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [314.25364758698095, 323.977321587489, 327.3681794137315, 331.17041810265283, 333.5946824608101, 5510.91733623995, 5599.328080630325, 5642.858928526789, 5699.5440364770775, 5711.714414279285, 5513.476219759126, 5566.0, 5566.888662226763, 5571.164325351199, 5602.719864006804, 4349.217140914634, 4361.694681372305, 4386.912261754763, 4388.379586840869, 4396.89007774805, 4258.808353624095, 4336.869893903188, 4347.78261086946, 4383.145286669101, 4388.6050255477, 4290.141971605692, 4308.913821723564, 4311.611954924057, 4313.568643135693, 4316.56834316569, 4300.78496075195, 4301.3117901135665, 4303.763293018883, 4304.289792184286, 4377.715448495869, 3667.633236676311, 3807.428885667144, 3814.4278358246206, 3831.080540670247, 3842.7502212356108, 5450.4549545045575, 5467.535259502907, 5467.617266791326, 5470.972645136789, 5496.966122534688, 4982.327385802942, 5000.349954505928, 5002.648755085104, 5028.34631497903, 5031.245313203012, 5580.358258800249, 5788.363280039192, 5891.553441236882, 5892.145638882338, 5902.793402230901, 4139.151473947833, 4144.896377590554, 4153.1486045360625, 4187.790610469495, 4188.518320393133, 5840.182374467578, 5950.464458198783, 6116.4800991915745, 6177.567570270083, 6183.196184495987, 4184.811683474251, 4191.601797829201, 4206.390073439334, 4242.363645453207, 4251.489821221473, 4257.723247988871, 4295.162443323522, 4310.181065597527, 4314.935275970863, 4316.935245971313, 4837.588804951619, 4913.7973865951635, 4923.950760492421, 4948.233023881304, 4948.752562371867, 5778.855528611734, 5855.765769369263, 5867.882642347215, 5875.265591801025, 5916.792912248051, 1462.2834810942775, 1474.240766005508, 1480.193294654416, 1485.9405623774928, 1488.6650503636595, 907.0965515541371, 940.9623615055322, 953.5280036382036, 956.5360800011989, 960.5629438605417, 5025.542592648091, 5049.747512624354, 5085.644004919694, 5088.262201980692, 5119.769610367543, 5311.911058233053, 5337.759800808973, 5344.759485823147, 5375.973120134452, 5377.865553361119, 5057.31726216956, 5087.084324821493, 5212.774997875496, 5310.761015754223, 5688.146777983253, 3191.872325107016, 3210.486322188439, 3218.4206842768526, 3223.3069889973767, 3224.161717953349, 6032.879342413127, 6208.534359923024, 6225.408586184305, 6232.906506402408, 6259.2488901332135, 6034.63792172471, 6104.321311639334, 6112.449879510777, 6116.8776624468155, 6124.724387402578, 6159.260888693296, 6159.96920015406, 6200.782972596027, 6206.224221972254, 6214.421015278699, 5736.903006014001, 5961.791337303173, 5962.910556341745, 5994.160817485643, 6017.638941663514, 5865.3254875689845, 5875.383084776208, 5921.282827979838, 5937.881242375215, 5961.7778355437895, 5907.261592300963, 5981.252343457068, 6124.510039196764, 6168.814935551941, 6181.9690901547, 4200.243956087934, 4204.264253755519, 4231.534531201503, 4239.194553034913, 4248.171606536695, 5765.509931655856, 5955.225820643289, 5976.400265884355, 5988.0, 5996.2504686914135, 5787.594868359343, 5818.185454036523, 5830.154627579062, 5838.474537291664, 5844.620099693507, 5811.418858114154, 5813.534917206698, 5826.213461182686, 5828.105865593614, 5832.650040997553, 5468.890622187613, 5712.42875712442, 5729.455701708331, 5753.223314852441, 5804.593678442638, 5869.236999190078, 5909.483857105016, 5909.793157239476, 5912.285437223157, 5942.61373010753, 5590.273264475592, 5737.512311453574, 5773.711314434346, 5781.682007489629, 5793.217915581343], "value": 4403.998836191239, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [794.972175973841, 807.7657479330994, 816.2735165702524, 845.4420082745389, 872.276010910944, 15711.0, 16692.74960875588, 16721.749173762404, 16766.83233167668, 16842.91578542107, 15189.4683686071, 15304.158271295075, 15333.616659583517, 15370.385184592631, 15429.228538573083, 797.0156856282487, 838.4508147163588, 843.9367047471465, 844.6705784743955, 845.5898889038812, 841.7727213652311, 843.3169133002287, 843.6920524008754, 844.3625063077368, 844.4173520271024, 884.8186121845006, 885.1148851148852, 885.9424137431079, 887.2946007923684, 887.4231749362901, 877.2236570634971, 878.8637761147032, 886.5079880666227, 886.8758373827669, 888.8533391990314, 644.5842431631618, 644.9451796597294, 645.0324513230155, 645.1033064040987, 645.686841881687, 15967.680646387123, 15993.20033998307, 16021.679566408606, 16062.5984350391, 16109.355625774955, 14523.0, 14767.335469903881, 14822.110673359524, 14837.332320045623, 14920.179390133539, 12831.74336513274, 12870.420831062625, 12911.35443227835, 12974.0, 13061.86938130616, 3894.6300101490315, 4007.73949693269, 4014.1168942832824, 4068.349064149722, 4091.488563929509, 83557.58221208856, 83791.5810420944, 84317.57841210878, 84320.57839710824, 84584.57707711484, 11754.412279385997, 11859.347735874437, 11930.701732456584, 12213.69465763363, 12337.629871103882, 22164.778352216596, 22220.77779222187, 22226.777732222472, 22286.888565557394, 22325.88837055837, 8822.294216462667, 8898.86651700225, 9029.142231487998, 9063.093690630883, 9178.541072946326, 4874.19575770001, 4889.559939605452, 4904.8773780655765, 5036.64743467961, 5089.796408143707, 3541.94687079694, 3651.379265524867, 3660.066682995819, 3660.084978755311, 3664.285464334429, 588.2529187931303, 604.8034388823562, 606.824021033904, 614.8155553333982, 630.3318482408662, 655.9821095788296, 666.6333516565869, 729.21973488368, 757.5984728094119, 767.1101522234293, 9498.810023799486, 9564.426134431957, 9657.275704322205, 9830.950845245728, 9905.75235619101, 625.6996641612052, 700.8633316503233, 726.5059759363578, 753.7512620835112, 772.7411317208686, 4371.584699453547, 4375.496817865923, 4676.18166820805, 4735.786889589976, 4746.311784791186, 66077.6696116526, 68842.0, 68953.0, 78053.0, 123633.0, 57510.0, 85069.0, 103720.0, 104052.0, 105209.47395262975, 67934.66032669904, 74052.0, 93205.53397232971, 93798.0, 94502.0, 9329.953350233205, 9652.887958260884, 9655.324127311022, 9669.758256043655, 9772.560234789593, 51649.0, 51961.96076078533, 52419.73790131025, 53250.0, 53353.46646533485, 68993.65503172453, 71296.64351678209, 78262.2173778255, 78873.60563197377, 80978.59510702408, 13384.799228011392, 13614.18314901109, 13682.384292707051, 13908.374123164684, 14036.719265614427, 15297.46458873934, 15690.9215453922, 15763.605909852346, 15897.205139743199, 16509.422170223985, 14453.855461445672, 14460.349284282021, 14741.336639851017, 14983.101013939198, 15259.0, 14039.438422463396, 14433.35049922735, 14520.0, 14521.92739036298, 14741.1892345922, 13536.187828729913, 14064.296785160497, 14125.576232713034, 14555.854441455873, 15072.849271507583, 10751.946240268748, 10766.0, 11162.330260184415, 11320.773584528428, 11325.924037216451, 10801.621943231949, 11835.230710003822, 12004.2197257178, 12073.058814141155, 12644.620661380173], "value": 7736.798368586685, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1530.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 112.0, 107.0, 113.0, 112.0, 113.0, 114.0, 112.0, 112.0, 112.0], "value": 111.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 117.0, 150.0, 176.0, 124.0, 146.0, 148.0, 120.0, 175.0, 118.0], "value": 142.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 160.0, 161.0, 164.0, 164.0, 167.0, 165.0, 163.0, 165.0], "value": 163.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 78.0, 167.0, 76.0, 75.0, 75.0, 77.0, 172.0, 76.0], "value": 94.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 152.0, 85.0, 83.0, 84.0, 141.0, 84.0, 84.0, 133.0], "value": 101.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 118.0, 117.0, 117.0, 117.0, 120.0, 118.0, 118.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 146.0, 151.0, 147.0, 148.0, 147.0, 148.0, 146.0, 148.0], "value": 147.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 94.0, 96.0, 95.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 53.0, 54.0, 52.0, 52.0, 52.0, 56.0, 52.0, 52.0, 54.0], "value": 52.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 63.0, 63.0, 64.0, 63.0, 63.0, 62.0, 66.0, 64.0], "value": 63.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 76.0, 76.0, 77.0, 77.0, 84.0, 79.0, 84.0, 77.0], "value": 78.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 145.0, 122.0, 124.0, 144.0, 126.0, 138.0, 131.0, 169.0, 124.0], "value": 134.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 169.0, 171.0, 165.0, 157.0, 160.0, 158.0, 161.0, 159.0], "value": 162.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 68.0, 65.0, 64.0, 65.0, 65.0, 64.0, 63.0, 65.0, 64.0], "value": 64.6, "unit": "score"}]}]} 07:30:01 INFO - Return code: 0 07:30:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:30:01 ERROR - # TBPL SUCCESS # 07:30:01 INFO - Running post-action listener: _resource_record_post_action 07:30:01 INFO - [mozharness: 2016-07-20 14:30:01.891366Z] Finished run-tests step (success) 07:30:01 INFO - Running post-run listener: _resource_record_post_run 07:30:01 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 571596800; Read time: 16; Write time: 551752 07:30:01 INFO - TinderboxPrint: CPU usage
13.3% 07:30:01 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 07:30:01 INFO - TinderboxPrint: I/O write bytes / time
571,596,800 / 551,752 07:30:01 INFO - TinderboxPrint: CPU idle
8,228.4 (86.6%) 07:30:01 INFO - TinderboxPrint: CPU user
1,211.8 (12.8%) 07:30:01 INFO - TinderboxPrint: Swap in / out
0 / 0 07:30:01 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 270663680; Read time: 0; Write time: 303484 07:30:01 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 4096; Write bytes: 300933120; Read time: 16; Write time: 248268 07:30:02 INFO - Running post-run listener: _upload_blobber_files 07:30:02 INFO - Blob upload gear active. 07:30:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:30:02 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 07:30:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:30:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:30:03 INFO - (blobuploader) - INFO - Open directory for files ... 07:30:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:30:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:30:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:30:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:30:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:30:03 INFO - (blobuploader) - INFO - Done attempting. 07:30:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:30:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:30:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:30:21 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:30:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:30:21 INFO - (blobuploader) - INFO - Done attempting. 07:30:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:30:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:30:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:30:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:30:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:30:22 INFO - (blobuploader) - INFO - Done attempting. 07:30:22 INFO - (blobuploader) - INFO - Iteration through files over. 07:30:22 INFO - Return code: 0 07:30:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:30:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:30:22 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/87c9c28eb83aabcdee51d41b2c0b655481ca35184cb416f2ddd54650cdb9778a45830cb812d3db5f92569c7a811330d82b0c34efd2943cdd4d22f9dce1619271", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/034bd665d0bb3370127175984b5a0f262f865d2df51417ad54dc391b1b336e9acc72047b1f548693c1e78acddc17c8078c3d8744134da4a61468c3dd0f37e519", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4d5d00a58b0aa5fb3d73b1c2b93dec6d5db00e9207ff2d89945f93e3fc09c2f43da4c4adab28b055decaab0ac1800e5f7d4eedd97841c99ae694fb0309236192"} 07:30:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:30:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:30:22 INFO - Contents: 07:30:22 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/87c9c28eb83aabcdee51d41b2c0b655481ca35184cb416f2ddd54650cdb9778a45830cb812d3db5f92569c7a811330d82b0c34efd2943cdd4d22f9dce1619271", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/034bd665d0bb3370127175984b5a0f262f865d2df51417ad54dc391b1b336e9acc72047b1f548693c1e78acddc17c8078c3d8744134da4a61468c3dd0f37e519", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4d5d00a58b0aa5fb3d73b1c2b93dec6d5db00e9207ff2d89945f93e3fc09c2f43da4c4adab28b055decaab0ac1800e5f7d4eedd97841c99ae694fb0309236192"} 07:30:22 INFO - Running post-run listener: copy_logs_to_upload_dir 07:30:22 INFO - Copying logs to upload dir... 07:30:22 INFO - mkdir: /builds/slave/test/build/upload/logs 07:30:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.731415 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-07-20 07:30:22.161145) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-20 07:30:22.164764) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1469023634.341069-206537822 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/Firefox/sha512/87c9c28eb83aabcdee51d41b2c0b655481ca35184cb416f2ddd54650cdb9778a45830cb812d3db5f92569c7a811330d82b0c34efd2943cdd4d22f9dce1619271", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/034bd665d0bb3370127175984b5a0f262f865d2df51417ad54dc391b1b336e9acc72047b1f548693c1e78acddc17c8078c3d8744134da4a61468c3dd0f37e519", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4d5d00a58b0aa5fb3d73b1c2b93dec6d5db00e9207ff2d89945f93e3fc09c2f43da4c4adab28b055decaab0ac1800e5f7d4eedd97841c99ae694fb0309236192"} build_url:https://queue.taskcluster.net/v1/task/JoYT_1EmSrK2PVMprcN4OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011252 build_url: 'https://queue.taskcluster.net/v1/task/JoYT_1EmSrK2PVMprcN4OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/87c9c28eb83aabcdee51d41b2c0b655481ca35184cb416f2ddd54650cdb9778a45830cb812d3db5f92569c7a811330d82b0c34efd2943cdd4d22f9dce1619271", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/034bd665d0bb3370127175984b5a0f262f865d2df51417ad54dc391b1b336e9acc72047b1f548693c1e78acddc17c8078c3d8744134da4a61468c3dd0f37e519", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4d5d00a58b0aa5fb3d73b1c2b93dec6d5db00e9207ff2d89945f93e3fc09c2f43da4c4adab28b055decaab0ac1800e5f7d4eedd97841c99ae694fb0309236192"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-20 07:30:22.189883) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 07:30:22.190230) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1469023634.341069-206537822 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004454 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 07:30:22.275291) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-20 07:30:22.275618) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-20 07:30:22.275918) ========= ========= Total master_lag: 0.17 =========