builder: autoland_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-066 starttime: 1470350271.25 results: success (0) buildid: 20160804123001 builduid: 82decb124fac48deb5b4e79ab6adfe89 revision: 4939f5d5c16c957ae0da6d509a26482983fc894a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-04 15:37:51.248952) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-04 15:37:51.249426) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-04 15:37:51.249738) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-04 15:37:51.274589) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 15:37:51.274890) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1470350271.782792-585685140 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-04 15:37:52-- 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% 46.1M=0s 2016-08-04 15:37:53 (46.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.348288 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 15:37:51.637432) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 15:37:51.637818) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1470350271.782792-585685140 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018634 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 15:37:51.688257) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-04 15:37:51.688608) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1470350271.782792-585685140 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-04 15:37:53,318 truncating revision to first 12 chars 2016-08-04 15:37:53,318 Setting DEBUG logging. 2016-08-04 15:37:53,318 attempt 1/10 2016-08-04 15:37:53,318 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:37:54,457 unpacking tar archive at: autoland-4939f5d5c16c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.465112 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-04 15:37:53.171015) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-04 15:37:53.171838) ========= script_repo_revision: 4939f5d5c16c957ae0da6d509a26482983fc894a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-04 15:37:53.172669) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-04 15:37:53.172974) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-04 15:37:53.185281) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-08-04 15:37:53.185858) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=82c74bd3bc9a11c5833d2010000001e6-1470350271.782792-585685140 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:37:54 INFO - MultiFileLogger online at 20160804 15:37:54 in /builds/slave/test 15:37:54 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 15:37:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:37:54 INFO - {'append_to_log': False, 15:37:54 INFO - 'base_work_dir': '/builds/slave/test', 15:37:54 INFO - 'blob_upload_branch': 'Autoland', 15:37:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:37:54 INFO - 'branch': 'Autoland', 15:37:54 INFO - 'buildbot_json_path': 'buildprops.json', 15:37:54 INFO - 'config_files': ('talos/linux_config.py',), 15:37:54 INFO - 'default_actions': ('clobber', 15:37:54 INFO - 'read-buildbot-config', 15:37:54 INFO - 'download-and-extract', 15:37:54 INFO - 'populate-webroot', 15:37:54 INFO - 'create-virtualenv', 15:37:54 INFO - 'install', 15:37:54 INFO - 'run-tests'), 15:37:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:37:54 INFO - 'download_minidump_stackwalk': True, 15:37:54 INFO - 'download_symbols': 'ondemand', 15:37:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:37:54 INFO - 'tooltool.py': '/tools/tooltool.py', 15:37:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:37:54 INFO - '/tools/misc-python/virtualenv.py')}, 15:37:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:37:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:37:54 INFO - 'installer_path': 'installer.exe', 15:37:54 INFO - 'log_level': 'info', 15:37:54 INFO - 'log_name': 'talos', 15:37:54 INFO - 'log_to_console': True, 15:37:54 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:37:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:37:54 INFO - 'opt_config_files': (), 15:37:54 INFO - 'pip_index': False, 15:37:54 INFO - 'sps_profile': False, 15:37:54 INFO - 'sps_profile_interval': 0, 15:37:54 INFO - 'suite': 'dromaeojs-e10s', 15:37:54 INFO - 'system_bits': '32', 15:37:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:37:54 INFO - 'title': 'talos-linux64-ix-066', 15:37:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:37:54 INFO - 'use_talos_json': True, 15:37:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:37:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:37:54 INFO - 'work_dir': 'build'} 15:37:54 INFO - [mozharness: 2016-08-04 22:37:54.915039Z] Running clobber step. 15:37:54 INFO - Running pre-action listener: _resource_record_pre_action 15:37:54 INFO - Running main action method: clobber 15:37:54 INFO - rmtree: /builds/slave/test/build 15:37:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:37:55 INFO - Running post-action listener: _resource_record_post_action 15:37:55 INFO - [mozharness: 2016-08-04 22:37:55.374928Z] Finished clobber step (success) 15:37:55 INFO - [mozharness: 2016-08-04 22:37:55.375031Z] Running read-buildbot-config step. 15:37:55 INFO - Running pre-action listener: _resource_record_pre_action 15:37:55 INFO - Running main action method: read_buildbot_config 15:37:55 INFO - Using buildbot properties: 15:37:55 INFO - { 15:37:55 INFO - "project": "", 15:37:55 INFO - "product": "firefox", 15:37:55 INFO - "script_repo_revision": "production", 15:37:55 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs-e10s", 15:37:55 INFO - "repository": "", 15:37:55 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland pgo talos dromaeojs-e10s", 15:37:55 INFO - "buildid": "20160804123001", 15:37:55 INFO - "pgo_build": "True", 15:37:55 INFO - "basedir": "/builds/slave/test", 15:37:55 INFO - "buildnumber": 84, 15:37:55 INFO - "slavename": "talos-linux64-ix-066", 15:37:55 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 15:37:55 INFO - "platform": "ubuntu64_hw", 15:37:55 INFO - "scheduler": "tests-autoland-linux64-pgo-talos", 15:37:55 INFO - "branch": "autoland", 15:37:55 INFO - "repo_path": "integration/autoland", 15:37:55 INFO - "revision": "4939f5d5c16c957ae0da6d509a26482983fc894a", 15:37:55 INFO - "stage_platform": "linux64-pgo", 15:37:55 INFO - "builduid": "82decb124fac48deb5b4e79ab6adfe89", 15:37:55 INFO - "slavebuilddir": "test" 15:37:55 INFO - } 15:37:55 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:37:55 INFO - Running post-action listener: _resource_record_post_action 15:37:55 INFO - [mozharness: 2016-08-04 22:37:55.377429Z] Finished read-buildbot-config step (success) 15:37:55 INFO - [mozharness: 2016-08-04 22:37:55.378311Z] Running download-and-extract step. 15:37:55 INFO - Running pre-action listener: _resource_record_pre_action 15:37:55 INFO - Running main action method: download_and_extract 15:37:55 INFO - mkdir: /builds/slave/test/build/tests 15:37:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:37:55 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:37:55 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:37:55 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:37:55 INFO - Downloaded 1361 bytes. 15:37:55 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 15:37:55 INFO - Using the following test package requirements: 15:37:55 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 15:37:55 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:37:55 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:37:55 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:37:55 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:37:55 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:37:55 INFO - u'jsshell-linux-x86_64.zip'], 15:37:55 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:37:55 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:37:55 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 15:37:55 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:37:55 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:37:55 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:37:55 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:37:55 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:37:55 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:37:55 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:37:55 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:37:55 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:37:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:37:55 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:37:55 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:37:55 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:37:56 INFO - Downloaded 21820708 bytes. 15:37:56 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:38:01 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:38:01 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:38:01 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:38:01 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:38:01 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:38:02 INFO - Downloaded 21820708 bytes. 15:38:02 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:38:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:38:06 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:38:06 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:38:06 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:38:07 INFO - Downloaded 14413723 bytes. 15:38:07 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:38:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:38:07 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:38:07 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:38:07 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:38:09 INFO - Downloaded 59342260 bytes. 15:38:09 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:38:09 INFO - mkdir: /builds/slave/test/properties 15:38:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:38:09 INFO - Writing to file /builds/slave/test/properties/build_url 15:38:09 INFO - Contents: 15:38:09 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:38:09 INFO - Running post-action listener: _resource_record_post_action 15:38:09 INFO - Running post-action listener: set_extra_try_arguments 15:38:09 INFO - [mozharness: 2016-08-04 22:38:09.851064Z] Finished download-and-extract step (success) 15:38:09 INFO - [mozharness: 2016-08-04 22:38:09.851362Z] Running populate-webroot step. 15:38:09 INFO - Running pre-action listener: _resource_record_pre_action 15:38:09 INFO - Running main action method: populate_webroot 15:38:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:38:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:38:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:38:09 INFO - '--tppagecycles', 15:38:09 INFO - '7'], 15:38:09 INFO - 'tests': ['tsvgm']}}, 15:38:09 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:38:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:38:09 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:38:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:38:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:38:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:38:09 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:38:09 INFO - 'talos_options': ['--disable-e10s'], 15:38:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:38:09 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:38:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:38:09 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:38:09 INFO - 'talos_options': ['--disable-e10s'], 15:38:09 INFO - 'tests': ['damp', 'tps']}, 15:38:09 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:38:09 INFO - 'tests': ['damp', 'tps']}, 15:38:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:38:09 INFO - 'tests': ['dromaeo_dom']}, 15:38:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:38:09 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:38:09 INFO - 'tests': ['basic_compositor_video']}, 15:38:09 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:38:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:38:09 INFO - 'tests': ['a11yr', 15:38:09 INFO - 'ts_paint', 15:38:09 INFO - 'tpaint', 15:38:09 INFO - 'sessionrestore', 15:38:09 INFO - 'sessionrestore_no_auto_restore', 15:38:09 INFO - 'tabpaint']}, 15:38:09 INFO - 'other-e10s': {'tests': ['a11yr', 15:38:09 INFO - 'ts_paint', 15:38:09 INFO - 'tpaint', 15:38:09 INFO - 'sessionrestore', 15:38:09 INFO - 'sessionrestore_no_auto_restore', 15:38:09 INFO - 'tabpaint']}, 15:38:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:38:09 INFO - 'ts_paint', 15:38:09 INFO - 'tpaint', 15:38:09 INFO - 'sessionrestore', 15:38:09 INFO - 'sessionrestore_no_auto_restore', 15:38:09 INFO - 'tabpaint']}, 15:38:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:38:09 INFO - 'ts_paint', 15:38:09 INFO - 'tpaint', 15:38:09 INFO - 'sessionrestore', 15:38:09 INFO - 'sessionrestore_no_auto_restore', 15:38:09 INFO - 'tabpaint']}, 15:38:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:38:09 INFO - 'tests': ['a11yr', 15:38:09 INFO - 'ts_paint', 15:38:09 INFO - 'tpaint', 15:38:09 INFO - 'sessionrestore', 15:38:09 INFO - 'sessionrestore_no_auto_restore', 15:38:09 INFO - 'tabpaint']}, 15:38:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:38:09 INFO - 'tests': ['a11yr', 15:38:09 INFO - 'ts_paint', 15:38:09 INFO - 'tpaint', 15:38:09 INFO - 'sessionrestore', 15:38:09 INFO - 'sessionrestore_no_auto_restore', 15:38:09 INFO - 'tabpaint']}, 15:38:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:38:09 INFO - 'tests': ['tsvgx', 15:38:09 INFO - 'tsvgr_opacity', 15:38:09 INFO - 'tart', 15:38:09 INFO - 'tscrollx', 15:38:09 INFO - 'cart']}, 15:38:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:38:09 INFO - 'tsvgr_opacity', 15:38:09 INFO - 'tart', 15:38:09 INFO - 'tscrollx', 15:38:09 INFO - 'cart']}, 15:38:09 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:38:09 INFO - 'talos_options': ['--disable-e10s'], 15:38:09 INFO - 'tests': ['tp5o']}, 15:38:09 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:38:09 INFO - 'tests': ['tp5o']}, 15:38:09 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:38:09 INFO - 'talos_options': ['--disable-e10s', 15:38:09 INFO - '--xperf_path', 15:38:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:38:09 INFO - 'tests': ['tp5n']}, 15:38:09 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:38:09 INFO - 'talos_options': ['--xperf_path', 15:38:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:38:09 INFO - 'tests': ['tp5n']}}, 15:38:09 INFO - 'talos.zip': {'path': '', 15:38:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:38:09 INFO - Running post-action listener: _resource_record_post_action 15:38:09 INFO - [mozharness: 2016-08-04 22:38:09.874893Z] Finished populate-webroot step (success) 15:38:09 INFO - [mozharness: 2016-08-04 22:38:09.874984Z] Running create-virtualenv step. 15:38:09 INFO - Running pre-action listener: _resource_record_pre_action 15:38:09 INFO - Running main action method: create_virtualenv 15:38:09 INFO - Creating virtualenv /builds/slave/test/build/venv 15:38:09 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:38:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:38:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:38:09 INFO - Using real prefix '/usr' 15:38:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:38:10 INFO - Installing distribute.............................................................................................................................................................................................done. 15:38:12 INFO - Installing pip.................done. 15:38:12 INFO - Return code: 0 15:38:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:38:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:38:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:38:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:38:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:38:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:38:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:38:12 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 0x23ed030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26ae180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ac3b0>, '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 0x26ad2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ad740>, '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': '82c74bd3bc9a11c5833d2010000001e6-1470350271.782792-585685140', '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:38:12 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:38:12 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:38:12 INFO - Using env: {'DISPLAY': ':0', 15:38:12 INFO - 'HOME': '/home/cltbld', 15:38:12 INFO - 'LANG': 'en_US.UTF-8', 15:38:12 INFO - 'LANGUAGE': 'en_US:en', 15:38:12 INFO - 'LOGNAME': 'cltbld', 15:38:12 INFO - 'MAIL': '/var/mail/cltbld', 15:38:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:38:12 INFO - 'MOZ_NO_REMOTE': '1', 15:38:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:38:12 INFO - 'NO_EM_RESTART': '1', 15:38:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:38:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:38:12 INFO - 'PWD': '/builds/slave/test', 15:38:12 INFO - 'SHELL': '/bin/bash', 15:38:12 INFO - 'SHLVL': '1', 15:38:12 INFO - 'TERM': 'linux', 15:38:12 INFO - 'TMOUT': '86400', 15:38:12 INFO - 'USER': 'cltbld', 15:38:12 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1470350271.782792-585685140', 15:38:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:38:12 INFO - '_': '/tools/buildbot/bin/python'} 15:38:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:38:12 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:38:12 INFO - Cleaning up... 15:38:12 INFO - Return code: 0 15:38:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:38:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:38:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:38:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:38:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:38:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:38:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:38:12 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 0x23ed030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26ae180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ac3b0>, '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 0x26ad2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ad740>, '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': '82c74bd3bc9a11c5833d2010000001e6-1470350271.782792-585685140', '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:38:12 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:38:12 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:38:12 INFO - Using env: {'DISPLAY': ':0', 15:38:12 INFO - 'HOME': '/home/cltbld', 15:38:12 INFO - 'LANG': 'en_US.UTF-8', 15:38:12 INFO - 'LANGUAGE': 'en_US:en', 15:38:12 INFO - 'LOGNAME': 'cltbld', 15:38:12 INFO - 'MAIL': '/var/mail/cltbld', 15:38:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:38:12 INFO - 'MOZ_NO_REMOTE': '1', 15:38:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:38:12 INFO - 'NO_EM_RESTART': '1', 15:38:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:38:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:38:12 INFO - 'PWD': '/builds/slave/test', 15:38:12 INFO - 'SHELL': '/bin/bash', 15:38:12 INFO - 'SHLVL': '1', 15:38:12 INFO - 'TERM': 'linux', 15:38:12 INFO - 'TMOUT': '86400', 15:38:12 INFO - 'USER': 'cltbld', 15:38:12 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1470350271.782792-585685140', 15:38:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:38:12 INFO - '_': '/tools/buildbot/bin/python'} 15:38:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:38:12 INFO - Downloading/unpacking psutil>=3.1.1 15:38:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:38:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:38:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:38:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:38:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:38:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:38:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:38:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:38:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:38:14 INFO - Installing collected packages: psutil 15:38:14 INFO - Running setup.py install for psutil 15:38:14 INFO - building 'psutil._psutil_linux' extension 15:38:14 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:38:15 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:38:15 INFO - building 'psutil._psutil_posix' extension 15:38:15 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:38:15 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:38:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:38:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:38:15 INFO - Successfully installed psutil 15:38:15 INFO - Cleaning up... 15:38:15 INFO - Return code: 0 15:38:15 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:38:15 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:38:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:38:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:38:15 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:38:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:38:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:38:15 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 0x23ed030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26ae180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ac3b0>, '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 0x26ad2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ad740>, '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': '82c74bd3bc9a11c5833d2010000001e6-1470350271.782792-585685140', '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:38:15 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:38:15 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:38:15 INFO - Using env: {'DISPLAY': ':0', 15:38:15 INFO - 'HOME': '/home/cltbld', 15:38:15 INFO - 'LANG': 'en_US.UTF-8', 15:38:15 INFO - 'LANGUAGE': 'en_US:en', 15:38:15 INFO - 'LOGNAME': 'cltbld', 15:38:15 INFO - 'MAIL': '/var/mail/cltbld', 15:38:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:38:15 INFO - 'MOZ_NO_REMOTE': '1', 15:38:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:38:15 INFO - 'NO_EM_RESTART': '1', 15:38:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:38:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:38:15 INFO - 'PWD': '/builds/slave/test', 15:38:15 INFO - 'SHELL': '/bin/bash', 15:38:15 INFO - 'SHLVL': '1', 15:38:15 INFO - 'TERM': 'linux', 15:38:15 INFO - 'TMOUT': '86400', 15:38:15 INFO - 'USER': 'cltbld', 15:38:15 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1470350271.782792-585685140', 15:38:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:38:15 INFO - '_': '/tools/buildbot/bin/python'} 15:38:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:38:15 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:38:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:38:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:38:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:38:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:38:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:38:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:38:17 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:38:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:38:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:38:17 INFO - Installing collected packages: mozsystemmonitor 15:38:17 INFO - Running setup.py install for mozsystemmonitor 15:38:17 INFO - Successfully installed mozsystemmonitor 15:38:17 INFO - Cleaning up... 15:38:17 INFO - Return code: 0 15:38:17 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:38:17 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:38:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:38:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:38:17 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:38:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:38:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:38:17 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 0x23ed030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26ae180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ac3b0>, '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 0x26ad2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ad740>, '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': '82c74bd3bc9a11c5833d2010000001e6-1470350271.782792-585685140', '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:38:17 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:38:17 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:38:17 INFO - Using env: {'DISPLAY': ':0', 15:38:17 INFO - 'HOME': '/home/cltbld', 15:38:17 INFO - 'LANG': 'en_US.UTF-8', 15:38:17 INFO - 'LANGUAGE': 'en_US:en', 15:38:17 INFO - 'LOGNAME': 'cltbld', 15:38:17 INFO - 'MAIL': '/var/mail/cltbld', 15:38:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:38:17 INFO - 'MOZ_NO_REMOTE': '1', 15:38:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:38:17 INFO - 'NO_EM_RESTART': '1', 15:38:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:38:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:38:17 INFO - 'PWD': '/builds/slave/test', 15:38:17 INFO - 'SHELL': '/bin/bash', 15:38:17 INFO - 'SHLVL': '1', 15:38:17 INFO - 'TERM': 'linux', 15:38:17 INFO - 'TMOUT': '86400', 15:38:17 INFO - 'USER': 'cltbld', 15:38:17 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1470350271.782792-585685140', 15:38:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:38:17 INFO - '_': '/tools/buildbot/bin/python'} 15:38:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:38:17 INFO - Downloading/unpacking jsonschema==2.5.1 15:38:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:38:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:38:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:38:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:38:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:38:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:38:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:38:19 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:38:19 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:38:19 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:38:19 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:38:19 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:38:19 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:38:19 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:38:19 INFO - Downloading functools32-3.2.3-2.tar.gz 15:38:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:38:20 INFO - warning: no files found matching '*.txt' 15:38:20 INFO - no previously-included directories found matching 'build' 15:38:20 INFO - no previously-included directories found matching 'dist' 15:38:20 INFO - no previously-included directories found matching '.git*' 15:38:20 INFO - Installing collected packages: jsonschema, functools32 15:38:20 INFO - Running setup.py install for functools32 15:38:20 INFO - warning: no files found matching '*.txt' 15:38:20 INFO - no previously-included directories found matching 'build' 15:38:20 INFO - no previously-included directories found matching 'dist' 15:38:20 INFO - no previously-included directories found matching '.git*' 15:38:20 INFO - Successfully installed jsonschema functools32 15:38:20 INFO - Cleaning up... 15:38:20 INFO - Return code: 0 15:38:20 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:38: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:38:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:38:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:38: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:38:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:38:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:38: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', '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 0x23ed030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26ae180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ac3b0>, '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 0x26ad2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ad740>, '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': '82c74bd3bc9a11c5833d2010000001e6-1470350271.782792-585685140', '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:38: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:38: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 functools32==3.2.3-2 15:38:20 INFO - Using env: {'DISPLAY': ':0', 15:38:20 INFO - 'HOME': '/home/cltbld', 15:38:20 INFO - 'LANG': 'en_US.UTF-8', 15:38:20 INFO - 'LANGUAGE': 'en_US:en', 15:38:20 INFO - 'LOGNAME': 'cltbld', 15:38:20 INFO - 'MAIL': '/var/mail/cltbld', 15:38:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:38:20 INFO - 'MOZ_NO_REMOTE': '1', 15:38:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:38:20 INFO - 'NO_EM_RESTART': '1', 15:38:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:38:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:38:20 INFO - 'PWD': '/builds/slave/test', 15:38:20 INFO - 'SHELL': '/bin/bash', 15:38:20 INFO - 'SHLVL': '1', 15:38:20 INFO - 'TERM': 'linux', 15:38:20 INFO - 'TMOUT': '86400', 15:38:20 INFO - 'USER': 'cltbld', 15:38:20 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1470350271.782792-585685140', 15:38:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:38:20 INFO - '_': '/tools/buildbot/bin/python'} 15:38:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:38:20 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:38:20 INFO - Cleaning up... 15:38:20 INFO - Return code: 0 15:38:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:38: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:38:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:38:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:38: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:38:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:38:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:38: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', '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 0x23ed030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26ae180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ac3b0>, '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 0x26ad2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ad740>, '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': '82c74bd3bc9a11c5833d2010000001e6-1470350271.782792-585685140', '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:38: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:38: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 blobuploader==1.2.4 15:38:20 INFO - Using env: {'DISPLAY': ':0', 15:38:20 INFO - 'HOME': '/home/cltbld', 15:38:20 INFO - 'LANG': 'en_US.UTF-8', 15:38:20 INFO - 'LANGUAGE': 'en_US:en', 15:38:20 INFO - 'LOGNAME': 'cltbld', 15:38:20 INFO - 'MAIL': '/var/mail/cltbld', 15:38:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:38:20 INFO - 'MOZ_NO_REMOTE': '1', 15:38:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:38:20 INFO - 'NO_EM_RESTART': '1', 15:38:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:38:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:38:20 INFO - 'PWD': '/builds/slave/test', 15:38:20 INFO - 'SHELL': '/bin/bash', 15:38:20 INFO - 'SHLVL': '1', 15:38:20 INFO - 'TERM': 'linux', 15:38:20 INFO - 'TMOUT': '86400', 15:38:20 INFO - 'USER': 'cltbld', 15:38:20 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1470350271.782792-585685140', 15:38:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:38:20 INFO - '_': '/tools/buildbot/bin/python'} 15:38:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:38:20 INFO - Downloading/unpacking blobuploader==1.2.4 15:38:20 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:38:20 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:38:20 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:38:20 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:38:20 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:38:20 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:38:22 INFO - Downloading blobuploader-1.2.4.tar.gz 15:38:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:38:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:38:22 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:38:22 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:38:22 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:38:22 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:38:22 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:38:22 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:38:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:38:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:38:23 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:38:23 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:38:23 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:38:23 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:38:23 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:38:23 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:38:23 INFO - Downloading docopt-0.6.1.tar.gz 15:38:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:38:23 INFO - Installing collected packages: blobuploader, requests, docopt 15:38:23 INFO - Running setup.py install for blobuploader 15:38:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:38:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:38:23 INFO - Running setup.py install for requests 15:38:23 INFO - Running setup.py install for docopt 15:38:23 INFO - Successfully installed blobuploader requests docopt 15:38:23 INFO - Cleaning up... 15:38:23 INFO - Return code: 0 15:38:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:38: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:38:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:38:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:38: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:38:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:38:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:38:23 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 0x23ed030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26ae180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ac3b0>, '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 0x26ad2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ad740>, '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': '82c74bd3bc9a11c5833d2010000001e6-1470350271.782792-585685140', '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:38:23 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:38:23 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:38:23 INFO - Using env: {'DISPLAY': ':0', 15:38:23 INFO - 'HOME': '/home/cltbld', 15:38:23 INFO - 'LANG': 'en_US.UTF-8', 15:38:23 INFO - 'LANGUAGE': 'en_US:en', 15:38:23 INFO - 'LOGNAME': 'cltbld', 15:38:23 INFO - 'MAIL': '/var/mail/cltbld', 15:38:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:38:23 INFO - 'MOZ_NO_REMOTE': '1', 15:38:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:38:23 INFO - 'NO_EM_RESTART': '1', 15:38:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:38:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:38:23 INFO - 'PWD': '/builds/slave/test', 15:38:23 INFO - 'SHELL': '/bin/bash', 15:38:23 INFO - 'SHLVL': '1', 15:38:23 INFO - 'TERM': 'linux', 15:38:23 INFO - 'TMOUT': '86400', 15:38:23 INFO - 'USER': 'cltbld', 15:38:23 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1470350271.782792-585685140', 15:38:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:38:23 INFO - '_': '/tools/buildbot/bin/python'} 15:38:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:38:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:38:24 INFO - Running setup.py (path:/tmp/pip-RWrc0e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:38:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:38:24 INFO - Running setup.py (path:/tmp/pip-hTpJJ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:38:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:38:24 INFO - Running setup.py (path:/tmp/pip-gSglN1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:38:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:38:24 INFO - Running setup.py (path:/tmp/pip-Z4XS5d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:38:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:38:24 INFO - Running setup.py (path:/tmp/pip-8xOSj9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:38:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:38:24 INFO - Running setup.py (path:/tmp/pip-yd8jdu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:38:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:38:24 INFO - Running setup.py (path:/tmp/pip-En9ThH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:38:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:38:24 INFO - Running setup.py (path:/tmp/pip-8M5faH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:38:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:38:24 INFO - Running setup.py (path:/tmp/pip-17rcq0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:38:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:38:24 INFO - Running setup.py (path:/tmp/pip-hMbcuv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:38:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:38:24 INFO - Running setup.py (path:/tmp/pip-9HldoJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:38:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:38:24 INFO - Running setup.py (path:/tmp/pip-cj4OwF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:38:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:38:25 INFO - Running setup.py (path:/tmp/pip-z8fh9V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:38:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:38:25 INFO - Running setup.py (path:/tmp/pip-Pu96XA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:38:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:38:25 INFO - Running setup.py (path:/tmp/pip-9ytdRu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:38:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:38:25 INFO - Running setup.py (path:/tmp/pip-tNKLdf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:38:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:38:25 INFO - Running setup.py (path:/tmp/pip-05vN7Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:38:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:38:25 INFO - Running setup.py install for manifestparser 15:38:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:38:25 INFO - Running setup.py install for mozcrash 15:38:25 INFO - Running setup.py install for mozdebug 15:38:25 INFO - Running setup.py install for mozdevice 15:38:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:38:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:38:25 INFO - Running setup.py install for mozfile 15:38:25 INFO - Running setup.py install for mozhttpd 15:38:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:38:25 INFO - Running setup.py install for mozinfo 15:38:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:38:26 INFO - Running setup.py install for mozInstall 15:38:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:38:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:38:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:38:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:38:26 INFO - Running setup.py install for mozleak 15:38:26 INFO - Running setup.py install for mozlog 15:38:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:38:26 INFO - Running setup.py install for moznetwork 15:38:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:38:26 INFO - Running setup.py install for mozprocess 15:38:26 INFO - Running setup.py install for mozprofile 15:38:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:38:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:38:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:38:26 INFO - Running setup.py install for mozrunner 15:38:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:38:26 INFO - Running setup.py install for mozscreenshot 15:38:26 INFO - Running setup.py install for moztest 15:38:27 INFO - Running setup.py install for mozversion 15:38:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:38:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:38:27 INFO - Cleaning up... 15:38:27 INFO - Return code: 0 15:38:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:38:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:38:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:38:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:38:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:38:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:38:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:38:27 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 0x23ed030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26ae180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ac3b0>, '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 0x26ad2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ad740>, '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': '82c74bd3bc9a11c5833d2010000001e6-1470350271.782792-585685140', '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:38:27 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:38:27 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:38:27 INFO - Using env: {'DISPLAY': ':0', 15:38:27 INFO - 'HOME': '/home/cltbld', 15:38:27 INFO - 'LANG': 'en_US.UTF-8', 15:38:27 INFO - 'LANGUAGE': 'en_US:en', 15:38:27 INFO - 'LOGNAME': 'cltbld', 15:38:27 INFO - 'MAIL': '/var/mail/cltbld', 15:38:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:38:27 INFO - 'MOZ_NO_REMOTE': '1', 15:38:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:38:27 INFO - 'NO_EM_RESTART': '1', 15:38:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:38:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:38:27 INFO - 'PWD': '/builds/slave/test', 15:38:27 INFO - 'SHELL': '/bin/bash', 15:38:27 INFO - 'SHLVL': '1', 15:38:27 INFO - 'TERM': 'linux', 15:38:27 INFO - 'TMOUT': '86400', 15:38:27 INFO - 'USER': 'cltbld', 15:38:27 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1470350271.782792-585685140', 15:38:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:38:27 INFO - '_': '/tools/buildbot/bin/python'} 15:38:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:38:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:38:27 INFO - Running setup.py (path:/tmp/pip-q9Qk0R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:38:27 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:38:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:38:27 INFO - Running setup.py (path:/tmp/pip-a4mWk4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:38:27 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:38:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:38:27 INFO - Running setup.py (path:/tmp/pip-Cv2P83-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:38:27 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:38:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:38:27 INFO - Running setup.py (path:/tmp/pip-nGsJsE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:38:27 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:38:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:38:27 INFO - Running setup.py (path:/tmp/pip-HbEbHH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:38:27 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:38:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:38:27 INFO - Running setup.py (path:/tmp/pip-lAVIOj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:38:27 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:38:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:38:27 INFO - Running setup.py (path:/tmp/pip-svfA7L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:38:27 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:38:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:38:27 INFO - Running setup.py (path:/tmp/pip-FTERS8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:38:27 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:38:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:38:27 INFO - Running setup.py (path:/tmp/pip-Gm6_t6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:38:28 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:38:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:38:28 INFO - Running setup.py (path:/tmp/pip-iO69MS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:38:28 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:38:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:38:28 INFO - Running setup.py (path:/tmp/pip-ZDf9qF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:38:28 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:38:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:38:28 INFO - Running setup.py (path:/tmp/pip-IkjpyB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:38:28 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:38:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:38:28 INFO - Running setup.py (path:/tmp/pip-ISdgn8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:38:28 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:38:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:38:28 INFO - Running setup.py (path:/tmp/pip-DDnIUS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:38:28 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:38:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:38:28 INFO - Running setup.py (path:/tmp/pip-ZOoYvW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:38:28 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:38:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:38:28 INFO - Running setup.py (path:/tmp/pip-YCc_S7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:38:28 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:38:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:38:28 INFO - Running setup.py (path:/tmp/pip-B7oqLs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:38:28 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:38:28 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:38:28 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:38:28 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:38:28 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:38:28 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:38:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:38: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:38: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:38: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:38: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:38: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:38: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:38:30 INFO - Downloading blessings-1.6.tar.gz 15:38:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:38:30 INFO - Installing collected packages: blessings 15:38:30 INFO - Running setup.py install for blessings 15:38:30 INFO - Successfully installed blessings 15:38:30 INFO - Cleaning up... 15:38:30 INFO - Return code: 0 15:38:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:38:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:38:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:38:30 INFO - Reading from file tmpfile_stdout 15:38:30 INFO - Current package versions: 15:38:30 INFO - argparse == 1.2.1 15:38:30 INFO - blessings == 1.6 15:38:30 INFO - blobuploader == 1.2.4 15:38:30 INFO - docopt == 0.6.1 15:38:30 INFO - functools32 == 3.2.3-2 15:38:30 INFO - jsonschema == 2.5.1 15:38:30 INFO - manifestparser == 1.1 15:38:30 INFO - mozInstall == 1.12 15:38:30 INFO - mozcrash == 0.17 15:38:30 INFO - mozdebug == 0.1 15:38:30 INFO - mozdevice == 0.48 15:38:30 INFO - mozfile == 1.2 15:38:30 INFO - mozhttpd == 0.7 15:38:30 INFO - mozinfo == 0.9 15:38:30 INFO - mozleak == 0.1 15:38:30 INFO - mozlog == 3.3 15:38:30 INFO - moznetwork == 0.27 15:38:30 INFO - mozprocess == 0.23 15:38:30 INFO - mozprofile == 0.28 15:38:30 INFO - mozrunner == 6.12 15:38:30 INFO - mozscreenshot == 0.1 15:38:30 INFO - mozsystemmonitor == 0.3 15:38:30 INFO - moztest == 0.7 15:38:30 INFO - mozversion == 1.4 15:38:30 INFO - psutil == 3.1.1 15:38:30 INFO - requests == 1.2.3 15:38:30 INFO - wsgiref == 0.1.2 15:38:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:38:30 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:38:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:38:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:38:30 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:38:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:38:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:38:30 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 0x23ed030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26ae180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ac3b0>, '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 0x26ad2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ad740>, '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': '82c74bd3bc9a11c5833d2010000001e6-1470350271.782792-585685140', '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:38:30 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:38:30 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:38:30 INFO - Using env: {'DISPLAY': ':0', 15:38:30 INFO - 'HOME': '/home/cltbld', 15:38:30 INFO - 'LANG': 'en_US.UTF-8', 15:38:30 INFO - 'LANGUAGE': 'en_US:en', 15:38:30 INFO - 'LOGNAME': 'cltbld', 15:38:30 INFO - 'MAIL': '/var/mail/cltbld', 15:38:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:38:30 INFO - 'MOZ_NO_REMOTE': '1', 15:38:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:38:30 INFO - 'NO_EM_RESTART': '1', 15:38:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:38:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:38:30 INFO - 'PWD': '/builds/slave/test', 15:38:30 INFO - 'SHELL': '/bin/bash', 15:38:30 INFO - 'SHLVL': '1', 15:38:30 INFO - 'TERM': 'linux', 15:38:30 INFO - 'TMOUT': '86400', 15:38:30 INFO - 'USER': 'cltbld', 15:38:30 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1470350271.782792-585685140', 15:38:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:38:30 INFO - '_': '/tools/buildbot/bin/python'} 15:38:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:38:31 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:38:31 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:38:31 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:38:31 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:38:31 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:38:31 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:38:31 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:38:31 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:38:31 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:38:31 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:38:31 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:38:31 INFO - Cleaning up... 15:38:31 INFO - Return code: 0 15:38:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:38:31 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:38:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:38:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:38:31 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:38:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:38:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:38:31 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 0x23ed030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26ae180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ac3b0>, '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 0x26ad2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ad740>, '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': '82c74bd3bc9a11c5833d2010000001e6-1470350271.782792-585685140', '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:38:31 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:38:31 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:38:31 INFO - Using env: {'DISPLAY': ':0', 15:38:31 INFO - 'HOME': '/home/cltbld', 15:38:31 INFO - 'LANG': 'en_US.UTF-8', 15:38:31 INFO - 'LANGUAGE': 'en_US:en', 15:38:31 INFO - 'LOGNAME': 'cltbld', 15:38:31 INFO - 'MAIL': '/var/mail/cltbld', 15:38:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:38:31 INFO - 'MOZ_NO_REMOTE': '1', 15:38:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:38:31 INFO - 'NO_EM_RESTART': '1', 15:38:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:38:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:38:31 INFO - 'PWD': '/builds/slave/test', 15:38:31 INFO - 'SHELL': '/bin/bash', 15:38:31 INFO - 'SHLVL': '1', 15:38:31 INFO - 'TERM': 'linux', 15:38:31 INFO - 'TMOUT': '86400', 15:38:31 INFO - 'USER': 'cltbld', 15:38:31 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1470350271.782792-585685140', 15:38:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:38:31 INFO - '_': '/tools/buildbot/bin/python'} 15:38:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:38:31 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:38:31 INFO - Cleaning up... 15:38:31 INFO - Return code: 0 15:38:31 INFO - Running post-action listener: _resource_record_post_action 15:38:31 INFO - Running post-action listener: _start_resource_monitoring 15:38:31 INFO - Starting resource monitoring. 15:38:31 INFO - [mozharness: 2016-08-04 22:38:31.436533Z] Finished create-virtualenv step (success) 15:38:31 INFO - [mozharness: 2016-08-04 22:38:31.437034Z] Running install step. 15:38:31 INFO - Running pre-action listener: _resource_record_pre_action 15:38:31 INFO - Running main action method: install 15:38:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:38:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:38:31 INFO - Reading from file tmpfile_stdout 15:38:31 INFO - Detecting whether we're running mozinstall >=1.0... 15:38:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:38:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:38:31 INFO - Reading from file tmpfile_stdout 15:38:31 INFO - Output received: 15:38:31 INFO - Usage: mozinstall [options] installer 15:38:31 INFO - Options: 15:38:31 INFO - -h, --help show this help message and exit 15:38:31 INFO - -d DEST, --destination=DEST 15:38:31 INFO - Directory to install application into. [default: 15:38:31 INFO - "/builds/slave/test"] 15:38:31 INFO - --app=APP Application being installed. [default: firefox] 15:38:31 INFO - mkdir: /builds/slave/test/build/application 15:38:31 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:38:31 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:38:48 INFO - Reading from file tmpfile_stdout 15:38:48 INFO - Output received: 15:38:48 INFO - /builds/slave/test/build/application/firefox/firefox 15:38:48 INFO - Running post-action listener: _resource_record_post_action 15:38:48 INFO - [mozharness: 2016-08-04 22:38:48.568757Z] Finished install step (success) 15:38:48 INFO - [mozharness: 2016-08-04 22:38:48.569005Z] Running run-tests step. 15:38:48 INFO - Running pre-action listener: _resource_record_pre_action 15:38:48 INFO - Running main action method: run_tests 15:38:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:38:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:38:48 INFO - Python 2.7.3 15:38:48 INFO - Return code: 0 15:38:48 INFO - grabbing minidump binary from tooltool 15:38:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:38:48 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 0x26ac3b0>, '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 0x26ad2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ad740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:38:48 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:38:48 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:38:48 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:38:48 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:38:48 INFO - Return code: 0 15:38:48 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:38:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:38:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:38:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:38:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:38:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/d_jGmSKyQEah49Y-A2TC2g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 15:38:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/d_jGmSKyQEah49Y-A2TC2g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-066 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 15:38:48 INFO - Using env: {'DISPLAY': ':0', 15:38:48 INFO - 'HOME': '/home/cltbld', 15:38:48 INFO - 'LANG': 'en_US.UTF-8', 15:38:48 INFO - 'LANGUAGE': 'en_US:en', 15:38:48 INFO - 'LOGNAME': 'cltbld', 15:38:48 INFO - 'MAIL': '/var/mail/cltbld', 15:38:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:38:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:38:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:38:48 INFO - 'MOZ_NO_REMOTE': '1', 15:38:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:38:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:38:48 INFO - 'NO_EM_RESTART': '1', 15:38:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:38:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:38:48 INFO - 'PWD': '/builds/slave/test', 15:38:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:38:48 INFO - 'SHELL': '/bin/bash', 15:38:48 INFO - 'SHLVL': '1', 15:38:48 INFO - 'TERM': 'linux', 15:38:48 INFO - 'TMOUT': '86400', 15:38:48 INFO - 'USER': 'cltbld', 15:38:48 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1470350271.782792-585685140', 15:38:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:38:48 INFO - '_': '/tools/buildbot/bin/python'} 15:38:48 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/d_jGmSKyQEah49Y-A2TC2g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 15:38:48 INFO - mozversion application_buildid: 20160804123001 15:38:48 INFO - mozversion application_changeset: 4939f5d5c16c957ae0da6d509a26482983fc894a 15:38:48 INFO - mozversion application_display_name: Nightly 15:38:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:38:48 INFO - mozversion application_name: Firefox 15:38:48 INFO - mozversion application_remotingname: firefox 15:38:48 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 15:38:48 INFO - mozversion application_vendor: Mozilla 15:38:48 INFO - mozversion application_version: 51.0a1 15:38:48 INFO - mozversion platform_buildid: 20160804123001 15:38:48 INFO - mozversion platform_changeset: 4939f5d5c16c957ae0da6d509a26482983fc894a 15:38:48 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 15:38:48 INFO - mozversion platform_version: 51.0a1 15:38:48 INFO - using testdate: 1470350328 15:38:48 INFO - actual date: 1470350328 15:38:48 INFO - starting webserver on 'localhost:44115' 15:38:48 INFO - SUITE-START | Running 2 tests 15:38:48 INFO - TEST-START | dromaeo_css 15:38:48 INFO - operating with platform_type : linux_ 15:38:48 INFO - Initialising browser for dromaeo_css test... 15:38:48 INFO - TEST-INFO | started process 30375 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDwuhpP/profile http://localhost:44115/getInfo.html) 15:38:53 INFO - PROCESS | 30375 | __metrics Screen width/height:1600/1200 15:38:53 INFO - PROCESS | 30375 | colorDepth:24 15:38:53 INFO - PROCESS | 30375 | Browser inner width/height: 1024/697 15:38:53 INFO - PROCESS | 30375 | __metrics 15:38:54 ERROR - PROCESS | 30375 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 15:38:55 INFO - TEST-INFO | 30375: exit 0 15:38:55 INFO - Browser initialized. 15:38:55 INFO - Running cycle 1/1 for dromaeo_css test... 15:38:55 INFO - TEST-INFO | started process 30494 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDwuhpP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:39:07 INFO - PROCESS | 30494 | RSS: Main: 163991552 15:39:07 INFO - PROCESS | 30494 | 15:39:56 INFO - PROCESS | 30494 | 1470350396617 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:42:05 INFO - PROCESS | 30494 | Cycle 1(1): loaded http://localhost:44115/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44115/tests/dromaeo/cssquery-ext.html) 15:42:06 INFO - PROCESS | 30494 | RSS: Main: 169881600 15:42:06 INFO - PROCESS | 30494 | 15:45:09 INFO - PROCESS | 30494 | Cycle 1(1): loaded http://localhost:44115/tests/dromaeo/cssquery-ext.html (next: http://localhost:44115/tests/dromaeo/cssquery-jquery.html) 15:45:09 INFO - PROCESS | 30494 | RSS: Main: 167854080 15:45:09 INFO - PROCESS | 30494 | 15:48:11 INFO - PROCESS | 30494 | Cycle 1(1): loaded http://localhost:44115/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44115/tests/dromaeo/cssquery-mootools.html) 15:48:12 INFO - PROCESS | 30494 | RSS: Main: 170459136 15:48:12 INFO - PROCESS | 30494 | 15:51:13 INFO - PROCESS | 30494 | Cycle 1(1): loaded http://localhost:44115/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44115/tests/dromaeo/cssquery-prototype.html) 15:51:14 INFO - PROCESS | 30494 | RSS: Main: 165658624 15:51:14 INFO - PROCESS | 30494 | 15:54:17 INFO - PROCESS | 30494 | Cycle 1(1): loaded http://localhost:44115/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44115/tests/dromaeo/cssquery-yui.html) 15:54:17 INFO - PROCESS | 30494 | RSS: Main: 167522304 15:54:17 INFO - PROCESS | 30494 | 15:57:20 INFO - PROCESS | 30494 | Cycle 1(1): loaded http://localhost:44115/tests/dromaeo/cssquery-yui.html (next: http://localhost:44115/tests/dromaeo/cssquery-dojo.html) 15:57:20 INFO - PROCESS | 30494 | RSS: Main: 170868736 15:57:20 INFO - PROCESS | 30494 | 15:57:20 INFO - PROCESS | 30494 | __start_tp_report 15:57:20 INFO - PROCESS | 30494 | _x_x_mozilla_page_load 15:57:20 INFO - PROCESS | 30494 | _x_x_mozilla_page_load_details 15:57:20 INFO - PROCESS | 30494 | |i|pagename|runs| 15:57:20 INFO - PROCESS | 30494 | |0;dojo.html;3047.6952304769525;3062.6784187660296;3064.203307140143;3083.059666801625;3092.5825013623166;5210.088234558956;5348.973255133724;5355.196720491923;5377.91933121003;5416.674999500033;5329.280547126137;5381.408045115034;5391.218273350371;5391.622586418943;5400.486953739389;4845.5396737310075;4884.87787805305;4886.462489126193;4911.8280860169725;4928.186849169901;4904.926426103611;4958.652894297383;4969.25461180824;4996.650234483587;5050.393952725678;791.0301136602703;4996.7001979881325;5016.046951079284;5021.397432308128;5050.747462626872;4829.082474329866;4966.428860681031;4984.2025275955675;4993;5007.924881126786;4849.321095046696;4849.927251091236;4855.5872750816225;4856.1016212000895;4906.141425250603;5273.235380869753;5334.253204551366;5345.251664766935;5348.064088784486;5353.03645343838;5547.140193270049;5702.258706368187;5719.6854173020465;5742.253507044099;5854.063349864044;5826.359100498942;5833.533317334603;5835.941640583582;5841.532677385799;5847.678377689225;5398.865028374244;5427.267318911975;5433.1035379162395;5439.265699130646;5450.509454149145;5650.491455769001;5655.943440565542;5703.971480142655;5732.71336433185;5796.0436527972415;5474.151506516497;5484.91772623411;5496.203050557727;5497.147942068906;5500.009998200282;5567.749451274703;5573.888522229614;5596.132599447093;5596.384397716248;5656.745446454919;5450.700211488406;5487.807926722546;5488.807891723771;5558.805441809517;5573.7770489179975;5495.53287970527;5518.2826232589505;5523.6685798852195;5530.751116199781;5535.114381698909;4297.54875738043;4303.397524346594;4303.526612072669;4337.436133302651;4342.544032876565;3756.0609847538117;3794.430835374716;3828.2917660232947;3845.403962385835;3847.249786291702;5282.735863206824;5356.866078348073;5365.275687782178;5381.811636592701;5423.674579525241;5538.6122971391615;5649.491545760901;5649.661020338793;5652.66084034951;5659.5755318351285;5237.292965449692;5294.867628309246;5339.172428273624;5339.733013349317;5413.02565538199;4820.903581928342;4841.491643377465;4847.975760121248;4849.102915960559;4883.072216278967;5681.0626246668835;5807.128930660435;5856.795012174553;5871.618344807659;5877.265341832271;5722.370539240764;5734.483896449339;5749.97125014389;5834.329052159056;5849.853753656193;5992.64044157352;6016.278046634432;6048.12302216185;6055.576109672457;6064.272287325549;5364.061289274439;5692.260006199168;5692.5445964321925;5709.942900570941;5720.141978703228;5702.6863522506665;5727.541796656341;5762.827115186551;5799.623024503394;5831.0378787499585;5563.610547261815;5612.410696876933;5629.352624448241;5645.379008309001;5659.801906933238;5322.627416080837;5633.464820842013;5633.6619802811965;5646.745896434588;5654.06707893193;5346.786128554814;5373.086575282289;5395.595330350161;5414.0525408052645;5431.239626452379;5529.557635389239;5532;5536.4186760389575;5547.0570003098765;5559.24950131727;5284.180951952453;5392.379876314118;5405.432429594994;5442.102053161184;5460.31746031746 15:57:20 INFO - PROCESS | 30494 | |1;ext.html;548.7165491187496;582.6329412470146;585.5140233606106;608.8508315462711;619.4982064527736;39809.601903980954;44710;44795.552044479584;44798.77600612;44854.77572612133;45200.321995170016;45695.77152114235;45717.31424028634;45870;46130;8939.195472407499;8986.595603197871;9058.909410905906;9073.183413492785;9085.954570227139;8945.523988541883;9084.50035248061;9084.545772711372;9085.954570227139;9113.362064655477;9125;9158.542072896362;9171.220446262076;9172.31207659425;9189.678361257358;9021.097890210993;9021.819563608724;9090.86363704545;9096.408733432305;9146.86279705805;8902.065283145306;8969.103089691043;8973.730788076367;8977.32670049749;8986.505742184243;43505.78247108744;44031.559684403066;44233.33649995253;44247.557524424665;44342.11315773699;3522.947155792665;3596.1009747563107;3690.7231957603285;3739.5886452490204;3806.333891568992;32371.514427283608;35240.647593523994;35271.64728352709;35372.82313588416;35405.29189416223;4287.721298115613;4456.286994080964;4479.46246450428;4561.064981678748;4611.308303754464;389597;390389;391557;393528;393763.0311848451;55637.44362556404;62817;64033;64058.35941640617;64716;68776.31223687799;68888.31111688919;68896.6555167221;68911.58809441746;69292;17703.645927081645;17819.910900445673;17843.821561784476;17990.550236243937;18000.549986250448;13724.862751372559;13801;13805.240711760749;13809.102408343426;13814.309284535733;19478.123484443233;19514.90242548778;19578.804211957697;19592.706109408085;19707.814099842726;7110.608916509538;7147.463940204506;7284.927150728425;7452.602964251009;7514.6618402172035;968.41894863083;1041.6041904076403;1088.1892989722708;1126.898579127866;1154.5035634677001;32746.181345466553;32942;33198.33603327968;33224;33513.497297540554;1119.725667211522;1121.9214654974237;1149.1955631058127;1149.8102813035755;1202.8857258560422;17546.824531754773;17652.293908243526;17703.291868325123;17784.733229001577;18003.18985645649;608182;612059;612373;612459;614371;61163.38836611577;62642.0603690945;62683;62790.0581491278;62935.37064629295;1347.9258640774656;1391.5268808605124;1394.9511767088104;1413.8868890488736;1418.44680574576;31424.214394640316;32532.186695332806;32822.67177328196;33355.33289334151;33927.66072339245;54741.452585473635;55145.44854551403;55171.17243241274;55188.44811551994;55193.724031379585;490166;492228;493826;494949;494977;29568.33884950365;29633.703662963093;30193.245168870955;30316.726245531234;30388;50712.74643626758;50796;51033;51733;52217;41403.929803510306;43983.78008109939;44645;45289;48024.51975480201;45392.77303613461;45634.54365456436;45973;46450.76774616105;46673.766631166625;42213;43228.351574727036;43408.782956085015;43608.12783744371;45073.32390014218;36322;38025.14811389212;40091.59908400878;40284.798576006935;40657;29293.41413171682;29479.26301842385;29895;29895.55156672695;30117.548236776904 15:57:20 INFO - PROCESS | 30494 | |2;jquery.html;373.63943794238537;383.38036391943183;391.26051762169493;394.4083874188717;412.9896752581185;15948.521544353658;18804.24783008678;19709.704354434696;20430.2849400271;20491.99999999998;19504.60990780187;19718.309859154895;19756.209751609917;20276.594468110667;20373.083211255493;5427.891442171164;5770.653760774367;5775.162601422791;5782;5800.15897694834;5540.529055030327;5687.943120568782;5694;5761.798337058204;5764.135379693038;5759.4528519790765;5795.333536643277;5827.475527202551;5836.328822185439;5837.978353788091;5617.859553511154;5738;5761.164631128505;5821.50517206038;5842.123681447774;5123.871903202413;5129.9230511542355;5133.84598462043;5135.589152867761;5142.357205349332;14370;22663.206787762512;23711.1701090461;23759.538172665943;24164.39589010289;2321.779430954057;2351.4356554426986;2822.872970716302;2967.8219306841656;2995.026616349695;10529.736756581147;11043.392613406259;11089.778204435946;11131.053860421875;11139.331640101538;1968.4193163016944;1978.238378224394;1985.851061170418;2068.11071239367;2080.136743251564;81306.4150755519;86294;86454;89119;93504.53247733785;10621.309614875008;11088;11199.60801371948;11256.606018789304;11407.600733974272;13907;14776.92611536957;15690.450834220748;15691.450799221973;15858.841411585736;8346.372457370875;8486.363522735819;8574.442661227;8760.4305720128;8799.29605631548;7624.466287359943;8123.268905798506;8394.874076888851;8398.874016889751;8644.22202001823;4767.118083154627;4835.782389792397;4869.415670119608;4873.902521949542;5022.773975171053;1956.5402130499322;2004.7894971028124;2007.5382661987824;2039.7144399784042;2051.446109550443;910.1717437132178;963.0946909904667;1017.1760873692333;1023.8054769593754;1048.449563978902;19825.487922032036;20001;20129.698054529195;20321.49196270105;20593.279235226695;1020.6886899495726;1040.1730624153815;1045.4720366215013;1051.3586712105762;1059.4332032362804;10557.47212639365;10999.450027498593;11056.778864422666;11154.944225278821;11202.103831693445;458666;459654;464800;497524;501853;80896.78654820182;94511.52744236235;94831.52584237173;95730;97638.5118074405;959.1176117971482;986.3046552180696;994.3785134291068;997.1524204426324;1027.5735569738624;17791.555211119827;17855.642887142443;18079.548011299823;18149.637007260044;18464.169112390242;42806.35790463208;43327.78336108299;43815.34276985784;43888.561114388445;43947.78026109849;56717.71641141933;56867;59777.40222597718;60892;61153;8194.262516373556;8306.916930830856;8427.705030323908;8480.660773568989;8729.170728780755;13158.934205328913;13388.19670819754;13425.26161061151;13438.932805335911;13857.861421385656;11359;11785.469653865768;11846.229995050295;12088.335141567299;12316.445759940645;11550.59572914944;11600.361980091177;11603.825942610698;11682;12280.631581052225;11905.46425410876;12036.217645852992;12199.085068620067;12208.145429820182;12325.876741232833;8599.312055035458;8708.433951793113;8794.120587941155;8840.557972101498;8888.155625215593;10948.397838118979;11810.645680629596;11858.76282474363;11862.762744745229;12294.262344259016 15:57:20 INFO - PROCESS | 30494 | |3;mootools.html;1475.5573328001597;1484.755015422455;1599.7280462321412;1750.6323672028873;1751.7722696049511;7893.960530197341;8020.5187688738715;8621.137886211376;9325.16073553381;9333.253339732822;8434.283085937688;8606.440581362207;8635.654573817055;8717.476951382921;8794.384393092487;2344.531093781242;2380.333506618141;2382.642603609464;2387.761223877607;2395.940101497468;2203.316971738758;2215.6565732311437;2234.0728597631964;2238.7201599800023;2240.372695645222;2295.4490922178725;2298.161171172527;2311.687922130516;2337.520808234308;2348.248560460653;2239.9776002240014;2255.909763609454;2263.1739415113366;2266.6713326567638;2269.364577918169;2185.841504002881;2216.866987980726;2225.1766846266823;2225.8219342452567;2230.018791731633;8683.609237584324;8750.606222719993;8751.518666473341;8759.080296568833;8759.2992560595;5203.245529398254;5254.21186821976;5297.12597421425;5317.760700768436;5323.946760532423;3240.0927740232773;3244.1403028197547;3426.640202778697;3442.294329662413;3448.3448144852396;1139.305023935407;1154.128632882177;1161.2335858333545;1171.226990186473;1195.3306148556749;11675.416229188591;11985.760284794254;12150.45322960469;12166.635000949986;12227.816582751266;4568.314752787042;4582.793774280165;4775.355327030876;4777.426708794897;4818.734969576707;10449;10528.26302158857;10553.208509361828;10640.255182137176;10720;5284.9735751320995;5366.060939335601;5385.946140538545;5396.244525766396;5400.567954563626;4333.328334108218;4634.652401069933;4758.595519380822;4789.090072886141;4856.39295088114;3964.900877478086;4003.139325045129;4063.923060388999;4107.712460127762;4113.732607380511;1296.3388671777461;1300.5383089003458;1306.6145487081333;1316.0392913173437;1319.2612137203005;919.6091661044029;1008.9204551130221;1053.257453495284;1056.4559251985233;1062.4634559547533;6046.093086037042;6204.100405441276;6240.375962403814;6304.65324407162;6509.44669703071;967.3277072434731;1054.1935419404163;1057;1057.6404022632341;1085.4193006741514;4050.7569545826755;4226.704130710882;4444.2444784386735;4498.955010449919;4578.244589642672;10684.732881678021;10986.670399888017;11094.445277736242;11098.389588572545;11223.55105795759;10724.463776811284;11202.551897923991;11333.206675532634;11367.147463940237;11375.203735738585;7990.9200907991335;8098.797530061795;8170.14213507585;8287.378446616527;8355.289800366916;5927.644341339361;5955.821325360246;6037.094435834484;6063.787767428119;6079.240094988127;9763.853542197015;9819.870714867882;9865.802683946424;9882.703518894445;9925.900740992498;9742.95128524353;9874.85187722199;10515.684529464128;10637.202209834139;10696.251262411557;6581.769638062645;7066.081409416743;7231.16841563227;7577.810554736176;7622.771316860503;8454.36592255571;8590.398672092893;8612.65549378018;8634.956825215833;8659.220670139717;7441.8139546511775;7642.1184146596115;7692.19231980634;7743.883841742266;7836.942012828195;7484.625768711434;7519.924800751923;7531.171571127281;7621.1616722161625;7656.770296891103;6850.554713943578;6901.206361268318;6954.3393377629045;6982.7206911725;7001.194862590867;5197.610179236497;5394.298741163623;5398.595105367034;5447.3735520414075;5695.601307908407;5370.946290537045;5385.596080293915;5468.91796623059;5505.504504594605;5587.497125258747 15:57:20 INFO - PROCESS | 30494 | |4;prototype.html;327.8491893728883;334.6335762340237;335.41637550661846;340.4178854159387;340.679761024637;5331.413544510101;5477.397486276506;5542.528885044771;5643.984082865082;5654.349749778777;5463.836084917459;5495;5503.807366742165;5511.5039646431815;5516;4329.54539773324;4332.891677708067;4333.068390296085;4372.934405983913;4385.714928529651;4214.704970652056;4295.570442955711;4341.78291085446;4364.367166760818;4375.234333991539;4284.871453856389;4297.355396690506;4299.301775798558;4302.440682711243;4333.978330108345;4315.136972605475;4334.826606935703;4335.566443355639;4345.587169218919;4391.890202744925;3542.734294927865;3841.2317536492815;3852.8616617777125;3855.1904100139004;3873.1479074603544;5310.831617044244;5373.435789242112;5380.273663055476;5383.031054410205;5392.083345831218;4887.3402090717655;4907.607391408679;4907.950920490785;4909.779059942275;4917.582005529534;5449.945500545023;5657.179708942181;5749.31008279005;5752.424757524256;5766.654000759968;4049.9190016199805;4051.6150965658217;4055.959440405588;4058;4079.122988557445;5947.762089516415;5949.167116603679;5971.790987315467;5973.566344077391;6088.8782224356155;3989.862889076657;4171.144915292358;4174.853880114242;4214.662826973835;4231.936520952188;4232.746035237834;4250.53244143144;4259.637930775919;4288.799136241857;4295.098029413795;4898.191798353303;4915.8033678652455;4920.729359885169;4930.433000204951;4931.309616653672;5591.720413979285;5785.392533783892;5879.3826648202175;5882.411758824083;5889.911651325234;1442.3581506229627;1448.3265281643876;1462.590474667095;1471.1687896338535;1474.9041312314664;893.6068130022899;931.487681775021;935.9391639543408;945.567465290086;947.6209516193578;4890.902181956341;4894.657373983787;4922.326409020879;4941.407031156285;4969.577585905166;5139.331886854685;5159;5184.196449550326;5194.92207616886;5213.244079608511;4725.173094708481;4900.607951363882;4907.5828554572545;4928.605711543068;4984.352034235599;2750.601162831378;2759.7102304258165;2771.5704065869822;2785.579354529164;2803.341214814517;5401.730593310569;5450.291462109901;5481.588880833953;5481.808136715275;5506.457172832429;5106.6722652109975;5206.427292997767;5213.817516386984;5321.4988955191;5340.546053585489;5306.336707911511;5343.396980905713;5375.381831089397;5384.488473595002;5396.244525766318;5172.612054095883;5177.326947496952;5195;5221.269022336952;5226.503482169188;4795.400574928134;5095;5134.793323569033;5152.690838549699;5154.14956532168;5384.4346343634925;5390.299261096033;5407.459254074718;5433.505785908907;5452.26394436746;3982.522097348337;4044.7977601120415;4123;4143.005678637166;4189.97905010473;5842.766289348378;5850.268716410449;5867.589268751147;5886.146508756121;5907.616004959664;5477.890442191214;5747.453991870766;5749.281339832521;5781.335146458211;5826.679532625746;5785.884282314246;5820.854478638068;5831.79588714393;5832.62087964281;5839.416058394127;5734.283214598176;5741.966446039753;5756.042945398584;5793.565482588907;5804.361520232856;5765.308163020464;5908.602553531822;5910.7635694573455;5942.851428714143;5974.462298393166;5739.253896993531;5770.5095066919785;5777.584491799536;5792.478676919098;5797.5361971041375 15:57:20 INFO - PROCESS | 30494 | |5;yui.html;683.9829004274894;718.7735863203094;748.8202831320484;759.2786852490136;822.3996482567727;16565.171741412927;17267.222974966124;17326.56683582908;17404.47786566402;17499.825001749978;15722.292496837641;15876.285567149476;15896;15897.1256580888;15901.840981590181;668.8662267546486;800.3957012455602;801.1467786807061;814.5479259011246;817.3338728935928;831.9251267385933;834.5368320582074;834.8246868157694;838.3963546246692;839.3830534557096;875.4222213339198;875.6409871952501;875.7372788163525;876.1720174435161;879.3361012435602;870.8911386076741;873.5501216873283;876.0669886570845;877.0527829943645;877.3025444771422;629.5341447328989;633.9651319177443;635.4598591197491;635.8315046512678;636.8949123394634;15113.54659360221;15246.695066098728;15252.466163684217;15295.923520382326;15348.693026139415;14410.423583056665;14669.706605867823;15398.07611543311;15579.610509737347;15992.600184995352;13677.452901883913;13725.725485490335;13767.724645507134;13904.652383690387;14047.22740249286;4629.791659375336;4652.092841895832;4684.3910291662205;4752.809887604491;4825.372701548777;85699.14300856974;90242.09757902402;91722;92445.53777231071;92767.07232927652;11230.831537526943;11405.828912566318;11522.942385288019;11576.76846463066;11644.184907056595;18717.532061698566;18787;18811.435656930313;19345.226190952206;19743.308984185773;8325.084240733515;8576.828463430697;8724.607392667218;8931.642734290686;9207.309451791009;4661.95338046622;4713.905721885543;4747.738874361874;4886.438059623118;4982.352294201731;3686.115332320224;3811.1615444602144;3830.9042273943373;3838.405047217686;3842.269968705937;686.2417029182781;688.1226436293665;689.334791925794;694.187800273681;695.02696225285;620.5035971223003;678.6301465701205;683.8700646877078;685.5715178013742;704.0600797934815;9520.904790952001;9893.752656183653;9918.851217231748;10051.59793608262;10306.793864122825;617.2500411999442;648.8978134319824;669.7488441834312;689.0112688292216;720.038748271064;4828.227483602677;4876.926846097312;4900.534449227318;4925.142023530346;5025.422076461181;101333;118666.40666796784;119076.40461797809;121269;121423.39288303502;91156;93963.53018234865;104075;105355;106523.46738266414;88641.55679221563;89447.55276223707;90216;92545.53727231456;92978;9891;10209.591616335263;10255.487225638837;10451.738706532398;10556.208284378856;51967.480325196266;52123.21815172851;52363;52924.206136908746;53622.195667065804;70747.64626176836;79696;79724;81710.59144704239;82004.17995819966;13180.324935763525;13397.263150526815;13503.932480337535;13545.59363219105;13662.521811736542;15400.306986185873;15460.304286306919;15807.920960395584;15968.600784980004;16531.33874645001;14099.506517272257;14123.152610843383;14263.714725705635;14698.191599462132;15093.47172848945;14068.437262509386;14280.857191427953;14447.638809029859;15372.846271537588;15419.845801541842;14064.226467543975;14088.520705325793;14227.359768810222;14686.265686715835;15206.847931520986;11516.366599837089;11629.18595698293;11938.52245910154;12201.816972745593;12333.444994975069;11583;12021.338826364285;12244.897959183645;12255.75488490243;12358.44387002569 15:57:20 INFO - PROCESS | 30494 | __end_tp_report 15:57:20 INFO - PROCESS | 30494 | __start_cc_report 15:57:20 INFO - PROCESS | 30494 | _x_x_mozilla_cycle_collect,330 15:57:20 INFO - PROCESS | 30494 | __end_cc_report 15:57:20 INFO - PROCESS | 30494 | __startTimestamp1470351440830__endTimestamp 15:57:20 INFO - PROCESS | 30494 | 15:57:20 INFO - PROCESS | 30494 | ------- Summary: start ------- 15:57:20 INFO - PROCESS | 30494 | Number of tests: 6 15:57:20 INFO - PROCESS | 30494 | 15:57:20 INFO - PROCESS | 30494 | [#0] dojo.html Cycles:165 Average:5262.18 Median:5439.27 stddev:692.13 (12.7%) stddev-sans-first:672.09 15:57:20 INFO - PROCESS | 30494 | Values: 3047.7 3062.7 3064.2 3083.1 3092.6 5210.1 5349.0 5355.2 5377.9 5416.7 5329.3 5381.4 5391.2 5391.6 5400.5 4845.5 4884.9 4886.5 4911.8 4928.2 4904.9 4958.7 4969.3 4996.7 5050.4 791.0 4996.7 5016.0 5021.4 5050.7 4829.1 4966.4 4984.2 4993.0 5007.9 4849.3 4849.9 4855.6 4856.1 4906.1 5273.2 5334.3 5345.3 5348.1 5353.0 5547.1 5702.3 5719.7 5742.3 5854.1 5826.4 5833.5 5835.9 5841.5 5847.7 5398.9 5427.3 5433.1 5439.3 5450.5 5650.5 5655.9 5704.0 5732.7 5796.0 5474.2 5484.9 5496.2 5497.1 5500.0 5567.7 5573.9 5596.1 5596.4 5656.7 5450.7 5487.8 5488.8 5558.8 5573.8 5495.5 5518.3 5523.7 5530.8 5535.1 4297.5 4303.4 4303.5 4337.4 4342.5 3756.1 3794.4 3828.3 3845.4 3847.2 5282.7 5356.9 5365.3 5381.8 5423.7 5538.6 5649.5 5649.7 5652.7 5659.6 5237.3 5294.9 5339.2 5339.7 5413.0 4820.9 4841.5 4848.0 4849.1 4883.1 5681.1 5807.1 5856.8 5871.6 5877.3 5722.4 5734.5 5750.0 5834.3 5849.9 5992.6 6016.3 6048.1 6055.6 6064.3 5364.1 5692.3 5692.5 5709.9 5720.1 5702.7 5727.5 5762.8 5799.6 5831.0 5563.6 5612.4 5629.4 5645.4 5659.8 5322.6 5633.5 5633.7 5646.7 5654.1 5346.8 5373.1 5395.6 5414.1 5431.2 5529.6 5532.0 5536.4 5547.1 5559.2 5284.2 5392.4 5405.4 5442.1 5460.3 15:57:20 INFO - PROCESS | 30494 | 15:57:20 INFO - PROCESS | 30494 | [#1] ext.html Cycles:180 Average:66614.91 Median:24637.51 stddev:134746.21 (546.9%) stddev-sans-first:135032.91 15:57:20 INFO - PROCESS | 30494 | Values: 548.7 582.6 585.5 608.9 619.5 39809.6 44710.0 44795.6 44798.8 44854.8 45200.3 45695.8 45717.3 45870.0 46130.0 8939.2 8986.6 9058.9 9073.2 9086.0 8945.5 9084.5 9084.5 9086.0 9113.4 9125.0 9158.5 9171.2 9172.3 9189.7 9021.1 9021.8 9090.9 9096.4 9146.9 8902.1 8969.1 8973.7 8977.3 8986.5 43505.8 44031.6 44233.3 44247.6 44342.1 3522.9 3596.1 3690.7 3739.6 3806.3 32371.5 35240.6 35271.6 35372.8 35405.3 4287.7 4456.3 4479.5 4561.1 4611.3 389597.0 390389.0 391557.0 393528.0 393763.0 55637.4 62817.0 64033.0 64058.4 64716.0 68776.3 68888.3 68896.7 68911.6 69292.0 17703.6 17819.9 17843.8 17990.6 18000.5 13724.9 13801.0 13805.2 13809.1 13814.3 19478.1 19514.9 19578.8 19592.7 19707.8 7110.6 7147.5 7284.9 7452.6 7514.7 968.4 1041.6 1088.2 1126.9 1154.5 32746.2 32942.0 33198.3 33224.0 33513.5 1119.7 1121.9 1149.2 1149.8 1202.9 17546.8 17652.3 17703.3 17784.7 18003.2 608182.0 612059.0 612373.0 612459.0 614371.0 61163.4 62642.1 62683.0 62790.1 62935.4 1347.9 1391.5 1395.0 1413.9 1418.4 31424.2 32532.2 32822.7 33355.3 33927.7 54741.5 55145.4 55171.2 55188.4 55193.7 490166.0 492228.0 493826.0 494949.0 494977.0 29568.3 29633.7 30193.2 30316.7 30388.0 50712.7 50796.0 51033.0 51733.0 52217.0 41403.9 43983.8 44645.0 45289.0 48024.5 45392.8 45634.5 45973.0 46450.8 46673.8 42213.0 43228.4 43408.8 43608.1 45073.3 36322.0 38025.1 40091.6 40284.8 40657.0 29293.4 29479.3 29895.0 29895.6 30117.5 15:57:20 INFO - PROCESS | 30494 | 15:57:20 INFO - PROCESS | 30494 | [#2] jquery.html Cycles:180 Average:29015.56 Median:13493.63 stddev:78852.26 (584.4%) stddev-sans-first:79044.13 15:57:20 INFO - PROCESS | 30494 | Values: 373.6 383.4 391.3 394.4 413.0 15948.5 18804.2 19709.7 20430.3 20492.0 19504.6 19718.3 19756.2 20276.6 20373.1 5427.9 5770.7 5775.2 5782.0 5800.2 5540.5 5687.9 5694.0 5761.8 5764.1 5759.5 5795.3 5827.5 5836.3 5838.0 5617.9 5738.0 5761.2 5821.5 5842.1 5123.9 5129.9 5133.8 5135.6 5142.4 14370.0 22663.2 23711.2 23759.5 24164.4 2321.8 2351.4 2822.9 2967.8 2995.0 10529.7 11043.4 11089.8 11131.1 11139.3 1968.4 1978.2 1985.9 2068.1 2080.1 81306.4 86294.0 86454.0 89119.0 93504.5 10621.3 11088.0 11199.6 11256.6 11407.6 13907.0 14776.9 15690.5 15691.5 15858.8 8346.4 8486.4 8574.4 8760.4 8799.3 7624.5 8123.3 8394.9 8398.9 8644.2 4767.1 4835.8 4869.4 4873.9 5022.8 1956.5 2004.8 2007.5 2039.7 2051.4 910.2 963.1 1017.2 1023.8 1048.4 19825.5 20001.0 20129.7 20321.5 20593.3 1020.7 1040.2 1045.5 1051.4 1059.4 10557.5 10999.5 11056.8 11154.9 11202.1 458666.0 459654.0 464800.0 497524.0 501853.0 80896.8 94511.5 94831.5 95730.0 97638.5 959.1 986.3 994.4 997.2 1027.6 17791.6 17855.6 18079.5 18149.6 18464.2 42806.4 43327.8 43815.3 43888.6 43947.8 56717.7 56867.0 59777.4 60892.0 61153.0 8194.3 8306.9 8427.7 8480.7 8729.2 13158.9 13388.2 13425.3 13438.9 13857.9 11359.0 11785.5 11846.2 12088.3 12316.4 11550.6 11600.4 11603.8 11682.0 12280.6 11905.5 12036.2 12199.1 12208.1 12325.9 8599.3 8708.4 8794.1 8840.6 8888.2 10948.4 11810.6 11858.8 11862.8 12294.3 15:57:20 INFO - PROCESS | 30494 | 15:57:20 INFO - PROCESS | 30494 | [#3] mootools.html Cycles:180 Average:5824.05 Median:4766.98 stddev:3279.87 (68.8%) stddev-sans-first:3272.79 15:57:20 INFO - PROCESS | 30494 | Values: 1475.6 1484.8 1599.7 1750.6 1751.8 7894.0 8020.5 8621.1 9325.2 9333.3 8434.3 8606.4 8635.7 8717.5 8794.4 2344.5 2380.3 2382.6 2387.8 2395.9 2203.3 2215.7 2234.1 2238.7 2240.4 2295.4 2298.2 2311.7 2337.5 2348.2 2240.0 2255.9 2263.2 2266.7 2269.4 2185.8 2216.9 2225.2 2225.8 2230.0 8683.6 8750.6 8751.5 8759.1 8759.3 5203.2 5254.2 5297.1 5317.8 5323.9 3240.1 3244.1 3426.6 3442.3 3448.3 1139.3 1154.1 1161.2 1171.2 1195.3 11675.4 11985.8 12150.5 12166.6 12227.8 4568.3 4582.8 4775.4 4777.4 4818.7 10449.0 10528.3 10553.2 10640.3 10720.0 5285.0 5366.1 5385.9 5396.2 5400.6 4333.3 4634.7 4758.6 4789.1 4856.4 3964.9 4003.1 4063.9 4107.7 4113.7 1296.3 1300.5 1306.6 1316.0 1319.3 919.6 1008.9 1053.3 1056.5 1062.5 6046.1 6204.1 6240.4 6304.7 6509.4 967.3 1054.2 1057.0 1057.6 1085.4 4050.8 4226.7 4444.2 4499.0 4578.2 10684.7 10986.7 11094.4 11098.4 11223.6 10724.5 11202.6 11333.2 11367.1 11375.2 7990.9 8098.8 8170.1 8287.4 8355.3 5927.6 5955.8 6037.1 6063.8 6079.2 9763.9 9819.9 9865.8 9882.7 9925.9 9743.0 9874.9 10515.7 10637.2 10696.3 6581.8 7066.1 7231.2 7577.8 7622.8 8454.4 8590.4 8612.7 8635.0 8659.2 7441.8 7642.1 7692.2 7743.9 7836.9 7484.6 7519.9 7531.2 7621.2 7656.8 6850.6 6901.2 6954.3 6982.7 7001.2 5197.6 5394.3 5398.6 5447.4 5695.6 5370.9 5385.6 5468.9 5505.5 5587.5 15:57:20 INFO - PROCESS | 30494 | 15:57:20 INFO - PROCESS | 30494 | [#4] prototype.html Cycles:180 Average:4679.48 Median:5189.56 stddev:1355.98 (26.1%) stddev-sans-first:1319.86 15:57:20 INFO - PROCESS | 30494 | Values: 327.8 334.6 335.4 340.4 340.7 5331.4 5477.4 5542.5 5644.0 5654.3 5463.8 5495.0 5503.8 5511.5 5516.0 4329.5 4332.9 4333.1 4372.9 4385.7 4214.7 4295.6 4341.8 4364.4 4375.2 4284.9 4297.4 4299.3 4302.4 4334.0 4315.1 4334.8 4335.6 4345.6 4391.9 3542.7 3841.2 3852.9 3855.2 3873.1 5310.8 5373.4 5380.3 5383.0 5392.1 4887.3 4907.6 4908.0 4909.8 4917.6 5449.9 5657.2 5749.3 5752.4 5766.7 4049.9 4051.6 4056.0 4058.0 4079.1 5947.8 5949.2 5971.8 5973.6 6088.9 3989.9 4171.1 4174.9 4214.7 4231.9 4232.7 4250.5 4259.6 4288.8 4295.1 4898.2 4915.8 4920.7 4930.4 4931.3 5591.7 5785.4 5879.4 5882.4 5889.9 1442.4 1448.3 1462.6 1471.2 1474.9 893.6 931.5 935.9 945.6 947.6 4890.9 4894.7 4922.3 4941.4 4969.6 5139.3 5159.0 5184.2 5194.9 5213.2 4725.2 4900.6 4907.6 4928.6 4984.4 2750.6 2759.7 2771.6 2785.6 2803.3 5401.7 5450.3 5481.6 5481.8 5506.5 5106.7 5206.4 5213.8 5321.5 5340.5 5306.3 5343.4 5375.4 5384.5 5396.2 5172.6 5177.3 5195.0 5221.3 5226.5 4795.4 5095.0 5134.8 5152.7 5154.1 5384.4 5390.3 5407.5 5433.5 5452.3 3982.5 4044.8 4123.0 4143.0 4190.0 5842.8 5850.3 5867.6 5886.1 5907.6 5477.9 5747.5 5749.3 5781.3 5826.7 5785.9 5820.9 5831.8 5832.6 5839.4 5734.3 5742.0 5756.0 5793.6 5804.4 5765.3 5908.6 5910.8 5942.9 5974.5 5739.3 5770.5 5777.6 5792.5 5797.5 15:57:20 INFO - PROCESS | 30494 | 15:57:20 INFO - PROCESS | 30494 | [#5] yui.html Cycles:180 Average:21891.78 Median:4657.02 stddev:31398.17 (674.2%) stddev-sans-first:31445.86 15:57:20 INFO - PROCESS | 30494 | Values: 684.0 718.8 748.8 759.3 822.4 16565.2 17267.2 17326.6 17404.5 17499.8 15722.3 15876.3 15896.0 15897.1 15901.8 668.9 800.4 801.1 814.5 817.3 831.9 834.5 834.8 838.4 839.4 875.4 875.6 875.7 876.2 879.3 870.9 873.6 876.1 877.1 877.3 629.5 634.0 635.5 635.8 636.9 15113.5 15246.7 15252.5 15295.9 15348.7 14410.4 14669.7 15398.1 15579.6 15992.6 13677.5 13725.7 13767.7 13904.7 14047.2 4629.8 4652.1 4684.4 4752.8 4825.4 85699.1 90242.1 91722.0 92445.5 92767.1 11230.8 11405.8 11522.9 11576.8 11644.2 18717.5 18787.0 18811.4 19345.2 19743.3 8325.1 8576.8 8724.6 8931.6 9207.3 4662.0 4713.9 4747.7 4886.4 4982.4 3686.1 3811.2 3830.9 3838.4 3842.3 686.2 688.1 689.3 694.2 695.0 620.5 678.6 683.9 685.6 704.1 9520.9 9893.8 9918.9 10051.6 10306.8 617.3 648.9 669.7 689.0 720.0 4828.2 4876.9 4900.5 4925.1 5025.4 101333.0 118666.4 119076.4 121269.0 121423.4 91156.0 93963.5 104075.0 105355.0 106523.5 88641.6 89447.6 90216.0 92545.5 92978.0 9891.0 10209.6 10255.5 10451.7 10556.2 51967.5 52123.2 52363.0 52924.2 53622.2 70747.6 79696.0 79724.0 81710.6 82004.2 13180.3 13397.3 13503.9 13545.6 13662.5 15400.3 15460.3 15807.9 15968.6 16531.3 14099.5 14123.2 14263.7 14698.2 15093.5 14068.4 14280.9 14447.6 15372.8 15419.8 14064.2 14088.5 14227.4 14686.3 15206.8 11516.4 11629.2 11938.5 12201.8 12333.4 11583.0 12021.3 12244.9 12255.8 12358.4 15:57:20 INFO - PROCESS | 30494 | -------- Summary: end -------- 15:57:20 INFO - PROCESS | 30494 | 15:57:21 INFO - TEST-INFO | 30494: exit 0 15:57:21 INFO - TEST-OK | dromaeo_css | took 1112718ms 15:57:21 INFO - TEST-START | kraken 15:57:21 INFO - operating with platform_type : linux_ 15:57:21 INFO - Initialising browser for kraken test... 15:57:21 INFO - TEST-INFO | started process 30855 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpi5lCwA/profile http://localhost:44115/getInfo.html) 15:57:26 INFO - PROCESS | 30855 | __metrics Screen width/height:1600/1200 15:57:26 INFO - PROCESS | 30855 | colorDepth:24 15:57:26 INFO - PROCESS | 30855 | Browser inner width/height: 1024/697 15:57:26 INFO - PROCESS | 30855 | __metrics 15:57:27 ERROR - PROCESS | 30855 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 15:57:28 INFO - TEST-INFO | 30855: exit 0 15:57:28 INFO - Browser initialized. 15:57:28 INFO - Running cycle 1/1 for kraken test... 15:57:28 INFO - TEST-INFO | started process 30975 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpi5lCwA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:57:39 INFO - PROCESS | 30975 | RSS: Main: 164081664 15:57:39 INFO - PROCESS | 30975 | 15:57:42 INFO - PROCESS | 30975 | Cycle 1(1): loaded http://localhost:44115/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44115/tests/kraken/driver.html?testName=audio-beat-detection) 15:57:43 INFO - PROCESS | 30975 | RSS: Main: 169574400 15:57:43 INFO - PROCESS | 30975 | 15:57:45 INFO - PROCESS | 30975 | Cycle 1(1): loaded http://localhost:44115/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44115/tests/kraken/driver.html?testName=audio-dft) 15:57:46 INFO - PROCESS | 30975 | RSS: Main: 168636416 15:57:46 INFO - PROCESS | 30975 | 15:57:49 INFO - PROCESS | 30975 | Cycle 1(1): loaded http://localhost:44115/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44115/tests/kraken/driver.html?testName=audio-fft) 15:57:49 INFO - PROCESS | 30975 | RSS: Main: 164397056 15:57:49 INFO - PROCESS | 30975 | 15:57:52 INFO - PROCESS | 30975 | Cycle 1(1): loaded http://localhost:44115/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44115/tests/kraken/driver.html?testName=audio-oscillator) 15:57:52 INFO - PROCESS | 30975 | RSS: Main: 166006784 15:57:52 INFO - PROCESS | 30975 | 15:57:54 INFO - PROCESS | 30975 | Cycle 1(1): loaded http://localhost:44115/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44115/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:57:55 INFO - PROCESS | 30975 | RSS: Main: 166170624 15:57:55 INFO - PROCESS | 30975 | 15:57:58 INFO - PROCESS | 30975 | Cycle 1(1): loaded http://localhost:44115/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44115/tests/kraken/driver.html?testName=imaging-darkroom) 15:57:59 INFO - PROCESS | 30975 | RSS: Main: 165306368 15:57:59 INFO - PROCESS | 30975 | 15:58:02 INFO - PROCESS | 30975 | Cycle 1(1): loaded http://localhost:44115/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44115/tests/kraken/driver.html?testName=imaging-desaturate) 15:58:03 INFO - PROCESS | 30975 | RSS: Main: 167194624 15:58:03 INFO - PROCESS | 30975 | 15:58:06 INFO - PROCESS | 30975 | Cycle 1(1): loaded http://localhost:44115/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44115/tests/kraken/driver.html?testName=json-parse-financial) 15:58:06 INFO - PROCESS | 30975 | RSS: Main: 166813696 15:58:06 INFO - PROCESS | 30975 | 15:58:08 INFO - PROCESS | 30975 | Cycle 1(1): loaded http://localhost:44115/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44115/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:58:09 INFO - PROCESS | 30975 | RSS: Main: 166342656 15:58:09 INFO - PROCESS | 30975 | 15:58:10 INFO - PROCESS | 30975 | Cycle 1(1): loaded http://localhost:44115/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44115/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:58:11 INFO - PROCESS | 30975 | RSS: Main: 166920192 15:58:11 INFO - PROCESS | 30975 | 15:58:13 INFO - PROCESS | 30975 | Cycle 1(1): loaded http://localhost:44115/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44115/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:58:14 INFO - PROCESS | 30975 | RSS: Main: 167075840 15:58:14 INFO - PROCESS | 30975 | 15:58:16 INFO - PROCESS | 30975 | Cycle 1(1): loaded http://localhost:44115/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44115/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:58:17 INFO - PROCESS | 30975 | RSS: Main: 167366656 15:58:17 INFO - PROCESS | 30975 | 15:58:20 INFO - PROCESS | 30975 | Cycle 1(1): loaded http://localhost:44115/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44115/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:58:20 INFO - PROCESS | 30975 | RSS: Main: 167555072 15:58:20 INFO - PROCESS | 30975 | 15:58:22 INFO - PROCESS | 30975 | Cycle 1(1): loaded http://localhost:44115/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44115/tests/kraken/driver.html?testName=ai-astar) 15:58:22 INFO - PROCESS | 30975 | RSS: Main: 168431616 15:58:22 INFO - PROCESS | 30975 | 15:58:22 INFO - PROCESS | 30975 | __start_tp_report 15:58:22 INFO - PROCESS | 30975 | _x_x_mozilla_page_load 15:58:22 INFO - PROCESS | 30975 | _x_x_mozilla_page_load_details 15:58:22 INFO - PROCESS | 30975 | |i|pagename|runs| 15:58:22 INFO - PROCESS | 30975 | |0;ai-astar;103;111;106;111;113;112;114;110;112;111 15:58:22 INFO - PROCESS | 30975 | |1;audio-beat-detection;148;123;148;186;119;144;152;120;191;119 15:58:22 INFO - PROCESS | 30975 | |2;audio-dft;164;164;163;164;163;163;169;162;163;163 15:58:22 INFO - PROCESS | 30975 | |3;audio-fft;76;76;75;189;76;75;78;74;160;77 15:58:22 INFO - PROCESS | 30975 | |4;audio-oscillator;84;84;151;83;84;84;136;84;84;141 15:58:22 INFO - PROCESS | 30975 | |5;imaging-gaussian-blur;117;118;117;117;117;118;117;117;118;118 15:58:22 INFO - PROCESS | 30975 | |6;imaging-darkroom;147;146;147;147;147;146;147;147;148;154 15:58:22 INFO - PROCESS | 30975 | |7;imaging-desaturate;100;97;95;95;95;95;96;96;97;95 15:58:22 INFO - PROCESS | 30975 | |8;json-parse-financial;52;51;51;52;60;53;53;51;54;50 15:58:22 INFO - PROCESS | 30975 | |9;json-stringify-tinderbox;61;61;61;61;61;60;61;65;61;61 15:58:22 INFO - PROCESS | 30975 | |10;stanford-crypto-aes;76;80;75;76;80;86;75;76;83;76 15:58:22 INFO - PROCESS | 30975 | |11;stanford-crypto-ccm;129;143;132;131;143;125;135;124;140;138 15:58:22 INFO - PROCESS | 30975 | |12;stanford-crypto-pbkdf2;163;162;163;158;159;163;161;161;160;160 15:58:22 INFO - PROCESS | 30975 | |13;stanford-crypto-sha256-iterative;67;65;65;64;65;65;65;64;72;67 15:58:22 INFO - PROCESS | 30975 | __end_tp_report 15:58:22 INFO - PROCESS | 30975 | __start_cc_report 15:58:22 INFO - PROCESS | 30975 | _x_x_mozilla_cycle_collect,851 15:58:22 INFO - PROCESS | 30975 | __end_cc_report 15:58:22 INFO - PROCESS | 30975 | __startTimestamp1470351502859__endTimestamp 15:58:22 INFO - PROCESS | 30975 | 15:58:22 INFO - PROCESS | 30975 | ------- Summary: start ------- 15:58:22 INFO - PROCESS | 30975 | Number of tests: 14 15:58:22 INFO - PROCESS | 30975 | 15:58:22 INFO - PROCESS | 30975 | [#0] ai-astar Cycles:10 Average:110.30 Median:111.50 stddev:3.33 (3.0%) stddev-sans-first:2.26 15:58:22 INFO - PROCESS | 30975 | Values: 103.0 111.0 106.0 111.0 113.0 112.0 114.0 110.0 112.0 111.0 15:58:22 INFO - PROCESS | 30975 | 15:58:22 INFO - PROCESS | 30975 | [#1] audio-beat-detection Cycles:10 Average:145.00 Median:148.00 stddev:26.51 (17.9%) stddev-sans-first:28.10 15:58:22 INFO - PROCESS | 30975 | Values: 148.0 123.0 148.0 186.0 119.0 144.0 152.0 120.0 191.0 119.0 15:58:22 INFO - PROCESS | 30975 | 15:58:22 INFO - PROCESS | 30975 | [#2] audio-dft Cycles:10 Average:163.80 Median:163.50 stddev:1.93 (1.2%) stddev-sans-first:2.05 15:58:22 INFO - PROCESS | 30975 | Values: 164.0 164.0 163.0 164.0 163.0 163.0 169.0 162.0 163.0 163.0 15:58:22 INFO - PROCESS | 30975 | 15:58:22 INFO - PROCESS | 30975 | [#3] audio-fft Cycles:10 Average:95.60 Median:76.00 stddev:42.16 (55.5%) stddev-sans-first:44.11 15:58:22 INFO - PROCESS | 30975 | Values: 76.0 76.0 75.0 189.0 76.0 75.0 78.0 74.0 160.0 77.0 15:58:22 INFO - PROCESS | 30975 | 15:58:22 INFO - PROCESS | 30975 | [#4] audio-oscillator Cycles:10 Average:101.50 Median:84.00 stddev:28.64 (34.1%) stddev-sans-first:29.67 15:58:22 INFO - PROCESS | 30975 | Values: 84.0 84.0 151.0 83.0 84.0 84.0 136.0 84.0 84.0 141.0 15:58:22 INFO - PROCESS | 30975 | 15:58:22 INFO - PROCESS | 30975 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 15:58:22 INFO - PROCESS | 30975 | Values: 117.0 118.0 117.0 117.0 117.0 118.0 117.0 117.0 118.0 118.0 15:58:22 INFO - PROCESS | 30975 | 15:58:22 INFO - PROCESS | 30975 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:147.00 stddev:2.32 (1.6%) stddev-sans-first:2.45 15:58:22 INFO - PROCESS | 30975 | Values: 147.0 146.0 147.0 147.0 147.0 146.0 147.0 147.0 148.0 154.0 15:58:22 INFO - PROCESS | 30975 | 15:58:22 INFO - PROCESS | 30975 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:95.50 stddev:1.60 (1.7%) stddev-sans-first:0.87 15:58:22 INFO - PROCESS | 30975 | Values: 100.0 97.0 95.0 95.0 95.0 95.0 96.0 96.0 97.0 95.0 15:58:22 INFO - PROCESS | 30975 | 15:58:22 INFO - PROCESS | 30975 | [#8] json-parse-financial Cycles:10 Average:52.70 Median:52.50 stddev:2.83 (5.4%) stddev-sans-first:2.99 15:58:22 INFO - PROCESS | 30975 | Values: 52.0 51.0 51.0 52.0 60.0 53.0 53.0 51.0 54.0 50.0 15:58:22 INFO - PROCESS | 30975 | 15:58:22 INFO - PROCESS | 30975 | [#9] json-stringify-tinderbox Cycles:10 Average:61.30 Median:61.00 stddev:1.34 (2.2%) stddev-sans-first:1.41 15:58:22 INFO - PROCESS | 30975 | Values: 61.0 61.0 61.0 61.0 61.0 60.0 61.0 65.0 61.0 61.0 15:58:22 INFO - PROCESS | 30975 | 15:58:22 INFO - PROCESS | 30975 | [#10] stanford-crypto-aes Cycles:10 Average:78.30 Median:78.00 stddev:3.80 (4.9%) stddev-sans-first:3.94 15:58:22 INFO - PROCESS | 30975 | Values: 76.0 80.0 75.0 76.0 80.0 86.0 75.0 76.0 83.0 76.0 15:58:22 INFO - PROCESS | 30975 | 15:58:22 INFO - PROCESS | 30975 | [#11] stanford-crypto-ccm Cycles:10 Average:134.00 Median:136.50 stddev:6.94 (5.1%) stddev-sans-first:7.13 15:58:22 INFO - PROCESS | 30975 | Values: 129.0 143.0 132.0 131.0 143.0 125.0 135.0 124.0 140.0 138.0 15:58:22 INFO - PROCESS | 30975 | 15:58:22 INFO - PROCESS | 30975 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.00 Median:161.50 stddev:1.76 (1.1%) stddev-sans-first:1.72 15:58:22 INFO - PROCESS | 30975 | Values: 163.0 162.0 163.0 158.0 159.0 163.0 161.0 161.0 160.0 160.0 15:58:22 INFO - PROCESS | 30975 | 15:58:22 INFO - PROCESS | 30975 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.90 Median:65.00 stddev:2.38 (3.7%) stddev-sans-first:2.49 15:58:22 INFO - PROCESS | 30975 | Values: 67.0 65.0 65.0 64.0 65.0 65.0 65.0 64.0 72.0 67.0 15:58:22 INFO - PROCESS | 30975 | -------- Summary: end -------- 15:58:22 INFO - PROCESS | 30975 | 15:58:23 INFO - TEST-INFO | 30975: exit 0 15:58:23 INFO - TEST-OK | kraken | took 62299ms 15:58:23 INFO - SUITE-END | took 1175s 15:58:24 INFO - Completed test suite (00:19:35) 15:58:24 INFO - javascript benchmark 15:58:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7394.224398632133, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3047.6952304769525, 3062.6784187660296, 3064.203307140143, 3083.059666801625, 3092.5825013623166, 5210.088234558956, 5348.973255133724, 5355.196720491923, 5377.91933121003, 5416.674999500033, 5329.280547126137, 5381.408045115034, 5391.218273350371, 5391.622586418943, 5400.486953739389, 4845.5396737310075, 4884.87787805305, 4886.462489126193, 4911.8280860169725, 4928.186849169901, 4904.926426103611, 4958.652894297383, 4969.25461180824, 4996.650234483587, 5050.393952725678, 791.0301136602703, 4996.7001979881325, 5016.046951079284, 5021.397432308128, 5050.747462626872, 4829.082474329866, 4966.428860681031, 4984.2025275955675, 4993.0, 5007.924881126786, 4849.321095046696, 4849.927251091236, 4855.5872750816225, 4856.1016212000895, 4906.141425250603, 5273.235380869753, 5334.253204551366, 5345.251664766935, 5348.064088784486, 5353.03645343838, 5547.140193270049, 5702.258706368187, 5719.6854173020465, 5742.253507044099, 5854.063349864044, 5826.359100498942, 5833.533317334603, 5835.941640583582, 5841.532677385799, 5847.678377689225, 5398.865028374244, 5427.267318911975, 5433.1035379162395, 5439.265699130646, 5450.509454149145, 5650.491455769001, 5655.943440565542, 5703.971480142655, 5732.71336433185, 5796.0436527972415, 5474.151506516497, 5484.91772623411, 5496.203050557727, 5497.147942068906, 5500.009998200282, 5567.749451274703, 5573.888522229614, 5596.132599447093, 5596.384397716248, 5656.745446454919, 5450.700211488406, 5487.807926722546, 5488.807891723771, 5558.805441809517, 5573.7770489179975, 5495.53287970527, 5518.2826232589505, 5523.6685798852195, 5530.751116199781, 5535.114381698909, 4297.54875738043, 4303.397524346594, 4303.526612072669, 4337.436133302651, 4342.544032876565, 3756.0609847538117, 3794.430835374716, 3828.2917660232947, 3845.403962385835, 3847.249786291702, 5282.735863206824, 5356.866078348073, 5365.275687782178, 5381.811636592701, 5423.674579525241, 5538.6122971391615, 5649.491545760901, 5649.661020338793, 5652.66084034951, 5659.5755318351285, 5237.292965449692, 5294.867628309246, 5339.172428273624, 5339.733013349317, 5413.02565538199, 4820.903581928342, 4841.491643377465, 4847.975760121248, 4849.102915960559, 4883.072216278967, 5681.0626246668835, 5807.128930660435, 5856.795012174553, 5871.618344807659, 5877.265341832271, 5722.370539240764, 5734.483896449339, 5749.97125014389, 5834.329052159056, 5849.853753656193, 5992.64044157352, 6016.278046634432, 6048.12302216185, 6055.576109672457, 6064.272287325549, 5364.061289274439, 5692.260006199168, 5692.5445964321925, 5709.942900570941, 5720.141978703228, 5702.6863522506665, 5727.541796656341, 5762.827115186551, 5799.623024503394, 5831.0378787499585, 5563.610547261815, 5612.410696876933, 5629.352624448241, 5645.379008309001, 5659.801906933238, 5322.627416080837, 5633.464820842013, 5633.6619802811965, 5646.745896434588, 5654.06707893193, 5346.786128554814, 5373.086575282289, 5395.595330350161, 5414.0525408052645, 5431.239626452379, 5529.557635389239, 5532.0, 5536.4186760389575, 5547.0570003098765, 5559.24950131727, 5284.180951952453, 5392.379876314118, 5405.432429594994, 5442.102053161184, 5460.31746031746], "value": 5218.113646641522, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [548.7165491187496, 582.6329412470146, 585.5140233606106, 608.8508315462711, 619.4982064527736, 39809.601903980954, 44710.0, 44795.552044479584, 44798.77600612, 44854.77572612133, 45200.321995170016, 45695.77152114235, 45717.31424028634, 45870.0, 46130.0, 8939.195472407499, 8986.595603197871, 9058.909410905906, 9073.183413492785, 9085.954570227139, 8945.523988541883, 9084.50035248061, 9084.545772711372, 9085.954570227139, 9113.362064655477, 9125.0, 9158.542072896362, 9171.220446262076, 9172.31207659425, 9189.678361257358, 9021.097890210993, 9021.819563608724, 9090.86363704545, 9096.408733432305, 9146.86279705805, 8902.065283145306, 8969.103089691043, 8973.730788076367, 8977.32670049749, 8986.505742184243, 43505.78247108744, 44031.559684403066, 44233.33649995253, 44247.557524424665, 44342.11315773699, 3522.947155792665, 3596.1009747563107, 3690.7231957603285, 3739.5886452490204, 3806.333891568992, 32371.514427283608, 35240.647593523994, 35271.64728352709, 35372.82313588416, 35405.29189416223, 4287.721298115613, 4456.286994080964, 4479.46246450428, 4561.064981678748, 4611.308303754464, 389597.0, 390389.0, 391557.0, 393528.0, 393763.0311848451, 55637.44362556404, 62817.0, 64033.0, 64058.35941640617, 64716.0, 68776.31223687799, 68888.31111688919, 68896.6555167221, 68911.58809441746, 69292.0, 17703.645927081645, 17819.910900445673, 17843.821561784476, 17990.550236243937, 18000.549986250448, 13724.862751372559, 13801.0, 13805.240711760749, 13809.102408343426, 13814.309284535733, 19478.123484443233, 19514.90242548778, 19578.804211957697, 19592.706109408085, 19707.814099842726, 7110.608916509538, 7147.463940204506, 7284.927150728425, 7452.602964251009, 7514.6618402172035, 968.41894863083, 1041.6041904076403, 1088.1892989722708, 1126.898579127866, 1154.5035634677001, 32746.181345466553, 32942.0, 33198.33603327968, 33224.0, 33513.497297540554, 1119.725667211522, 1121.9214654974237, 1149.1955631058127, 1149.8102813035755, 1202.8857258560422, 17546.824531754773, 17652.293908243526, 17703.291868325123, 17784.733229001577, 18003.18985645649, 608182.0, 612059.0, 612373.0, 612459.0, 614371.0, 61163.38836611577, 62642.0603690945, 62683.0, 62790.0581491278, 62935.37064629295, 1347.9258640774656, 1391.5268808605124, 1394.9511767088104, 1413.8868890488736, 1418.44680574576, 31424.214394640316, 32532.186695332806, 32822.67177328196, 33355.33289334151, 33927.66072339245, 54741.452585473635, 55145.44854551403, 55171.17243241274, 55188.44811551994, 55193.724031379585, 490166.0, 492228.0, 493826.0, 494949.0, 494977.0, 29568.33884950365, 29633.703662963093, 30193.245168870955, 30316.726245531234, 30388.0, 50712.74643626758, 50796.0, 51033.0, 51733.0, 52217.0, 41403.929803510306, 43983.78008109939, 44645.0, 45289.0, 48024.51975480201, 45392.77303613461, 45634.54365456436, 45973.0, 46450.76774616105, 46673.766631166625, 42213.0, 43228.351574727036, 43408.782956085015, 43608.12783744371, 45073.32390014218, 36322.0, 38025.14811389212, 40091.59908400878, 40284.798576006935, 40657.0, 29293.41413171682, 29479.26301842385, 29895.0, 29895.55156672695, 30117.548236776904], "value": 21235.133808748487, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [373.63943794238537, 383.38036391943183, 391.26051762169493, 394.4083874188717, 412.9896752581185, 15948.521544353658, 18804.24783008678, 19709.704354434696, 20430.2849400271, 20491.99999999998, 19504.60990780187, 19718.309859154895, 19756.209751609917, 20276.594468110667, 20373.083211255493, 5427.891442171164, 5770.653760774367, 5775.162601422791, 5782.0, 5800.15897694834, 5540.529055030327, 5687.943120568782, 5694.0, 5761.798337058204, 5764.135379693038, 5759.4528519790765, 5795.333536643277, 5827.475527202551, 5836.328822185439, 5837.978353788091, 5617.859553511154, 5738.0, 5761.164631128505, 5821.50517206038, 5842.123681447774, 5123.871903202413, 5129.9230511542355, 5133.84598462043, 5135.589152867761, 5142.357205349332, 14370.0, 22663.206787762512, 23711.1701090461, 23759.538172665943, 24164.39589010289, 2321.779430954057, 2351.4356554426986, 2822.872970716302, 2967.8219306841656, 2995.026616349695, 10529.736756581147, 11043.392613406259, 11089.778204435946, 11131.053860421875, 11139.331640101538, 1968.4193163016944, 1978.238378224394, 1985.851061170418, 2068.11071239367, 2080.136743251564, 81306.4150755519, 86294.0, 86454.0, 89119.0, 93504.53247733785, 10621.309614875008, 11088.0, 11199.60801371948, 11256.606018789304, 11407.600733974272, 13907.0, 14776.92611536957, 15690.450834220748, 15691.450799221973, 15858.841411585736, 8346.372457370875, 8486.363522735819, 8574.442661227, 8760.4305720128, 8799.29605631548, 7624.466287359943, 8123.268905798506, 8394.874076888851, 8398.874016889751, 8644.22202001823, 4767.118083154627, 4835.782389792397, 4869.415670119608, 4873.902521949542, 5022.773975171053, 1956.5402130499322, 2004.7894971028124, 2007.5382661987824, 2039.7144399784042, 2051.446109550443, 910.1717437132178, 963.0946909904667, 1017.1760873692333, 1023.8054769593754, 1048.449563978902, 19825.487922032036, 20001.0, 20129.698054529195, 20321.49196270105, 20593.279235226695, 1020.6886899495726, 1040.1730624153815, 1045.4720366215013, 1051.3586712105762, 1059.4332032362804, 10557.47212639365, 10999.450027498593, 11056.778864422666, 11154.944225278821, 11202.103831693445, 458666.0, 459654.0, 464800.0, 497524.0, 501853.0, 80896.78654820182, 94511.52744236235, 94831.52584237173, 95730.0, 97638.5118074405, 959.1176117971482, 986.3046552180696, 994.3785134291068, 997.1524204426324, 1027.5735569738624, 17791.555211119827, 17855.642887142443, 18079.548011299823, 18149.637007260044, 18464.169112390242, 42806.35790463208, 43327.78336108299, 43815.34276985784, 43888.561114388445, 43947.78026109849, 56717.71641141933, 56867.0, 59777.40222597718, 60892.0, 61153.0, 8194.262516373556, 8306.916930830856, 8427.705030323908, 8480.660773568989, 8729.170728780755, 13158.934205328913, 13388.19670819754, 13425.26161061151, 13438.932805335911, 13857.861421385656, 11359.0, 11785.469653865768, 11846.229995050295, 12088.335141567299, 12316.445759940645, 11550.59572914944, 11600.361980091177, 11603.825942610698, 11682.0, 12280.631581052225, 11905.46425410876, 12036.217645852992, 12199.085068620067, 12208.145429820182, 12325.876741232833, 8599.312055035458, 8708.433951793113, 8794.120587941155, 8840.557972101498, 8888.155625215593, 10948.397838118979, 11810.645680629596, 11858.76282474363, 11862.762744745229, 12294.262344259016], "value": 9386.880269907148, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1475.5573328001597, 1484.755015422455, 1599.7280462321412, 1750.6323672028873, 1751.7722696049511, 7893.960530197341, 8020.5187688738715, 8621.137886211376, 9325.16073553381, 9333.253339732822, 8434.283085937688, 8606.440581362207, 8635.654573817055, 8717.476951382921, 8794.384393092487, 2344.531093781242, 2380.333506618141, 2382.642603609464, 2387.761223877607, 2395.940101497468, 2203.316971738758, 2215.6565732311437, 2234.0728597631964, 2238.7201599800023, 2240.372695645222, 2295.4490922178725, 2298.161171172527, 2311.687922130516, 2337.520808234308, 2348.248560460653, 2239.9776002240014, 2255.909763609454, 2263.1739415113366, 2266.6713326567638, 2269.364577918169, 2185.841504002881, 2216.866987980726, 2225.1766846266823, 2225.8219342452567, 2230.018791731633, 8683.609237584324, 8750.606222719993, 8751.518666473341, 8759.080296568833, 8759.2992560595, 5203.245529398254, 5254.21186821976, 5297.12597421425, 5317.760700768436, 5323.946760532423, 3240.0927740232773, 3244.1403028197547, 3426.640202778697, 3442.294329662413, 3448.3448144852396, 1139.305023935407, 1154.128632882177, 1161.2335858333545, 1171.226990186473, 1195.3306148556749, 11675.416229188591, 11985.760284794254, 12150.45322960469, 12166.635000949986, 12227.816582751266, 4568.314752787042, 4582.793774280165, 4775.355327030876, 4777.426708794897, 4818.734969576707, 10449.0, 10528.26302158857, 10553.208509361828, 10640.255182137176, 10720.0, 5284.9735751320995, 5366.060939335601, 5385.946140538545, 5396.244525766396, 5400.567954563626, 4333.328334108218, 4634.652401069933, 4758.595519380822, 4789.090072886141, 4856.39295088114, 3964.900877478086, 4003.139325045129, 4063.923060388999, 4107.712460127762, 4113.732607380511, 1296.3388671777461, 1300.5383089003458, 1306.6145487081333, 1316.0392913173437, 1319.2612137203005, 919.6091661044029, 1008.9204551130221, 1053.257453495284, 1056.4559251985233, 1062.4634559547533, 6046.093086037042, 6204.100405441276, 6240.375962403814, 6304.65324407162, 6509.44669703071, 967.3277072434731, 1054.1935419404163, 1057.0, 1057.6404022632341, 1085.4193006741514, 4050.7569545826755, 4226.704130710882, 4444.2444784386735, 4498.955010449919, 4578.244589642672, 10684.732881678021, 10986.670399888017, 11094.445277736242, 11098.389588572545, 11223.55105795759, 10724.463776811284, 11202.551897923991, 11333.206675532634, 11367.147463940237, 11375.203735738585, 7990.9200907991335, 8098.797530061795, 8170.14213507585, 8287.378446616527, 8355.289800366916, 5927.644341339361, 5955.821325360246, 6037.094435834484, 6063.787767428119, 6079.240094988127, 9763.853542197015, 9819.870714867882, 9865.802683946424, 9882.703518894445, 9925.900740992498, 9742.95128524353, 9874.85187722199, 10515.684529464128, 10637.202209834139, 10696.251262411557, 6581.769638062645, 7066.081409416743, 7231.16841563227, 7577.810554736176, 7622.771316860503, 8454.36592255571, 8590.398672092893, 8612.65549378018, 8634.956825215833, 8659.220670139717, 7441.8139546511775, 7642.1184146596115, 7692.19231980634, 7743.883841742266, 7836.942012828195, 7484.625768711434, 7519.924800751923, 7531.171571127281, 7621.1616722161625, 7656.770296891103, 6850.554713943578, 6901.206361268318, 6954.3393377629045, 6982.7206911725, 7001.194862590867, 5197.610179236497, 5394.298741163623, 5398.595105367034, 5447.3735520414075, 5695.601307908407, 5370.946290537045, 5385.596080293915, 5468.91796623059, 5505.504504594605, 5587.497125258747], "value": 4686.255541363827, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [327.8491893728883, 334.6335762340237, 335.41637550661846, 340.4178854159387, 340.679761024637, 5331.413544510101, 5477.397486276506, 5542.528885044771, 5643.984082865082, 5654.349749778777, 5463.836084917459, 5495.0, 5503.807366742165, 5511.5039646431815, 5516.0, 4329.54539773324, 4332.891677708067, 4333.068390296085, 4372.934405983913, 4385.714928529651, 4214.704970652056, 4295.570442955711, 4341.78291085446, 4364.367166760818, 4375.234333991539, 4284.871453856389, 4297.355396690506, 4299.301775798558, 4302.440682711243, 4333.978330108345, 4315.136972605475, 4334.826606935703, 4335.566443355639, 4345.587169218919, 4391.890202744925, 3542.734294927865, 3841.2317536492815, 3852.8616617777125, 3855.1904100139004, 3873.1479074603544, 5310.831617044244, 5373.435789242112, 5380.273663055476, 5383.031054410205, 5392.083345831218, 4887.3402090717655, 4907.607391408679, 4907.950920490785, 4909.779059942275, 4917.582005529534, 5449.945500545023, 5657.179708942181, 5749.31008279005, 5752.424757524256, 5766.654000759968, 4049.9190016199805, 4051.6150965658217, 4055.959440405588, 4058.0, 4079.122988557445, 5947.762089516415, 5949.167116603679, 5971.790987315467, 5973.566344077391, 6088.8782224356155, 3989.862889076657, 4171.144915292358, 4174.853880114242, 4214.662826973835, 4231.936520952188, 4232.746035237834, 4250.53244143144, 4259.637930775919, 4288.799136241857, 4295.098029413795, 4898.191798353303, 4915.8033678652455, 4920.729359885169, 4930.433000204951, 4931.309616653672, 5591.720413979285, 5785.392533783892, 5879.3826648202175, 5882.411758824083, 5889.911651325234, 1442.3581506229627, 1448.3265281643876, 1462.590474667095, 1471.1687896338535, 1474.9041312314664, 893.6068130022899, 931.487681775021, 935.9391639543408, 945.567465290086, 947.6209516193578, 4890.902181956341, 4894.657373983787, 4922.326409020879, 4941.407031156285, 4969.577585905166, 5139.331886854685, 5159.0, 5184.196449550326, 5194.92207616886, 5213.244079608511, 4725.173094708481, 4900.607951363882, 4907.5828554572545, 4928.605711543068, 4984.352034235599, 2750.601162831378, 2759.7102304258165, 2771.5704065869822, 2785.579354529164, 2803.341214814517, 5401.730593310569, 5450.291462109901, 5481.588880833953, 5481.808136715275, 5506.457172832429, 5106.6722652109975, 5206.427292997767, 5213.817516386984, 5321.4988955191, 5340.546053585489, 5306.336707911511, 5343.396980905713, 5375.381831089397, 5384.488473595002, 5396.244525766318, 5172.612054095883, 5177.326947496952, 5195.0, 5221.269022336952, 5226.503482169188, 4795.400574928134, 5095.0, 5134.793323569033, 5152.690838549699, 5154.14956532168, 5384.4346343634925, 5390.299261096033, 5407.459254074718, 5433.505785908907, 5452.26394436746, 3982.522097348337, 4044.7977601120415, 4123.0, 4143.005678637166, 4189.97905010473, 5842.766289348378, 5850.268716410449, 5867.589268751147, 5886.146508756121, 5907.616004959664, 5477.890442191214, 5747.453991870766, 5749.281339832521, 5781.335146458211, 5826.679532625746, 5785.884282314246, 5820.854478638068, 5831.79588714393, 5832.62087964281, 5839.416058394127, 5734.283214598176, 5741.966446039753, 5756.042945398584, 5793.565482588907, 5804.361520232856, 5765.308163020464, 5908.602553531822, 5910.7635694573455, 5942.851428714143, 5974.462298393166, 5739.253896993531, 5770.5095066919785, 5777.584491799536, 5792.478676919098, 5797.5361971041375], "value": 4246.260228837691, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [683.9829004274894, 718.7735863203094, 748.8202831320484, 759.2786852490136, 822.3996482567727, 16565.171741412927, 17267.222974966124, 17326.56683582908, 17404.47786566402, 17499.825001749978, 15722.292496837641, 15876.285567149476, 15896.0, 15897.1256580888, 15901.840981590181, 668.8662267546486, 800.3957012455602, 801.1467786807061, 814.5479259011246, 817.3338728935928, 831.9251267385933, 834.5368320582074, 834.8246868157694, 838.3963546246692, 839.3830534557096, 875.4222213339198, 875.6409871952501, 875.7372788163525, 876.1720174435161, 879.3361012435602, 870.8911386076741, 873.5501216873283, 876.0669886570845, 877.0527829943645, 877.3025444771422, 629.5341447328989, 633.9651319177443, 635.4598591197491, 635.8315046512678, 636.8949123394634, 15113.54659360221, 15246.695066098728, 15252.466163684217, 15295.923520382326, 15348.693026139415, 14410.423583056665, 14669.706605867823, 15398.07611543311, 15579.610509737347, 15992.600184995352, 13677.452901883913, 13725.725485490335, 13767.724645507134, 13904.652383690387, 14047.22740249286, 4629.791659375336, 4652.092841895832, 4684.3910291662205, 4752.809887604491, 4825.372701548777, 85699.14300856974, 90242.09757902402, 91722.0, 92445.53777231071, 92767.07232927652, 11230.831537526943, 11405.828912566318, 11522.942385288019, 11576.76846463066, 11644.184907056595, 18717.532061698566, 18787.0, 18811.435656930313, 19345.226190952206, 19743.308984185773, 8325.084240733515, 8576.828463430697, 8724.607392667218, 8931.642734290686, 9207.309451791009, 4661.95338046622, 4713.905721885543, 4747.738874361874, 4886.438059623118, 4982.352294201731, 3686.115332320224, 3811.1615444602144, 3830.9042273943373, 3838.405047217686, 3842.269968705937, 686.2417029182781, 688.1226436293665, 689.334791925794, 694.187800273681, 695.02696225285, 620.5035971223003, 678.6301465701205, 683.8700646877078, 685.5715178013742, 704.0600797934815, 9520.904790952001, 9893.752656183653, 9918.851217231748, 10051.59793608262, 10306.793864122825, 617.2500411999442, 648.8978134319824, 669.7488441834312, 689.0112688292216, 720.038748271064, 4828.227483602677, 4876.926846097312, 4900.534449227318, 4925.142023530346, 5025.422076461181, 101333.0, 118666.40666796784, 119076.40461797809, 121269.0, 121423.39288303502, 91156.0, 93963.53018234865, 104075.0, 105355.0, 106523.46738266414, 88641.55679221563, 89447.55276223707, 90216.0, 92545.53727231456, 92978.0, 9891.0, 10209.591616335263, 10255.487225638837, 10451.738706532398, 10556.208284378856, 51967.480325196266, 52123.21815172851, 52363.0, 52924.206136908746, 53622.195667065804, 70747.64626176836, 79696.0, 79724.0, 81710.59144704239, 82004.17995819966, 13180.324935763525, 13397.263150526815, 13503.932480337535, 13545.59363219105, 13662.521811736542, 15400.306986185873, 15460.304286306919, 15807.920960395584, 15968.600784980004, 16531.33874645001, 14099.506517272257, 14123.152610843383, 14263.714725705635, 14698.191599462132, 15093.47172848945, 14068.437262509386, 14280.857191427953, 14447.638809029859, 15372.846271537588, 15419.845801541842, 14064.226467543975, 14088.520705325793, 14227.359768810222, 14686.265686715835, 15206.847931520986, 11516.366599837089, 11629.18595698293, 11938.52245910154, 12201.816972745593, 12333.444994975069, 11583.0, 12021.338826364285, 12244.897959183645, 12255.75488490243, 12358.44387002569], "value": 7895.613622449035, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1530.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 111.0, 106.0, 111.0, 113.0, 112.0, 114.0, 110.0, 112.0, 111.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 123.0, 148.0, 186.0, 119.0, 144.0, 152.0, 120.0, 191.0, 119.0], "value": 145.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 163.0, 164.0, 163.0, 163.0, 169.0, 162.0, 163.0, 163.0], "value": 163.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 189.0, 76.0, 75.0, 78.0, 74.0, 160.0, 77.0], "value": 95.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 151.0, 83.0, 84.0, 84.0, 136.0, 84.0, 84.0, 141.0], "value": 101.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 118.0, 118.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 147.0, 147.0, 146.0, 147.0, 147.0, 148.0, 154.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 97.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 97.0, 95.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 51.0, 51.0, 52.0, 60.0, 53.0, 53.0, 51.0, 54.0, 50.0], "value": 52.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 61.0, 61.0, 60.0, 61.0, 65.0, 61.0, 61.0], "value": 61.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 80.0, 75.0, 76.0, 80.0, 86.0, 75.0, 76.0, 83.0, 76.0], "value": 78.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 143.0, 132.0, 131.0, 143.0, 125.0, 135.0, 124.0, 140.0, 138.0], "value": 134.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 163.0, 158.0, 159.0, 163.0, 161.0, 161.0, 160.0, 160.0], "value": 161.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 65.0, 64.0, 65.0, 65.0, 65.0, 64.0, 72.0, 67.0], "value": 65.9, "unit": "score"}]}]} 15:58:24 INFO - Return code: 0 15:58:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:58:24 ERROR - # TBPL SUCCESS # 15:58:24 INFO - Running post-action listener: _resource_record_post_action 15:58:24 INFO - [mozharness: 2016-08-04 22:58:24.158901Z] Finished run-tests step (success) 15:58:24 INFO - Running post-run listener: _resource_record_post_run 15:58:24 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 8192; Write bytes: 405651456; Read time: 268; Write time: 389716 15:58:24 INFO - TinderboxPrint: CPU usage
13.4% 15:58:24 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 268 15:58:24 INFO - TinderboxPrint: I/O write bytes / time
405,651,456 / 389,716 15:58:24 INFO - TinderboxPrint: CPU idle
8,238.1 (86.6%) 15:58:24 INFO - TinderboxPrint: CPU user
1,211.6 (12.7%) 15:58:24 INFO - TinderboxPrint: Swap in / out
0 / 0 15:58:24 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 117080064; Read time: 0; Write time: 102332 15:58:24 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 287207424; Read time: 264; Write time: 287260 15:58:24 INFO - Running post-run listener: _upload_blobber_files 15:58:24 INFO - Blob upload gear active. 15:58:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:58:24 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:58:24 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:58:24 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:58:25 INFO - (blobuploader) - INFO - Open directory for files ... 15:58:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:58:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:58:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:58:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:58:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:58:26 INFO - (blobuploader) - INFO - Done attempting. 15:58:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:58:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:58:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:58:29 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:58:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:58:29 INFO - (blobuploader) - INFO - Done attempting. 15:58:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:58:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:58:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:58:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:58:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:58:30 INFO - (blobuploader) - INFO - Done attempting. 15:58:30 INFO - (blobuploader) - INFO - Iteration through files over. 15:58:30 INFO - Return code: 0 15:58:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:58:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:58:30 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/bafe72c6b65654586ffeb74e67b7dbaab17708fa0175e8f5ce23cb674dee33c4d988cfcf5a0b91de49003462f664f03eca74aa8954191860c6db9118e8969557", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/86d220107cd2d7a6ccecb47dc0bdab2dc7c4c54f118f2ba709b7eb469fd0b78d98cb92cc2498b8980543f245e4eae67e6dad65d65ad0d06db2e1c44cb5589dc1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/200c7ca1096a7beec2c45abe43bd9a87075034d6910f34cc9df3e125177fdef505254832a1b5045f76d0423b49ba3896c8d40aa22204010423ece496cb501a21"} 15:58:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:58:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:58:30 INFO - Contents: 15:58:30 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/bafe72c6b65654586ffeb74e67b7dbaab17708fa0175e8f5ce23cb674dee33c4d988cfcf5a0b91de49003462f664f03eca74aa8954191860c6db9118e8969557", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/86d220107cd2d7a6ccecb47dc0bdab2dc7c4c54f118f2ba709b7eb469fd0b78d98cb92cc2498b8980543f245e4eae67e6dad65d65ad0d06db2e1c44cb5589dc1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/200c7ca1096a7beec2c45abe43bd9a87075034d6910f34cc9df3e125177fdef505254832a1b5045f76d0423b49ba3896c8d40aa22204010423ece496cb501a21"} 15:58:30 INFO - Running post-run listener: copy_logs_to_upload_dir 15:58:30 INFO - Copying logs to upload dir... 15:58:30 INFO - mkdir: /builds/slave/test/build/upload/logs 15:58:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.776667 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-08-04 15:58:28.975146) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-04 15:58:28.978637) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1470350271.782792-585685140 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/bafe72c6b65654586ffeb74e67b7dbaab17708fa0175e8f5ce23cb674dee33c4d988cfcf5a0b91de49003462f664f03eca74aa8954191860c6db9118e8969557", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/86d220107cd2d7a6ccecb47dc0bdab2dc7c4c54f118f2ba709b7eb469fd0b78d98cb92cc2498b8980543f245e4eae67e6dad65d65ad0d06db2e1c44cb5589dc1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/200c7ca1096a7beec2c45abe43bd9a87075034d6910f34cc9df3e125177fdef505254832a1b5045f76d0423b49ba3896c8d40aa22204010423ece496cb501a21"} 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.011250 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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/bafe72c6b65654586ffeb74e67b7dbaab17708fa0175e8f5ce23cb674dee33c4d988cfcf5a0b91de49003462f664f03eca74aa8954191860c6db9118e8969557", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/86d220107cd2d7a6ccecb47dc0bdab2dc7c4c54f118f2ba709b7eb469fd0b78d98cb92cc2498b8980543f245e4eae67e6dad65d65ad0d06db2e1c44cb5589dc1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/200c7ca1096a7beec2c45abe43bd9a87075034d6910f34cc9df3e125177fdef505254832a1b5045f76d0423b49ba3896c8d40aa22204010423ece496cb501a21"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-04 15:58:29.008090) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 15:58:29.008787) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1470350271.782792-585685140 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004443 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 15:58:29.094731) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-04 15:58:29.095388) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-04 15:58:29.096080) ========= ========= Total master_lag: 0.18 =========