builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-016 starttime: 1472138544.39 results: success (0) buildid: 20160825054326 builduid: 7e29b840d0b84dbe8217f7fde66c11ba revision: 7963ebdd52b93f96b812eff2eab8d94097147b9c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-25 08:22:24.385516) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-25 08:22:24.385969) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-25 08:22:24.386272) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-25 08:22:24.401907) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 08:22:24.402225) ========= 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=00204705a9daa57ed339a427000001b9-1472138533.492312-8059851 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-25 08:22:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 45.6M=0s 2016-08-25 08:22:24 (45.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.079017 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 08:22:24.495642) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 08:22:24.495952) ========= 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=00204705a9daa57ed339a427000001b9-1472138533.492312-8059851 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015706 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 08:22:24.545893) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 08:22:24.546256) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 7963ebdd52b93f96b812eff2eab8d94097147b9c --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 7963ebdd52b93f96b812eff2eab8d94097147b9c --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=00204705a9daa57ed339a427000001b9-1472138533.492312-8059851 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-25 08:22:25,043 truncating revision to first 12 chars 2016-08-25 08:22:25,043 Setting DEBUG logging. 2016-08-25 08:22:25,043 attempt 1/10 2016-08-25 08:22:25,043 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/7963ebdd52b9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-25 08:22:25,467 unpacking tar archive at: mozilla-central-7963ebdd52b9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.717935 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 08:22:25.278400) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-25 08:22:25.278707) ========= script_repo_revision: 7963ebdd52b93f96b812eff2eab8d94097147b9c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-25 08:22:25.279106) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-25 08:22:25.279370) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-25 08:22:25.287460) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-08-25 08:22:25.287739) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=00204705a9daa57ed339a427000001b9-1472138533.492312-8059851 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:22:25 INFO - MultiFileLogger online at 20160825 08:22:25 in /builds/slave/test 08:22:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 08:22:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:22:25 INFO - {'append_to_log': False, 08:22:25 INFO - 'base_work_dir': '/builds/slave/test', 08:22:25 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 08:22:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:22:25 INFO - 'branch': 'Firefox-Non-PGO', 08:22:25 INFO - 'buildbot_json_path': 'buildprops.json', 08:22:25 INFO - 'config_files': ('talos/linux_config.py',), 08:22:25 INFO - 'default_actions': ('clobber', 08:22:25 INFO - 'read-buildbot-config', 08:22:25 INFO - 'download-and-extract', 08:22:25 INFO - 'populate-webroot', 08:22:25 INFO - 'create-virtualenv', 08:22:25 INFO - 'install', 08:22:25 INFO - 'run-tests'), 08:22:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:22:25 INFO - 'download_minidump_stackwalk': True, 08:22:25 INFO - 'download_symbols': 'ondemand', 08:22:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:22:25 INFO - 'tooltool.py': '/tools/tooltool.py', 08:22:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:22:25 INFO - '/tools/misc-python/virtualenv.py')}, 08:22:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:22:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:22:25 INFO - 'installer_path': 'installer.exe', 08:22:25 INFO - 'log_level': 'info', 08:22:25 INFO - 'log_name': 'talos', 08:22:25 INFO - 'log_to_console': True, 08:22:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:22:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:22:25 INFO - 'opt_config_files': (), 08:22:25 INFO - 'pip_index': False, 08:22:25 INFO - 'sps_profile': False, 08:22:25 INFO - 'sps_profile_interval': 0, 08:22:25 INFO - 'suite': 'dromaeojs', 08:22:25 INFO - 'system_bits': '32', 08:22:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:22:25 INFO - 'title': 'talos-linux64-ix-016', 08:22:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:22:25 INFO - 'use_talos_json': True, 08:22:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:22:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:22:25 INFO - 'work_dir': 'build'} 08:22:25 INFO - [mozharness: 2016-08-25 15:22:25.875282Z] Running clobber step. 08:22:25 INFO - Running pre-action listener: _resource_record_pre_action 08:22:25 INFO - Running main action method: clobber 08:22:25 INFO - rmtree: /builds/slave/test/build 08:22:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:22:26 INFO - Running post-action listener: _resource_record_post_action 08:22:26 INFO - [mozharness: 2016-08-25 15:22:26.854173Z] Finished clobber step (success) 08:22:26 INFO - [mozharness: 2016-08-25 15:22:26.854271Z] Running read-buildbot-config step. 08:22:26 INFO - Running pre-action listener: _resource_record_pre_action 08:22:26 INFO - Running main action method: read_buildbot_config 08:22:26 INFO - Using buildbot properties: 08:22:26 INFO - { 08:22:26 INFO - "project": "", 08:22:26 INFO - "product": "firefox", 08:22:26 INFO - "script_repo_revision": "production", 08:22:26 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 08:22:26 INFO - "repository": "", 08:22:26 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 08:22:26 INFO - "buildid": "20160825054326", 08:22:26 INFO - "pgo_build": "False", 08:22:26 INFO - "basedir": "/builds/slave/test", 08:22:26 INFO - "buildnumber": 187, 08:22:26 INFO - "slavename": "talos-linux64-ix-016", 08:22:26 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:22:26 INFO - "platform": "ubuntu64_hw", 08:22:26 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 08:22:26 INFO - "branch": "mozilla-central", 08:22:26 INFO - "repo_path": "mozilla-central", 08:22:26 INFO - "revision": "7963ebdd52b93f96b812eff2eab8d94097147b9c", 08:22:26 INFO - "stage_platform": "linux64", 08:22:26 INFO - "builduid": "7e29b840d0b84dbe8217f7fde66c11ba", 08:22:26 INFO - "slavebuilddir": "test" 08:22:26 INFO - } 08:22:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/AmlpMaaKSjSbDlMngjkkHQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 08:22:26 INFO - Running post-action listener: _resource_record_post_action 08:22:26 INFO - [mozharness: 2016-08-25 15:22:26.856663Z] Finished read-buildbot-config step (success) 08:22:26 INFO - [mozharness: 2016-08-25 15:22:26.856749Z] Running download-and-extract step. 08:22:26 INFO - Running pre-action listener: _resource_record_pre_action 08:22:26 INFO - Running main action method: download_and_extract 08:22:26 INFO - mkdir: /builds/slave/test/build/tests 08:22:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:22:26 INFO - trying https://queue.taskcluster.net/v1/task/AmlpMaaKSjSbDlMngjkkHQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 08:22:26 INFO - Downloading https://queue.taskcluster.net/v1/task/AmlpMaaKSjSbDlMngjkkHQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 08:22:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AmlpMaaKSjSbDlMngjkkHQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:22:27 INFO - Downloaded 1361 bytes. 08:22:27 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 08:22:27 INFO - Using the following test package requirements: 08:22:27 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 08:22:27 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:22:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:22:27 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:22:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:22:27 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:22:27 INFO - u'jsshell-linux-x86_64.zip'], 08:22:27 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:22:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:22:27 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 08:22:27 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:22:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:22:27 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:22:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:22:27 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:22:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:22:27 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:22:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:22:27 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:22:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:22:27 INFO - trying https://queue.taskcluster.net/v1/task/AmlpMaaKSjSbDlMngjkkHQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:22:27 INFO - Downloading https://queue.taskcluster.net/v1/task/AmlpMaaKSjSbDlMngjkkHQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:22:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AmlpMaaKSjSbDlMngjkkHQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:22:28 INFO - Downloaded 20324311 bytes. 08:22:28 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 08:22:32 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:22:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:22:32 INFO - trying https://queue.taskcluster.net/v1/task/AmlpMaaKSjSbDlMngjkkHQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:22:32 INFO - Downloading https://queue.taskcluster.net/v1/task/AmlpMaaKSjSbDlMngjkkHQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:22:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AmlpMaaKSjSbDlMngjkkHQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:22:33 INFO - Downloaded 20324311 bytes. 08:22:33 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 08:22:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:22:38 INFO - trying https://queue.taskcluster.net/v1/task/AmlpMaaKSjSbDlMngjkkHQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 08:22:38 INFO - Downloading https://queue.taskcluster.net/v1/task/AmlpMaaKSjSbDlMngjkkHQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 08:22:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AmlpMaaKSjSbDlMngjkkHQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:22:38 INFO - Downloaded 14413981 bytes. 08:22:38 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 08:22:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:22:39 INFO - trying https://queue.taskcluster.net/v1/task/AmlpMaaKSjSbDlMngjkkHQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:22:39 INFO - Downloading https://queue.taskcluster.net/v1/task/AmlpMaaKSjSbDlMngjkkHQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:22:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AmlpMaaKSjSbDlMngjkkHQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:22:40 INFO - Downloaded 55750173 bytes. 08:22:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AmlpMaaKSjSbDlMngjkkHQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:22:40 INFO - mkdir: /builds/slave/test/properties 08:22:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:22:40 INFO - Writing to file /builds/slave/test/properties/build_url 08:22:40 INFO - Contents: 08:22:40 INFO - build_url:https://queue.taskcluster.net/v1/task/AmlpMaaKSjSbDlMngjkkHQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:22:41 INFO - Running post-action listener: _resource_record_post_action 08:22:41 INFO - Running post-action listener: set_extra_try_arguments 08:22:41 INFO - [mozharness: 2016-08-25 15:22:41.168755Z] Finished download-and-extract step (success) 08:22:41 INFO - [mozharness: 2016-08-25 15:22:41.168978Z] Running populate-webroot step. 08:22:41 INFO - Running pre-action listener: _resource_record_pre_action 08:22:41 INFO - Running main action method: populate_webroot 08:22:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:22:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:22:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:22:41 INFO - '--tppagecycles', 08:22:41 INFO - '7'], 08:22:41 INFO - 'tests': ['tsvgm']}}, 08:22:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:22:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:22:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:22:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:22:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:22:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:22:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:22:41 INFO - 'talos_options': ['--disable-e10s'], 08:22:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:22:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:22:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:22:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:22:41 INFO - 'talos_options': ['--disable-e10s'], 08:22:41 INFO - 'tests': ['damp', 'tps']}, 08:22:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:22:41 INFO - 'tests': ['damp', 'tps']}, 08:22:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:22:41 INFO - 'tests': ['dromaeo_dom']}, 08:22:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:22:41 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:22:41 INFO - 'tests': ['basic_compositor_video']}, 08:22:41 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:22:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:22:41 INFO - 'tests': ['a11yr', 08:22:41 INFO - 'ts_paint', 08:22:41 INFO - 'tpaint', 08:22:41 INFO - 'sessionrestore', 08:22:41 INFO - 'sessionrestore_no_auto_restore', 08:22:41 INFO - 'tabpaint']}, 08:22:41 INFO - 'other-e10s': {'tests': ['a11yr', 08:22:41 INFO - 'ts_paint', 08:22:41 INFO - 'tpaint', 08:22:41 INFO - 'sessionrestore', 08:22:41 INFO - 'sessionrestore_no_auto_restore', 08:22:41 INFO - 'tabpaint']}, 08:22:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:22:41 INFO - 'ts_paint', 08:22:41 INFO - 'tpaint', 08:22:41 INFO - 'sessionrestore', 08:22:41 INFO - 'sessionrestore_no_auto_restore', 08:22:41 INFO - 'tabpaint']}, 08:22:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:22:41 INFO - 'ts_paint', 08:22:41 INFO - 'tpaint', 08:22:41 INFO - 'sessionrestore', 08:22:41 INFO - 'sessionrestore_no_auto_restore', 08:22:41 INFO - 'tabpaint']}, 08:22:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:22:41 INFO - 'tests': ['a11yr', 08:22:41 INFO - 'ts_paint', 08:22:41 INFO - 'tpaint', 08:22:41 INFO - 'sessionrestore', 08:22:41 INFO - 'sessionrestore_no_auto_restore', 08:22:41 INFO - 'tabpaint']}, 08:22:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:22:41 INFO - 'tests': ['a11yr', 08:22:41 INFO - 'ts_paint', 08:22:41 INFO - 'tpaint', 08:22:41 INFO - 'sessionrestore', 08:22:41 INFO - 'sessionrestore_no_auto_restore', 08:22:41 INFO - 'tabpaint']}, 08:22:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:22:41 INFO - 'tests': ['tsvgx', 08:22:41 INFO - 'tsvgr_opacity', 08:22:41 INFO - 'tart', 08:22:41 INFO - 'tscrollx', 08:22:41 INFO - 'cart']}, 08:22:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:22:41 INFO - 'tsvgr_opacity', 08:22:41 INFO - 'tart', 08:22:41 INFO - 'tscrollx', 08:22:41 INFO - 'cart']}, 08:22:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:22:41 INFO - 'talos_options': ['--disable-e10s'], 08:22:41 INFO - 'tests': ['tp5o']}, 08:22:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:22:41 INFO - 'tests': ['tp5o']}, 08:22:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:22:41 INFO - 'talos_options': ['--disable-e10s', 08:22:41 INFO - '--xperf_path', 08:22:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:22:41 INFO - 'tests': ['tp5n']}, 08:22:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:22:41 INFO - 'talos_options': ['--xperf_path', 08:22:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:22:41 INFO - 'tests': ['tp5n']}}, 08:22:41 INFO - 'talos.zip': {'path': '', 08:22:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:22:41 INFO - Running post-action listener: _resource_record_post_action 08:22:41 INFO - [mozharness: 2016-08-25 15:22:41.185096Z] Finished populate-webroot step (success) 08:22:41 INFO - [mozharness: 2016-08-25 15:22:41.185183Z] Running create-virtualenv step. 08:22:41 INFO - Running pre-action listener: _resource_record_pre_action 08:22:41 INFO - Running main action method: create_virtualenv 08:22:41 INFO - Creating virtualenv /builds/slave/test/build/venv 08:22:41 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 08:22:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:22:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:22:41 INFO - Using real prefix '/usr' 08:22:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:22:41 INFO - Installing distribute.............................................................................................................................................................................................done. 08:22:43 INFO - Installing pip.................done. 08:22:43 INFO - Return code: 0 08:22:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:22: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:22:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:22:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:22:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:22:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:43 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 0x7f383506ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1913230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x190d090>, '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 0x19109b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1910e40>, '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': '00204705a9daa57ed339a427000001b9-1472138533.492312-8059851', '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 08:22:43 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 08:22:43 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 08:22:43 INFO - Using env: {'DISPLAY': ':0', 08:22:43 INFO - 'HOME': '/home/cltbld', 08:22:43 INFO - 'LANG': 'en_US.UTF-8', 08:22:43 INFO - 'LANGUAGE': 'en_US:en', 08:22:43 INFO - 'LOGNAME': 'cltbld', 08:22:43 INFO - 'MAIL': '/var/mail/cltbld', 08:22:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:22:43 INFO - 'MOZ_NO_REMOTE': '1', 08:22:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:22:43 INFO - 'NO_EM_RESTART': '1', 08:22:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:22:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:22:43 INFO - 'PWD': '/builds/slave/test', 08:22:43 INFO - 'SHELL': '/bin/bash', 08:22:43 INFO - 'SHLVL': '1', 08:22:43 INFO - 'TERM': 'linux', 08:22:43 INFO - 'TMOUT': '86400', 08:22:43 INFO - 'USER': 'cltbld', 08:22:43 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1472138533.492312-8059851', 08:22:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:22:43 INFO - '_': '/tools/buildbot/bin/python'} 08:22:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:22:43 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 08:22:43 INFO - Cleaning up... 08:22:44 INFO - Return code: 0 08:22:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:22:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:22:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:22:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:22:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:22:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:44 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 0x7f383506ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1913230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x190d090>, '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 0x19109b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1910e40>, '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': '00204705a9daa57ed339a427000001b9-1472138533.492312-8059851', '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 08:22:44 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 08:22:44 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 08:22:44 INFO - Using env: {'DISPLAY': ':0', 08:22:44 INFO - 'HOME': '/home/cltbld', 08:22:44 INFO - 'LANG': 'en_US.UTF-8', 08:22:44 INFO - 'LANGUAGE': 'en_US:en', 08:22:44 INFO - 'LOGNAME': 'cltbld', 08:22:44 INFO - 'MAIL': '/var/mail/cltbld', 08:22:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:22:44 INFO - 'MOZ_NO_REMOTE': '1', 08:22:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:22:44 INFO - 'NO_EM_RESTART': '1', 08:22:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:22:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:22:44 INFO - 'PWD': '/builds/slave/test', 08:22:44 INFO - 'SHELL': '/bin/bash', 08:22:44 INFO - 'SHLVL': '1', 08:22:44 INFO - 'TERM': 'linux', 08:22:44 INFO - 'TMOUT': '86400', 08:22:44 INFO - 'USER': 'cltbld', 08:22:44 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1472138533.492312-8059851', 08:22:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:22:44 INFO - '_': '/tools/buildbot/bin/python'} 08:22:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:22:44 INFO - Downloading/unpacking psutil>=3.1.1 08:22:44 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 08:22:44 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 08:22:44 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 08:22:44 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 08:22:44 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 08:22:44 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 08:22:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:22:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:22:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:22:46 INFO - Installing collected packages: psutil 08:22:46 INFO - Running setup.py install for psutil 08:22:46 INFO - building 'psutil._psutil_linux' extension 08:22:46 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 08:22:46 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 08:22:46 INFO - building 'psutil._psutil_posix' extension 08:22:46 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 08:22:46 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 08:22:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:22:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:22:46 INFO - Successfully installed psutil 08:22:46 INFO - Cleaning up... 08:22:46 INFO - Return code: 0 08:22:46 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:22:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:22:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:22:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:22:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:22:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:46 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 0x7f383506ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1913230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x190d090>, '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 0x19109b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1910e40>, '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': '00204705a9daa57ed339a427000001b9-1472138533.492312-8059851', '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 08:22:46 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 08:22:46 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 08:22:46 INFO - Using env: {'DISPLAY': ':0', 08:22:46 INFO - 'HOME': '/home/cltbld', 08:22:46 INFO - 'LANG': 'en_US.UTF-8', 08:22:46 INFO - 'LANGUAGE': 'en_US:en', 08:22:46 INFO - 'LOGNAME': 'cltbld', 08:22:46 INFO - 'MAIL': '/var/mail/cltbld', 08:22:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:22:46 INFO - 'MOZ_NO_REMOTE': '1', 08:22:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:22:46 INFO - 'NO_EM_RESTART': '1', 08:22:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:22:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:22:46 INFO - 'PWD': '/builds/slave/test', 08:22:46 INFO - 'SHELL': '/bin/bash', 08:22:46 INFO - 'SHLVL': '1', 08:22:46 INFO - 'TERM': 'linux', 08:22:46 INFO - 'TMOUT': '86400', 08:22:46 INFO - 'USER': 'cltbld', 08:22:46 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1472138533.492312-8059851', 08:22:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:22:46 INFO - '_': '/tools/buildbot/bin/python'} 08:22:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:22:46 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:22:46 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 08:22:46 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 08:22:46 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 08:22:46 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 08:22:46 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 08:22:46 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 08:22:48 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:22:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:22:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:22:48 INFO - Installing collected packages: mozsystemmonitor 08:22:48 INFO - Running setup.py install for mozsystemmonitor 08:22:48 INFO - Successfully installed mozsystemmonitor 08:22:48 INFO - Cleaning up... 08:22:49 INFO - Return code: 0 08:22:49 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:22:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:22:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:22:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:22:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:22:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:49 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 0x7f383506ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1913230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x190d090>, '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 0x19109b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1910e40>, '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': '00204705a9daa57ed339a427000001b9-1472138533.492312-8059851', '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 08:22:49 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 08:22:49 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 08:22:49 INFO - Using env: {'DISPLAY': ':0', 08:22:49 INFO - 'HOME': '/home/cltbld', 08:22:49 INFO - 'LANG': 'en_US.UTF-8', 08:22:49 INFO - 'LANGUAGE': 'en_US:en', 08:22:49 INFO - 'LOGNAME': 'cltbld', 08:22:49 INFO - 'MAIL': '/var/mail/cltbld', 08:22:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:22:49 INFO - 'MOZ_NO_REMOTE': '1', 08:22:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:22:49 INFO - 'NO_EM_RESTART': '1', 08:22:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:22:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:22:49 INFO - 'PWD': '/builds/slave/test', 08:22:49 INFO - 'SHELL': '/bin/bash', 08:22:49 INFO - 'SHLVL': '1', 08:22:49 INFO - 'TERM': 'linux', 08:22:49 INFO - 'TMOUT': '86400', 08:22:49 INFO - 'USER': 'cltbld', 08:22:49 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1472138533.492312-8059851', 08:22:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:22:49 INFO - '_': '/tools/buildbot/bin/python'} 08:22:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:22:49 INFO - Downloading/unpacking jsonschema==2.5.1 08:22:49 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 08:22:49 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 08:22:49 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 08:22:49 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 08:22:49 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 08:22:49 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 08:22:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:22:51 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:22:51 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 08:22:51 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 08:22:51 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 08:22:51 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 08:22:51 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 08:22:51 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 08:22:51 INFO - Downloading functools32-3.2.3-2.tar.gz 08:22:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:22:51 INFO - warning: no files found matching '*.txt' 08:22:51 INFO - no previously-included directories found matching 'build' 08:22:51 INFO - no previously-included directories found matching 'dist' 08:22:51 INFO - no previously-included directories found matching '.git*' 08:22:51 INFO - Installing collected packages: jsonschema, functools32 08:22:51 INFO - Running setup.py install for functools32 08:22:51 INFO - warning: no files found matching '*.txt' 08:22:51 INFO - no previously-included directories found matching 'build' 08:22:51 INFO - no previously-included directories found matching 'dist' 08:22:51 INFO - no previously-included directories found matching '.git*' 08:22:51 INFO - Successfully installed jsonschema functools32 08:22:51 INFO - Cleaning up... 08:22:51 INFO - Return code: 0 08:22:51 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:22:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:22:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:22:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:22:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:22:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f383506ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1913230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x190d090>, '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 0x19109b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1910e40>, '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': '00204705a9daa57ed339a427000001b9-1472138533.492312-8059851', '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 08:22:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:22:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:22:51 INFO - Using env: {'DISPLAY': ':0', 08:22:51 INFO - 'HOME': '/home/cltbld', 08:22:51 INFO - 'LANG': 'en_US.UTF-8', 08:22:51 INFO - 'LANGUAGE': 'en_US:en', 08:22:51 INFO - 'LOGNAME': 'cltbld', 08:22:51 INFO - 'MAIL': '/var/mail/cltbld', 08:22:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:22:51 INFO - 'MOZ_NO_REMOTE': '1', 08:22:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:22:51 INFO - 'NO_EM_RESTART': '1', 08:22:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:22:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:22:51 INFO - 'PWD': '/builds/slave/test', 08:22:51 INFO - 'SHELL': '/bin/bash', 08:22:51 INFO - 'SHLVL': '1', 08:22:51 INFO - 'TERM': 'linux', 08:22:51 INFO - 'TMOUT': '86400', 08:22:51 INFO - 'USER': 'cltbld', 08:22:51 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1472138533.492312-8059851', 08:22:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:22:51 INFO - '_': '/tools/buildbot/bin/python'} 08:22:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:22:51 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:22:51 INFO - Cleaning up... 08:22:51 INFO - Return code: 0 08:22:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:22:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:22:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:22:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:22:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:22:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:51 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 0x7f383506ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1913230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x190d090>, '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 0x19109b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1910e40>, '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': '00204705a9daa57ed339a427000001b9-1472138533.492312-8059851', '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 08:22:51 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 08:22:51 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 08:22:51 INFO - Using env: {'DISPLAY': ':0', 08:22:51 INFO - 'HOME': '/home/cltbld', 08:22:51 INFO - 'LANG': 'en_US.UTF-8', 08:22:51 INFO - 'LANGUAGE': 'en_US:en', 08:22:51 INFO - 'LOGNAME': 'cltbld', 08:22:51 INFO - 'MAIL': '/var/mail/cltbld', 08:22:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:22:51 INFO - 'MOZ_NO_REMOTE': '1', 08:22:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:22:51 INFO - 'NO_EM_RESTART': '1', 08:22:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:22:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:22:51 INFO - 'PWD': '/builds/slave/test', 08:22:51 INFO - 'SHELL': '/bin/bash', 08:22:51 INFO - 'SHLVL': '1', 08:22:51 INFO - 'TERM': 'linux', 08:22:51 INFO - 'TMOUT': '86400', 08:22:51 INFO - 'USER': 'cltbld', 08:22:51 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1472138533.492312-8059851', 08:22:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:22:51 INFO - '_': '/tools/buildbot/bin/python'} 08:22:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:22:52 INFO - Downloading/unpacking blobuploader==1.2.4 08:22:52 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 08:22:52 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 08:22:52 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 08:22:52 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 08:22:52 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 08:22:52 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 08:22:53 INFO - Downloading blobuploader-1.2.4.tar.gz 08:22:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:22:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:22: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 08:22: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 08:22: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 08:22: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 08:22: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 08:22: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 08:22:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:22:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:22:54 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 08:22:54 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 08:22:54 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 08:22:54 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 08:22:54 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 08:22:54 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 08:22:54 INFO - Downloading docopt-0.6.1.tar.gz 08:22:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:22:54 INFO - Installing collected packages: blobuploader, requests, docopt 08:22:54 INFO - Running setup.py install for blobuploader 08:22:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:22:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:22:54 INFO - Running setup.py install for requests 08:22:55 INFO - Running setup.py install for docopt 08:22:55 INFO - Successfully installed blobuploader requests docopt 08:22:55 INFO - Cleaning up... 08:22:55 INFO - Return code: 0 08:22:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:22:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:22:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:22:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:22:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:22:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:55 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 0x7f383506ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1913230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x190d090>, '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 0x19109b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1910e40>, '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': '00204705a9daa57ed339a427000001b9-1472138533.492312-8059851', '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 08:22:55 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 08:22:55 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 08:22:55 INFO - Using env: {'DISPLAY': ':0', 08:22:55 INFO - 'HOME': '/home/cltbld', 08:22:55 INFO - 'LANG': 'en_US.UTF-8', 08:22:55 INFO - 'LANGUAGE': 'en_US:en', 08:22:55 INFO - 'LOGNAME': 'cltbld', 08:22:55 INFO - 'MAIL': '/var/mail/cltbld', 08:22:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:22:55 INFO - 'MOZ_NO_REMOTE': '1', 08:22:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:22:55 INFO - 'NO_EM_RESTART': '1', 08:22:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:22:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:22:55 INFO - 'PWD': '/builds/slave/test', 08:22:55 INFO - 'SHELL': '/bin/bash', 08:22:55 INFO - 'SHLVL': '1', 08:22:55 INFO - 'TERM': 'linux', 08:22:55 INFO - 'TMOUT': '86400', 08:22:55 INFO - 'USER': 'cltbld', 08:22:55 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1472138533.492312-8059851', 08:22:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:22:55 INFO - '_': '/tools/buildbot/bin/python'} 08:22:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:22:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:22:55 INFO - Running setup.py (path:/tmp/pip-EbQIkj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:22:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:22:55 INFO - Running setup.py (path:/tmp/pip-0yf1Vq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:22:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:22:55 INFO - Running setup.py (path:/tmp/pip-LlJ5vL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:22:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:22:55 INFO - Running setup.py (path:/tmp/pip-ckBnIx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:22:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:22:55 INFO - Running setup.py (path:/tmp/pip-RY7kaS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:22:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:22:55 INFO - Running setup.py (path:/tmp/pip-LLz6fX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:22:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:22:55 INFO - Running setup.py (path:/tmp/pip-MBieXH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:22:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:22:55 INFO - Running setup.py (path:/tmp/pip-AeL02h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:22:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:22:56 INFO - Running setup.py (path:/tmp/pip-xkASkK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:22:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:22:56 INFO - Running setup.py (path:/tmp/pip-2iBWGU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:22:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:22:56 INFO - Running setup.py (path:/tmp/pip-4qyVBb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:22:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:22:56 INFO - Running setup.py (path:/tmp/pip-pzbeva-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:22:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:22:56 INFO - Running setup.py (path:/tmp/pip-bseWgk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:22:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:22:56 INFO - Running setup.py (path:/tmp/pip-GVrrhn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:22:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:22:56 INFO - Running setup.py (path:/tmp/pip-XPptdb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:22:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:22:56 INFO - Running setup.py (path:/tmp/pip-C1oo7Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:22:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:22:56 INFO - Running setup.py (path:/tmp/pip-ryUS6a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:22:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:22:56 INFO - Running setup.py install for manifestparser 08:22:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:22:56 INFO - Running setup.py install for mozcrash 08:22:56 INFO - Running setup.py install for mozdebug 08:22:56 INFO - Running setup.py install for mozdevice 08:22:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:22:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:22:57 INFO - Running setup.py install for mozfile 08:22:57 INFO - Running setup.py install for mozhttpd 08:22:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:22:57 INFO - Running setup.py install for mozinfo 08:22:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:22:57 INFO - Running setup.py install for mozInstall 08:22:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:22:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:22:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:22:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:22:57 INFO - Running setup.py install for mozleak 08:22:57 INFO - Running setup.py install for mozlog 08:22:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:22:57 INFO - Running setup.py install for moznetwork 08:22:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:22:57 INFO - Running setup.py install for mozprocess 08:22:57 INFO - Running setup.py install for mozprofile 08:22:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:22:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:22:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:22:58 INFO - Running setup.py install for mozrunner 08:22:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:22:58 INFO - Running setup.py install for mozscreenshot 08:22:58 INFO - Running setup.py install for moztest 08:22:58 INFO - Running setup.py install for mozversion 08:22:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:22:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:22:58 INFO - Cleaning up... 08:22:58 INFO - Return code: 0 08:22:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:22:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:22:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:22:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:22:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:22:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:58 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 0x7f383506ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1913230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x190d090>, '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 0x19109b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1910e40>, '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': '00204705a9daa57ed339a427000001b9-1472138533.492312-8059851', '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 08:22:58 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 08:22:58 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 08:22:58 INFO - Using env: {'DISPLAY': ':0', 08:22:58 INFO - 'HOME': '/home/cltbld', 08:22:58 INFO - 'LANG': 'en_US.UTF-8', 08:22:58 INFO - 'LANGUAGE': 'en_US:en', 08:22:58 INFO - 'LOGNAME': 'cltbld', 08:22:58 INFO - 'MAIL': '/var/mail/cltbld', 08:22:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:22:58 INFO - 'MOZ_NO_REMOTE': '1', 08:22:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:22:58 INFO - 'NO_EM_RESTART': '1', 08:22:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:22:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:22:58 INFO - 'PWD': '/builds/slave/test', 08:22:58 INFO - 'SHELL': '/bin/bash', 08:22:58 INFO - 'SHLVL': '1', 08:22:58 INFO - 'TERM': 'linux', 08:22:58 INFO - 'TMOUT': '86400', 08:22:58 INFO - 'USER': 'cltbld', 08:22:58 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1472138533.492312-8059851', 08:22:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:22:58 INFO - '_': '/tools/buildbot/bin/python'} 08:22:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:22:58 INFO - Running setup.py (path:/tmp/pip-GiKfXO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:22:58 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)) 08:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:22:58 INFO - Running setup.py (path:/tmp/pip-CFyupc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:22:58 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)) 08:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:22:58 INFO - Running setup.py (path:/tmp/pip-wqAoTx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:22:58 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)) 08:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:22:58 INFO - Running setup.py (path:/tmp/pip-yRvhRc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:22:59 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)) 08:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:22:59 INFO - Running setup.py (path:/tmp/pip-4lIaEu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:22:59 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)) 08:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:22:59 INFO - Running setup.py (path:/tmp/pip-W4PnGY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:22:59 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)) 08:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:22:59 INFO - Running setup.py (path:/tmp/pip-WrJYas-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:22:59 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)) 08:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:22:59 INFO - Running setup.py (path:/tmp/pip-wM7kzP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:22:59 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)) 08:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:22:59 INFO - Running setup.py (path:/tmp/pip-C6Acud-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:22:59 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)) 08:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:22:59 INFO - Running setup.py (path:/tmp/pip-rn6Uec-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:22:59 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)) 08:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:22:59 INFO - Running setup.py (path:/tmp/pip-J9R8dw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:22:59 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)) 08:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:22:59 INFO - Running setup.py (path:/tmp/pip-sKFPX_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:22:59 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)) 08:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:22:59 INFO - Running setup.py (path:/tmp/pip-ccFMPi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:22:59 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)) 08:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:22:59 INFO - Running setup.py (path:/tmp/pip-r6MzcT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:22:59 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)) 08:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:22:59 INFO - Running setup.py (path:/tmp/pip-gurUgt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:22:59 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)) 08:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:22:59 INFO - Running setup.py (path:/tmp/pip-q_z_6a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:22:59 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)) 08:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:22:59 INFO - Running setup.py (path:/tmp/pip-KaVxZm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:22:59 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)) 08:22:59 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)) 08:22:59 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)) 08:22:59 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)) 08:22:59 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)) 08:22:59 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)) 08:22:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:22:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:22:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:22:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:22:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:22:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:22:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:01 INFO - Downloading blessings-1.6.tar.gz 08:23:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:23:01 INFO - Installing collected packages: blessings 08:23:01 INFO - Running setup.py install for blessings 08:23:02 INFO - Successfully installed blessings 08:23:02 INFO - Cleaning up... 08:23:02 INFO - Return code: 0 08:23:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:23:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:23:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:23:02 INFO - Reading from file tmpfile_stdout 08:23:02 INFO - Current package versions: 08:23:02 INFO - argparse == 1.2.1 08:23:02 INFO - blessings == 1.6 08:23:02 INFO - blobuploader == 1.2.4 08:23:02 INFO - docopt == 0.6.1 08:23:02 INFO - functools32 == 3.2.3-2 08:23:02 INFO - jsonschema == 2.5.1 08:23:02 INFO - manifestparser == 1.1 08:23:02 INFO - mozInstall == 1.12 08:23:02 INFO - mozcrash == 0.17 08:23:02 INFO - mozdebug == 0.1 08:23:02 INFO - mozdevice == 0.48 08:23:02 INFO - mozfile == 1.2 08:23:02 INFO - mozhttpd == 0.7 08:23:02 INFO - mozinfo == 0.9 08:23:02 INFO - mozleak == 0.1 08:23:02 INFO - mozlog == 3.3 08:23:02 INFO - moznetwork == 0.27 08:23:02 INFO - mozprocess == 0.23 08:23:02 INFO - mozprofile == 0.28 08:23:02 INFO - mozrunner == 6.12 08:23:02 INFO - mozscreenshot == 0.1 08:23:02 INFO - mozsystemmonitor == 0.3 08:23:02 INFO - moztest == 0.7 08:23:02 INFO - mozversion == 1.4 08:23:02 INFO - psutil == 3.1.1 08:23:02 INFO - requests == 1.2.3 08:23:02 INFO - wsgiref == 0.1.2 08:23:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:23:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:23:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:23:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:02 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 0x7f383506ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1913230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x190d090>, '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 0x19109b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1910e40>, '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': '00204705a9daa57ed339a427000001b9-1472138533.492312-8059851', '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 08:23:02 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 08:23:02 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 08:23:02 INFO - Using env: {'DISPLAY': ':0', 08:23:02 INFO - 'HOME': '/home/cltbld', 08:23:02 INFO - 'LANG': 'en_US.UTF-8', 08:23:02 INFO - 'LANGUAGE': 'en_US:en', 08:23:02 INFO - 'LOGNAME': 'cltbld', 08:23:02 INFO - 'MAIL': '/var/mail/cltbld', 08:23:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:02 INFO - 'MOZ_NO_REMOTE': '1', 08:23:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:02 INFO - 'NO_EM_RESTART': '1', 08:23:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:02 INFO - 'PWD': '/builds/slave/test', 08:23:02 INFO - 'SHELL': '/bin/bash', 08:23:02 INFO - 'SHLVL': '1', 08:23:02 INFO - 'TERM': 'linux', 08:23:02 INFO - 'TMOUT': '86400', 08:23:02 INFO - 'USER': 'cltbld', 08:23:02 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1472138533.492312-8059851', 08:23:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:02 INFO - '_': '/tools/buildbot/bin/python'} 08:23:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:02 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)) 08:23:02 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)) 08:23:02 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)) 08:23:02 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)) 08:23:02 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)) 08:23:02 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)) 08:23:02 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)) 08:23:02 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)) 08:23:02 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)) 08:23:02 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)) 08:23:02 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)) 08:23:02 INFO - Cleaning up... 08:23:02 INFO - Return code: 0 08:23:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:23:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:23:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:23:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:02 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 0x7f383506ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1913230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x190d090>, '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 0x19109b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1910e40>, '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': '00204705a9daa57ed339a427000001b9-1472138533.492312-8059851', '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 08:23:02 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 08:23:02 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 08:23:02 INFO - Using env: {'DISPLAY': ':0', 08:23:02 INFO - 'HOME': '/home/cltbld', 08:23:02 INFO - 'LANG': 'en_US.UTF-8', 08:23:02 INFO - 'LANGUAGE': 'en_US:en', 08:23:02 INFO - 'LOGNAME': 'cltbld', 08:23:02 INFO - 'MAIL': '/var/mail/cltbld', 08:23:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:02 INFO - 'MOZ_NO_REMOTE': '1', 08:23:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:02 INFO - 'NO_EM_RESTART': '1', 08:23:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:02 INFO - 'PWD': '/builds/slave/test', 08:23:02 INFO - 'SHELL': '/bin/bash', 08:23:02 INFO - 'SHLVL': '1', 08:23:02 INFO - 'TERM': 'linux', 08:23:02 INFO - 'TMOUT': '86400', 08:23:02 INFO - 'USER': 'cltbld', 08:23:02 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1472138533.492312-8059851', 08:23:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:02 INFO - '_': '/tools/buildbot/bin/python'} 08:23:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:02 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:23:02 INFO - Cleaning up... 08:23:02 INFO - Return code: 0 08:23:02 INFO - Running post-action listener: _resource_record_post_action 08:23:02 INFO - Running post-action listener: _start_resource_monitoring 08:23:02 INFO - Starting resource monitoring. 08:23:02 INFO - [mozharness: 2016-08-25 15:23:02.815015Z] Finished create-virtualenv step (success) 08:23:02 INFO - [mozharness: 2016-08-25 15:23:02.815471Z] Running install step. 08:23:02 INFO - Running pre-action listener: _resource_record_pre_action 08:23:02 INFO - Running main action method: install 08:23:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:23:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:23:03 INFO - Reading from file tmpfile_stdout 08:23:03 INFO - Detecting whether we're running mozinstall >=1.0... 08:23:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:23:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:23:03 INFO - Reading from file tmpfile_stdout 08:23:03 INFO - Output received: 08:23:03 INFO - Usage: mozinstall [options] installer 08:23:03 INFO - Options: 08:23:03 INFO - -h, --help show this help message and exit 08:23:03 INFO - -d DEST, --destination=DEST 08:23:03 INFO - Directory to install application into. [default: 08:23:03 INFO - "/builds/slave/test"] 08:23:03 INFO - --app=APP Application being installed. [default: firefox] 08:23:03 INFO - mkdir: /builds/slave/test/build/application 08:23:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:23:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:23:19 INFO - Reading from file tmpfile_stdout 08:23:19 INFO - Output received: 08:23:19 INFO - /builds/slave/test/build/application/firefox/firefox 08:23:19 INFO - Running post-action listener: _resource_record_post_action 08:23:19 INFO - [mozharness: 2016-08-25 15:23:19.190542Z] Finished install step (success) 08:23:19 INFO - [mozharness: 2016-08-25 15:23:19.190789Z] Running run-tests step. 08:23:19 INFO - Running pre-action listener: _resource_record_pre_action 08:23:19 INFO - Running main action method: run_tests 08:23:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:23:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:23:19 INFO - Python 2.7.3 08:23:19 INFO - Return code: 0 08:23:19 INFO - grabbing minidump binary from tooltool 08:23:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:23:19 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 0x190d090>, '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 0x19109b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1910e40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:23:19 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 08:23:19 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 08:23:19 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 08:23:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:23:19 INFO - Return code: 0 08:23:19 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:23:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:23:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:23:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:23:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:23:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AmlpMaaKSjSbDlMngjkkHQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:23:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/AmlpMaaKSjSbDlMngjkkHQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-016 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:23:19 INFO - Using env: {'DISPLAY': ':0', 08:23:19 INFO - 'HOME': '/home/cltbld', 08:23:19 INFO - 'LANG': 'en_US.UTF-8', 08:23:19 INFO - 'LANGUAGE': 'en_US:en', 08:23:19 INFO - 'LOGNAME': 'cltbld', 08:23:19 INFO - 'MAIL': '/var/mail/cltbld', 08:23:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:23:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:23:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:19 INFO - 'MOZ_NO_REMOTE': '1', 08:23:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:23:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:19 INFO - 'NO_EM_RESTART': '1', 08:23:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:19 INFO - 'PWD': '/builds/slave/test', 08:23:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:23:19 INFO - 'SHELL': '/bin/bash', 08:23:19 INFO - 'SHLVL': '1', 08:23:19 INFO - 'TERM': 'linux', 08:23:19 INFO - 'TMOUT': '86400', 08:23:19 INFO - 'USER': 'cltbld', 08:23:19 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1472138533.492312-8059851', 08:23:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:19 INFO - '_': '/tools/buildbot/bin/python'} 08:23:19 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AmlpMaaKSjSbDlMngjkkHQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:23:19 INFO - mozversion application_buildid: 20160825054326 08:23:19 INFO - mozversion application_changeset: 7963ebdd52b93f96b812eff2eab8d94097147b9c 08:23:19 INFO - mozversion application_display_name: Nightly 08:23:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:23:19 INFO - mozversion application_name: Firefox 08:23:19 INFO - mozversion application_remotingname: firefox 08:23:19 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:23:19 INFO - mozversion application_vendor: Mozilla 08:23:19 INFO - mozversion application_version: 51.0a1 08:23:19 INFO - mozversion platform_buildid: 20160825054326 08:23:19 INFO - mozversion platform_changeset: 7963ebdd52b93f96b812eff2eab8d94097147b9c 08:23:19 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:23:19 INFO - mozversion platform_version: 51.0a1 08:23:19 INFO - using testdate: 1472138599 08:23:19 INFO - actual date: 1472138599 08:23:19 INFO - starting webserver on 'localhost:50922' 08:23:19 INFO - SUITE-START | Running 2 tests 08:23:19 INFO - TEST-START | dromaeo_css 08:23:19 INFO - operating with platform_type : linux_ 08:23:19 INFO - Initialising browser for dromaeo_css test... 08:23:19 INFO - TEST-INFO | started process 21086 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpio0xzP/profile http://localhost:50922/getInfo.html) 08:23:23 INFO - PROCESS | 21086 | __metrics Screen width/height:1600/1200 08:23:23 INFO - PROCESS | 21086 | colorDepth:24 08:23:23 INFO - PROCESS | 21086 | Browser inner width/height: 1024/697 08:23:23 INFO - PROCESS | 21086 | __metrics 08:23:24 INFO - PROCESS | 21086 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:23:24 INFO - PROCESS | 21086 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:23:25 INFO - PROCESS | 21086 | console.error: PushService: 08:23:25 INFO - PROCESS | 21086 | stateChangeProcessEnqueue: Error transitioning state 08:23:25 INFO - PROCESS | 21086 | UnknownError 08:23:25 INFO - TEST-INFO | 21086: exit 0 08:23:25 INFO - Browser initialized. 08:23:25 INFO - Running cycle 1/1 for dromaeo_css test... 08:23:25 INFO - TEST-INFO | started process 21166 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpio0xzP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:23:37 INFO - PROCESS | 21166 | RSS: Main: 179249152 08:23:37 INFO - PROCESS | 21166 | 08:24:29 INFO - PROCESS | 21166 | 1472138669183 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] 08:26:42 INFO - PROCESS | 21166 | Cycle 1(1): loaded http://localhost:50922/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50922/tests/dromaeo/cssquery-ext.html) 08:26:43 INFO - PROCESS | 21166 | RSS: Main: 270249984 08:26:43 INFO - PROCESS | 21166 | 08:29:46 INFO - PROCESS | 21166 | Cycle 1(1): loaded http://localhost:50922/tests/dromaeo/cssquery-ext.html (next: http://localhost:50922/tests/dromaeo/cssquery-jquery.html) 08:29:47 INFO - PROCESS | 21166 | RSS: Main: 278335488 08:29:47 INFO - PROCESS | 21166 | 08:32:49 INFO - PROCESS | 21166 | Cycle 1(1): loaded http://localhost:50922/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50922/tests/dromaeo/cssquery-mootools.html) 08:32:49 INFO - PROCESS | 21166 | RSS: Main: 218869760 08:32:49 INFO - PROCESS | 21166 | 08:35:52 INFO - PROCESS | 21166 | Cycle 1(1): loaded http://localhost:50922/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50922/tests/dromaeo/cssquery-prototype.html) 08:35:52 INFO - PROCESS | 21166 | RSS: Main: 228503552 08:35:52 INFO - PROCESS | 21166 | 08:38:56 INFO - PROCESS | 21166 | Cycle 1(1): loaded http://localhost:50922/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50922/tests/dromaeo/cssquery-yui.html) 08:38:56 INFO - PROCESS | 21166 | RSS: Main: 216801280 08:38:56 INFO - PROCESS | 21166 | 08:41:59 INFO - PROCESS | 21166 | Cycle 1(1): loaded http://localhost:50922/tests/dromaeo/cssquery-yui.html (next: http://localhost:50922/tests/dromaeo/cssquery-dojo.html) 08:41:59 INFO - PROCESS | 21166 | RSS: Main: 304275456 08:41:59 INFO - PROCESS | 21166 | 08:41:59 INFO - PROCESS | 21166 | __start_tp_report 08:41:59 INFO - PROCESS | 21166 | _x_x_mozilla_page_load 08:41:59 INFO - PROCESS | 21166 | _x_x_mozilla_page_load_details 08:41:59 INFO - PROCESS | 21166 | |i|pagename|runs| 08:41:59 INFO - PROCESS | 21166 | |0;dojo.html;2574.961375579366;2588.948221035578;2590.676165479316;2605.1663467690337;2633.0915834037264;4507.6168525675275;4600.102979918917;4620.168369693454;4699.083678682654;4748.335233067373;4543.636509079274;4598.655100867431;4622.630189584834;4631.050634619904;4684.086603112394;4153.937690934638;4160.979195104035;4214.536400995888;4288.656907447396;4398.516163222043;4338.392625032498;4339.566043395666;4370.235208838457;4370.825166993316;4393.1872603568445;4157.646600039;4186.727862688916;4198.391233271159;4270.829166833323;4274.29474136767;4209.7895105244925;4209.957900421018;4217.894552636178;4261.552536983634;4271.188474189894;4181.832726690929;4201.537830838605;4249.383839343278;4250.256205164084;4255.0426154115385;4601.723896566216;4642.048380082075;4642.117997580449;4647.372604698357;4686.835960741358;4849.005953779467;4923.064617722621;4926.531979461981;4937.925931111036;4949.925751113737;4923.827666031708;4932.580730637864;4933.333999910002;4939.086269040239;5009.7495125243595;4503.954960450354;4598.79305431253;4620.722756634613;4631.930521042187;4632.5830675239395;4915.877103072452;4956.033573453215;4960.503949605083;4972.378452693413;5035.84892453227;4761.40482439695;4786.8085276588545;4792.808287668454;4794.304825800239;4850.151223535938;4740.905181896343;4852.466228714909;4860.246661767432;4865.878353041131;4925.630577706686;4835.734034628129;4881.4630390657;4884.169691152512;4884.291777692215;4968.8509344719;4896.534829191292;4903.607711383081;4905.288733133676;4907.7064147031515;4970.726610036482;4094.3449048152747;4230.619244267969;4232.386303985905;4243.724157929724;4284.464441944757;3614.963850361515;3679.2273622539033;3704.944425833615;3752.75607085544;3798;4253.106847561985;4262.552431994658;4272.359146128106;4278.7004909656025;4332;4995.075910956485;4996.275540046673;4997.425296090996;5003.24951257307;5043.445221025684;4178.8537401190815;4180.874573762792;4199.601037901394;4211.473565804275;4262.65898728101;4412.3160910059;4432.113577284492;4436.401085853433;4437.667174961891;4491.595756381876;4619.676622636383;4627.30590411441;4631.606313463393;4649.465311489222;4684;4774.30772537987;4879.463259041431;4939.580135688363;4939.75301234944;4999.075171093359;4642.419697537808;4646.790894409827;4652.860414187579;4668.813247470063;4714.292856071616;4845.442774081026;4851.733154676385;4853.611711063177;4860.3195552621955;4919.704817710949;4733.171694953438;4828.66199366041;4835.371401717754;4866.391701037371;4890.437599675941;4798.016406636701;4804.615630749601;4806.375171227718;4831.710097394168;4862.294967229803;4790.329353890388;4790.760461976957;4794.808207671654;4795.136875362328;4844.249141383091;4634;4737.786799594095;4760.428748550196;4784.976075119741;4796.136695394863;4863.416390033219;4907.043126590281;4914.7542622867995;4950.133726597759;4980.103581355391;4773.403324584427;4789.521047895182;4792.113459010095;4793.640476964172;4844.0554091951735 08:41:59 INFO - PROCESS | 21166 | |1;ext.html;563.6026601246119;563.9323281206255;569.4903061759724;578.777170789246;586.1852025684296;28007.719922800767;38683.41974870376;39801.80099099504;39881.40177897334;43124.568754312444;39450.80274598623;39514;39794.80102599483;39831.80084099583;39901.800490997506;7267.963660181718;7543.4719569630015;7668.463207575472;7703.730369437071;7706.576138312391;7167.0682811234465;7418.072740907387;7418.332350088491;9711.320207585472;9902.356346837469;10000.04999525044;10028.849567256497;10048.397096174216;10050.296479246455;10055.19558435327;9876.901230987705;9951.502424878727;9962.900370996269;9966.601335946554;9970.25223108266;9515.333926625139;9605.663801766905;9609.519524023772;9611.807763844685;9613.663521776703;37389.25221495582;37682.24635507302;37700.81149594262;37714.24571508555;37715.62284377149;3056.6484854241826;3292.8024318540965;3378.425667636483;3383.712384447325;3473.444248920186;28430;28811.56782648262;28884.422311553863;28892;30496.237594060105;3430.588329400463;3441.741869359808;3531.5408996830247;3539.50446937429;3566.8038257895805;240322;241242.22608834776;241607;242279;242618;30352.54471182934;50115.74942125266;50475.24287135696;50503;50513.74743126261;30771.846140769154;32459.837700811346;32467.35065298728;32480;32497.187570310933;12946.029047821452;13048.673783155307;13069.215847049207;13094.934525327502;13098.869011309765;10812.405317707444;10884.129269658408;10884.891151088388;10887.673369798918;10891.128709703205;7148;7481.588512631857;7647.120581133129;7716.691332346643;7825.804354891174;3044.1476386611785;3088.351446196324;3103.8137711736917;3108.7202151805996;3119.2201949512623;839.6347588798892;896.5830888636815;921.3872774604947;934.1872570863256;961.293449314753;25988.74011259901;28287.43425131486;28320.73434125265;28446.715532844406;28676.569851452245;930.6603089872148;958.6069711418425;972.8832540095234;979.6669132494986;981.4503877828439;14523.78214326786;14892.180930048735;15004.474843380647;15198.772018419733;15199.316030778642;365303;366802;368275;368323;368436;47866.52133478621;48539.271910921365;48629.270560941615;48647.75676121597;48675;1085.9294145880492;1150.3787954504473;1167.9532818687157;1182.4560702076797;1198.9280643161437;26509.33726656849;28784.42431151407;29092.418151637274;29351;29667.258318541346;39159;45023.324650130926;46107;46110;51270.48729512657;357033;361849;362457;362682;363008;24190.637140442555;25150.11974580954;25185.370365741004;37965.43051854169;38555.22889542137;39019;39025.804870975466;39412.51162279158;39540.40689389604;39644.801775990934;33316.83341583276;33323.666763332054;33780.83109584436;33817.49273760847;34322.31355372829;33235.50146747752;33943.66056339405;34020.14949626279;34799.30401391907;35364.82317588499;33315;34088.82955585305;34213.657863421045;34507.34150889598;34522.65477345194;30158.69841301559;30847.2288192788;31295.687043129277;31433;31475.84262078675;24320.058945649467;24384.146554870495;24570.63144052805;24756.38109047216;24908.12821551237 08:41:59 INFO - PROCESS | 21166 | |2;jquery.html;340.3035866206956;361.8715356048604;364.58437381385215;369.9815009249537;374.68713624123853;12511.374431278433;16034.51896443107;16037.679246415079;16326.673466530692;17525.21136548855;16285.430009949654;16599.66800663986;16965.49103526893;17071.146442677848;17080.914595427035;4916.016796640668;4925;5005.724685142316;5041.143005689023;5044.419891712463;3690.5940346561856;3820.789856557888;4987.975060124712;5070.797168113271;5082.110630639623;3883.572806991243;3891.6497515223623;4417.779111044451;5748.683822389767;5772.393898640646;5864.472197502203;5867.325257595346;5871.1193321001765;5889.79385721502;5900.350961394243;5065.442801291855;5235.1623740201385;5299.152135658276;5306.495882891158;5311;18736;19182.904085479622;19228.134733937008;20545;20761.58476830455;2069.503319203395;2350.8942097605477;2388.868612226327;2415.842970206931;2481.6153496208117;8931.776705582348;9627.277954153467;9860.161886239679;12217.877821221762;13038.282894440801;1707.4621494229277;1762.2510433065895;1768.124778234769;1771.5128339706555;1797.128392729525;66501.66749166271;67862;68764.3123568763;69352.3064769356;69555;10009;10059.742532183476;10229.74425639365;10477.31897426665;10541.156707463384;14031.087979281314;14060.226687532284;14065.578032659037;14082.225477598831;14107.71784564303;6945.861082778417;7139.500234983501;7185;7372.741954031583;7390.076240469942;6662.900056499157;6707.579134641271;6880.931190688129;6885.208201056842;6888.965555172293;4289.613934745826;4361.651067914623;4387.912241755211;4476.731396116244;4513.977430112894;1766.3641089207874;1793.6681713882974;1802.180008096313;1815.3646223821556;1863.7297591849106;823.6828820903876;830.2527725047505;835.5905606252892;864.0754392799644;901.6213190460022;16556.523130142807;16783.496495105166;16814.243359048873;17311;17603.82396176022;872.6771094694876;878.2578720980761;895.3598177303129;914.9542522873962;928.0302084321764;9038.63845446188;9622.951885240529;9680.225581953428;9686.128248457673;9742;366388;366756;368634;372626;373905;72730.27269727341;75703.62148189223;76059.23940760632;76832;78261;874.0691163910415;895.5477483870603;918.9218916392048;919.0120620333169;920.7053742802373;15029.924850375679;15065.623359415664;15379.538613841603;15643.687126257639;15767;35752.284954301285;35897.28205435929;36392;36665;37301.4404783923;49955.25067124069;50154.49845501498;50424;52853.20720189277;53597.464025359244;7433.70265189408;7680.231976802275;7713.151553329241;7844.607769611611;8032;8626.11849578495;11127.276727012719;11357.943210283896;11536.192466527598;11954.940225298818;9017.098290171192;9216.907830921606;9292.58183381736;9527.47598882068;9579.281553883347;9901.801963960825;10104.747381315527;10105.848412273675;10375.325603835727;10553.63062292816;9384.95307523458;9851.310408271353;9941.353812002197;10173.389596624227;10214.131798796889;7423.294786995227;7599.848003040019;7746.961265193638;7804.180561041009;7868.72459463916;4554.476235232991;4653.790579423866;9430.151286384258;9476.768020157335;9989.850152247576 08:41:59 INFO - PROCESS | 21166 | |3;mootools.html;1242.4533205389635;1333.8732820382063;1392.0673148990174;1420.5525259543242;1656.3788579282768;7405.5186412883195;7796.493227940187;7798.298153166221;7979.561124138185;7982.121966583672;7820.530768153914;7914.129445760962;7917.287444130027;7939.523628582289;7947.364210863131;1840.9631807363844;2090.6097445198925;2174.293354659738;2199.2082850173924;2201.636729939558;2160.621891169047;2160.924367647133;2161.2975782870553;2163.3185546552863;2183.443221978401;2120.6076875777953;2143.0142134618095;2148.054855863415;2150.849440539163;2184.388371256051;2036.4603380104284;2068.917243310266;2075.0247383729625;2075.2632815350635;2103.926362577318;2190.233418303597;2207.1061220205843;2210.668399740036;2212.093041852833;2213.2917466410754;7752.147263800977;7788.260115289038;7797.7660670179985;7808.843823123562;7823.374130069581;4427.800748966304;4573.245414506636;4574.885627859297;4579.381783459224;4591.540845915415;2883.8413887236193;2913.6940621234676;3037.58992536007;3039.1794215561677;3044.101989912981;954.4941181173989;954.6754103604808;964.71058682395;965.9227261819037;978.6770365779275;10757.193210509244;10860.402677852637;10877.67366978992;10892.128629709605;10905.454727263685;3968.6229808168755;4091.57038510958;4102.466679331667;4104.712670113123;4316.115196384796;8172.346212303001;8253.504789712517;8277.58612069394;8284.171582841787;8304.667813287522;4333.978330108329;4339.956600434019;4340.435743353344;4342.088161486124;4346.152500262482;3585.551806024247;3961.980190099031;3964.702647301406;4070.4911886014247;4140.834366625301;3385.170633194883;3389.6271410144864;3451.8101504416995;3496;3501.807400592992;1031.4327120083924;1037.5849660136007;1042.4058286776617;1049.6378749331468;1057.836035414512;775.1047540091204;793.8610743119931;827.3505298340893;833.2667252817482;848.7411339541499;5203.898945693287;5268.394134674485;5322.281491998608;5355.0360935031285;5548.056830338852;424.6114804953495;429.42671533503125;435.1101996417334;435.22964353094847;436.89514516515806;3517.36687396266;3541.5041894134843;3586.7309951753723;3596.3346780845627;3770.377887648562;9692.75768105803;10081.042300981395;10124.949375253223;10147.797044059078;10148.898511014942;10024.599016039278;10025.448600326907;10065.547050382751;10076.193904487624;10086.142677872464;7288.635568221568;7386;7403.185649578542;7511.211322811136;7572.167061623217;5215.217717342429;5241.266222728897;5243.606729495227;5244.292020577173;5341.145416733304;8942.46345219289;8957.507337096262;8958.148975847284;8985.146411090936;9074.773130671521;8759.080296569024;8943.508107054175;8967.192952634294;9038.186563209343;9043;6056.121862329849;6114.755409783559;6745.52781305304;6783.491238157059;6925.272846351262;7408.851822963618;7734.5359278443475;7744.2642948919765;7759.456838021284;7763.805904852424;6612.437942774918;6856.554323968926;6867.416269616939;6895.5173137881875;6953.687084081127;6754.493412994143;6831.077804496329;6865.450763938773;6888.965555172192;6898.965505172643;6334.923063079195;6348.079528468438;6409.327020662763;6424.229092508929;6431.710573024318;4585;4629.1436084324505;4651.767411629473;4793.0413917216;4911.091448082117;4654.16225079489;4658.720476771405;4728.219843725747;4781.258904869751;4808.951910480991 08:41:59 INFO - PROCESS | 21166 | |4;prototype.html;293.32535169111054;298.517893601833;301.35209300005;303.59924899133136;304.83843562911636;4597.9080418391695;4715.066822602734;4723.504032076634;4744.786484608192;4782.995570930105;4525.954740452603;4602.677812553123;4634.281686338614;4647.674662773607;4668.159731248374;3732.1789206374556;3751.4935483709623;3754.7559408638417;3754.9910797723223;3759.4172903200047;3583.5341405617232;3782.5460944686674;3789.431585262219;3791.772493650376;3811.942820857689;3532.364174448598;3730.694257010052;3733.4959780429567;3742.101895545063;3749.3626083565723;3725.5343082114737;3736;3739.663430291273;3742.5321834770652;3753.680937120348;3308.586426696663;3310.543360921187;3323.8670453181844;3324.817135057571;3331.850066747002;4516.9159401743345;4601.148787474328;4616.8614941551805;4647.930281045787;4668.323093151508;4212.178625168093;4220.767857767822;4229.2598795210715;4231.936520952188;4248.277792775236;4908.920037591724;4926.507349265081;4927.6550641455115;4962.851114466572;4970.82602108928;3483.2336885885065;3585.15748799032;3600.7119430445764;3610.3681855675413;3624.4563315502887;5167.224916262553;5175.948240517584;5177;5202.297689811865;5226.294450249244;3722.8510859565313;3722.8883133506038;3728.2729867675544;3728.496652951817;3740.588535261119;3781.636477201749;3797.2974999625158;3815.4276858471453;3821.503204583442;3823.5338206856422;4179.665626749853;4264.31770916658;4280.785960701953;4309.870703878889;4317.11499142675;4919.2129259318335;4943.258511223274;4949.851504454872;4953.455119936804;4955.1823949048;1244.9190802597802;1249.3877999780043;1273.5860845225338;1274.9107562470538;1283.2483659804486;898.7573355194061;928.823523530527;932.8181004704153;934.3973137326523;937.301710225886;4408.118376324684;4415.448068991376;4418.580234877746;4424.889377765518;4434.401355816924;5157.0975079361715;5167.457416971239;5169.095408303532;5171.896562068738;5173.922391164136;4294.291441912112;4326.9663258268565;4356.346548017759;4357.4988876279;4424.84513042042;2356.7761062699014;2410.5781488239486;2411.8794060296914;2414.5774489464275;2418.709754829432;4278.978605107017;4290.8843700637435;4309.547497512779;4343.847965321262;4351.607485604576;4376.540463251376;4585.518520555293;4622.237330840374;4623.722576645345;4648.883777905579;4287.549807270254;4289;4290.313549832012;4320.287152619782;4335.349697545394;4465.910681786281;4480.260756975063;4489.416375871116;4490.932636010397;4524.773761311987;4267.67992400565;4395.626371758309;4429.579189976947;4433.423654924839;4434.756088415168;4290.485141783006;4297.312430011183;4300.333448315516;4312.611864932172;4312.741235525878;3409.7101746351836;3417.1115509968085;3422.2279953237958;3426.417509023422;3450.706689931384;4312.5903039211225;4525.275955847049;4540.636749060001;4550.590446859798;4566.45202575693;4376;4377.6497880170145;4387.36383224437;4406.911861762683;4407.11857628482;4311.288637374798;4328.458942632171;4375.309184851357;4385.386045953633;4407.933880991852;4308.74147551148;4320.243957307396;4341.392205091227;4607.009492958896;4668.229742092517;4965.975170124127;4980.078685443204;4995.200767877122;4996.7001979881325;5005.7997680092385;4854;4861.27080937848;4863.7324947128245;4867.58625516835;4870.4155501340065 08:41:59 INFO - PROCESS | 21166 | |5;yui.html;649.2760571962262;657.4411750012487;660.8116686744276;708.4317266286987;736.5543845973184;12965.546205882796;14166.575002749934;14191.503297384594;14251.216183109938;14363.138211707292;13113.67215819605;13241.735165296688;13248;13259.071864969455;13347.332633368342;607.8358843112356;722.5556282886026;728.2717282717283;737.1890919987998;742.8699977503942;761.8590560746279;763.3664058831157;764.2701220334595;764.4381379685926;765.1927216786288;808.7412028150994;810.5298926622545;810.8864758933754;811.1928631012122;811.5860910935436;642.5791106825037;776.9922300776976;785.2932360875258;791.8891355210275;802.3220378779922;584.6930361560172;584.988300233993;585.1865906390121;585.8271809816072;586.085706298172;13195.670108247275;13199.40602672882;13206.33968301581;13215.537456188988;13231.470741170342;12543.698935380045;12602.68493287666;13020.479180832755;13021.41403636829;13489.86510134896;11634.883651163465;11925.582604608884;11945.40272986356;12064.215825971283;12121.696957576043;4071.3282308419075;4099.836006559734;4122.793860307002;4146.3158578834455;4171.478565179353;61098.69450652763;61128;61170.388296116915;61190.69404652993;61384.38615613876;9473.976295239212;9589.856152157723;9981.80036399268;9992.300538962203;10076.69769906904;19314.903425482782;19352.4194274172;19370.612587748165;19378.321758738377;19454.90272548628;6701.061851340816;6777.898331525031;6804.95374455892;6900.413464855443;7015.403690686348;3615.349237137288;3657.305112028706;3710.888673339804;3715.8885233442497;3833.8274777635074;2765.3363192833576;2869.0818937939657;2873.6551613806478;3098.6746391629003;3282.3763484937786;560.2912315920282;566.1988286574533;567.4155619711704;569.3964397738328;583.4340689531148;542.7096503370677;586.4868240289746;607.1348328631682;628.4515350052465;632.2981490545491;8554.528430877206;8724.214820666044;8861.98087219978;8974.685885993958;9037.141471560191;499.88002879308704;548.8243761996123;560.4479587606205;575.8963386590453;587.2336600735995;4267.1679022590915;4342.934855977162;4380.6933514653665;4385.3641222022625;4438.400815889813;96182;100925.49537252267;102389;103375.48312258541;106314;85883;87923;88391;88825;89323;70155.2984470159;75978.6201068991;78164;79921.60039199766;81463;8202.475338460012;8300.626471808904;8413.831723365622;8750.47497150173;8794.824103518022;45933;46821.765891170326;47819.76090119666;48087.27869082036;48271.75864120657;63538.68230658817;63830;69405;70832.29167708257;71639;9643.324967252225;9749.951250243703;10061.446620435947;10369.377837329785;10803.135749139892;11682.47428865686;11827.763444730885;11998.100142489173;12139.453724582238;12198.634040978784;10622.946885265525;10814.783704325711;11206.327620342805;11228.66314010581;11310.264832785842;9854.852177217492;9899.851502227617;9919.206463483048;9950.10449059588;10398.844017339898;10791.352518848895;11090.611828585961;11246.04408625276;11395.316281023164;11572.132090093108;9299;9587.520623968634;9640.228781697588;9804.594442703738;9950.45272510019;8703.95648021756;8787.209151176425;9665.661701840401;10000.199984001409;10124.797504050026 08:41:59 INFO - PROCESS | 21166 | __end_tp_report 08:41:59 INFO - PROCESS | 21166 | __start_cc_report 08:41:59 INFO - PROCESS | 21166 | _x_x_mozilla_cycle_collect,945 08:41:59 INFO - PROCESS | 21166 | __end_cc_report 08:41:59 INFO - PROCESS | 21166 | __startTimestamp1472139719902__endTimestamp 08:41:59 INFO - PROCESS | 21166 | 08:41:59 INFO - PROCESS | 21166 | ------- Summary: start ------- 08:41:59 INFO - PROCESS | 21166 | Number of tests: 6 08:41:59 INFO - PROCESS | 21166 | 08:41:59 INFO - PROCESS | 21166 | [#0] dojo.html Cycles:165 Average:4561.35 Median:4686.84 stddev:466.36 (10.0%) stddev-sans-first:440.99 08:41:59 INFO - PROCESS | 21166 | Values: 2575.0 2588.9 2590.7 2605.2 2633.1 4507.6 4600.1 4620.2 4699.1 4748.3 4543.6 4598.7 4622.6 4631.1 4684.1 4153.9 4161.0 4214.5 4288.7 4398.5 4338.4 4339.6 4370.2 4370.8 4393.2 4157.6 4186.7 4198.4 4270.8 4274.3 4209.8 4210.0 4217.9 4261.6 4271.2 4181.8 4201.5 4249.4 4250.3 4255.0 4601.7 4642.0 4642.1 4647.4 4686.8 4849.0 4923.1 4926.5 4937.9 4949.9 4923.8 4932.6 4933.3 4939.1 5009.7 4504.0 4598.8 4620.7 4631.9 4632.6 4915.9 4956.0 4960.5 4972.4 5035.8 4761.4 4786.8 4792.8 4794.3 4850.2 4740.9 4852.5 4860.2 4865.9 4925.6 4835.7 4881.5 4884.2 4884.3 4968.9 4896.5 4903.6 4905.3 4907.7 4970.7 4094.3 4230.6 4232.4 4243.7 4284.5 3615.0 3679.2 3704.9 3752.8 3798.0 4253.1 4262.6 4272.4 4278.7 4332.0 4995.1 4996.3 4997.4 5003.2 5043.4 4178.9 4180.9 4199.6 4211.5 4262.7 4412.3 4432.1 4436.4 4437.7 4491.6 4619.7 4627.3 4631.6 4649.5 4684.0 4774.3 4879.5 4939.6 4939.8 4999.1 4642.4 4646.8 4652.9 4668.8 4714.3 4845.4 4851.7 4853.6 4860.3 4919.7 4733.2 4828.7 4835.4 4866.4 4890.4 4798.0 4804.6 4806.4 4831.7 4862.3 4790.3 4790.8 4794.8 4795.1 4844.2 4634.0 4737.8 4760.4 4785.0 4796.1 4863.4 4907.0 4914.8 4950.1 4980.1 4773.4 4789.5 4792.1 4793.6 4844.1 08:41:59 INFO - PROCESS | 21166 | 08:41:59 INFO - PROCESS | 21166 | [#1] ext.html Cycles:180 Average:46574.21 Median:19165.42 stddev:86696.43 (452.4%) stddev-sans-first:86870.81 08:41:59 INFO - PROCESS | 21166 | Values: 563.6 563.9 569.5 578.8 586.2 28007.7 38683.4 39801.8 39881.4 43124.6 39450.8 39514.0 39794.8 39831.8 39901.8 7268.0 7543.5 7668.5 7703.7 7706.6 7167.1 7418.1 7418.3 9711.3 9902.4 10000.0 10028.8 10048.4 10050.3 10055.2 9876.9 9951.5 9962.9 9966.6 9970.3 9515.3 9605.7 9609.5 9611.8 9613.7 37389.3 37682.2 37700.8 37714.2 37715.6 3056.6 3292.8 3378.4 3383.7 3473.4 28430.0 28811.6 28884.4 28892.0 30496.2 3430.6 3441.7 3531.5 3539.5 3566.8 240322.0 241242.2 241607.0 242279.0 242618.0 30352.5 50115.7 50475.2 50503.0 50513.7 30771.8 32459.8 32467.4 32480.0 32497.2 12946.0 13048.7 13069.2 13094.9 13098.9 10812.4 10884.1 10884.9 10887.7 10891.1 7148.0 7481.6 7647.1 7716.7 7825.8 3044.1 3088.4 3103.8 3108.7 3119.2 839.6 896.6 921.4 934.2 961.3 25988.7 28287.4 28320.7 28446.7 28676.6 930.7 958.6 972.9 979.7 981.5 14523.8 14892.2 15004.5 15198.8 15199.3 365303.0 366802.0 368275.0 368323.0 368436.0 47866.5 48539.3 48629.3 48647.8 48675.0 1085.9 1150.4 1168.0 1182.5 1198.9 26509.3 28784.4 29092.4 29351.0 29667.3 39159.0 45023.3 46107.0 46110.0 51270.5 357033.0 361849.0 362457.0 362682.0 363008.0 24190.6 25150.1 25185.4 37965.4 38555.2 39019.0 39025.8 39412.5 39540.4 39644.8 33316.8 33323.7 33780.8 33817.5 34322.3 33235.5 33943.7 34020.1 34799.3 35364.8 33315.0 34088.8 34213.7 34507.3 34522.7 30158.7 30847.2 31295.7 31433.0 31475.8 24320.1 24384.1 24570.6 24756.4 24908.1 08:41:59 INFO - PROCESS | 21166 | 08:41:59 INFO - PROCESS | 21166 | [#2] jquery.html Cycles:180 Average:23531.16 Median:4956.49 stddev:61170.46 (1234.1%) stddev-sans-first:61317.27 08:41:59 INFO - PROCESS | 21166 | Values: 340.3 361.9 364.6 370.0 374.7 12511.4 16034.5 16037.7 16326.7 17525.2 16285.4 16599.7 16965.5 17071.1 17080.9 4916.0 4925.0 5005.7 5041.1 5044.4 3690.6 3820.8 4988.0 5070.8 5082.1 3883.6 3891.6 4417.8 5748.7 5772.4 5864.5 5867.3 5871.1 5889.8 5900.4 5065.4 5235.2 5299.2 5306.5 5311.0 18736.0 19182.9 19228.1 20545.0 20761.6 2069.5 2350.9 2388.9 2415.8 2481.6 8931.8 9627.3 9860.2 12217.9 13038.3 1707.5 1762.3 1768.1 1771.5 1797.1 66501.7 67862.0 68764.3 69352.3 69555.0 10009.0 10059.7 10229.7 10477.3 10541.2 14031.1 14060.2 14065.6 14082.2 14107.7 6945.9 7139.5 7185.0 7372.7 7390.1 6662.9 6707.6 6880.9 6885.2 6889.0 4289.6 4361.7 4387.9 4476.7 4514.0 1766.4 1793.7 1802.2 1815.4 1863.7 823.7 830.3 835.6 864.1 901.6 16556.5 16783.5 16814.2 17311.0 17603.8 872.7 878.3 895.4 915.0 928.0 9038.6 9623.0 9680.2 9686.1 9742.0 366388.0 366756.0 368634.0 372626.0 373905.0 72730.3 75703.6 76059.2 76832.0 78261.0 874.1 895.5 918.9 919.0 920.7 15029.9 15065.6 15379.5 15643.7 15767.0 35752.3 35897.3 36392.0 36665.0 37301.4 49955.3 50154.5 50424.0 52853.2 53597.5 7433.7 7680.2 7713.2 7844.6 8032.0 8626.1 11127.3 11357.9 11536.2 11954.9 9017.1 9216.9 9292.6 9527.5 9579.3 9901.8 10104.7 10105.8 10375.3 10553.6 9385.0 9851.3 9941.4 10173.4 10214.1 7423.3 7599.8 7747.0 7804.2 7868.7 4554.5 4653.8 9430.2 9476.8 9989.9 08:41:59 INFO - PROCESS | 21166 | 08:41:59 INFO - PROCESS | 21166 | [#3] mootools.html Cycles:180 Average:5131.46 Median:4640.46 stddev:2946.59 (63.5%) stddev-sans-first:2940.36 08:41:59 INFO - PROCESS | 21166 | Values: 1242.5 1333.9 1392.1 1420.6 1656.4 7405.5 7796.5 7798.3 7979.6 7982.1 7820.5 7914.1 7917.3 7939.5 7947.4 1841.0 2090.6 2174.3 2199.2 2201.6 2160.6 2160.9 2161.3 2163.3 2183.4 2120.6 2143.0 2148.1 2150.8 2184.4 2036.5 2068.9 2075.0 2075.3 2103.9 2190.2 2207.1 2210.7 2212.1 2213.3 7752.1 7788.3 7797.8 7808.8 7823.4 4427.8 4573.2 4574.9 4579.4 4591.5 2883.8 2913.7 3037.6 3039.2 3044.1 954.5 954.7 964.7 965.9 978.7 10757.2 10860.4 10877.7 10892.1 10905.5 3968.6 4091.6 4102.5 4104.7 4316.1 8172.3 8253.5 8277.6 8284.2 8304.7 4334.0 4340.0 4340.4 4342.1 4346.2 3585.6 3962.0 3964.7 4070.5 4140.8 3385.2 3389.6 3451.8 3496.0 3501.8 1031.4 1037.6 1042.4 1049.6 1057.8 775.1 793.9 827.4 833.3 848.7 5203.9 5268.4 5322.3 5355.0 5548.1 424.6 429.4 435.1 435.2 436.9 3517.4 3541.5 3586.7 3596.3 3770.4 9692.8 10081.0 10124.9 10147.8 10148.9 10024.6 10025.4 10065.5 10076.2 10086.1 7288.6 7386.0 7403.2 7511.2 7572.2 5215.2 5241.3 5243.6 5244.3 5341.1 8942.5 8957.5 8958.1 8985.1 9074.8 8759.1 8943.5 8967.2 9038.2 9043.0 6056.1 6114.8 6745.5 6783.5 6925.3 7408.9 7734.5 7744.3 7759.5 7763.8 6612.4 6856.6 6867.4 6895.5 6953.7 6754.5 6831.1 6865.5 6889.0 6899.0 6334.9 6348.1 6409.3 6424.2 6431.7 4585.0 4629.1 4651.8 4793.0 4911.1 4654.2 4658.7 4728.2 4781.3 4809.0 08:41:59 INFO - PROCESS | 21166 | 08:41:59 INFO - PROCESS | 21166 | [#4] prototype.html Cycles:180 Average:3974.35 Median:4338.37 stddev:1112.25 (25.6%) stddev-sans-first:1080.51 08:41:59 INFO - PROCESS | 21166 | Values: 293.3 298.5 301.4 303.6 304.8 4597.9 4715.1 4723.5 4744.8 4783.0 4526.0 4602.7 4634.3 4647.7 4668.2 3732.2 3751.5 3754.8 3755.0 3759.4 3583.5 3782.5 3789.4 3791.8 3811.9 3532.4 3730.7 3733.5 3742.1 3749.4 3725.5 3736.0 3739.7 3742.5 3753.7 3308.6 3310.5 3323.9 3324.8 3331.9 4516.9 4601.1 4616.9 4647.9 4668.3 4212.2 4220.8 4229.3 4231.9 4248.3 4908.9 4926.5 4927.7 4962.9 4970.8 3483.2 3585.2 3600.7 3610.4 3624.5 5167.2 5175.9 5177.0 5202.3 5226.3 3722.9 3722.9 3728.3 3728.5 3740.6 3781.6 3797.3 3815.4 3821.5 3823.5 4179.7 4264.3 4280.8 4309.9 4317.1 4919.2 4943.3 4949.9 4953.5 4955.2 1244.9 1249.4 1273.6 1274.9 1283.2 898.8 928.8 932.8 934.4 937.3 4408.1 4415.4 4418.6 4424.9 4434.4 5157.1 5167.5 5169.1 5171.9 5173.9 4294.3 4327.0 4356.3 4357.5 4424.8 2356.8 2410.6 2411.9 2414.6 2418.7 4279.0 4290.9 4309.5 4343.8 4351.6 4376.5 4585.5 4622.2 4623.7 4648.9 4287.5 4289.0 4290.3 4320.3 4335.3 4465.9 4480.3 4489.4 4490.9 4524.8 4267.7 4395.6 4429.6 4433.4 4434.8 4290.5 4297.3 4300.3 4312.6 4312.7 3409.7 3417.1 3422.2 3426.4 3450.7 4312.6 4525.3 4540.6 4550.6 4566.5 4376.0 4377.6 4387.4 4406.9 4407.1 4311.3 4328.5 4375.3 4385.4 4407.9 4308.7 4320.2 4341.4 4607.0 4668.2 4966.0 4980.1 4995.2 4996.7 5005.8 4854.0 4861.3 4863.7 4867.6 4870.4 08:41:59 INFO - PROCESS | 21166 | 08:41:59 INFO - PROCESS | 21166 | [#5] yui.html Cycles:180 Average:18244.91 Median:584.06 stddev:26474.72 (4532.8%) stddev-sans-first:26516.02 08:41:59 INFO - PROCESS | 21166 | Values: 649.3 657.4 660.8 708.4 736.6 12965.5 14166.6 14191.5 14251.2 14363.1 13113.7 13241.7 13248.0 13259.1 13347.3 607.8 722.6 728.3 737.2 742.9 761.9 763.4 764.3 764.4 765.2 808.7 810.5 810.9 811.2 811.6 642.6 777.0 785.3 791.9 802.3 584.7 585.0 585.2 585.8 586.1 13195.7 13199.4 13206.3 13215.5 13231.5 12543.7 12602.7 13020.5 13021.4 13489.9 11634.9 11925.6 11945.4 12064.2 12121.7 4071.3 4099.8 4122.8 4146.3 4171.5 61098.7 61128.0 61170.4 61190.7 61384.4 9474.0 9589.9 9981.8 9992.3 10076.7 19314.9 19352.4 19370.6 19378.3 19454.9 6701.1 6777.9 6805.0 6900.4 7015.4 3615.3 3657.3 3710.9 3715.9 3833.8 2765.3 2869.1 2873.7 3098.7 3282.4 560.3 566.2 567.4 569.4 583.4 542.7 586.5 607.1 628.5 632.3 8554.5 8724.2 8862.0 8974.7 9037.1 499.9 548.8 560.4 575.9 587.2 4267.2 4342.9 4380.7 4385.4 4438.4 96182.0 100925.5 102389.0 103375.5 106314.0 85883.0 87923.0 88391.0 88825.0 89323.0 70155.3 75978.6 78164.0 79921.6 81463.0 8202.5 8300.6 8413.8 8750.5 8794.8 45933.0 46821.8 47819.8 48087.3 48271.8 63538.7 63830.0 69405.0 70832.3 71639.0 9643.3 9750.0 10061.4 10369.4 10803.1 11682.5 11827.8 11998.1 12139.5 12198.6 10622.9 10814.8 11206.3 11228.7 11310.3 9854.9 9899.9 9919.2 9950.1 10398.8 10791.4 11090.6 11246.0 11395.3 11572.1 9299.0 9587.5 9640.2 9804.6 9950.5 8704.0 8787.2 9665.7 10000.2 10124.8 08:41:59 INFO - PROCESS | 21166 | -------- Summary: end -------- 08:41:59 INFO - PROCESS | 21166 | 08:42:00 INFO - TEST-INFO | 21166: exit 0 08:42:00 INFO - TEST-OK | dromaeo_css | took 1121406ms 08:42:00 INFO - TEST-START | kraken 08:42:00 INFO - operating with platform_type : linux_ 08:42:00 INFO - Initialising browser for kraken test... 08:42:00 INFO - TEST-INFO | started process 21466 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqLinYt/profile http://localhost:50922/getInfo.html) 08:42:05 INFO - PROCESS | 21466 | __metrics Screen width/height:1600/1200 08:42:05 INFO - PROCESS | 21466 | colorDepth:24 08:42:05 INFO - PROCESS | 21466 | Browser inner width/height: 1024/697 08:42:05 INFO - PROCESS | 21466 | __metrics 08:42:05 INFO - PROCESS | 21466 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:42:05 INFO - PROCESS | 21466 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:42:06 INFO - PROCESS | 21466 | console.error: PushService: 08:42:06 INFO - PROCESS | 21466 | stateChangeProcessEnqueue: Error transitioning state 08:42:06 INFO - PROCESS | 21466 | UnknownError 08:42:07 INFO - TEST-INFO | 21466: exit 0 08:42:07 INFO - Browser initialized. 08:42:07 INFO - Running cycle 1/1 for kraken test... 08:42:07 INFO - TEST-INFO | started process 21547 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqLinYt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:42:19 INFO - PROCESS | 21547 | RSS: Main: 179933184 08:42:19 INFO - PROCESS | 21547 | 08:42:22 INFO - PROCESS | 21547 | Cycle 1(1): loaded http://localhost:50922/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50922/tests/kraken/driver.html?testName=audio-beat-detection) 08:42:22 INFO - PROCESS | 21547 | RSS: Main: 233234432 08:42:22 INFO - PROCESS | 21547 | 08:42:25 INFO - PROCESS | 21547 | Cycle 1(1): loaded http://localhost:50922/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50922/tests/kraken/driver.html?testName=audio-dft) 08:42:26 INFO - PROCESS | 21547 | RSS: Main: 224206848 08:42:26 INFO - PROCESS | 21547 | 08:42:29 INFO - PROCESS | 21547 | Cycle 1(1): loaded http://localhost:50922/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50922/tests/kraken/driver.html?testName=audio-fft) 08:42:30 INFO - PROCESS | 21547 | RSS: Main: 303046656 08:42:30 INFO - PROCESS | 21547 | 08:42:32 INFO - PROCESS | 21547 | Cycle 1(1): loaded http://localhost:50922/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50922/tests/kraken/driver.html?testName=audio-oscillator) 08:42:33 INFO - PROCESS | 21547 | RSS: Main: 212361216 08:42:33 INFO - PROCESS | 21547 | 08:42:35 INFO - PROCESS | 21547 | Cycle 1(1): loaded http://localhost:50922/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50922/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:42:35 INFO - PROCESS | 21547 | RSS: Main: 213934080 08:42:35 INFO - PROCESS | 21547 | 08:42:39 INFO - PROCESS | 21547 | Cycle 1(1): loaded http://localhost:50922/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50922/tests/kraken/driver.html?testName=imaging-darkroom) 08:42:39 INFO - PROCESS | 21547 | RSS: Main: 251441152 08:42:39 INFO - PROCESS | 21547 | 08:42:43 INFO - PROCESS | 21547 | Cycle 1(1): loaded http://localhost:50922/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50922/tests/kraken/driver.html?testName=imaging-desaturate) 08:42:43 INFO - PROCESS | 21547 | RSS: Main: 250880000 08:42:43 INFO - PROCESS | 21547 | 08:42:46 INFO - PROCESS | 21547 | Cycle 1(1): loaded http://localhost:50922/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50922/tests/kraken/driver.html?testName=json-parse-financial) 08:42:47 INFO - PROCESS | 21547 | RSS: Main: 251174912 08:42:47 INFO - PROCESS | 21547 | 08:42:49 INFO - PROCESS | 21547 | Cycle 1(1): loaded http://localhost:50922/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50922/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:42:49 INFO - PROCESS | 21547 | RSS: Main: 213852160 08:42:49 INFO - PROCESS | 21547 | 08:42:51 INFO - PROCESS | 21547 | Cycle 1(1): loaded http://localhost:50922/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50922/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:42:52 INFO - PROCESS | 21547 | RSS: Main: 220745728 08:42:52 INFO - PROCESS | 21547 | 08:42:54 INFO - PROCESS | 21547 | Cycle 1(1): loaded http://localhost:50922/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50922/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:42:55 INFO - PROCESS | 21547 | RSS: Main: 222502912 08:42:55 INFO - PROCESS | 21547 | 08:42:57 INFO - PROCESS | 21547 | Cycle 1(1): loaded http://localhost:50922/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50922/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:42:58 INFO - PROCESS | 21547 | RSS: Main: 223039488 08:42:58 INFO - PROCESS | 21547 | 08:43:01 INFO - PROCESS | 21547 | Cycle 1(1): loaded http://localhost:50922/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50922/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:43:02 INFO - PROCESS | 21547 | RSS: Main: 220450816 08:43:02 INFO - PROCESS | 21547 | 08:43:03 INFO - PROCESS | 21547 | Cycle 1(1): loaded http://localhost:50922/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50922/tests/kraken/driver.html?testName=ai-astar) 08:43:04 INFO - PROCESS | 21547 | RSS: Main: 271540224 08:43:04 INFO - PROCESS | 21547 | 08:43:04 INFO - PROCESS | 21547 | __start_tp_report 08:43:04 INFO - PROCESS | 21547 | _x_x_mozilla_page_load 08:43:04 INFO - PROCESS | 21547 | _x_x_mozilla_page_load_details 08:43:04 INFO - PROCESS | 21547 | |i|pagename|runs| 08:43:04 INFO - PROCESS | 21547 | |0;ai-astar;114;114;129;115;115;115;113;115;114;115 08:43:04 INFO - PROCESS | 21547 | |1;audio-beat-detection;151;120;150;202;127;148;152;126;192;123 08:43:04 INFO - PROCESS | 21547 | |2;audio-dft;162;162;164;161;162;169;164;162;161;160 08:43:04 INFO - PROCESS | 21547 | |3;audio-fft;75;77;76;180;77;77;75;77;162;76 08:43:04 INFO - PROCESS | 21547 | |4;audio-oscillator;88;87;142;86;86;87;146;85;86;138 08:43:04 INFO - PROCESS | 21547 | |5;imaging-gaussian-blur;118;116;117;117;117;117;116;116;117;117 08:43:04 INFO - PROCESS | 21547 | |6;imaging-darkroom;148;145;146;147;147;146;146;146;147;146 08:43:04 INFO - PROCESS | 21547 | |7;imaging-desaturate;95;94;94;94;95;94;95;95;95;95 08:43:04 INFO - PROCESS | 21547 | |8;json-parse-financial;65;65;65;66;65;66;66;66;66;66 08:43:04 INFO - PROCESS | 21547 | |9;json-stringify-tinderbox;65;65;65;66;67;65;65;65;67;66 08:43:04 INFO - PROCESS | 21547 | |10;stanford-crypto-aes;85;88;90;83;96;90;86;81;81;84 08:43:04 INFO - PROCESS | 21547 | |11;stanford-crypto-ccm;133;141;130;131;140;130;136;149;169;135 08:43:04 INFO - PROCESS | 21547 | |12;stanford-crypto-pbkdf2;174;177;175;170;174;171;170;170;171;169 08:43:04 INFO - PROCESS | 21547 | |13;stanford-crypto-sha256-iterative;69;70;70;68;70;68;69;69;70;68 08:43:04 INFO - PROCESS | 21547 | __end_tp_report 08:43:04 INFO - PROCESS | 21547 | __start_cc_report 08:43:04 INFO - PROCESS | 21547 | _x_x_mozilla_cycle_collect,2035 08:43:04 INFO - PROCESS | 21547 | __end_cc_report 08:43:04 INFO - PROCESS | 21547 | __startTimestamp1472139784084__endTimestamp 08:43:04 INFO - PROCESS | 21547 | 08:43:04 INFO - PROCESS | 21547 | ------- Summary: start ------- 08:43:04 INFO - PROCESS | 21547 | Number of tests: 14 08:43:04 INFO - PROCESS | 21547 | 08:43:04 INFO - PROCESS | 21547 | [#0] ai-astar Cycles:10 Average:115.90 Median:115.00 stddev:4.65 (4.0%) stddev-sans-first:4.88 08:43:04 INFO - PROCESS | 21547 | Values: 114.0 114.0 129.0 115.0 115.0 115.0 113.0 115.0 114.0 115.0 08:43:04 INFO - PROCESS | 21547 | 08:43:04 INFO - PROCESS | 21547 | [#1] audio-beat-detection Cycles:10 Average:149.10 Median:150.50 stddev:28.29 (18.8%) stddev-sans-first:30.00 08:43:04 INFO - PROCESS | 21547 | Values: 151.0 120.0 150.0 202.0 127.0 148.0 152.0 126.0 192.0 123.0 08:43:04 INFO - PROCESS | 21547 | 08:43:04 INFO - PROCESS | 21547 | [#2] audio-dft Cycles:10 Average:162.70 Median:162.00 stddev:2.54 (1.6%) stddev-sans-first:2.68 08:43:04 INFO - PROCESS | 21547 | Values: 162.0 162.0 164.0 161.0 162.0 169.0 164.0 162.0 161.0 160.0 08:43:04 INFO - PROCESS | 21547 | 08:43:04 INFO - PROCESS | 21547 | [#3] audio-fft Cycles:10 Average:95.20 Median:76.50 stddev:40.18 (52.5%) stddev-sans-first:41.95 08:43:04 INFO - PROCESS | 21547 | Values: 75.0 77.0 76.0 180.0 77.0 77.0 75.0 77.0 162.0 76.0 08:43:04 INFO - PROCESS | 21547 | 08:43:04 INFO - PROCESS | 21547 | [#4] audio-oscillator Cycles:10 Average:103.10 Median:86.00 stddev:26.92 (31.3%) stddev-sans-first:27.99 08:43:04 INFO - PROCESS | 21547 | Values: 88.0 87.0 142.0 86.0 86.0 87.0 146.0 85.0 86.0 138.0 08:43:04 INFO - PROCESS | 21547 | 08:43:04 INFO - PROCESS | 21547 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.50 08:43:04 INFO - PROCESS | 21547 | Values: 118.0 116.0 117.0 117.0 117.0 117.0 116.0 116.0 117.0 117.0 08:43:04 INFO - PROCESS | 21547 | 08:43:04 INFO - PROCESS | 21547 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.84 (0.6%) stddev-sans-first:0.67 08:43:04 INFO - PROCESS | 21547 | Values: 148.0 145.0 146.0 147.0 147.0 146.0 146.0 146.0 147.0 146.0 08:43:04 INFO - PROCESS | 21547 | 08:43:04 INFO - PROCESS | 21547 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 08:43:04 INFO - PROCESS | 21547 | Values: 95.0 94.0 94.0 94.0 95.0 94.0 95.0 95.0 95.0 95.0 08:43:04 INFO - PROCESS | 21547 | 08:43:04 INFO - PROCESS | 21547 | [#8] json-parse-financial Cycles:10 Average:65.60 Median:66.00 stddev:0.52 (0.8%) stddev-sans-first:0.50 08:43:04 INFO - PROCESS | 21547 | Values: 65.0 65.0 65.0 66.0 65.0 66.0 66.0 66.0 66.0 66.0 08:43:04 INFO - PROCESS | 21547 | 08:43:04 INFO - PROCESS | 21547 | [#9] json-stringify-tinderbox Cycles:10 Average:65.60 Median:65.50 stddev:0.84 (1.3%) stddev-sans-first:0.87 08:43:04 INFO - PROCESS | 21547 | Values: 65.0 65.0 65.0 66.0 67.0 65.0 65.0 65.0 67.0 66.0 08:43:04 INFO - PROCESS | 21547 | 08:43:04 INFO - PROCESS | 21547 | [#10] stanford-crypto-aes Cycles:10 Average:86.40 Median:87.00 stddev:4.70 (5.4%) stddev-sans-first:4.95 08:43:04 INFO - PROCESS | 21547 | Values: 85.0 88.0 90.0 83.0 96.0 90.0 86.0 81.0 81.0 84.0 08:43:04 INFO - PROCESS | 21547 | 08:43:04 INFO - PROCESS | 21547 | [#11] stanford-crypto-ccm Cycles:10 Average:139.40 Median:138.00 stddev:11.97 (8.7%) stddev-sans-first:12.47 08:43:04 INFO - PROCESS | 21547 | Values: 133.0 141.0 130.0 131.0 140.0 130.0 136.0 149.0 169.0 135.0 08:43:04 INFO - PROCESS | 21547 | 08:43:04 INFO - PROCESS | 21547 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.10 Median:172.50 stddev:2.69 (1.6%) stddev-sans-first:2.76 08:43:04 INFO - PROCESS | 21547 | Values: 174.0 177.0 175.0 170.0 174.0 171.0 170.0 170.0 171.0 169.0 08:43:04 INFO - PROCESS | 21547 | 08:43:04 INFO - PROCESS | 21547 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.10 Median:69.50 stddev:0.88 (1.3%) stddev-sans-first:0.93 08:43:04 INFO - PROCESS | 21547 | Values: 69.0 70.0 70.0 68.0 70.0 68.0 69.0 69.0 70.0 68.0 08:43:04 INFO - PROCESS | 21547 | -------- Summary: end -------- 08:43:04 INFO - PROCESS | 21547 | 08:43:05 INFO - TEST-INFO | 21547: exit 0 08:43:05 INFO - TEST-OK | kraken | took 64517ms 08:43:05 INFO - SUITE-END | took 1185s 08:43:05 INFO - Completed test suite (00:19:46) 08:43:05 INFO - javascript benchmark 08:43:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2574.961375579366, 2588.948221035578, 2590.676165479316, 2605.1663467690337, 2633.0915834037264, 4507.6168525675275, 4600.102979918917, 4620.168369693454, 4699.083678682654, 4748.335233067373, 4543.636509079274, 4598.655100867431, 4622.630189584834, 4631.050634619904, 4684.086603112394, 4153.937690934638, 4160.979195104035, 4214.536400995888, 4288.656907447396, 4398.516163222043, 4338.392625032498, 4339.566043395666, 4370.235208838457, 4370.825166993316, 4393.1872603568445, 4157.646600039, 4186.727862688916, 4198.391233271159, 4270.829166833323, 4274.29474136767, 4209.7895105244925, 4209.957900421018, 4217.894552636178, 4261.552536983634, 4271.188474189894, 4181.832726690929, 4201.537830838605, 4249.383839343278, 4250.256205164084, 4255.0426154115385, 4601.723896566216, 4642.048380082075, 4642.117997580449, 4647.372604698357, 4686.835960741358, 4849.005953779467, 4923.064617722621, 4926.531979461981, 4937.925931111036, 4949.925751113737, 4923.827666031708, 4932.580730637864, 4933.333999910002, 4939.086269040239, 5009.7495125243595, 4503.954960450354, 4598.79305431253, 4620.722756634613, 4631.930521042187, 4632.5830675239395, 4915.877103072452, 4956.033573453215, 4960.503949605083, 4972.378452693413, 5035.84892453227, 4761.40482439695, 4786.8085276588545, 4792.808287668454, 4794.304825800239, 4850.151223535938, 4740.905181896343, 4852.466228714909, 4860.246661767432, 4865.878353041131, 4925.630577706686, 4835.734034628129, 4881.4630390657, 4884.169691152512, 4884.291777692215, 4968.8509344719, 4896.534829191292, 4903.607711383081, 4905.288733133676, 4907.7064147031515, 4970.726610036482, 4094.3449048152747, 4230.619244267969, 4232.386303985905, 4243.724157929724, 4284.464441944757, 3614.963850361515, 3679.2273622539033, 3704.944425833615, 3752.75607085544, 3798.0, 4253.106847561985, 4262.552431994658, 4272.359146128106, 4278.7004909656025, 4332.0, 4995.075910956485, 4996.275540046673, 4997.425296090996, 5003.24951257307, 5043.445221025684, 4178.8537401190815, 4180.874573762792, 4199.601037901394, 4211.473565804275, 4262.65898728101, 4412.3160910059, 4432.113577284492, 4436.401085853433, 4437.667174961891, 4491.595756381876, 4619.676622636383, 4627.30590411441, 4631.606313463393, 4649.465311489222, 4684.0, 4774.30772537987, 4879.463259041431, 4939.580135688363, 4939.75301234944, 4999.075171093359, 4642.419697537808, 4646.790894409827, 4652.860414187579, 4668.813247470063, 4714.292856071616, 4845.442774081026, 4851.733154676385, 4853.611711063177, 4860.3195552621955, 4919.704817710949, 4733.171694953438, 4828.66199366041, 4835.371401717754, 4866.391701037371, 4890.437599675941, 4798.016406636701, 4804.615630749601, 4806.375171227718, 4831.710097394168, 4862.294967229803, 4790.329353890388, 4790.760461976957, 4794.808207671654, 4795.136875362328, 4844.249141383091, 4634.0, 4737.786799594095, 4760.428748550196, 4784.976075119741, 4796.136695394863, 4863.416390033219, 4907.043126590281, 4914.7542622867995, 4950.133726597759, 4980.103581355391, 4773.403324584427, 4789.521047895182, 4792.113459010095, 4793.640476964172, 4844.0554091951735], "value": 4532.249714606084, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [563.6026601246119, 563.9323281206255, 569.4903061759724, 578.777170789246, 586.1852025684296, 28007.719922800767, 38683.41974870376, 39801.80099099504, 39881.40177897334, 43124.568754312444, 39450.80274598623, 39514.0, 39794.80102599483, 39831.80084099583, 39901.800490997506, 7267.963660181718, 7543.4719569630015, 7668.463207575472, 7703.730369437071, 7706.576138312391, 7167.0682811234465, 7418.072740907387, 7418.332350088491, 9711.320207585472, 9902.356346837469, 10000.04999525044, 10028.849567256497, 10048.397096174216, 10050.296479246455, 10055.19558435327, 9876.901230987705, 9951.502424878727, 9962.900370996269, 9966.601335946554, 9970.25223108266, 9515.333926625139, 9605.663801766905, 9609.519524023772, 9611.807763844685, 9613.663521776703, 37389.25221495582, 37682.24635507302, 37700.81149594262, 37714.24571508555, 37715.62284377149, 3056.6484854241826, 3292.8024318540965, 3378.425667636483, 3383.712384447325, 3473.444248920186, 28430.0, 28811.56782648262, 28884.422311553863, 28892.0, 30496.237594060105, 3430.588329400463, 3441.741869359808, 3531.5408996830247, 3539.50446937429, 3566.8038257895805, 240322.0, 241242.22608834776, 241607.0, 242279.0, 242618.0, 30352.54471182934, 50115.74942125266, 50475.24287135696, 50503.0, 50513.74743126261, 30771.846140769154, 32459.837700811346, 32467.35065298728, 32480.0, 32497.187570310933, 12946.029047821452, 13048.673783155307, 13069.215847049207, 13094.934525327502, 13098.869011309765, 10812.405317707444, 10884.129269658408, 10884.891151088388, 10887.673369798918, 10891.128709703205, 7148.0, 7481.588512631857, 7647.120581133129, 7716.691332346643, 7825.804354891174, 3044.1476386611785, 3088.351446196324, 3103.8137711736917, 3108.7202151805996, 3119.2201949512623, 839.6347588798892, 896.5830888636815, 921.3872774604947, 934.1872570863256, 961.293449314753, 25988.74011259901, 28287.43425131486, 28320.73434125265, 28446.715532844406, 28676.569851452245, 930.6603089872148, 958.6069711418425, 972.8832540095234, 979.6669132494986, 981.4503877828439, 14523.78214326786, 14892.180930048735, 15004.474843380647, 15198.772018419733, 15199.316030778642, 365303.0, 366802.0, 368275.0, 368323.0, 368436.0, 47866.52133478621, 48539.271910921365, 48629.270560941615, 48647.75676121597, 48675.0, 1085.9294145880492, 1150.3787954504473, 1167.9532818687157, 1182.4560702076797, 1198.9280643161437, 26509.33726656849, 28784.42431151407, 29092.418151637274, 29351.0, 29667.258318541346, 39159.0, 45023.324650130926, 46107.0, 46110.0, 51270.48729512657, 357033.0, 361849.0, 362457.0, 362682.0, 363008.0, 24190.637140442555, 25150.11974580954, 25185.370365741004, 37965.43051854169, 38555.22889542137, 39019.0, 39025.804870975466, 39412.51162279158, 39540.40689389604, 39644.801775990934, 33316.83341583276, 33323.666763332054, 33780.83109584436, 33817.49273760847, 34322.31355372829, 33235.50146747752, 33943.66056339405, 34020.14949626279, 34799.30401391907, 35364.82317588499, 33315.0, 34088.82955585305, 34213.657863421045, 34507.34150889598, 34522.65477345194, 30158.69841301559, 30847.2288192788, 31295.687043129277, 31433.0, 31475.84262078675, 24320.058945649467, 24384.146554870495, 24570.63144052805, 24756.38109047216, 24908.12821551237], "value": 16688.329932865945, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [340.3035866206956, 361.8715356048604, 364.58437381385215, 369.9815009249537, 374.68713624123853, 12511.374431278433, 16034.51896443107, 16037.679246415079, 16326.673466530692, 17525.21136548855, 16285.430009949654, 16599.66800663986, 16965.49103526893, 17071.146442677848, 17080.914595427035, 4916.016796640668, 4925.0, 5005.724685142316, 5041.143005689023, 5044.419891712463, 3690.5940346561856, 3820.789856557888, 4987.975060124712, 5070.797168113271, 5082.110630639623, 3883.572806991243, 3891.6497515223623, 4417.779111044451, 5748.683822389767, 5772.393898640646, 5864.472197502203, 5867.325257595346, 5871.1193321001765, 5889.79385721502, 5900.350961394243, 5065.442801291855, 5235.1623740201385, 5299.152135658276, 5306.495882891158, 5311.0, 18736.0, 19182.904085479622, 19228.134733937008, 20545.0, 20761.58476830455, 2069.503319203395, 2350.8942097605477, 2388.868612226327, 2415.842970206931, 2481.6153496208117, 8931.776705582348, 9627.277954153467, 9860.161886239679, 12217.877821221762, 13038.282894440801, 1707.4621494229277, 1762.2510433065895, 1768.124778234769, 1771.5128339706555, 1797.128392729525, 66501.66749166271, 67862.0, 68764.3123568763, 69352.3064769356, 69555.0, 10009.0, 10059.742532183476, 10229.74425639365, 10477.31897426665, 10541.156707463384, 14031.087979281314, 14060.226687532284, 14065.578032659037, 14082.225477598831, 14107.71784564303, 6945.861082778417, 7139.500234983501, 7185.0, 7372.741954031583, 7390.076240469942, 6662.900056499157, 6707.579134641271, 6880.931190688129, 6885.208201056842, 6888.965555172293, 4289.613934745826, 4361.651067914623, 4387.912241755211, 4476.731396116244, 4513.977430112894, 1766.3641089207874, 1793.6681713882974, 1802.180008096313, 1815.3646223821556, 1863.7297591849106, 823.6828820903876, 830.2527725047505, 835.5905606252892, 864.0754392799644, 901.6213190460022, 16556.523130142807, 16783.496495105166, 16814.243359048873, 17311.0, 17603.82396176022, 872.6771094694876, 878.2578720980761, 895.3598177303129, 914.9542522873962, 928.0302084321764, 9038.63845446188, 9622.951885240529, 9680.225581953428, 9686.128248457673, 9742.0, 366388.0, 366756.0, 368634.0, 372626.0, 373905.0, 72730.27269727341, 75703.62148189223, 76059.23940760632, 76832.0, 78261.0, 874.0691163910415, 895.5477483870603, 918.9218916392048, 919.0120620333169, 920.7053742802373, 15029.924850375679, 15065.623359415664, 15379.538613841603, 15643.687126257639, 15767.0, 35752.284954301285, 35897.28205435929, 36392.0, 36665.0, 37301.4404783923, 49955.25067124069, 50154.49845501498, 50424.0, 52853.20720189277, 53597.464025359244, 7433.70265189408, 7680.231976802275, 7713.151553329241, 7844.607769611611, 8032.0, 8626.11849578495, 11127.276727012719, 11357.943210283896, 11536.192466527598, 11954.940225298818, 9017.098290171192, 9216.907830921606, 9292.58183381736, 9527.47598882068, 9579.281553883347, 9901.801963960825, 10104.747381315527, 10105.848412273675, 10375.325603835727, 10553.63062292816, 9384.95307523458, 9851.310408271353, 9941.353812002197, 10173.389596624227, 10214.131798796889, 7423.294786995227, 7599.848003040019, 7746.961265193638, 7804.180561041009, 7868.72459463916, 4554.476235232991, 4653.790579423866, 9430.151286384258, 9476.768020157335, 9989.850152247576], "value": 8074.601418578136, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1242.4533205389635, 1333.8732820382063, 1392.0673148990174, 1420.5525259543242, 1656.3788579282768, 7405.5186412883195, 7796.493227940187, 7798.298153166221, 7979.561124138185, 7982.121966583672, 7820.530768153914, 7914.129445760962, 7917.287444130027, 7939.523628582289, 7947.364210863131, 1840.9631807363844, 2090.6097445198925, 2174.293354659738, 2199.2082850173924, 2201.636729939558, 2160.621891169047, 2160.924367647133, 2161.2975782870553, 2163.3185546552863, 2183.443221978401, 2120.6076875777953, 2143.0142134618095, 2148.054855863415, 2150.849440539163, 2184.388371256051, 2036.4603380104284, 2068.917243310266, 2075.0247383729625, 2075.2632815350635, 2103.926362577318, 2190.233418303597, 2207.1061220205843, 2210.668399740036, 2212.093041852833, 2213.2917466410754, 7752.147263800977, 7788.260115289038, 7797.7660670179985, 7808.843823123562, 7823.374130069581, 4427.800748966304, 4573.245414506636, 4574.885627859297, 4579.381783459224, 4591.540845915415, 2883.8413887236193, 2913.6940621234676, 3037.58992536007, 3039.1794215561677, 3044.101989912981, 954.4941181173989, 954.6754103604808, 964.71058682395, 965.9227261819037, 978.6770365779275, 10757.193210509244, 10860.402677852637, 10877.67366978992, 10892.128629709605, 10905.454727263685, 3968.6229808168755, 4091.57038510958, 4102.466679331667, 4104.712670113123, 4316.115196384796, 8172.346212303001, 8253.504789712517, 8277.58612069394, 8284.171582841787, 8304.667813287522, 4333.978330108329, 4339.956600434019, 4340.435743353344, 4342.088161486124, 4346.152500262482, 3585.551806024247, 3961.980190099031, 3964.702647301406, 4070.4911886014247, 4140.834366625301, 3385.170633194883, 3389.6271410144864, 3451.8101504416995, 3496.0, 3501.807400592992, 1031.4327120083924, 1037.5849660136007, 1042.4058286776617, 1049.6378749331468, 1057.836035414512, 775.1047540091204, 793.8610743119931, 827.3505298340893, 833.2667252817482, 848.7411339541499, 5203.898945693287, 5268.394134674485, 5322.281491998608, 5355.0360935031285, 5548.056830338852, 424.6114804953495, 429.42671533503125, 435.1101996417334, 435.22964353094847, 436.89514516515806, 3517.36687396266, 3541.5041894134843, 3586.7309951753723, 3596.3346780845627, 3770.377887648562, 9692.75768105803, 10081.042300981395, 10124.949375253223, 10147.797044059078, 10148.898511014942, 10024.599016039278, 10025.448600326907, 10065.547050382751, 10076.193904487624, 10086.142677872464, 7288.635568221568, 7386.0, 7403.185649578542, 7511.211322811136, 7572.167061623217, 5215.217717342429, 5241.266222728897, 5243.606729495227, 5244.292020577173, 5341.145416733304, 8942.46345219289, 8957.507337096262, 8958.148975847284, 8985.146411090936, 9074.773130671521, 8759.080296569024, 8943.508107054175, 8967.192952634294, 9038.186563209343, 9043.0, 6056.121862329849, 6114.755409783559, 6745.52781305304, 6783.491238157059, 6925.272846351262, 7408.851822963618, 7734.5359278443475, 7744.2642948919765, 7759.456838021284, 7763.805904852424, 6612.437942774918, 6856.554323968926, 6867.416269616939, 6895.5173137881875, 6953.687084081127, 6754.493412994143, 6831.077804496329, 6865.450763938773, 6888.965555172192, 6898.965505172643, 6334.923063079195, 6348.079528468438, 6409.327020662763, 6424.229092508929, 6431.710573024318, 4585.0, 4629.1436084324505, 4651.767411629473, 4793.0413917216, 4911.091448082117, 4654.16225079489, 4658.720476771405, 4728.219843725747, 4781.258904869751, 4808.951910480991], "value": 4035.549008493439, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [293.32535169111054, 298.517893601833, 301.35209300005, 303.59924899133136, 304.83843562911636, 4597.9080418391695, 4715.066822602734, 4723.504032076634, 4744.786484608192, 4782.995570930105, 4525.954740452603, 4602.677812553123, 4634.281686338614, 4647.674662773607, 4668.159731248374, 3732.1789206374556, 3751.4935483709623, 3754.7559408638417, 3754.9910797723223, 3759.4172903200047, 3583.5341405617232, 3782.5460944686674, 3789.431585262219, 3791.772493650376, 3811.942820857689, 3532.364174448598, 3730.694257010052, 3733.4959780429567, 3742.101895545063, 3749.3626083565723, 3725.5343082114737, 3736.0, 3739.663430291273, 3742.5321834770652, 3753.680937120348, 3308.586426696663, 3310.543360921187, 3323.8670453181844, 3324.817135057571, 3331.850066747002, 4516.9159401743345, 4601.148787474328, 4616.8614941551805, 4647.930281045787, 4668.323093151508, 4212.178625168093, 4220.767857767822, 4229.2598795210715, 4231.936520952188, 4248.277792775236, 4908.920037591724, 4926.507349265081, 4927.6550641455115, 4962.851114466572, 4970.82602108928, 3483.2336885885065, 3585.15748799032, 3600.7119430445764, 3610.3681855675413, 3624.4563315502887, 5167.224916262553, 5175.948240517584, 5177.0, 5202.297689811865, 5226.294450249244, 3722.8510859565313, 3722.8883133506038, 3728.2729867675544, 3728.496652951817, 3740.588535261119, 3781.636477201749, 3797.2974999625158, 3815.4276858471453, 3821.503204583442, 3823.5338206856422, 4179.665626749853, 4264.31770916658, 4280.785960701953, 4309.870703878889, 4317.11499142675, 4919.2129259318335, 4943.258511223274, 4949.851504454872, 4953.455119936804, 4955.1823949048, 1244.9190802597802, 1249.3877999780043, 1273.5860845225338, 1274.9107562470538, 1283.2483659804486, 898.7573355194061, 928.823523530527, 932.8181004704153, 934.3973137326523, 937.301710225886, 4408.118376324684, 4415.448068991376, 4418.580234877746, 4424.889377765518, 4434.401355816924, 5157.0975079361715, 5167.457416971239, 5169.095408303532, 5171.896562068738, 5173.922391164136, 4294.291441912112, 4326.9663258268565, 4356.346548017759, 4357.4988876279, 4424.84513042042, 2356.7761062699014, 2410.5781488239486, 2411.8794060296914, 2414.5774489464275, 2418.709754829432, 4278.978605107017, 4290.8843700637435, 4309.547497512779, 4343.847965321262, 4351.607485604576, 4376.540463251376, 4585.518520555293, 4622.237330840374, 4623.722576645345, 4648.883777905579, 4287.549807270254, 4289.0, 4290.313549832012, 4320.287152619782, 4335.349697545394, 4465.910681786281, 4480.260756975063, 4489.416375871116, 4490.932636010397, 4524.773761311987, 4267.67992400565, 4395.626371758309, 4429.579189976947, 4433.423654924839, 4434.756088415168, 4290.485141783006, 4297.312430011183, 4300.333448315516, 4312.611864932172, 4312.741235525878, 3409.7101746351836, 3417.1115509968085, 3422.2279953237958, 3426.417509023422, 3450.706689931384, 4312.5903039211225, 4525.275955847049, 4540.636749060001, 4550.590446859798, 4566.45202575693, 4376.0, 4377.6497880170145, 4387.36383224437, 4406.911861762683, 4407.11857628482, 4311.288637374798, 4328.458942632171, 4375.309184851357, 4385.386045953633, 4407.933880991852, 4308.74147551148, 4320.243957307396, 4341.392205091227, 4607.009492958896, 4668.229742092517, 4965.975170124127, 4980.078685443204, 4995.200767877122, 4996.7001979881325, 5005.7997680092385, 4854.0, 4861.27080937848, 4863.7324947128245, 4867.58625516835, 4870.4155501340065], "value": 3631.7517121706933, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [649.2760571962262, 657.4411750012487, 660.8116686744276, 708.4317266286987, 736.5543845973184, 12965.546205882796, 14166.575002749934, 14191.503297384594, 14251.216183109938, 14363.138211707292, 13113.67215819605, 13241.735165296688, 13248.0, 13259.071864969455, 13347.332633368342, 607.8358843112356, 722.5556282886026, 728.2717282717283, 737.1890919987998, 742.8699977503942, 761.8590560746279, 763.3664058831157, 764.2701220334595, 764.4381379685926, 765.1927216786288, 808.7412028150994, 810.5298926622545, 810.8864758933754, 811.1928631012122, 811.5860910935436, 642.5791106825037, 776.9922300776976, 785.2932360875258, 791.8891355210275, 802.3220378779922, 584.6930361560172, 584.988300233993, 585.1865906390121, 585.8271809816072, 586.085706298172, 13195.670108247275, 13199.40602672882, 13206.33968301581, 13215.537456188988, 13231.470741170342, 12543.698935380045, 12602.68493287666, 13020.479180832755, 13021.41403636829, 13489.86510134896, 11634.883651163465, 11925.582604608884, 11945.40272986356, 12064.215825971283, 12121.696957576043, 4071.3282308419075, 4099.836006559734, 4122.793860307002, 4146.3158578834455, 4171.478565179353, 61098.69450652763, 61128.0, 61170.388296116915, 61190.69404652993, 61384.38615613876, 9473.976295239212, 9589.856152157723, 9981.80036399268, 9992.300538962203, 10076.69769906904, 19314.903425482782, 19352.4194274172, 19370.612587748165, 19378.321758738377, 19454.90272548628, 6701.061851340816, 6777.898331525031, 6804.95374455892, 6900.413464855443, 7015.403690686348, 3615.349237137288, 3657.305112028706, 3710.888673339804, 3715.8885233442497, 3833.8274777635074, 2765.3363192833576, 2869.0818937939657, 2873.6551613806478, 3098.6746391629003, 3282.3763484937786, 560.2912315920282, 566.1988286574533, 567.4155619711704, 569.3964397738328, 583.4340689531148, 542.7096503370677, 586.4868240289746, 607.1348328631682, 628.4515350052465, 632.2981490545491, 8554.528430877206, 8724.214820666044, 8861.98087219978, 8974.685885993958, 9037.141471560191, 499.88002879308704, 548.8243761996123, 560.4479587606205, 575.8963386590453, 587.2336600735995, 4267.1679022590915, 4342.934855977162, 4380.6933514653665, 4385.3641222022625, 4438.400815889813, 96182.0, 100925.49537252267, 102389.0, 103375.48312258541, 106314.0, 85883.0, 87923.0, 88391.0, 88825.0, 89323.0, 70155.2984470159, 75978.6201068991, 78164.0, 79921.60039199766, 81463.0, 8202.475338460012, 8300.626471808904, 8413.831723365622, 8750.47497150173, 8794.824103518022, 45933.0, 46821.765891170326, 47819.76090119666, 48087.27869082036, 48271.75864120657, 63538.68230658817, 63830.0, 69405.0, 70832.29167708257, 71639.0, 9643.324967252225, 9749.951250243703, 10061.446620435947, 10369.377837329785, 10803.135749139892, 11682.47428865686, 11827.763444730885, 11998.100142489173, 12139.453724582238, 12198.634040978784, 10622.946885265525, 10814.783704325711, 11206.327620342805, 11228.66314010581, 11310.264832785842, 9854.852177217492, 9899.851502227617, 9919.206463483048, 9950.10449059588, 10398.844017339898, 10791.352518848895, 11090.611828585961, 11246.04408625276, 11395.316281023164, 11572.132090093108, 9299.0, 9587.520623968634, 9640.228781697588, 9804.594442703738, 9950.45272510019, 8703.95648021756, 8787.209151176425, 9665.661701840401, 10000.199984001409, 10124.797504050026], "value": 6615.9047299186805, "unit": "score"}], "name": "dromaeo_css", "value": 6243.351967483918, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 129.0, 115.0, 115.0, 115.0, 113.0, 115.0, 114.0, 115.0], "value": 115.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 120.0, 150.0, 202.0, 127.0, 148.0, 152.0, 126.0, 192.0, 123.0], "value": 149.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 164.0, 161.0, 162.0, 169.0, 164.0, 162.0, 161.0, 160.0], "value": 162.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 76.0, 180.0, 77.0, 77.0, 75.0, 77.0, 162.0, 76.0], "value": 95.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 142.0, 86.0, 86.0, 87.0, 146.0, 85.0, 86.0, 138.0], "value": 103.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 145.0, 146.0, 147.0, 147.0, 146.0, 146.0, 146.0, 147.0, 146.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 94.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 66.0, 65.0, 66.0, 66.0, 66.0, 66.0, 66.0], "value": 65.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 66.0, 67.0, 65.0, 65.0, 65.0, 67.0, 66.0], "value": 65.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 88.0, 90.0, 83.0, 96.0, 90.0, 86.0, 81.0, 81.0, 84.0], "value": 86.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 141.0, 130.0, 131.0, 140.0, 130.0, 136.0, 149.0, 169.0, 135.0], "value": 139.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 177.0, 175.0, 170.0, 174.0, 171.0, 170.0, 170.0, 171.0, 169.0], "value": 172.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 70.0, 68.0, 70.0, 68.0, 69.0, 69.0, 70.0, 68.0], "value": 69.1, "unit": "score"}], "name": "kraken", "value": 1581.9999999999998, "alertThreshold": 2.0}]} 08:43:05 INFO - Return code: 0 08:43:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:43:05 INFO - # TBPL SUCCESS # 08:43:05 INFO - Running post-action listener: _resource_record_post_action 08:43:05 INFO - [mozharness: 2016-08-25 15:43:05.876582Z] Finished run-tests step (success) 08:43:05 INFO - Running post-run listener: _resource_record_post_run 08:43:05 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 8192; Write bytes: 405884928; Read time: 20; Write time: 227820 08:43:05 INFO - TinderboxPrint: CPU usage
13.1% 08:43:05 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 20 08:43:05 INFO - TinderboxPrint: I/O write bytes / time
405,884,928 / 227,820 08:43:05 INFO - TinderboxPrint: CPU idle
8,334.4 (86.9%) 08:43:05 INFO - TinderboxPrint: CPU user
1,207.1 (12.6%) 08:43:05 INFO - TinderboxPrint: Swap in / out
0 / 0 08:43:05 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 114216960; Read time: 0; Write time: 84208 08:43:05 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 291667968; Read time: 0; Write time: 143612 08:43:06 INFO - Running post-run listener: _upload_blobber_files 08:43:06 INFO - Blob upload gear active. 08:43:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:43:06 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 08:43:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:43:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:43:06 INFO - (blobuploader) - INFO - Open directory for files ... 08:43:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:43:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:43:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:43:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:43:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:43:07 INFO - (blobuploader) - INFO - Done attempting. 08:43:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:43:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:43:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:43:13 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:43:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:43:13 INFO - (blobuploader) - INFO - Done attempting. 08:43:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:43:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:43:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:43:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:43:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:43:14 INFO - (blobuploader) - INFO - Done attempting. 08:43:14 INFO - (blobuploader) - INFO - Iteration through files over. 08:43:14 INFO - Return code: 0 08:43:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:43:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:43:14 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b4b7b7ba2c18cd0e3bc138b7c186bb12cb198abc0b400ce448eecff968b7a0698a6fa7a71b872384a7b24a37732eb19622b3cc8b1ae8392030dd1769948b58ff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/932536b54e652dd743702134c11efc9b3452454888d3645c318c31207b18020bc66edb5929e16fb86f2c0930d1b2640d207cb629d3f8a86524e06e3bef4fac66", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1d290747f95b90c228cb7c7f7c588c752a6942d2ed1733aa51c24488fa2d59d54bafe900ad4309a7a781b18b8c72b9aea6781d1a12bbb86305b3251cc1853368"} 08:43:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:43:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:43:14 INFO - Contents: 08:43:14 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b4b7b7ba2c18cd0e3bc138b7c186bb12cb198abc0b400ce448eecff968b7a0698a6fa7a71b872384a7b24a37732eb19622b3cc8b1ae8392030dd1769948b58ff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/932536b54e652dd743702134c11efc9b3452454888d3645c318c31207b18020bc66edb5929e16fb86f2c0930d1b2640d207cb629d3f8a86524e06e3bef4fac66", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1d290747f95b90c228cb7c7f7c588c752a6942d2ed1733aa51c24488fa2d59d54bafe900ad4309a7a781b18b8c72b9aea6781d1a12bbb86305b3251cc1853368"} 08:43:14 INFO - Running post-run listener: copy_logs_to_upload_dir 08:43:14 INFO - Copying logs to upload dir... 08:43:14 INFO - mkdir: /builds/slave/test/build/upload/logs 08:43:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.587294 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-08-25 08:43:13.898065) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-25 08:43:13.901606) ========= 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=00204705a9daa57ed339a427000001b9-1472138533.492312-8059851 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b4b7b7ba2c18cd0e3bc138b7c186bb12cb198abc0b400ce448eecff968b7a0698a6fa7a71b872384a7b24a37732eb19622b3cc8b1ae8392030dd1769948b58ff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/932536b54e652dd743702134c11efc9b3452454888d3645c318c31207b18020bc66edb5929e16fb86f2c0930d1b2640d207cb629d3f8a86524e06e3bef4fac66", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1d290747f95b90c228cb7c7f7c588c752a6942d2ed1733aa51c24488fa2d59d54bafe900ad4309a7a781b18b8c72b9aea6781d1a12bbb86305b3251cc1853368"} build_url:https://queue.taskcluster.net/v1/task/AmlpMaaKSjSbDlMngjkkHQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011291 build_url: 'https://queue.taskcluster.net/v1/task/AmlpMaaKSjSbDlMngjkkHQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b4b7b7ba2c18cd0e3bc138b7c186bb12cb198abc0b400ce448eecff968b7a0698a6fa7a71b872384a7b24a37732eb19622b3cc8b1ae8392030dd1769948b58ff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/932536b54e652dd743702134c11efc9b3452454888d3645c318c31207b18020bc66edb5929e16fb86f2c0930d1b2640d207cb629d3f8a86524e06e3bef4fac66", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1d290747f95b90c228cb7c7f7c588c752a6942d2ed1733aa51c24488fa2d59d54bafe900ad4309a7a781b18b8c72b9aea6781d1a12bbb86305b3251cc1853368"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-25 08:43:13.926989) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 08:43:13.927328) ========= 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=00204705a9daa57ed339a427000001b9-1472138533.492312-8059851 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004512 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 08:43:14.012093) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-25 08:43:14.012406) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-25 08:43:14.012721) ========= ========= Total master_lag: 0.18 =========