builder: autoland_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-016 starttime: 1470349496.73 results: success (0) buildid: 20160804123001 builduid: 82decb124fac48deb5b4e79ab6adfe89 revision: 4939f5d5c16c957ae0da6d509a26482983fc894a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-04 15:24:56.729534) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-04 15:24:56.730088) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-04 15:24:56.730563) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-04 15:24:56.745806) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 15:24:56.746128) ========= 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-1470348141.91211-1355357942 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-04 15:24:56-- 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% 220M=0s 2016-08-04 15:24:57 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.089760 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 15:24:56.854703) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 15:24:56.855036) ========= 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-1470348141.91211-1355357942 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019959 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 15:24:56.914060) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 15:24:56.914417) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 4939f5d5c16c957ae0da6d509a26482983fc894a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 4939f5d5c16c957ae0da6d509a26482983fc894a --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-1470348141.91211-1355357942 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-04 15:24:57,180 truncating revision to first 12 chars 2016-08-04 15:24:57,180 Setting DEBUG logging. 2016-08-04 15:24:57,180 attempt 1/10 2016-08-04 15:24:57,180 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/4939f5d5c16c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-04 15:24:57,476 unpacking tar archive at: autoland-4939f5d5c16c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.626725 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 15:24:57.555703) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-04 15:24:57.556020) ========= script_repo_revision: 4939f5d5c16c957ae0da6d509a26482983fc894a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-04 15:24:57.556464) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-04 15:24:57.556744) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-04 15:24:57.568503) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-08-04 15:24:57.568985) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=00204705a9daa57ed339a427000001b9-1470348141.91211-1355357942 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:24:57 INFO - MultiFileLogger online at 20160804 15:24:57 in /builds/slave/test 15:24:57 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 15:24:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:24:57 INFO - {'append_to_log': False, 15:24:57 INFO - 'base_work_dir': '/builds/slave/test', 15:24:57 INFO - 'blob_upload_branch': 'Autoland', 15:24:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:24:57 INFO - 'branch': 'Autoland', 15:24:57 INFO - 'buildbot_json_path': 'buildprops.json', 15:24:57 INFO - 'config_files': ('talos/linux_config.py',), 15:24:57 INFO - 'default_actions': ('clobber', 15:24:57 INFO - 'read-buildbot-config', 15:24:57 INFO - 'download-and-extract', 15:24:57 INFO - 'populate-webroot', 15:24:57 INFO - 'create-virtualenv', 15:24:57 INFO - 'install', 15:24:57 INFO - 'run-tests'), 15:24:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:24:57 INFO - 'download_minidump_stackwalk': True, 15:24:57 INFO - 'download_symbols': 'ondemand', 15:24:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:24:57 INFO - 'tooltool.py': '/tools/tooltool.py', 15:24:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:24:57 INFO - '/tools/misc-python/virtualenv.py')}, 15:24:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:24:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:24:57 INFO - 'installer_path': 'installer.exe', 15:24:57 INFO - 'log_level': 'info', 15:24:57 INFO - 'log_name': 'talos', 15:24:57 INFO - 'log_to_console': True, 15:24:57 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:24:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:24:57 INFO - 'opt_config_files': (), 15:24:57 INFO - 'pip_index': False, 15:24:57 INFO - 'sps_profile': False, 15:24:57 INFO - 'sps_profile_interval': 0, 15:24:57 INFO - 'suite': 'dromaeojs', 15:24:57 INFO - 'system_bits': '32', 15:24:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:24:57 INFO - 'title': 'talos-linux64-ix-016', 15:24:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:24:57 INFO - 'use_talos_json': True, 15:24:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:24:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:24:57 INFO - 'work_dir': 'build'} 15:24:57 INFO - [mozharness: 2016-08-04 22:24:57.922889Z] Running clobber step. 15:24:57 INFO - Running pre-action listener: _resource_record_pre_action 15:24:57 INFO - Running main action method: clobber 15:24:57 INFO - rmtree: /builds/slave/test/build 15:24:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:24:58 INFO - Running post-action listener: _resource_record_post_action 15:24:58 INFO - [mozharness: 2016-08-04 22:24:58.898950Z] Finished clobber step (success) 15:24:58 INFO - [mozharness: 2016-08-04 22:24:58.899049Z] Running read-buildbot-config step. 15:24:58 INFO - Running pre-action listener: _resource_record_pre_action 15:24:58 INFO - Running main action method: read_buildbot_config 15:24:58 INFO - Using buildbot properties: 15:24:58 INFO - { 15:24:58 INFO - "project": "", 15:24:58 INFO - "product": "firefox", 15:24:58 INFO - "script_repo_revision": "production", 15:24:58 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 15:24:58 INFO - "repository": "", 15:24:58 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland pgo talos dromaeojs", 15:24:58 INFO - "buildid": "20160804123001", 15:24:58 INFO - "pgo_build": "True", 15:24:58 INFO - "basedir": "/builds/slave/test", 15:24:58 INFO - "buildnumber": 84, 15:24:58 INFO - "slavename": "talos-linux64-ix-016", 15:24:58 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:24:58 INFO - "platform": "ubuntu64_hw", 15:24:58 INFO - "scheduler": "tests-autoland-linux64-pgo-talos", 15:24:58 INFO - "branch": "autoland", 15:24:58 INFO - "repo_path": "integration/autoland", 15:24:58 INFO - "revision": "4939f5d5c16c957ae0da6d509a26482983fc894a", 15:24:58 INFO - "stage_platform": "linux64-pgo", 15:24:58 INFO - "builduid": "82decb124fac48deb5b4e79ab6adfe89", 15:24:58 INFO - "slavebuilddir": "test" 15:24:58 INFO - } 15:24:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/d_jGmSKyQEah49Y-A2TC2g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 15:24:58 INFO - Running post-action listener: _resource_record_post_action 15:24:58 INFO - [mozharness: 2016-08-04 22:24:58.901497Z] Finished read-buildbot-config step (success) 15:24:58 INFO - [mozharness: 2016-08-04 22:24:58.901587Z] Running download-and-extract step. 15:24:58 INFO - Running pre-action listener: _resource_record_pre_action 15:24:58 INFO - Running main action method: download_and_extract 15:24:58 INFO - mkdir: /builds/slave/test/build/tests 15:24: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')]} 15:24:58 INFO - trying https://queue.taskcluster.net/v1/task/d_jGmSKyQEah49Y-A2TC2g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 15:24:58 INFO - Downloading https://queue.taskcluster.net/v1/task/d_jGmSKyQEah49Y-A2TC2g/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 15:24:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/d_jGmSKyQEah49Y-A2TC2g/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 15:24:59 INFO - Downloaded 1361 bytes. 15:24:59 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 15:24:59 INFO - Using the following test package requirements: 15:24:59 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 15:24:59 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:24:59 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:24:59 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:24:59 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:24:59 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:24:59 INFO - u'jsshell-linux-x86_64.zip'], 15:24:59 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:24:59 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:24:59 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 15:24:59 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:24:59 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:24:59 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:24:59 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:24:59 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:24:59 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:24:59 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:24:59 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:24:59 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:24:59 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')]} 15:24:59 INFO - trying https://queue.taskcluster.net/v1/task/d_jGmSKyQEah49Y-A2TC2g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 15:24:59 INFO - Downloading https://queue.taskcluster.net/v1/task/d_jGmSKyQEah49Y-A2TC2g/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 15:24:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/d_jGmSKyQEah49Y-A2TC2g/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 15:25:01 INFO - Downloaded 21820708 bytes. 15:25:01 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 15:25:05 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 15:25:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:25:05 INFO - trying https://queue.taskcluster.net/v1/task/d_jGmSKyQEah49Y-A2TC2g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 15:25:05 INFO - Downloading https://queue.taskcluster.net/v1/task/d_jGmSKyQEah49Y-A2TC2g/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 15:25:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/d_jGmSKyQEah49Y-A2TC2g/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 15:25:07 INFO - Downloaded 21820708 bytes. 15:25:07 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 15:25:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:25:11 INFO - trying https://queue.taskcluster.net/v1/task/d_jGmSKyQEah49Y-A2TC2g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 15:25:11 INFO - Downloading https://queue.taskcluster.net/v1/task/d_jGmSKyQEah49Y-A2TC2g/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 15:25:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/d_jGmSKyQEah49Y-A2TC2g/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 15:25:13 INFO - Downloaded 14413723 bytes. 15:25:13 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 15:25:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:25:13 INFO - trying https://queue.taskcluster.net/v1/task/d_jGmSKyQEah49Y-A2TC2g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 15:25:13 INFO - Downloading https://queue.taskcluster.net/v1/task/d_jGmSKyQEah49Y-A2TC2g/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 15:25:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/d_jGmSKyQEah49Y-A2TC2g/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 15:25:17 INFO - Downloaded 59342260 bytes. 15:25:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/d_jGmSKyQEah49Y-A2TC2g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 15:25:17 INFO - mkdir: /builds/slave/test/properties 15:25:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:25:17 INFO - Writing to file /builds/slave/test/properties/build_url 15:25:17 INFO - Contents: 15:25:17 INFO - build_url:https://queue.taskcluster.net/v1/task/d_jGmSKyQEah49Y-A2TC2g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 15:25:18 INFO - Running post-action listener: _resource_record_post_action 15:25:18 INFO - Running post-action listener: set_extra_try_arguments 15:25:18 INFO - [mozharness: 2016-08-04 22:25:18.361564Z] Finished download-and-extract step (success) 15:25:18 INFO - [mozharness: 2016-08-04 22:25:18.361789Z] Running populate-webroot step. 15:25:18 INFO - Running pre-action listener: _resource_record_pre_action 15:25:18 INFO - Running main action method: populate_webroot 15:25:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:25:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:25:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:25:18 INFO - '--tppagecycles', 15:25:18 INFO - '7'], 15:25:18 INFO - 'tests': ['tsvgm']}}, 15:25:18 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:25:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:25:18 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:25:18 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:25:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:25:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:25:18 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:25:18 INFO - 'talos_options': ['--disable-e10s'], 15:25:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:25:18 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:25:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:25:18 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:25:18 INFO - 'talos_options': ['--disable-e10s'], 15:25:18 INFO - 'tests': ['damp', 'tps']}, 15:25:18 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:25:18 INFO - 'tests': ['damp', 'tps']}, 15:25:18 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:25:18 INFO - 'tests': ['dromaeo_dom']}, 15:25:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:25:18 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:25:18 INFO - 'tests': ['basic_compositor_video']}, 15:25:18 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:25:18 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:25:18 INFO - 'tests': ['a11yr', 15:25:18 INFO - 'ts_paint', 15:25:18 INFO - 'tpaint', 15:25:18 INFO - 'sessionrestore', 15:25:18 INFO - 'sessionrestore_no_auto_restore', 15:25:18 INFO - 'tabpaint']}, 15:25:18 INFO - 'other-e10s': {'tests': ['a11yr', 15:25:18 INFO - 'ts_paint', 15:25:18 INFO - 'tpaint', 15:25:18 INFO - 'sessionrestore', 15:25:18 INFO - 'sessionrestore_no_auto_restore', 15:25:18 INFO - 'tabpaint']}, 15:25:18 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:25:18 INFO - 'ts_paint', 15:25:18 INFO - 'tpaint', 15:25:18 INFO - 'sessionrestore', 15:25:18 INFO - 'sessionrestore_no_auto_restore', 15:25:18 INFO - 'tabpaint']}, 15:25:18 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:25:18 INFO - 'ts_paint', 15:25:18 INFO - 'tpaint', 15:25:18 INFO - 'sessionrestore', 15:25:18 INFO - 'sessionrestore_no_auto_restore', 15:25:18 INFO - 'tabpaint']}, 15:25:18 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:25:18 INFO - 'tests': ['a11yr', 15:25:18 INFO - 'ts_paint', 15:25:18 INFO - 'tpaint', 15:25:18 INFO - 'sessionrestore', 15:25:18 INFO - 'sessionrestore_no_auto_restore', 15:25:18 INFO - 'tabpaint']}, 15:25:18 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:25:18 INFO - 'tests': ['a11yr', 15:25:18 INFO - 'ts_paint', 15:25:18 INFO - 'tpaint', 15:25:18 INFO - 'sessionrestore', 15:25:18 INFO - 'sessionrestore_no_auto_restore', 15:25:18 INFO - 'tabpaint']}, 15:25:18 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:25:18 INFO - 'tests': ['tsvgx', 15:25:18 INFO - 'tsvgr_opacity', 15:25:18 INFO - 'tart', 15:25:18 INFO - 'tscrollx', 15:25:18 INFO - 'cart']}, 15:25:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:25:18 INFO - 'tsvgr_opacity', 15:25:18 INFO - 'tart', 15:25:18 INFO - 'tscrollx', 15:25:18 INFO - 'cart']}, 15:25:18 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:25:18 INFO - 'talos_options': ['--disable-e10s'], 15:25:18 INFO - 'tests': ['tp5o']}, 15:25:18 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:25:18 INFO - 'tests': ['tp5o']}, 15:25:18 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:25:18 INFO - 'talos_options': ['--disable-e10s', 15:25:18 INFO - '--xperf_path', 15:25:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:25:18 INFO - 'tests': ['tp5n']}, 15:25:18 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:25:18 INFO - 'talos_options': ['--xperf_path', 15:25:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:25:18 INFO - 'tests': ['tp5n']}}, 15:25:18 INFO - 'talos.zip': {'path': '', 15:25:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:25:18 INFO - Running post-action listener: _resource_record_post_action 15:25:18 INFO - [mozharness: 2016-08-04 22:25:18.379829Z] Finished populate-webroot step (success) 15:25:18 INFO - [mozharness: 2016-08-04 22:25:18.379918Z] Running create-virtualenv step. 15:25:18 INFO - Running pre-action listener: _resource_record_pre_action 15:25:18 INFO - Running main action method: create_virtualenv 15:25:18 INFO - Creating virtualenv /builds/slave/test/build/venv 15:25:18 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 15:25:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:25:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:25:18 INFO - Using real prefix '/usr' 15:25:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:25:18 INFO - Installing distribute.............................................................................................................................................................................................done. 15:25:20 INFO - Installing pip.................done. 15:25:20 INFO - Return code: 0 15:25:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:25:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:25:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:25:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:25:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:25:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17c2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a83180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a813b0>, '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 0x1a822b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a82740>, '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-1470348141.91211-1355357942', '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 15:25:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:25:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:25:20 INFO - Using env: {'DISPLAY': ':0', 15:25:20 INFO - 'HOME': '/home/cltbld', 15:25:20 INFO - 'LANG': 'en_US.UTF-8', 15:25:20 INFO - 'LANGUAGE': 'en_US:en', 15:25:20 INFO - 'LOGNAME': 'cltbld', 15:25:20 INFO - 'MAIL': '/var/mail/cltbld', 15:25:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:25:20 INFO - 'MOZ_NO_REMOTE': '1', 15:25:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:25:20 INFO - 'NO_EM_RESTART': '1', 15:25:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:25:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:25:20 INFO - 'PWD': '/builds/slave/test', 15:25:20 INFO - 'SHELL': '/bin/bash', 15:25:20 INFO - 'SHLVL': '1', 15:25:20 INFO - 'TERM': 'linux', 15:25:20 INFO - 'TMOUT': '86400', 15:25:20 INFO - 'USER': 'cltbld', 15:25:20 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1470348141.91211-1355357942', 15:25:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:25:20 INFO - '_': '/tools/buildbot/bin/python'} 15:25:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:25:21 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 15:25:21 INFO - Cleaning up... 15:25:21 INFO - Return code: 0 15:25:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:25:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:25:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:25:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:25:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:25:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25:21 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 0x17c2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a83180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a813b0>, '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 0x1a822b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a82740>, '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-1470348141.91211-1355357942', '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 15:25:21 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 15:25:21 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 15:25:21 INFO - Using env: {'DISPLAY': ':0', 15:25:21 INFO - 'HOME': '/home/cltbld', 15:25:21 INFO - 'LANG': 'en_US.UTF-8', 15:25:21 INFO - 'LANGUAGE': 'en_US:en', 15:25:21 INFO - 'LOGNAME': 'cltbld', 15:25:21 INFO - 'MAIL': '/var/mail/cltbld', 15:25:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:25:21 INFO - 'MOZ_NO_REMOTE': '1', 15:25:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:25:21 INFO - 'NO_EM_RESTART': '1', 15:25:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:25:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:25:21 INFO - 'PWD': '/builds/slave/test', 15:25:21 INFO - 'SHELL': '/bin/bash', 15:25:21 INFO - 'SHLVL': '1', 15:25:21 INFO - 'TERM': 'linux', 15:25:21 INFO - 'TMOUT': '86400', 15:25:21 INFO - 'USER': 'cltbld', 15:25:21 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1470348141.91211-1355357942', 15:25:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:25:21 INFO - '_': '/tools/buildbot/bin/python'} 15:25:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:25:21 INFO - Downloading/unpacking psutil>=3.1.1 15:25:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:25:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:25:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:25:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:25:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:25:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:25:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:25:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:25:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:25:23 INFO - Installing collected packages: psutil 15:25:23 INFO - Running setup.py install for psutil 15:25:23 INFO - building 'psutil._psutil_linux' extension 15:25:23 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 15:25:23 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 15:25:23 INFO - building 'psutil._psutil_posix' extension 15:25:23 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 15:25:23 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 15:25:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:25:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:25:23 INFO - Successfully installed psutil 15:25:23 INFO - Cleaning up... 15:25:23 INFO - Return code: 0 15:25:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:25:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:25:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:25:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:25:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:25:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25:23 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 0x17c2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a83180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a813b0>, '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 0x1a822b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a82740>, '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-1470348141.91211-1355357942', '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 15:25:23 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 15:25:23 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 15:25:23 INFO - Using env: {'DISPLAY': ':0', 15:25:23 INFO - 'HOME': '/home/cltbld', 15:25:23 INFO - 'LANG': 'en_US.UTF-8', 15:25:23 INFO - 'LANGUAGE': 'en_US:en', 15:25:23 INFO - 'LOGNAME': 'cltbld', 15:25:23 INFO - 'MAIL': '/var/mail/cltbld', 15:25:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:25:23 INFO - 'MOZ_NO_REMOTE': '1', 15:25:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:25:23 INFO - 'NO_EM_RESTART': '1', 15:25:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:25:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:25:23 INFO - 'PWD': '/builds/slave/test', 15:25:23 INFO - 'SHELL': '/bin/bash', 15:25:23 INFO - 'SHLVL': '1', 15:25:23 INFO - 'TERM': 'linux', 15:25:23 INFO - 'TMOUT': '86400', 15:25:23 INFO - 'USER': 'cltbld', 15:25:23 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1470348141.91211-1355357942', 15:25:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:25:23 INFO - '_': '/tools/buildbot/bin/python'} 15:25:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:25:24 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:25:24 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 15:25:24 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 15:25:24 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 15:25:24 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 15:25:24 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 15:25:24 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 15:25:26 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:25:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:25:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:25:26 INFO - Installing collected packages: mozsystemmonitor 15:25:26 INFO - Running setup.py install for mozsystemmonitor 15:25:26 INFO - Successfully installed mozsystemmonitor 15:25:26 INFO - Cleaning up... 15:25:26 INFO - Return code: 0 15:25:26 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:25: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')]} 15:25:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:25:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25: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')]} 15:25:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:25:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25:26 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 0x17c2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a83180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a813b0>, '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 0x1a822b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a82740>, '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-1470348141.91211-1355357942', '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 15:25:26 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 15:25:26 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 15:25:26 INFO - Using env: {'DISPLAY': ':0', 15:25:26 INFO - 'HOME': '/home/cltbld', 15:25:26 INFO - 'LANG': 'en_US.UTF-8', 15:25:26 INFO - 'LANGUAGE': 'en_US:en', 15:25:26 INFO - 'LOGNAME': 'cltbld', 15:25:26 INFO - 'MAIL': '/var/mail/cltbld', 15:25:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:25:26 INFO - 'MOZ_NO_REMOTE': '1', 15:25:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:25:26 INFO - 'NO_EM_RESTART': '1', 15:25:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:25:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:25:26 INFO - 'PWD': '/builds/slave/test', 15:25:26 INFO - 'SHELL': '/bin/bash', 15:25:26 INFO - 'SHLVL': '1', 15:25:26 INFO - 'TERM': 'linux', 15:25:26 INFO - 'TMOUT': '86400', 15:25:26 INFO - 'USER': 'cltbld', 15:25:26 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1470348141.91211-1355357942', 15:25:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:25:26 INFO - '_': '/tools/buildbot/bin/python'} 15:25:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:25:26 INFO - Downloading/unpacking jsonschema==2.5.1 15:25:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:25:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:25:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:25:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:25:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:25:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:25:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:25:28 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:25:28 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 15:25:28 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 15:25:28 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 15:25:28 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 15:25:28 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 15:25:28 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 15:25:28 INFO - Downloading functools32-3.2.3-2.tar.gz 15:25:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:25:28 INFO - warning: no files found matching '*.txt' 15:25:28 INFO - no previously-included directories found matching 'build' 15:25:28 INFO - no previously-included directories found matching 'dist' 15:25:28 INFO - no previously-included directories found matching '.git*' 15:25:28 INFO - Installing collected packages: jsonschema, functools32 15:25:29 INFO - Running setup.py install for functools32 15:25:29 INFO - warning: no files found matching '*.txt' 15:25:29 INFO - no previously-included directories found matching 'build' 15:25:29 INFO - no previously-included directories found matching 'dist' 15:25:29 INFO - no previously-included directories found matching '.git*' 15:25:29 INFO - Successfully installed jsonschema functools32 15:25:29 INFO - Cleaning up... 15:25:29 INFO - Return code: 0 15:25:29 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:25:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:25:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:25:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:25:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:25:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x17c2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a83180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a813b0>, '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 0x1a822b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a82740>, '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-1470348141.91211-1355357942', '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 15:25:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:25:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 15:25:29 INFO - Using env: {'DISPLAY': ':0', 15:25:29 INFO - 'HOME': '/home/cltbld', 15:25:29 INFO - 'LANG': 'en_US.UTF-8', 15:25:29 INFO - 'LANGUAGE': 'en_US:en', 15:25:29 INFO - 'LOGNAME': 'cltbld', 15:25:29 INFO - 'MAIL': '/var/mail/cltbld', 15:25:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:25:29 INFO - 'MOZ_NO_REMOTE': '1', 15:25:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:25:29 INFO - 'NO_EM_RESTART': '1', 15:25:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:25:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:25:29 INFO - 'PWD': '/builds/slave/test', 15:25:29 INFO - 'SHELL': '/bin/bash', 15:25:29 INFO - 'SHLVL': '1', 15:25:29 INFO - 'TERM': 'linux', 15:25:29 INFO - 'TMOUT': '86400', 15:25:29 INFO - 'USER': 'cltbld', 15:25:29 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1470348141.91211-1355357942', 15:25:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:25:29 INFO - '_': '/tools/buildbot/bin/python'} 15:25:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:25:29 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:25:29 INFO - Cleaning up... 15:25:29 INFO - Return code: 0 15:25:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:25:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:25:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:25:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:25:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:25:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x17c2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a83180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a813b0>, '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 0x1a822b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a82740>, '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-1470348141.91211-1355357942', '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 15:25:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:25:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:25:29 INFO - Using env: {'DISPLAY': ':0', 15:25:29 INFO - 'HOME': '/home/cltbld', 15:25:29 INFO - 'LANG': 'en_US.UTF-8', 15:25:29 INFO - 'LANGUAGE': 'en_US:en', 15:25:29 INFO - 'LOGNAME': 'cltbld', 15:25:29 INFO - 'MAIL': '/var/mail/cltbld', 15:25:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:25:29 INFO - 'MOZ_NO_REMOTE': '1', 15:25:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:25:29 INFO - 'NO_EM_RESTART': '1', 15:25:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:25:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:25:29 INFO - 'PWD': '/builds/slave/test', 15:25:29 INFO - 'SHELL': '/bin/bash', 15:25:29 INFO - 'SHLVL': '1', 15:25:29 INFO - 'TERM': 'linux', 15:25:29 INFO - 'TMOUT': '86400', 15:25:29 INFO - 'USER': 'cltbld', 15:25:29 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1470348141.91211-1355357942', 15:25:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:25:29 INFO - '_': '/tools/buildbot/bin/python'} 15:25:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:25:29 INFO - Downloading/unpacking blobuploader==1.2.4 15:25:29 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 15:25:29 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 15:25:29 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 15:25:29 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 15:25:29 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 15:25:29 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 15:25:31 INFO - Downloading blobuploader-1.2.4.tar.gz 15:25:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:25:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:25:31 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 15:25:31 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 15:25:31 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 15:25:31 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 15:25:31 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 15:25:31 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 15:25:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:25:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:25:32 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 15:25:32 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 15:25:32 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 15:25:32 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 15:25:32 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 15:25:32 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 15:25:32 INFO - Downloading docopt-0.6.1.tar.gz 15:25:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:25:32 INFO - Installing collected packages: blobuploader, requests, docopt 15:25:32 INFO - Running setup.py install for blobuploader 15:25:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:25:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:25:32 INFO - Running setup.py install for requests 15:25:32 INFO - Running setup.py install for docopt 15:25:33 INFO - Successfully installed blobuploader requests docopt 15:25:33 INFO - Cleaning up... 15:25:33 INFO - Return code: 0 15:25:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:25:33 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')]} 15:25:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:25:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25:33 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')]} 15:25:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:25:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25:33 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 0x17c2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a83180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a813b0>, '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 0x1a822b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a82740>, '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-1470348141.91211-1355357942', '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 15:25:33 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 15:25:33 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 15:25:33 INFO - Using env: {'DISPLAY': ':0', 15:25:33 INFO - 'HOME': '/home/cltbld', 15:25:33 INFO - 'LANG': 'en_US.UTF-8', 15:25:33 INFO - 'LANGUAGE': 'en_US:en', 15:25:33 INFO - 'LOGNAME': 'cltbld', 15:25:33 INFO - 'MAIL': '/var/mail/cltbld', 15:25:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:25:33 INFO - 'MOZ_NO_REMOTE': '1', 15:25:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:25:33 INFO - 'NO_EM_RESTART': '1', 15:25:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:25:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:25:33 INFO - 'PWD': '/builds/slave/test', 15:25:33 INFO - 'SHELL': '/bin/bash', 15:25:33 INFO - 'SHLVL': '1', 15:25:33 INFO - 'TERM': 'linux', 15:25:33 INFO - 'TMOUT': '86400', 15:25:33 INFO - 'USER': 'cltbld', 15:25:33 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1470348141.91211-1355357942', 15:25:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:25:33 INFO - '_': '/tools/buildbot/bin/python'} 15:25:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:25:33 INFO - Running setup.py (path:/tmp/pip-FO1WEO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:25:33 INFO - Running setup.py (path:/tmp/pip-otkI3L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:25:33 INFO - Running setup.py (path:/tmp/pip-bWHcIk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:25:33 INFO - Running setup.py (path:/tmp/pip-yz5qZn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:25:33 INFO - Running setup.py (path:/tmp/pip-o2_W7w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:25:33 INFO - Running setup.py (path:/tmp/pip-iVYmBX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:25:33 INFO - Running setup.py (path:/tmp/pip-c4X9Jd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:25:33 INFO - Running setup.py (path:/tmp/pip-8qAGWI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:25:33 INFO - Running setup.py (path:/tmp/pip-gKb68n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:25:33 INFO - Running setup.py (path:/tmp/pip-Qghtwb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:25:34 INFO - Running setup.py (path:/tmp/pip-gmfbMK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:25:34 INFO - Running setup.py (path:/tmp/pip-Q8OTT5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:25:34 INFO - Running setup.py (path:/tmp/pip-tA1Z0n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:25:34 INFO - Running setup.py (path:/tmp/pip-aHpfoY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:25:34 INFO - Running setup.py (path:/tmp/pip-UoGjBr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:25:34 INFO - Running setup.py (path:/tmp/pip-Gm2nly-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:25:34 INFO - Running setup.py (path:/tmp/pip-Jll0_B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:25:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:25:34 INFO - Running setup.py install for manifestparser 15:25:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:25:34 INFO - Running setup.py install for mozcrash 15:25:34 INFO - Running setup.py install for mozdebug 15:25:34 INFO - Running setup.py install for mozdevice 15:25:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:25:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:25:34 INFO - Running setup.py install for mozfile 15:25:35 INFO - Running setup.py install for mozhttpd 15:25:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:25:35 INFO - Running setup.py install for mozinfo 15:25:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:25:35 INFO - Running setup.py install for mozInstall 15:25:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:25:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:25:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:25:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:25:35 INFO - Running setup.py install for mozleak 15:25:35 INFO - Running setup.py install for mozlog 15:25:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:25:35 INFO - Running setup.py install for moznetwork 15:25:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:25:35 INFO - Running setup.py install for mozprocess 15:25:35 INFO - Running setup.py install for mozprofile 15:25:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:25:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:25:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:25:35 INFO - Running setup.py install for mozrunner 15:25:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:25:36 INFO - Running setup.py install for mozscreenshot 15:25:36 INFO - Running setup.py install for moztest 15:25:36 INFO - Running setup.py install for mozversion 15:25:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:25:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:25:36 INFO - Cleaning up... 15:25:36 INFO - Return code: 0 15:25:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:25:36 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')]} 15:25:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:25:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25:36 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')]} 15:25:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:25:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25:36 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 0x17c2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a83180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a813b0>, '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 0x1a822b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a82740>, '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-1470348141.91211-1355357942', '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 15:25:36 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 15:25:36 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 15:25:36 INFO - Using env: {'DISPLAY': ':0', 15:25:36 INFO - 'HOME': '/home/cltbld', 15:25:36 INFO - 'LANG': 'en_US.UTF-8', 15:25:36 INFO - 'LANGUAGE': 'en_US:en', 15:25:36 INFO - 'LOGNAME': 'cltbld', 15:25:36 INFO - 'MAIL': '/var/mail/cltbld', 15:25:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:25:36 INFO - 'MOZ_NO_REMOTE': '1', 15:25:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:25:36 INFO - 'NO_EM_RESTART': '1', 15:25:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:25:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:25:36 INFO - 'PWD': '/builds/slave/test', 15:25:36 INFO - 'SHELL': '/bin/bash', 15:25:36 INFO - 'SHLVL': '1', 15:25:36 INFO - 'TERM': 'linux', 15:25:36 INFO - 'TMOUT': '86400', 15:25:36 INFO - 'USER': 'cltbld', 15:25:36 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1470348141.91211-1355357942', 15:25:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:25:36 INFO - '_': '/tools/buildbot/bin/python'} 15:25:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:25:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:25:36 INFO - Running setup.py (path:/tmp/pip-gW0DUO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:25:36 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)) 15:25:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:25:36 INFO - Running setup.py (path:/tmp/pip-8eCdwQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:25:36 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)) 15:25:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:25:36 INFO - Running setup.py (path:/tmp/pip-sWHSBr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:25:36 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)) 15:25:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:25:36 INFO - Running setup.py (path:/tmp/pip-x1MJrh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:25:36 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)) 15:25:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:25:36 INFO - Running setup.py (path:/tmp/pip-7EGi4a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:25:36 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)) 15:25:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:25:36 INFO - Running setup.py (path:/tmp/pip-D4bz6A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:25:36 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)) 15:25:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:25:36 INFO - Running setup.py (path:/tmp/pip-6ZjWOS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:25:37 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)) 15:25:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:25:37 INFO - Running setup.py (path:/tmp/pip-yTMIV9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:25:37 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)) 15:25:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:25:37 INFO - Running setup.py (path:/tmp/pip-hfy07A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:25:37 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)) 15:25:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:25:37 INFO - Running setup.py (path:/tmp/pip-gbbEV2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:25:37 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)) 15:25:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:25:37 INFO - Running setup.py (path:/tmp/pip-SbZDNG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:25:37 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)) 15:25:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:25:37 INFO - Running setup.py (path:/tmp/pip-X75bp7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:25:37 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)) 15:25:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:25:37 INFO - Running setup.py (path:/tmp/pip-KxKb6X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:25:37 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)) 15:25:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:25:37 INFO - Running setup.py (path:/tmp/pip-9v34id-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:25:37 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)) 15:25:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:25:37 INFO - Running setup.py (path:/tmp/pip-Xy1j4T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:25:37 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)) 15:25:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:25:37 INFO - Running setup.py (path:/tmp/pip-3ox0Ot-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:25:37 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)) 15:25:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:25:37 INFO - Running setup.py (path:/tmp/pip-DEkdRQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:25:37 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)) 15:25:37 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)) 15:25:37 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)) 15:25:37 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)) 15:25:37 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)) 15:25:37 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)) 15:25:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:25:37 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 15:25:37 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 15:25:37 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 15:25:37 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 15:25:37 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 15:25:37 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 15:25:39 INFO - Downloading blessings-1.6.tar.gz 15:25:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:25:39 INFO - Installing collected packages: blessings 15:25:39 INFO - Running setup.py install for blessings 15:25:40 INFO - Successfully installed blessings 15:25:40 INFO - Cleaning up... 15:25:40 INFO - Return code: 0 15:25:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:25:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:25:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:25:40 INFO - Reading from file tmpfile_stdout 15:25:40 INFO - Current package versions: 15:25:40 INFO - argparse == 1.2.1 15:25:40 INFO - blessings == 1.6 15:25:40 INFO - blobuploader == 1.2.4 15:25:40 INFO - docopt == 0.6.1 15:25:40 INFO - functools32 == 3.2.3-2 15:25:40 INFO - jsonschema == 2.5.1 15:25:40 INFO - manifestparser == 1.1 15:25:40 INFO - mozInstall == 1.12 15:25:40 INFO - mozcrash == 0.17 15:25:40 INFO - mozdebug == 0.1 15:25:40 INFO - mozdevice == 0.48 15:25:40 INFO - mozfile == 1.2 15:25:40 INFO - mozhttpd == 0.7 15:25:40 INFO - mozinfo == 0.9 15:25:40 INFO - mozleak == 0.1 15:25:40 INFO - mozlog == 3.3 15:25:40 INFO - moznetwork == 0.27 15:25:40 INFO - mozprocess == 0.23 15:25:40 INFO - mozprofile == 0.28 15:25:40 INFO - mozrunner == 6.12 15:25:40 INFO - mozscreenshot == 0.1 15:25:40 INFO - mozsystemmonitor == 0.3 15:25:40 INFO - moztest == 0.7 15:25:40 INFO - mozversion == 1.4 15:25:40 INFO - psutil == 3.1.1 15:25:40 INFO - requests == 1.2.3 15:25:40 INFO - wsgiref == 0.1.2 15:25:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:25:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:25:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:25:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:25:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:25:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25:40 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 0x17c2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a83180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a813b0>, '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 0x1a822b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a82740>, '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-1470348141.91211-1355357942', '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 15:25:40 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 15:25:40 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 15:25:40 INFO - Using env: {'DISPLAY': ':0', 15:25:40 INFO - 'HOME': '/home/cltbld', 15:25:40 INFO - 'LANG': 'en_US.UTF-8', 15:25:40 INFO - 'LANGUAGE': 'en_US:en', 15:25:40 INFO - 'LOGNAME': 'cltbld', 15:25:40 INFO - 'MAIL': '/var/mail/cltbld', 15:25:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:25:40 INFO - 'MOZ_NO_REMOTE': '1', 15:25:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:25:40 INFO - 'NO_EM_RESTART': '1', 15:25:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:25:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:25:40 INFO - 'PWD': '/builds/slave/test', 15:25:40 INFO - 'SHELL': '/bin/bash', 15:25:40 INFO - 'SHLVL': '1', 15:25:40 INFO - 'TERM': 'linux', 15:25:40 INFO - 'TMOUT': '86400', 15:25:40 INFO - 'USER': 'cltbld', 15:25:40 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1470348141.91211-1355357942', 15:25:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:25:40 INFO - '_': '/tools/buildbot/bin/python'} 15:25:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:25:40 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)) 15:25:40 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)) 15:25:40 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)) 15:25:40 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)) 15:25:40 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)) 15:25:40 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)) 15:25:40 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)) 15:25:40 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)) 15:25:40 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)) 15:25:40 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)) 15:25:40 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)) 15:25:40 INFO - Cleaning up... 15:25:40 INFO - Return code: 0 15:25:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:25:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:25:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:25:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:25:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:25:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25:40 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 0x17c2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a83180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a813b0>, '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 0x1a822b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a82740>, '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-1470348141.91211-1355357942', '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 15:25:40 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 15:25:40 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 15:25:40 INFO - Using env: {'DISPLAY': ':0', 15:25:40 INFO - 'HOME': '/home/cltbld', 15:25:40 INFO - 'LANG': 'en_US.UTF-8', 15:25:40 INFO - 'LANGUAGE': 'en_US:en', 15:25:40 INFO - 'LOGNAME': 'cltbld', 15:25:40 INFO - 'MAIL': '/var/mail/cltbld', 15:25:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:25:40 INFO - 'MOZ_NO_REMOTE': '1', 15:25:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:25:40 INFO - 'NO_EM_RESTART': '1', 15:25:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:25:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:25:40 INFO - 'PWD': '/builds/slave/test', 15:25:40 INFO - 'SHELL': '/bin/bash', 15:25:40 INFO - 'SHLVL': '1', 15:25:40 INFO - 'TERM': 'linux', 15:25:40 INFO - 'TMOUT': '86400', 15:25:40 INFO - 'USER': 'cltbld', 15:25:40 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1470348141.91211-1355357942', 15:25:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:25:40 INFO - '_': '/tools/buildbot/bin/python'} 15:25:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:25:40 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:25:40 INFO - Cleaning up... 15:25:40 INFO - Return code: 0 15:25:40 INFO - Running post-action listener: _resource_record_post_action 15:25:40 INFO - Running post-action listener: _start_resource_monitoring 15:25:40 INFO - Starting resource monitoring. 15:25:40 INFO - [mozharness: 2016-08-04 22:25:40.847437Z] Finished create-virtualenv step (success) 15:25:40 INFO - [mozharness: 2016-08-04 22:25:40.847896Z] Running install step. 15:25:40 INFO - Running pre-action listener: _resource_record_pre_action 15:25:40 INFO - Running main action method: install 15:25:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:25:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:25:41 INFO - Reading from file tmpfile_stdout 15:25:41 INFO - Detecting whether we're running mozinstall >=1.0... 15:25:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:25:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:25:41 INFO - Reading from file tmpfile_stdout 15:25:41 INFO - Output received: 15:25:41 INFO - Usage: mozinstall [options] installer 15:25:41 INFO - Options: 15:25:41 INFO - -h, --help show this help message and exit 15:25:41 INFO - -d DEST, --destination=DEST 15:25:41 INFO - Directory to install application into. [default: 15:25:41 INFO - "/builds/slave/test"] 15:25:41 INFO - --app=APP Application being installed. [default: firefox] 15:25:41 INFO - mkdir: /builds/slave/test/build/application 15:25:41 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'] 15:25:41 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 15:25:58 INFO - Reading from file tmpfile_stdout 15:25:58 INFO - Output received: 15:25:58 INFO - /builds/slave/test/build/application/firefox/firefox 15:25:58 INFO - Running post-action listener: _resource_record_post_action 15:25:58 INFO - [mozharness: 2016-08-04 22:25:58.020101Z] Finished install step (success) 15:25:58 INFO - [mozharness: 2016-08-04 22:25:58.020347Z] Running run-tests step. 15:25:58 INFO - Running pre-action listener: _resource_record_pre_action 15:25:58 INFO - Running main action method: run_tests 15:25:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:25:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:25:58 INFO - Python 2.7.3 15:25:58 INFO - Return code: 0 15:25:58 INFO - grabbing minidump binary from tooltool 15:25: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')]} 15:25:58 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 0x1a813b0>, '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 0x1a822b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a82740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:25:58 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 15:25:58 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 15:25:58 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 15:25:58 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:25:58 INFO - Return code: 0 15:25:58 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:25:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:25:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:25:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:25:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:25:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/d_jGmSKyQEah49Y-A2TC2g/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 15:25:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/d_jGmSKyQEah49Y-A2TC2g/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 15:25:58 INFO - Using env: {'DISPLAY': ':0', 15:25:58 INFO - 'HOME': '/home/cltbld', 15:25:58 INFO - 'LANG': 'en_US.UTF-8', 15:25:58 INFO - 'LANGUAGE': 'en_US:en', 15:25:58 INFO - 'LOGNAME': 'cltbld', 15:25:58 INFO - 'MAIL': '/var/mail/cltbld', 15:25:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:25:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:25:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:25:58 INFO - 'MOZ_NO_REMOTE': '1', 15:25:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:25:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:25:58 INFO - 'NO_EM_RESTART': '1', 15:25:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:25:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:25:58 INFO - 'PWD': '/builds/slave/test', 15:25:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:25:58 INFO - 'SHELL': '/bin/bash', 15:25:58 INFO - 'SHLVL': '1', 15:25:58 INFO - 'TERM': 'linux', 15:25:58 INFO - 'TMOUT': '86400', 15:25:58 INFO - 'USER': 'cltbld', 15:25:58 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1470348141.91211-1355357942', 15:25:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:25:58 INFO - '_': '/tools/buildbot/bin/python'} 15:25:58 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/d_jGmSKyQEah49Y-A2TC2g/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 15:25:58 INFO - mozversion application_buildid: 20160804123001 15:25:58 INFO - mozversion application_changeset: 4939f5d5c16c957ae0da6d509a26482983fc894a 15:25:58 INFO - mozversion application_display_name: Nightly 15:25:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:25:58 INFO - mozversion application_name: Firefox 15:25:58 INFO - mozversion application_remotingname: firefox 15:25:58 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 15:25:58 INFO - mozversion application_vendor: Mozilla 15:25:58 INFO - mozversion application_version: 51.0a1 15:25:58 INFO - mozversion platform_buildid: 20160804123001 15:25:58 INFO - mozversion platform_changeset: 4939f5d5c16c957ae0da6d509a26482983fc894a 15:25:58 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 15:25:58 INFO - mozversion platform_version: 51.0a1 15:25:58 INFO - using testdate: 1470349558 15:25:58 INFO - actual date: 1470349558 15:25:58 INFO - starting webserver on 'localhost:55262' 15:25:58 INFO - SUITE-START | Running 2 tests 15:25:58 INFO - TEST-START | dromaeo_css 15:25:58 INFO - operating with platform_type : linux_ 15:25:58 INFO - Initialising browser for dromaeo_css test... 15:25:58 INFO - TEST-INFO | started process 10286 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpydPWfu/profile http://localhost:55262/getInfo.html) 15:26:02 INFO - PROCESS | 10286 | __metrics Screen width/height:1600/1200 15:26:02 INFO - PROCESS | 10286 | colorDepth:24 15:26:02 INFO - PROCESS | 10286 | Browser inner width/height: 1024/697 15:26:02 INFO - PROCESS | 10286 | __metrics 15:26:03 INFO - PROCESS | 10286 | 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" 15:26:03 INFO - PROCESS | 10286 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:26:03 INFO - PROCESS | 10286 | console.error: PushService: 15:26:03 INFO - PROCESS | 10286 | stateChangeProcessEnqueue: Error transitioning state 15:26:03 INFO - PROCESS | 10286 | UnknownError 15:26:04 INFO - TEST-INFO | 10286: exit 0 15:26:04 INFO - Browser initialized. 15:26:04 INFO - Running cycle 1/1 for dromaeo_css test... 15:26:04 INFO - TEST-INFO | started process 10367 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpydPWfu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:26:16 INFO - PROCESS | 10367 | RSS: Main: 156651520 15:26:16 INFO - PROCESS | 10367 | 15:27:07 INFO - PROCESS | 10367 | 1470349627719 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] 15:29:16 INFO - PROCESS | 10367 | Cycle 1(1): loaded http://localhost:55262/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55262/tests/dromaeo/cssquery-ext.html) 15:29:17 INFO - PROCESS | 10367 | RSS: Main: 262971392 15:29:17 INFO - PROCESS | 10367 | 15:32:20 INFO - PROCESS | 10367 | Cycle 1(1): loaded http://localhost:55262/tests/dromaeo/cssquery-ext.html (next: http://localhost:55262/tests/dromaeo/cssquery-jquery.html) 15:32:20 INFO - PROCESS | 10367 | RSS: Main: 244781056 15:32:20 INFO - PROCESS | 10367 | 15:35:22 INFO - PROCESS | 10367 | Cycle 1(1): loaded http://localhost:55262/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55262/tests/dromaeo/cssquery-mootools.html) 15:35:23 INFO - PROCESS | 10367 | RSS: Main: 185389056 15:35:23 INFO - PROCESS | 10367 | 15:38:25 INFO - PROCESS | 10367 | Cycle 1(1): loaded http://localhost:55262/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55262/tests/dromaeo/cssquery-prototype.html) 15:38:26 INFO - PROCESS | 10367 | RSS: Main: 184418304 15:38:26 INFO - PROCESS | 10367 | 15:41:28 INFO - PROCESS | 10367 | Cycle 1(1): loaded http://localhost:55262/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55262/tests/dromaeo/cssquery-yui.html) 15:41:29 INFO - PROCESS | 10367 | RSS: Main: 185352192 15:41:29 INFO - PROCESS | 10367 | 15:44:32 INFO - PROCESS | 10367 | Cycle 1(1): loaded http://localhost:55262/tests/dromaeo/cssquery-yui.html (next: http://localhost:55262/tests/dromaeo/cssquery-dojo.html) 15:44:32 INFO - PROCESS | 10367 | RSS: Main: 268894208 15:44:32 INFO - PROCESS | 10367 | 15:44:32 INFO - PROCESS | 10367 | __start_tp_report 15:44:32 INFO - PROCESS | 10367 | _x_x_mozilla_page_load 15:44:32 INFO - PROCESS | 10367 | _x_x_mozilla_page_load_details 15:44:32 INFO - PROCESS | 10367 | |i|pagename|runs| 15:44:32 INFO - PROCESS | 10367 | |0;dojo.html;2987.910362689119;3006.143249173983;3027.9697203027963;3030.1969977955846;3046.7867249292544;5142.331496905402;5153.81961631343;5227.764750586223;5241.423443421226;5309.8938021239555;5225.372955245366;5258.211268309756;5309.5752339812725;5313.628046036779;5353.544948679357;4763.071201115784;4808.2547205183255;4835.734034628112;4837.226043832988;4941.678790878582;4785.306130611059;4910.116179087763;4960.156773348522;4964.404271487427;4970.030843985424;4883.413990321149;4927.1870141426625;4929.950700492985;4935.407751069876;4961.925571116418;4685.461171965199;4721.457032441244;4731.290306454025;4757.976210118927;4831.734254615994;4678.087772884289;4703.365045718852;4712.175369310391;4780.617550595944;4802.59177969873;5174.43081261061;5237.3453318335205;5245.527902488756;5263.631545791796;5273.2617433559335;5443.863903402446;5604.495595396393;5692.0608099663505;5696.829095127153;5701.059325211335;5661.037623603997;5701.857453563653;5710.7430165642645;5716.314042314907;5729.427057294279;5103.132467480537;5337.172738225581;5341.4925582069645;5347.866303342447;5349.946500535023;5586.1062230043;5623.550115990711;5630.211770352154;5722.54219662426;5723.427657234327;5434.3207099112615;5436.320459942507;5487.067198576252;5493.615446918678;5498;5432.29380180574;5564.554835613141;5570;5571.164325351229;5575.832725018256;5413.756380962866;5429.891402172014;5445.1832225166545;5475.479829416199;5510.338759348904;5451.863703407446;5462.562994960473;5468;5469.699166545878;5472;4174.102567947845;4225.176090662353;4256.36154576816;4259.169461954889;4286.421333120051;3790.431435284674;3825.139343647713;3829.272438236726;3837.865674701372;3852.499175107218;5186.6369354144845;5206.739663016834;5211;5216.321878155892;5259.289995850588;5396.1366181410785;5514.972425137848;5527.198556209327;5539.778408863681;5554.333479982428;5253.947460525345;5299.152135658276;5327.200919862052;5371.221172929982;5371.75827087782;4814.422269327633;4833.782479788418;4871.391076115486;4879.73126986986;4882.950165714388;5630.634008789498;5773.1051686988585;5915.645061296336;5925.4074592541265;5931.792387266425;5562.860928476821;5624.184493248538;5645.125005624135;5667.40492248308;5680.431956804452;5817.2146760188525;5819.127130930395;5827.388124246893;5835.591508594358;5836.620619659709;5219;5321.095413779744;5524.861878453071;5532.336119665505;5542.806001789918;5419.187121931742;5464.153056276284;5470.425605311385;5508.614396992172;5525.696086715108;5359.062164121186;5410.107332290128;5411.540019098264;5413.323334583177;5431.103867861759;5228.294180285765;5400.918986215132;5405.189221616789;5440.047991601533;5449.264349312792;5363.249145119608;5487.6158668894395;5492.340919089735;5521.309836270466;5542.667439953616;5571.832845014656;5582.441755824385;5613.775448982158;5619.775208991595;5623.915641265467;5154.587632989277;5410.891782164414;5461.9453805461435;5462.590305727166;5472.288602481811 15:44:32 INFO - PROCESS | 10367 | |1;ext.html;585.9209006784083;601.7213421479356;606.0969155957623;617.4782308948936;623.224086012914;46141.30788038182;47171;47317.52682473174;47423.28865067027;50106.49893501064;46597.53402465974;47135;47270.29094563576;47285.52714472854;47319.76340118303;8193.590320483981;9052.90947090529;9208.953955230249;9210.907890921106;10705.197110216726;10735.40955247461;11139.220254582182;11142.442877856116;11153.442327883615;11155.38645374504;11142.888571114267;11252.26860254081;11264.718382040433;11267.60563380282;11269.211155219138;11064.612738554153;11151.330920144817;11189.608363707313;11199.552017919274;11200.99999999996;10939.070179034792;10944.288621239593;10997.395143267117;10998.395088270141;11000.834987475195;44790.55209447896;44954.77522612399;45199;45216.095678086254;45313.320300195526;3712.851485940559;3723.553173619156;3754.9249015019545;3866;4212.726172798758;34315.828420857986;34865.82567087174;34931.82534087339;35038.649613503796;35142.82428587866;3959.1487830116375;4009.939850902239;4013.5986401359633;4101.159262351241;4117.97941010293;357234;358848;358872;359775;361002.194989026;62494.37505624886;62691;62753;62849;62990.68504657447;64978.75106244669;65025.69948601002;65167.34832651613;65184.34815651783;65250;17262.65474690499;17539.56151096233;17568.209430575655;17568.736468952975;17592.912035439742;12252.44863981123;12837.165584236995;13027.283499407435;13204.14173078766;13342;18342.816571834377;18392.908035460005;18417;18450.723239151423;18702.158402871904;6025.698715064229;6110.786122485781;6226.844328891814;6264;6315.242170939517;811.5901469757735;922.391221793613;1039.5218199628255;1098.8626421697288;1130.2370899642872;33096.66903330984;33172.50241246383;33338.166545836066;33491.1579863105;33822.661773382446;1077.5043479999288;1091.1489038549944;1093.5133865429807;1132.416805345248;1132.5526417065214;17069.48791536256;17378.47864564065;17664.646707065785;17677.469675909742;17685.82314176842;164424.13455192727;165386;165841;166173;166695.16652416904;60807.39192608017;60996;61043.389566104655;61103;61122.38877611167;1221.9389030548614;1251.0117007564104;1255.12768625806;1350.9662258443618;1382.0947279531922;23851.403714907265;30281.545776813808;31241.68758312388;33060;33161.50257746087;54862.72568637131;55315;55325.44674553203;55398;55581.77672893201;402904;404624;405118;405746;405787;37241.62758372381;41832.58167418287;42180.367294489995;42214.57785422107;44062;48120.7593962028;49650;49843.25235121549;49960;49987;41946;42246.57753422426;42648.5735142657;43262.56737432585;43988;41639.58360416357;41678.16643667049;41678.37482437705;42957.57042429536;43430.78284608557;41449.79275103605;42579.14841703087;43285.35071973986;43679.34480982724;44863;35786.463203051455;37828;38603.420948686355;38803.61196388113;39491.605083948794;27321.590176146976;29212;29305.41389172162;29367;29597.704022959493 15:44:32 INFO - PROCESS | 10367 | |2;jquery.html;382.9674477669398;389.83626876711776;391.40311025685827;404.9979750101249;414.75322183300943;13949;18578.071096445175;20094.196232150716;20106.69839952402;20668.58662826746;18931.905340473313;19082.141303641336;19200.51998700033;19206.51983700408;19242.13410396532;5418.539424148942;5809.883802323951;5851.356350801409;5852.736626851802;5858.912116318259;4072.1652061327504;5755.68343741094;5837.066069428893;5839.708014599274;5861.1208318752315;6170.413810687977;6371.39471750183;6410.743570257184;6505.772297969572;6511.12099866519;6300.621962682254;6489.902651460232;6503.154589903306;6510.739570417178;6554.279029306773;5783.363829978699;5784.537237021028;5785.623934444247;5788.363280039192;5789;22635.77364226353;23409.648855267184;23461.296161115195;23476.060957561676;23699;2327.290176496168;2469.8271121021535;2509.8619575923317;2554.7062087859763;2842.701516340775;14744.483943061941;14746.188959607218;14891.404343826342;14933.328000239906;15276.236188190545;1948.3375652278153;1973.851961102923;1983.4347211044783;1987.2945104487844;2008.2167954497756;81061;81282;81663;82544;84127.5793621028;10297.485125743682;10367.066963973279;10426.68719938403;10441.216908731723;10638.361698298128;13030.609081727564;13477.19136851792;13493.5711571918;13516.5269215577;14375.424983000772;8001.5599142046585;8020.197980201933;8075.475094118863;8117.756467305991;8310.459820111673;7742;7811.68753249875;7945.602719863984;7993.681042627902;8009.519428834172;6531.183602049744;6572.638504882182;6644.634545099969;6659.334066593302;6718.428933540606;1918.4915997260737;1920.9423717288503;1938.139386189274;1944.669406200921;1955.5208973801225;909.4815954905772;990.6780296403698;1013.7871047080048;1026.3072426112494;1073.6295977887617;19382.70925936112;19495.415137545897;19689.50776230577;19782.70325945112;19929.302474413325;1014.9289549731595;1014.974625634365;1025.738436698652;1030.314840630987;1056.2395075545594;10656.413897235727;11159.665210043711;11181.608643697431;11259.887401126047;11281.435928203557;465816;469047;494325;511591;527578;79347.60326198448;84024;98483;100267;103127;996.8169708338716;1013.8834034086027;1039.101177481488;1048.7168464514386;1056.6248981611418;14510.854891451372;16621.50135495937;17773.644527109645;18189.272429102686;18500.167492462602;46581.30128048014;46768;46966;47393.28910066283;47968.520314796406;60546.394536055835;61835.690821545606;61898.381016191066;62058.37941620706;62430.687846560475;8779.20987111163;8798.34012449056;8860.734177974671;9027.4132181408;9190;10120.443375614412;13175.47298108065;13683.384247708678;14012.089214201043;14193.148411095368;11892.286462812259;12016.399180041139;12105.81841272364;12234.055807787758;12399.194052386567;11637.650870473899;11790.351530665896;11949.581764638197;12290.324032177958;12572.182808117443;11956.880431195925;12123.878761212274;12174.634760957186;12294.446749896455;12358.44387002605;8885.733427996913;8957;9217.170454659114;9221.538923053955;9292.488913109844;11459.255148415326;11997;12054.15620906528;12086.093542984136;12296.631101066982 15:44:32 INFO - PROCESS | 10367 | |3;mootools.html;1323.166405164746;1429.463951018368;1509.6301406155494;1606.2370374072318;1787.8837875538097;8071.757847264576;8302.543360115198;8393.16068393162;8454.408191426603;8951.328650351217;8191;8360.289375403083;8507.489550626966;8525.744227673164;8537;2024.7975202479709;2298.839081264312;2319.141917490531;2364.337985364092;2367.893444794988;2250.4148921280503;2283.8858057097077;2286.0969916882823;2286.2912497125863;2290.3129061281634;2248.2243625949022;2263.9434014149697;2273.113485740554;2274.1699279762934;2349.189529612281;2161.1139432832465;2235.3182279404773;2240.574290884727;2247.292102987554;2248.9212877549207;2360.7639236076425;2375.09746296408;2377.239283429303;2380.8690522021284;2383.07060246504;8763.561821908943;8789.428687135316;8843.778905527413;8856.955715221447;8875.822483550293;5145.614078944094;5263.578913686896;5277.155655095166;5280.52475277223;5281.498257665516;3180.9840950795096;3205.9198520036953;3359.1266270769534;3363.915902102467;3365.7812242204423;1061.506399524225;1066.3441983180367;1075.5267682219799;1088.1729885287239;1088.542812018954;11615.651530454015;12079.09406794494;12201.267923924594;12314.384280786015;12422.37888105591;4521.615662668644;4605.309203619417;4754.643401744883;4770.76146192689;4777.331173635694;10357.482125893675;10365.948170259251;10381.532831022621;10396.22028347877;10447.582096716198;5267.367915850123;5277.419483856773;5288.021715982555;5290.841274761763;5309.044372012998;4190.748555086705;4347.5217726050105;4821.373221481185;4829.372181616367;4894.143524883131;4033.4353190553347;4040.252553277653;4147.087640719037;4148.23257697327;4284.485861696617;1264.759695657822;1268.7652784234947;1271.9300438475786;1275.655572995286;1303.4590644882458;989.5893204320271;990.4849478271259;1002.1031177096604;1010.9140723038624;1018.2108865629197;5900.4984576310635;5964.850878728066;6045.455908968214;6168.136460895478;6249.6875156242;465.6368032934317;477.45093142885264;485.13645710635126;485.77168730696513;489.207483876123;4085.9182816343505;4186.35111557709;4191.790410479463;4241.957580424218;4355.956440435619;10418.166546676248;11031.338119712844;11145.052670522935;11157.27477713946;11179.161562882817;10835.079018283377;10928.890711092947;10937.781244375068;10953.726156845983;10975.121990240921;7949.205079492121;8048.959755201186;8088.8382232355025;8091.029076510857;8093.3929955252415;6083.574149809471;6239.812805615838;6251.624902505864;6299.716512756845;6445.677716114082;10047.799044019224;10364.481775911325;10521;10521.053105220566;10522.210834187314;9429.198518126037;9538.28462865274;9641.37331073478;9864.112229899343;9902.653407131003;7203.955426463029;7347.8530429392185;7483.812904677427;7556.546607203585;7680.884786728316;8213.79465513343;8492.787680308042;8510.531920744419;8517.361197910057;8541.402101852811;7664.386849052174;7668.108140498917;7678.769636910902;7851.56816375082;7934.365250780039;7504.549727016397;7671.424643151674;7676.692932282646;7677.654505547152;7762.1073576537165;6923.2038315594355;7022.648867556704;7094.467914906506;7248.528845625228;7267.818304542428;4951.084049450719;5007.474215207497;5057.8229761958155;5083.415407228216;5097.413797413345;5053.949460505495;5170.146925757208;5200.6619569727845;5254.7898084076205;5305.2307415423775 15:44:32 INFO - PROCESS | 10367 | |4;prototype.html;330.3970254285928;334.7673367009929;338.6934823984295;340.3957974595095;344.06242987858076;5269.6311258211945;5304.920426193606;5309.761060752266;5325.946740532593;5344.545713614342;5207.088759467088;5223.537409525329;5262.500062494057;5267.578593712504;5269.947300526994;3939.763614183158;3986.6013398660193;3997.2804895118866;4060.472138621975;4067.440989134507;3773.64150405711;4139.379093136024;4141.192467468844;4145.5647157048525;4151.169766046788;4102.5076990761;4106.137711080677;4109.178164367138;4109.301418758803;4111.424400583921;3947.7631342119275;4115.691323150761;4135.91728165435;4138.358554424069;4144.274751918432;3598.352296586613;3640.290143422034;3662.1872173274132;3678.2643471305846;3689.6163938523055;5078.4921507849285;5088;5091.567216786578;5094.210397388374;5103.260027296058;4698.976505117486;4700.623950083985;4702.365180700596;4704.388429504143;4709.71741695496;5123.8206662767;5346.866328341823;5357.785688572452;5358.347617929111;5398.676079435247;3909.3745000799736;3911.9608803911883;3918.9804050979847;3929.2337994091163;3930.1746633207063;5368.677879327252;5460.7542660579975;5626.186906546726;5642.633228840113;5662.839117980845;3995.6603688686787;4012.518497780285;4017.8392864285684;4018.0557568971267;4021.195760847842;4055.1346380665223;4062;4063.776492292893;4063.9390409143884;4075.4701888754867;4509.549045095529;4606.907861842745;4623.959609087996;4626.306054091846;4634.606058485067;5426.647267927572;5445.646033007842;5452.536534394541;5463.781448742086;5464.754086066137;1390.7427125981726;1401.4464286606938;1403.5578792680274;1406.985930140706;1407.2893188939724;869.5043825019678;903.3089686389917;905.1536813079791;909.0999910088964;917.3440989692402;4680.251159814481;4685.250359942393;4689.484156742756;4693.460252070987;4694.201985662446;4918.631102667314;4925.872071234791;4932.7286999215385;4933.260010998379;4945.579625731782;4343.7176583522605;4667.089917466129;4698.483166851644;4699.412573428322;4703.670743048022;2612.9216123516326;2620.6724159480063;2625.9868700656375;2633.578627419604;2634.3414146463383;5083.8983220335385;5098;5116.927644304063;5125.461826508237;5144.794208231704;4633.62930965522;5011.218773580697;5015.04714104319;5079.3396858408905;5081.110805609003;5060.2156665716875;5086.2017300276975;5115.258287548285;5117.596798129277;5133.456890651725;4916.237983112624;4916.901661966812;4928.4475390251955;4940.654154209171;4940.912999140183;4843.467218606021;4891.80432782699;4892;5113.693178409308;5538.944610553843;5549.44505549458;5651.350094739158;5852.297724273115;5855.2095467113095;5871.236739223874;4036.2936486114227;4054.432379466936;4060.675145988255;4067.2882245607493;4070.7964601770386;5666.943330566642;5687.317521897234;5688.516476099578;5693.430656934273;5698.430156984268;5306.761195746278;5513.365962914316;5523.861903452285;5527.143292789624;5563.58273129525;5490.286262785812;5494.340679118532;5512.9877594678455;5514.007478653721;5515.310586176728;5248.506959194505;5450.645708028966;5453.454654534515;5463.885585216389;5489.149181876815;5522.3649280333275;5530.866172434722;5537.535796570487;5551.583631227593;5573.693446860461;5416.21464887597;5424.616722735677;5454.972725136349;5454.990826697073;5463.890722185454 15:44:32 INFO - PROCESS | 10367 | |5;yui.html;660.9801705948823;730.517858213579;746.5222257755034;779.403756126563;803.2008151888867;15045.699086018287;16233;16259.83740162598;16273.104979226153;16304;15772.921135394336;15909.124998125099;15926.442574509894;15926.84073159268;15940.442084527043;664.7806223946086;788.7476007677545;805.2068712318362;821.6343727041469;825.3768404854357;778.2956424435866;779.0223269796397;779.5011192836589;779.5283853268776;781.0471225105363;845.188618925832;846.1200351634293;846.174979395091;846.3102571404286;848.5375470368633;704.936555709986;833.2792134803412;846.0608724316004;855.5080828523562;865.8614621660568;596.6420147911261;600.2676734384045;608.2700759089066;608.5223099866583;609.7713357490941;14492.27538623075;14504.202268875208;14529.636759081108;14532.70934581313;14534.12795232279;14671.853281467262;14730.631734206623;14881.404743810235;14983.400663973536;15020.474283400137;13623.455061797516;13710.862891371058;13755;13892.95802814793;14066.507672231422;4332.545082766327;4450.621697155746;4475.932861007088;4516.277395616718;4575.1993401155;80625;84226.15773842306;84353.15646843515;84690;86390.56804715999;11311.151663625262;11418.600348987746;11458.656240312805;11461.140414468948;11805.291682499077;18328;18508.44474665762;18521.166547505396;18717.532061698566;18969.90515047416;8642.351823613128;8768.649254029895;8822.77943051416;8846.513441760637;8879.511626860456;4617.399738034102;4677.532246775295;4800.831970881002;4934.580560652313;4946.455889852114;3446.172918499542;3529.982350088233;3533.858645654145;3534.257805860798;3538.805365704911;608.4189598933008;611.703323887914;615.3323643846477;615.3538784276492;627.6987046217749;654.3489228217953;670.3832474123818;680.3978479046079;682.5324652612976;690.453384418898;9734;9975.850362244571;10026.69919902404;10037.397756134655;10044.397336159855;567.5431277821311;634.3751404866204;649.694643517546;654.3750718064238;667.1160712056544;4686.7656617169005;4885.511448855086;4922.286268491049;4950.9009819803405;4977.65156439053;121299.0506091793;125932;131459.34270328586;131822.34088829494;132366;62534.68732656308;86809;87630;88796;105305;72536.27463725401;83344.58327708322;88249;91210.54394727983;91966;10052.673424766623;10212.183025358103;10337;10364.740881478023;10427.582896684047;39420.211595768495;48461.75769121132;52278;52546.73726631342;53337;53354.1996870055;67601.3239867595;68841.65579172272;69564.2174313042;76646;13929.791053134413;14020.789688154482;14021.5092471763;14081.08472949255;14292.42830286777;15259.923700381427;15691.607709807346;16065.75901361504;16108.355665773237;16173;14555.708885822436;14577.416903323749;14651.12093274407;14866.702665946405;15303;14699;14746.926265369033;14996.47512337063;15084.698306034037;15213.923930380277;14095.506657267357;14204.573862784133;14640.487582934546;14981.77527337069;15301;11234.988851003449;11722.296662200295;11812.409379530816;11907.94046029799;12654.430550625428;11891.643250702147;11897.405129743305;12162.695932601755;12348.753024939631;12354.75290494203 15:44:32 INFO - PROCESS | 10367 | __end_tp_report 15:44:32 INFO - PROCESS | 10367 | __start_cc_report 15:44:32 INFO - PROCESS | 10367 | _x_x_mozilla_cycle_collect,958 15:44:32 INFO - PROCESS | 10367 | __end_cc_report 15:44:32 INFO - PROCESS | 10367 | __startTimestamp1470350672442__endTimestamp 15:44:32 INFO - PROCESS | 10367 | 15:44:32 INFO - PROCESS | 10367 | ------- Summary: start ------- 15:44:32 INFO - PROCESS | 10367 | Number of tests: 6 15:44:32 INFO - PROCESS | 10367 | 15:44:32 INFO - PROCESS | 10367 | [#0] dojo.html Cycles:165 Average:5199.62 Median:5400.92 stddev:581.05 (10.8%) stddev-sans-first:556.33 15:44:32 INFO - PROCESS | 10367 | Values: 2987.9 3006.1 3028.0 3030.2 3046.8 5142.3 5153.8 5227.8 5241.4 5309.9 5225.4 5258.2 5309.6 5313.6 5353.5 4763.1 4808.3 4835.7 4837.2 4941.7 4785.3 4910.1 4960.2 4964.4 4970.0 4883.4 4927.2 4930.0 4935.4 4961.9 4685.5 4721.5 4731.3 4758.0 4831.7 4678.1 4703.4 4712.2 4780.6 4802.6 5174.4 5237.3 5245.5 5263.6 5273.3 5443.9 5604.5 5692.1 5696.8 5701.1 5661.0 5701.9 5710.7 5716.3 5729.4 5103.1 5337.2 5341.5 5347.9 5349.9 5586.1 5623.6 5630.2 5722.5 5723.4 5434.3 5436.3 5487.1 5493.6 5498.0 5432.3 5564.6 5570.0 5571.2 5575.8 5413.8 5429.9 5445.2 5475.5 5510.3 5451.9 5462.6 5468.0 5469.7 5472.0 4174.1 4225.2 4256.4 4259.2 4286.4 3790.4 3825.1 3829.3 3837.9 3852.5 5186.6 5206.7 5211.0 5216.3 5259.3 5396.1 5515.0 5527.2 5539.8 5554.3 5253.9 5299.2 5327.2 5371.2 5371.8 4814.4 4833.8 4871.4 4879.7 4883.0 5630.6 5773.1 5915.6 5925.4 5931.8 5562.9 5624.2 5645.1 5667.4 5680.4 5817.2 5819.1 5827.4 5835.6 5836.6 5219.0 5321.1 5524.9 5532.3 5542.8 5419.2 5464.2 5470.4 5508.6 5525.7 5359.1 5410.1 5411.5 5413.3 5431.1 5228.3 5400.9 5405.2 5440.0 5449.3 5363.2 5487.6 5492.3 5521.3 5542.7 5571.8 5582.4 5613.8 5619.8 5623.9 5154.6 5410.9 5461.9 5462.6 5472.3 15:44:32 INFO - PROCESS | 10367 | 15:44:32 INFO - PROCESS | 10367 | [#1] ext.html Cycles:180 Average:51023.12 Median:21234.71 stddev:86052.14 (405.2%) stddev-sans-first:86210.21 15:44:32 INFO - PROCESS | 10367 | Values: 585.9 601.7 606.1 617.5 623.2 46141.3 47171.0 47317.5 47423.3 50106.5 46597.5 47135.0 47270.3 47285.5 47319.8 8193.6 9052.9 9209.0 9210.9 10705.2 10735.4 11139.2 11142.4 11153.4 11155.4 11142.9 11252.3 11264.7 11267.6 11269.2 11064.6 11151.3 11189.6 11199.6 11201.0 10939.1 10944.3 10997.4 10998.4 11000.8 44790.6 44954.8 45199.0 45216.1 45313.3 3712.9 3723.6 3754.9 3866.0 4212.7 34315.8 34865.8 34931.8 35038.6 35142.8 3959.1 4009.9 4013.6 4101.2 4118.0 357234.0 358848.0 358872.0 359775.0 361002.2 62494.4 62691.0 62753.0 62849.0 62990.7 64978.8 65025.7 65167.3 65184.3 65250.0 17262.7 17539.6 17568.2 17568.7 17592.9 12252.4 12837.2 13027.3 13204.1 13342.0 18342.8 18392.9 18417.0 18450.7 18702.2 6025.7 6110.8 6226.8 6264.0 6315.2 811.6 922.4 1039.5 1098.9 1130.2 33096.7 33172.5 33338.2 33491.2 33822.7 1077.5 1091.1 1093.5 1132.4 1132.6 17069.5 17378.5 17664.6 17677.5 17685.8 164424.1 165386.0 165841.0 166173.0 166695.2 60807.4 60996.0 61043.4 61103.0 61122.4 1221.9 1251.0 1255.1 1351.0 1382.1 23851.4 30281.5 31241.7 33060.0 33161.5 54862.7 55315.0 55325.4 55398.0 55581.8 402904.0 404624.0 405118.0 405746.0 405787.0 37241.6 41832.6 42180.4 42214.6 44062.0 48120.8 49650.0 49843.3 49960.0 49987.0 41946.0 42246.6 42648.6 43262.6 43988.0 41639.6 41678.2 41678.4 42957.6 43430.8 41449.8 42579.1 43285.4 43679.3 44863.0 35786.5 37828.0 38603.4 38803.6 39491.6 27321.6 29212.0 29305.4 29367.0 29597.7 15:44:32 INFO - PROCESS | 10367 | 15:44:32 INFO - PROCESS | 10367 | [#2] jquery.html Cycles:180 Average:29654.41 Median:12868.47 stddev:81541.06 (633.7%) stddev-sans-first:81740.18 15:44:32 INFO - PROCESS | 10367 | Values: 383.0 389.8 391.4 405.0 414.8 13949.0 18578.1 20094.2 20106.7 20668.6 18931.9 19082.1 19200.5 19206.5 19242.1 5418.5 5809.9 5851.4 5852.7 5858.9 4072.2 5755.7 5837.1 5839.7 5861.1 6170.4 6371.4 6410.7 6505.8 6511.1 6300.6 6489.9 6503.2 6510.7 6554.3 5783.4 5784.5 5785.6 5788.4 5789.0 22635.8 23409.6 23461.3 23476.1 23699.0 2327.3 2469.8 2509.9 2554.7 2842.7 14744.5 14746.2 14891.4 14933.3 15276.2 1948.3 1973.9 1983.4 1987.3 2008.2 81061.0 81282.0 81663.0 82544.0 84127.6 10297.5 10367.1 10426.7 10441.2 10638.4 13030.6 13477.2 13493.6 13516.5 14375.4 8001.6 8020.2 8075.5 8117.8 8310.5 7742.0 7811.7 7945.6 7993.7 8009.5 6531.2 6572.6 6644.6 6659.3 6718.4 1918.5 1920.9 1938.1 1944.7 1955.5 909.5 990.7 1013.8 1026.3 1073.6 19382.7 19495.4 19689.5 19782.7 19929.3 1014.9 1015.0 1025.7 1030.3 1056.2 10656.4 11159.7 11181.6 11259.9 11281.4 465816.0 469047.0 494325.0 511591.0 527578.0 79347.6 84024.0 98483.0 100267.0 103127.0 996.8 1013.9 1039.1 1048.7 1056.6 14510.9 16621.5 17773.6 18189.3 18500.2 46581.3 46768.0 46966.0 47393.3 47968.5 60546.4 61835.7 61898.4 62058.4 62430.7 8779.2 8798.3 8860.7 9027.4 9190.0 10120.4 13175.5 13683.4 14012.1 14193.1 11892.3 12016.4 12105.8 12234.1 12399.2 11637.7 11790.4 11949.6 12290.3 12572.2 11956.9 12123.9 12174.6 12294.4 12358.4 8885.7 8957.0 9217.2 9221.5 9292.5 11459.3 11997.0 12054.2 12086.1 12296.6 15:44:32 INFO - PROCESS | 10367 | 15:44:32 INFO - PROCESS | 10367 | [#3] mootools.html Cycles:180 Average:5764.60 Median:4774.05 stddev:3291.54 (68.9%) stddev-sans-first:3283.85 15:44:32 INFO - PROCESS | 10367 | Values: 1323.2 1429.5 1509.6 1606.2 1787.9 8071.8 8302.5 8393.2 8454.4 8951.3 8191.0 8360.3 8507.5 8525.7 8537.0 2024.8 2298.8 2319.1 2364.3 2367.9 2250.4 2283.9 2286.1 2286.3 2290.3 2248.2 2263.9 2273.1 2274.2 2349.2 2161.1 2235.3 2240.6 2247.3 2248.9 2360.8 2375.1 2377.2 2380.9 2383.1 8763.6 8789.4 8843.8 8857.0 8875.8 5145.6 5263.6 5277.2 5280.5 5281.5 3181.0 3205.9 3359.1 3363.9 3365.8 1061.5 1066.3 1075.5 1088.2 1088.5 11615.7 12079.1 12201.3 12314.4 12422.4 4521.6 4605.3 4754.6 4770.8 4777.3 10357.5 10365.9 10381.5 10396.2 10447.6 5267.4 5277.4 5288.0 5290.8 5309.0 4190.7 4347.5 4821.4 4829.4 4894.1 4033.4 4040.3 4147.1 4148.2 4284.5 1264.8 1268.8 1271.9 1275.7 1303.5 989.6 990.5 1002.1 1010.9 1018.2 5900.5 5964.9 6045.5 6168.1 6249.7 465.6 477.5 485.1 485.8 489.2 4085.9 4186.4 4191.8 4242.0 4356.0 10418.2 11031.3 11145.1 11157.3 11179.2 10835.1 10928.9 10937.8 10953.7 10975.1 7949.2 8049.0 8088.8 8091.0 8093.4 6083.6 6239.8 6251.6 6299.7 6445.7 10047.8 10364.5 10521.0 10521.1 10522.2 9429.2 9538.3 9641.4 9864.1 9902.7 7204.0 7347.9 7483.8 7556.5 7680.9 8213.8 8492.8 8510.5 8517.4 8541.4 7664.4 7668.1 7678.8 7851.6 7934.4 7504.5 7671.4 7676.7 7677.7 7762.1 6923.2 7022.6 7094.5 7248.5 7267.8 4951.1 5007.5 5057.8 5083.4 5097.4 5053.9 5170.1 5200.7 5254.8 5305.2 15:44:32 INFO - PROCESS | 10367 | 15:44:32 INFO - PROCESS | 10367 | [#4] prototype.html Cycles:180 Average:4466.13 Median:4936.96 stddev:1291.89 (26.2%) stddev-sans-first:1257.67 15:44:32 INFO - PROCESS | 10367 | Values: 330.4 334.8 338.7 340.4 344.1 5269.6 5304.9 5309.8 5325.9 5344.5 5207.1 5223.5 5262.5 5267.6 5269.9 3939.8 3986.6 3997.3 4060.5 4067.4 3773.6 4139.4 4141.2 4145.6 4151.2 4102.5 4106.1 4109.2 4109.3 4111.4 3947.8 4115.7 4135.9 4138.4 4144.3 3598.4 3640.3 3662.2 3678.3 3689.6 5078.5 5088.0 5091.6 5094.2 5103.3 4699.0 4700.6 4702.4 4704.4 4709.7 5123.8 5346.9 5357.8 5358.3 5398.7 3909.4 3912.0 3919.0 3929.2 3930.2 5368.7 5460.8 5626.2 5642.6 5662.8 3995.7 4012.5 4017.8 4018.1 4021.2 4055.1 4062.0 4063.8 4063.9 4075.5 4509.5 4606.9 4624.0 4626.3 4634.6 5426.6 5445.6 5452.5 5463.8 5464.8 1390.7 1401.4 1403.6 1407.0 1407.3 869.5 903.3 905.2 909.1 917.3 4680.3 4685.3 4689.5 4693.5 4694.2 4918.6 4925.9 4932.7 4933.3 4945.6 4343.7 4667.1 4698.5 4699.4 4703.7 2612.9 2620.7 2626.0 2633.6 2634.3 5083.9 5098.0 5116.9 5125.5 5144.8 4633.6 5011.2 5015.0 5079.3 5081.1 5060.2 5086.2 5115.3 5117.6 5133.5 4916.2 4916.9 4928.4 4940.7 4940.9 4843.5 4891.8 4892.0 5113.7 5538.9 5549.4 5651.4 5852.3 5855.2 5871.2 4036.3 4054.4 4060.7 4067.3 4070.8 5666.9 5687.3 5688.5 5693.4 5698.4 5306.8 5513.4 5523.9 5527.1 5563.6 5490.3 5494.3 5513.0 5514.0 5515.3 5248.5 5450.6 5453.5 5463.9 5489.1 5522.4 5530.9 5537.5 5551.6 5573.7 5416.2 5424.6 5455.0 5455.0 5463.9 15:44:32 INFO - PROCESS | 10367 | 15:44:32 INFO - PROCESS | 10367 | [#5] yui.html Cycles:180 Average:21039.93 Median:4391.58 stddev:30384.47 (691.9%) stddev-sans-first:30431.18 15:44:32 INFO - PROCESS | 10367 | Values: 661.0 730.5 746.5 779.4 803.2 15045.7 16233.0 16259.8 16273.1 16304.0 15772.9 15909.1 15926.4 15926.8 15940.4 664.8 788.7 805.2 821.6 825.4 778.3 779.0 779.5 779.5 781.0 845.2 846.1 846.2 846.3 848.5 704.9 833.3 846.1 855.5 865.9 596.6 600.3 608.3 608.5 609.8 14492.3 14504.2 14529.6 14532.7 14534.1 14671.9 14730.6 14881.4 14983.4 15020.5 13623.5 13710.9 13755.0 13893.0 14066.5 4332.5 4450.6 4475.9 4516.3 4575.2 80625.0 84226.2 84353.2 84690.0 86390.6 11311.2 11418.6 11458.7 11461.1 11805.3 18328.0 18508.4 18521.2 18717.5 18969.9 8642.4 8768.6 8822.8 8846.5 8879.5 4617.4 4677.5 4800.8 4934.6 4946.5 3446.2 3530.0 3533.9 3534.3 3538.8 608.4 611.7 615.3 615.4 627.7 654.3 670.4 680.4 682.5 690.5 9734.0 9975.9 10026.7 10037.4 10044.4 567.5 634.4 649.7 654.4 667.1 4686.8 4885.5 4922.3 4950.9 4977.7 121299.1 125932.0 131459.3 131822.3 132366.0 62534.7 86809.0 87630.0 88796.0 105305.0 72536.3 83344.6 88249.0 91210.5 91966.0 10052.7 10212.2 10337.0 10364.7 10427.6 39420.2 48461.8 52278.0 52546.7 53337.0 53354.2 67601.3 68841.7 69564.2 76646.0 13929.8 14020.8 14021.5 14081.1 14292.4 15259.9 15691.6 16065.8 16108.4 16173.0 14555.7 14577.4 14651.1 14866.7 15303.0 14699.0 14746.9 14996.5 15084.7 15213.9 14095.5 14204.6 14640.5 14981.8 15301.0 11235.0 11722.3 11812.4 11907.9 12654.4 11891.6 11897.4 12162.7 12348.8 12354.8 15:44:32 INFO - PROCESS | 10367 | -------- Summary: end -------- 15:44:32 INFO - PROCESS | 10367 | 15:44:33 INFO - TEST-INFO | 10367: exit 0 15:44:33 INFO - TEST-OK | dromaeo_css | took 1114887ms 15:44:33 INFO - TEST-START | kraken 15:44:33 INFO - operating with platform_type : linux_ 15:44:33 INFO - Initialising browser for kraken test... 15:44:33 INFO - TEST-INFO | started process 10673 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp42Tg1k/profile http://localhost:55262/getInfo.html) 15:44:37 INFO - PROCESS | 10673 | __metrics Screen width/height:1600/1200 15:44:37 INFO - PROCESS | 10673 | colorDepth:24 15:44:37 INFO - PROCESS | 10673 | Browser inner width/height: 1024/697 15:44:37 INFO - PROCESS | 10673 | __metrics 15:44:38 INFO - PROCESS | 10673 | 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" 15:44:38 INFO - PROCESS | 10673 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:44:38 INFO - PROCESS | 10673 | console.error: PushService: 15:44:38 INFO - PROCESS | 10673 | stateChangeProcessEnqueue: Error transitioning state 15:44:38 INFO - PROCESS | 10673 | UnknownError 15:44:38 INFO - TEST-INFO | 10673: exit 0 15:44:38 INFO - Browser initialized. 15:44:38 INFO - Running cycle 1/1 for kraken test... 15:44:39 INFO - TEST-INFO | started process 10755 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp42Tg1k/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:44:50 INFO - PROCESS | 10755 | RSS: Main: 156938240 15:44:50 INFO - PROCESS | 10755 | 15:44:53 INFO - PROCESS | 10755 | Cycle 1(1): loaded http://localhost:55262/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55262/tests/kraken/driver.html?testName=audio-beat-detection) 15:44:54 INFO - PROCESS | 10755 | RSS: Main: 213577728 15:44:54 INFO - PROCESS | 10755 | 15:44:56 INFO - PROCESS | 10755 | Cycle 1(1): loaded http://localhost:55262/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55262/tests/kraken/driver.html?testName=audio-dft) 15:44:57 INFO - PROCESS | 10755 | RSS: Main: 191930368 15:44:57 INFO - PROCESS | 10755 | 15:45:00 INFO - PROCESS | 10755 | Cycle 1(1): loaded http://localhost:55262/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55262/tests/kraken/driver.html?testName=audio-fft) 15:45:01 INFO - PROCESS | 10755 | RSS: Main: 270225408 15:45:01 INFO - PROCESS | 10755 | 15:45:03 INFO - PROCESS | 10755 | Cycle 1(1): loaded http://localhost:55262/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55262/tests/kraken/driver.html?testName=audio-oscillator) 15:45:03 INFO - PROCESS | 10755 | RSS: Main: 180039680 15:45:03 INFO - PROCESS | 10755 | 15:45:05 INFO - PROCESS | 10755 | Cycle 1(1): loaded http://localhost:55262/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55262/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:45:06 INFO - PROCESS | 10755 | RSS: Main: 184422400 15:45:06 INFO - PROCESS | 10755 | 15:45:09 INFO - PROCESS | 10755 | Cycle 1(1): loaded http://localhost:55262/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55262/tests/kraken/driver.html?testName=imaging-darkroom) 15:45:10 INFO - PROCESS | 10755 | RSS: Main: 219500544 15:45:10 INFO - PROCESS | 10755 | 15:45:13 INFO - PROCESS | 10755 | Cycle 1(1): loaded http://localhost:55262/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55262/tests/kraken/driver.html?testName=imaging-desaturate) 15:45:14 INFO - PROCESS | 10755 | RSS: Main: 220127232 15:45:14 INFO - PROCESS | 10755 | 15:45:16 INFO - PROCESS | 10755 | Cycle 1(1): loaded http://localhost:55262/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55262/tests/kraken/driver.html?testName=json-parse-financial) 15:45:17 INFO - PROCESS | 10755 | RSS: Main: 219549696 15:45:17 INFO - PROCESS | 10755 | 15:45:19 INFO - PROCESS | 10755 | Cycle 1(1): loaded http://localhost:55262/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55262/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:45:19 INFO - PROCESS | 10755 | RSS: Main: 184172544 15:45:19 INFO - PROCESS | 10755 | 15:45:21 INFO - PROCESS | 10755 | Cycle 1(1): loaded http://localhost:55262/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55262/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:45:22 INFO - PROCESS | 10755 | RSS: Main: 189288448 15:45:22 INFO - PROCESS | 10755 | 15:45:23 INFO - PROCESS | 10755 | Cycle 1(1): loaded http://localhost:55262/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55262/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:45:24 INFO - PROCESS | 10755 | RSS: Main: 194568192 15:45:24 INFO - PROCESS | 10755 | 15:45:27 INFO - PROCESS | 10755 | Cycle 1(1): loaded http://localhost:55262/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55262/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:45:27 INFO - PROCESS | 10755 | RSS: Main: 189988864 15:45:27 INFO - PROCESS | 10755 | 15:45:30 INFO - PROCESS | 10755 | Cycle 1(1): loaded http://localhost:55262/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55262/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:45:31 INFO - PROCESS | 10755 | RSS: Main: 192548864 15:45:31 INFO - PROCESS | 10755 | 15:45:32 INFO - PROCESS | 10755 | Cycle 1(1): loaded http://localhost:55262/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55262/tests/kraken/driver.html?testName=ai-astar) 15:45:33 INFO - PROCESS | 10755 | RSS: Main: 243625984 15:45:33 INFO - PROCESS | 10755 | 15:45:33 INFO - PROCESS | 10755 | __start_tp_report 15:45:33 INFO - PROCESS | 10755 | _x_x_mozilla_page_load 15:45:33 INFO - PROCESS | 10755 | _x_x_mozilla_page_load_details 15:45:33 INFO - PROCESS | 10755 | |i|pagename|runs| 15:45:33 INFO - PROCESS | 10755 | |0;ai-astar;101;111;109;110;112;111;109;112;111;110 15:45:33 INFO - PROCESS | 10755 | |1;audio-beat-detection;148;116;118;185;117;123;145;116;159;117 15:45:33 INFO - PROCESS | 10755 | |2;audio-dft;160;159;162;161;160;161;162;162;163;161 15:45:33 INFO - PROCESS | 10755 | |3;audio-fft;75;76;75;115;74;75;75;75;99;76 15:45:33 INFO - PROCESS | 10755 | |4;audio-oscillator;83;84;112;84;83;83;119;83;84;124 15:45:33 INFO - PROCESS | 10755 | |5;imaging-gaussian-blur;117;116;117;116;117;117;118;117;117;117 15:45:33 INFO - PROCESS | 10755 | |6;imaging-darkroom;146;146;146;146;146;146;147;147;146;145 15:45:33 INFO - PROCESS | 10755 | |7;imaging-desaturate;94;95;95;94;96;95;95;95;95;95 15:45:33 INFO - PROCESS | 10755 | |8;json-parse-financial;51;50;50;50;49;52;50;50;50;50 15:45:33 INFO - PROCESS | 10755 | |9;json-stringify-tinderbox;60;61;59;59;61;60;60;65;61;60 15:45:33 INFO - PROCESS | 10755 | |10;stanford-crypto-aes;76;76;76;75;76;75;76;76;76;76 15:45:33 INFO - PROCESS | 10755 | |11;stanford-crypto-ccm;124;136;129;126;122;121;122;117;153;127 15:45:33 INFO - PROCESS | 10755 | |12;stanford-crypto-pbkdf2;159;161;157;159;157;157;158;163;161;160 15:45:33 INFO - PROCESS | 10755 | |13;stanford-crypto-sha256-iterative;66;64;63;67;65;64;62;62;62;62 15:45:33 INFO - PROCESS | 10755 | __end_tp_report 15:45:33 INFO - PROCESS | 10755 | __start_cc_report 15:45:33 INFO - PROCESS | 10755 | _x_x_mozilla_cycle_collect,1643 15:45:33 INFO - PROCESS | 10755 | __end_cc_report 15:45:33 INFO - PROCESS | 10755 | __startTimestamp1470350733038__endTimestamp 15:45:33 INFO - PROCESS | 10755 | 15:45:33 INFO - PROCESS | 10755 | ------- Summary: start ------- 15:45:33 INFO - PROCESS | 10755 | Number of tests: 14 15:45:33 INFO - PROCESS | 10755 | 15:45:33 INFO - PROCESS | 10755 | [#0] ai-astar Cycles:10 Average:109.60 Median:111.00 stddev:3.20 (2.9%) stddev-sans-first:1.13 15:45:33 INFO - PROCESS | 10755 | Values: 101.0 111.0 109.0 110.0 112.0 111.0 109.0 112.0 111.0 110.0 15:45:33 INFO - PROCESS | 10755 | 15:45:33 INFO - PROCESS | 10755 | [#1] audio-beat-detection Cycles:10 Average:134.40 Median:134.00 stddev:23.91 (17.8%) stddev-sans-first:24.85 15:45:33 INFO - PROCESS | 10755 | Values: 148.0 116.0 118.0 185.0 117.0 123.0 145.0 116.0 159.0 117.0 15:45:33 INFO - PROCESS | 10755 | 15:45:33 INFO - PROCESS | 10755 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.50 stddev:1.20 (0.7%) stddev-sans-first:1.20 15:45:33 INFO - PROCESS | 10755 | Values: 160.0 159.0 162.0 161.0 160.0 161.0 162.0 162.0 163.0 161.0 15:45:33 INFO - PROCESS | 10755 | 15:45:33 INFO - PROCESS | 10755 | [#3] audio-fft Cycles:10 Average:81.50 Median:75.00 stddev:13.97 (18.6%) stddev-sans-first:14.62 15:45:33 INFO - PROCESS | 10755 | Values: 75.0 76.0 75.0 115.0 74.0 75.0 75.0 75.0 99.0 76.0 15:45:33 INFO - PROCESS | 10755 | 15:45:33 INFO - PROCESS | 10755 | [#4] audio-oscillator Cycles:10 Average:93.90 Median:83.00 stddev:17.10 (20.6%) stddev-sans-first:17.68 15:45:33 INFO - PROCESS | 10755 | Values: 83.0 84.0 112.0 84.0 83.0 83.0 119.0 83.0 84.0 124.0 15:45:33 INFO - PROCESS | 10755 | 15:45:33 INFO - PROCESS | 10755 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 15:45:33 INFO - PROCESS | 10755 | Values: 117.0 116.0 117.0 116.0 117.0 117.0 118.0 117.0 117.0 117.0 15:45:33 INFO - PROCESS | 10755 | 15:45:33 INFO - PROCESS | 10755 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 15:45:33 INFO - PROCESS | 10755 | Values: 146.0 146.0 146.0 146.0 146.0 146.0 147.0 147.0 146.0 145.0 15:45:33 INFO - PROCESS | 10755 | 15:45:33 INFO - PROCESS | 10755 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.50 15:45:33 INFO - PROCESS | 10755 | Values: 94.0 95.0 95.0 94.0 96.0 95.0 95.0 95.0 95.0 95.0 15:45:33 INFO - PROCESS | 10755 | 15:45:33 INFO - PROCESS | 10755 | [#8] json-parse-financial Cycles:10 Average:50.20 Median:50.00 stddev:0.79 (1.6%) stddev-sans-first:0.78 15:45:33 INFO - PROCESS | 10755 | Values: 51.0 50.0 50.0 50.0 49.0 52.0 50.0 50.0 50.0 50.0 15:45:33 INFO - PROCESS | 10755 | 15:45:33 INFO - PROCESS | 10755 | [#9] json-stringify-tinderbox Cycles:10 Average:60.60 Median:60.50 stddev:1.71 (2.8%) stddev-sans-first:1.80 15:45:33 INFO - PROCESS | 10755 | Values: 60.0 61.0 59.0 59.0 61.0 60.0 60.0 65.0 61.0 60.0 15:45:33 INFO - PROCESS | 10755 | 15:45:33 INFO - PROCESS | 10755 | [#10] stanford-crypto-aes Cycles:10 Average:75.80 Median:76.00 stddev:0.42 (0.6%) stddev-sans-first:0.44 15:45:33 INFO - PROCESS | 10755 | Values: 76.0 76.0 76.0 75.0 76.0 75.0 76.0 76.0 76.0 76.0 15:45:33 INFO - PROCESS | 10755 | 15:45:33 INFO - PROCESS | 10755 | [#11] stanford-crypto-ccm Cycles:10 Average:127.70 Median:126.50 stddev:10.29 (8.1%) stddev-sans-first:10.82 15:45:33 INFO - PROCESS | 10755 | Values: 124.0 136.0 129.0 126.0 122.0 121.0 122.0 117.0 153.0 127.0 15:45:33 INFO - PROCESS | 10755 | 15:45:33 INFO - PROCESS | 10755 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.20 Median:159.50 stddev:2.04 (1.3%) stddev-sans-first:2.17 15:45:33 INFO - PROCESS | 10755 | Values: 159.0 161.0 157.0 159.0 157.0 157.0 158.0 163.0 161.0 160.0 15:45:33 INFO - PROCESS | 10755 | 15:45:33 INFO - PROCESS | 10755 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.70 Median:64.00 stddev:1.83 (2.9%) stddev-sans-first:1.74 15:45:33 INFO - PROCESS | 10755 | Values: 66.0 64.0 63.0 67.0 65.0 64.0 62.0 62.0 62.0 62.0 15:45:33 INFO - PROCESS | 10755 | -------- Summary: end -------- 15:45:33 INFO - PROCESS | 10755 | 15:45:34 INFO - TEST-INFO | 10755: exit 0 15:45:34 INFO - TEST-OK | kraken | took 60876ms 15:45:34 INFO - SUITE-END | took 1175s 15:45:34 INFO - Completed test suite (00:19:35) 15:45:34 INFO - javascript benchmark 15:45:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2987.910362689119, 3006.143249173983, 3027.9697203027963, 3030.1969977955846, 3046.7867249292544, 5142.331496905402, 5153.81961631343, 5227.764750586223, 5241.423443421226, 5309.8938021239555, 5225.372955245366, 5258.211268309756, 5309.5752339812725, 5313.628046036779, 5353.544948679357, 4763.071201115784, 4808.2547205183255, 4835.734034628112, 4837.226043832988, 4941.678790878582, 4785.306130611059, 4910.116179087763, 4960.156773348522, 4964.404271487427, 4970.030843985424, 4883.413990321149, 4927.1870141426625, 4929.950700492985, 4935.407751069876, 4961.925571116418, 4685.461171965199, 4721.457032441244, 4731.290306454025, 4757.976210118927, 4831.734254615994, 4678.087772884289, 4703.365045718852, 4712.175369310391, 4780.617550595944, 4802.59177969873, 5174.43081261061, 5237.3453318335205, 5245.527902488756, 5263.631545791796, 5273.2617433559335, 5443.863903402446, 5604.495595396393, 5692.0608099663505, 5696.829095127153, 5701.059325211335, 5661.037623603997, 5701.857453563653, 5710.7430165642645, 5716.314042314907, 5729.427057294279, 5103.132467480537, 5337.172738225581, 5341.4925582069645, 5347.866303342447, 5349.946500535023, 5586.1062230043, 5623.550115990711, 5630.211770352154, 5722.54219662426, 5723.427657234327, 5434.3207099112615, 5436.320459942507, 5487.067198576252, 5493.615446918678, 5498.0, 5432.29380180574, 5564.554835613141, 5570.0, 5571.164325351229, 5575.832725018256, 5413.756380962866, 5429.891402172014, 5445.1832225166545, 5475.479829416199, 5510.338759348904, 5451.863703407446, 5462.562994960473, 5468.0, 5469.699166545878, 5472.0, 4174.102567947845, 4225.176090662353, 4256.36154576816, 4259.169461954889, 4286.421333120051, 3790.431435284674, 3825.139343647713, 3829.272438236726, 3837.865674701372, 3852.499175107218, 5186.6369354144845, 5206.739663016834, 5211.0, 5216.321878155892, 5259.289995850588, 5396.1366181410785, 5514.972425137848, 5527.198556209327, 5539.778408863681, 5554.333479982428, 5253.947460525345, 5299.152135658276, 5327.200919862052, 5371.221172929982, 5371.75827087782, 4814.422269327633, 4833.782479788418, 4871.391076115486, 4879.73126986986, 4882.950165714388, 5630.634008789498, 5773.1051686988585, 5915.645061296336, 5925.4074592541265, 5931.792387266425, 5562.860928476821, 5624.184493248538, 5645.125005624135, 5667.40492248308, 5680.431956804452, 5817.2146760188525, 5819.127130930395, 5827.388124246893, 5835.591508594358, 5836.620619659709, 5219.0, 5321.095413779744, 5524.861878453071, 5532.336119665505, 5542.806001789918, 5419.187121931742, 5464.153056276284, 5470.425605311385, 5508.614396992172, 5525.696086715108, 5359.062164121186, 5410.107332290128, 5411.540019098264, 5413.323334583177, 5431.103867861759, 5228.294180285765, 5400.918986215132, 5405.189221616789, 5440.047991601533, 5449.264349312792, 5363.249145119608, 5487.6158668894395, 5492.340919089735, 5521.309836270466, 5542.667439953616, 5571.832845014656, 5582.441755824385, 5613.775448982158, 5619.775208991595, 5623.915641265467, 5154.587632989277, 5410.891782164414, 5461.9453805461435, 5462.590305727166, 5472.288602481811], "value": 5160.816699609547, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [585.9209006784083, 601.7213421479356, 606.0969155957623, 617.4782308948936, 623.224086012914, 46141.30788038182, 47171.0, 47317.52682473174, 47423.28865067027, 50106.49893501064, 46597.53402465974, 47135.0, 47270.29094563576, 47285.52714472854, 47319.76340118303, 8193.590320483981, 9052.90947090529, 9208.953955230249, 9210.907890921106, 10705.197110216726, 10735.40955247461, 11139.220254582182, 11142.442877856116, 11153.442327883615, 11155.38645374504, 11142.888571114267, 11252.26860254081, 11264.718382040433, 11267.60563380282, 11269.211155219138, 11064.612738554153, 11151.330920144817, 11189.608363707313, 11199.552017919274, 11200.99999999996, 10939.070179034792, 10944.288621239593, 10997.395143267117, 10998.395088270141, 11000.834987475195, 44790.55209447896, 44954.77522612399, 45199.0, 45216.095678086254, 45313.320300195526, 3712.851485940559, 3723.553173619156, 3754.9249015019545, 3866.0, 4212.726172798758, 34315.828420857986, 34865.82567087174, 34931.82534087339, 35038.649613503796, 35142.82428587866, 3959.1487830116375, 4009.939850902239, 4013.5986401359633, 4101.159262351241, 4117.97941010293, 357234.0, 358848.0, 358872.0, 359775.0, 361002.194989026, 62494.37505624886, 62691.0, 62753.0, 62849.0, 62990.68504657447, 64978.75106244669, 65025.69948601002, 65167.34832651613, 65184.34815651783, 65250.0, 17262.65474690499, 17539.56151096233, 17568.209430575655, 17568.736468952975, 17592.912035439742, 12252.44863981123, 12837.165584236995, 13027.283499407435, 13204.14173078766, 13342.0, 18342.816571834377, 18392.908035460005, 18417.0, 18450.723239151423, 18702.158402871904, 6025.698715064229, 6110.786122485781, 6226.844328891814, 6264.0, 6315.242170939517, 811.5901469757735, 922.391221793613, 1039.5218199628255, 1098.8626421697288, 1130.2370899642872, 33096.66903330984, 33172.50241246383, 33338.166545836066, 33491.1579863105, 33822.661773382446, 1077.5043479999288, 1091.1489038549944, 1093.5133865429807, 1132.416805345248, 1132.5526417065214, 17069.48791536256, 17378.47864564065, 17664.646707065785, 17677.469675909742, 17685.82314176842, 164424.13455192727, 165386.0, 165841.0, 166173.0, 166695.16652416904, 60807.39192608017, 60996.0, 61043.389566104655, 61103.0, 61122.38877611167, 1221.9389030548614, 1251.0117007564104, 1255.12768625806, 1350.9662258443618, 1382.0947279531922, 23851.403714907265, 30281.545776813808, 31241.68758312388, 33060.0, 33161.50257746087, 54862.72568637131, 55315.0, 55325.44674553203, 55398.0, 55581.77672893201, 402904.0, 404624.0, 405118.0, 405746.0, 405787.0, 37241.62758372381, 41832.58167418287, 42180.367294489995, 42214.57785422107, 44062.0, 48120.7593962028, 49650.0, 49843.25235121549, 49960.0, 49987.0, 41946.0, 42246.57753422426, 42648.5735142657, 43262.56737432585, 43988.0, 41639.58360416357, 41678.16643667049, 41678.37482437705, 42957.57042429536, 43430.78284608557, 41449.79275103605, 42579.14841703087, 43285.35071973986, 43679.34480982724, 44863.0, 35786.463203051455, 37828.0, 38603.420948686355, 38803.61196388113, 39491.605083948794, 27321.590176146976, 29212.0, 29305.41389172162, 29367.0, 29597.704022959493], "value": 20549.625474754124, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.9674477669398, 389.83626876711776, 391.40311025685827, 404.9979750101249, 414.75322183300943, 13949.0, 18578.071096445175, 20094.196232150716, 20106.69839952402, 20668.58662826746, 18931.905340473313, 19082.141303641336, 19200.51998700033, 19206.51983700408, 19242.13410396532, 5418.539424148942, 5809.883802323951, 5851.356350801409, 5852.736626851802, 5858.912116318259, 4072.1652061327504, 5755.68343741094, 5837.066069428893, 5839.708014599274, 5861.1208318752315, 6170.413810687977, 6371.39471750183, 6410.743570257184, 6505.772297969572, 6511.12099866519, 6300.621962682254, 6489.902651460232, 6503.154589903306, 6510.739570417178, 6554.279029306773, 5783.363829978699, 5784.537237021028, 5785.623934444247, 5788.363280039192, 5789.0, 22635.77364226353, 23409.648855267184, 23461.296161115195, 23476.060957561676, 23699.0, 2327.290176496168, 2469.8271121021535, 2509.8619575923317, 2554.7062087859763, 2842.701516340775, 14744.483943061941, 14746.188959607218, 14891.404343826342, 14933.328000239906, 15276.236188190545, 1948.3375652278153, 1973.851961102923, 1983.4347211044783, 1987.2945104487844, 2008.2167954497756, 81061.0, 81282.0, 81663.0, 82544.0, 84127.5793621028, 10297.485125743682, 10367.066963973279, 10426.68719938403, 10441.216908731723, 10638.361698298128, 13030.609081727564, 13477.19136851792, 13493.5711571918, 13516.5269215577, 14375.424983000772, 8001.5599142046585, 8020.197980201933, 8075.475094118863, 8117.756467305991, 8310.459820111673, 7742.0, 7811.68753249875, 7945.602719863984, 7993.681042627902, 8009.519428834172, 6531.183602049744, 6572.638504882182, 6644.634545099969, 6659.334066593302, 6718.428933540606, 1918.4915997260737, 1920.9423717288503, 1938.139386189274, 1944.669406200921, 1955.5208973801225, 909.4815954905772, 990.6780296403698, 1013.7871047080048, 1026.3072426112494, 1073.6295977887617, 19382.70925936112, 19495.415137545897, 19689.50776230577, 19782.70325945112, 19929.302474413325, 1014.9289549731595, 1014.974625634365, 1025.738436698652, 1030.314840630987, 1056.2395075545594, 10656.413897235727, 11159.665210043711, 11181.608643697431, 11259.887401126047, 11281.435928203557, 465816.0, 469047.0, 494325.0, 511591.0, 527578.0, 79347.60326198448, 84024.0, 98483.0, 100267.0, 103127.0, 996.8169708338716, 1013.8834034086027, 1039.101177481488, 1048.7168464514386, 1056.6248981611418, 14510.854891451372, 16621.50135495937, 17773.644527109645, 18189.272429102686, 18500.167492462602, 46581.30128048014, 46768.0, 46966.0, 47393.28910066283, 47968.520314796406, 60546.394536055835, 61835.690821545606, 61898.381016191066, 62058.37941620706, 62430.687846560475, 8779.20987111163, 8798.34012449056, 8860.734177974671, 9027.4132181408, 9190.0, 10120.443375614412, 13175.47298108065, 13683.384247708678, 14012.089214201043, 14193.148411095368, 11892.286462812259, 12016.399180041139, 12105.81841272364, 12234.055807787758, 12399.194052386567, 11637.650870473899, 11790.351530665896, 11949.581764638197, 12290.324032177958, 12572.182808117443, 11956.880431195925, 12123.878761212274, 12174.634760957186, 12294.446749896455, 12358.44387002605, 8885.733427996913, 8957.0, 9217.170454659114, 9221.538923053955, 9292.488913109844, 11459.255148415326, 11997.0, 12054.15620906528, 12086.093542984136, 12296.631101066982], "value": 9584.003984761044, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1323.166405164746, 1429.463951018368, 1509.6301406155494, 1606.2370374072318, 1787.8837875538097, 8071.757847264576, 8302.543360115198, 8393.16068393162, 8454.408191426603, 8951.328650351217, 8191.0, 8360.289375403083, 8507.489550626966, 8525.744227673164, 8537.0, 2024.7975202479709, 2298.839081264312, 2319.141917490531, 2364.337985364092, 2367.893444794988, 2250.4148921280503, 2283.8858057097077, 2286.0969916882823, 2286.2912497125863, 2290.3129061281634, 2248.2243625949022, 2263.9434014149697, 2273.113485740554, 2274.1699279762934, 2349.189529612281, 2161.1139432832465, 2235.3182279404773, 2240.574290884727, 2247.292102987554, 2248.9212877549207, 2360.7639236076425, 2375.09746296408, 2377.239283429303, 2380.8690522021284, 2383.07060246504, 8763.561821908943, 8789.428687135316, 8843.778905527413, 8856.955715221447, 8875.822483550293, 5145.614078944094, 5263.578913686896, 5277.155655095166, 5280.52475277223, 5281.498257665516, 3180.9840950795096, 3205.9198520036953, 3359.1266270769534, 3363.915902102467, 3365.7812242204423, 1061.506399524225, 1066.3441983180367, 1075.5267682219799, 1088.1729885287239, 1088.542812018954, 11615.651530454015, 12079.09406794494, 12201.267923924594, 12314.384280786015, 12422.37888105591, 4521.615662668644, 4605.309203619417, 4754.643401744883, 4770.76146192689, 4777.331173635694, 10357.482125893675, 10365.948170259251, 10381.532831022621, 10396.22028347877, 10447.582096716198, 5267.367915850123, 5277.419483856773, 5288.021715982555, 5290.841274761763, 5309.044372012998, 4190.748555086705, 4347.5217726050105, 4821.373221481185, 4829.372181616367, 4894.143524883131, 4033.4353190553347, 4040.252553277653, 4147.087640719037, 4148.23257697327, 4284.485861696617, 1264.759695657822, 1268.7652784234947, 1271.9300438475786, 1275.655572995286, 1303.4590644882458, 989.5893204320271, 990.4849478271259, 1002.1031177096604, 1010.9140723038624, 1018.2108865629197, 5900.4984576310635, 5964.850878728066, 6045.455908968214, 6168.136460895478, 6249.6875156242, 465.6368032934317, 477.45093142885264, 485.13645710635126, 485.77168730696513, 489.207483876123, 4085.9182816343505, 4186.35111557709, 4191.790410479463, 4241.957580424218, 4355.956440435619, 10418.166546676248, 11031.338119712844, 11145.052670522935, 11157.27477713946, 11179.161562882817, 10835.079018283377, 10928.890711092947, 10937.781244375068, 10953.726156845983, 10975.121990240921, 7949.205079492121, 8048.959755201186, 8088.8382232355025, 8091.029076510857, 8093.3929955252415, 6083.574149809471, 6239.812805615838, 6251.624902505864, 6299.716512756845, 6445.677716114082, 10047.799044019224, 10364.481775911325, 10521.0, 10521.053105220566, 10522.210834187314, 9429.198518126037, 9538.28462865274, 9641.37331073478, 9864.112229899343, 9902.653407131003, 7203.955426463029, 7347.8530429392185, 7483.812904677427, 7556.546607203585, 7680.884786728316, 8213.79465513343, 8492.787680308042, 8510.531920744419, 8517.361197910057, 8541.402101852811, 7664.386849052174, 7668.108140498917, 7678.769636910902, 7851.56816375082, 7934.365250780039, 7504.549727016397, 7671.424643151674, 7676.692932282646, 7677.654505547152, 7762.1073576537165, 6923.2038315594355, 7022.648867556704, 7094.467914906506, 7248.528845625228, 7267.818304542428, 4951.084049450719, 5007.474215207497, 5057.8229761958155, 5083.415407228216, 5097.413797413345, 5053.949460505495, 5170.146925757208, 5200.6619569727845, 5254.7898084076205, 5305.2307415423775], "value": 4538.727329875985, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [330.3970254285928, 334.7673367009929, 338.6934823984295, 340.3957974595095, 344.06242987858076, 5269.6311258211945, 5304.920426193606, 5309.761060752266, 5325.946740532593, 5344.545713614342, 5207.088759467088, 5223.537409525329, 5262.500062494057, 5267.578593712504, 5269.947300526994, 3939.763614183158, 3986.6013398660193, 3997.2804895118866, 4060.472138621975, 4067.440989134507, 3773.64150405711, 4139.379093136024, 4141.192467468844, 4145.5647157048525, 4151.169766046788, 4102.5076990761, 4106.137711080677, 4109.178164367138, 4109.301418758803, 4111.424400583921, 3947.7631342119275, 4115.691323150761, 4135.91728165435, 4138.358554424069, 4144.274751918432, 3598.352296586613, 3640.290143422034, 3662.1872173274132, 3678.2643471305846, 3689.6163938523055, 5078.4921507849285, 5088.0, 5091.567216786578, 5094.210397388374, 5103.260027296058, 4698.976505117486, 4700.623950083985, 4702.365180700596, 4704.388429504143, 4709.71741695496, 5123.8206662767, 5346.866328341823, 5357.785688572452, 5358.347617929111, 5398.676079435247, 3909.3745000799736, 3911.9608803911883, 3918.9804050979847, 3929.2337994091163, 3930.1746633207063, 5368.677879327252, 5460.7542660579975, 5626.186906546726, 5642.633228840113, 5662.839117980845, 3995.6603688686787, 4012.518497780285, 4017.8392864285684, 4018.0557568971267, 4021.195760847842, 4055.1346380665223, 4062.0, 4063.776492292893, 4063.9390409143884, 4075.4701888754867, 4509.549045095529, 4606.907861842745, 4623.959609087996, 4626.306054091846, 4634.606058485067, 5426.647267927572, 5445.646033007842, 5452.536534394541, 5463.781448742086, 5464.754086066137, 1390.7427125981726, 1401.4464286606938, 1403.5578792680274, 1406.985930140706, 1407.2893188939724, 869.5043825019678, 903.3089686389917, 905.1536813079791, 909.0999910088964, 917.3440989692402, 4680.251159814481, 4685.250359942393, 4689.484156742756, 4693.460252070987, 4694.201985662446, 4918.631102667314, 4925.872071234791, 4932.7286999215385, 4933.260010998379, 4945.579625731782, 4343.7176583522605, 4667.089917466129, 4698.483166851644, 4699.412573428322, 4703.670743048022, 2612.9216123516326, 2620.6724159480063, 2625.9868700656375, 2633.578627419604, 2634.3414146463383, 5083.8983220335385, 5098.0, 5116.927644304063, 5125.461826508237, 5144.794208231704, 4633.62930965522, 5011.218773580697, 5015.04714104319, 5079.3396858408905, 5081.110805609003, 5060.2156665716875, 5086.2017300276975, 5115.258287548285, 5117.596798129277, 5133.456890651725, 4916.237983112624, 4916.901661966812, 4928.4475390251955, 4940.654154209171, 4940.912999140183, 4843.467218606021, 4891.80432782699, 4892.0, 5113.693178409308, 5538.944610553843, 5549.44505549458, 5651.350094739158, 5852.297724273115, 5855.2095467113095, 5871.236739223874, 4036.2936486114227, 4054.432379466936, 4060.675145988255, 4067.2882245607493, 4070.7964601770386, 5666.943330566642, 5687.317521897234, 5688.516476099578, 5693.430656934273, 5698.430156984268, 5306.761195746278, 5513.365962914316, 5523.861903452285, 5527.143292789624, 5563.58273129525, 5490.286262785812, 5494.340679118532, 5512.9877594678455, 5514.007478653721, 5515.310586176728, 5248.506959194505, 5450.645708028966, 5453.454654534515, 5463.885585216389, 5489.149181876815, 5522.3649280333275, 5530.866172434722, 5537.535796570487, 5551.583631227593, 5573.693446860461, 5416.21464887597, 5424.616722735677, 5454.972725136349, 5454.990826697073, 5463.890722185454], "value": 4059.7867736680196, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [660.9801705948823, 730.517858213579, 746.5222257755034, 779.403756126563, 803.2008151888867, 15045.699086018287, 16233.0, 16259.83740162598, 16273.104979226153, 16304.0, 15772.921135394336, 15909.124998125099, 15926.442574509894, 15926.84073159268, 15940.442084527043, 664.7806223946086, 788.7476007677545, 805.2068712318362, 821.6343727041469, 825.3768404854357, 778.2956424435866, 779.0223269796397, 779.5011192836589, 779.5283853268776, 781.0471225105363, 845.188618925832, 846.1200351634293, 846.174979395091, 846.3102571404286, 848.5375470368633, 704.936555709986, 833.2792134803412, 846.0608724316004, 855.5080828523562, 865.8614621660568, 596.6420147911261, 600.2676734384045, 608.2700759089066, 608.5223099866583, 609.7713357490941, 14492.27538623075, 14504.202268875208, 14529.636759081108, 14532.70934581313, 14534.12795232279, 14671.853281467262, 14730.631734206623, 14881.404743810235, 14983.400663973536, 15020.474283400137, 13623.455061797516, 13710.862891371058, 13755.0, 13892.95802814793, 14066.507672231422, 4332.545082766327, 4450.621697155746, 4475.932861007088, 4516.277395616718, 4575.1993401155, 80625.0, 84226.15773842306, 84353.15646843515, 84690.0, 86390.56804715999, 11311.151663625262, 11418.600348987746, 11458.656240312805, 11461.140414468948, 11805.291682499077, 18328.0, 18508.44474665762, 18521.166547505396, 18717.532061698566, 18969.90515047416, 8642.351823613128, 8768.649254029895, 8822.77943051416, 8846.513441760637, 8879.511626860456, 4617.399738034102, 4677.532246775295, 4800.831970881002, 4934.580560652313, 4946.455889852114, 3446.172918499542, 3529.982350088233, 3533.858645654145, 3534.257805860798, 3538.805365704911, 608.4189598933008, 611.703323887914, 615.3323643846477, 615.3538784276492, 627.6987046217749, 654.3489228217953, 670.3832474123818, 680.3978479046079, 682.5324652612976, 690.453384418898, 9734.0, 9975.850362244571, 10026.69919902404, 10037.397756134655, 10044.397336159855, 567.5431277821311, 634.3751404866204, 649.694643517546, 654.3750718064238, 667.1160712056544, 4686.7656617169005, 4885.511448855086, 4922.286268491049, 4950.9009819803405, 4977.65156439053, 121299.0506091793, 125932.0, 131459.34270328586, 131822.34088829494, 132366.0, 62534.68732656308, 86809.0, 87630.0, 88796.0, 105305.0, 72536.27463725401, 83344.58327708322, 88249.0, 91210.54394727983, 91966.0, 10052.673424766623, 10212.183025358103, 10337.0, 10364.740881478023, 10427.582896684047, 39420.211595768495, 48461.75769121132, 52278.0, 52546.73726631342, 53337.0, 53354.1996870055, 67601.3239867595, 68841.65579172272, 69564.2174313042, 76646.0, 13929.791053134413, 14020.789688154482, 14021.5092471763, 14081.08472949255, 14292.42830286777, 15259.923700381427, 15691.607709807346, 16065.75901361504, 16108.355665773237, 16173.0, 14555.708885822436, 14577.416903323749, 14651.12093274407, 14866.702665946405, 15303.0, 14699.0, 14746.926265369033, 14996.47512337063, 15084.698306034037, 15213.923930380277, 14095.506657267357, 14204.573862784133, 14640.487582934546, 14981.77527337069, 15301.0, 11234.988851003449, 11722.296662200295, 11812.409379530816, 11907.94046029799, 12654.430550625428, 11891.643250702147, 11897.405129743305, 12162.695932601755, 12348.753024939631, 12354.75290494203], "value": 7680.497033228125, "unit": "score"}], "name": "dromaeo_css", "value": 7238.650882005046, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 111.0, 109.0, 110.0, 112.0, 111.0, 109.0, 112.0, 111.0, 110.0], "value": 109.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 116.0, 118.0, 185.0, 117.0, 123.0, 145.0, 116.0, 159.0, 117.0], "value": 134.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 159.0, 162.0, 161.0, 160.0, 161.0, 162.0, 162.0, 163.0, 161.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 115.0, 74.0, 75.0, 75.0, 75.0, 99.0, 76.0], "value": 81.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 112.0, 84.0, 83.0, 83.0, 119.0, 83.0, 84.0, 124.0], "value": 93.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 147.0, 146.0, 145.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 94.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 50.0, 50.0, 50.0, 49.0, 52.0, 50.0, 50.0, 50.0, 50.0], "value": 50.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 59.0, 59.0, 61.0, 60.0, 60.0, 65.0, 61.0, 60.0], "value": 60.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 75.0, 76.0, 75.0, 76.0, 76.0, 76.0, 76.0], "value": 75.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 136.0, 129.0, 126.0, 122.0, 121.0, 122.0, 117.0, 153.0, 127.0], "value": 127.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 161.0, 157.0, 159.0, 157.0, 157.0, 158.0, 163.0, 161.0, 160.0], "value": 159.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 63.0, 67.0, 65.0, 64.0, 62.0, 62.0, 62.0, 62.0], "value": 63.7, "unit": "score"}], "name": "kraken", "value": 1475.6000000000001, "alertThreshold": 2.0}]} 15:45:34 INFO - Return code: 0 15:45:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:45:34 INFO - # TBPL SUCCESS # 15:45:34 INFO - Running post-action listener: _resource_record_post_action 15:45:34 INFO - [mozharness: 2016-08-04 22:45:34.341266Z] Finished run-tests step (success) 15:45:34 INFO - Running post-run listener: _resource_record_post_run 15:45:34 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 408866816; Read time: 12; Write time: 237396 15:45:34 INFO - TinderboxPrint: CPU usage
13.0% 15:45:34 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 15:45:34 INFO - TinderboxPrint: I/O write bytes / time
408,866,816 / 237,396 15:45:34 INFO - TinderboxPrint: CPU idle
8,284.3 (87.0%) 15:45:34 INFO - TinderboxPrint: CPU user
1,192.8 (12.5%) 15:45:34 INFO - TinderboxPrint: Swap in / out
0 / 0 15:45:34 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 118005760; Read time: 0; Write time: 73216 15:45:34 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 290136064; Read time: 0; Write time: 164120 15:45:34 INFO - Running post-run listener: _upload_blobber_files 15:45:34 INFO - Blob upload gear active. 15:45:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:45:34 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 15:45:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:45:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:45:35 INFO - (blobuploader) - INFO - Open directory for files ... 15:45:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:45:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:45:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:45:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:45:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:45:36 INFO - (blobuploader) - INFO - Done attempting. 15:45:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:45:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:45:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:45:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:45:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:45:39 INFO - (blobuploader) - INFO - Done attempting. 15:45:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:45:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:45:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:45:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:45:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:45:41 INFO - (blobuploader) - INFO - Done attempting. 15:45:41 INFO - (blobuploader) - INFO - Iteration through files over. 15:45:41 INFO - Return code: 0 15:45:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:45:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:45:41 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/5bb4b171f3167a49c3527f9117867d3b56fdb9b8e63830644ff153db16fc806d9efc29d6f6805f110a5fb9f128b2f7034e8df2d3141a8e71fb6eed815ac27f61", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/8025de04e64a5969ee38f6eb6155204224f3e31ccad17d930d938bd623729297b89fc4118178376f075e646fb73e10f244ccaaec6d00232637608e069df3ce0f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/7a30da1efa300bcf73ac6571965a3504dfe9fa824234099b284ff9a2e91a2f9965357550203f272facb320b21550547951d55727d5b444a531b42e6ca9055ac5"} 15:45:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:45:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:45:41 INFO - Contents: 15:45:41 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/5bb4b171f3167a49c3527f9117867d3b56fdb9b8e63830644ff153db16fc806d9efc29d6f6805f110a5fb9f128b2f7034e8df2d3141a8e71fb6eed815ac27f61", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/8025de04e64a5969ee38f6eb6155204224f3e31ccad17d930d938bd623729297b89fc4118178376f075e646fb73e10f244ccaaec6d00232637608e069df3ce0f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/7a30da1efa300bcf73ac6571965a3504dfe9fa824234099b284ff9a2e91a2f9965357550203f272facb320b21550547951d55727d5b444a531b42e6ca9055ac5"} 15:45:41 INFO - Running post-run listener: copy_logs_to_upload_dir 15:45:41 INFO - Copying logs to upload dir... 15:45:41 INFO - mkdir: /builds/slave/test/build/upload/logs 15:45:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.409079 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-08-04 15:45:40.999328) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-04 15:45:41.002790) ========= 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-1470348141.91211-1355357942 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/5bb4b171f3167a49c3527f9117867d3b56fdb9b8e63830644ff153db16fc806d9efc29d6f6805f110a5fb9f128b2f7034e8df2d3141a8e71fb6eed815ac27f61", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/8025de04e64a5969ee38f6eb6155204224f3e31ccad17d930d938bd623729297b89fc4118178376f075e646fb73e10f244ccaaec6d00232637608e069df3ce0f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/7a30da1efa300bcf73ac6571965a3504dfe9fa824234099b284ff9a2e91a2f9965357550203f272facb320b21550547951d55727d5b444a531b42e6ca9055ac5"} build_url:https://queue.taskcluster.net/v1/task/d_jGmSKyQEah49Y-A2TC2g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011118 build_url: 'https://queue.taskcluster.net/v1/task/d_jGmSKyQEah49Y-A2TC2g/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/Autoland/sha512/5bb4b171f3167a49c3527f9117867d3b56fdb9b8e63830644ff153db16fc806d9efc29d6f6805f110a5fb9f128b2f7034e8df2d3141a8e71fb6eed815ac27f61", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/8025de04e64a5969ee38f6eb6155204224f3e31ccad17d930d938bd623729297b89fc4118178376f075e646fb73e10f244ccaaec6d00232637608e069df3ce0f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/7a30da1efa300bcf73ac6571965a3504dfe9fa824234099b284ff9a2e91a2f9965357550203f272facb320b21550547951d55727d5b444a531b42e6ca9055ac5"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-04 15:45:41.027976) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 15:45:41.028294) ========= 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-1470348141.91211-1355357942 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004457 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 15:45:41.111216) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-04 15:45:41.111536) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-04 15:45:41.111830) ========= ========= Total master_lag: 0.19 =========